builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-058 starttime: 1451099799.15 results: success (0) buildid: 20151225175049 builduid: b2410bd04aa247d9967ba1f79956e258 revision: 4a559a618d6798eb9a8fdc559f5a7a00085e2062 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-25 19:16:39.146748) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-25 19:16:39.147220) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-25 19:16:39.147523) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1451099795.457553-1013360044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006189 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-25 19:16:39.170678) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-25 19:16:39.170987) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-25 19:16:39.184098) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 19:16:39.184486) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1451099795.457553-1013360044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004600 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 19:16:39.233226) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-25 19:16:39.233541) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-25 19:16:39.233890) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 19:16:39.234160) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1451099795.457553-1013360044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-25 19:16:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2015-12-25 19:16:39 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171155 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 19:16:39.417424) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 19:16:39.420901) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1451099795.457553-1013360044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018126 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 19:16:39.470656) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 19:16:39.471002) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4a559a618d6798eb9a8fdc559f5a7a00085e2062 --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 4a559a618d6798eb9a8fdc559f5a7a00085e2062 --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=e25b24362c3bb3dea6e300e4000001c1-1451099795.457553-1013360044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-25 19:16:39,754 truncating revision to first 12 chars 2015-12-25 19:16:39,754 Setting DEBUG logging. 2015-12-25 19:16:39,754 attempt 1/10 2015-12-25 19:16:39,754 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4a559a618d67?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-25 19:16:40,367 unpacking tar archive at: mozilla-central-4a559a618d67/testing/mozharness/ program finished with exit code 0 elapsedTime=0.898701 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 19:16:40.382323) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-25 19:16:40.382655) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-25 19:16:40.391468) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-25 19:16:40.391798) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-25 19:16:40.392222) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-25 19:16:40.392515) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--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=e25b24362c3bb3dea6e300e4000001c1-1451099795.457553-1013360044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:16:40 INFO - MultiFileLogger online at 20151225 19:16:40 in /builds/slave/test 19:16:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 19:16:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:16:40 INFO - {'append_to_log': False, 19:16:40 INFO - 'base_work_dir': '/builds/slave/test', 19:16:40 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 19:16:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:16:40 INFO - 'branch': 'Firefox-Non-PGO', 19:16:40 INFO - 'buildbot_json_path': 'buildprops.json', 19:16:40 INFO - 'config_files': ('talos/linux_config.py',), 19:16:40 INFO - 'default_actions': ('clobber', 19:16:40 INFO - 'read-buildbot-config', 19:16:40 INFO - 'download-and-extract', 19:16:40 INFO - 'populate-webroot', 19:16:40 INFO - 'create-virtualenv', 19:16:40 INFO - 'install', 19:16:40 INFO - 'run-tests'), 19:16:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:16:40 INFO - 'download_minidump_stackwalk': True, 19:16:40 INFO - 'download_symbols': 'ondemand', 19:16:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:16:40 INFO - 'tooltool.py': '/tools/tooltool.py', 19:16:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:16:40 INFO - '/tools/misc-python/virtualenv.py')}, 19:16:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:16:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:16:40 INFO - 'installer_path': 'installer.exe', 19:16:40 INFO - 'log_level': 'info', 19:16:40 INFO - 'log_name': 'talos', 19:16:40 INFO - 'log_to_console': True, 19:16:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:16:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:16:40 INFO - 'opt_config_files': (), 19:16:40 INFO - 'pip_index': False, 19:16:40 INFO - 'sps_profile': False, 19:16:40 INFO - 'sps_profile_interval': 0, 19:16:40 INFO - 'suite': 'dromaeojs-e10s', 19:16:40 INFO - 'system_bits': '64', 19:16:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:16:40 INFO - 'title': 'talos-linux64-ix-058', 19:16:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:16:40 INFO - 'use_talos_json': True, 19:16:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:16:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:16:40 INFO - 'work_dir': 'build'} 19:16:40 INFO - ##### 19:16:40 INFO - ##### Running clobber step. 19:16:40 INFO - ##### 19:16:40 INFO - Running pre-action listener: _resource_record_pre_action 19:16:40 INFO - Running main action method: clobber 19:16:40 INFO - rmtree: /builds/slave/test/build 19:16:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:16:41 INFO - Running post-action listener: _resource_record_post_action 19:16:41 INFO - ##### 19:16:41 INFO - ##### Running read-buildbot-config step. 19:16:41 INFO - ##### 19:16:41 INFO - Running pre-action listener: _resource_record_pre_action 19:16:41 INFO - Running main action method: read_buildbot_config 19:16:41 INFO - Using buildbot properties: 19:16:41 INFO - { 19:16:41 INFO - "project": "", 19:16:41 INFO - "product": "firefox", 19:16:41 INFO - "script_repo_revision": "production", 19:16:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:16:41 INFO - "repository": "", 19:16:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 19:16:41 INFO - "buildid": "20151225175049", 19:16:41 INFO - "pgo_build": "False", 19:16:41 INFO - "basedir": "/builds/slave/test", 19:16:41 INFO - "buildnumber": 152, 19:16:41 INFO - "slavename": "talos-linux64-ix-058", 19:16:41 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:16:41 INFO - "platform": "ubuntu64_hw", 19:16:41 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 19:16:41 INFO - "branch": "mozilla-central", 19:16:41 INFO - "repo_path": "mozilla-central", 19:16:41 INFO - "revision": "4a559a618d6798eb9a8fdc559f5a7a00085e2062", 19:16:41 INFO - "stage_platform": "linux64", 19:16:41 INFO - "builduid": "b2410bd04aa247d9967ba1f79956e258", 19:16:41 INFO - "slavebuilddir": "test" 19:16:41 INFO - } 19:16:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/m8dl1bDfSMyT2Tju64aBcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:16:41 INFO - Running post-action listener: _resource_record_post_action 19:16:41 INFO - ##### 19:16:41 INFO - ##### Running download-and-extract step. 19:16:41 INFO - ##### 19:16:41 INFO - Running pre-action listener: _resource_record_pre_action 19:16:41 INFO - Running main action method: download_and_extract 19:16:41 INFO - mkdir: /builds/slave/test/build/tests 19:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:16:41 INFO - https://queue.taskcluster.net/v1/task/m8dl1bDfSMyT2Tju64aBcA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:16:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m8dl1bDfSMyT2Tju64aBcA/artifacts/public/build/test_packages.json 19:16:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m8dl1bDfSMyT2Tju64aBcA/artifacts/public/build/test_packages.json 19:16:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m8dl1bDfSMyT2Tju64aBcA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 19:16:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m8dl1bDfSMyT2Tju64aBcA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 19:16:41 INFO - Downloaded 1302 bytes. 19:16:41 INFO - Reading from file /builds/slave/test/build/test_packages.json 19:16:41 INFO - Using the following test package requirements: 19:16:41 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:16:41 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:16:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:16:41 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:16:41 INFO - u'jsshell-linux-x86_64.zip'], 19:16:41 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:16:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:16:41 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:16:41 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:16:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:16:41 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:16:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:16:41 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:16:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:16:41 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:16:41 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:16:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:16:41 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:16:41 INFO - https://queue.taskcluster.net/v1/task/m8dl1bDfSMyT2Tju64aBcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:16:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m8dl1bDfSMyT2Tju64aBcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:16:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m8dl1bDfSMyT2Tju64aBcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:16:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m8dl1bDfSMyT2Tju64aBcA/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 19:16:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m8dl1bDfSMyT2Tju64aBcA/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 19:16:42 INFO - Downloaded 21942092 bytes. 19:16:42 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 19:16:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:16:42 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 19:16:43 INFO - Return code: 0 19:16:43 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 19:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:16:43 INFO - https://queue.taskcluster.net/v1/task/m8dl1bDfSMyT2Tju64aBcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:16:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m8dl1bDfSMyT2Tju64aBcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:16:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m8dl1bDfSMyT2Tju64aBcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:16:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m8dl1bDfSMyT2Tju64aBcA/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 19:16:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m8dl1bDfSMyT2Tju64aBcA/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 19:16:44 INFO - Downloaded 21942092 bytes. 19:16:44 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 19:16:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:16:44 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 19:16:46 INFO - Return code: 0 19:16:46 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')]} 19:16:46 INFO - https://queue.taskcluster.net/v1/task/m8dl1bDfSMyT2Tju64aBcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:16:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m8dl1bDfSMyT2Tju64aBcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:16:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m8dl1bDfSMyT2Tju64aBcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:16:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m8dl1bDfSMyT2Tju64aBcA/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 19:16:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m8dl1bDfSMyT2Tju64aBcA/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 19:16:47 INFO - Downloaded 11132270 bytes. 19:16:47 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 19:16:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:16:47 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 19:16:47 INFO - Return code: 0 19:16: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')]} 19:16:47 INFO - https://queue.taskcluster.net/v1/task/m8dl1bDfSMyT2Tju64aBcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:16:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m8dl1bDfSMyT2Tju64aBcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:16:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m8dl1bDfSMyT2Tju64aBcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:16:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m8dl1bDfSMyT2Tju64aBcA/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 19:16:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/m8dl1bDfSMyT2Tju64aBcA/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 19:16:48 INFO - Downloaded 53335327 bytes. 19:16:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/m8dl1bDfSMyT2Tju64aBcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:16:48 INFO - mkdir: /builds/slave/test/properties 19:16:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:16:48 INFO - Writing to file /builds/slave/test/properties/build_url 19:16:48 INFO - Contents: 19:16:48 INFO - build_url:https://queue.taskcluster.net/v1/task/m8dl1bDfSMyT2Tju64aBcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:16:48 INFO - Running post-action listener: _resource_record_post_action 19:16:48 INFO - Running post-action listener: set_extra_try_arguments 19:16:48 INFO - ##### 19:16:48 INFO - ##### Running populate-webroot step. 19:16:48 INFO - ##### 19:16:48 INFO - Running pre-action listener: _resource_record_pre_action 19:16:48 INFO - Running main action method: populate_webroot 19:16:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:16:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:16:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:16:48 INFO - '--tppagecycles', 19:16:48 INFO - '7'], 19:16:48 INFO - 'tests': ['tsvgm']}}, 19:16:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:16:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:16:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:16:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:16:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:16:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:16:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:16:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:48 INFO - 'talos_options': ['--e10s'], 19:16:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:16:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:48 INFO - 'tests': ['damp', 'tps']}, 19:16:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:48 INFO - 'talos_options': ['--e10s'], 19:16:48 INFO - 'tests': ['damp', 'tps']}, 19:16:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:16:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:16:48 INFO - 'other': {'tests': ['a11yr', 19:16:48 INFO - 'ts_paint', 19:16:48 INFO - 'tpaint', 19:16:48 INFO - 'sessionrestore', 19:16:48 INFO - 'sessionrestore_no_auto_restore']}, 19:16:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:16:48 INFO - 'tests': ['a11yr', 19:16:48 INFO - 'ts_paint', 19:16:48 INFO - 'tpaint', 19:16:48 INFO - 'sessionrestore', 19:16:48 INFO - 'sessionrestore_no_auto_restore']}, 19:16:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:16:48 INFO - 'tests': ['a11yr', 19:16:48 INFO - 'ts_paint', 19:16:48 INFO - 'tpaint', 19:16:48 INFO - 'sessionrestore', 19:16:48 INFO - 'sessionrestore_no_auto_restore']}, 19:16:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:16:48 INFO - 'tests': ['a11yr', 19:16:48 INFO - 'ts_paint', 19:16:48 INFO - 'tpaint', 19:16:48 INFO - 'sessionrestore', 19:16:48 INFO - 'sessionrestore_no_auto_restore']}, 19:16:48 INFO - 'other_l64': {'tests': ['a11yr', 19:16:48 INFO - 'ts_paint', 19:16:48 INFO - 'tpaint', 19:16:48 INFO - 'sessionrestore', 19:16:48 INFO - 'sessionrestore_no_auto_restore']}, 19:16:48 INFO - 'other_nol64': {'tests': ['a11yr', 19:16:48 INFO - 'ts_paint', 19:16:48 INFO - 'tpaint', 19:16:48 INFO - 'sessionrestore', 19:16:48 INFO - 'sessionrestore_no_auto_restore']}, 19:16:48 INFO - 'svgr': {'tests': ['tsvgx', 19:16:48 INFO - 'tsvgr_opacity', 19:16:48 INFO - 'tart', 19:16:48 INFO - 'tscrollx', 19:16:48 INFO - 'cart']}, 19:16:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:16:48 INFO - 'tests': ['tsvgx', 19:16:48 INFO - 'tsvgr_opacity', 19:16:48 INFO - 'tart', 19:16:48 INFO - 'tscrollx', 19:16:48 INFO - 'cart']}, 19:16:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:48 INFO - 'tests': ['tp5o']}, 19:16:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:48 INFO - 'talos_options': ['--e10s'], 19:16:48 INFO - 'tests': ['tp5o']}, 19:16:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:48 INFO - 'talos_options': ['--xperf_path', 19:16:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:16:48 INFO - 'tests': ['tp5n']}, 19:16:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:48 INFO - 'talos_options': ['--e10s', 19:16:48 INFO - '--xperf_path', 19:16:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:16:48 INFO - 'tests': ['tp5n']}}, 19:16:48 INFO - 'talos.zip': {'path': '', 19:16:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:16:48 INFO - Running post-action listener: _resource_record_post_action 19:16:48 INFO - ##### 19:16:48 INFO - ##### Running create-virtualenv step. 19:16:48 INFO - ##### 19:16:48 INFO - Running pre-action listener: _resource_record_pre_action 19:16:48 INFO - Running main action method: create_virtualenv 19:16:48 INFO - Creating virtualenv /builds/slave/test/build/venv 19:16:48 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 19:16:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:16:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:16:48 INFO - Using real prefix '/usr' 19:16:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:16:49 INFO - Installing distribute.............................................................................................................................................................................................done. 19:16:51 INFO - Installing pip.................done. 19:16:51 INFO - Return code: 0 19:16:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:16:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:51 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 0x7faecdfd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e23d0>, '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 0x174ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174e360>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1451099795.457553-1013360044', '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 19:16:51 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 19:16:51 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 19:16:51 INFO - Using env: {'DISPLAY': ':0', 19:16:51 INFO - 'HOME': '/home/cltbld', 19:16:51 INFO - 'LANG': 'en_US.UTF-8', 19:16:51 INFO - 'LANGUAGE': 'en_US:en', 19:16:51 INFO - 'LOGNAME': 'cltbld', 19:16:51 INFO - 'MAIL': '/var/mail/cltbld', 19:16:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:51 INFO - 'MOZ_NO_REMOTE': '1', 19:16:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:16:51 INFO - 'NO_EM_RESTART': '1', 19:16:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:16:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:16:51 INFO - 'PWD': '/builds/slave/test', 19:16:51 INFO - 'SHELL': '/bin/bash', 19:16:51 INFO - 'SHLVL': '1', 19:16:51 INFO - 'TERM': 'linux', 19:16:51 INFO - 'TMOUT': '86400', 19:16:51 INFO - 'USER': 'cltbld', 19:16:51 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1451099795.457553-1013360044', 19:16:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:16:51 INFO - '_': '/tools/buildbot/bin/python'} 19:16:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:16:51 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 19:16:51 INFO - Cleaning up... 19:16:51 INFO - Return code: 0 19:16:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:16:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:51 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 0x7faecdfd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e23d0>, '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 0x174ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174e360>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1451099795.457553-1013360044', '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 19:16:51 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 19:16:51 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 19:16:51 INFO - Using env: {'DISPLAY': ':0', 19:16:51 INFO - 'HOME': '/home/cltbld', 19:16:51 INFO - 'LANG': 'en_US.UTF-8', 19:16:51 INFO - 'LANGUAGE': 'en_US:en', 19:16:51 INFO - 'LOGNAME': 'cltbld', 19:16:51 INFO - 'MAIL': '/var/mail/cltbld', 19:16:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:51 INFO - 'MOZ_NO_REMOTE': '1', 19:16:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:16:51 INFO - 'NO_EM_RESTART': '1', 19:16:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:16:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:16:51 INFO - 'PWD': '/builds/slave/test', 19:16:51 INFO - 'SHELL': '/bin/bash', 19:16:51 INFO - 'SHLVL': '1', 19:16:51 INFO - 'TERM': 'linux', 19:16:51 INFO - 'TMOUT': '86400', 19:16:51 INFO - 'USER': 'cltbld', 19:16:51 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1451099795.457553-1013360044', 19:16:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:16:51 INFO - '_': '/tools/buildbot/bin/python'} 19:16:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:16:51 INFO - Downloading/unpacking psutil>=0.7.1 19:16: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 19:16: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 19:16: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 19:16: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 19:16: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 19:16: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 19:16:53 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 19:16:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:16:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:16:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:16:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:16:53 INFO - Installing collected packages: psutil 19:16:53 INFO - Running setup.py install for psutil 19:16:53 INFO - building 'psutil._psutil_linux' extension 19:16:53 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 19:16:53 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 19:16:53 INFO - building 'psutil._psutil_posix' extension 19:16:53 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 19:16:53 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 19:16:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:16:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:16:53 INFO - Successfully installed psutil 19:16:53 INFO - Cleaning up... 19:16:53 INFO - Return code: 0 19:16:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:16:53 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')]} 19:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:53 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')]} 19:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:53 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 0x7faecdfd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e23d0>, '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 0x174ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174e360>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1451099795.457553-1013360044', '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 19:16:53 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 19:16:53 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 19:16:53 INFO - Using env: {'DISPLAY': ':0', 19:16:53 INFO - 'HOME': '/home/cltbld', 19:16:53 INFO - 'LANG': 'en_US.UTF-8', 19:16:53 INFO - 'LANGUAGE': 'en_US:en', 19:16:53 INFO - 'LOGNAME': 'cltbld', 19:16:53 INFO - 'MAIL': '/var/mail/cltbld', 19:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:53 INFO - 'MOZ_NO_REMOTE': '1', 19:16:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:16:53 INFO - 'NO_EM_RESTART': '1', 19:16:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:16:53 INFO - 'PWD': '/builds/slave/test', 19:16:53 INFO - 'SHELL': '/bin/bash', 19:16:53 INFO - 'SHLVL': '1', 19:16:53 INFO - 'TERM': 'linux', 19:16:53 INFO - 'TMOUT': '86400', 19:16:53 INFO - 'USER': 'cltbld', 19:16:53 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1451099795.457553-1013360044', 19:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:16:53 INFO - '_': '/tools/buildbot/bin/python'} 19:16:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:16:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:16:54 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 19:16:54 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 19:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:16:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:16:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:16:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:16:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:16:55 INFO - Installing collected packages: mozsystemmonitor 19:16:55 INFO - Running setup.py install for mozsystemmonitor 19:16:55 INFO - Successfully installed mozsystemmonitor 19:16:55 INFO - Cleaning up... 19:16:56 INFO - Return code: 0 19:16:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:16:56 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')]} 19:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:56 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')]} 19:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:56 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 0x7faecdfd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e23d0>, '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 0x174ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174e360>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1451099795.457553-1013360044', '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 19:16:56 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 19:16:56 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 19:16:56 INFO - Using env: {'DISPLAY': ':0', 19:16:56 INFO - 'HOME': '/home/cltbld', 19:16:56 INFO - 'LANG': 'en_US.UTF-8', 19:16:56 INFO - 'LANGUAGE': 'en_US:en', 19:16:56 INFO - 'LOGNAME': 'cltbld', 19:16:56 INFO - 'MAIL': '/var/mail/cltbld', 19:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:56 INFO - 'MOZ_NO_REMOTE': '1', 19:16:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:16:56 INFO - 'NO_EM_RESTART': '1', 19:16:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:16:56 INFO - 'PWD': '/builds/slave/test', 19:16:56 INFO - 'SHELL': '/bin/bash', 19:16:56 INFO - 'SHLVL': '1', 19:16:56 INFO - 'TERM': 'linux', 19:16:56 INFO - 'TMOUT': '86400', 19:16:56 INFO - 'USER': 'cltbld', 19:16:56 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1451099795.457553-1013360044', 19:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:16:56 INFO - '_': '/tools/buildbot/bin/python'} 19:16:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:16:56 INFO - Downloading/unpacking blobuploader==1.2.4 19:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:16:56 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 19:16:56 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 19:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:16:57 INFO - Downloading blobuploader-1.2.4.tar.gz 19:16:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:16:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:16:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:16: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 19:16: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 19:16: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 19:16: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 19:16: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 19:16: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 19:16:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:16:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:16:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:16:58 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 19:16:58 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 19:16:58 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 19:16:58 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 19:16:58 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 19:16:58 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 19:16:58 INFO - Downloading docopt-0.6.1.tar.gz 19:16:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:16:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:16:58 INFO - Installing collected packages: blobuploader, requests, docopt 19:16:58 INFO - Running setup.py install for blobuploader 19:16:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:16:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:16:58 INFO - Running setup.py install for requests 19:16:59 INFO - Running setup.py install for docopt 19:16:59 INFO - Successfully installed blobuploader requests docopt 19:16:59 INFO - Cleaning up... 19:17:00 INFO - Return code: 0 19:17:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:17:00 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')]} 19:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:00 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')]} 19:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:00 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 0x7faecdfd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e23d0>, '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 0x174ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174e360>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1451099795.457553-1013360044', '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 19:17:00 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 19:17:00 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 19:17:00 INFO - Using env: {'DISPLAY': ':0', 19:17:00 INFO - 'HOME': '/home/cltbld', 19:17:00 INFO - 'LANG': 'en_US.UTF-8', 19:17:00 INFO - 'LANGUAGE': 'en_US:en', 19:17:00 INFO - 'LOGNAME': 'cltbld', 19:17:00 INFO - 'MAIL': '/var/mail/cltbld', 19:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:00 INFO - 'MOZ_NO_REMOTE': '1', 19:17:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:00 INFO - 'NO_EM_RESTART': '1', 19:17:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:00 INFO - 'PWD': '/builds/slave/test', 19:17:00 INFO - 'SHELL': '/bin/bash', 19:17:00 INFO - 'SHLVL': '1', 19:17:00 INFO - 'TERM': 'linux', 19:17:00 INFO - 'TMOUT': '86400', 19:17:00 INFO - 'USER': 'cltbld', 19:17:00 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1451099795.457553-1013360044', 19:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:00 INFO - '_': '/tools/buildbot/bin/python'} 19:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:17:00 INFO - Running setup.py (path:/tmp/pip-eIHB7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:17:00 INFO - Running setup.py (path:/tmp/pip-yXYQsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:17:00 INFO - Running setup.py (path:/tmp/pip-qSIUw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:17:00 INFO - Running setup.py (path:/tmp/pip-efnW8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:17:00 INFO - Running setup.py (path:/tmp/pip-Lym1aB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:17:00 INFO - Running setup.py (path:/tmp/pip-BdUlou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:17:00 INFO - Running setup.py (path:/tmp/pip-Bs8bcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:17:00 INFO - Running setup.py (path:/tmp/pip-0yF90R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:17:00 INFO - Running setup.py (path:/tmp/pip-vj6zXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:17:01 INFO - Running setup.py (path:/tmp/pip-2LXoTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:17:01 INFO - Running setup.py (path:/tmp/pip-DvQbXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:17:01 INFO - Running setup.py (path:/tmp/pip-aBXppl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:17:01 INFO - Running setup.py (path:/tmp/pip-MJhoiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:17:01 INFO - Running setup.py (path:/tmp/pip-nm3z7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:17:01 INFO - Running setup.py (path:/tmp/pip-emI6EJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:17:01 INFO - Running setup.py (path:/tmp/pip-I8iUzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:17:01 INFO - Running setup.py (path:/tmp/pip-FM0v6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:17:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:17:01 INFO - Running setup.py install for manifestparser 19:17:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:17:01 INFO - Running setup.py install for mozcrash 19:17:01 INFO - Running setup.py install for mozdebug 19:17:01 INFO - Running setup.py install for mozdevice 19:17:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:17:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:17:02 INFO - Running setup.py install for mozfile 19:17:02 INFO - Running setup.py install for mozhttpd 19:17:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:17:02 INFO - Running setup.py install for mozinfo 19:17:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:17:02 INFO - Running setup.py install for mozInstall 19:17:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:17:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:17:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:17:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:17:02 INFO - Running setup.py install for mozleak 19:17:02 INFO - Running setup.py install for mozlog 19:17:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:17:02 INFO - Running setup.py install for moznetwork 19:17:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:17:02 INFO - Running setup.py install for mozprocess 19:17:02 INFO - Running setup.py install for mozprofile 19:17:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:17:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:17:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:17:02 INFO - Running setup.py install for mozrunner 19:17:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:17:03 INFO - Running setup.py install for mozscreenshot 19:17:03 INFO - Running setup.py install for moztest 19:17:03 INFO - Running setup.py install for mozversion 19:17:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:17:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:17:03 INFO - Cleaning up... 19:17:03 INFO - Return code: 0 19:17:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:17:03 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')]} 19:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:03 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')]} 19:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:03 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 0x7faecdfd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e23d0>, '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 0x174ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174e360>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1451099795.457553-1013360044', '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 19:17:03 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 19:17:03 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 19:17:03 INFO - Using env: {'DISPLAY': ':0', 19:17:03 INFO - 'HOME': '/home/cltbld', 19:17:03 INFO - 'LANG': 'en_US.UTF-8', 19:17:03 INFO - 'LANGUAGE': 'en_US:en', 19:17:03 INFO - 'LOGNAME': 'cltbld', 19:17:03 INFO - 'MAIL': '/var/mail/cltbld', 19:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:03 INFO - 'MOZ_NO_REMOTE': '1', 19:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:03 INFO - 'NO_EM_RESTART': '1', 19:17:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:03 INFO - 'PWD': '/builds/slave/test', 19:17:03 INFO - 'SHELL': '/bin/bash', 19:17:03 INFO - 'SHLVL': '1', 19:17:03 INFO - 'TERM': 'linux', 19:17:03 INFO - 'TMOUT': '86400', 19:17:03 INFO - 'USER': 'cltbld', 19:17:03 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1451099795.457553-1013360044', 19:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:03 INFO - '_': '/tools/buildbot/bin/python'} 19:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:17:03 INFO - Running setup.py (path:/tmp/pip-WVDYwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:17:03 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)) 19:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:17:03 INFO - Running setup.py (path:/tmp/pip-zyCQaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:17:03 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)) 19:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:17:03 INFO - Running setup.py (path:/tmp/pip-exFrp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:17:03 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)) 19:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:17:03 INFO - Running setup.py (path:/tmp/pip-9r6YJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:17:03 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)) 19:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:17:03 INFO - Running setup.py (path:/tmp/pip-4XWqcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:17:03 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)) 19:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:17:03 INFO - Running setup.py (path:/tmp/pip-JZm_bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:17:04 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)) 19:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:17:04 INFO - Running setup.py (path:/tmp/pip-6wwd7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:17:04 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)) 19:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:17:04 INFO - Running setup.py (path:/tmp/pip-MpRnAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:17:04 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)) 19:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:17:04 INFO - Running setup.py (path:/tmp/pip-TKelnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:17:04 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)) 19:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:17:04 INFO - Running setup.py (path:/tmp/pip-qNSmKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:17:04 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)) 19:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:17:04 INFO - Running setup.py (path:/tmp/pip-63niXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:17:04 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)) 19:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:17:04 INFO - Running setup.py (path:/tmp/pip-Emz0kK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:17:04 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)) 19:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:17:04 INFO - Running setup.py (path:/tmp/pip-cPGwm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:17:04 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)) 19:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:17:04 INFO - Running setup.py (path:/tmp/pip-5aWFdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:17:04 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)) 19:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:17:04 INFO - Running setup.py (path:/tmp/pip-wV8EU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:17:04 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)) 19:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:17:04 INFO - Running setup.py (path:/tmp/pip-qi_4lH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:17:04 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)) 19:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:17:04 INFO - Running setup.py (path:/tmp/pip-XXq_hR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:17:04 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)) 19:17:04 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)) 19:17:04 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)) 19:17:04 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)) 19:17:04 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)) 19:17:04 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)) 19:17:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:17: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 19:17: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 19:17: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 19:17: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 19:17: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 19:17: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 19:17:06 INFO - Downloading blessings-1.5.1.tar.gz 19:17:06 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 19:17:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:17:06 INFO - Installing collected packages: blessings 19:17:06 INFO - Running setup.py install for blessings 19:17:06 INFO - Successfully installed blessings 19:17:06 INFO - Cleaning up... 19:17:06 INFO - Return code: 0 19:17:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:17:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:17:06 INFO - Reading from file tmpfile_stdout 19:17:06 INFO - Current package versions: 19:17:06 INFO - argparse == 1.2.1 19:17:06 INFO - blessings == 1.5.1 19:17:06 INFO - blobuploader == 1.2.4 19:17:06 INFO - docopt == 0.6.1 19:17:06 INFO - manifestparser == 1.1 19:17:06 INFO - mozInstall == 1.12 19:17:06 INFO - mozcrash == 0.16 19:17:06 INFO - mozdebug == 0.1 19:17:06 INFO - mozdevice == 0.47 19:17:06 INFO - mozfile == 1.2 19:17:06 INFO - mozhttpd == 0.7 19:17:06 INFO - mozinfo == 0.9 19:17:06 INFO - mozleak == 0.1 19:17:06 INFO - mozlog == 3.1 19:17:06 INFO - moznetwork == 0.27 19:17:06 INFO - mozprocess == 0.22 19:17:06 INFO - mozprofile == 0.28 19:17:06 INFO - mozrunner == 6.11 19:17:06 INFO - mozscreenshot == 0.1 19:17:06 INFO - mozsystemmonitor == 0.0 19:17:06 INFO - moztest == 0.7 19:17:06 INFO - mozversion == 1.4 19:17:06 INFO - psutil == 3.1.1 19:17:06 INFO - requests == 1.2.3 19:17:06 INFO - wsgiref == 0.1.2 19:17:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:17:06 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')]} 19:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:06 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')]} 19:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:06 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 0x7faecdfd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e23d0>, '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 0x174ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174e360>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1451099795.457553-1013360044', '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 19:17:06 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 19:17:06 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 19:17:06 INFO - Using env: {'DISPLAY': ':0', 19:17:06 INFO - 'HOME': '/home/cltbld', 19:17:06 INFO - 'LANG': 'en_US.UTF-8', 19:17:06 INFO - 'LANGUAGE': 'en_US:en', 19:17:06 INFO - 'LOGNAME': 'cltbld', 19:17:06 INFO - 'MAIL': '/var/mail/cltbld', 19:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:06 INFO - 'MOZ_NO_REMOTE': '1', 19:17:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:06 INFO - 'NO_EM_RESTART': '1', 19:17:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:06 INFO - 'PWD': '/builds/slave/test', 19:17:06 INFO - 'SHELL': '/bin/bash', 19:17:06 INFO - 'SHLVL': '1', 19:17:06 INFO - 'TERM': 'linux', 19:17:06 INFO - 'TMOUT': '86400', 19:17:06 INFO - 'USER': 'cltbld', 19:17:06 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1451099795.457553-1013360044', 19:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:06 INFO - '_': '/tools/buildbot/bin/python'} 19:17:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:07 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)) 19:17:07 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)) 19:17:07 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)) 19:17:07 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)) 19:17:07 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)) 19:17:07 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)) 19:17:07 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)) 19:17:07 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)) 19:17:07 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)) 19:17:07 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)) 19:17:07 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)) 19:17:07 INFO - Cleaning up... 19:17:07 INFO - Return code: 0 19:17:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:17:07 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')]} 19:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:07 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')]} 19:17:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:07 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 0x7faecdfd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e23d0>, '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 0x174ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174e360>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1451099795.457553-1013360044', '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 19:17:07 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 19:17:07 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 19:17:07 INFO - Using env: {'DISPLAY': ':0', 19:17:07 INFO - 'HOME': '/home/cltbld', 19:17:07 INFO - 'LANG': 'en_US.UTF-8', 19:17:07 INFO - 'LANGUAGE': 'en_US:en', 19:17:07 INFO - 'LOGNAME': 'cltbld', 19:17:07 INFO - 'MAIL': '/var/mail/cltbld', 19:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:07 INFO - 'MOZ_NO_REMOTE': '1', 19:17:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:07 INFO - 'NO_EM_RESTART': '1', 19:17:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:07 INFO - 'PWD': '/builds/slave/test', 19:17:07 INFO - 'SHELL': '/bin/bash', 19:17:07 INFO - 'SHLVL': '1', 19:17:07 INFO - 'TERM': 'linux', 19:17:07 INFO - 'TMOUT': '86400', 19:17:07 INFO - 'USER': 'cltbld', 19:17:07 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1451099795.457553-1013360044', 19:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:07 INFO - '_': '/tools/buildbot/bin/python'} 19:17:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:07 INFO - Downloading/unpacking jsonschema 19:17:07 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 19:17:07 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 19:17:07 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 19:17:07 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 19:17:07 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 19:17:07 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 19:17:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:17:09 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 19:17:09 INFO - Downloading/unpacking functools32 (from jsonschema) 19:17:09 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 19:17:09 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 19:17:09 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 19:17:09 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 19:17:09 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 19:17:09 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 19:17:09 INFO - Downloading functools32-3.2.3-2.tar.gz 19:17:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:17:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:17:09 INFO - warning: no files found matching '*.txt' 19:17:09 INFO - no previously-included directories found matching 'build' 19:17:09 INFO - no previously-included directories found matching 'dist' 19:17:09 INFO - no previously-included directories found matching '.git*' 19:17:09 INFO - Installing collected packages: jsonschema, functools32 19:17:09 INFO - Running setup.py install for functools32 19:17:09 INFO - warning: no files found matching '*.txt' 19:17:09 INFO - no previously-included directories found matching 'build' 19:17:09 INFO - no previously-included directories found matching 'dist' 19:17:09 INFO - no previously-included directories found matching '.git*' 19:17:09 INFO - Successfully installed jsonschema functools32 19:17:09 INFO - Cleaning up... 19:17:09 INFO - Return code: 0 19:17:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:17:09 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')]} 19:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:09 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')]} 19:17:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:09 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 0x7faecdfd1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e23d0>, '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 0x174ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174e360>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1451099795.457553-1013360044', '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 19:17:09 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 19:17:09 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 19:17:09 INFO - Using env: {'DISPLAY': ':0', 19:17:09 INFO - 'HOME': '/home/cltbld', 19:17:09 INFO - 'LANG': 'en_US.UTF-8', 19:17:09 INFO - 'LANGUAGE': 'en_US:en', 19:17:09 INFO - 'LOGNAME': 'cltbld', 19:17:09 INFO - 'MAIL': '/var/mail/cltbld', 19:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:09 INFO - 'MOZ_NO_REMOTE': '1', 19:17:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:09 INFO - 'NO_EM_RESTART': '1', 19:17:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:09 INFO - 'PWD': '/builds/slave/test', 19:17:09 INFO - 'SHELL': '/bin/bash', 19:17:09 INFO - 'SHLVL': '1', 19:17:09 INFO - 'TERM': 'linux', 19:17:09 INFO - 'TMOUT': '86400', 19:17:09 INFO - 'USER': 'cltbld', 19:17:09 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1451099795.457553-1013360044', 19:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:09 INFO - '_': '/tools/buildbot/bin/python'} 19:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:09 INFO - Downloading/unpacking flake8 19:17:09 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 19:17:09 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 19:17:09 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 19:17:09 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 19:17:09 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 19:17:09 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 19:17:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:17:11 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 19:17:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:17:11 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 19:17:11 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 19:17:11 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 19:17:11 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 19:17:11 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 19:17:11 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 19:17:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:17:11 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 19:17:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:17:11 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 19:17:11 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 19:17:11 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 19:17:11 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 19:17:11 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 19:17:11 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 19:17:11 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 19:17:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:17:11 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 19:17:11 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 19:17:11 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 19:17:11 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 19:17:11 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 19:17:11 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 19:17:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:17:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:17:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:17:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:17:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:17:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:17:12 INFO - no previously-included directories found matching 'docs/_build' 19:17:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:17:12 INFO - Running setup.py install for pep8 19:17:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:17:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:17:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:17:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:17:12 INFO - no previously-included directories found matching 'docs/_build' 19:17:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:17:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:17:12 INFO - Cleaning up... 19:17:12 INFO - Return code: 0 19:17:12 INFO - Running post-action listener: _resource_record_post_action 19:17:12 INFO - Running post-action listener: _start_resource_monitoring 19:17:12 INFO - Starting resource monitoring. 19:17:12 INFO - ##### 19:17:12 INFO - ##### Running install step. 19:17:12 INFO - ##### 19:17:12 INFO - Running pre-action listener: _resource_record_pre_action 19:17:12 INFO - Running main action method: install 19:17:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:17:12 INFO - Reading from file tmpfile_stdout 19:17:12 INFO - Detecting whether we're running mozinstall >=1.0... 19:17:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:17:12 INFO - Reading from file tmpfile_stdout 19:17:12 INFO - Output received: 19:17:12 INFO - Usage: mozinstall [options] installer 19:17:12 INFO - Options: 19:17:12 INFO - -h, --help show this help message and exit 19:17:12 INFO - -d DEST, --destination=DEST 19:17:12 INFO - Directory to install application into. [default: 19:17:12 INFO - "/builds/slave/test"] 19:17:12 INFO - --app=APP Application being installed. [default: firefox] 19:17:12 INFO - mkdir: /builds/slave/test/build/application 19:17:12 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'] 19:17:12 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 19:17:28 INFO - Reading from file tmpfile_stdout 19:17:28 INFO - Output received: 19:17:28 INFO - /builds/slave/test/build/application/firefox/firefox 19:17:28 INFO - Running post-action listener: _resource_record_post_action 19:17:28 INFO - ##### 19:17:28 INFO - ##### Running run-tests step. 19:17:28 INFO - ##### 19:17:28 INFO - Running pre-action listener: _resource_record_pre_action 19:17:28 INFO - Running main action method: run_tests 19:17:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:17:28 INFO - Python 2.7.3 19:17:28 INFO - Return code: 0 19:17:28 INFO - grabbing minidump binary from tooltool 19:17:28 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')]} 19:17:28 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 0x17e23d0>, '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 0x174ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174e360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:17:28 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 19:17:28 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 19:17:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:17:28 INFO - Return code: 0 19:17:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:17:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:17:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:17:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:17:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:17:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:17:29 INFO - Return code: 0 19:17:29 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/m8dl1bDfSMyT2Tju64aBcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:17:29 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/m8dl1bDfSMyT2Tju64aBcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:17:29 INFO - Using env: {'DISPLAY': ':0', 19:17:29 INFO - 'HOME': '/home/cltbld', 19:17:29 INFO - 'LANG': 'en_US.UTF-8', 19:17:29 INFO - 'LANGUAGE': 'en_US:en', 19:17:29 INFO - 'LOGNAME': 'cltbld', 19:17:29 INFO - 'MAIL': '/var/mail/cltbld', 19:17:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:17:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:29 INFO - 'MOZ_NO_REMOTE': '1', 19:17:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:17:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:29 INFO - 'NO_EM_RESTART': '1', 19:17:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:29 INFO - 'PWD': '/builds/slave/test', 19:17:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:17:29 INFO - 'SHELL': '/bin/bash', 19:17:29 INFO - 'SHLVL': '1', 19:17:29 INFO - 'TERM': 'linux', 19:17:29 INFO - 'TMOUT': '86400', 19:17:29 INFO - 'USER': 'cltbld', 19:17:29 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1451099795.457553-1013360044', 19:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:29 INFO - '_': '/tools/buildbot/bin/python'} 19:17:29 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/m8dl1bDfSMyT2Tju64aBcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:17:29 INFO - mozversion application_buildid: 20151225175049 19:17:29 INFO - mozversion application_changeset: 4a559a618d6798eb9a8fdc559f5a7a00085e2062 19:17:29 INFO - mozversion application_display_name: Nightly 19:17:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:17:29 INFO - mozversion application_name: Firefox 19:17:29 INFO - mozversion application_remotingname: firefox 19:17:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:17:29 INFO - mozversion application_vendor: Mozilla 19:17:29 INFO - mozversion application_version: 46.0a1 19:17:29 INFO - mozversion platform_buildid: 20151225175049 19:17:29 INFO - mozversion platform_changeset: 4a559a618d6798eb9a8fdc559f5a7a00085e2062 19:17:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:17:29 INFO - mozversion platform_version: 46.0a1 19:17:29 INFO - using testdate: 1451099849 19:17:29 INFO - actual date: 1451099849 19:17:29 INFO - starting webserver on 'localhost:42261' 19:17:29 INFO - SUITE-START | Running 3 tests 19:17:29 INFO - TEST-START | dromaeo_css 19:17:29 INFO - operating with platform_type : linux_ 19:17:29 INFO - Initialising browser for dromaeo_css test... 19:17:29 INFO - TEST-INFO | started process 3934 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAicDgH/profile http://localhost:42261/getInfo.html) 19:17:35 INFO - PROCESS | 3934 | __metrics Screen width/height:1600/1200 19:17:35 INFO - PROCESS | 3934 | colorDepth:24 19:17:35 INFO - PROCESS | 3934 | Browser inner width/height: 1024/697 19:17:35 INFO - PROCESS | 3934 | __metrics 19:17:35 INFO - PROCESS | 3934 | 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:17:37 INFO - TEST-INFO | 3934: exit 0 19:17:37 INFO - Browser initialized. 19:17:37 INFO - Running cycle 1/1 for dromaeo_css test... 19:17:37 INFO - TEST-INFO | started process 4062 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAicDgH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:17:49 INFO - PROCESS | 4062 | RSS: Main: 149127168 19:17:49 INFO - PROCESS | 4062 | 19:18:38 INFO - PROCESS | 4062 | 1451099918895 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] 19:20:50 INFO - PROCESS | 4062 | Cycle 1(1): loaded http://localhost:42261/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42261/tests/dromaeo/cssquery-ext.html) 19:20:51 INFO - PROCESS | 4062 | RSS: Main: 155631616 19:20:51 INFO - PROCESS | 4062 | 19:23:53 INFO - PROCESS | 4062 | Cycle 1(1): loaded http://localhost:42261/tests/dromaeo/cssquery-ext.html (next: http://localhost:42261/tests/dromaeo/cssquery-jquery.html) 19:23:54 INFO - PROCESS | 4062 | RSS: Main: 152956928 19:23:54 INFO - PROCESS | 4062 | 19:26:56 INFO - PROCESS | 4062 | Cycle 1(1): loaded http://localhost:42261/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42261/tests/dromaeo/cssquery-mootools.html) 19:26:56 INFO - PROCESS | 4062 | RSS: Main: 152555520 19:26:56 INFO - PROCESS | 4062 | 19:29:58 INFO - PROCESS | 4062 | Cycle 1(1): loaded http://localhost:42261/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42261/tests/dromaeo/cssquery-prototype.html) 19:29:59 INFO - PROCESS | 4062 | RSS: Main: 151003136 19:29:59 INFO - PROCESS | 4062 | 19:33:01 INFO - PROCESS | 4062 | Cycle 1(1): loaded http://localhost:42261/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42261/tests/dromaeo/cssquery-yui.html) 19:33:02 INFO - PROCESS | 4062 | RSS: Main: 153321472 19:33:02 INFO - PROCESS | 4062 | 19:36:04 INFO - PROCESS | 4062 | Cycle 1(1): loaded http://localhost:42261/tests/dromaeo/cssquery-yui.html (next: http://localhost:42261/tests/dromaeo/cssquery-dojo.html) 19:36:05 INFO - PROCESS | 4062 | RSS: Main: 154656768 19:36:05 INFO - PROCESS | 4062 | 19:36:05 INFO - PROCESS | 4062 | __start_tp_report 19:36:05 INFO - PROCESS | 4062 | _x_x_mozilla_page_load 19:36:05 INFO - PROCESS | 4062 | _x_x_mozilla_page_load_details 19:36:05 INFO - PROCESS | 4062 | |i|pagename|runs| 19:36:05 INFO - PROCESS | 4062 | |0;dojo.html;2616.4897844920242;2647.8808453619586;2668.826526275792;2671.9999999999995;2685.905993290235;4480.215962206617;4537.205988951932;4602.838900638479;4627.699199552031;4648.11685779702;4524.140413321466;4525.773711314429;4597.88505287368;4730.645201609885;4757.833475828346;4220.978895105528;4250.851220207293;4345.8478953236645;4353.586409291128;4397.032652816375;4347.891302717441;4350.303951367781;4382.97808510957;4404.471463424394;4486.506484286726;4159.771212583307;4207.768572728499;4262.957370426318;4342.3052311630145;4347.108842687273;4255.234057869582;4271.145770845812;4299.032717638537;4342.478902531717;4348.065165989327;4282.957170428287;4290.485141782975;4292.377605247221;4299.892502687427;4349.956500435019;4382.145481631083;4473.7986790594505;4489.955100448987;4581.450225972904;4610.9308360374625;5002.274670172841;5006.148954677714;5011.198208286657;5016.573591244749;5024.070546948826;5064.772085256135;5112.258722485256;5114.977004599095;5129.051125541787;5177.663451875616;4480.574345437179;4559.908801823945;4573.954260457353;4585.95414045862;4587.610053145487;4949.752512374439;4966.826161084345;4974.253861920669;4981.551660350513;5090.872728181825;4963.106640804617;4969.751512424365;4970.428400733889;4972.801087956441;4991.126552853236;5007.4241462231585;5052.469490703496;5058.620603454756;5063.240513922941;5089.6691715038405;4758.690685105526;4826.372571565674;4876.195427754452;4919.0899683558655;5002.624803139779;4841.3222148899185;4897.853064408074;4903.901921961612;4904.705717656952;4935.358403407534;4115.526714427879;4143.91712165755;4148.522919864194;4149.709520333608;4197.958020419818;3561.0385195996937;3615.222727113683;3654.561452625702;3685.7051435885064;3710.18375957289;4305.84929527465;4328.71863328889;4343.4136391586735;4372.0162963333;4384.0355121873135;4769.403824521934;5019.498050195024;5033.169527028;5055.772490237948;5057.190849464068;4224.028473451062;4247.532771395206;4297.763623000765;4302.483701955723;4330.2638551446325;4408.801603927767;4435.112977404532;4461.776911154429;4466.2630665940405;4469.240229161051;4502.6623003275545;4601.539846015372;4758.143534163814;4766.571008609242;4779.593734532604;4884.731339776346;4955.677880937727;5022.347094877642;5046.949530504648;5081.542661160365;4712.410948631421;4729.266963620645;4750.548697873696;4765.880852978565;4767.76161191946;4739.597134243628;4843.95156048435;4947;4957.429895562056;5004.674696144739;4984.42679091909;5046.041252162077;5065.037642847848;5074.16276314404;5100.821471248489;4795.784189711401;4813.78337974785;4819.59033482158;4827.08285425768;4828.493008234085;4630.652701047367;4746.572808447257;4764.880877978078;4821.783019764189;4863.756812159449;4706.364640773451;4722.362481065013;4747.596454301423;4772.904541909212;4775.47469778331;4883.706977581214;4907.092187945242;4907.631927605516;4924.7537623119415;4947.6536642434685;4604.102200070954;4706.764661766966;4739.146953548395;4797.520247975174;4828.275758636092 19:36:05 INFO - PROCESS | 4062 | |1;ext.html;520.6823837459149;543.9864003399912;571.8427432456074;574.962627429217;585.0814221671975;32546.83726581367;33070.66929330706;33224.33551328972;33229.66770332296;33241;36260.63739362606;36674.63325366745;36762.26475470489;36802.631973680254;37064;7552.1692613812575;7670.3480204182715;7724.073111226632;7736.61316934151;7751.689932402697;7509.023826902495;7605.885911711329;7683.308502234798;7809.82852572113;7861.410394220427;7798.883016754753;7803.453758236926;7819.648115834772;7835.451518393715;7860.331871790904;7740.574268415235;7841;7863.213678632148;7882.369410447208;7912.604369781517;7619.08570971487;7668.233176682343;7704.075510938667;7733.304002639789;7737.148913619498;36339.4549081764;37040;37057.25885482275;37077.07307317312;37078.25843483115;2920.5473151661527;2997.2057404787747;3213.694699003591;3331.2504686445354;3486.494458303557;27996.160115196577;28317.716822831713;28329.57505637417;28611.57082643762;28870;3269.8909203563567;3310.1228174533767;3331.583552055993;3422;3425.9657403425895;220392;222567.88716056477;222990;223508;223575;45491;46448.3032754509;55734.72132639311;56483;56701.716491417275;50668.746656266485;50929.74535127375;50935.490645093814;51194.48805511972;51239.231411528854;12743.617691469271;12854.935725321313;12933.224006559636;12946.352682365845;12961.351932403342;9468.195203407788;9476.241900648069;9478.715638530855;9491.38306010107;9582.329236953487;19073.842551249374;19418.12618432174;19553.511162221057;19584;19652.901735491232;7421.257874212535;7525.548467091992;7547.660355283915;7593.392528597809;7650.655720492591;809.29591255608;855.6662901468433;864.7924498120406;1033.8242498775226;1052.2529004406956;25884.22347329583;26193.276268453046;26449.603255951177;26785;26842.194734158005;924.5746956399997;965.3725078698902;986.0780170540568;995.6714284286168;1007.1087087927091;13788.103773254707;13944.930275348559;14180.787288190686;14207.28963551839;14289.928550357181;264437;267762;269485;270006;270708;46443;47020;47121.29318060232;47194.5280547197;47300.5269947303;1169.5555688838188;1183.0890214534932;1185.04603793945;1189.8631657359515;1194.976100478003;24733;26406.339841503348;26587.734122658527;26655.866720666272;26701.732982669924;40405.393919090646;40721.79639101786;40755.79622101989;40770.79614601908;40774.388384174854;244279;245641;245771;246032;246491;24226.394340140934;24334.513309733353;28836.423271534033;30615.387692245586;31153.417357004233;41119.7944010278;41692.166156677304;41713.1657366857;42383.7880810594;42588;30161.547576786805;30573.019758787104;30644.233894152825;30728.65609402963;30734.385312293183;29683.257918552208;29874.253143671584;30096;30106.096817095524;30266.940657076895;35224.82387588046;35315.823420882734;35560.46659300061;35963.92108236757;36364.454533181495;25936.481270374865;26375.868120659274;27726.86136569385;28222.294442639097;28380.85809570939;22569;23786.524269514168;24029.879850600635;24057.157999469935;24256.272311830675 19:36:05 INFO - PROCESS | 4062 | |2;jquery.html;324.12971172402104;325.6613122352753;329.22139140931705;332.0470250381406;333.0441632514683;14674.413023479061;15076.698466030673;15649.139297338641;15766.527004189878;16255.83744162561;13452.125611835223;13458.259795711256;13476.66308342292;14215.715685686306;14878.404863805436;4340.826366945318;4473.9776301118445;6207.968960155193;6417.229932408094;6449.580777249487;6297.968510157443;6390.616563006211;6411.5191360647905;6446.484281257512;6450.7742229022;5909.734061967221;6119.173911521954;6119.204503414549;6526.738930442777;6532.706028228741;6189.102580125879;6229.065640153968;6235.87528249437;6293.370662933716;6626.271110177877;6282.654454005028;6302.527310451735;6351.809445716636;6361.650109243989;6362.5228107891635;19585.216591336328;21366.893165534228;21995.890020549956;22056.117755289768;22228.666570001464;1877.7840548336842;1889.9905500472546;1930.2954421636143;2028.4827369020804;2042.0708577597306;12903.096783225084;13596.59210223695;13680.863191368058;14163.645908852259;14361.928190359085;1823.489422961573;1828.7531183290218;1858.479625704805;1895.2040143139914;1900;62359.37640623581;66063.3393666062;66525.3347466524;67045.3295467044;67298.32701673018;15802.525924222062;15826;15831.604209894846;15857;15869.603259918364;23178.53642927132;23273.138148948045;23572.64641030386;23611.40971475727;23690;8333.458325208841;8335.666573337;8367.748967530984;8435;8467;6959.791206263821;7064.894026589605;7066.717331306793;7071.186813516511;7080.044194033842;7667.693292268247;7689.769306920802;7735.1491335953;7754.495957762728;7766.534007959541;1679.8488136067813;1713.6487020160837;2999.3401451680597;3016.638003439601;3153.8423078845967;768.7078910014159;806.2058872011064;823.2714048067503;849.2356878809121;931.9701729588842;15547.30037148331;15664;15752.92123539375;15937.601559961095;16133.838661613234;810.8175660476463;839.5718183726343;850.6299759604592;878.5695009445453;902.8871391076116;7219.422446204396;8936.821263574822;9150.176484116462;9178.81642367149;9285.58214880332;313889;322406;326413;326809;526069;32161.839190804363;32166.35667286688;36127.096822579646;59579;66053.669731652;1026.7689769801734;1044.9477526123815;1045.325764881647;1047.669983955067;1056.8309070548676;14444.239226472604;14505.564833055025;14643.633909152357;14676.926615366854;14851;29894.701052989192;31859;32467.837660811543;32927.67072329246;32968.83515582407;35160.47259291061;36175.457368138974;36424.27151456903;38014.239715206095;38780.224395512494;8401.789955251168;8654.350923680624;8684.088170741981;8890.64437422496;8905.910940890508;14845;15157.772633410728;15410.229488525752;15615.76576351333;15693.764593530877;13387.129836560593;13450;13611.455541778614;13728.794068088788;13802.240876751473;13321.267330296927;13896.305184740924;13946.721065578835;13992.930035349758;14035.859641403455;13608.65978350549;14145.504907328193;14295.213763242706;14362.928185359006;14577.198254095701;8336.958315208385;8808.647654093764;8856.202941735017;9044.773880653036;9052.275817934682;9066.456012639263;11218.831717524406;13452.327383630583;13517.932410337886;13855.861441385458 19:36:05 INFO - PROCESS | 4062 | |3;mootools.html;1342.8522862485124;1359.8912087033038;1434.1825159659;1670.9164541772923;1680.9663806723865;6884.483663725228;6978;6993.580385176893;7099.893501597474;7112.253213412589;7020.648967551615;7060.470464715154;7137.571745695262;7154.463415243865;7155.391791697712;1995.4113536506693;2012.4063401296653;2016.5765189310262;2022.1911235505843;2029.6346657601625;2028.5334373094124;2037.3989673046412;2049.354453347191;2057.177129148345;2057.783932687069;1960.4804726747352;1991.711201875727;1992.2628627407807;2009.2264478175862;2028.1988614497266;2028.0569535166144;2070.037432593836;2071.7203177570987;2074.481379655086;2076.3355726167633;1996.8502362322884;2035.0537000294787;2035.104553996237;2035.542003049317;2044.6830741234983;6869.622170780605;6893.310668933117;6937.791866243971;6944.02783610295;6956.165260168762;4145.108801607669;4204.600562946515;4207.095474473003;4216.9578304216875;4217.325227963511;2647.126448272085;2647.9867600661873;2751.8899244030213;2767.2805070681566;2771.6119743235763;826.3678286111129;833.3666413525704;848.2916764501648;874.711345256064;877.0965905117675;9322.48726320052;9357.953210233905;9372.390794598397;9452.57463414148;9497.240220782322;3705.6664900159117;3750.8124593770203;3799.6580307772433;3806.467094606757;3823.9426408603895;7527.661255243527;7543.415882664593;7591;7594.658240379196;7614.352780013761;4183.853565125206;4186.644135248477;4193.077522944947;4202;4209.74741515504;3812.904677383088;3836.3478208704028;3843.7501562398916;3844.38489841624;3855.51806024247;3097.962182668786;3126.7185953264316;3134.5925029746445;3154.5899033125547;3166.255929856482;919.2140719684706;921.7142685767434;922.9261659067258;924.1636319131197;924.2098006204733;887.7558671365426;893.7274131389988;893.9150780675825;938.9671361502293;1138.93166410014;6379.585326953733;6454.128692626529;6465.515086368541;6478.1578394808375;6503;938.7512309238058;993.2749093161888;1047.324475713176;1050.5902697947806;1076.1552181537456;5207.270982062514;5237.8428647140645;5252.9737351313;5262.868428289324;5295.232191332235;8098.51408915467;8612.138786121337;8623;8624.525651089125;8699.347548933856;8411.45325553837;8464.83070338602;8475.1524847516;8486.448380855225;8504.659813607386;6507.089007538948;6557.016447532908;6714.899276510856;6797.28628494001;6810.114685091005;6474.708638111202;6482.837929051811;6531.673416329259;6540.411362977355;6542.738290468518;7438.776836694691;7641.426892982938;7697.114831794192;7745.186755390603;7800.882986755317;7387.519811212254;7564.697412103455;7601.885971710318;7624.199459056719;7872.291493765589;6043.456088952015;6117.592953620603;6158.137860699416;6174.228221472316;6332.145160403471;6658.533902626769;6662.966685166543;6709.563878347892;6769.763058292936;6816.488763342868;5960.8807823844145;6021;6137.324894261538;6218.782342618168;6436.259830119596;5300.602454815981;5955.2853657559635;5995.700214989146;6089.177960975212;6111.541634377529;6237.75048998035;6291.496680265659;6302.117703521602;6306.085617585332;6322.715477803602;5652.85867853307;5710.143478478261;5766.682832444256;5774.682392468455;5780;5591.329040515164;5752.654840709571;5856.560757943256;5861.267341582302;5879.265091863517 19:36:05 INFO - PROCESS | 4062 | |4;prototype.html;292.6312845814274;303.08921690320585;303.7903846346021;304.6785641148587;306.66726601637225;5547.722613869306;5609.7195140242975;5628.240187574676;5641.210230567714;5724.885502289952;5531.225628412026;5534.059209934311;5562.443755624436;5565.6660600364;5572.7770889164385;4089.8773036808943;4240.215560121387;4260.147970405916;4280.464941882257;4311.353297005458;4190.811413486385;4213.346931225649;4226.281532139528;4226.4716910386205;4227.640650544692;4211.157768446307;4211.536730959592;4212.789360531977;4214.093969796493;4225.830966761326;4200.264953633117;4205.5794420558;4208.747475151501;4208.873733787976;4209.758121354208;3608.440691692792;3630.146915474888;3639.9272014559824;3640.5085313482605;3643.6174201708704;5274.815381461669;5345.919811202835;5387.24578559002;5406.729663516809;5429.647072940285;4926.778294976734;4953.653244272902;4967.056259310755;4987.276844857512;4996.500349965011;5900.380460051719;5902.32123305821;5911.113333000041;5929.0513517836935;5936.46571808535;4012.197560487914;4105.958940410617;4112.115895082542;4112.259793237216;4115.97942010291;6136.23297087864;6210.130581718563;6229.87540249197;6253.218347706536;6325.493960483104;4241.575842415796;4242.766647834399;4247.532771395144;4251.319788833834;4254.383114448449;4301.2257793597455;4303.569643035671;4304.677149213821;4305.82776688929;4310.784460777011;4824.855254342376;4911.066897289504;4913.459519452857;4932.506749325111;4967.4535801062575;5903.734331955073;5904.498117659961;5911.9113213301835;5912.615679980788;5933.1396947443245;1506.4501456968128;1519.9392024319125;1521.269790500566;1521.9695606087816;1524.26073354423;1028.3367228137809;1036.0571879589688;1041.6510468992972;1043.932144410626;1059.7191744187796;5114.514121158484;5123.2827404163445;5133.948660513347;5134.358205224347;5148.58811295103;6148.877022459616;6152;6157.692115394212;6168.074788781629;6184.6598437086395;5115.7442127893455;5120.334356533627;5120.564751996048;5139.974300128475;5142.048720986555;3227.935441291161;3315.370079684852;3316.4859446785786;3328.5340052392685;3331.350386674575;5675.659460432387;5766.452187042224;5813.418658134153;5840.561957853178;5861.736221870026;6340.492760579143;6341.841453963688;6343.619382837044;6364;6367.586106903036;5770.855728606818;5794;5795.913061304083;5800.88398232033;5808.970955145282;6162.075688646739;6163.705621819288;6176.876462470816;6182.783602573888;6188.412100850412;5814.505767009682;6001.879962400815;6032.366601506954;6043.486303664062;6045.486133678511;5807.912881306868;5809.448102430262;5811.215485909517;5823.213866128019;5824;4114.280000999873;4160.084781348099;4160.708750387565;4163.8959026024595;4165.5001399831;6055.939440605714;6164.938350616437;6184.226971628546;6185.597936134137;6206.937930620636;5910.556708246812;5919.526437885045;5923.911141332969;5941.702914854153;5951.613145145551;5888.735006924784;5925.111233315038;5932.525397968238;5932.79235226765;5936.525077993837;5563.915036567831;5702.258706368146;5770.192173095854;5781.364049954585;5783.392743761844;5902.20320256777;5903.114532820111;5985.102234664835;5998.370171131968;5998.580099393001;5725.828225153252;5764.135379692912;5769.480746732815;5797.449242321973;5830.067189249699 19:36:05 INFO - PROCESS | 4062 | |5;yui.html;654.9410553050226;723.7430712097205;751.932326090652;761.9123800762914;765.5521519910852;10493.632722854702;10853.34879907206;10963.725906852333;11058.391788451632;11072.667819965403;10424.478776061185;10447.477626118702;10463.581456741722;10544.051035406812;10580.576776928932;608.5496732418023;747.3311386309264;760.2359628573304;760.5132715062365;762.4548447859779;607.3107023528305;751.9210482899299;752.2815710995985;760.6424980259269;762.5424745152919;787.5747096567875;790.0637744273055;791.6477167660394;792.5086446403209;793.3217099380033;781.238292664653;782.1630854985168;783.8432313537315;788.6490511722286;794.9841003179932;579.5421616922627;582.5456144207525;582.8309790160848;589.7346194212579;590.7105518296004;10116.89883101167;10155.847662285072;10242.436665983369;10265.332753371007;10273.38359698413;10375.325603835727;11099.278546894508;11103.38931358775;11132.833007504894;11176.273542219811;8010.919890801134;8034.276915077613;8133.26800587944;8148.307393871528;9043.547822608843;3099.628044634636;3132.6084239470065;3152.4956007038763;3161.7944833585743;3162.177833763215;40339.596604034174;40514.59485405138;40654.593454065674;41042.589574104175;41224;9228.8615670765;9332.95333523328;9427;9435.858462123073;9488.288378371511;15995.12026838535;16008.519744407686;16025.759613605805;16050.277737501841;16060.956037857502;6124.326324104345;6145.4161854623735;6225;6311.400416960381;6352.047192921006;3503.4394496880886;3538.5399898013607;3605.7295702822394;3609.224016836393;3671.2473942841652;2604.231751633273;2630.8684565771637;2635.3016450640594;2635.9472810544066;2641.088824355594;425.7381710248237;427.3397600706853;430.7566225082818;433.87200775771225;437.5668088592271;433.8546586893426;579.1775678536488;594.2512434332772;602.1479606357043;609.679918043031;7605.391568674493;7616.885746713804;7969.521828690181;8580.914190858137;8711.172438618321;437.9978100109479;456.76704880510516;545.9836204913859;601.5518438763149;636.6371168434041;3383.610884748236;3436.106612280775;3532.2405682778326;3580.785152890835;3753.155540003477;47030.5296947033;47896.760516197195;48096.27855582169;48344;48346.27480587794;40290.59709402927;40654.59345406508;44013.779931100136;44573.55426445759;44637.77681111639;38403.615963840006;38589.42115868264;38621.227575448334;42110.78944605319;42430.36354454624;7773.41699372538;7804.219578042151;7878.369730421437;8007.519548826856;8058.234467725557;31352.686473135887;31554.211144721565;31885.840570796998;32057.839710801298;32250.677493224768;37281.81359093187;40515.18969620532;41111.588884111974;41229.793851030554;41480.58519414888;9828.508574571386;10025.5488503019;10029.498525073863;10032.949835250776;10168.28821982454;11103.333799972028;11258.38078905668;11270.154738394489;11369.658910232707;11621.24461909973;10204;10285.640002600172;10570.630027949292;10692.091172250446;10735.141188704729;9936.950315248378;9984.101430871257;10211.23415743837;10568.735781605521;10834.783304334027;10018.148457380912;10145.391276523433;10355.637552685619;10622;10623.575056997634;8703.47779133254;8812.955935220283;8822.250108740573;9393.389429687048;9402.43585384879;8534.573271336532;8784.692535761218;9391.483468409304;9460.763480912758;9709.805803884024 19:36:05 INFO - PROCESS | 4062 | __end_tp_report 19:36:05 INFO - PROCESS | 4062 | __start_cc_report 19:36:05 INFO - PROCESS | 4062 | _x_x_mozilla_cycle_collect,318 19:36:05 INFO - PROCESS | 4062 | __end_cc_report 19:36:05 INFO - PROCESS | 4062 | __startTimestamp1451100965130__endTimestamp 19:36:05 INFO - PROCESS | 4062 | 19:36:05 INFO - PROCESS | 4062 | ------- Summary: start ------- 19:36:05 INFO - PROCESS | 4062 | Number of tests: 6 19:36:05 INFO - PROCESS | 4062 | 19:36:05 INFO - PROCESS | 4062 | [#0] dojo.html Cycles:165 Average:4595.37 Median:4730.65 stddev:479.93 (10.1%) stddev-sans-first:455.60 19:36:05 INFO - PROCESS | 4062 | Values: 2616.5 2647.9 2668.8 2672.0 2685.9 4480.2 4537.2 4602.8 4627.7 4648.1 4524.1 4525.8 4597.9 4730.6 4757.8 4221.0 4250.9 4345.8 4353.6 4397.0 4347.9 4350.3 4383.0 4404.5 4486.5 4159.8 4207.8 4263.0 4342.3 4347.1 4255.2 4271.1 4299.0 4342.5 4348.1 4283.0 4290.5 4292.4 4299.9 4350.0 4382.1 4473.8 4490.0 4581.5 4610.9 5002.3 5006.1 5011.2 5016.6 5024.1 5064.8 5112.3 5115.0 5129.1 5177.7 4480.6 4559.9 4574.0 4586.0 4587.6 4949.8 4966.8 4974.3 4981.6 5090.9 4963.1 4969.8 4970.4 4972.8 4991.1 5007.4 5052.5 5058.6 5063.2 5089.7 4758.7 4826.4 4876.2 4919.1 5002.6 4841.3 4897.9 4903.9 4904.7 4935.4 4115.5 4143.9 4148.5 4149.7 4198.0 3561.0 3615.2 3654.6 3685.7 3710.2 4305.8 4328.7 4343.4 4372.0 4384.0 4769.4 5019.5 5033.2 5055.8 5057.2 4224.0 4247.5 4297.8 4302.5 4330.3 4408.8 4435.1 4461.8 4466.3 4469.2 4502.7 4601.5 4758.1 4766.6 4779.6 4884.7 4955.7 5022.3 5046.9 5081.5 4712.4 4729.3 4750.5 4765.9 4767.8 4739.6 4844.0 4947.0 4957.4 5004.7 4984.4 5046.0 5065.0 5074.2 5100.8 4795.8 4813.8 4819.6 4827.1 4828.5 4630.7 4746.6 4764.9 4821.8 4863.8 4706.4 4722.4 4747.6 4772.9 4775.5 4883.7 4907.1 4907.6 4924.8 4947.7 4604.1 4706.8 4739.1 4797.5 4828.3 19:36:05 INFO - PROCESS | 4062 | 19:36:05 INFO - PROCESS | 4062 | [#1] ext.html Cycles:180 Average:40134.05 Median:3423.98 stddev:64162.81 (1873.9%) stddev-sans-first:64273.86 19:36:05 INFO - PROCESS | 4062 | Values: 520.7 544.0 571.8 575.0 585.1 32546.8 33070.7 33224.3 33229.7 33241.0 36260.6 36674.6 36762.3 36802.6 37064.0 7552.2 7670.3 7724.1 7736.6 7751.7 7509.0 7605.9 7683.3 7809.8 7861.4 7798.9 7803.5 7819.6 7835.5 7860.3 7740.6 7841.0 7863.2 7882.4 7912.6 7619.1 7668.2 7704.1 7733.3 7737.1 36339.5 37040.0 37057.3 37077.1 37078.3 2920.5 2997.2 3213.7 3331.3 3486.5 27996.2 28317.7 28329.6 28611.6 28870.0 3269.9 3310.1 3331.6 3422.0 3426.0 220392.0 222567.9 222990.0 223508.0 223575.0 45491.0 46448.3 55734.7 56483.0 56701.7 50668.7 50929.7 50935.5 51194.5 51239.2 12743.6 12854.9 12933.2 12946.4 12961.4 9468.2 9476.2 9478.7 9491.4 9582.3 19073.8 19418.1 19553.5 19584.0 19652.9 7421.3 7525.5 7547.7 7593.4 7650.7 809.3 855.7 864.8 1033.8 1052.3 25884.2 26193.3 26449.6 26785.0 26842.2 924.6 965.4 986.1 995.7 1007.1 13788.1 13944.9 14180.8 14207.3 14289.9 264437.0 267762.0 269485.0 270006.0 270708.0 46443.0 47020.0 47121.3 47194.5 47300.5 1169.6 1183.1 1185.0 1189.9 1195.0 24733.0 26406.3 26587.7 26655.9 26701.7 40405.4 40721.8 40755.8 40770.8 40774.4 244279.0 245641.0 245771.0 246032.0 246491.0 24226.4 24334.5 28836.4 30615.4 31153.4 41119.8 41692.2 41713.2 42383.8 42588.0 30161.5 30573.0 30644.2 30728.7 30734.4 29683.3 29874.3 30096.0 30106.1 30266.9 35224.8 35315.8 35560.5 35963.9 36364.5 25936.5 26375.9 27726.9 28222.3 28380.9 22569.0 23786.5 24029.9 24057.2 24256.3 19:36:05 INFO - PROCESS | 4062 | 19:36:05 INFO - PROCESS | 4062 | [#2] jquery.html Cycles:180 Average:23231.35 Median:16395.98 stddev:60723.84 (370.4%) stddev-sans-first:60869.83 19:36:05 INFO - PROCESS | 4062 | Values: 324.1 325.7 329.2 332.0 333.0 14674.4 15076.7 15649.1 15766.5 16255.8 13452.1 13458.3 13476.7 14215.7 14878.4 4340.8 4474.0 6208.0 6417.2 6449.6 6298.0 6390.6 6411.5 6446.5 6450.8 5909.7 6119.2 6119.2 6526.7 6532.7 6189.1 6229.1 6235.9 6293.4 6626.3 6282.7 6302.5 6351.8 6361.7 6362.5 19585.2 21366.9 21995.9 22056.1 22228.7 1877.8 1890.0 1930.3 2028.5 2042.1 12903.1 13596.6 13680.9 14163.6 14361.9 1823.5 1828.8 1858.5 1895.2 1900.0 62359.4 66063.3 66525.3 67045.3 67298.3 15802.5 15826.0 15831.6 15857.0 15869.6 23178.5 23273.1 23572.6 23611.4 23690.0 8333.5 8335.7 8367.7 8435.0 8467.0 6959.8 7064.9 7066.7 7071.2 7080.0 7667.7 7689.8 7735.1 7754.5 7766.5 1679.8 1713.6 2999.3 3016.6 3153.8 768.7 806.2 823.3 849.2 932.0 15547.3 15664.0 15752.9 15937.6 16133.8 810.8 839.6 850.6 878.6 902.9 7219.4 8936.8 9150.2 9178.8 9285.6 313889.0 322406.0 326413.0 326809.0 526069.0 32161.8 32166.4 36127.1 59579.0 66053.7 1026.8 1044.9 1045.3 1047.7 1056.8 14444.2 14505.6 14643.6 14676.9 14851.0 29894.7 31859.0 32467.8 32927.7 32968.8 35160.5 36175.5 36424.3 38014.2 38780.2 8401.8 8654.4 8684.1 8890.6 8905.9 14845.0 15157.8 15410.2 15615.8 15693.8 13387.1 13450.0 13611.5 13728.8 13802.2 13321.3 13896.3 13946.7 13992.9 14035.9 13608.7 14145.5 14295.2 14362.9 14577.2 8337.0 8808.6 8856.2 9044.8 9052.3 9066.5 11218.8 13452.3 13517.9 13855.9 19:36:05 INFO - PROCESS | 4062 | 19:36:05 INFO - PROCESS | 4062 | [#3] mootools.html Cycles:180 Average:4866.58 Median:6196.51 stddev:2524.06 (40.7%) stddev-sans-first:2517.25 19:36:05 INFO - PROCESS | 4062 | Values: 1342.9 1359.9 1434.2 1670.9 1681.0 6884.5 6978.0 6993.6 7099.9 7112.3 7020.6 7060.5 7137.6 7154.5 7155.4 1995.4 2012.4 2016.6 2022.2 2029.6 2028.5 2037.4 2049.4 2057.2 2057.8 1960.5 1991.7 1992.3 2009.2 2028.2 2028.1 2070.0 2071.7 2074.5 2076.3 1996.9 2035.1 2035.1 2035.5 2044.7 6869.6 6893.3 6937.8 6944.0 6956.2 4145.1 4204.6 4207.1 4217.0 4217.3 2647.1 2648.0 2751.9 2767.3 2771.6 826.4 833.4 848.3 874.7 877.1 9322.5 9358.0 9372.4 9452.6 9497.2 3705.7 3750.8 3799.7 3806.5 3823.9 7527.7 7543.4 7591.0 7594.7 7614.4 4183.9 4186.6 4193.1 4202.0 4209.7 3812.9 3836.3 3843.8 3844.4 3855.5 3098.0 3126.7 3134.6 3154.6 3166.3 919.2 921.7 922.9 924.2 924.2 887.8 893.7 893.9 939.0 1138.9 6379.6 6454.1 6465.5 6478.2 6503.0 938.8 993.3 1047.3 1050.6 1076.2 5207.3 5237.8 5253.0 5262.9 5295.2 8098.5 8612.1 8623.0 8624.5 8699.3 8411.5 8464.8 8475.2 8486.4 8504.7 6507.1 6557.0 6714.9 6797.3 6810.1 6474.7 6482.8 6531.7 6540.4 6542.7 7438.8 7641.4 7697.1 7745.2 7800.9 7387.5 7564.7 7601.9 7624.2 7872.3 6043.5 6117.6 6158.1 6174.2 6332.1 6658.5 6663.0 6709.6 6769.8 6816.5 5960.9 6021.0 6137.3 6218.8 6436.3 5300.6 5955.3 5995.7 6089.2 6111.5 6237.8 6291.5 6302.1 6306.1 6322.7 5652.9 5710.1 5766.7 5774.7 5780.0 5591.3 5752.7 5856.6 5861.3 5879.3 19:36:05 INFO - PROCESS | 4062 | 19:36:05 INFO - PROCESS | 4062 | [#4] prototype.html Cycles:180 Average:4882.31 Median:5532.64 stddev:1455.21 (26.3%) stddev-sans-first:1417.93 19:36:05 INFO - PROCESS | 4062 | Values: 292.6 303.1 303.8 304.7 306.7 5547.7 5609.7 5628.2 5641.2 5724.9 5531.2 5534.1 5562.4 5565.7 5572.8 4089.9 4240.2 4260.1 4280.5 4311.4 4190.8 4213.3 4226.3 4226.5 4227.6 4211.2 4211.5 4212.8 4214.1 4225.8 4200.3 4205.6 4208.7 4208.9 4209.8 3608.4 3630.1 3639.9 3640.5 3643.6 5274.8 5345.9 5387.2 5406.7 5429.6 4926.8 4953.7 4967.1 4987.3 4996.5 5900.4 5902.3 5911.1 5929.1 5936.5 4012.2 4106.0 4112.1 4112.3 4116.0 6136.2 6210.1 6229.9 6253.2 6325.5 4241.6 4242.8 4247.5 4251.3 4254.4 4301.2 4303.6 4304.7 4305.8 4310.8 4824.9 4911.1 4913.5 4932.5 4967.5 5903.7 5904.5 5911.9 5912.6 5933.1 1506.5 1519.9 1521.3 1522.0 1524.3 1028.3 1036.1 1041.7 1043.9 1059.7 5114.5 5123.3 5133.9 5134.4 5148.6 6148.9 6152.0 6157.7 6168.1 6184.7 5115.7 5120.3 5120.6 5140.0 5142.0 3227.9 3315.4 3316.5 3328.5 3331.4 5675.7 5766.5 5813.4 5840.6 5861.7 6340.5 6341.8 6343.6 6364.0 6367.6 5770.9 5794.0 5795.9 5800.9 5809.0 6162.1 6163.7 6176.9 6182.8 6188.4 5814.5 6001.9 6032.4 6043.5 6045.5 5807.9 5809.4 5811.2 5823.2 5824.0 4114.3 4160.1 4160.7 4163.9 4165.5 6055.9 6164.9 6184.2 6185.6 6206.9 5910.6 5919.5 5923.9 5941.7 5951.6 5888.7 5925.1 5932.5 5932.8 5936.5 5563.9 5702.3 5770.2 5781.4 5783.4 5902.2 5903.1 5985.1 5998.4 5998.6 5725.8 5764.1 5769.5 5797.4 5830.1 19:36:05 INFO - PROCESS | 4062 | 19:36:05 INFO - PROCESS | 4062 | [#5] yui.html Cycles:180 Average:11990.80 Median:429.05 stddev:13647.64 (3180.9%) stddev-sans-first:13659.37 19:36:05 INFO - PROCESS | 4062 | Values: 654.9 723.7 751.9 761.9 765.6 10493.6 10853.3 10963.7 11058.4 11072.7 10424.5 10447.5 10463.6 10544.1 10580.6 608.5 747.3 760.2 760.5 762.5 607.3 751.9 752.3 760.6 762.5 787.6 790.1 791.6 792.5 793.3 781.2 782.2 783.8 788.6 795.0 579.5 582.5 582.8 589.7 590.7 10116.9 10155.8 10242.4 10265.3 10273.4 10375.3 11099.3 11103.4 11132.8 11176.3 8010.9 8034.3 8133.3 8148.3 9043.5 3099.6 3132.6 3152.5 3161.8 3162.2 40339.6 40514.6 40654.6 41042.6 41224.0 9228.9 9333.0 9427.0 9435.9 9488.3 15995.1 16008.5 16025.8 16050.3 16061.0 6124.3 6145.4 6225.0 6311.4 6352.0 3503.4 3538.5 3605.7 3609.2 3671.2 2604.2 2630.9 2635.3 2635.9 2641.1 425.7 427.3 430.8 433.9 437.6 433.9 579.2 594.3 602.1 609.7 7605.4 7616.9 7969.5 8580.9 8711.2 438.0 456.8 546.0 601.6 636.6 3383.6 3436.1 3532.2 3580.8 3753.2 47030.5 47896.8 48096.3 48344.0 48346.3 40290.6 40654.6 44013.8 44573.6 44637.8 38403.6 38589.4 38621.2 42110.8 42430.4 7773.4 7804.2 7878.4 8007.5 8058.2 31352.7 31554.2 31885.8 32057.8 32250.7 37281.8 40515.2 41111.6 41229.8 41480.6 9828.5 10025.5 10029.5 10032.9 10168.3 11103.3 11258.4 11270.2 11369.7 11621.2 10204.0 10285.6 10570.6 10692.1 10735.1 9937.0 9984.1 10211.2 10568.7 10834.8 10018.1 10145.4 10355.6 10622.0 10623.6 8703.5 8813.0 8822.3 9393.4 9402.4 8534.6 8784.7 9391.5 9460.8 9709.8 19:36:05 INFO - PROCESS | 4062 | -------- Summary: end -------- 19:36:05 INFO - PROCESS | 4062 | 19:36:05 INFO - TEST-INFO | 4062: exit 0 19:36:05 INFO - TEST-OK | dromaeo_css | took 1116578ms 19:36:05 INFO - TEST-START | kraken 19:36:05 INFO - operating with platform_type : linux_ 19:36:05 INFO - Initialising browser for kraken test... 19:36:05 INFO - TEST-INFO | started process 4303 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3DI7mh/profile http://localhost:42261/getInfo.html) 19:36:10 INFO - PROCESS | 4303 | __metrics Screen width/height:1600/1200 19:36:10 INFO - PROCESS | 4303 | colorDepth:24 19:36:10 INFO - PROCESS | 4303 | Browser inner width/height: 1024/697 19:36:10 INFO - PROCESS | 4303 | __metrics 19:36:10 INFO - PROCESS | 4303 | 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:36:11 INFO - TEST-INFO | 4303: exit 0 19:36:11 INFO - Browser initialized. 19:36:11 INFO - Running cycle 1/1 for kraken test... 19:36:11 INFO - TEST-INFO | started process 4425 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3DI7mh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:36:23 INFO - PROCESS | 4425 | RSS: Main: 149839872 19:36:23 INFO - PROCESS | 4425 | 19:36:26 INFO - PROCESS | 4425 | Cycle 1(1): loaded http://localhost:42261/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42261/tests/kraken/driver.html?testName=audio-beat-detection) 19:36:26 INFO - PROCESS | 4425 | RSS: Main: 149721088 19:36:26 INFO - PROCESS | 4425 | 19:36:29 INFO - PROCESS | 4425 | Cycle 1(1): loaded http://localhost:42261/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42261/tests/kraken/driver.html?testName=audio-dft) 19:36:30 INFO - PROCESS | 4425 | RSS: Main: 149970944 19:36:30 INFO - PROCESS | 4425 | 19:36:33 INFO - PROCESS | 4425 | Cycle 1(1): loaded http://localhost:42261/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42261/tests/kraken/driver.html?testName=audio-fft) 19:36:33 INFO - PROCESS | 4425 | RSS: Main: 146661376 19:36:33 INFO - PROCESS | 4425 | 19:36:35 INFO - PROCESS | 4425 | Cycle 1(1): loaded http://localhost:42261/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42261/tests/kraken/driver.html?testName=audio-oscillator) 19:36:36 INFO - PROCESS | 4425 | RSS: Main: 146710528 19:36:36 INFO - PROCESS | 4425 | 19:36:38 INFO - PROCESS | 4425 | Cycle 1(1): loaded http://localhost:42261/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42261/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:36:39 INFO - PROCESS | 4425 | RSS: Main: 146128896 19:36:39 INFO - PROCESS | 4425 | 19:36:42 INFO - PROCESS | 4425 | Cycle 1(1): loaded http://localhost:42261/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42261/tests/kraken/driver.html?testName=imaging-darkroom) 19:36:42 INFO - PROCESS | 4425 | RSS: Main: 145424384 19:36:42 INFO - PROCESS | 4425 | 19:36:46 INFO - PROCESS | 4425 | Cycle 1(1): loaded http://localhost:42261/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42261/tests/kraken/driver.html?testName=imaging-desaturate) 19:36:47 INFO - PROCESS | 4425 | RSS: Main: 145416192 19:36:47 INFO - PROCESS | 4425 | 19:36:49 INFO - PROCESS | 4425 | Cycle 1(1): loaded http://localhost:42261/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42261/tests/kraken/driver.html?testName=json-parse-financial) 19:36:50 INFO - PROCESS | 4425 | RSS: Main: 145244160 19:36:50 INFO - PROCESS | 4425 | 19:36:52 INFO - PROCESS | 4425 | Cycle 1(1): loaded http://localhost:42261/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42261/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:36:52 INFO - PROCESS | 4425 | RSS: Main: 148230144 19:36:52 INFO - PROCESS | 4425 | 19:36:54 INFO - PROCESS | 4425 | Cycle 1(1): loaded http://localhost:42261/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42261/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:36:55 INFO - PROCESS | 4425 | RSS: Main: 148762624 19:36:55 INFO - PROCESS | 4425 | 19:36:57 INFO - PROCESS | 4425 | Cycle 1(1): loaded http://localhost:42261/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42261/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:36:58 INFO - PROCESS | 4425 | RSS: Main: 148701184 19:36:58 INFO - PROCESS | 4425 | 19:37:00 INFO - PROCESS | 4425 | Cycle 1(1): loaded http://localhost:42261/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42261/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:37:01 INFO - PROCESS | 4425 | RSS: Main: 149155840 19:37:01 INFO - PROCESS | 4425 | 19:37:03 INFO - PROCESS | 4425 | Cycle 1(1): loaded http://localhost:42261/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42261/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:37:04 INFO - PROCESS | 4425 | RSS: Main: 148164608 19:37:04 INFO - PROCESS | 4425 | 19:37:06 INFO - PROCESS | 4425 | Cycle 1(1): loaded http://localhost:42261/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42261/tests/kraken/driver.html?testName=ai-astar) 19:37:06 INFO - PROCESS | 4425 | RSS: Main: 147419136 19:37:06 INFO - PROCESS | 4425 | 19:37:06 INFO - PROCESS | 4425 | __start_tp_report 19:37:06 INFO - PROCESS | 4425 | _x_x_mozilla_page_load 19:37:06 INFO - PROCESS | 4425 | _x_x_mozilla_page_load_details 19:37:06 INFO - PROCESS | 4425 | |i|pagename|runs| 19:37:06 INFO - PROCESS | 4425 | |0;ai-astar;115;108;113;112;114;126;114;114;112;113 19:37:06 INFO - PROCESS | 4425 | |1;audio-beat-detection;161;130;153;183;128;157;161;137;172;133 19:37:06 INFO - PROCESS | 4425 | |2;audio-dft;172;162;164;160;164;163;172;166;164;162 19:37:06 INFO - PROCESS | 4425 | |3;audio-fft;72;74;75;75;132;72;73;73;72;89 19:37:06 INFO - PROCESS | 4425 | |4;audio-oscillator;97;97;135;99;98;99;132;98;98;133 19:37:06 INFO - PROCESS | 4425 | |5;imaging-gaussian-blur;110;109;110;111;110;110;111;110;110;109 19:37:06 INFO - PROCESS | 4425 | |6;imaging-darkroom;148;150;149;148;149;149;148;149;149;148 19:37:06 INFO - PROCESS | 4425 | |7;imaging-desaturate;96;97;97;96;96;100;97;96;95;96 19:37:06 INFO - PROCESS | 4425 | |8;json-parse-financial;73;71;73;71;75;71;71;73;73;68 19:37:06 INFO - PROCESS | 4425 | |9;json-stringify-tinderbox;67;71;70;68;69;68;69;71;71;69 19:37:06 INFO - PROCESS | 4425 | |10;stanford-crypto-aes;87;85;86;84;85;87;85;85;86;83 19:37:06 INFO - PROCESS | 4425 | |11;stanford-crypto-ccm;123;134;120;124;124;125;124;129;131;120 19:37:06 INFO - PROCESS | 4425 | |12;stanford-crypto-pbkdf2;138;150;148;151;149;154;141;150;150;137 19:37:06 INFO - PROCESS | 4425 | |13;stanford-crypto-sha256-iterative;69;71;69;69;69;70;68;72;69;72 19:37:06 INFO - PROCESS | 4425 | __end_tp_report 19:37:06 INFO - PROCESS | 4425 | __start_cc_report 19:37:06 INFO - PROCESS | 4425 | _x_x_mozilla_cycle_collect,781 19:37:06 INFO - PROCESS | 4425 | __end_cc_report 19:37:06 INFO - PROCESS | 4425 | __startTimestamp1451101026502__endTimestamp 19:37:06 INFO - PROCESS | 4425 | 19:37:06 INFO - PROCESS | 4425 | ------- Summary: start ------- 19:37:06 INFO - PROCESS | 4425 | Number of tests: 14 19:37:06 INFO - PROCESS | 4425 | 19:37:06 INFO - PROCESS | 4425 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.00 stddev:4.61 (4.0%) stddev-sans-first:4.87 19:37:06 INFO - PROCESS | 4425 | Values: 115.0 108.0 113.0 112.0 114.0 126.0 114.0 114.0 112.0 113.0 19:37:06 INFO - PROCESS | 4425 | 19:37:06 INFO - PROCESS | 4425 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:159.00 stddev:18.83 (11.8%) stddev-sans-first:19.66 19:37:06 INFO - PROCESS | 4425 | Values: 161.0 130.0 153.0 183.0 128.0 157.0 161.0 137.0 172.0 133.0 19:37:06 INFO - PROCESS | 4425 | 19:37:06 INFO - PROCESS | 4425 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.00 stddev:4.07 (2.5%) stddev-sans-first:3.41 19:37:06 INFO - PROCESS | 4425 | Values: 172.0 162.0 164.0 160.0 164.0 163.0 172.0 166.0 164.0 162.0 19:37:06 INFO - PROCESS | 4425 | 19:37:06 INFO - PROCESS | 4425 | [#3] audio-fft Cycles:10 Average:80.70 Median:73.50 stddev:18.73 (25.5%) stddev-sans-first:19.60 19:37:06 INFO - PROCESS | 4425 | Values: 72.0 74.0 75.0 75.0 132.0 72.0 73.0 73.0 72.0 89.0 19:37:06 INFO - PROCESS | 4425 | 19:37:06 INFO - PROCESS | 4425 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:98.00 stddev:17.10 (17.4%) stddev-sans-first:17.61 19:37:06 INFO - PROCESS | 4425 | Values: 97.0 97.0 135.0 99.0 98.0 99.0 132.0 98.0 98.0 133.0 19:37:06 INFO - PROCESS | 4425 | 19:37:06 INFO - PROCESS | 4425 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 19:37:06 INFO - PROCESS | 4425 | Values: 110.0 109.0 110.0 111.0 110.0 110.0 111.0 110.0 110.0 109.0 19:37:06 INFO - PROCESS | 4425 | 19:37:06 INFO - PROCESS | 4425 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 19:37:06 INFO - PROCESS | 4425 | Values: 148.0 150.0 149.0 148.0 149.0 149.0 148.0 149.0 149.0 148.0 19:37:06 INFO - PROCESS | 4425 | 19:37:06 INFO - PROCESS | 4425 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.00 stddev:1.35 (1.4%) stddev-sans-first:1.41 19:37:06 INFO - PROCESS | 4425 | Values: 96.0 97.0 97.0 96.0 96.0 100.0 97.0 96.0 95.0 96.0 19:37:06 INFO - PROCESS | 4425 | 19:37:06 INFO - PROCESS | 4425 | [#8] json-parse-financial Cycles:10 Average:71.90 Median:73.00 stddev:1.91 (2.6%) stddev-sans-first:1.99 19:37:06 INFO - PROCESS | 4425 | Values: 73.0 71.0 73.0 71.0 75.0 71.0 71.0 73.0 73.0 68.0 19:37:06 INFO - PROCESS | 4425 | 19:37:06 INFO - PROCESS | 4425 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.50 stddev:1.42 (2.0%) stddev-sans-first:1.24 19:37:06 INFO - PROCESS | 4425 | Values: 67.0 71.0 70.0 68.0 69.0 68.0 69.0 71.0 71.0 69.0 19:37:06 INFO - PROCESS | 4425 | 19:37:06 INFO - PROCESS | 4425 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.50 stddev:1.25 (1.5%) stddev-sans-first:1.17 19:37:06 INFO - PROCESS | 4425 | Values: 87.0 85.0 86.0 84.0 85.0 87.0 85.0 85.0 86.0 83.0 19:37:06 INFO - PROCESS | 4425 | 19:37:06 INFO - PROCESS | 4425 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:124.50 stddev:4.58 (3.7%) stddev-sans-first:4.77 19:37:06 INFO - PROCESS | 4425 | Values: 123.0 134.0 120.0 124.0 124.0 125.0 124.0 129.0 131.0 120.0 19:37:06 INFO - PROCESS | 4425 | 19:37:06 INFO - PROCESS | 4425 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.80 Median:150.00 stddev:5.90 (3.9%) stddev-sans-first:5.33 19:37:06 INFO - PROCESS | 4425 | Values: 138.0 150.0 148.0 151.0 149.0 154.0 141.0 150.0 150.0 137.0 19:37:06 INFO - PROCESS | 4425 | 19:37:06 INFO - PROCESS | 4425 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:69.50 stddev:1.40 (2.0%) stddev-sans-first:1.45 19:37:06 INFO - PROCESS | 4425 | Values: 69.0 71.0 69.0 69.0 69.0 70.0 68.0 72.0 69.0 72.0 19:37:06 INFO - PROCESS | 4425 | -------- Summary: end -------- 19:37:06 INFO - PROCESS | 4425 | 19:37:07 INFO - TEST-INFO | 4425: exit 0 19:37:07 INFO - TEST-OK | kraken | took 61566ms 19:37:07 INFO - TEST-START | v8_7 19:37:07 INFO - operating with platform_type : linux_ 19:37:07 INFO - Initialising browser for v8_7 test... 19:37:07 INFO - TEST-INFO | started process 4709 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkaXqI6/profile http://localhost:42261/getInfo.html) 19:37:12 INFO - PROCESS | 4709 | __metrics Screen width/height:1600/1200 19:37:12 INFO - PROCESS | 4709 | colorDepth:24 19:37:12 INFO - PROCESS | 4709 | Browser inner width/height: 1024/697 19:37:12 INFO - PROCESS | 4709 | __metrics 19:37:12 INFO - PROCESS | 4709 | 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:37:13 INFO - TEST-INFO | 4709: exit 0 19:37:13 INFO - Browser initialized. 19:37:13 INFO - Running cycle 1/1 for v8_7 test... 19:37:13 INFO - TEST-INFO | started process 4831 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkaXqI6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:37:25 INFO - PROCESS | 4831 | RSS: Main: 149602304 19:37:25 INFO - PROCESS | 4831 | 19:37:46 INFO - PROCESS | 4831 | Cycle 1(1): loaded http://localhost:42261/tests/v8_7/run.html (next: http://localhost:42261/tests/v8_7/run.html) 19:37:46 INFO - PROCESS | 4831 | RSS: Main: 145104896 19:37:46 INFO - PROCESS | 4831 | 19:37:46 INFO - PROCESS | 4831 | __start_tp_report 19:37:46 INFO - PROCESS | 4831 | _x_x_mozilla_page_load 19:37:46 INFO - PROCESS | 4831 | _x_x_mozilla_page_load_details 19:37:46 INFO - PROCESS | 4831 | |i|pagename|runs| 19:37:46 INFO - PROCESS | 4831 | |0;Richards;169.43409013893594 19:37:46 INFO - PROCESS | 4831 | |1;DeltaBlue;189.5734597156398 19:37:46 INFO - PROCESS | 4831 | |2;Encrypt;278.08676307007784 19:37:46 INFO - PROCESS | 4831 | |3;Decrypt;5208.333333333333 19:37:46 INFO - PROCESS | 4831 | |4;RayTrace;1050.420168067227 19:37:46 INFO - PROCESS | 4831 | |5;Earley;703.7297677691766 19:37:46 INFO - PROCESS | 4831 | |6;Boyer;12512.5 19:37:46 INFO - PROCESS | 4831 | |7;RegExp;26394.736842105263 19:37:46 INFO - PROCESS | 4831 | |8;Splay;645.577792123951 19:37:46 INFO - PROCESS | 4831 | |9;NavierStokes;4840.579710144928 19:37:46 INFO - PROCESS | 4831 | __end_tp_report 19:37:46 INFO - PROCESS | 4831 | __startTimestamp1451101066948__endTimestamp 19:37:46 INFO - PROCESS | 4831 | 19:37:46 INFO - PROCESS | 4831 | ------- Summary: start ------- 19:37:46 INFO - PROCESS | 4831 | Number of tests: 10 19:37:46 INFO - PROCESS | 4831 | 19:37:46 INFO - PROCESS | 4831 | [#0] Richards Cycles:1 Average:169.43 Median:169.43 stddev:0.00 (0.0%) 19:37:46 INFO - PROCESS | 4831 | Values: 169.4 19:37:46 INFO - PROCESS | 4831 | 19:37:46 INFO - PROCESS | 4831 | [#1] DeltaBlue Cycles:1 Average:189.57 Median:189.57 stddev:0.00 (0.0%) 19:37:46 INFO - PROCESS | 4831 | Values: 189.6 19:37:46 INFO - PROCESS | 4831 | 19:37:46 INFO - PROCESS | 4831 | [#2] Encrypt Cycles:1 Average:278.09 Median:278.09 stddev:0.00 (0.0%) 19:37:46 INFO - PROCESS | 4831 | Values: 278.1 19:37:46 INFO - PROCESS | 4831 | 19:37:46 INFO - PROCESS | 4831 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 19:37:46 INFO - PROCESS | 4831 | Values: 5208.3 19:37:46 INFO - PROCESS | 4831 | 19:37:46 INFO - PROCESS | 4831 | [#4] RayTrace Cycles:1 Average:1050.42 Median:1050.42 stddev:0.00 (0.0%) 19:37:46 INFO - PROCESS | 4831 | Values: 1050.4 19:37:46 INFO - PROCESS | 4831 | 19:37:46 INFO - PROCESS | 4831 | [#5] Earley Cycles:1 Average:703.73 Median:703.73 stddev:0.00 (0.0%) 19:37:46 INFO - PROCESS | 4831 | Values: 703.7 19:37:46 INFO - PROCESS | 4831 | 19:37:46 INFO - PROCESS | 4831 | [#6] Boyer Cycles:1 Average:12512.50 Median:12512.50 stddev:0.00 (0.0%) 19:37:46 INFO - PROCESS | 4831 | Values: 12512.5 19:37:46 INFO - PROCESS | 4831 | 19:37:46 INFO - PROCESS | 4831 | [#7] RegExp Cycles:1 Average:26394.74 Median:26394.74 stddev:0.00 (0.0%) 19:37:46 INFO - PROCESS | 4831 | Values: 26394.7 19:37:46 INFO - PROCESS | 4831 | 19:37:46 INFO - PROCESS | 4831 | [#8] Splay Cycles:1 Average:645.58 Median:645.58 stddev:0.00 (0.0%) 19:37:46 INFO - PROCESS | 4831 | Values: 645.6 19:37:46 INFO - PROCESS | 4831 | 19:37:46 INFO - PROCESS | 4831 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 19:37:46 INFO - PROCESS | 4831 | Values: 4840.6 19:37:46 INFO - PROCESS | 4831 | -------- Summary: end -------- 19:37:46 INFO - PROCESS | 4831 | 19:37:47 INFO - TEST-INFO | 4831: exit 0 19:37:47 INFO - TEST-OK | v8_7 | took 40454ms 19:37:47 INFO - SUITE-END | took 1218s 19:37:47 INFO - Completed test suite (00:20:18) 19:37:47 INFO - Working with test: dromaeo_css 19:37:47 INFO - Generating results file: dromaeo_css 19:37:47 INFO - Working with test: kraken 19:37:47 INFO - Generating results file: kraken 19:37:47 INFO - javascript benchmark 19:37:47 INFO - Working with test: v8_7 19:37:47 INFO - Generating results file: v8_7 19:37:47 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:37:48 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 19:37:48 INFO - process_Request line: dromaeo_css 6357.69 graph.html#tests=[[72,94,43]] 19:37:48 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:37:48 INFO - process_Request line: kraken 1543.60 graph.html#tests=[[232,94,43]] 19:37:48 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:37:48 INFO - process_Request line: v8_7 21111.73 graph.html#tests=[[230,94,43]] 19:37:48 INFO - RETURN: dromaeo_css: 6357.69 19:37:48 INFO - RETURN: kraken: 1543.60 19:37:48 INFO - RETURN: v8_7: 21111.73 19:37:48 INFO - javascript benchmark 19:37:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2616.4897844920242, 2647.8808453619586, 2668.826526275792, 2671.9999999999995, 2685.905993290235, 4480.215962206617, 4537.205988951932, 4602.838900638479, 4627.699199552031, 4648.11685779702, 4524.140413321466, 4525.773711314429, 4597.88505287368, 4730.645201609885, 4757.833475828346, 4220.978895105528, 4250.851220207293, 4345.8478953236645, 4353.586409291128, 4397.032652816375, 4347.891302717441, 4350.303951367781, 4382.97808510957, 4404.471463424394, 4486.506484286726, 4159.771212583307, 4207.768572728499, 4262.957370426318, 4342.3052311630145, 4347.108842687273, 4255.234057869582, 4271.145770845812, 4299.032717638537, 4342.478902531717, 4348.065165989327, 4282.957170428287, 4290.485141782975, 4292.377605247221, 4299.892502687427, 4349.956500435019, 4382.145481631083, 4473.7986790594505, 4489.955100448987, 4581.450225972904, 4610.9308360374625, 5002.274670172841, 5006.148954677714, 5011.198208286657, 5016.573591244749, 5024.070546948826, 5064.772085256135, 5112.258722485256, 5114.977004599095, 5129.051125541787, 5177.663451875616, 4480.574345437179, 4559.908801823945, 4573.954260457353, 4585.95414045862, 4587.610053145487, 4949.752512374439, 4966.826161084345, 4974.253861920669, 4981.551660350513, 5090.872728181825, 4963.106640804617, 4969.751512424365, 4970.428400733889, 4972.801087956441, 4991.126552853236, 5007.4241462231585, 5052.469490703496, 5058.620603454756, 5063.240513922941, 5089.6691715038405, 4758.690685105526, 4826.372571565674, 4876.195427754452, 4919.0899683558655, 5002.624803139779, 4841.3222148899185, 4897.853064408074, 4903.901921961612, 4904.705717656952, 4935.358403407534, 4115.526714427879, 4143.91712165755, 4148.522919864194, 4149.709520333608, 4197.958020419818, 3561.0385195996937, 3615.222727113683, 3654.561452625702, 3685.7051435885064, 3710.18375957289, 4305.84929527465, 4328.71863328889, 4343.4136391586735, 4372.0162963333, 4384.0355121873135, 4769.403824521934, 5019.498050195024, 5033.169527028, 5055.772490237948, 5057.190849464068, 4224.028473451062, 4247.532771395206, 4297.763623000765, 4302.483701955723, 4330.2638551446325, 4408.801603927767, 4435.112977404532, 4461.776911154429, 4466.2630665940405, 4469.240229161051, 4502.6623003275545, 4601.539846015372, 4758.143534163814, 4766.571008609242, 4779.593734532604, 4884.731339776346, 4955.677880937727, 5022.347094877642, 5046.949530504648, 5081.542661160365, 4712.410948631421, 4729.266963620645, 4750.548697873696, 4765.880852978565, 4767.76161191946, 4739.597134243628, 4843.95156048435, 4947.0, 4957.429895562056, 5004.674696144739, 4984.42679091909, 5046.041252162077, 5065.037642847848, 5074.16276314404, 5100.821471248489, 4795.784189711401, 4813.78337974785, 4819.59033482158, 4827.08285425768, 4828.493008234085, 4630.652701047367, 4746.572808447257, 4764.880877978078, 4821.783019764189, 4863.756812159449, 4706.364640773451, 4722.362481065013, 4747.596454301423, 4772.904541909212, 4775.47469778331, 4883.706977581214, 4907.092187945242, 4907.631927605516, 4924.7537623119415, 4947.6536642434685, 4604.102200070954, 4706.764661766966, 4739.146953548395, 4797.520247975174, 4828.275758636092], "unit": "score", "name": "dojo.html", "value": 4565.512272449269}, {"lowerIsBetter": false, "replicates": [520.6823837459149, 543.9864003399912, 571.8427432456074, 574.962627429217, 585.0814221671975, 32546.83726581367, 33070.66929330706, 33224.33551328972, 33229.66770332296, 33241.0, 36260.63739362606, 36674.63325366745, 36762.26475470489, 36802.631973680254, 37064.0, 7552.1692613812575, 7670.3480204182715, 7724.073111226632, 7736.61316934151, 7751.689932402697, 7509.023826902495, 7605.885911711329, 7683.308502234798, 7809.82852572113, 7861.410394220427, 7798.883016754753, 7803.453758236926, 7819.648115834772, 7835.451518393715, 7860.331871790904, 7740.574268415235, 7841.0, 7863.213678632148, 7882.369410447208, 7912.604369781517, 7619.08570971487, 7668.233176682343, 7704.075510938667, 7733.304002639789, 7737.148913619498, 36339.4549081764, 37040.0, 37057.25885482275, 37077.07307317312, 37078.25843483115, 2920.5473151661527, 2997.2057404787747, 3213.694699003591, 3331.2504686445354, 3486.494458303557, 27996.160115196577, 28317.716822831713, 28329.57505637417, 28611.57082643762, 28870.0, 3269.8909203563567, 3310.1228174533767, 3331.583552055993, 3422.0, 3425.9657403425895, 220392.0, 222567.88716056477, 222990.0, 223508.0, 223575.0, 45491.0, 46448.3032754509, 55734.72132639311, 56483.0, 56701.716491417275, 50668.746656266485, 50929.74535127375, 50935.490645093814, 51194.48805511972, 51239.231411528854, 12743.617691469271, 12854.935725321313, 12933.224006559636, 12946.352682365845, 12961.351932403342, 9468.195203407788, 9476.241900648069, 9478.715638530855, 9491.38306010107, 9582.329236953487, 19073.842551249374, 19418.12618432174, 19553.511162221057, 19584.0, 19652.901735491232, 7421.257874212535, 7525.548467091992, 7547.660355283915, 7593.392528597809, 7650.655720492591, 809.29591255608, 855.6662901468433, 864.7924498120406, 1033.8242498775226, 1052.2529004406956, 25884.22347329583, 26193.276268453046, 26449.603255951177, 26785.0, 26842.194734158005, 924.5746956399997, 965.3725078698902, 986.0780170540568, 995.6714284286168, 1007.1087087927091, 13788.103773254707, 13944.930275348559, 14180.787288190686, 14207.28963551839, 14289.928550357181, 264437.0, 267762.0, 269485.0, 270006.0, 270708.0, 46443.0, 47020.0, 47121.29318060232, 47194.5280547197, 47300.5269947303, 1169.5555688838188, 1183.0890214534932, 1185.04603793945, 1189.8631657359515, 1194.976100478003, 24733.0, 26406.339841503348, 26587.734122658527, 26655.866720666272, 26701.732982669924, 40405.393919090646, 40721.79639101786, 40755.79622101989, 40770.79614601908, 40774.388384174854, 244279.0, 245641.0, 245771.0, 246032.0, 246491.0, 24226.394340140934, 24334.513309733353, 28836.423271534033, 30615.387692245586, 31153.417357004233, 41119.7944010278, 41692.166156677304, 41713.1657366857, 42383.7880810594, 42588.0, 30161.547576786805, 30573.019758787104, 30644.233894152825, 30728.65609402963, 30734.385312293183, 29683.257918552208, 29874.253143671584, 30096.0, 30106.096817095524, 30266.940657076895, 35224.82387588046, 35315.823420882734, 35560.46659300061, 35963.92108236757, 36364.454533181495, 25936.481270374865, 26375.868120659274, 27726.86136569385, 28222.294442639097, 28380.85809570939, 22569.0, 23786.524269514168, 24029.879850600635, 24057.157999469935, 24256.272311830675], "unit": "score", "name": "ext.html", "value": 16542.361949991282}, {"lowerIsBetter": false, "replicates": [324.12971172402104, 325.6613122352753, 329.22139140931705, 332.0470250381406, 333.0441632514683, 14674.413023479061, 15076.698466030673, 15649.139297338641, 15766.527004189878, 16255.83744162561, 13452.125611835223, 13458.259795711256, 13476.66308342292, 14215.715685686306, 14878.404863805436, 4340.826366945318, 4473.9776301118445, 6207.968960155193, 6417.229932408094, 6449.580777249487, 6297.968510157443, 6390.616563006211, 6411.5191360647905, 6446.484281257512, 6450.7742229022, 5909.734061967221, 6119.173911521954, 6119.204503414549, 6526.738930442777, 6532.706028228741, 6189.102580125879, 6229.065640153968, 6235.87528249437, 6293.370662933716, 6626.271110177877, 6282.654454005028, 6302.527310451735, 6351.809445716636, 6361.650109243989, 6362.5228107891635, 19585.216591336328, 21366.893165534228, 21995.890020549956, 22056.117755289768, 22228.666570001464, 1877.7840548336842, 1889.9905500472546, 1930.2954421636143, 2028.4827369020804, 2042.0708577597306, 12903.096783225084, 13596.59210223695, 13680.863191368058, 14163.645908852259, 14361.928190359085, 1823.489422961573, 1828.7531183290218, 1858.479625704805, 1895.2040143139914, 1900.0, 62359.37640623581, 66063.3393666062, 66525.3347466524, 67045.3295467044, 67298.32701673018, 15802.525924222062, 15826.0, 15831.604209894846, 15857.0, 15869.603259918364, 23178.53642927132, 23273.138148948045, 23572.64641030386, 23611.40971475727, 23690.0, 8333.458325208841, 8335.666573337, 8367.748967530984, 8435.0, 8467.0, 6959.791206263821, 7064.894026589605, 7066.717331306793, 7071.186813516511, 7080.044194033842, 7667.693292268247, 7689.769306920802, 7735.1491335953, 7754.495957762728, 7766.534007959541, 1679.8488136067813, 1713.6487020160837, 2999.3401451680597, 3016.638003439601, 3153.8423078845967, 768.7078910014159, 806.2058872011064, 823.2714048067503, 849.2356878809121, 931.9701729588842, 15547.30037148331, 15664.0, 15752.92123539375, 15937.601559961095, 16133.838661613234, 810.8175660476463, 839.5718183726343, 850.6299759604592, 878.5695009445453, 902.8871391076116, 7219.422446204396, 8936.821263574822, 9150.176484116462, 9178.81642367149, 9285.58214880332, 313889.0, 322406.0, 326413.0, 326809.0, 526069.0, 32161.839190804363, 32166.35667286688, 36127.096822579646, 59579.0, 66053.669731652, 1026.7689769801734, 1044.9477526123815, 1045.325764881647, 1047.669983955067, 1056.8309070548676, 14444.239226472604, 14505.564833055025, 14643.633909152357, 14676.926615366854, 14851.0, 29894.701052989192, 31859.0, 32467.837660811543, 32927.67072329246, 32968.83515582407, 35160.47259291061, 36175.457368138974, 36424.27151456903, 38014.239715206095, 38780.224395512494, 8401.789955251168, 8654.350923680624, 8684.088170741981, 8890.64437422496, 8905.910940890508, 14845.0, 15157.772633410728, 15410.229488525752, 15615.76576351333, 15693.764593530877, 13387.129836560593, 13450.0, 13611.455541778614, 13728.794068088788, 13802.240876751473, 13321.267330296927, 13896.305184740924, 13946.721065578835, 13992.930035349758, 14035.859641403455, 13608.65978350549, 14145.504907328193, 14295.213763242706, 14362.928185359006, 14577.198254095701, 8336.958315208385, 8808.647654093764, 8856.202941735017, 9044.773880653036, 9052.275817934682, 9066.456012639263, 11218.831717524406, 13452.327383630583, 13517.932410337886, 13855.861441385458], "unit": "score", "name": "jquery.html", "value": 8989.053695769737}, {"lowerIsBetter": false, "replicates": [1342.8522862485124, 1359.8912087033038, 1434.1825159659, 1670.9164541772923, 1680.9663806723865, 6884.483663725228, 6978.0, 6993.580385176893, 7099.893501597474, 7112.253213412589, 7020.648967551615, 7060.470464715154, 7137.571745695262, 7154.463415243865, 7155.391791697712, 1995.4113536506693, 2012.4063401296653, 2016.5765189310262, 2022.1911235505843, 2029.6346657601625, 2028.5334373094124, 2037.3989673046412, 2049.354453347191, 2057.177129148345, 2057.783932687069, 1960.4804726747352, 1991.711201875727, 1992.2628627407807, 2009.2264478175862, 2028.1988614497266, 2028.0569535166144, 2070.037432593836, 2071.7203177570987, 2074.481379655086, 2076.3355726167633, 1996.8502362322884, 2035.0537000294787, 2035.104553996237, 2035.542003049317, 2044.6830741234983, 6869.622170780605, 6893.310668933117, 6937.791866243971, 6944.02783610295, 6956.165260168762, 4145.108801607669, 4204.600562946515, 4207.095474473003, 4216.9578304216875, 4217.325227963511, 2647.126448272085, 2647.9867600661873, 2751.8899244030213, 2767.2805070681566, 2771.6119743235763, 826.3678286111129, 833.3666413525704, 848.2916764501648, 874.711345256064, 877.0965905117675, 9322.48726320052, 9357.953210233905, 9372.390794598397, 9452.57463414148, 9497.240220782322, 3705.6664900159117, 3750.8124593770203, 3799.6580307772433, 3806.467094606757, 3823.9426408603895, 7527.661255243527, 7543.415882664593, 7591.0, 7594.658240379196, 7614.352780013761, 4183.853565125206, 4186.644135248477, 4193.077522944947, 4202.0, 4209.74741515504, 3812.904677383088, 3836.3478208704028, 3843.7501562398916, 3844.38489841624, 3855.51806024247, 3097.962182668786, 3126.7185953264316, 3134.5925029746445, 3154.5899033125547, 3166.255929856482, 919.2140719684706, 921.7142685767434, 922.9261659067258, 924.1636319131197, 924.2098006204733, 887.7558671365426, 893.7274131389988, 893.9150780675825, 938.9671361502293, 1138.93166410014, 6379.585326953733, 6454.128692626529, 6465.515086368541, 6478.1578394808375, 6503.0, 938.7512309238058, 993.2749093161888, 1047.324475713176, 1050.5902697947806, 1076.1552181537456, 5207.270982062514, 5237.8428647140645, 5252.9737351313, 5262.868428289324, 5295.232191332235, 8098.51408915467, 8612.138786121337, 8623.0, 8624.525651089125, 8699.347548933856, 8411.45325553837, 8464.83070338602, 8475.1524847516, 8486.448380855225, 8504.659813607386, 6507.089007538948, 6557.016447532908, 6714.899276510856, 6797.28628494001, 6810.114685091005, 6474.708638111202, 6482.837929051811, 6531.673416329259, 6540.411362977355, 6542.738290468518, 7438.776836694691, 7641.426892982938, 7697.114831794192, 7745.186755390603, 7800.882986755317, 7387.519811212254, 7564.697412103455, 7601.885971710318, 7624.199459056719, 7872.291493765589, 6043.456088952015, 6117.592953620603, 6158.137860699416, 6174.228221472316, 6332.145160403471, 6658.533902626769, 6662.966685166543, 6709.563878347892, 6769.763058292936, 6816.488763342868, 5960.8807823844145, 6021.0, 6137.324894261538, 6218.782342618168, 6436.259830119596, 5300.602454815981, 5955.2853657559635, 5995.700214989146, 6089.177960975212, 6111.541634377529, 6237.75048998035, 6291.496680265659, 6302.117703521602, 6306.085617585332, 6322.715477803602, 5652.85867853307, 5710.143478478261, 5766.682832444256, 5774.682392468455, 5780.0, 5591.329040515164, 5752.654840709571, 5856.560757943256, 5861.267341582302, 5879.265091863517], "unit": "score", "name": "mootools.html", "value": 3984.898043559309}, {"lowerIsBetter": false, "replicates": [292.6312845814274, 303.08921690320585, 303.7903846346021, 304.6785641148587, 306.66726601637225, 5547.722613869306, 5609.7195140242975, 5628.240187574676, 5641.210230567714, 5724.885502289952, 5531.225628412026, 5534.059209934311, 5562.443755624436, 5565.6660600364, 5572.7770889164385, 4089.8773036808943, 4240.215560121387, 4260.147970405916, 4280.464941882257, 4311.353297005458, 4190.811413486385, 4213.346931225649, 4226.281532139528, 4226.4716910386205, 4227.640650544692, 4211.157768446307, 4211.536730959592, 4212.789360531977, 4214.093969796493, 4225.830966761326, 4200.264953633117, 4205.5794420558, 4208.747475151501, 4208.873733787976, 4209.758121354208, 3608.440691692792, 3630.146915474888, 3639.9272014559824, 3640.5085313482605, 3643.6174201708704, 5274.815381461669, 5345.919811202835, 5387.24578559002, 5406.729663516809, 5429.647072940285, 4926.778294976734, 4953.653244272902, 4967.056259310755, 4987.276844857512, 4996.500349965011, 5900.380460051719, 5902.32123305821, 5911.113333000041, 5929.0513517836935, 5936.46571808535, 4012.197560487914, 4105.958940410617, 4112.115895082542, 4112.259793237216, 4115.97942010291, 6136.23297087864, 6210.130581718563, 6229.87540249197, 6253.218347706536, 6325.493960483104, 4241.575842415796, 4242.766647834399, 4247.532771395144, 4251.319788833834, 4254.383114448449, 4301.2257793597455, 4303.569643035671, 4304.677149213821, 4305.82776688929, 4310.784460777011, 4824.855254342376, 4911.066897289504, 4913.459519452857, 4932.506749325111, 4967.4535801062575, 5903.734331955073, 5904.498117659961, 5911.9113213301835, 5912.615679980788, 5933.1396947443245, 1506.4501456968128, 1519.9392024319125, 1521.269790500566, 1521.9695606087816, 1524.26073354423, 1028.3367228137809, 1036.0571879589688, 1041.6510468992972, 1043.932144410626, 1059.7191744187796, 5114.514121158484, 5123.2827404163445, 5133.948660513347, 5134.358205224347, 5148.58811295103, 6148.877022459616, 6152.0, 6157.692115394212, 6168.074788781629, 6184.6598437086395, 5115.7442127893455, 5120.334356533627, 5120.564751996048, 5139.974300128475, 5142.048720986555, 3227.935441291161, 3315.370079684852, 3316.4859446785786, 3328.5340052392685, 3331.350386674575, 5675.659460432387, 5766.452187042224, 5813.418658134153, 5840.561957853178, 5861.736221870026, 6340.492760579143, 6341.841453963688, 6343.619382837044, 6364.0, 6367.586106903036, 5770.855728606818, 5794.0, 5795.913061304083, 5800.88398232033, 5808.970955145282, 6162.075688646739, 6163.705621819288, 6176.876462470816, 6182.783602573888, 6188.412100850412, 5814.505767009682, 6001.879962400815, 6032.366601506954, 6043.486303664062, 6045.486133678511, 5807.912881306868, 5809.448102430262, 5811.215485909517, 5823.213866128019, 5824.0, 4114.280000999873, 4160.084781348099, 4160.708750387565, 4163.8959026024595, 4165.5001399831, 6055.939440605714, 6164.938350616437, 6184.226971628546, 6185.597936134137, 6206.937930620636, 5910.556708246812, 5919.526437885045, 5923.911141332969, 5941.702914854153, 5951.613145145551, 5888.735006924784, 5925.111233315038, 5932.525397968238, 5932.79235226765, 5936.525077993837, 5563.915036567831, 5702.258706368146, 5770.192173095854, 5781.364049954585, 5783.392743761844, 5902.20320256777, 5903.114532820111, 5985.102234664835, 5998.370171131968, 5998.580099393001, 5725.828225153252, 5764.135379692912, 5769.480746732815, 5797.449242321973, 5830.067189249699], "unit": "score", "name": "prototype.html", "value": 4411.216316917685}, {"lowerIsBetter": false, "replicates": [654.9410553050226, 723.7430712097205, 751.932326090652, 761.9123800762914, 765.5521519910852, 10493.632722854702, 10853.34879907206, 10963.725906852333, 11058.391788451632, 11072.667819965403, 10424.478776061185, 10447.477626118702, 10463.581456741722, 10544.051035406812, 10580.576776928932, 608.5496732418023, 747.3311386309264, 760.2359628573304, 760.5132715062365, 762.4548447859779, 607.3107023528305, 751.9210482899299, 752.2815710995985, 760.6424980259269, 762.5424745152919, 787.5747096567875, 790.0637744273055, 791.6477167660394, 792.5086446403209, 793.3217099380033, 781.238292664653, 782.1630854985168, 783.8432313537315, 788.6490511722286, 794.9841003179932, 579.5421616922627, 582.5456144207525, 582.8309790160848, 589.7346194212579, 590.7105518296004, 10116.89883101167, 10155.847662285072, 10242.436665983369, 10265.332753371007, 10273.38359698413, 10375.325603835727, 11099.278546894508, 11103.38931358775, 11132.833007504894, 11176.273542219811, 8010.919890801134, 8034.276915077613, 8133.26800587944, 8148.307393871528, 9043.547822608843, 3099.628044634636, 3132.6084239470065, 3152.4956007038763, 3161.7944833585743, 3162.177833763215, 40339.596604034174, 40514.59485405138, 40654.593454065674, 41042.589574104175, 41224.0, 9228.8615670765, 9332.95333523328, 9427.0, 9435.858462123073, 9488.288378371511, 15995.12026838535, 16008.519744407686, 16025.759613605805, 16050.277737501841, 16060.956037857502, 6124.326324104345, 6145.4161854623735, 6225.0, 6311.400416960381, 6352.047192921006, 3503.4394496880886, 3538.5399898013607, 3605.7295702822394, 3609.224016836393, 3671.2473942841652, 2604.231751633273, 2630.8684565771637, 2635.3016450640594, 2635.9472810544066, 2641.088824355594, 425.7381710248237, 427.3397600706853, 430.7566225082818, 433.87200775771225, 437.5668088592271, 433.8546586893426, 579.1775678536488, 594.2512434332772, 602.1479606357043, 609.679918043031, 7605.391568674493, 7616.885746713804, 7969.521828690181, 8580.914190858137, 8711.172438618321, 437.9978100109479, 456.76704880510516, 545.9836204913859, 601.5518438763149, 636.6371168434041, 3383.610884748236, 3436.106612280775, 3532.2405682778326, 3580.785152890835, 3753.155540003477, 47030.5296947033, 47896.760516197195, 48096.27855582169, 48344.0, 48346.27480587794, 40290.59709402927, 40654.59345406508, 44013.779931100136, 44573.55426445759, 44637.77681111639, 38403.615963840006, 38589.42115868264, 38621.227575448334, 42110.78944605319, 42430.36354454624, 7773.41699372538, 7804.219578042151, 7878.369730421437, 8007.519548826856, 8058.234467725557, 31352.686473135887, 31554.211144721565, 31885.840570796998, 32057.839710801298, 32250.677493224768, 37281.81359093187, 40515.18969620532, 41111.588884111974, 41229.793851030554, 41480.58519414888, 9828.508574571386, 10025.5488503019, 10029.498525073863, 10032.949835250776, 10168.28821982454, 11103.333799972028, 11258.38078905668, 11270.154738394489, 11369.658910232707, 11621.24461909973, 10204.0, 10285.640002600172, 10570.630027949292, 10692.091172250446, 10735.141188704729, 9936.950315248378, 9984.101430871257, 10211.23415743837, 10568.735781605521, 10834.783304334027, 10018.148457380912, 10145.391276523433, 10355.637552685619, 10622.0, 10623.575056997634, 8703.47779133254, 8812.955935220283, 8822.250108740573, 9393.389429687048, 9402.43585384879, 8534.573271336532, 8784.692535761218, 9391.483468409304, 9460.763480912758, 9709.805803884024], "unit": "score", "name": "yui.html", "value": 5533.189512512455}], "name": "dromaeo_css", "value": 6357.694341977836}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 108.0, 113.0, 112.0, 114.0, 126.0, 114.0, 114.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 114.1}, {"lowerIsBetter": true, "replicates": [161.0, 130.0, 153.0, 183.0, 128.0, 157.0, 161.0, 137.0, 172.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 151.5}, {"lowerIsBetter": true, "replicates": [172.0, 162.0, 164.0, 160.0, 164.0, 163.0, 172.0, 166.0, 164.0, 162.0], "unit": "score", "name": "audio-dft", "value": 164.9}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 75.0, 75.0, 132.0, 72.0, 73.0, 73.0, 72.0, 89.0], "unit": "score", "name": "audio-fft", "value": 80.7}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 135.0, 99.0, 98.0, 99.0, 132.0, 98.0, 98.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 108.6}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 111.0, 110.0, 110.0, 111.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 150.0, 149.0, 148.0, 149.0, 149.0, 148.0, 149.0, 149.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 96.0, 96.0, 100.0, 97.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 73.0, 71.0, 75.0, 71.0, 71.0, 73.0, 73.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 71.9}, {"lowerIsBetter": true, "replicates": [67.0, 71.0, 70.0, 68.0, 69.0, 68.0, 69.0, 71.0, 71.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 86.0, 84.0, 85.0, 87.0, 85.0, 85.0, 86.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [123.0, 134.0, 120.0, 124.0, 124.0, 125.0, 124.0, 129.0, 131.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.4}, {"lowerIsBetter": true, "replicates": [138.0, 150.0, 148.0, 151.0, 149.0, 154.0, 141.0, 150.0, 150.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.8}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 69.0, 69.0, 69.0, 70.0, 68.0, 72.0, 69.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.8}], "name": "kraken", "value": 1543.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.43409013893594], "unit": "score", "name": "Richards", "value": 208.35240399999998}, {"lowerIsBetter": false, "replicates": [189.5734597156398], "unit": "score", "name": "DeltaBlue", "value": 348.77245000000016}, {"lowerIsBetter": false, "replicates": [278.08676307007784], "unit": "score", "name": "Encrypt", "value": 957.1868759999999}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1050.420168067227], "unit": "score", "name": "RayTrace", "value": 704.469528}, {"lowerIsBetter": false, "replicates": [703.7297677691766], "unit": "score", "name": "Earley", "value": 947.0439230000003}, {"lowerIsBetter": false, "replicates": [12512.5], "unit": "score", "name": "Boyer", "value": 53.26377622377621}, {"lowerIsBetter": false, "replicates": [26394.736842105263], "unit": "score", "name": "RegExp", "value": 34.51388833499503}, {"lowerIsBetter": false, "replicates": [645.577792123951], "unit": "score", "name": "Splay", "value": 126.229559}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21111.73326002062}]} 19:37:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21111.73"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1543.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6357.69"}}} 19:37:48 INFO - Return code: 0 19:37:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:37:48 INFO - # TBPL SUCCESS # 19:37:48 INFO - Running post-action listener: _resource_record_post_action 19:37:48 INFO - Running post-run listener: _resource_record_post_run 19:37:49 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 499712; Write bytes: 314343424; Read time: 116; Write time: 220812 19:37:49 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1409024; Read time: 0; Write time: 88 19:37:49 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 499712; Write bytes: 312934400; Read time: 116; Write time: 220724 19:37:49 INFO - Running post-run listener: _upload_blobber_files 19:37:49 INFO - Blob upload gear active. 19:37:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:37:49 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:37:49 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:37:49 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:37:49 INFO - (blobuploader) - INFO - Open directory for files ... 19:37:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:37:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:37:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:37:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:37:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:37:50 INFO - (blobuploader) - INFO - Done attempting. 19:37:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:37:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:37:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:37:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:37:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:37:51 INFO - (blobuploader) - INFO - Done attempting. 19:37:51 INFO - (blobuploader) - INFO - Iteration through files over. 19:37:51 INFO - Return code: 0 19:37:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:37:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:37:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/96e61472b11603a11fdb03ef06be273fa81dfccbfa4bb6472da24e265e86bfb886d1194dd94b18d4e80c8a9f2565f45cd0f98a786465eb17f2b8f7f16842b8c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c1963ae3a5f6b718b0adb51f7ad47b62aa28b3eb717d620788e5910be4f867c24e99f6467e19d70e70eb533e1d178d71d80e47836e2ee8ada8dac68709a559e"} 19:37:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:37:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:37:51 INFO - Contents: 19:37:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/96e61472b11603a11fdb03ef06be273fa81dfccbfa4bb6472da24e265e86bfb886d1194dd94b18d4e80c8a9f2565f45cd0f98a786465eb17f2b8f7f16842b8c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c1963ae3a5f6b718b0adb51f7ad47b62aa28b3eb717d620788e5910be4f867c24e99f6467e19d70e70eb533e1d178d71d80e47836e2ee8ada8dac68709a559e"} 19:37:51 INFO - Copying logs to upload dir... 19:37:51 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1271.126562 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-25 19:37:51.534232) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-25 19:37:51.537993) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1451099795.457553-1013360044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/96e61472b11603a11fdb03ef06be273fa81dfccbfa4bb6472da24e265e86bfb886d1194dd94b18d4e80c8a9f2565f45cd0f98a786465eb17f2b8f7f16842b8c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c1963ae3a5f6b718b0adb51f7ad47b62aa28b3eb717d620788e5910be4f867c24e99f6467e19d70e70eb533e1d178d71d80e47836e2ee8ada8dac68709a559e"} build_url:https://queue.taskcluster.net/v1/task/m8dl1bDfSMyT2Tju64aBcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011440 build_url: 'https://queue.taskcluster.net/v1/task/m8dl1bDfSMyT2Tju64aBcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/96e61472b11603a11fdb03ef06be273fa81dfccbfa4bb6472da24e265e86bfb886d1194dd94b18d4e80c8a9f2565f45cd0f98a786465eb17f2b8f7f16842b8c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c1963ae3a5f6b718b0adb51f7ad47b62aa28b3eb717d620788e5910be4f867c24e99f6467e19d70e70eb533e1d178d71d80e47836e2ee8ada8dac68709a559e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-25 19:37:51.563186) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 19:37:51.563572) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1451099795.457553-1013360044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 19:37:51.647387) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-25 19:37:51.647739) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-25 19:37:51.648042) ========= ========= Total master_lag: 0.23 =========