builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-044 starttime: 1451530109.09 results: success (0) buildid: 20151230173640 builduid: 5921b0e048534446bede439c0ac3f08b revision: 22f51211915bf7daff076180847a7140d35aa353 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 18:48:29.090949) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 18:48:29.091601) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 18:48:29.092068) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0cff312cb257a7829adc5a5d000001df-1451530044.516086-1845407381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006252 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 18:48:29.127082) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 18:48:29.127389) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 18:48:29.143354) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:48:29.143639) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0cff312cb257a7829adc5a5d000001df-1451530044.516086-1845407381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004614 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:48:29.192713) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 18:48:29.193142) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 18:48:29.193723) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:48:29.194195) ========= 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 /builds/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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0cff312cb257a7829adc5a5d000001df-1451530044.516086-1845407381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-30 18:48:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 60.7M=0s 2015-12-30 18:48:31 (60.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162229 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:48:29.373768) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:48:29.374080) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0cff312cb257a7829adc5a5d000001df-1451530044.516086-1845407381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013827 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:48:29.423932) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:48:29.424238) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 22f51211915bf7daff076180847a7140d35aa353 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 22f51211915bf7daff076180847a7140d35aa353 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0cff312cb257a7829adc5a5d000001df-1451530044.516086-1845407381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-30 18:48:31,387 truncating revision to first 12 chars 2015-12-30 18:48:31,387 Setting DEBUG logging. 2015-12-30 18:48:31,388 attempt 1/10 2015-12-30 18:48:31,388 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/22f51211915b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-30 18:48:31,637 unpacking tar archive at: mozilla-central-22f51211915b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.536773 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:48:29.974170) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 18:48:29.974499) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 18:48:29.981899) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 18:48:29.982172) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 18:48:29.982600) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-30 18:48:29.982926) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0cff312cb257a7829adc5a5d000001df-1451530044.516086-1845407381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:48:32 INFO - MultiFileLogger online at 20151230 18:48:32 in /builds/slave/test 18:48:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 18:48:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:48:32 INFO - {'append_to_log': False, 18:48:32 INFO - 'base_work_dir': '/builds/slave/test', 18:48:32 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:48:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:48:32 INFO - 'branch': 'Firefox-Non-PGO', 18:48:32 INFO - 'buildbot_json_path': 'buildprops.json', 18:48:32 INFO - 'config_files': ('talos/linux_config.py',), 18:48:32 INFO - 'default_actions': ('clobber', 18:48:32 INFO - 'read-buildbot-config', 18:48:32 INFO - 'download-and-extract', 18:48:32 INFO - 'populate-webroot', 18:48:32 INFO - 'create-virtualenv', 18:48:32 INFO - 'install', 18:48:32 INFO - 'run-tests'), 18:48:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:48:32 INFO - 'download_minidump_stackwalk': True, 18:48:32 INFO - 'download_symbols': 'ondemand', 18:48:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:48:32 INFO - 'tooltool.py': '/tools/tooltool.py', 18:48:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:48:32 INFO - '/tools/misc-python/virtualenv.py')}, 18:48:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:48:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:48:32 INFO - 'installer_path': 'installer.exe', 18:48:32 INFO - 'log_level': 'info', 18:48:32 INFO - 'log_name': 'talos', 18:48:32 INFO - 'log_to_console': True, 18:48:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:48:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:48:32 INFO - 'opt_config_files': (), 18:48:32 INFO - 'pip_index': False, 18:48:32 INFO - 'sps_profile': False, 18:48:32 INFO - 'sps_profile_interval': 0, 18:48:32 INFO - 'suite': 'dromaeojs', 18:48:32 INFO - 'system_bits': '32', 18:48:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:48:32 INFO - 'title': 'talos-linux64-ix-044', 18:48:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:48:32 INFO - 'use_talos_json': True, 18:48:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:48:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:48:32 INFO - 'work_dir': 'build'} 18:48:32 INFO - ##### 18:48:32 INFO - ##### Running clobber step. 18:48:32 INFO - ##### 18:48:32 INFO - Running pre-action listener: _resource_record_pre_action 18:48:32 INFO - Running main action method: clobber 18:48:32 INFO - rmtree: /builds/slave/test/build 18:48:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:48:32 INFO - Running post-action listener: _resource_record_post_action 18:48:32 INFO - ##### 18:48:32 INFO - ##### Running read-buildbot-config step. 18:48:32 INFO - ##### 18:48:32 INFO - Running pre-action listener: _resource_record_pre_action 18:48:32 INFO - Running main action method: read_buildbot_config 18:48:32 INFO - Using buildbot properties: 18:48:32 INFO - { 18:48:32 INFO - "project": "", 18:48:32 INFO - "product": "firefox", 18:48:32 INFO - "script_repo_revision": "production", 18:48:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 18:48:32 INFO - "repository": "", 18:48:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 18:48:32 INFO - "buildid": "20151230173640", 18:48:32 INFO - "pgo_build": "False", 18:48:32 INFO - "basedir": "/builds/slave/test", 18:48:32 INFO - "buildnumber": 360, 18:48:32 INFO - "slavename": "talos-linux64-ix-044", 18:48:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:48:32 INFO - "platform": "ubuntu64_hw", 18:48:32 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 18:48:32 INFO - "branch": "mozilla-central", 18:48:32 INFO - "repo_path": "mozilla-central", 18:48:32 INFO - "revision": "22f51211915bf7daff076180847a7140d35aa353", 18:48:32 INFO - "stage_platform": "linux64", 18:48:32 INFO - "builduid": "5921b0e048534446bede439c0ac3f08b", 18:48:32 INFO - "slavebuilddir": "test" 18:48:32 INFO - } 18:48:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 18:48:32 INFO - Running post-action listener: _resource_record_post_action 18:48:32 INFO - ##### 18:48:32 INFO - ##### Running download-and-extract step. 18:48:32 INFO - ##### 18:48:32 INFO - Running pre-action listener: _resource_record_pre_action 18:48:32 INFO - Running main action method: download_and_extract 18:48:32 INFO - mkdir: /builds/slave/test/build/tests 18:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:32 INFO - https://queue.taskcluster.net/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:48:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/test_packages.json 18:48:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/test_packages.json 18:48:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:48:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:48:33 INFO - Downloaded 1302 bytes. 18:48:33 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:48:33 INFO - Using the following test package requirements: 18:48:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:48:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:48:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:48:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:48:33 INFO - u'jsshell-linux-x86_64.zip'], 18:48:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:48:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:48:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:48:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:48:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:48:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:48:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:48:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:48:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:48:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:48:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:48:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:48:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:48:33 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:33 INFO - https://queue.taskcluster.net/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:48:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:48:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:48:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:48:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:48:34 INFO - Downloaded 21946014 bytes. 18:48:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 18:48:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:48:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:48:35 INFO - Return code: 0 18:48:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:48:35 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:35 INFO - https://queue.taskcluster.net/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:48:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:48:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:48:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:48:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:48:36 INFO - Downloaded 21946014 bytes. 18:48:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 18:48:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:48:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:48:38 INFO - Return code: 0 18:48:38 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:38 INFO - https://queue.taskcluster.net/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:48:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:48:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:48:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:48:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:48:40 INFO - Downloaded 11132285 bytes. 18:48:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 18:48:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:48:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 18:48:40 INFO - Return code: 0 18:48:40 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:40 INFO - https://queue.taskcluster.net/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:48:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:48:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:48:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:48:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:48:42 INFO - Downloaded 53363959 bytes. 18:48:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:48:42 INFO - mkdir: /builds/slave/test/properties 18:48:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:48:42 INFO - Writing to file /builds/slave/test/properties/build_url 18:48:42 INFO - Contents: 18:48:42 INFO - build_url:https://queue.taskcluster.net/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:48:42 INFO - Running post-action listener: _resource_record_post_action 18:48:42 INFO - Running post-action listener: set_extra_try_arguments 18:48:42 INFO - ##### 18:48:42 INFO - ##### Running populate-webroot step. 18:48:42 INFO - ##### 18:48:42 INFO - Running pre-action listener: _resource_record_pre_action 18:48:42 INFO - Running main action method: populate_webroot 18:48:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:48:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:48:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:48:42 INFO - '--tppagecycles', 18:48:42 INFO - '7'], 18:48:42 INFO - 'tests': ['tsvgm']}}, 18:48:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:48:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:48:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:48:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:48:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:48:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:48:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:48:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:42 INFO - 'talos_options': ['--e10s'], 18:48:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:48:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:42 INFO - 'tests': ['damp', 'tps']}, 18:48:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:42 INFO - 'talos_options': ['--e10s'], 18:48:42 INFO - 'tests': ['damp', 'tps']}, 18:48:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:48:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:48:42 INFO - 'other': {'tests': ['a11yr', 18:48:42 INFO - 'ts_paint', 18:48:42 INFO - 'tpaint', 18:48:42 INFO - 'sessionrestore', 18:48:42 INFO - 'sessionrestore_no_auto_restore']}, 18:48:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:48:42 INFO - 'tests': ['a11yr', 18:48:42 INFO - 'ts_paint', 18:48:42 INFO - 'tpaint', 18:48:42 INFO - 'sessionrestore', 18:48:42 INFO - 'sessionrestore_no_auto_restore']}, 18:48:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:48:42 INFO - 'tests': ['a11yr', 18:48:42 INFO - 'ts_paint', 18:48:42 INFO - 'tpaint', 18:48:42 INFO - 'sessionrestore', 18:48:42 INFO - 'sessionrestore_no_auto_restore']}, 18:48:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:48:42 INFO - 'tests': ['a11yr', 18:48:42 INFO - 'ts_paint', 18:48:42 INFO - 'tpaint', 18:48:42 INFO - 'sessionrestore', 18:48:42 INFO - 'sessionrestore_no_auto_restore']}, 18:48:42 INFO - 'other_l64': {'tests': ['a11yr', 18:48:42 INFO - 'ts_paint', 18:48:42 INFO - 'tpaint', 18:48:42 INFO - 'sessionrestore', 18:48:42 INFO - 'sessionrestore_no_auto_restore']}, 18:48:42 INFO - 'other_nol64': {'tests': ['a11yr', 18:48:42 INFO - 'ts_paint', 18:48:42 INFO - 'tpaint', 18:48:42 INFO - 'sessionrestore', 18:48:42 INFO - 'sessionrestore_no_auto_restore']}, 18:48:42 INFO - 'svgr': {'tests': ['tsvgx', 18:48:42 INFO - 'tsvgr_opacity', 18:48:42 INFO - 'tart', 18:48:42 INFO - 'tscrollx', 18:48:42 INFO - 'cart']}, 18:48:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:48:42 INFO - 'tests': ['tsvgx', 18:48:42 INFO - 'tsvgr_opacity', 18:48:42 INFO - 'tart', 18:48:42 INFO - 'tscrollx', 18:48:42 INFO - 'cart']}, 18:48:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:42 INFO - 'tests': ['tp5o']}, 18:48:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:42 INFO - 'talos_options': ['--e10s'], 18:48:42 INFO - 'tests': ['tp5o']}, 18:48:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:42 INFO - 'talos_options': ['--xperf_path', 18:48:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:48:42 INFO - 'tests': ['tp5n']}, 18:48:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:48:42 INFO - 'talos_options': ['--e10s', 18:48:42 INFO - '--xperf_path', 18:48:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:48:42 INFO - 'tests': ['tp5n']}}, 18:48:42 INFO - 'talos.zip': {'path': '', 18:48:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:48:42 INFO - Running post-action listener: _resource_record_post_action 18:48:42 INFO - ##### 18:48:42 INFO - ##### Running create-virtualenv step. 18:48:42 INFO - ##### 18:48:42 INFO - Running pre-action listener: _resource_record_pre_action 18:48:42 INFO - Running main action method: create_virtualenv 18:48:42 INFO - Creating virtualenv /builds/slave/test/build/venv 18:48:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:48:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:48:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:48:42 INFO - Using real prefix '/usr' 18:48:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:48:42 INFO - Installing distribute.............................................................................................................................................................................................done. 18:48:44 INFO - Installing pip.................done. 18:48:44 INFO - Return code: 0 18:48:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:48:44 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:44 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f61e6d1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acfdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b623d0>, '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 0x2acded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ace360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451530044.516086-1845407381', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:48:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:48:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:48:44 INFO - Using env: {'DISPLAY': ':0', 18:48:44 INFO - 'HOME': '/home/cltbld', 18:48:44 INFO - 'LANG': 'en_US.UTF-8', 18:48:44 INFO - 'LANGUAGE': 'en_US:en', 18:48:44 INFO - 'LOGNAME': 'cltbld', 18:48:44 INFO - 'MAIL': '/var/mail/cltbld', 18:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:44 INFO - 'MOZ_NO_REMOTE': '1', 18:48:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:44 INFO - 'NO_EM_RESTART': '1', 18:48:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:44 INFO - 'PWD': '/builds/slave/test', 18:48:44 INFO - 'SHELL': '/bin/bash', 18:48:44 INFO - 'SHLVL': '1', 18:48:44 INFO - 'TERM': 'linux', 18:48:44 INFO - 'TMOUT': '86400', 18:48:44 INFO - 'USER': 'cltbld', 18:48:44 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451530044.516086-1845407381', 18:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:44 INFO - '_': '/tools/buildbot/bin/python'} 18:48:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:48:44 INFO - Cleaning up... 18:48:44 INFO - Return code: 0 18:48:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:48:44 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:44 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f61e6d1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acfdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b623d0>, '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 0x2acded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ace360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451530044.516086-1845407381', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:48:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:48:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:48:44 INFO - Using env: {'DISPLAY': ':0', 18:48:44 INFO - 'HOME': '/home/cltbld', 18:48:44 INFO - 'LANG': 'en_US.UTF-8', 18:48:44 INFO - 'LANGUAGE': 'en_US:en', 18:48:44 INFO - 'LOGNAME': 'cltbld', 18:48:44 INFO - 'MAIL': '/var/mail/cltbld', 18:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:44 INFO - 'MOZ_NO_REMOTE': '1', 18:48:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:44 INFO - 'NO_EM_RESTART': '1', 18:48:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:44 INFO - 'PWD': '/builds/slave/test', 18:48:44 INFO - 'SHELL': '/bin/bash', 18:48:44 INFO - 'SHLVL': '1', 18:48:44 INFO - 'TERM': 'linux', 18:48:44 INFO - 'TMOUT': '86400', 18:48:44 INFO - 'USER': 'cltbld', 18:48:44 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451530044.516086-1845407381', 18:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:44 INFO - '_': '/tools/buildbot/bin/python'} 18:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:45 INFO - Downloading/unpacking psutil>=0.7.1 18:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:46 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:48:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:48:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:48:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:48:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:48:46 INFO - Installing collected packages: psutil 18:48:46 INFO - Running setup.py install for psutil 18:48:47 INFO - building 'psutil._psutil_linux' extension 18:48:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:48:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:48:47 INFO - building 'psutil._psutil_posix' extension 18:48:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:48:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:48:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:48:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:48:47 INFO - Successfully installed psutil 18:48:47 INFO - Cleaning up... 18:48:47 INFO - Return code: 0 18:48:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:48:47 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:47 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f61e6d1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acfdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b623d0>, '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 0x2acded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ace360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451530044.516086-1845407381', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:48:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:48:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:48:47 INFO - Using env: {'DISPLAY': ':0', 18:48:47 INFO - 'HOME': '/home/cltbld', 18:48:47 INFO - 'LANG': 'en_US.UTF-8', 18:48:47 INFO - 'LANGUAGE': 'en_US:en', 18:48:47 INFO - 'LOGNAME': 'cltbld', 18:48:47 INFO - 'MAIL': '/var/mail/cltbld', 18:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:47 INFO - 'MOZ_NO_REMOTE': '1', 18:48:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:47 INFO - 'NO_EM_RESTART': '1', 18:48:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:47 INFO - 'PWD': '/builds/slave/test', 18:48:47 INFO - 'SHELL': '/bin/bash', 18:48:47 INFO - 'SHLVL': '1', 18:48:47 INFO - 'TERM': 'linux', 18:48:47 INFO - 'TMOUT': '86400', 18:48:47 INFO - 'USER': 'cltbld', 18:48:47 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451530044.516086-1845407381', 18:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:47 INFO - '_': '/tools/buildbot/bin/python'} 18:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:48:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:48:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:48:49 INFO - Installing collected packages: mozsystemmonitor 18:48:49 INFO - Running setup.py install for mozsystemmonitor 18:48:49 INFO - Successfully installed mozsystemmonitor 18:48:49 INFO - Cleaning up... 18:48:49 INFO - Return code: 0 18:48:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:48: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f61e6d1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acfdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b623d0>, '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 0x2acded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ace360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451530044.516086-1845407381', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:48:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:48:49 INFO - Using env: {'DISPLAY': ':0', 18:48:49 INFO - 'HOME': '/home/cltbld', 18:48:49 INFO - 'LANG': 'en_US.UTF-8', 18:48:49 INFO - 'LANGUAGE': 'en_US:en', 18:48:49 INFO - 'LOGNAME': 'cltbld', 18:48:49 INFO - 'MAIL': '/var/mail/cltbld', 18:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:49 INFO - 'MOZ_NO_REMOTE': '1', 18:48:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:49 INFO - 'NO_EM_RESTART': '1', 18:48:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:49 INFO - 'PWD': '/builds/slave/test', 18:48:49 INFO - 'SHELL': '/bin/bash', 18:48:49 INFO - 'SHLVL': '1', 18:48:49 INFO - 'TERM': 'linux', 18:48:49 INFO - 'TMOUT': '86400', 18:48:49 INFO - 'USER': 'cltbld', 18:48:49 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451530044.516086-1845407381', 18:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:49 INFO - '_': '/tools/buildbot/bin/python'} 18:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:49 INFO - Downloading/unpacking blobuploader==1.2.4 18:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:51 INFO - Downloading blobuploader-1.2.4.tar.gz 18:48:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:48:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:48: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 18:48: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 18:48:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48: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 18:48: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 18:48:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:48:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:48: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 18:48: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 18:48:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48: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 18:48: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 18:48:52 INFO - Downloading docopt-0.6.1.tar.gz 18:48:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:48:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:48:52 INFO - Installing collected packages: blobuploader, requests, docopt 18:48:52 INFO - Running setup.py install for blobuploader 18:48:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:48:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:48:52 INFO - Running setup.py install for requests 18:48:52 INFO - Running setup.py install for docopt 18:48:52 INFO - Successfully installed blobuploader requests docopt 18:48:52 INFO - Cleaning up... 18:48:52 INFO - Return code: 0 18:48:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:48: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f61e6d1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acfdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b623d0>, '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 0x2acded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ace360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451530044.516086-1845407381', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:48:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:48:52 INFO - Using env: {'DISPLAY': ':0', 18:48:52 INFO - 'HOME': '/home/cltbld', 18:48:52 INFO - 'LANG': 'en_US.UTF-8', 18:48:52 INFO - 'LANGUAGE': 'en_US:en', 18:48:52 INFO - 'LOGNAME': 'cltbld', 18:48:52 INFO - 'MAIL': '/var/mail/cltbld', 18:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:52 INFO - 'MOZ_NO_REMOTE': '1', 18:48:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:52 INFO - 'NO_EM_RESTART': '1', 18:48:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:52 INFO - 'PWD': '/builds/slave/test', 18:48:52 INFO - 'SHELL': '/bin/bash', 18:48:52 INFO - 'SHLVL': '1', 18:48:52 INFO - 'TERM': 'linux', 18:48:52 INFO - 'TMOUT': '86400', 18:48:52 INFO - 'USER': 'cltbld', 18:48:52 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451530044.516086-1845407381', 18:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:52 INFO - '_': '/tools/buildbot/bin/python'} 18:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:48:53 INFO - Running setup.py (path:/tmp/pip-ZkzJeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:48:53 INFO - Running setup.py (path:/tmp/pip-njzRsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:48:53 INFO - Running setup.py (path:/tmp/pip-E7uTNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:48:53 INFO - Running setup.py (path:/tmp/pip-MkMbQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:48:53 INFO - Running setup.py (path:/tmp/pip-S0lxxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:48:53 INFO - Running setup.py (path:/tmp/pip-2QKd4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:48:53 INFO - Running setup.py (path:/tmp/pip-eWb6lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:48:53 INFO - Running setup.py (path:/tmp/pip-Ig92Su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:48:53 INFO - Running setup.py (path:/tmp/pip-Al9q_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:48:53 INFO - Running setup.py (path:/tmp/pip-JjRIiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:48:53 INFO - Running setup.py (path:/tmp/pip-nenl9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:48:53 INFO - Running setup.py (path:/tmp/pip-Gn5U9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:48:53 INFO - Running setup.py (path:/tmp/pip-pe650y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:48:53 INFO - Running setup.py (path:/tmp/pip-GimbtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:48:53 INFO - Running setup.py (path:/tmp/pip-bhrgLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:48:54 INFO - Running setup.py (path:/tmp/pip-08d94C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:48:54 INFO - Running setup.py (path:/tmp/pip-uCgOrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:48:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:48:54 INFO - Running setup.py install for manifestparser 18:48:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:48:54 INFO - Running setup.py install for mozcrash 18:48:54 INFO - Running setup.py install for mozdebug 18:48:54 INFO - Running setup.py install for mozdevice 18:48:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:48:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:48:54 INFO - Running setup.py install for mozfile 18:48:54 INFO - Running setup.py install for mozhttpd 18:48:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:48:54 INFO - Running setup.py install for mozinfo 18:48:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:48:54 INFO - Running setup.py install for mozInstall 18:48:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:48:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:48:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:48:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:48:55 INFO - Running setup.py install for mozleak 18:48:55 INFO - Running setup.py install for mozlog 18:48:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:48:55 INFO - Running setup.py install for moznetwork 18:48:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:48:55 INFO - Running setup.py install for mozprocess 18:48:55 INFO - Running setup.py install for mozprofile 18:48:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:48:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:48:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:48:55 INFO - Running setup.py install for mozrunner 18:48:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:48:55 INFO - Running setup.py install for mozscreenshot 18:48:55 INFO - Running setup.py install for moztest 18:48:55 INFO - Running setup.py install for mozversion 18:48:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:48:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:48:55 INFO - Cleaning up... 18:48:55 INFO - Return code: 0 18:48:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:48:55 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:55 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f61e6d1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acfdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b623d0>, '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 0x2acded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ace360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451530044.516086-1845407381', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:48:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:48:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:48:55 INFO - Using env: {'DISPLAY': ':0', 18:48:55 INFO - 'HOME': '/home/cltbld', 18:48:55 INFO - 'LANG': 'en_US.UTF-8', 18:48:55 INFO - 'LANGUAGE': 'en_US:en', 18:48:55 INFO - 'LOGNAME': 'cltbld', 18:48:55 INFO - 'MAIL': '/var/mail/cltbld', 18:48:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:55 INFO - 'MOZ_NO_REMOTE': '1', 18:48:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:55 INFO - 'NO_EM_RESTART': '1', 18:48:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:55 INFO - 'PWD': '/builds/slave/test', 18:48:55 INFO - 'SHELL': '/bin/bash', 18:48:55 INFO - 'SHLVL': '1', 18:48:55 INFO - 'TERM': 'linux', 18:48:55 INFO - 'TMOUT': '86400', 18:48:55 INFO - 'USER': 'cltbld', 18:48:55 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451530044.516086-1845407381', 18:48:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:55 INFO - '_': '/tools/buildbot/bin/python'} 18:48:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:48:56 INFO - Running setup.py (path:/tmp/pip-xE0XzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:48:56 INFO - Running setup.py (path:/tmp/pip-pZN44T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:48:56 INFO - Running setup.py (path:/tmp/pip-eI4xQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:48:56 INFO - Running setup.py (path:/tmp/pip-qYdEAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:48:56 INFO - Running setup.py (path:/tmp/pip-h48U53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:48:56 INFO - Running setup.py (path:/tmp/pip-BIosHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:48:56 INFO - Running setup.py (path:/tmp/pip-lZyjBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:48:56 INFO - Running setup.py (path:/tmp/pip-L17A7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:48:56 INFO - Running setup.py (path:/tmp/pip-hFXvnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:48:56 INFO - Running setup.py (path:/tmp/pip-dhWYhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:48:56 INFO - Running setup.py (path:/tmp/pip-3pqz2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:48:56 INFO - Running setup.py (path:/tmp/pip-Xc9aiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:48:57 INFO - Running setup.py (path:/tmp/pip-xjpc9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:48:57 INFO - Running setup.py (path:/tmp/pip-6s1G1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:48:57 INFO - Running setup.py (path:/tmp/pip-_1s7Y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:48:57 INFO - Running setup.py (path:/tmp/pip-rcGBiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:48:57 INFO - Running setup.py (path:/tmp/pip-E92h0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:48:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:48: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 18:48: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 18:48:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48: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 18:48: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 18:48:59 INFO - Downloading blessings-1.5.1.tar.gz 18:48:59 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 18:48:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:48:59 INFO - Installing collected packages: blessings 18:48:59 INFO - Running setup.py install for blessings 18:48:59 INFO - Successfully installed blessings 18:48:59 INFO - Cleaning up... 18:48:59 INFO - Return code: 0 18:48:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:48:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:48:59 INFO - Reading from file tmpfile_stdout 18:48:59 INFO - Current package versions: 18:48:59 INFO - argparse == 1.2.1 18:48:59 INFO - blessings == 1.5.1 18:48:59 INFO - blobuploader == 1.2.4 18:48:59 INFO - docopt == 0.6.1 18:48:59 INFO - manifestparser == 1.1 18:48:59 INFO - mozInstall == 1.12 18:48:59 INFO - mozcrash == 0.16 18:48:59 INFO - mozdebug == 0.1 18:48:59 INFO - mozdevice == 0.47 18:48:59 INFO - mozfile == 1.2 18:48:59 INFO - mozhttpd == 0.7 18:48:59 INFO - mozinfo == 0.9 18:48:59 INFO - mozleak == 0.1 18:48:59 INFO - mozlog == 3.1 18:48:59 INFO - moznetwork == 0.27 18:48:59 INFO - mozprocess == 0.22 18:48:59 INFO - mozprofile == 0.28 18:48:59 INFO - mozrunner == 6.11 18:48:59 INFO - mozscreenshot == 0.1 18:48:59 INFO - mozsystemmonitor == 0.0 18:48:59 INFO - moztest == 0.7 18:48:59 INFO - mozversion == 1.4 18:48:59 INFO - psutil == 3.1.1 18:48:59 INFO - requests == 1.2.3 18:48:59 INFO - wsgiref == 0.1.2 18:48:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f61e6d1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acfdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b623d0>, '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 0x2acded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ace360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451530044.516086-1845407381', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:48:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:48:59 INFO - Using env: {'DISPLAY': ':0', 18:48:59 INFO - 'HOME': '/home/cltbld', 18:48:59 INFO - 'LANG': 'en_US.UTF-8', 18:48:59 INFO - 'LANGUAGE': 'en_US:en', 18:48:59 INFO - 'LOGNAME': 'cltbld', 18:48:59 INFO - 'MAIL': '/var/mail/cltbld', 18:48:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:59 INFO - 'MOZ_NO_REMOTE': '1', 18:48:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:59 INFO - 'NO_EM_RESTART': '1', 18:48:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:59 INFO - 'PWD': '/builds/slave/test', 18:48:59 INFO - 'SHELL': '/bin/bash', 18:48:59 INFO - 'SHLVL': '1', 18:48:59 INFO - 'TERM': 'linux', 18:48:59 INFO - 'TMOUT': '86400', 18:48:59 INFO - 'USER': 'cltbld', 18:48:59 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451530044.516086-1845407381', 18:48:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:59 INFO - '_': '/tools/buildbot/bin/python'} 18:48:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:48:59 INFO - Cleaning up... 18:48:59 INFO - Return code: 0 18:48:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f61e6d1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acfdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b623d0>, '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 0x2acded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ace360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451530044.516086-1845407381', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:48:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:48:59 INFO - Using env: {'DISPLAY': ':0', 18:48:59 INFO - 'HOME': '/home/cltbld', 18:48:59 INFO - 'LANG': 'en_US.UTF-8', 18:48:59 INFO - 'LANGUAGE': 'en_US:en', 18:48:59 INFO - 'LOGNAME': 'cltbld', 18:48:59 INFO - 'MAIL': '/var/mail/cltbld', 18:48:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:59 INFO - 'MOZ_NO_REMOTE': '1', 18:48:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:59 INFO - 'NO_EM_RESTART': '1', 18:48:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:48:59 INFO - 'PWD': '/builds/slave/test', 18:48:59 INFO - 'SHELL': '/bin/bash', 18:48:59 INFO - 'SHLVL': '1', 18:48:59 INFO - 'TERM': 'linux', 18:48:59 INFO - 'TMOUT': '86400', 18:48:59 INFO - 'USER': 'cltbld', 18:48:59 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451530044.516086-1845407381', 18:48:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:59 INFO - '_': '/tools/buildbot/bin/python'} 18:48:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:59 INFO - Downloading/unpacking jsonschema 18:48: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 18:48: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 18:48:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48: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 18:48: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 18:49:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:49:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 18:49:01 INFO - Downloading/unpacking functools32 (from jsonschema) 18:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:49:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:01 INFO - Downloading functools32-3.2.3-2.tar.gz 18:49:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 18:49:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:49:01 INFO - warning: no files found matching '*.txt' 18:49:01 INFO - no previously-included directories found matching 'build' 18:49:01 INFO - no previously-included directories found matching 'dist' 18:49:01 INFO - no previously-included directories found matching '.git*' 18:49:01 INFO - Installing collected packages: jsonschema, functools32 18:49:01 INFO - Running setup.py install for functools32 18:49:02 INFO - warning: no files found matching '*.txt' 18:49:02 INFO - no previously-included directories found matching 'build' 18:49:02 INFO - no previously-included directories found matching 'dist' 18:49:02 INFO - no previously-included directories found matching '.git*' 18:49:02 INFO - Successfully installed jsonschema functools32 18:49:02 INFO - Cleaning up... 18:49:02 INFO - Return code: 0 18:49:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:49:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:49:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:49:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:49:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f61e6d1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acfdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b623d0>, '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 0x2acded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ace360>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451530044.516086-1845407381', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:49:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:49:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:49:02 INFO - Using env: {'DISPLAY': ':0', 18:49:02 INFO - 'HOME': '/home/cltbld', 18:49:02 INFO - 'LANG': 'en_US.UTF-8', 18:49:02 INFO - 'LANGUAGE': 'en_US:en', 18:49:02 INFO - 'LOGNAME': 'cltbld', 18:49:02 INFO - 'MAIL': '/var/mail/cltbld', 18:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:02 INFO - 'MOZ_NO_REMOTE': '1', 18:49:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:02 INFO - 'NO_EM_RESTART': '1', 18:49:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:49:02 INFO - 'PWD': '/builds/slave/test', 18:49:02 INFO - 'SHELL': '/bin/bash', 18:49:02 INFO - 'SHLVL': '1', 18:49:02 INFO - 'TERM': 'linux', 18:49:02 INFO - 'TMOUT': '86400', 18:49:02 INFO - 'USER': 'cltbld', 18:49:02 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451530044.516086-1845407381', 18:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:02 INFO - '_': '/tools/buildbot/bin/python'} 18:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:49:02 INFO - Downloading/unpacking flake8 18:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:49:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:49:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 18:49:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:49:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:49:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 18:49:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:49:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 18:49:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:49:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:49:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 18:49:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:49:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:49:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:49:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:49:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:49:04 INFO - no previously-included directories found matching 'docs/_build' 18:49:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:49:04 INFO - Running setup.py install for pep8 18:49:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:49:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:49:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:49:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:49:04 INFO - no previously-included directories found matching 'docs/_build' 18:49:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:49:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:49:04 INFO - Cleaning up... 18:49:04 INFO - Return code: 0 18:49:04 INFO - Running post-action listener: _resource_record_post_action 18:49:04 INFO - Running post-action listener: _start_resource_monitoring 18:49:04 INFO - Starting resource monitoring. 18:49:04 INFO - ##### 18:49:04 INFO - ##### Running install step. 18:49:04 INFO - ##### 18:49:04 INFO - Running pre-action listener: _resource_record_pre_action 18:49:04 INFO - Running main action method: install 18:49:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:49:05 INFO - Reading from file tmpfile_stdout 18:49:05 INFO - Detecting whether we're running mozinstall >=1.0... 18:49:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:49:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:49:05 INFO - Reading from file tmpfile_stdout 18:49:05 INFO - Output received: 18:49:05 INFO - Usage: mozinstall [options] installer 18:49:05 INFO - Options: 18:49:05 INFO - -h, --help show this help message and exit 18:49:05 INFO - -d DEST, --destination=DEST 18:49:05 INFO - Directory to install application into. [default: 18:49:05 INFO - "/builds/slave/test"] 18:49:05 INFO - --app=APP Application being installed. [default: firefox] 18:49:05 INFO - mkdir: /builds/slave/test/build/application 18:49:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:49:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:49:20 INFO - Reading from file tmpfile_stdout 18:49:20 INFO - Output received: 18:49:20 INFO - /builds/slave/test/build/application/firefox/firefox 18:49:20 INFO - Running post-action listener: _resource_record_post_action 18:49:20 INFO - ##### 18:49:20 INFO - ##### Running run-tests step. 18:49:20 INFO - ##### 18:49:20 INFO - Running pre-action listener: _resource_record_pre_action 18:49:20 INFO - Running main action method: run_tests 18:49:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:49:20 INFO - Python 2.7.3 18:49:20 INFO - Return code: 0 18:49:20 INFO - grabbing minidump binary from tooltool 18:49: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:49:20 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b623d0>, '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 0x2acded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ace360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:49:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:49:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:49:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:49:20 INFO - Return code: 0 18:49:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:49:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:49:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:49:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:49:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:49:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:49:21 INFO - Return code: 0 18:49:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:49:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:49:21 INFO - Using env: {'DISPLAY': ':0', 18:49:21 INFO - 'HOME': '/home/cltbld', 18:49:21 INFO - 'LANG': 'en_US.UTF-8', 18:49:21 INFO - 'LANGUAGE': 'en_US:en', 18:49:21 INFO - 'LOGNAME': 'cltbld', 18:49:21 INFO - 'MAIL': '/var/mail/cltbld', 18:49:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:49:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:49:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:49:21 INFO - 'MOZ_NO_REMOTE': '1', 18:49:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:49:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:49:21 INFO - 'NO_EM_RESTART': '1', 18:49:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:49:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:49:21 INFO - 'PWD': '/builds/slave/test', 18:49:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:49:21 INFO - 'SHELL': '/bin/bash', 18:49:21 INFO - 'SHLVL': '1', 18:49:21 INFO - 'TERM': 'linux', 18:49:21 INFO - 'TMOUT': '86400', 18:49:21 INFO - 'USER': 'cltbld', 18:49:21 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451530044.516086-1845407381', 18:49:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:49:21 INFO - '_': '/tools/buildbot/bin/python'} 18:49:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:49:22 INFO - mozversion application_buildid: 20151230173640 18:49:22 INFO - mozversion application_changeset: 22f51211915bf7daff076180847a7140d35aa353 18:49:22 INFO - mozversion application_display_name: Nightly 18:49:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:49:22 INFO - mozversion application_name: Firefox 18:49:22 INFO - mozversion application_remotingname: firefox 18:49:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:49:22 INFO - mozversion application_vendor: Mozilla 18:49:22 INFO - mozversion application_version: 46.0a1 18:49:22 INFO - mozversion platform_buildid: 20151230173640 18:49:22 INFO - mozversion platform_changeset: 22f51211915bf7daff076180847a7140d35aa353 18:49:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:49:22 INFO - mozversion platform_version: 46.0a1 18:49:22 INFO - using testdate: 1451530162 18:49:22 INFO - actual date: 1451530162 18:49:22 INFO - starting webserver on 'localhost:44263' 18:49:22 INFO - SUITE-START | Running 3 tests 18:49:22 INFO - TEST-START | dromaeo_css 18:49:22 INFO - operating with platform_type : linux_ 18:49:22 INFO - Initialising browser for dromaeo_css test... 18:49:22 INFO - TEST-INFO | started process 29430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4Yb2zH/profile http://localhost:44263/getInfo.html) 18:49:26 INFO - PROCESS | 29430 | __metrics Screen width/height:1600/1200 18:49:26 INFO - PROCESS | 29430 | colorDepth:24 18:49:26 INFO - PROCESS | 29430 | Browser inner width/height: 1024/697 18:49:26 INFO - PROCESS | 29430 | __metrics 18:49:26 INFO - PROCESS | 29430 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:49:27 INFO - PROCESS | 29430 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:49:27 INFO - PROCESS | 29430 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 18:49:28 INFO - TEST-INFO | 29430: exit 0 18:49:28 INFO - Browser initialized. 18:49:28 INFO - Running cycle 1/1 for dromaeo_css test... 18:49:28 INFO - TEST-INFO | started process 29526 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4Yb2zH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:49:40 INFO - PROCESS | 29526 | RSS: Main: 147226624 18:49:40 INFO - PROCESS | 29526 | 18:50:31 INFO - PROCESS | 29526 | 1451530231196 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:52:43 INFO - PROCESS | 29526 | Cycle 1(1): loaded http://localhost:44263/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44263/tests/dromaeo/cssquery-ext.html) 18:52:44 INFO - PROCESS | 29526 | RSS: Main: 266895360 18:52:44 INFO - PROCESS | 29526 | 18:55:46 INFO - PROCESS | 29526 | Cycle 1(1): loaded http://localhost:44263/tests/dromaeo/cssquery-ext.html (next: http://localhost:44263/tests/dromaeo/cssquery-jquery.html) 18:55:47 INFO - PROCESS | 29526 | RSS: Main: 233537536 18:55:47 INFO - PROCESS | 29526 | 18:58:49 INFO - PROCESS | 29526 | Cycle 1(1): loaded http://localhost:44263/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44263/tests/dromaeo/cssquery-mootools.html) 18:58:50 INFO - PROCESS | 29526 | RSS: Main: 223748096 18:58:50 INFO - PROCESS | 29526 | 19:01:51 INFO - PROCESS | 29526 | Cycle 1(1): loaded http://localhost:44263/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44263/tests/dromaeo/cssquery-prototype.html) 19:01:52 INFO - PROCESS | 29526 | RSS: Main: 210739200 19:01:52 INFO - PROCESS | 29526 | 19:04:55 INFO - PROCESS | 29526 | Cycle 1(1): loaded http://localhost:44263/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44263/tests/dromaeo/cssquery-yui.html) 19:04:55 INFO - PROCESS | 29526 | RSS: Main: 218435584 19:04:55 INFO - PROCESS | 29526 | 19:07:58 INFO - PROCESS | 29526 | Cycle 1(1): loaded http://localhost:44263/tests/dromaeo/cssquery-yui.html (next: http://localhost:44263/tests/dromaeo/cssquery-dojo.html) 19:07:58 INFO - PROCESS | 29526 | RSS: Main: 258187264 19:07:58 INFO - PROCESS | 29526 | 19:07:58 INFO - PROCESS | 29526 | __start_tp_report 19:07:58 INFO - PROCESS | 29526 | _x_x_mozilla_page_load 19:07:58 INFO - PROCESS | 29526 | _x_x_mozilla_page_load_details 19:07:58 INFO - PROCESS | 29526 | |i|pagename|runs| 19:07:58 INFO - PROCESS | 29526 | |0;dojo.html;2570.228931320604;2614.2549373428565;2649.1390298153106;2655.707872134065;2666.4267182555755;4518.073794872052;4542.159700455418;4548.999999999995;4557;4660;4518.8418405355815;4594.127115847987;4643.930341044887;4657.184992626294;4676.158291507527;4243.215005224043;4254.63835573975;4257.7445353278745;4261.29688601382;4295.3986441898005;4023.5976402359825;4297.05464797744;4312.331588603772;4333.090051089275;4355.259605867011;4157.750534967881;4215.409842622035;4224.72539284947;4238.237117318881;4282.614564689193;4226.323788193905;4233.068724880522;4242.490901091858;4249.4475718156755;4274.252005898987;4087.264292427362;4195.748255104703;4223.598758117974;4241.87274381769;4266.679999000087;4438.733675979419;4461.08547747711;4515.074409745994;4536.478304994935;4572.725636461823;4896.192128298826;4916.58209052231;4919.7540122993705;4923.679960802572;4946.604271658259;4795.400574928134;4895.608351331921;4930.852074437773;4966.602671786249;4983.9252411213865;4500.167469018242;4528.977355113237;4599.149157405891;4610.95389046112;4652.046330502239;5073.11220536412;5103.18349064148;5104.41299250591;5106.923396149061;5144.43411224765;4666.976665116721;4779.139754844162;4870.853874383774;4889.095517329305;4894.192458244421;4807.591354734816;4843.128236917319;4902.828401005948;4920.040592084509;4963.6525443218625;4859.2954021666665;4871.171900776876;4880.755962201875;4910.754462276872;4913.091078150554;4670.136024835417;4807.879803004953;4847.200211964986;4863.319135321058;4903.926441103386;3980.3034468967817;4033.556308806029;4063.227986682521;4116.835326586963;4118.814653340607;3510.297940411928;3512.7892326460496;3515;3542.7874327539917;3551.893443196708;4145.958540414617;4188.874333769992;4191.287481128215;4224.831006759757;4225.68307376948;4733.5503127202865;4814.398200224972;4838.588719958772;4887.7556122194455;4936;4214.789260536961;4228.619424251832;4233.25917964355;4248.91502169961;4264.893377665583;4197.139586384784;4356.390105385249;4357.346398040256;4382.496012958487;4386.0789234261165;4548.226801443829;4554.4990051094355;4576.679632425765;4616.422947131608;4659.044895796422;4885.1450996076255;4915.287283343967;4922.630802689741;4926.8768280793265;4981.10340138764;4499;4656.837010704609;4659.161350956861;4669.533046695304;4675.789589468414;4732.976335118303;4748.833790817304;4832.299316599003;4892.535209155125;4961.925571116364;4897.240927656219;4907.141250281115;4911.189653707098;4921.557059864629;4950.6782059166035;4610.377599024089;4760.214564596941;4767.713937163781;4779.259214821708;4823.300621409946;4649.070185962753;4672.065586882705;4684.742339171378;4686.812527498998;4781.043791241696;4672.719636821802;4681.531846815291;4684.297355396718;4693.718376897397;4717.056588682209;4778.474367819467;4781.737004464788;4781.760911954458;4790.640701947298;4829.058333624909;4510.594046535827;4608.446986361524;4620.5148459411275;4627.375304333872;4682.41469816273 19:07:58 INFO - PROCESS | 29526 | |1;ext.html;500.122285389142;502.70089296868355;505.189171379935;518.6421369255215;543.9700816455096;25159.119430819926;25573.360665983335;33013.50479742806;33107.66892331076;33208.33583328338;39147.80426097873;39631.80184099075;39844.800775996155;40182.598174018254;40193;6900.3099690031095;7995.200479951987;8160.387970902206;8165.142660020701;8188.385871059664;7032.964835175817;9718.368306060083;9947.403155810638;9952.651657192;9956.203503719722;9660.951695241514;9734.41593504392;9744.074312940294;9747.463889486075;9751.41491510508;7132.679029443636;7300.853982920312;9767.316287859852;9810.313278070538;9895.208383329353;9604.135627793532;9777.90222097777;9789.070038346346;9791.804163916753;9792.853107203326;32707.6729232707;33010.669893301;33016.33967320664;33070.677172913056;33089.33821323584;2818.4363127374404;2824.265690920355;2843.3744576193203;2847.9003234886886;3257.1368587324378;25923.22230333093;27391.726082739315;28064.719352806416;28128.296792580146;28169;3465.6707612776745;3481.686648201674;3526.7883926964464;3541.8406171722077;3583.62371950944;221964;222592;222837;223012.88493557592;223102;46063.539364605924;46615.5338446618;53554.732226338616;54325;54823.451765482634;47725.761371193614;47859.042819143426;47881.76059119682;47940.520594793605;48136.277955830694;13270.66823329405;13468.595942121752;13510.189388636712;13511.391987360395;13527.932360338134;10378;10478.214133939984;10537.683869483928;10538.156947444186;10565;17421.738673919903;18253.726194107097;18282.451526454228;18452.169652365676;18456.446306610822;7176.425885929113;7338.86247631618;7462.619415408167;7512.422391297889;7573.772786816405;819.8524265632124;903.3947255338938;984.6947446291673;998.4857798233916;1014.0923873133504;26373.472530549665;26398;26588.335291617863;27126.72873271242;27253.454930901273;979.2361957673027;982.9705108846746;1031.5203430404897;1091.7761858818924;1091.8689757229024;14014.229217393142;14301.64245893861;14595.635109122144;14829.555113346616;15021.324040418207;267912;273688;273912;273932;274042;46835.5316446838;47009.8845551951;47039.23686105103;47066.294005589945;47080.5291947083;1205.2467207995003;1208.6313674329238;1211.2526063827197;1215.5927764199093;1223.2782658231686;26347.604785927844;27016.459670806868;27123.321916951445;27253.318667033484;27631.171064868086;34993;35753.46369804507;35815.64184358123;39394.40908386319;39792.60207397889;245716;250825;251433;251508;251815;24236.272911812674;27004.72995270022;27566.173014808785;27594.724052759215;27613;26899;41320.586794131676;41523.7923810379;41598.79200604099;41953.16093678171;31348.373032538766;31873;31917.20206994844;32212.516812248305;32439.675603243664;31552.684473154975;31617.683823161475;31684;31734.365312693157;31793.205169870937;31358;31562.210944726565;31699.52450713287;31775.205619858763;32035.839820800746;27383.315417114733;28449.28876778097;28704.569431458127;28966.565501517915;29005.56491652669;22359.77640223642;22551.436214094778;22652.773472265068;22655.43361415912;22989.88505057531 19:07:58 INFO - PROCESS | 29526 | |2;jquery.html;328.44000978331945;332.390064232134;337.15038103977975;337.6539047476337;339.46195280480435;12384.876151238484;12711.745765084694;14225.857741422595;14713;15706.293216805243;7794.337481314095;9081.409708368968;9407.764805879857;11753.35356555389;14149.858501414983;4438.889027774308;4562.931556026662;4563.406757121569;4568.109218702354;4569.246074397737;3379.188994641293;4447.599716025557;4534.161180181677;4564.954350456503;5074.898502029976;4985.601151907857;5017.322661440713;5063.569596584276;5066;5069.366329208849;4924.80300787968;4983.152864013126;4985.077760614298;4985.775640096204;5039.974800125994;4810.086083644096;4814.181589129857;4814.494478079786;4818.301346304801;4819.0602832447685;11357.204995650307;14123.435062597484;15684.294206760724;19249.32627358036;19280.517987050436;1656.527889551472;1726.5597272695509;1788.4098247578268;1809.1677828199045;1839.0988415676356;8716.346274029409;10089.798204035878;11235.70789359226;12526;12907.031972601999;1667.7081510735572;1689.7465380192946;1715.0567188046525;1764.8941063536229;1806.3768000039966;55320.72339638316;58097;58251.12623310654;58452.415475845126;58788;9389.577469013911;9445;9464.574094165779;9465.858012129824;9549.283803714749;11882.108841836896;11935.283882967049;12016.459259333351;12018.15872888907;12041.21732087429;7165.534240274365;8502.957485212535;8565;8710.60802263887;8890.155435233642;7202.71189152428;7243.855122897513;7261.273872612696;7344.96327518359;7391.6304184791625;7376.815579610553;7393.593352365671;7431.554106753612;7520.1351844537485;7609.809754756176;2492.6510288559616;2998.4302982433705;3028.772842036812;3046.192758918888;3075.7385622221914;809.2918696140877;825.9256666899888;833.4913806011018;902.201551626815;903.1284810158097;15570.22648592685;15598.298076586581;15769.763453548207;16326.102064386572;16351;829.9336053115736;842.2377748137945;847.5550336073487;863.935204859638;886.8802711633975;9273.608958656256;9282.953585232166;9353.953230233805;9358.298127640453;9374.250059995184;281462;285915;466490;469803;470836;66182;72983.63508182531;74904;77086.22913770903;78218.6089069551;1016.4155610523978;1034.8344264917578;1051.3376572759112;1052.0058544675207;1054.5254635414094;14032.859671403156;14149;14164.291785410482;14478.493252736103;14561.563153105424;29858.402831942803;30423;31155.065348039596;32003.519947201275;32629.18427039343;39757;41012.179756405305;41310.38034429426;41354;42508.36237456379;8619.91380086191;8729.519876406604;8882.60028298741;8923.598438070172;8960.68637597681;13514.256715880721;14460.27698615086;16225.945313555054;16557.006579605262;17153.22810473557;14009.369578369202;14209.431622734975;14279.500217492337;14306.499272525412;14324.785128223293;13401.06192566511;13773.862261377259;13923.651908702364;14033.087849289763;14253;14129.929350353183;14361.928190358982;14612.488562900673;14677.339519721852;14835.406583736529;8647.092055334351;8708.129187081242;8786.428882122642;8840.160184782435;8843.292536597186;13901.0964287321;14002.229877356436;14077.929610351883;14279.143251404948;14479.203643799692 19:07:58 INFO - PROCESS | 29526 | |3;mootools.html;1086.8967448092428;1381.3921874375278;1388.0838646493314;1500.5348342013976;1731.264212709599;5736.856578585533;5897.02699054656;6586.176727909012;6685.665716714157;6688.264290928007;6742.359475849787;6786.694598743056;6813.931860681391;6840.179178498574;6840.2133754618235;2018.5962807438498;2052.887091209983;2053.4558342039372;2057.5164836263466;2057.5987682401937;2073.813356797888;2084.3642688979853;2092.016752126498;2130.0734180631475;2131.3179782469615;2038.9082491287854;2047.8361731061555;2074.3984244569056;2076.0035183112113;2076.1176499987446;2038.1337931379178;2067.1008111471406;2071.0887209627717;2071.585682863426;2073.1810934680866;2046.4270004398793;2074.481379655086;2114.5770845830893;2117.4388786971463;2118.7033815265877;6687.899681504781;6761.391474767245;6761.4590832733265;6763.898541521881;6776.728930842761;3859.0352411897024;3922.235164142993;3924.2936271471126;3929.4105884117325;3932.5674175840636;2470.7899828514596;2471.765182307678;2509.4353770401513;2566.089038391363;2568.2808813532242;789.1556035042507;790.5375355417087;805.9516429014219;807.6850028488894;817.8773184022385;8867.334949878785;8892.644294228223;8895.110488951117;8896.110388961117;8900.109989001114;3614.765040272374;3632.9636703633155;3671.3391589514144;3678.062094166024;3706.1661126246377;7690.692372305157;7691.615419229128;7694.038245219348;7706.229377062249;7709.190534993745;4017.0760725032824;4018.2767101921936;4022.155347377025;4023.5171779386073;4026.8187931543152;3036.347185355159;3123.984380078085;3545.556805399325;3646.781193128421;3649.85400583979;3236.2394837213237;3273.558069660613;3296.241864371208;3319.286353434023;3332.483465062919;1015.7409860485529;1041.4792603698152;1046.9685909422728;1053.3153450257241;1054.4147997861107;948.7817801905462;1119.5074167366333;1133.9489722962487;1141.7887690777234;1141.8858114188515;6139.57023008394;6181.258249010148;6188.504919606511;6190.3190649028575;6190.350013248634;987.8172538080478;1016.065219997604;1027.3271007490107;1029.3904950949457;1052.153016821466;4842.370491836039;4872.342233798392;4873.269009648581;4878.731669758197;4885.8045678173185;7738.071431428152;7789.260020298176;7930.325922296554;8015.358771298399;8018.077921039038;7840;7845.1762564931005;7848.725294614661;7923.683052677944;7944.165862584461;6358.078078678565;6393.328700486475;6440.6135631862235;6471.644059576768;6481.09264702942;6054.576179667381;6062.969685151546;6212.782552610637;6249.96875015622;6256.31180570146;7157.57054576727;7198.928010719826;7246.601436920809;7297.124345078624;7365;7420.740274090381;7588.886166707393;7621.237876212556;7633.923660763321;7641.617919104134;5145.331106956071;5193.714345711022;6127.84680382994;6205.82089403012;6221.129041934042;6161.507079433545;6215.595986260879;6216.658083805434;6218.968905155445;6233;5722.885542289214;5807.041838096667;5873.353931067664;5976.551758618208;6100.420460056288;5759.56803239767;5879.882402352015;5954.553408494294;5961.791337303173;5986.850328741816;5882.49998750111;5939.851503712442;5943.910841337297;6052.455279024909;6093.329733729375;5675.772969081356;5700.600957932905;5709.857253568528;5717.228174196596;5719.656820590778;5784.971075144597;5796.42035796417;5804.65172089676;5812.94187058141;5814.360420353673 19:07:58 INFO - PROCESS | 29526 | |4;prototype.html;276.8214501646438;286.8551381552315;291.52044886162264;300.9458297506449;303.45075413501576;5270.314859068325;5278;5305.991861546308;5318.335208098988;5371.677699338043;5254.658447200929;5262.578993680506;5265.104932161532;5265.605079619035;5274.736263186835;4112.2186784511;4112.5064992200905;4113.835446582133;4116.835326586948;4117.341225403936;3872.67082298005;3967.682585393162;3996.380561013033;4077.612626800464;4081.693872959525;4023.718339716206;4042.7978601069976;4072.7149099563044;4073.368627862686;4075.3071977763702;3815.084379748868;3893.0851249956236;4064.3903414487913;4066.085130845566;4072.1448495815916;3482;3549.591796943333;3557.5553055868018;3557.94663080054;3561.893143205708;4978.402591688984;5037.244413337992;5067.0879241736475;5073.3911930568565;5079.009593129341;4681.0871879983415;4681.485036645966;4683.601893839028;4693.6010439112715;4694.507076756926;5405.162199859028;5540.695261760601;5544.7227638618315;5547.195656629807;5552.333719953591;3884.4173373993845;3885.30064588374;3888.669463095612;3889.552701439314;3892.6885849132;5827.504662103684;5835.066389377722;5838.64968101911;5840.065589505659;5840.561957853136;3992.2813893499447;4009.4186342980106;4011.1576568920855;4011.338129208648;4013.5585085640555;4058.5738497457933;4061.9593804062174;4062.5531191568903;4066.1664358806374;4068.9796551017057;4503.279475284005;4642.419697537808;4652.581267685924;4655.627549796008;4656.4412270527755;5523.751431185607;5528.115501519737;5529.142982837667;5530.585206109477;5535.612507124462;1415.8725714685522;1437.4465830655272;1438.6547228665254;1439.604108870048;1440.1431148466645;969.6315400147898;978.6183388478499;978.7259567321162;995;998.3311181508407;4900.8774780630765;4903.779329930162;4903.975480122576;4905.5094490550655;4906.165951788204;5771.134329850556;5774.307083150049;5777.075667893117;5783.1325301204315;5788.739506722208;4898.044881248194;4901.289313049588;4901.754912254373;4903.828366007173;4907.043126590281;2990.2524368907775;2991.970080299213;3084.6452657944174;3115.5482455043893;3118.532220166948;5400.459954004568;5439.918401223985;5538.47384498472;5559.360673522516;5559.388467268597;5978.342382337939;5990.520758339322;5991.681829997394;5997.0404735242155;5997.250343707036;5523.8066667666435;5529.203009022084;5532.363778165482;5534.1975413565615;5540.141278101901;5603.159526071122;5802.912956305743;5823.242978412779;5830.53355731549;5837;5669.262995810518;5676.68778217202;5678.403767604507;5680.77276908919;5687.317521897398;5501.669899806025;5527.281453411031;5533.280673512418;5537.335519737658;5538.169274608841;3831.65515103642;3872.4897290057465;3917.177392747555;3922.4312474691583;3927.3912543555793;5807.535397168132;5821.214136091573;5821.738021788945;5822.70886455684;5826.533877289891;5588.608797384144;5590.5248053915875;5591.552675785846;5592.384837667934;5592.720363981866;5586.273784408001;5586.636868603528;5587.8882422352135;5588.413216612197;5590.133529302964;5361.169018802092;5440.483154100354;5476.096444086681;5477.616566840283;5487.341519017744;5608.9158662619275;5608.971955140361;5613.46672066153;5614.550835933034;5618.381977982337;5443.537299329601;5446.665566936126;5447.809326673548;5447.972760136174;5493.505584497414 19:07:58 INFO - PROCESS | 29526 | |5;yui.html;675.1122274209414;722.2632914427285;723.0311382747119;766.9760869239564;767.715945100313;10318.896811031887;10460.738481537956;10464.68605941821;10469.371837689725;10470.424126673039;10330.896691033087;10479.476026198698;10485;10532.894671053287;10615.84076238857;623.0374072058657;629.8834715577633;766.0462723908728;782.9412794040442;795.5107608820563;791.0665414810521;792;797.3063434811722;797.6330887791623;798.5807451088167;645.1516256123207;830.8629076202419;836.7071524966243;837.6314421654453;838.3335248477475;648.6853875870199;814.0434988888062;829.2453866981078;835.1648351648352;835.2816577743137;608.242737791448;611.6360765344657;612.6201754911939;617.1452538234532;617.3301967365414;10084.49577521121;10143.89856101437;10186.847197292047;10190.49047547627;10195.235357348229;10267.486625668762;10678.305910115818;10953.945230273797;11101.000909918066;11499.137564682598;9197.724068277963;9219.631214751402;9359.110884465965;9494.192993595552;9515.762105947337;3007.849607519637;3040.148758347666;3046.4211799757977;3068.5243787213017;3125.3749250150063;37666.62333376658;37944.43083353752;38012.42981355282;38036.23927521462;38065.23869522622;7935.761927142195;8081.272685458337;8150;8282.296004839656;8293.046299675494;15318.234088295541;15319.770203446957;15326.693466130615;15346.846531534766;15348.846511534743;6138.416850399205;6169.96915015422;6332.050192471074;6376.936230637727;6400.423961843363;3544.4328907374697;3643.653852883972;3663.5420572428447;3665;3677.356462619031;2545.223706769453;2576.188500622298;2577.4200804819143;2580.3936075022357;2580.509703156394;459.0199923164002;464.0764877892969;467.752091391563;479.28586406255124;484.3098584517049;415.71523506398216;416.72287928527794;420.45551011440256;424.645421073401;427.393101795445;7224.927750722425;7276.63616819157;7478.962605187048;7518.210587888193;7586.089669239726;564.9406812284733;588.141313682029;600.9308929473079;605.9818205453755;611.944924956756;3394.321135772806;3673.1184515716036;3907.4138879167785;4031.173609410064;4128.153728485653;48117.75941120272;49143;49152.75423622859;49217.26174107391;49468.75265623649;41632.583674162874;42510.362344564855;42788.35817462741;42835.35746963798;42900;38744;38842.22315553673;38946.61053389486;39026.609733902864;39471.60528394737;7922.603869806602;7972.402069844901;8011.599420028859;8190.303824174774;8252.504849709037;29058.564121538617;29075.418491630473;29603;29838;29839.25401864884;35521.467177991835;37457.62542374541;37569.62430375771;37599.81200093982;38030.288637010846;9820.65627703027;9944.411661154183;9945.254105941938;10126.291159619052;10138;10266.598625637194;10313.071823535918;10884.673459796219;11369.431528423711;11491.94254028758;9419.481928493999;9771.413715177112;10007.349522281029;10662.200334974752;10989.450527473755;10283.382997020202;10675.145988321072;10737.355758654505;10877;11040.392778397265;7416.866635794386;8577.313814894918;8620.396572239883;9902.603895844373;10515.684529464128;8608.698695545625;8824.558772061242;8982.550872456482;8999.910000900169;9474.621015159317;7925.484843485155;8037.879431808411;8054.718084867001;8084.555349455836;8624.698135565224 19:07:58 INFO - PROCESS | 29526 | __end_tp_report 19:07:58 INFO - PROCESS | 29526 | __start_cc_report 19:07:58 INFO - PROCESS | 29526 | _x_x_mozilla_cycle_collect,996 19:07:58 INFO - PROCESS | 29526 | __end_cc_report 19:07:58 INFO - PROCESS | 29526 | __startTimestamp1451531278706__endTimestamp 19:07:58 INFO - PROCESS | 29526 | 19:07:58 INFO - PROCESS | 29526 | ------- Summary: start ------- 19:07:58 INFO - PROCESS | 29526 | Number of tests: 6 19:07:58 INFO - PROCESS | 29526 | 19:07:58 INFO - PROCESS | 29526 | [#0] dojo.html Cycles:165 Average:4517.78 Median:4652.05 stddev:472.88 (10.2%) stddev-sans-first:448.97 19:07:58 INFO - PROCESS | 29526 | Values: 2570.2 2614.3 2649.1 2655.7 2666.4 4518.1 4542.2 4549.0 4557.0 4660.0 4518.8 4594.1 4643.9 4657.2 4676.2 4243.2 4254.6 4257.7 4261.3 4295.4 4023.6 4297.1 4312.3 4333.1 4355.3 4157.8 4215.4 4224.7 4238.2 4282.6 4226.3 4233.1 4242.5 4249.4 4274.3 4087.3 4195.7 4223.6 4241.9 4266.7 4438.7 4461.1 4515.1 4536.5 4572.7 4896.2 4916.6 4919.8 4923.7 4946.6 4795.4 4895.6 4930.9 4966.6 4983.9 4500.2 4529.0 4599.1 4611.0 4652.0 5073.1 5103.2 5104.4 5106.9 5144.4 4667.0 4779.1 4870.9 4889.1 4894.2 4807.6 4843.1 4902.8 4920.0 4963.7 4859.3 4871.2 4880.8 4910.8 4913.1 4670.1 4807.9 4847.2 4863.3 4903.9 3980.3 4033.6 4063.2 4116.8 4118.8 3510.3 3512.8 3515.0 3542.8 3551.9 4146.0 4188.9 4191.3 4224.8 4225.7 4733.6 4814.4 4838.6 4887.8 4936.0 4214.8 4228.6 4233.3 4248.9 4264.9 4197.1 4356.4 4357.3 4382.5 4386.1 4548.2 4554.5 4576.7 4616.4 4659.0 4885.1 4915.3 4922.6 4926.9 4981.1 4499.0 4656.8 4659.2 4669.5 4675.8 4733.0 4748.8 4832.3 4892.5 4961.9 4897.2 4907.1 4911.2 4921.6 4950.7 4610.4 4760.2 4767.7 4779.3 4823.3 4649.1 4672.1 4684.7 4686.8 4781.0 4672.7 4681.5 4684.3 4693.7 4717.1 4778.5 4781.7 4781.8 4790.6 4829.1 4510.6 4608.4 4620.5 4627.4 4682.4 19:07:58 INFO - PROCESS | 29526 | 19:07:58 INFO - PROCESS | 29526 | [#1] ext.html Cycles:180 Average:40127.19 Median:31833.10 stddev:64918.82 (203.9%) stddev-sans-first:65032.75 19:07:58 INFO - PROCESS | 29526 | Values: 500.1 502.7 505.2 518.6 544.0 25159.1 25573.4 33013.5 33107.7 33208.3 39147.8 39631.8 39844.8 40182.6 40193.0 6900.3 7995.2 8160.4 8165.1 8188.4 7033.0 9718.4 9947.4 9952.7 9956.2 9661.0 9734.4 9744.1 9747.5 9751.4 7132.7 7300.9 9767.3 9810.3 9895.2 9604.1 9777.9 9789.1 9791.8 9792.9 32707.7 33010.7 33016.3 33070.7 33089.3 2818.4 2824.3 2843.4 2847.9 3257.1 25923.2 27391.7 28064.7 28128.3 28169.0 3465.7 3481.7 3526.8 3541.8 3583.6 221964.0 222592.0 222837.0 223012.9 223102.0 46063.5 46615.5 53554.7 54325.0 54823.5 47725.8 47859.0 47881.8 47940.5 48136.3 13270.7 13468.6 13510.2 13511.4 13527.9 10378.0 10478.2 10537.7 10538.2 10565.0 17421.7 18253.7 18282.5 18452.2 18456.4 7176.4 7338.9 7462.6 7512.4 7573.8 819.9 903.4 984.7 998.5 1014.1 26373.5 26398.0 26588.3 27126.7 27253.5 979.2 983.0 1031.5 1091.8 1091.9 14014.2 14301.6 14595.6 14829.6 15021.3 267912.0 273688.0 273912.0 273932.0 274042.0 46835.5 47009.9 47039.2 47066.3 47080.5 1205.2 1208.6 1211.3 1215.6 1223.3 26347.6 27016.5 27123.3 27253.3 27631.2 34993.0 35753.5 35815.6 39394.4 39792.6 245716.0 250825.0 251433.0 251508.0 251815.0 24236.3 27004.7 27566.2 27594.7 27613.0 26899.0 41320.6 41523.8 41598.8 41953.2 31348.4 31873.0 31917.2 32212.5 32439.7 31552.7 31617.7 31684.0 31734.4 31793.2 31358.0 31562.2 31699.5 31775.2 32035.8 27383.3 28449.3 28704.6 28966.6 29005.6 22359.8 22551.4 22652.8 22655.4 22989.9 19:07:58 INFO - PROCESS | 29526 | 19:07:58 INFO - PROCESS | 29526 | [#2] jquery.html Cycles:180 Average:23825.11 Median:41161.28 stddev:66484.47 (161.5%) stddev-sans-first:66647.57 19:07:58 INFO - PROCESS | 29526 | Values: 328.4 332.4 337.2 337.7 339.5 12384.9 12711.7 14225.9 14713.0 15706.3 7794.3 9081.4 9407.8 11753.4 14149.9 4438.9 4562.9 4563.4 4568.1 4569.2 3379.2 4447.6 4534.2 4565.0 5074.9 4985.6 5017.3 5063.6 5066.0 5069.4 4924.8 4983.2 4985.1 4985.8 5040.0 4810.1 4814.2 4814.5 4818.3 4819.1 11357.2 14123.4 15684.3 19249.3 19280.5 1656.5 1726.6 1788.4 1809.2 1839.1 8716.3 10089.8 11235.7 12526.0 12907.0 1667.7 1689.7 1715.1 1764.9 1806.4 55320.7 58097.0 58251.1 58452.4 58788.0 9389.6 9445.0 9464.6 9465.9 9549.3 11882.1 11935.3 12016.5 12018.2 12041.2 7165.5 8503.0 8565.0 8710.6 8890.2 7202.7 7243.9 7261.3 7345.0 7391.6 7376.8 7393.6 7431.6 7520.1 7609.8 2492.7 2998.4 3028.8 3046.2 3075.7 809.3 825.9 833.5 902.2 903.1 15570.2 15598.3 15769.8 16326.1 16351.0 829.9 842.2 847.6 863.9 886.9 9273.6 9283.0 9354.0 9358.3 9374.3 281462.0 285915.0 466490.0 469803.0 470836.0 66182.0 72983.6 74904.0 77086.2 78218.6 1016.4 1034.8 1051.3 1052.0 1054.5 14032.9 14149.0 14164.3 14478.5 14561.6 29858.4 30423.0 31155.1 32003.5 32629.2 39757.0 41012.2 41310.4 41354.0 42508.4 8619.9 8729.5 8882.6 8923.6 8960.7 13514.3 14460.3 16225.9 16557.0 17153.2 14009.4 14209.4 14279.5 14306.5 14324.8 13401.1 13773.9 13923.7 14033.1 14253.0 14129.9 14361.9 14612.5 14677.3 14835.4 8647.1 8708.1 8786.4 8840.2 8843.3 13901.1 14002.2 14077.9 14279.1 14479.2 19:07:58 INFO - PROCESS | 29526 | 19:07:58 INFO - PROCESS | 29526 | [#3] mootools.html Cycles:180 Average:4682.25 Median:5805.85 stddev:2375.68 (40.9%) stddev-sans-first:2366.96 19:07:58 INFO - PROCESS | 29526 | Values: 1086.9 1381.4 1388.1 1500.5 1731.3 5736.9 5897.0 6586.2 6685.7 6688.3 6742.4 6786.7 6813.9 6840.2 6840.2 2018.6 2052.9 2053.5 2057.5 2057.6 2073.8 2084.4 2092.0 2130.1 2131.3 2038.9 2047.8 2074.4 2076.0 2076.1 2038.1 2067.1 2071.1 2071.6 2073.2 2046.4 2074.5 2114.6 2117.4 2118.7 6687.9 6761.4 6761.5 6763.9 6776.7 3859.0 3922.2 3924.3 3929.4 3932.6 2470.8 2471.8 2509.4 2566.1 2568.3 789.2 790.5 806.0 807.7 817.9 8867.3 8892.6 8895.1 8896.1 8900.1 3614.8 3633.0 3671.3 3678.1 3706.2 7690.7 7691.6 7694.0 7706.2 7709.2 4017.1 4018.3 4022.2 4023.5 4026.8 3036.3 3124.0 3545.6 3646.8 3649.9 3236.2 3273.6 3296.2 3319.3 3332.5 1015.7 1041.5 1047.0 1053.3 1054.4 948.8 1119.5 1133.9 1141.8 1141.9 6139.6 6181.3 6188.5 6190.3 6190.4 987.8 1016.1 1027.3 1029.4 1052.2 4842.4 4872.3 4873.3 4878.7 4885.8 7738.1 7789.3 7930.3 8015.4 8018.1 7840.0 7845.2 7848.7 7923.7 7944.2 6358.1 6393.3 6440.6 6471.6 6481.1 6054.6 6063.0 6212.8 6250.0 6256.3 7157.6 7198.9 7246.6 7297.1 7365.0 7420.7 7588.9 7621.2 7633.9 7641.6 5145.3 5193.7 6127.8 6205.8 6221.1 6161.5 6215.6 6216.7 6219.0 6233.0 5722.9 5807.0 5873.4 5976.6 6100.4 5759.6 5879.9 5954.6 5961.8 5986.9 5882.5 5939.9 5943.9 6052.5 6093.3 5675.8 5700.6 5709.9 5717.2 5719.7 5785.0 5796.4 5804.7 5812.9 5814.4 19:07:58 INFO - PROCESS | 29526 | 19:07:58 INFO - PROCESS | 29526 | [#4] prototype.html Cycles:180 Average:4617.83 Median:5276.37 stddev:1368.16 (25.9%) stddev-sans-first:1332.64 19:07:58 INFO - PROCESS | 29526 | Values: 276.8 286.9 291.5 300.9 303.5 5270.3 5278.0 5306.0 5318.3 5371.7 5254.7 5262.6 5265.1 5265.6 5274.7 4112.2 4112.5 4113.8 4116.8 4117.3 3872.7 3967.7 3996.4 4077.6 4081.7 4023.7 4042.8 4072.7 4073.4 4075.3 3815.1 3893.1 4064.4 4066.1 4072.1 3482.0 3549.6 3557.6 3557.9 3561.9 4978.4 5037.2 5067.1 5073.4 5079.0 4681.1 4681.5 4683.6 4693.6 4694.5 5405.2 5540.7 5544.7 5547.2 5552.3 3884.4 3885.3 3888.7 3889.6 3892.7 5827.5 5835.1 5838.6 5840.1 5840.6 3992.3 4009.4 4011.2 4011.3 4013.6 4058.6 4062.0 4062.6 4066.2 4069.0 4503.3 4642.4 4652.6 4655.6 4656.4 5523.8 5528.1 5529.1 5530.6 5535.6 1415.9 1437.4 1438.7 1439.6 1440.1 969.6 978.6 978.7 995.0 998.3 4900.9 4903.8 4904.0 4905.5 4906.2 5771.1 5774.3 5777.1 5783.1 5788.7 4898.0 4901.3 4901.8 4903.8 4907.0 2990.3 2992.0 3084.6 3115.5 3118.5 5400.5 5439.9 5538.5 5559.4 5559.4 5978.3 5990.5 5991.7 5997.0 5997.3 5523.8 5529.2 5532.4 5534.2 5540.1 5603.2 5802.9 5823.2 5830.5 5837.0 5669.3 5676.7 5678.4 5680.8 5687.3 5501.7 5527.3 5533.3 5537.3 5538.2 3831.7 3872.5 3917.2 3922.4 3927.4 5807.5 5821.2 5821.7 5822.7 5826.5 5588.6 5590.5 5591.6 5592.4 5592.7 5586.3 5586.6 5587.9 5588.4 5590.1 5361.2 5440.5 5476.1 5477.6 5487.3 5608.9 5609.0 5613.5 5614.6 5618.4 5443.5 5446.7 5447.8 5448.0 5493.5 19:07:58 INFO - PROCESS | 29526 | 19:07:58 INFO - PROCESS | 29526 | [#5] yui.html Cycles:180 Average:11631.41 Median:21679.51 stddev:13228.14 (61.0%) stddev-sans-first:13239.66 19:07:58 INFO - PROCESS | 29526 | Values: 675.1 722.3 723.0 767.0 767.7 10318.9 10460.7 10464.7 10469.4 10470.4 10330.9 10479.5 10485.0 10532.9 10615.8 623.0 629.9 766.0 782.9 795.5 791.1 792.0 797.3 797.6 798.6 645.2 830.9 836.7 837.6 838.3 648.7 814.0 829.2 835.2 835.3 608.2 611.6 612.6 617.1 617.3 10084.5 10143.9 10186.8 10190.5 10195.2 10267.5 10678.3 10953.9 11101.0 11499.1 9197.7 9219.6 9359.1 9494.2 9515.8 3007.8 3040.1 3046.4 3068.5 3125.4 37666.6 37944.4 38012.4 38036.2 38065.2 7935.8 8081.3 8150.0 8282.3 8293.0 15318.2 15319.8 15326.7 15346.8 15348.8 6138.4 6170.0 6332.1 6376.9 6400.4 3544.4 3643.7 3663.5 3665.0 3677.4 2545.2 2576.2 2577.4 2580.4 2580.5 459.0 464.1 467.8 479.3 484.3 415.7 416.7 420.5 424.6 427.4 7224.9 7276.6 7479.0 7518.2 7586.1 564.9 588.1 600.9 606.0 611.9 3394.3 3673.1 3907.4 4031.2 4128.2 48117.8 49143.0 49152.8 49217.3 49468.8 41632.6 42510.4 42788.4 42835.4 42900.0 38744.0 38842.2 38946.6 39026.6 39471.6 7922.6 7972.4 8011.6 8190.3 8252.5 29058.6 29075.4 29603.0 29838.0 29839.3 35521.5 37457.6 37569.6 37599.8 38030.3 9820.7 9944.4 9945.3 10126.3 10138.0 10266.6 10313.1 10884.7 11369.4 11491.9 9419.5 9771.4 10007.3 10662.2 10989.5 10283.4 10675.1 10737.4 10877.0 11040.4 7416.9 8577.3 8620.4 9902.6 10515.7 8608.7 8824.6 8982.6 8999.9 9474.6 7925.5 8037.9 8054.7 8084.6 8624.7 19:07:58 INFO - PROCESS | 29526 | -------- Summary: end -------- 19:07:58 INFO - PROCESS | 29526 | 19:07:59 INFO - TEST-INFO | 29526: exit 0 19:07:59 INFO - TEST-OK | dromaeo_css | took 1117510ms 19:07:59 INFO - TEST-START | kraken 19:07:59 INFO - operating with platform_type : linux_ 19:07:59 INFO - Initialising browser for kraken test... 19:07:59 INFO - TEST-INFO | started process 29713 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpULZ5JS/profile http://localhost:44263/getInfo.html) 19:08:04 INFO - PROCESS | 29713 | __metrics Screen width/height:1600/1200 19:08:04 INFO - PROCESS | 29713 | colorDepth:24 19:08:04 INFO - PROCESS | 29713 | Browser inner width/height: 1024/697 19:08:04 INFO - PROCESS | 29713 | __metrics 19:08:04 INFO - PROCESS | 29713 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:08:04 INFO - PROCESS | 29713 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:08:05 INFO - TEST-INFO | 29713: exit 0 19:08:05 INFO - Browser initialized. 19:08:05 INFO - Running cycle 1/1 for kraken test... 19:08:05 INFO - TEST-INFO | started process 29797 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpULZ5JS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:08:17 INFO - PROCESS | 29797 | RSS: Main: 149463040 19:08:17 INFO - PROCESS | 29797 | 19:08:19 INFO - PROCESS | 29797 | Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44263/tests/kraken/driver.html?testName=audio-beat-detection) 19:08:20 INFO - PROCESS | 29797 | RSS: Main: 185298944 19:08:20 INFO - PROCESS | 29797 | 19:08:23 INFO - PROCESS | 29797 | Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44263/tests/kraken/driver.html?testName=audio-dft) 19:08:23 INFO - PROCESS | 29797 | RSS: Main: 176467968 19:08:23 INFO - PROCESS | 29797 | 19:08:26 INFO - PROCESS | 29797 | Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44263/tests/kraken/driver.html?testName=audio-fft) 19:08:27 INFO - PROCESS | 29797 | RSS: Main: 160247808 19:08:27 INFO - PROCESS | 29797 | 19:08:29 INFO - PROCESS | 29797 | Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44263/tests/kraken/driver.html?testName=audio-oscillator) 19:08:30 INFO - PROCESS | 29797 | RSS: Main: 162361344 19:08:30 INFO - PROCESS | 29797 | 19:08:32 INFO - PROCESS | 29797 | Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44263/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:08:32 INFO - PROCESS | 29797 | RSS: Main: 165076992 19:08:32 INFO - PROCESS | 29797 | 19:08:35 INFO - PROCESS | 29797 | Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44263/tests/kraken/driver.html?testName=imaging-darkroom) 19:08:36 INFO - PROCESS | 29797 | RSS: Main: 165707776 19:08:36 INFO - PROCESS | 29797 | 19:08:39 INFO - PROCESS | 29797 | Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44263/tests/kraken/driver.html?testName=imaging-desaturate) 19:08:40 INFO - PROCESS | 29797 | RSS: Main: 165089280 19:08:40 INFO - PROCESS | 29797 | 19:08:43 INFO - PROCESS | 29797 | Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44263/tests/kraken/driver.html?testName=json-parse-financial) 19:08:43 INFO - PROCESS | 29797 | RSS: Main: 165511168 19:08:43 INFO - PROCESS | 29797 | 19:08:45 INFO - PROCESS | 29797 | Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44263/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:08:46 INFO - PROCESS | 29797 | RSS: Main: 175456256 19:08:46 INFO - PROCESS | 29797 | 19:08:48 INFO - PROCESS | 29797 | Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44263/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:08:48 INFO - PROCESS | 29797 | RSS: Main: 174845952 19:08:48 INFO - PROCESS | 29797 | 19:08:50 INFO - PROCESS | 29797 | Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44263/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:08:51 INFO - PROCESS | 29797 | RSS: Main: 188350464 19:08:51 INFO - PROCESS | 29797 | 19:08:53 INFO - PROCESS | 29797 | Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:08:54 INFO - PROCESS | 29797 | RSS: Main: 192901120 19:08:54 INFO - PROCESS | 29797 | 19:08:57 INFO - PROCESS | 29797 | Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:08:57 INFO - PROCESS | 29797 | RSS: Main: 190918656 19:08:57 INFO - PROCESS | 29797 | 19:08:59 INFO - PROCESS | 29797 | Cycle 1(1): loaded http://localhost:44263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44263/tests/kraken/driver.html?testName=ai-astar) 19:08:59 INFO - PROCESS | 29797 | RSS: Main: 248287232 19:08:59 INFO - PROCESS | 29797 | 19:08:59 INFO - PROCESS | 29797 | __start_tp_report 19:08:59 INFO - PROCESS | 29797 | _x_x_mozilla_page_load 19:08:59 INFO - PROCESS | 29797 | _x_x_mozilla_page_load_details 19:08:59 INFO - PROCESS | 29797 | |i|pagename|runs| 19:08:59 INFO - PROCESS | 29797 | |0;ai-astar;112;115;109;113;112;114;102;113;112;102 19:08:59 INFO - PROCESS | 29797 | |1;audio-beat-detection;158;133;155;168;136;153;150;132;171;130 19:08:59 INFO - PROCESS | 29797 | |2;audio-dft;162;163;161;160;162;162;162;163;164;162 19:08:59 INFO - PROCESS | 29797 | |3;audio-fft;73;73;87;90;73;73;72;104;89;78 19:08:59 INFO - PROCESS | 29797 | |4;audio-oscillator;98;99;130;97;99;98;136;98;99;139 19:08:59 INFO - PROCESS | 29797 | |5;imaging-gaussian-blur;110;109;109;109;109;109;110;110;109;110 19:08:59 INFO - PROCESS | 29797 | |6;imaging-darkroom;147;147;147;147;147;146;147;147;147;146 19:08:59 INFO - PROCESS | 29797 | |7;imaging-desaturate;97;96;95;96;96;96;96;95;96;96 19:08:59 INFO - PROCESS | 29797 | |8;json-parse-financial;73;74;73;73;73;73;73;81;70;71 19:08:59 INFO - PROCESS | 29797 | |9;json-stringify-tinderbox;69;70;69;69;69;71;70;69;69;70 19:08:59 INFO - PROCESS | 29797 | |10;stanford-crypto-aes;85;93;85;85;86;86;86;87;86;86 19:08:59 INFO - PROCESS | 29797 | |11;stanford-crypto-ccm;120;121;125;125;139;126;122;128;130;122 19:08:59 INFO - PROCESS | 29797 | |12;stanford-crypto-pbkdf2;148;158;162;148;151;138;149;149;143;138 19:08:59 INFO - PROCESS | 29797 | |13;stanford-crypto-sha256-iterative;72;71;70;69;70;73;70;71;72;73 19:08:59 INFO - PROCESS | 29797 | __end_tp_report 19:08:59 INFO - PROCESS | 29797 | __start_cc_report 19:08:59 INFO - PROCESS | 29797 | _x_x_mozilla_cycle_collect,994 19:08:59 INFO - PROCESS | 29797 | __end_cc_report 19:08:59 INFO - PROCESS | 29797 | __startTimestamp1451531339804__endTimestamp 19:08:59 INFO - PROCESS | 29797 | 19:08:59 INFO - PROCESS | 29797 | ------- Summary: start ------- 19:08:59 INFO - PROCESS | 29797 | Number of tests: 14 19:08:59 INFO - PROCESS | 29797 | 19:08:59 INFO - PROCESS | 29797 | [#0] ai-astar Cycles:10 Average:110.40 Median:112.50 stddev:4.70 (4.2%) stddev-sans-first:4.94 19:08:59 INFO - PROCESS | 29797 | Values: 112.0 115.0 109.0 113.0 112.0 114.0 102.0 113.0 112.0 102.0 19:08:59 INFO - PROCESS | 29797 | 19:08:59 INFO - PROCESS | 29797 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:154.00 stddev:15.10 (9.8%) stddev-sans-first:15.63 19:08:59 INFO - PROCESS | 29797 | Values: 158.0 133.0 155.0 168.0 136.0 153.0 150.0 132.0 171.0 130.0 19:08:59 INFO - PROCESS | 29797 | 19:08:59 INFO - PROCESS | 29797 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 19:08:59 INFO - PROCESS | 29797 | Values: 162.0 163.0 161.0 160.0 162.0 162.0 162.0 163.0 164.0 162.0 19:08:59 INFO - PROCESS | 29797 | 19:08:59 INFO - PROCESS | 29797 | [#3] audio-fft Cycles:10 Average:81.20 Median:75.50 stddev:10.83 (14.3%) stddev-sans-first:11.07 19:08:59 INFO - PROCESS | 29797 | Values: 73.0 73.0 87.0 90.0 73.0 73.0 72.0 104.0 89.0 78.0 19:08:59 INFO - PROCESS | 29797 | 19:08:59 INFO - PROCESS | 29797 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:98.00 stddev:17.88 (18.2%) stddev-sans-first:18.49 19:08:59 INFO - PROCESS | 29797 | Values: 98.0 99.0 130.0 97.0 99.0 98.0 136.0 98.0 99.0 139.0 19:08:59 INFO - PROCESS | 29797 | 19:08:59 INFO - PROCESS | 29797 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 19:08:59 INFO - PROCESS | 29797 | Values: 110.0 109.0 109.0 109.0 109.0 109.0 110.0 110.0 109.0 110.0 19:08:59 INFO - PROCESS | 29797 | 19:08:59 INFO - PROCESS | 29797 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 19:08:59 INFO - PROCESS | 29797 | Values: 147.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 146.0 19:08:59 INFO - PROCESS | 29797 | 19:08:59 INFO - PROCESS | 29797 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 19:08:59 INFO - PROCESS | 29797 | Values: 97.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 19:08:59 INFO - PROCESS | 29797 | 19:08:59 INFO - PROCESS | 29797 | [#8] json-parse-financial Cycles:10 Average:73.40 Median:73.00 stddev:2.91 (4.0%) stddev-sans-first:3.09 19:08:59 INFO - PROCESS | 29797 | Values: 73.0 74.0 73.0 73.0 73.0 73.0 73.0 81.0 70.0 71.0 19:08:59 INFO - PROCESS | 29797 | 19:08:59 INFO - PROCESS | 29797 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:69.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 19:08:59 INFO - PROCESS | 29797 | Values: 69.0 70.0 69.0 69.0 69.0 71.0 70.0 69.0 69.0 70.0 19:08:59 INFO - PROCESS | 29797 | 19:08:59 INFO - PROCESS | 29797 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.00 stddev:2.37 (2.8%) stddev-sans-first:2.45 19:08:59 INFO - PROCESS | 29797 | Values: 85.0 93.0 85.0 85.0 86.0 86.0 86.0 87.0 86.0 86.0 19:08:59 INFO - PROCESS | 29797 | 19:08:59 INFO - PROCESS | 29797 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:125.50 stddev:5.61 (4.5%) stddev-sans-first:5.55 19:08:59 INFO - PROCESS | 29797 | Values: 120.0 121.0 125.0 125.0 139.0 126.0 122.0 128.0 130.0 122.0 19:08:59 INFO - PROCESS | 29797 | 19:08:59 INFO - PROCESS | 29797 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.40 Median:149.00 stddev:7.68 (5.2%) stddev-sans-first:8.14 19:08:59 INFO - PROCESS | 29797 | Values: 148.0 158.0 162.0 148.0 151.0 138.0 149.0 149.0 143.0 138.0 19:08:59 INFO - PROCESS | 29797 | 19:08:59 INFO - PROCESS | 29797 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:71.50 stddev:1.37 (1.9%) stddev-sans-first:1.41 19:08:59 INFO - PROCESS | 29797 | Values: 72.0 71.0 70.0 69.0 70.0 73.0 70.0 71.0 72.0 73.0 19:08:59 INFO - PROCESS | 29797 | -------- Summary: end -------- 19:08:59 INFO - PROCESS | 29797 | 19:09:00 INFO - TEST-INFO | 29797: exit 0 19:09:00 INFO - TEST-OK | kraken | took 61183ms 19:09:00 INFO - TEST-START | v8_7 19:09:00 INFO - operating with platform_type : linux_ 19:09:00 INFO - Initialising browser for v8_7 test... 19:09:00 INFO - TEST-INFO | started process 30044 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu2Y1uS/profile http://localhost:44263/getInfo.html) 19:09:05 INFO - PROCESS | 30044 | __metrics Screen width/height:1600/1200 19:09:05 INFO - PROCESS | 30044 | colorDepth:24 19:09:05 INFO - PROCESS | 30044 | Browser inner width/height: 1024/697 19:09:05 INFO - PROCESS | 30044 | __metrics 19:09:05 INFO - PROCESS | 30044 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:09:05 INFO - PROCESS | 30044 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:09:06 INFO - TEST-INFO | 30044: exit 0 19:09:06 INFO - Browser initialized. 19:09:06 INFO - Running cycle 1/1 for v8_7 test... 19:09:06 INFO - TEST-INFO | started process 30125 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu2Y1uS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:09:18 INFO - PROCESS | 30125 | RSS: Main: 149823488 19:09:18 INFO - PROCESS | 30125 | 19:09:39 INFO - PROCESS | 30125 | Cycle 1(1): loaded http://localhost:44263/tests/v8_7/run.html (next: http://localhost:44263/tests/v8_7/run.html) 19:09:40 INFO - PROCESS | 30125 | RSS: Main: 446513152 19:09:40 INFO - PROCESS | 30125 | 19:09:40 INFO - PROCESS | 30125 | __start_tp_report 19:09:40 INFO - PROCESS | 30125 | _x_x_mozilla_page_load 19:09:40 INFO - PROCESS | 30125 | _x_x_mozilla_page_load_details 19:09:40 INFO - PROCESS | 30125 | |i|pagename|runs| 19:09:40 INFO - PROCESS | 30125 | |0;Richards;166.63889351774705 19:09:40 INFO - PROCESS | 30125 | |1;DeltaBlue;188.89308651303364 19:09:40 INFO - PROCESS | 30125 | |2;Encrypt;279.3296089385475 19:09:40 INFO - PROCESS | 30125 | |3;Decrypt;5181.347150259067 19:09:40 INFO - PROCESS | 30125 | |4;RayTrace;1996.007984031936 19:09:40 INFO - PROCESS | 30125 | |5;Earley;811.6883116883117 19:09:40 INFO - PROCESS | 30125 | |6;Boyer;12407.407407407407 19:09:40 INFO - PROCESS | 30125 | |7;RegExp;26921.052631578947 19:09:40 INFO - PROCESS | 30125 | |8;Splay;595.3654188948307 19:09:40 INFO - PROCESS | 30125 | |9;NavierStokes;4830.917874396136 19:09:40 INFO - PROCESS | 30125 | __end_tp_report 19:09:40 INFO - PROCESS | 30125 | __startTimestamp1451531380145__endTimestamp 19:09:40 INFO - PROCESS | 30125 | 19:09:40 INFO - PROCESS | 30125 | ------- Summary: start ------- 19:09:40 INFO - PROCESS | 30125 | Number of tests: 10 19:09:40 INFO - PROCESS | 30125 | 19:09:40 INFO - PROCESS | 30125 | [#0] Richards Cycles:1 Average:166.64 Median:166.64 stddev:0.00 (0.0%) 19:09:40 INFO - PROCESS | 30125 | Values: 166.6 19:09:40 INFO - PROCESS | 30125 | 19:09:40 INFO - PROCESS | 30125 | [#1] DeltaBlue Cycles:1 Average:188.89 Median:188.89 stddev:0.00 (0.0%) 19:09:40 INFO - PROCESS | 30125 | Values: 188.9 19:09:40 INFO - PROCESS | 30125 | 19:09:40 INFO - PROCESS | 30125 | [#2] Encrypt Cycles:1 Average:279.33 Median:279.33 stddev:0.00 (0.0%) 19:09:40 INFO - PROCESS | 30125 | Values: 279.3 19:09:40 INFO - PROCESS | 30125 | 19:09:40 INFO - PROCESS | 30125 | [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 19:09:40 INFO - PROCESS | 30125 | Values: 5181.3 19:09:40 INFO - PROCESS | 30125 | 19:09:40 INFO - PROCESS | 30125 | [#4] RayTrace Cycles:1 Average:1996.01 Median:1996.01 stddev:0.00 (0.0%) 19:09:40 INFO - PROCESS | 30125 | Values: 1996.0 19:09:40 INFO - PROCESS | 30125 | 19:09:40 INFO - PROCESS | 30125 | [#5] Earley Cycles:1 Average:811.69 Median:811.69 stddev:0.00 (0.0%) 19:09:40 INFO - PROCESS | 30125 | Values: 811.7 19:09:40 INFO - PROCESS | 30125 | 19:09:40 INFO - PROCESS | 30125 | [#6] Boyer Cycles:1 Average:12407.41 Median:12407.41 stddev:0.00 (0.0%) 19:09:40 INFO - PROCESS | 30125 | Values: 12407.4 19:09:40 INFO - PROCESS | 30125 | 19:09:40 INFO - PROCESS | 30125 | [#7] RegExp Cycles:1 Average:26921.05 Median:26921.05 stddev:0.00 (0.0%) 19:09:40 INFO - PROCESS | 30125 | Values: 26921.1 19:09:40 INFO - PROCESS | 30125 | 19:09:40 INFO - PROCESS | 30125 | [#8] Splay Cycles:1 Average:595.37 Median:595.37 stddev:0.00 (0.0%) 19:09:40 INFO - PROCESS | 30125 | Values: 595.4 19:09:40 INFO - PROCESS | 30125 | 19:09:40 INFO - PROCESS | 30125 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 19:09:40 INFO - PROCESS | 30125 | Values: 4830.9 19:09:40 INFO - PROCESS | 30125 | -------- Summary: end -------- 19:09:40 INFO - PROCESS | 30125 | 19:09:41 INFO - TEST-INFO | 30125: exit 0 19:09:41 INFO - TEST-OK | v8_7 | took 40451ms 19:09:41 INFO - SUITE-END | took 1219s 19:09:41 INFO - Completed test suite (00:20:19) 19:09:41 INFO - Working with test: dromaeo_css 19:09:41 INFO - Generating results file: dromaeo_css 19:09:41 INFO - Working with test: kraken 19:09:41 INFO - Generating results file: kraken 19:09:41 INFO - javascript benchmark 19:09:41 INFO - Working with test: v8_7 19:09:41 INFO - Generating results file: v8_7 19:09:41 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:09:41 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 19:09:41 INFO - process_Request line: dromaeo_css 6176.91 graph.html#tests=[[72,94,35]] 19:09:41 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:09:41 INFO - process_Request line: kraken 1538.40 graph.html#tests=[[232,94,35]] 19:09:41 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:09:41 INFO - process_Request line: v8_7 19695.47 graph.html#tests=[[230,94,35]] 19:09:41 INFO - RETURN: dromaeo_css: 6176.91 19:09:41 INFO - RETURN: kraken: 1538.40 19:09:41 INFO - RETURN: v8_7: 19695.47 19:09:41 INFO - javascript benchmark 19:09:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2570.228931320604, 2614.2549373428565, 2649.1390298153106, 2655.707872134065, 2666.4267182555755, 4518.073794872052, 4542.159700455418, 4548.999999999995, 4557.0, 4660.0, 4518.8418405355815, 4594.127115847987, 4643.930341044887, 4657.184992626294, 4676.158291507527, 4243.215005224043, 4254.63835573975, 4257.7445353278745, 4261.29688601382, 4295.3986441898005, 4023.5976402359825, 4297.05464797744, 4312.331588603772, 4333.090051089275, 4355.259605867011, 4157.750534967881, 4215.409842622035, 4224.72539284947, 4238.237117318881, 4282.614564689193, 4226.323788193905, 4233.068724880522, 4242.490901091858, 4249.4475718156755, 4274.252005898987, 4087.264292427362, 4195.748255104703, 4223.598758117974, 4241.87274381769, 4266.679999000087, 4438.733675979419, 4461.08547747711, 4515.074409745994, 4536.478304994935, 4572.725636461823, 4896.192128298826, 4916.58209052231, 4919.7540122993705, 4923.679960802572, 4946.604271658259, 4795.400574928134, 4895.608351331921, 4930.852074437773, 4966.602671786249, 4983.9252411213865, 4500.167469018242, 4528.977355113237, 4599.149157405891, 4610.95389046112, 4652.046330502239, 5073.11220536412, 5103.18349064148, 5104.41299250591, 5106.923396149061, 5144.43411224765, 4666.976665116721, 4779.139754844162, 4870.853874383774, 4889.095517329305, 4894.192458244421, 4807.591354734816, 4843.128236917319, 4902.828401005948, 4920.040592084509, 4963.6525443218625, 4859.2954021666665, 4871.171900776876, 4880.755962201875, 4910.754462276872, 4913.091078150554, 4670.136024835417, 4807.879803004953, 4847.200211964986, 4863.319135321058, 4903.926441103386, 3980.3034468967817, 4033.556308806029, 4063.227986682521, 4116.835326586963, 4118.814653340607, 3510.297940411928, 3512.7892326460496, 3515.0, 3542.7874327539917, 3551.893443196708, 4145.958540414617, 4188.874333769992, 4191.287481128215, 4224.831006759757, 4225.68307376948, 4733.5503127202865, 4814.398200224972, 4838.588719958772, 4887.7556122194455, 4936.0, 4214.789260536961, 4228.619424251832, 4233.25917964355, 4248.91502169961, 4264.893377665583, 4197.139586384784, 4356.390105385249, 4357.346398040256, 4382.496012958487, 4386.0789234261165, 4548.226801443829, 4554.4990051094355, 4576.679632425765, 4616.422947131608, 4659.044895796422, 4885.1450996076255, 4915.287283343967, 4922.630802689741, 4926.8768280793265, 4981.10340138764, 4499.0, 4656.837010704609, 4659.161350956861, 4669.533046695304, 4675.789589468414, 4732.976335118303, 4748.833790817304, 4832.299316599003, 4892.535209155125, 4961.925571116364, 4897.240927656219, 4907.141250281115, 4911.189653707098, 4921.557059864629, 4950.6782059166035, 4610.377599024089, 4760.214564596941, 4767.713937163781, 4779.259214821708, 4823.300621409946, 4649.070185962753, 4672.065586882705, 4684.742339171378, 4686.812527498998, 4781.043791241696, 4672.719636821802, 4681.531846815291, 4684.297355396718, 4693.718376897397, 4717.056588682209, 4778.474367819467, 4781.737004464788, 4781.760911954458, 4790.640701947298, 4829.058333624909, 4510.594046535827, 4608.446986361524, 4620.5148459411275, 4627.375304333872, 4682.41469816273], "unit": "score", "name": "dojo.html", "value": 4488.323076239073}, {"lowerIsBetter": false, "replicates": [500.122285389142, 502.70089296868355, 505.189171379935, 518.6421369255215, 543.9700816455096, 25159.119430819926, 25573.360665983335, 33013.50479742806, 33107.66892331076, 33208.33583328338, 39147.80426097873, 39631.80184099075, 39844.800775996155, 40182.598174018254, 40193.0, 6900.3099690031095, 7995.200479951987, 8160.387970902206, 8165.142660020701, 8188.385871059664, 7032.964835175817, 9718.368306060083, 9947.403155810638, 9952.651657192, 9956.203503719722, 9660.951695241514, 9734.41593504392, 9744.074312940294, 9747.463889486075, 9751.41491510508, 7132.679029443636, 7300.853982920312, 9767.316287859852, 9810.313278070538, 9895.208383329353, 9604.135627793532, 9777.90222097777, 9789.070038346346, 9791.804163916753, 9792.853107203326, 32707.6729232707, 33010.669893301, 33016.33967320664, 33070.677172913056, 33089.33821323584, 2818.4363127374404, 2824.265690920355, 2843.3744576193203, 2847.9003234886886, 3257.1368587324378, 25923.22230333093, 27391.726082739315, 28064.719352806416, 28128.296792580146, 28169.0, 3465.6707612776745, 3481.686648201674, 3526.7883926964464, 3541.8406171722077, 3583.62371950944, 221964.0, 222592.0, 222837.0, 223012.88493557592, 223102.0, 46063.539364605924, 46615.5338446618, 53554.732226338616, 54325.0, 54823.451765482634, 47725.761371193614, 47859.042819143426, 47881.76059119682, 47940.520594793605, 48136.277955830694, 13270.66823329405, 13468.595942121752, 13510.189388636712, 13511.391987360395, 13527.932360338134, 10378.0, 10478.214133939984, 10537.683869483928, 10538.156947444186, 10565.0, 17421.738673919903, 18253.726194107097, 18282.451526454228, 18452.169652365676, 18456.446306610822, 7176.425885929113, 7338.86247631618, 7462.619415408167, 7512.422391297889, 7573.772786816405, 819.8524265632124, 903.3947255338938, 984.6947446291673, 998.4857798233916, 1014.0923873133504, 26373.472530549665, 26398.0, 26588.335291617863, 27126.72873271242, 27253.454930901273, 979.2361957673027, 982.9705108846746, 1031.5203430404897, 1091.7761858818924, 1091.8689757229024, 14014.229217393142, 14301.64245893861, 14595.635109122144, 14829.555113346616, 15021.324040418207, 267912.0, 273688.0, 273912.0, 273932.0, 274042.0, 46835.5316446838, 47009.8845551951, 47039.23686105103, 47066.294005589945, 47080.5291947083, 1205.2467207995003, 1208.6313674329238, 1211.2526063827197, 1215.5927764199093, 1223.2782658231686, 26347.604785927844, 27016.459670806868, 27123.321916951445, 27253.318667033484, 27631.171064868086, 34993.0, 35753.46369804507, 35815.64184358123, 39394.40908386319, 39792.60207397889, 245716.0, 250825.0, 251433.0, 251508.0, 251815.0, 24236.272911812674, 27004.72995270022, 27566.173014808785, 27594.724052759215, 27613.0, 26899.0, 41320.586794131676, 41523.7923810379, 41598.79200604099, 41953.16093678171, 31348.373032538766, 31873.0, 31917.20206994844, 32212.516812248305, 32439.675603243664, 31552.684473154975, 31617.683823161475, 31684.0, 31734.365312693157, 31793.205169870937, 31358.0, 31562.210944726565, 31699.52450713287, 31775.205619858763, 32035.839820800746, 27383.315417114733, 28449.28876778097, 28704.569431458127, 28966.565501517915, 29005.56491652669, 22359.77640223642, 22551.436214094778, 22652.773472265068, 22655.43361415912, 22989.88505057531], "unit": "score", "name": "ext.html", "value": 16752.73820340153}, {"lowerIsBetter": false, "replicates": [328.44000978331945, 332.390064232134, 337.15038103977975, 337.6539047476337, 339.46195280480435, 12384.876151238484, 12711.745765084694, 14225.857741422595, 14713.0, 15706.293216805243, 7794.337481314095, 9081.409708368968, 9407.764805879857, 11753.35356555389, 14149.858501414983, 4438.889027774308, 4562.931556026662, 4563.406757121569, 4568.109218702354, 4569.246074397737, 3379.188994641293, 4447.599716025557, 4534.161180181677, 4564.954350456503, 5074.898502029976, 4985.601151907857, 5017.322661440713, 5063.569596584276, 5066.0, 5069.366329208849, 4924.80300787968, 4983.152864013126, 4985.077760614298, 4985.775640096204, 5039.974800125994, 4810.086083644096, 4814.181589129857, 4814.494478079786, 4818.301346304801, 4819.0602832447685, 11357.204995650307, 14123.435062597484, 15684.294206760724, 19249.32627358036, 19280.517987050436, 1656.527889551472, 1726.5597272695509, 1788.4098247578268, 1809.1677828199045, 1839.0988415676356, 8716.346274029409, 10089.798204035878, 11235.70789359226, 12526.0, 12907.031972601999, 1667.7081510735572, 1689.7465380192946, 1715.0567188046525, 1764.8941063536229, 1806.3768000039966, 55320.72339638316, 58097.0, 58251.12623310654, 58452.415475845126, 58788.0, 9389.577469013911, 9445.0, 9464.574094165779, 9465.858012129824, 9549.283803714749, 11882.108841836896, 11935.283882967049, 12016.459259333351, 12018.15872888907, 12041.21732087429, 7165.534240274365, 8502.957485212535, 8565.0, 8710.60802263887, 8890.155435233642, 7202.71189152428, 7243.855122897513, 7261.273872612696, 7344.96327518359, 7391.6304184791625, 7376.815579610553, 7393.593352365671, 7431.554106753612, 7520.1351844537485, 7609.809754756176, 2492.6510288559616, 2998.4302982433705, 3028.772842036812, 3046.192758918888, 3075.7385622221914, 809.2918696140877, 825.9256666899888, 833.4913806011018, 902.201551626815, 903.1284810158097, 15570.22648592685, 15598.298076586581, 15769.763453548207, 16326.102064386572, 16351.0, 829.9336053115736, 842.2377748137945, 847.5550336073487, 863.935204859638, 886.8802711633975, 9273.608958656256, 9282.953585232166, 9353.953230233805, 9358.298127640453, 9374.250059995184, 281462.0, 285915.0, 466490.0, 469803.0, 470836.0, 66182.0, 72983.63508182531, 74904.0, 77086.22913770903, 78218.6089069551, 1016.4155610523978, 1034.8344264917578, 1051.3376572759112, 1052.0058544675207, 1054.5254635414094, 14032.859671403156, 14149.0, 14164.291785410482, 14478.493252736103, 14561.563153105424, 29858.402831942803, 30423.0, 31155.065348039596, 32003.519947201275, 32629.18427039343, 39757.0, 41012.179756405305, 41310.38034429426, 41354.0, 42508.36237456379, 8619.91380086191, 8729.519876406604, 8882.60028298741, 8923.598438070172, 8960.68637597681, 13514.256715880721, 14460.27698615086, 16225.945313555054, 16557.006579605262, 17153.22810473557, 14009.369578369202, 14209.431622734975, 14279.500217492337, 14306.499272525412, 14324.785128223293, 13401.06192566511, 13773.862261377259, 13923.651908702364, 14033.087849289763, 14253.0, 14129.929350353183, 14361.928190358982, 14612.488562900673, 14677.339519721852, 14835.406583736529, 8647.092055334351, 8708.129187081242, 8786.428882122642, 8840.160184782435, 8843.292536597186, 13901.0964287321, 14002.229877356436, 14077.929610351883, 14279.143251404948, 14479.203643799692], "unit": "score", "name": "jquery.html", "value": 8369.959184177767}, {"lowerIsBetter": false, "replicates": [1086.8967448092428, 1381.3921874375278, 1388.0838646493314, 1500.5348342013976, 1731.264212709599, 5736.856578585533, 5897.02699054656, 6586.176727909012, 6685.665716714157, 6688.264290928007, 6742.359475849787, 6786.694598743056, 6813.931860681391, 6840.179178498574, 6840.2133754618235, 2018.5962807438498, 2052.887091209983, 2053.4558342039372, 2057.5164836263466, 2057.5987682401937, 2073.813356797888, 2084.3642688979853, 2092.016752126498, 2130.0734180631475, 2131.3179782469615, 2038.9082491287854, 2047.8361731061555, 2074.3984244569056, 2076.0035183112113, 2076.1176499987446, 2038.1337931379178, 2067.1008111471406, 2071.0887209627717, 2071.585682863426, 2073.1810934680866, 2046.4270004398793, 2074.481379655086, 2114.5770845830893, 2117.4388786971463, 2118.7033815265877, 6687.899681504781, 6761.391474767245, 6761.4590832733265, 6763.898541521881, 6776.728930842761, 3859.0352411897024, 3922.235164142993, 3924.2936271471126, 3929.4105884117325, 3932.5674175840636, 2470.7899828514596, 2471.765182307678, 2509.4353770401513, 2566.089038391363, 2568.2808813532242, 789.1556035042507, 790.5375355417087, 805.9516429014219, 807.6850028488894, 817.8773184022385, 8867.334949878785, 8892.644294228223, 8895.110488951117, 8896.110388961117, 8900.109989001114, 3614.765040272374, 3632.9636703633155, 3671.3391589514144, 3678.062094166024, 3706.1661126246377, 7690.692372305157, 7691.615419229128, 7694.038245219348, 7706.229377062249, 7709.190534993745, 4017.0760725032824, 4018.2767101921936, 4022.155347377025, 4023.5171779386073, 4026.8187931543152, 3036.347185355159, 3123.984380078085, 3545.556805399325, 3646.781193128421, 3649.85400583979, 3236.2394837213237, 3273.558069660613, 3296.241864371208, 3319.286353434023, 3332.483465062919, 1015.7409860485529, 1041.4792603698152, 1046.9685909422728, 1053.3153450257241, 1054.4147997861107, 948.7817801905462, 1119.5074167366333, 1133.9489722962487, 1141.7887690777234, 1141.8858114188515, 6139.57023008394, 6181.258249010148, 6188.504919606511, 6190.3190649028575, 6190.350013248634, 987.8172538080478, 1016.065219997604, 1027.3271007490107, 1029.3904950949457, 1052.153016821466, 4842.370491836039, 4872.342233798392, 4873.269009648581, 4878.731669758197, 4885.8045678173185, 7738.071431428152, 7789.260020298176, 7930.325922296554, 8015.358771298399, 8018.077921039038, 7840.0, 7845.1762564931005, 7848.725294614661, 7923.683052677944, 7944.165862584461, 6358.078078678565, 6393.328700486475, 6440.6135631862235, 6471.644059576768, 6481.09264702942, 6054.576179667381, 6062.969685151546, 6212.782552610637, 6249.96875015622, 6256.31180570146, 7157.57054576727, 7198.928010719826, 7246.601436920809, 7297.124345078624, 7365.0, 7420.740274090381, 7588.886166707393, 7621.237876212556, 7633.923660763321, 7641.617919104134, 5145.331106956071, 5193.714345711022, 6127.84680382994, 6205.82089403012, 6221.129041934042, 6161.507079433545, 6215.595986260879, 6216.658083805434, 6218.968905155445, 6233.0, 5722.885542289214, 5807.041838096667, 5873.353931067664, 5976.551758618208, 6100.420460056288, 5759.56803239767, 5879.882402352015, 5954.553408494294, 5961.791337303173, 5986.850328741816, 5882.49998750111, 5939.851503712442, 5943.910841337297, 6052.455279024909, 6093.329733729375, 5675.772969081356, 5700.600957932905, 5709.857253568528, 5717.228174196596, 5719.656820590778, 5784.971075144597, 5796.42035796417, 5804.65172089676, 5812.94187058141, 5814.360420353673], "unit": "score", "name": "mootools.html", "value": 3886.0854457574264}, {"lowerIsBetter": false, "replicates": [276.8214501646438, 286.8551381552315, 291.52044886162264, 300.9458297506449, 303.45075413501576, 5270.314859068325, 5278.0, 5305.991861546308, 5318.335208098988, 5371.677699338043, 5254.658447200929, 5262.578993680506, 5265.104932161532, 5265.605079619035, 5274.736263186835, 4112.2186784511, 4112.5064992200905, 4113.835446582133, 4116.835326586948, 4117.341225403936, 3872.67082298005, 3967.682585393162, 3996.380561013033, 4077.612626800464, 4081.693872959525, 4023.718339716206, 4042.7978601069976, 4072.7149099563044, 4073.368627862686, 4075.3071977763702, 3815.084379748868, 3893.0851249956236, 4064.3903414487913, 4066.085130845566, 4072.1448495815916, 3482.0, 3549.591796943333, 3557.5553055868018, 3557.94663080054, 3561.893143205708, 4978.402591688984, 5037.244413337992, 5067.0879241736475, 5073.3911930568565, 5079.009593129341, 4681.0871879983415, 4681.485036645966, 4683.601893839028, 4693.6010439112715, 4694.507076756926, 5405.162199859028, 5540.695261760601, 5544.7227638618315, 5547.195656629807, 5552.333719953591, 3884.4173373993845, 3885.30064588374, 3888.669463095612, 3889.552701439314, 3892.6885849132, 5827.504662103684, 5835.066389377722, 5838.64968101911, 5840.065589505659, 5840.561957853136, 3992.2813893499447, 4009.4186342980106, 4011.1576568920855, 4011.338129208648, 4013.5585085640555, 4058.5738497457933, 4061.9593804062174, 4062.5531191568903, 4066.1664358806374, 4068.9796551017057, 4503.279475284005, 4642.419697537808, 4652.581267685924, 4655.627549796008, 4656.4412270527755, 5523.751431185607, 5528.115501519737, 5529.142982837667, 5530.585206109477, 5535.612507124462, 1415.8725714685522, 1437.4465830655272, 1438.6547228665254, 1439.604108870048, 1440.1431148466645, 969.6315400147898, 978.6183388478499, 978.7259567321162, 995.0, 998.3311181508407, 4900.8774780630765, 4903.779329930162, 4903.975480122576, 4905.5094490550655, 4906.165951788204, 5771.134329850556, 5774.307083150049, 5777.075667893117, 5783.1325301204315, 5788.739506722208, 4898.044881248194, 4901.289313049588, 4901.754912254373, 4903.828366007173, 4907.043126590281, 2990.2524368907775, 2991.970080299213, 3084.6452657944174, 3115.5482455043893, 3118.532220166948, 5400.459954004568, 5439.918401223985, 5538.47384498472, 5559.360673522516, 5559.388467268597, 5978.342382337939, 5990.520758339322, 5991.681829997394, 5997.0404735242155, 5997.250343707036, 5523.8066667666435, 5529.203009022084, 5532.363778165482, 5534.1975413565615, 5540.141278101901, 5603.159526071122, 5802.912956305743, 5823.242978412779, 5830.53355731549, 5837.0, 5669.262995810518, 5676.68778217202, 5678.403767604507, 5680.77276908919, 5687.317521897398, 5501.669899806025, 5527.281453411031, 5533.280673512418, 5537.335519737658, 5538.169274608841, 3831.65515103642, 3872.4897290057465, 3917.177392747555, 3922.4312474691583, 3927.3912543555793, 5807.535397168132, 5821.214136091573, 5821.738021788945, 5822.70886455684, 5826.533877289891, 5588.608797384144, 5590.5248053915875, 5591.552675785846, 5592.384837667934, 5592.720363981866, 5586.273784408001, 5586.636868603528, 5587.8882422352135, 5588.413216612197, 5590.133529302964, 5361.169018802092, 5440.483154100354, 5476.096444086681, 5477.616566840283, 5487.341519017744, 5608.9158662619275, 5608.971955140361, 5613.46672066153, 5614.550835933034, 5618.381977982337, 5443.537299329601, 5446.665566936126, 5447.809326673548, 5447.972760136174, 5493.505584497414], "unit": "score", "name": "prototype.html", "value": 4176.136211536289}, {"lowerIsBetter": false, "replicates": [675.1122274209414, 722.2632914427285, 723.0311382747119, 766.9760869239564, 767.715945100313, 10318.896811031887, 10460.738481537956, 10464.68605941821, 10469.371837689725, 10470.424126673039, 10330.896691033087, 10479.476026198698, 10485.0, 10532.894671053287, 10615.84076238857, 623.0374072058657, 629.8834715577633, 766.0462723908728, 782.9412794040442, 795.5107608820563, 791.0665414810521, 792.0, 797.3063434811722, 797.6330887791623, 798.5807451088167, 645.1516256123207, 830.8629076202419, 836.7071524966243, 837.6314421654453, 838.3335248477475, 648.6853875870199, 814.0434988888062, 829.2453866981078, 835.1648351648352, 835.2816577743137, 608.242737791448, 611.6360765344657, 612.6201754911939, 617.1452538234532, 617.3301967365414, 10084.49577521121, 10143.89856101437, 10186.847197292047, 10190.49047547627, 10195.235357348229, 10267.486625668762, 10678.305910115818, 10953.945230273797, 11101.000909918066, 11499.137564682598, 9197.724068277963, 9219.631214751402, 9359.110884465965, 9494.192993595552, 9515.762105947337, 3007.849607519637, 3040.148758347666, 3046.4211799757977, 3068.5243787213017, 3125.3749250150063, 37666.62333376658, 37944.43083353752, 38012.42981355282, 38036.23927521462, 38065.23869522622, 7935.761927142195, 8081.272685458337, 8150.0, 8282.296004839656, 8293.046299675494, 15318.234088295541, 15319.770203446957, 15326.693466130615, 15346.846531534766, 15348.846511534743, 6138.416850399205, 6169.96915015422, 6332.050192471074, 6376.936230637727, 6400.423961843363, 3544.4328907374697, 3643.653852883972, 3663.5420572428447, 3665.0, 3677.356462619031, 2545.223706769453, 2576.188500622298, 2577.4200804819143, 2580.3936075022357, 2580.509703156394, 459.0199923164002, 464.0764877892969, 467.752091391563, 479.28586406255124, 484.3098584517049, 415.71523506398216, 416.72287928527794, 420.45551011440256, 424.645421073401, 427.393101795445, 7224.927750722425, 7276.63616819157, 7478.962605187048, 7518.210587888193, 7586.089669239726, 564.9406812284733, 588.141313682029, 600.9308929473079, 605.9818205453755, 611.944924956756, 3394.321135772806, 3673.1184515716036, 3907.4138879167785, 4031.173609410064, 4128.153728485653, 48117.75941120272, 49143.0, 49152.75423622859, 49217.26174107391, 49468.75265623649, 41632.583674162874, 42510.362344564855, 42788.35817462741, 42835.35746963798, 42900.0, 38744.0, 38842.22315553673, 38946.61053389486, 39026.609733902864, 39471.60528394737, 7922.603869806602, 7972.402069844901, 8011.599420028859, 8190.303824174774, 8252.504849709037, 29058.564121538617, 29075.418491630473, 29603.0, 29838.0, 29839.25401864884, 35521.467177991835, 37457.62542374541, 37569.62430375771, 37599.81200093982, 38030.288637010846, 9820.65627703027, 9944.411661154183, 9945.254105941938, 10126.291159619052, 10138.0, 10266.598625637194, 10313.071823535918, 10884.673459796219, 11369.431528423711, 11491.94254028758, 9419.481928493999, 9771.413715177112, 10007.349522281029, 10662.200334974752, 10989.450527473755, 10283.382997020202, 10675.145988321072, 10737.355758654505, 10877.0, 11040.392778397265, 7416.866635794386, 8577.313814894918, 8620.396572239883, 9902.603895844373, 10515.684529464128, 8608.698695545625, 8824.558772061242, 8982.550872456482, 8999.910000900169, 9474.621015159317, 7925.484843485155, 8037.879431808411, 8054.718084867001, 8084.555349455836, 8624.698135565224], "unit": "score", "name": "yui.html", "value": 5437.47556996783}], "name": "dromaeo_css", "value": 6176.905859137341}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 115.0, 109.0, 113.0, 112.0, 114.0, 102.0, 113.0, 112.0, 102.0], "unit": "score", "name": "ai-astar", "value": 110.4}, {"lowerIsBetter": true, "replicates": [158.0, 133.0, 155.0, 168.0, 136.0, 153.0, 150.0, 132.0, 171.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 161.0, 160.0, 162.0, 162.0, 162.0, 163.0, 164.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 87.0, 90.0, 73.0, 73.0, 72.0, 104.0, 89.0, 78.0], "unit": "score", "name": "audio-fft", "value": 81.2}, {"lowerIsBetter": true, "replicates": [98.0, 99.0, 130.0, 97.0, 99.0, 98.0, 136.0, 98.0, 99.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.3}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 73.0, 73.0, 73.0, 73.0, 73.0, 81.0, 70.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 73.4}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 69.0, 69.0, 71.0, 70.0, 69.0, 69.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.5}, {"lowerIsBetter": true, "replicates": [85.0, 93.0, 85.0, 85.0, 86.0, 86.0, 86.0, 87.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [120.0, 121.0, 125.0, 125.0, 139.0, 126.0, 122.0, 128.0, 130.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.8}, {"lowerIsBetter": true, "replicates": [148.0, 158.0, 162.0, 148.0, 151.0, 138.0, 149.0, 149.0, 143.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.4}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 70.0, 69.0, 70.0, 73.0, 70.0, 71.0, 72.0, 73.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.1}], "name": "kraken", "value": 1538.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.63889351774705], "unit": "score", "name": "Richards", "value": 211.84730199999996}, {"lowerIsBetter": false, "replicates": [188.89308651303364], "unit": "score", "name": "DeltaBlue", "value": 350.02869200000004}, {"lowerIsBetter": false, "replicates": [279.3296089385475], "unit": "score", "name": "Encrypt", "value": 952.9279799999998}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1996.007984031936], "unit": "score", "name": "RayTrace", "value": 370.73448899999994}, {"lowerIsBetter": false, "replicates": [811.6883116883117], "unit": "score", "name": "Earley", "value": 821.0824160000001}, {"lowerIsBetter": false, "replicates": [12407.407407407407], "unit": "score", "name": "Boyer", "value": 53.71492835820899}, {"lowerIsBetter": false, "replicates": [26921.052631578947], "unit": "score", "name": "RegExp", "value": 33.83913000977518}, {"lowerIsBetter": false, "replicates": [595.3654188948307], "unit": "score", "name": "Splay", "value": 136.87560179640718}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19695.4680398834}]} 19:09:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19695.47"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1538.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6176.91"}}} 19:09:41 INFO - Return code: 0 19:09:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:09:41 INFO - # TBPL SUCCESS # 19:09:41 INFO - Running post-action listener: _resource_record_post_action 19:09:41 INFO - Running post-run listener: _resource_record_post_run 19:09:42 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 4096; Write bytes: 555773952; Read time: 8; Write time: 783880 19:09:42 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 240685056; Read time: 0; Write time: 478340 19:09:42 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 4096; Write bytes: 315088896; Read time: 8; Write time: 305540 19:09:42 INFO - Running post-run listener: _upload_blobber_files 19:09:42 INFO - Blob upload gear active. 19:09:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:09:42 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:09:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:09:43 INFO - (blobuploader) - INFO - Open directory for files ... 19:09:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:09:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:09:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:09:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:09:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:09:44 INFO - (blobuploader) - INFO - Done attempting. 19:09:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:09:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:09:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:09:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:09:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:09:45 INFO - (blobuploader) - INFO - Done attempting. 19:09:45 INFO - (blobuploader) - INFO - Iteration through files over. 19:09:45 INFO - Return code: 0 19:09:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:09:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:09:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/906b195c3431cd7ce2809191467780fde2cc1c44ecfa26b798ae45f3e821de004ee35280bb479bba43af3a349e7f726757962a039daf8711914a81651a46cba2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/542f246541ad7335b44ff74451003841e09fb8705fb60c33f13eca28c5fd31a8abab3b74f6e7daccf92022164737d7aabea3e2dd05f5156ecdd8726832c275f3"} 19:09:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:09:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:09:45 INFO - Contents: 19:09:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/906b195c3431cd7ce2809191467780fde2cc1c44ecfa26b798ae45f3e821de004ee35280bb479bba43af3a349e7f726757962a039daf8711914a81651a46cba2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/542f246541ad7335b44ff74451003841e09fb8705fb60c33f13eca28c5fd31a8abab3b74f6e7daccf92022164737d7aabea3e2dd05f5156ecdd8726832c275f3"} 19:09:45 INFO - Copying logs to upload dir... 19:09:45 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1273.315076 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-30 19:09:43.307531) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 19:09:43.310799) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0cff312cb257a7829adc5a5d000001df-1451530044.516086-1845407381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/906b195c3431cd7ce2809191467780fde2cc1c44ecfa26b798ae45f3e821de004ee35280bb479bba43af3a349e7f726757962a039daf8711914a81651a46cba2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/542f246541ad7335b44ff74451003841e09fb8705fb60c33f13eca28c5fd31a8abab3b74f6e7daccf92022164737d7aabea3e2dd05f5156ecdd8726832c275f3"} build_url:https://queue.taskcluster.net/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011301 build_url: 'https://queue.taskcluster.net/v1/task/BMkbg80hQlG7ZUdCCS72Cg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/906b195c3431cd7ce2809191467780fde2cc1c44ecfa26b798ae45f3e821de004ee35280bb479bba43af3a349e7f726757962a039daf8711914a81651a46cba2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/542f246541ad7335b44ff74451003841e09fb8705fb60c33f13eca28c5fd31a8abab3b74f6e7daccf92022164737d7aabea3e2dd05f5156ecdd8726832c275f3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 19:09:43.335627) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 19:09:43.335977) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0cff312cb257a7829adc5a5d000001df-1451530044.516086-1845407381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 19:09:43.422403) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 19:09:43.422729) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 19:09:43.423055) ========= ========= Total master_lag: 0.24 =========