builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-019 starttime: 1452023209.87 results: success (0) buildid: 20160105111831 builduid: 5e7de258744041b5a49165bf459af969 revision: 3c7d6b80345e197eea1d13bc32ebf3439bbc89fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 11:46:49.869118) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 11:46:49.869741) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 11:46:49.870030) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1452019095.232496-1284594825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006345 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 11:46:49.926300) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 11:46:49.926650) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 11:46:50.008315) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 11:46:50.008585) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1452019095.232496-1284594825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004601 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 11:46:50.059205) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 11:46:50.059477) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 11:46:50.059813) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 11:46:50.060092) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1452019095.232496-1284594825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-05 11:46:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.6M=0s 2016-01-05 11:46:50 (43.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132569 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 11:46:50.205395) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 11:46:50.205686) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1452019095.232496-1284594825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022399 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 11:46:50.255766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 11:46:50.256066) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3c7d6b80345e197eea1d13bc32ebf3439bbc89fb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 3c7d6b80345e197eea1d13bc32ebf3439bbc89fb --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=78329bfc0fd5309db0a6e0ac000001b4-1452019095.232496-1284594825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-05 11:46:51,007 truncating revision to first 12 chars 2016-01-05 11:46:51,007 Setting DEBUG logging. 2016-01-05 11:46:51,007 attempt 1/10 2016-01-05 11:46:51,007 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3c7d6b80345e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-05 11:46:51,422 unpacking tar archive at: fx-team-3c7d6b80345e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.727381 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 11:46:50.997127) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 11:46:50.997520) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 11:46:51.007037) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 11:46:51.007572) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 11:46:51.008066) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-01-05 11:46:51.008358) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=78329bfc0fd5309db0a6e0ac000001b4-1452019095.232496-1284594825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:46:51 INFO - MultiFileLogger online at 20160105 11:46:51 in /builds/slave/test 11:46:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 11:46:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:46:51 INFO - {'append_to_log': False, 11:46:51 INFO - 'base_work_dir': '/builds/slave/test', 11:46:51 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:46:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:46:51 INFO - 'branch': 'Fx-Team-Non-PGO', 11:46:51 INFO - 'buildbot_json_path': 'buildprops.json', 11:46:51 INFO - 'config_files': ('talos/linux_config.py',), 11:46:51 INFO - 'default_actions': ('clobber', 11:46:51 INFO - 'read-buildbot-config', 11:46:51 INFO - 'download-and-extract', 11:46:51 INFO - 'populate-webroot', 11:46:51 INFO - 'create-virtualenv', 11:46:51 INFO - 'install', 11:46:51 INFO - 'run-tests'), 11:46:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:46:51 INFO - 'download_minidump_stackwalk': True, 11:46:51 INFO - 'download_symbols': 'ondemand', 11:46:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:46:51 INFO - 'tooltool.py': '/tools/tooltool.py', 11:46:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:46:51 INFO - '/tools/misc-python/virtualenv.py')}, 11:46:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:46:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:46:51 INFO - 'installer_path': 'installer.exe', 11:46:51 INFO - 'log_level': 'info', 11:46:51 INFO - 'log_name': 'talos', 11:46:51 INFO - 'log_to_console': True, 11:46:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:46:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:46:51 INFO - 'opt_config_files': (), 11:46:51 INFO - 'pip_index': False, 11:46:51 INFO - 'sps_profile': False, 11:46:51 INFO - 'sps_profile_interval': 0, 11:46:51 INFO - 'suite': 'dromaeojs', 11:46:51 INFO - 'system_bits': '32', 11:46:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:46:51 INFO - 'title': 'talos-linux64-ix-019', 11:46:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:46:51 INFO - 'use_talos_json': True, 11:46:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:46:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:46:51 INFO - 'work_dir': 'build'} 11:46:51 INFO - ##### 11:46:51 INFO - ##### Running clobber step. 11:46:51 INFO - ##### 11:46:51 INFO - Running pre-action listener: _resource_record_pre_action 11:46:51 INFO - Running main action method: clobber 11:46:51 INFO - rmtree: /builds/slave/test/build 11:46:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:46:52 INFO - Running post-action listener: _resource_record_post_action 11:46:52 INFO - ##### 11:46:52 INFO - ##### Running read-buildbot-config step. 11:46:52 INFO - ##### 11:46:52 INFO - Running pre-action listener: _resource_record_pre_action 11:46:52 INFO - Running main action method: read_buildbot_config 11:46:52 INFO - Using buildbot properties: 11:46:52 INFO - { 11:46:52 INFO - "project": "", 11:46:52 INFO - "product": "firefox", 11:46:52 INFO - "script_repo_revision": "production", 11:46:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:46:52 INFO - "repository": "", 11:46:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:46:52 INFO - "buildid": "20160105111831", 11:46:52 INFO - "pgo_build": "False", 11:46:52 INFO - "basedir": "/builds/slave/test", 11:46:52 INFO - "buildnumber": 1216, 11:46:52 INFO - "slavename": "talos-linux64-ix-019", 11:46:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:46:52 INFO - "platform": "ubuntu64_hw", 11:46:52 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:46:52 INFO - "branch": "fx-team", 11:46:52 INFO - "repo_path": "integration/fx-team", 11:46:52 INFO - "revision": "3c7d6b80345e197eea1d13bc32ebf3439bbc89fb", 11:46:52 INFO - "stage_platform": "linux64", 11:46:52 INFO - "builduid": "5e7de258744041b5a49165bf459af969", 11:46:52 INFO - "slavebuilddir": "test" 11:46:52 INFO - } 11:46:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 11:46:52 INFO - Running post-action listener: _resource_record_post_action 11:46:52 INFO - ##### 11:46:52 INFO - ##### Running download-and-extract step. 11:46:52 INFO - ##### 11:46:52 INFO - Running pre-action listener: _resource_record_pre_action 11:46:52 INFO - Running main action method: download_and_extract 11:46:52 INFO - mkdir: /builds/slave/test/build/tests 11:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:52 INFO - https://queue.taskcluster.net/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:46:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/artifacts/public/build/test_packages.json 11:46:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/artifacts/public/build/test_packages.json 11:46:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:46:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:46:58 INFO - Downloaded 1302 bytes. 11:46:58 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:46:58 INFO - Using the following test package requirements: 11:46:58 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:46:58 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:46:58 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:58 INFO - u'jsshell-linux-x86_64.zip'], 11:46:58 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:46:58 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:46:58 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:46:58 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:46:58 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:46:58 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:46:58 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:46:58 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:46:58 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')]} 11:46:58 INFO - https://queue.taskcluster.net/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:46:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:46:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:46:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/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 11:46:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/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 11:47:01 INFO - Downloaded 22784336 bytes. 11:47:01 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 11:47:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:47:01 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 11:47:02 INFO - Return code: 0 11:47:02 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 11:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:02 INFO - https://queue.taskcluster.net/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:47:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:47:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:47:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/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 11:47:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/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 11:47:11 INFO - Downloaded 22784336 bytes. 11:47:11 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 11:47:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:47:11 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 11:47:12 INFO - Return code: 0 11:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:47:12 INFO - https://queue.taskcluster.net/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:47:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:47:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:47:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/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 11:47:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/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 11:47:13 INFO - Downloaded 11132285 bytes. 11:47:13 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 11:47:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:47:13 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 11:47:13 INFO - Return code: 0 11:47:13 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')]} 11:47:13 INFO - https://queue.taskcluster.net/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:47:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:47:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:47:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/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 11:47:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/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 11:47:15 INFO - Downloaded 53394781 bytes. 11:47:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:47:15 INFO - mkdir: /builds/slave/test/properties 11:47:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:47:15 INFO - Writing to file /builds/slave/test/properties/build_url 11:47:15 INFO - Contents: 11:47:15 INFO - build_url:https://queue.taskcluster.net/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:47:15 INFO - Running post-action listener: _resource_record_post_action 11:47:15 INFO - Running post-action listener: set_extra_try_arguments 11:47:15 INFO - ##### 11:47:15 INFO - ##### Running populate-webroot step. 11:47:15 INFO - ##### 11:47:15 INFO - Running pre-action listener: _resource_record_pre_action 11:47:15 INFO - Running main action method: populate_webroot 11:47:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:47:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:47:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:47:15 INFO - '--tppagecycles', 11:47:15 INFO - '7'], 11:47:15 INFO - 'tests': ['tsvgm']}}, 11:47:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:47:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:47:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:47:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:47:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:47:15 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:47:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:47:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:15 INFO - 'talos_options': ['--e10s'], 11:47:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:47:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:15 INFO - 'tests': ['damp', 'tps']}, 11:47:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:15 INFO - 'talos_options': ['--e10s'], 11:47:15 INFO - 'tests': ['damp', 'tps']}, 11:47:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:47:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:47:15 INFO - 'other': {'tests': ['a11yr', 11:47:15 INFO - 'ts_paint', 11:47:15 INFO - 'tpaint', 11:47:15 INFO - 'sessionrestore', 11:47:15 INFO - 'sessionrestore_no_auto_restore']}, 11:47:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:47:15 INFO - 'tests': ['a11yr', 11:47:15 INFO - 'ts_paint', 11:47:15 INFO - 'tpaint', 11:47:15 INFO - 'sessionrestore', 11:47:15 INFO - 'sessionrestore_no_auto_restore']}, 11:47:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:47:15 INFO - 'tests': ['a11yr', 11:47:15 INFO - 'ts_paint', 11:47:15 INFO - 'tpaint', 11:47:15 INFO - 'sessionrestore', 11:47:15 INFO - 'sessionrestore_no_auto_restore']}, 11:47:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:47:15 INFO - 'tests': ['a11yr', 11:47:15 INFO - 'ts_paint', 11:47:15 INFO - 'tpaint', 11:47:15 INFO - 'sessionrestore', 11:47:15 INFO - 'sessionrestore_no_auto_restore']}, 11:47:15 INFO - 'other_l64': {'tests': ['a11yr', 11:47:15 INFO - 'ts_paint', 11:47:15 INFO - 'tpaint', 11:47:15 INFO - 'sessionrestore', 11:47:15 INFO - 'sessionrestore_no_auto_restore']}, 11:47:15 INFO - 'other_nol64': {'tests': ['a11yr', 11:47:15 INFO - 'ts_paint', 11:47:15 INFO - 'tpaint', 11:47:15 INFO - 'sessionrestore', 11:47:15 INFO - 'sessionrestore_no_auto_restore']}, 11:47:15 INFO - 'svgr': {'tests': ['tsvgx', 11:47:15 INFO - 'tsvgr_opacity', 11:47:15 INFO - 'tart', 11:47:15 INFO - 'tscrollx', 11:47:15 INFO - 'cart']}, 11:47:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:47:15 INFO - 'tests': ['tsvgx', 11:47:15 INFO - 'tsvgr_opacity', 11:47:15 INFO - 'tart', 11:47:15 INFO - 'tscrollx', 11:47:15 INFO - 'cart']}, 11:47:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:15 INFO - 'tests': ['tp5o']}, 11:47:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:15 INFO - 'talos_options': ['--e10s'], 11:47:15 INFO - 'tests': ['tp5o']}, 11:47:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:15 INFO - 'talos_options': ['--xperf_path', 11:47:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:47:15 INFO - 'tests': ['tp5n']}, 11:47:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:15 INFO - 'talos_options': ['--e10s', 11:47:15 INFO - '--xperf_path', 11:47:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:47:15 INFO - 'tests': ['tp5n']}}, 11:47:15 INFO - 'talos.zip': {'path': '', 11:47:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:47:15 INFO - Running post-action listener: _resource_record_post_action 11:47:15 INFO - ##### 11:47:15 INFO - ##### Running create-virtualenv step. 11:47:15 INFO - ##### 11:47:15 INFO - Running pre-action listener: _resource_record_pre_action 11:47:15 INFO - Running main action method: create_virtualenv 11:47:15 INFO - Creating virtualenv /builds/slave/test/build/venv 11:47:15 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 11:47:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:47:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:47:15 INFO - Using real prefix '/usr' 11:47:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:47:15 INFO - Installing distribute.............................................................................................................................................................................................done. 11:47:17 INFO - Installing pip.................done. 11:47:17 INFO - Return code: 0 11:47:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:47:17 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')]} 11:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:17 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')]} 11:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:17 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 0x7faf99fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2478dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250b3d0>, '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 0x2476ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2477360>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452019095.232496-1284594825', '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 11:47:17 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 11:47:17 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 11:47:17 INFO - Using env: {'DISPLAY': ':0', 11:47:17 INFO - 'HOME': '/home/cltbld', 11:47:17 INFO - 'LANG': 'en_US.UTF-8', 11:47:17 INFO - 'LANGUAGE': 'en_US:en', 11:47:17 INFO - 'LOGNAME': 'cltbld', 11:47:17 INFO - 'MAIL': '/var/mail/cltbld', 11:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:17 INFO - 'MOZ_NO_REMOTE': '1', 11:47:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:17 INFO - 'NO_EM_RESTART': '1', 11:47:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:17 INFO - 'PWD': '/builds/slave/test', 11:47:17 INFO - 'SHELL': '/bin/bash', 11:47:17 INFO - 'SHLVL': '1', 11:47:17 INFO - 'TERM': 'linux', 11:47:17 INFO - 'TMOUT': '86400', 11:47:17 INFO - 'USER': 'cltbld', 11:47:17 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452019095.232496-1284594825', 11:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:17 INFO - '_': '/tools/buildbot/bin/python'} 11:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:18 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 11:47:18 INFO - Cleaning up... 11:47:18 INFO - Return code: 0 11:47:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:47:18 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')]} 11:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:18 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')]} 11:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:18 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 0x7faf99fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2478dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250b3d0>, '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 0x2476ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2477360>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452019095.232496-1284594825', '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 11:47:18 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 11:47:18 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 11:47:18 INFO - Using env: {'DISPLAY': ':0', 11:47:18 INFO - 'HOME': '/home/cltbld', 11:47:18 INFO - 'LANG': 'en_US.UTF-8', 11:47:18 INFO - 'LANGUAGE': 'en_US:en', 11:47:18 INFO - 'LOGNAME': 'cltbld', 11:47:18 INFO - 'MAIL': '/var/mail/cltbld', 11:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:18 INFO - 'MOZ_NO_REMOTE': '1', 11:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:18 INFO - 'NO_EM_RESTART': '1', 11:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:18 INFO - 'PWD': '/builds/slave/test', 11:47:18 INFO - 'SHELL': '/bin/bash', 11:47:18 INFO - 'SHLVL': '1', 11:47:18 INFO - 'TERM': 'linux', 11:47:18 INFO - 'TMOUT': '86400', 11:47:18 INFO - 'USER': 'cltbld', 11:47:18 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452019095.232496-1284594825', 11:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:18 INFO - '_': '/tools/buildbot/bin/python'} 11:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:18 INFO - Downloading/unpacking psutil>=0.7.1 11:47:18 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 11:47:18 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 11:47:18 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 11:47:18 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 11:47:18 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 11:47:18 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 11:47:19 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:47:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:47:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:47:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:47:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:47:20 INFO - Installing collected packages: psutil 11:47:20 INFO - Running setup.py install for psutil 11:47:20 INFO - building 'psutil._psutil_linux' extension 11:47:20 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 11:47:20 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 11:47:20 INFO - building 'psutil._psutil_posix' extension 11:47:20 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 11:47:20 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 11:47:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:47:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:47:20 INFO - Successfully installed psutil 11:47:20 INFO - Cleaning up... 11:47:20 INFO - Return code: 0 11:47:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:20 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 0x7faf99fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2478dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250b3d0>, '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 0x2476ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2477360>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452019095.232496-1284594825', '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 11:47:20 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 11:47:20 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 11:47:20 INFO - Using env: {'DISPLAY': ':0', 11:47:20 INFO - 'HOME': '/home/cltbld', 11:47:20 INFO - 'LANG': 'en_US.UTF-8', 11:47:20 INFO - 'LANGUAGE': 'en_US:en', 11:47:20 INFO - 'LOGNAME': 'cltbld', 11:47:20 INFO - 'MAIL': '/var/mail/cltbld', 11:47:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:20 INFO - 'MOZ_NO_REMOTE': '1', 11:47:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:20 INFO - 'NO_EM_RESTART': '1', 11:47:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:20 INFO - 'PWD': '/builds/slave/test', 11:47:20 INFO - 'SHELL': '/bin/bash', 11:47:20 INFO - 'SHLVL': '1', 11:47:20 INFO - 'TERM': 'linux', 11:47:20 INFO - 'TMOUT': '86400', 11:47:20 INFO - 'USER': 'cltbld', 11:47:20 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452019095.232496-1284594825', 11:47:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:20 INFO - '_': '/tools/buildbot/bin/python'} 11:47:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:47:20 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 11:47:20 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 11:47:20 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 11:47:20 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 11:47:20 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 11:47:20 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 11:47:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:47:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:47:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:47:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:47:22 INFO - Installing collected packages: mozsystemmonitor 11:47:22 INFO - Running setup.py install for mozsystemmonitor 11:47:22 INFO - Successfully installed mozsystemmonitor 11:47:22 INFO - Cleaning up... 11:47:22 INFO - Return code: 0 11:47:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:47:22 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')]} 11:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:22 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')]} 11:47:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:22 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 0x7faf99fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2478dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250b3d0>, '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 0x2476ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2477360>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452019095.232496-1284594825', '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 11:47:22 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 11:47:22 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 11:47:22 INFO - Using env: {'DISPLAY': ':0', 11:47:22 INFO - 'HOME': '/home/cltbld', 11:47:22 INFO - 'LANG': 'en_US.UTF-8', 11:47:22 INFO - 'LANGUAGE': 'en_US:en', 11:47:22 INFO - 'LOGNAME': 'cltbld', 11:47:22 INFO - 'MAIL': '/var/mail/cltbld', 11:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:22 INFO - 'MOZ_NO_REMOTE': '1', 11:47:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:22 INFO - 'NO_EM_RESTART': '1', 11:47:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:22 INFO - 'PWD': '/builds/slave/test', 11:47:22 INFO - 'SHELL': '/bin/bash', 11:47:22 INFO - 'SHLVL': '1', 11:47:22 INFO - 'TERM': 'linux', 11:47:22 INFO - 'TMOUT': '86400', 11:47:22 INFO - 'USER': 'cltbld', 11:47:22 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452019095.232496-1284594825', 11:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:22 INFO - '_': '/tools/buildbot/bin/python'} 11:47:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:22 INFO - Downloading/unpacking blobuploader==1.2.4 11:47:22 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 11:47:22 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 11:47:22 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 11:47:22 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 11:47:22 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 11:47:22 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 11:47:24 INFO - Downloading blobuploader-1.2.4.tar.gz 11:47:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:47:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:47:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:47:24 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 11:47:24 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 11:47:24 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 11:47:24 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 11:47:24 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 11:47:24 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 11:47:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:47:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:47:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:47:25 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 11:47:25 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 11:47:25 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 11:47:25 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 11:47:25 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 11:47:25 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 11:47:25 INFO - Downloading docopt-0.6.1.tar.gz 11:47:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:47:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:47:25 INFO - Installing collected packages: blobuploader, requests, docopt 11:47:25 INFO - Running setup.py install for blobuploader 11:47:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:47:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:47:25 INFO - Running setup.py install for requests 11:47:25 INFO - Running setup.py install for docopt 11:47:25 INFO - Successfully installed blobuploader requests docopt 11:47:25 INFO - Cleaning up... 11:47:25 INFO - Return code: 0 11:47:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:47:25 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')]} 11:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:25 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')]} 11:47:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:25 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 0x7faf99fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2478dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250b3d0>, '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 0x2476ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2477360>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452019095.232496-1284594825', '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 11:47:25 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 11:47:25 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 11:47:25 INFO - Using env: {'DISPLAY': ':0', 11:47:25 INFO - 'HOME': '/home/cltbld', 11:47:25 INFO - 'LANG': 'en_US.UTF-8', 11:47:25 INFO - 'LANGUAGE': 'en_US:en', 11:47:25 INFO - 'LOGNAME': 'cltbld', 11:47:25 INFO - 'MAIL': '/var/mail/cltbld', 11:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:25 INFO - 'MOZ_NO_REMOTE': '1', 11:47:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:25 INFO - 'NO_EM_RESTART': '1', 11:47:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:25 INFO - 'PWD': '/builds/slave/test', 11:47:25 INFO - 'SHELL': '/bin/bash', 11:47:25 INFO - 'SHLVL': '1', 11:47:25 INFO - 'TERM': 'linux', 11:47:25 INFO - 'TMOUT': '86400', 11:47:25 INFO - 'USER': 'cltbld', 11:47:25 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452019095.232496-1284594825', 11:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:25 INFO - '_': '/tools/buildbot/bin/python'} 11:47:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:47:26 INFO - Running setup.py (path:/tmp/pip-Pqp7oE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:47:26 INFO - Running setup.py (path:/tmp/pip-3P_gdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:47:26 INFO - Running setup.py (path:/tmp/pip-o9KVvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:47:26 INFO - Running setup.py (path:/tmp/pip-b_zaSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:47:26 INFO - Running setup.py (path:/tmp/pip-XaJ85s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:47:26 INFO - Running setup.py (path:/tmp/pip-D9qC_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:47:26 INFO - Running setup.py (path:/tmp/pip-aCzUD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:47:26 INFO - Running setup.py (path:/tmp/pip-DAsef7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:47:26 INFO - Running setup.py (path:/tmp/pip-dOPIja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:47:26 INFO - Running setup.py (path:/tmp/pip-kIebPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:47:26 INFO - Running setup.py (path:/tmp/pip-37ONBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:47:26 INFO - Running setup.py (path:/tmp/pip-4kneJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:47:27 INFO - Running setup.py (path:/tmp/pip-Hcbor1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:47:27 INFO - Running setup.py (path:/tmp/pip-6yD2Ag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:27 INFO - Running setup.py (path:/tmp/pip-F_joZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:47:27 INFO - Running setup.py (path:/tmp/pip-NbVGk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:47:27 INFO - Running setup.py (path:/tmp/pip-rMZSSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:47:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:47:27 INFO - Running setup.py install for manifestparser 11:47:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:47:27 INFO - Running setup.py install for mozcrash 11:47:27 INFO - Running setup.py install for mozdebug 11:47:27 INFO - Running setup.py install for mozdevice 11:47:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:47:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:47:27 INFO - Running setup.py install for mozfile 11:47:27 INFO - Running setup.py install for mozhttpd 11:47:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:47:28 INFO - Running setup.py install for mozinfo 11:47:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:47:28 INFO - Running setup.py install for mozInstall 11:47:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:47:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:47:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:47:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:47:28 INFO - Running setup.py install for mozleak 11:47:28 INFO - Running setup.py install for mozlog 11:47:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:47:28 INFO - Running setup.py install for moznetwork 11:47:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:47:28 INFO - Running setup.py install for mozprocess 11:47:28 INFO - Running setup.py install for mozprofile 11:47:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:47:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:47:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:47:28 INFO - Running setup.py install for mozrunner 11:47:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:47:28 INFO - Running setup.py install for mozscreenshot 11:47:28 INFO - Running setup.py install for moztest 11:47:29 INFO - Running setup.py install for mozversion 11:47:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:47:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:47:29 INFO - Cleaning up... 11:47:29 INFO - Return code: 0 11:47:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:47:29 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')]} 11:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:29 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')]} 11:47:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:29 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 0x7faf99fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2478dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250b3d0>, '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 0x2476ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2477360>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452019095.232496-1284594825', '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 11:47:29 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 11:47:29 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 11:47:29 INFO - Using env: {'DISPLAY': ':0', 11:47:29 INFO - 'HOME': '/home/cltbld', 11:47:29 INFO - 'LANG': 'en_US.UTF-8', 11:47:29 INFO - 'LANGUAGE': 'en_US:en', 11:47:29 INFO - 'LOGNAME': 'cltbld', 11:47:29 INFO - 'MAIL': '/var/mail/cltbld', 11:47:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:29 INFO - 'MOZ_NO_REMOTE': '1', 11:47:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:29 INFO - 'NO_EM_RESTART': '1', 11:47:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:29 INFO - 'PWD': '/builds/slave/test', 11:47:29 INFO - 'SHELL': '/bin/bash', 11:47:29 INFO - 'SHLVL': '1', 11:47:29 INFO - 'TERM': 'linux', 11:47:29 INFO - 'TMOUT': '86400', 11:47:29 INFO - 'USER': 'cltbld', 11:47:29 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452019095.232496-1284594825', 11:47:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:29 INFO - '_': '/tools/buildbot/bin/python'} 11:47:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:47:29 INFO - Running setup.py (path:/tmp/pip-rrJS2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:47:29 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)) 11:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:47:29 INFO - Running setup.py (path:/tmp/pip-4G0H3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:47:29 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)) 11:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:47:29 INFO - Running setup.py (path:/tmp/pip-Dhna5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:47:29 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)) 11:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:47:29 INFO - Running setup.py (path:/tmp/pip-r1i_qu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:47:29 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)) 11:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:47:29 INFO - Running setup.py (path:/tmp/pip-B19__5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:47:29 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)) 11:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:47:29 INFO - Running setup.py (path:/tmp/pip-nGUCb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:47:29 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)) 11:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:47:29 INFO - Running setup.py (path:/tmp/pip-_ygQLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:47:29 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)) 11:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:47:29 INFO - Running setup.py (path:/tmp/pip-lyYxyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:47:29 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)) 11:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:47:29 INFO - Running setup.py (path:/tmp/pip-2C1x0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:47:30 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)) 11:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:47:30 INFO - Running setup.py (path:/tmp/pip-IeYKwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:47:30 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)) 11:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:47:30 INFO - Running setup.py (path:/tmp/pip-dxjvEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:47:30 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)) 11:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:47:30 INFO - Running setup.py (path:/tmp/pip-ktCana-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:47:30 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)) 11:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:47:30 INFO - Running setup.py (path:/tmp/pip-5sSUxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:47:30 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)) 11:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:47:30 INFO - Running setup.py (path:/tmp/pip-m0xghN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:47:30 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)) 11:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:30 INFO - Running setup.py (path:/tmp/pip-AOPMN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:30 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)) 11:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:47:30 INFO - Running setup.py (path:/tmp/pip-53JIio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:47:30 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)) 11:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:47:30 INFO - Running setup.py (path:/tmp/pip-9EvjH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:47:30 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)) 11:47:30 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)) 11:47:30 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)) 11:47:30 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)) 11:47:30 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)) 11:47:30 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)) 11:47:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:30 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 11:47:30 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 11:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:32 INFO - Downloading blessings-1.5.1.tar.gz 11:47:32 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 11:47:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:47:32 INFO - Installing collected packages: blessings 11:47:32 INFO - Running setup.py install for blessings 11:47:32 INFO - Successfully installed blessings 11:47:32 INFO - Cleaning up... 11:47:32 INFO - Return code: 0 11:47:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:47:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:47:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:47:32 INFO - Reading from file tmpfile_stdout 11:47:32 INFO - Current package versions: 11:47:32 INFO - argparse == 1.2.1 11:47:32 INFO - blessings == 1.5.1 11:47:32 INFO - blobuploader == 1.2.4 11:47:32 INFO - docopt == 0.6.1 11:47:32 INFO - manifestparser == 1.1 11:47:32 INFO - mozInstall == 1.12 11:47:32 INFO - mozcrash == 0.16 11:47:32 INFO - mozdebug == 0.1 11:47:32 INFO - mozdevice == 0.47 11:47:32 INFO - mozfile == 1.2 11:47:32 INFO - mozhttpd == 0.7 11:47:32 INFO - mozinfo == 0.9 11:47:32 INFO - mozleak == 0.1 11:47:32 INFO - mozlog == 3.1 11:47:32 INFO - moznetwork == 0.27 11:47:32 INFO - mozprocess == 0.22 11:47:32 INFO - mozprofile == 0.28 11:47:32 INFO - mozrunner == 6.11 11:47:32 INFO - mozscreenshot == 0.1 11:47:32 INFO - mozsystemmonitor == 0.0 11:47:32 INFO - moztest == 0.7 11:47:32 INFO - mozversion == 1.4 11:47:32 INFO - psutil == 3.1.1 11:47:32 INFO - requests == 1.2.3 11:47:32 INFO - wsgiref == 0.1.2 11:47:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:47:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:32 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 0x7faf99fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2478dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250b3d0>, '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 0x2476ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2477360>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452019095.232496-1284594825', '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 11:47:32 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 11:47:32 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 11:47:32 INFO - Using env: {'DISPLAY': ':0', 11:47:32 INFO - 'HOME': '/home/cltbld', 11:47:32 INFO - 'LANG': 'en_US.UTF-8', 11:47:32 INFO - 'LANGUAGE': 'en_US:en', 11:47:32 INFO - 'LOGNAME': 'cltbld', 11:47:32 INFO - 'MAIL': '/var/mail/cltbld', 11:47:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:32 INFO - 'MOZ_NO_REMOTE': '1', 11:47:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:32 INFO - 'NO_EM_RESTART': '1', 11:47:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:32 INFO - 'PWD': '/builds/slave/test', 11:47:32 INFO - 'SHELL': '/bin/bash', 11:47:32 INFO - 'SHLVL': '1', 11:47:32 INFO - 'TERM': 'linux', 11:47:32 INFO - 'TMOUT': '86400', 11:47:32 INFO - 'USER': 'cltbld', 11:47:32 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452019095.232496-1284594825', 11:47:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:32 INFO - '_': '/tools/buildbot/bin/python'} 11:47:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:32 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)) 11:47:32 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)) 11:47:32 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)) 11:47:32 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)) 11:47:32 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)) 11:47:32 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)) 11:47:32 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)) 11:47:32 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)) 11:47:32 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)) 11:47:32 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)) 11:47:32 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)) 11:47:32 INFO - Cleaning up... 11:47:32 INFO - Return code: 0 11:47:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:47:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:32 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 0x7faf99fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2478dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250b3d0>, '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 0x2476ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2477360>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452019095.232496-1284594825', '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 11:47:32 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 11:47:32 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 11:47:32 INFO - Using env: {'DISPLAY': ':0', 11:47:32 INFO - 'HOME': '/home/cltbld', 11:47:32 INFO - 'LANG': 'en_US.UTF-8', 11:47:32 INFO - 'LANGUAGE': 'en_US:en', 11:47:32 INFO - 'LOGNAME': 'cltbld', 11:47:32 INFO - 'MAIL': '/var/mail/cltbld', 11:47:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:32 INFO - 'MOZ_NO_REMOTE': '1', 11:47:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:32 INFO - 'NO_EM_RESTART': '1', 11:47:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:32 INFO - 'PWD': '/builds/slave/test', 11:47:32 INFO - 'SHELL': '/bin/bash', 11:47:32 INFO - 'SHLVL': '1', 11:47:32 INFO - 'TERM': 'linux', 11:47:32 INFO - 'TMOUT': '86400', 11:47:32 INFO - 'USER': 'cltbld', 11:47:32 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452019095.232496-1284594825', 11:47:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:32 INFO - '_': '/tools/buildbot/bin/python'} 11:47:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:33 INFO - Downloading/unpacking jsonschema 11:47:33 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 11:47:33 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 11:47:33 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 11:47:33 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 11:47:33 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 11:47:33 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 11:47:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:47:34 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 11:47:34 INFO - Downloading/unpacking functools32 (from jsonschema) 11:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:34 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 11:47:34 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 11:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:35 INFO - Downloading functools32-3.2.3-2.tar.gz 11:47:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 11:47:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:47:35 INFO - warning: no files found matching '*.txt' 11:47:35 INFO - no previously-included directories found matching 'build' 11:47:35 INFO - no previously-included directories found matching 'dist' 11:47:35 INFO - no previously-included directories found matching '.git*' 11:47:35 INFO - Installing collected packages: jsonschema, functools32 11:47:35 INFO - Running setup.py install for functools32 11:47:35 INFO - warning: no files found matching '*.txt' 11:47:35 INFO - no previously-included directories found matching 'build' 11:47:35 INFO - no previously-included directories found matching 'dist' 11:47:35 INFO - no previously-included directories found matching '.git*' 11:47:35 INFO - Successfully installed jsonschema functools32 11:47:35 INFO - Cleaning up... 11:47:35 INFO - Return code: 0 11:47:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:47:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:35 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 0x7faf99fc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2478dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250b3d0>, '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 0x2476ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2477360>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452019095.232496-1284594825', '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 11:47:35 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 11:47:35 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 11:47:35 INFO - Using env: {'DISPLAY': ':0', 11:47:35 INFO - 'HOME': '/home/cltbld', 11:47:35 INFO - 'LANG': 'en_US.UTF-8', 11:47:35 INFO - 'LANGUAGE': 'en_US:en', 11:47:35 INFO - 'LOGNAME': 'cltbld', 11:47:35 INFO - 'MAIL': '/var/mail/cltbld', 11:47:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:35 INFO - 'MOZ_NO_REMOTE': '1', 11:47:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:35 INFO - 'NO_EM_RESTART': '1', 11:47:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:35 INFO - 'PWD': '/builds/slave/test', 11:47:35 INFO - 'SHELL': '/bin/bash', 11:47:35 INFO - 'SHLVL': '1', 11:47:35 INFO - 'TERM': 'linux', 11:47:35 INFO - 'TMOUT': '86400', 11:47:35 INFO - 'USER': 'cltbld', 11:47:35 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452019095.232496-1284594825', 11:47:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:35 INFO - '_': '/tools/buildbot/bin/python'} 11:47:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:35 INFO - Downloading/unpacking flake8 11:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:35 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 11:47:35 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 11:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:47:37 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 11:47:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:37 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 11:47:37 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 11:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:47:37 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 11:47:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:37 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 11:47:37 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 11:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:37 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 11:47:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:37 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 11:47:37 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 11:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:47:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:47:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:47:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:47:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:47:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:47:37 INFO - no previously-included directories found matching 'docs/_build' 11:47:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:47:38 INFO - Running setup.py install for pep8 11:47:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:47:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:47:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:47:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:47:38 INFO - no previously-included directories found matching 'docs/_build' 11:47:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:47:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:47:38 INFO - Cleaning up... 11:47:38 INFO - Return code: 0 11:47:38 INFO - Running post-action listener: _resource_record_post_action 11:47:38 INFO - Running post-action listener: _start_resource_monitoring 11:47:38 INFO - Starting resource monitoring. 11:47:38 INFO - ##### 11:47:38 INFO - ##### Running install step. 11:47:38 INFO - ##### 11:47:38 INFO - Running pre-action listener: _resource_record_pre_action 11:47:38 INFO - Running main action method: install 11:47:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:47:38 INFO - Reading from file tmpfile_stdout 11:47:38 INFO - Detecting whether we're running mozinstall >=1.0... 11:47:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:47:38 INFO - Reading from file tmpfile_stdout 11:47:38 INFO - Output received: 11:47:38 INFO - Usage: mozinstall [options] installer 11:47:38 INFO - Options: 11:47:38 INFO - -h, --help show this help message and exit 11:47:38 INFO - -d DEST, --destination=DEST 11:47:38 INFO - Directory to install application into. [default: 11:47:38 INFO - "/builds/slave/test"] 11:47:38 INFO - --app=APP Application being installed. [default: firefox] 11:47:38 INFO - mkdir: /builds/slave/test/build/application 11:47:38 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'] 11:47:38 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 11:47:54 INFO - Reading from file tmpfile_stdout 11:47:54 INFO - Output received: 11:47:54 INFO - /builds/slave/test/build/application/firefox/firefox 11:47:54 INFO - Running post-action listener: _resource_record_post_action 11:47:54 INFO - ##### 11:47:54 INFO - ##### Running run-tests step. 11:47:54 INFO - ##### 11:47:54 INFO - Running pre-action listener: _resource_record_pre_action 11:47:54 INFO - Running main action method: run_tests 11:47:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:47:54 INFO - Python 2.7.3 11:47:54 INFO - Return code: 0 11:47:54 INFO - grabbing minidump binary from tooltool 11:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:47:54 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 0x250b3d0>, '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 0x2476ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2477360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:47:54 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 11:47:54 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 11:47:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:47:54 INFO - Return code: 0 11:47:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:47:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:47:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:47:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:47:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:47:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:47:55 INFO - Return code: 0 11:47:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:47:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:47:55 INFO - Using env: {'DISPLAY': ':0', 11:47:55 INFO - 'HOME': '/home/cltbld', 11:47:55 INFO - 'LANG': 'en_US.UTF-8', 11:47:55 INFO - 'LANGUAGE': 'en_US:en', 11:47:55 INFO - 'LOGNAME': 'cltbld', 11:47:55 INFO - 'MAIL': '/var/mail/cltbld', 11:47:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:47:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:55 INFO - 'MOZ_NO_REMOTE': '1', 11:47:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:47:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:55 INFO - 'NO_EM_RESTART': '1', 11:47:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:55 INFO - 'PWD': '/builds/slave/test', 11:47:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:47:55 INFO - 'SHELL': '/bin/bash', 11:47:55 INFO - 'SHLVL': '1', 11:47:55 INFO - 'TERM': 'linux', 11:47:55 INFO - 'TMOUT': '86400', 11:47:55 INFO - 'USER': 'cltbld', 11:47:55 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452019095.232496-1284594825', 11:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:55 INFO - '_': '/tools/buildbot/bin/python'} 11:47:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:47:55 INFO - mozversion application_buildid: 20160105111831 11:47:55 INFO - mozversion application_changeset: 3c7d6b80345e197eea1d13bc32ebf3439bbc89fb 11:47:55 INFO - mozversion application_display_name: Nightly 11:47:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:47:55 INFO - mozversion application_name: Firefox 11:47:55 INFO - mozversion application_remotingname: firefox 11:47:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:47:55 INFO - mozversion application_vendor: Mozilla 11:47:55 INFO - mozversion application_version: 46.0a1 11:47:55 INFO - mozversion platform_buildid: 20160105111831 11:47:55 INFO - mozversion platform_changeset: 3c7d6b80345e197eea1d13bc32ebf3439bbc89fb 11:47:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:47:55 INFO - mozversion platform_version: 46.0a1 11:47:55 INFO - using testdate: 1452023275 11:47:55 INFO - actual date: 1452023275 11:47:55 INFO - starting webserver on 'localhost:50747' 11:47:55 INFO - SUITE-START | Running 3 tests 11:47:55 INFO - TEST-START | dromaeo_css 11:47:55 INFO - operating with platform_type : linux_ 11:47:55 INFO - Initialising browser for dromaeo_css test... 11:47:55 INFO - TEST-INFO | started process 31985 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUHwNmP/profile http://localhost:50747/getInfo.html) 11:47:59 INFO - PROCESS | 31985 | __metrics Screen width/height:1600/1200 11:47:59 INFO - PROCESS | 31985 | colorDepth:24 11:47:59 INFO - PROCESS | 31985 | Browser inner width/height: 1024/697 11:47:59 INFO - PROCESS | 31985 | __metrics 11:47:59 INFO - PROCESS | 31985 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:47:59 INFO - PROCESS | 31985 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:48:00 INFO - TEST-INFO | 31985: exit 0 11:48:00 INFO - Browser initialized. 11:48:00 INFO - Running cycle 1/1 for dromaeo_css test... 11:48:00 INFO - TEST-INFO | started process 32076 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUHwNmP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:48:12 INFO - PROCESS | 32076 | RSS: Main: 150163456 11:48:12 INFO - PROCESS | 32076 | 11:49:03 INFO - PROCESS | 32076 | 1452023343627 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] 11:51:17 INFO - PROCESS | 32076 | Cycle 1(1): loaded http://localhost:50747/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50747/tests/dromaeo/cssquery-ext.html) 11:51:18 INFO - PROCESS | 32076 | RSS: Main: 254500864 11:51:18 INFO - PROCESS | 32076 | 11:54:20 INFO - PROCESS | 32076 | Cycle 1(1): loaded http://localhost:50747/tests/dromaeo/cssquery-ext.html (next: http://localhost:50747/tests/dromaeo/cssquery-jquery.html) 11:54:21 INFO - PROCESS | 32076 | RSS: Main: 233566208 11:54:21 INFO - PROCESS | 32076 | 11:57:23 INFO - PROCESS | 32076 | Cycle 1(1): loaded http://localhost:50747/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50747/tests/dromaeo/cssquery-mootools.html) 11:57:24 INFO - PROCESS | 32076 | RSS: Main: 228446208 11:57:24 INFO - PROCESS | 32076 | 12:00:26 INFO - PROCESS | 32076 | Cycle 1(1): loaded http://localhost:50747/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50747/tests/dromaeo/cssquery-prototype.html) 12:00:26 INFO - PROCESS | 32076 | RSS: Main: 215027712 12:00:26 INFO - PROCESS | 32076 | 12:03:29 INFO - PROCESS | 32076 | Cycle 1(1): loaded http://localhost:50747/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50747/tests/dromaeo/cssquery-yui.html) 12:03:30 INFO - PROCESS | 32076 | RSS: Main: 218128384 12:03:30 INFO - PROCESS | 32076 | 12:06:32 INFO - PROCESS | 32076 | Cycle 1(1): loaded http://localhost:50747/tests/dromaeo/cssquery-yui.html (next: http://localhost:50747/tests/dromaeo/cssquery-dojo.html) 12:06:32 INFO - PROCESS | 32076 | RSS: Main: 258637824 12:06:32 INFO - PROCESS | 32076 | 12:06:32 INFO - PROCESS | 32076 | __start_tp_report 12:06:32 INFO - PROCESS | 32076 | _x_x_mozilla_page_load 12:06:32 INFO - PROCESS | 32076 | _x_x_mozilla_page_load_details 12:06:32 INFO - PROCESS | 32076 | |i|pagename|runs| 12:06:32 INFO - PROCESS | 32076 | |0;dojo.html;2583.0830055330352;2683.235277945786;2700.743429374209;2700.864956752162;2717.850518221498;4398.912021759571;4512.278035514319;4578.771061446931;4587.885302867426;4594.540545945404;4556;4581.31280307954;4611.538846115395;4623.514530974249;4643.214071557064;4198.8320467181275;4220.767857767822;4281.9357709634305;4318.827246910136;4340.587644173815;4086.080631857823;4297.05464797744;4316.20150272199;4350.56494350564;4363.650907927358;4151.501819781615;4178.080822219137;4181.456410666594;4253.936190957138;4260.573942605745;4174.31123864562;4180.331147016494;4194.643455306303;4213.199492096523;4234.809433575497;4087.3664581989838;4157.91684166318;4177.143685544456;4179.665626749853;4211.4946206455115;4430.490493593245;4434.268345722952;4436.268015777393;4554.567316104964;4595.149897268982;4882.36529251195;4917.950820491785;4922.729249891255;4925.088858561177;4964.801407943678;4750.501197374295;4940.6788558743565;4946.480619534969;4953.455119936804;4996.075725990703;4495.730256184606;4506.098780243964;4532.5694059065;4594.97702511492;4656.371389862393;5061.569766569883;5072.442031376546;5080.983803239367;5081.2378143278065;5087.109755792721;4639.373684552542;4872.926906096412;4881.316615673809;4883.731394773322;4921.655484116149;4774.3077253798;4779.713217206979;4873.342098816685;4920.6555541111775;4922.630802689741;4770.880727981828;4792;4802.27965805125;4810.927836082462;4834.419869615669;4618.584327410549;4765.9046819064115;4776.020915712271;4779.30700048498;4817.205161148371;3975.7018223633345;4043.8786836394956;4116.91766164681;4135.421041054255;4153.563875793058;3617.3488772021287;3620.6560376764164;3621.6921561667555;3630.2739452109686;3642.1076836174775;4084.3873418986796;4277.101808620162;4280.850170244026;4281.529031806499;4322.7190232634775;4839.927401088987;4873.074115917964;4888.364512613409;4973.950260497421;5012.398512178562;4252.468441444819;4262.295081967163;4272.487301523837;4289.721168124062;4325.9134817303475;4201.369794530845;4386.298192289219;4394.604485596312;4399.604035636744;4426.911461770746;4608.654350923761;4631.536846315342;4632.305154226893;4637.1421287062;4757;4953.7523123844385;4959.628027897994;4967.03142887148;4970.304157417892;5022.949770502249;4704.717716936994;4711.293306004127;4714.127886340901;4734.384530011076;4763.54746299101;4660.067986402801;4773.64197685182;4791.9281210782565;4894.828680996148;4934.55588996992;4878.195097808822;4964.131277026434;4985.52637499437;4989.975050124726;5033.748312584283;4787.281907713871;4818.4217893852965;4820.590249828804;4831.830885918976;4865.1242776300605;4598;4707.035057813072;4709.270063140219;4828.155072862165;4862.562369386772;4551.635869130396;4596;4616.146012987608;4735.668503204881;4765.475797662324;4832.347633069631;4833.564979151753;4854;4855.320255164351;4884.65807393479;4737.336772851734;4737.952620473889;4739;4739.7867095981455;4790.0419916016235 12:06:32 INFO - PROCESS | 32076 | |1;ext.html;505.5071305477158;512.0118171928182;516.3519782672745;535.6571794051806;547.8027909952414;24782.75217247827;25160.874195629043;25165.119220827273;25176.87411562942;25219;25546.233612991593;32213.19467013326;32645.347093058124;32656;32775.344493110126;7619.238076192378;7694.576798276093;7696.345810606105;7775.533467991939;7779.455438119334;6932.098827152463;7111.928880711178;7482.326590606845;7591.81020474487;7604.0875094988405;9767.120959113678;9991.350562213469;9991.500424978758;9991.950040249789;9994.90005099947;9581.137697607213;9684.322097453181;9696.0788725071;9709.417434953926;9709.611615535336;6946.895796563055;7121.145462544528;9464.716058518256;9521.476318802463;9724.611015559369;32249;32683;32722.509162362585;32824.83587582071;32921.6707832921;2745.409736906575;2799.244204064891;2887.985560072186;3363.747718921091;3402.2004828865197;26229;26516.60225096625;26711.19866404011;26714.332141696417;27177.86411067932;3441.7934923904645;3473.774204676688;3490.6683865033037;3515.771474854152;3554.964450355515;214493;216332;216787;217310.99999999843;217614;53772.73113634407;54227.45772542303;54266.728666356415;54301.72849135729;54305.185422218696;49710.75144624326;50742;58116;58502.70748646229;60323.39676603265;12847.586765455793;13051.412686429134;13071.673208169872;13108.279044652445;13130.146540474838;9576.467765157542;9698.127168554864;9700.90299097014;9702.951485242529;9707.854382184272;17943.282268709365;18139.183736731615;18235.817641823676;18240.543986400447;18273.45179644586;7213.89179162313;7453.217412171753;7496.662650180755;7540.509866858746;7595.506292090997;790.4980337485738;862.2326129744532;874.6676263020012;901.3825529512305;953.3850666320185;26026.86986565055;27556.586651200247;29010;29070.563941540895;31724;881.352206128495;907.2288554728428;915.4507295622707;923.7136487688838;929.4098247612679;13088.672783180496;13089.280089595164;13232.19134898461;13315;13382.866171338357;317981;325150;325627;325912;326045;45319.32021019687;45864.77067614641;45866.541334586225;45891.311630325574;46289.5371046292;1082.9729256768644;1141.760230351619;1146.4439746722999;1155.6590805712335;1249.1006475337742;23329;23686.763132368455;24353.756462435147;27173.59239611368;29019;39688.206235874546;42111.36832947447;42848.57151428446;42877.78561107299;42976.14047719091;233250;234093;236862;237883;238159;37815.43276850905;38065.23869522649;38229;38235;38404.80797595994;41037.38443923403;41082;41317.1736565273;41359.37960930528;41965;33345.83327083349;33824.49263261004;34570;34617.65382346144;35072.82463587768;30008.549871752377;30078;30140.84929575426;30358.392832142792;30421.197350331207;30470.390592188476;35179.824100879334;35545.644543554234;35690.46464303089;35693.46459803053;25956.35109122287;27714.168574942785;28001;28006.159815205578;28047.579286310312;21543.56912861765;21891.67162492596;22025.449363766034;22034.88982555077;22038.779612203674 12:06:32 INFO - PROCESS | 32076 | |2;jquery.html;315.760022382989;318.1989936956825;325.21298457732286;331.30702112206626;332.106633156808;12155.696107597314;12558.937205313983;14528.200948947817;14888.106713597179;15011.249437528135;9907.356021858574;10066.899331006687;10194.898051019487;14989.325480353384;15399.384024639028;4425.933610995829;4537.115262523809;4538.251188553884;4539.024109816389;4540.091981603676;3343.9665603343897;3438.157651375404;4703.976480117594;6178.8455288617915;6406.519511036668;6324.209473815773;6395.424411802936;6405.071264666621;6439.710213040401;6439.903401448982;6424.775132870351;6435.324290949429;6445;6506.056621789838;6520.836979075538;6112.602680825732;6231.750729970796;6245.281792593864;6245.937540624581;6270.46701030413;17632.382866599608;19784;20338.898305508526;21275.36173914785;21557.89221053885;1844.0779610194902;1860.2837907405747;1893.6780747272996;1932.3526618582791;1954.853385996056;13583.52457663977;13754.862451375458;13818.447262109503;13914.09558378702;14067.648308792259;1871.2889102141235;1899.2782742557877;1906.3804263614243;1907.6661584222845;1927.7204805303293;57613.71193144008;60901.6954915227;60946.695266523384;61238.38761612416;61927;15138.243087845563;15186.848131518544;15240.390384384722;15262.542123736306;15296;22381;22779.316620501413;22835.31494055181;22877.656835147485;22915;8157.510549366938;8234.694285600042;8244.793880153044;8268.710595129141;8292.212239837207;6763.526553141233;6796.558223715443;6808.6255255960405;6814.182298124158;6849;7333.633318334062;7385.3722433592675;7411.518251313755;7417;7418;1668.1325710630404;1703.3867807589259;1705.1303835044216;1725.2495164603188;2133.7730804786997;353.38510990876205;360.7817270551331;367.2398135858747;837.5226121111031;860.1484530314943;7810.375169986388;9322.95338523303;9450.243980481682;9543.188828949478;9643.614255429704;376.8266597365243;380.3894748927986;808.6926967752216;808.8382323535317;828.9502629842108;8732.91267087321;9004;9235.58439870194;9377.812443751223;9422.104900034486;514365;520334;526725;530202.9797020344;535707;66290.66854665696;69107.65446172738;70395.2960470399;70422.29577704157;70562;1089.8801131875487;1090.5583238788304;1093.2507987220542;1117.5473933057124;1118.1781390677845;14317.427302907767;14453.49412770548;14623.341949612506;14631.634209144857;14734.63163420923;31508.527372088978;32135.839320803247;32162.83918580392;32411.837940810146;32960.1759956003;41612;44460.33309500425;44760;45029.09941801211;45232;8809.678548217818;8952.820943581222;8992.46045237288;9059.728208153765;9064.365494415328;10313.22650801208;14957.551273461813;15345.462908798585;15682.529524114294;15720.213989300719;12843.807342889677;12853.678658033625;12980.805287920877;13244.933775331061;13516.391762370913;10464.11055060298;11771.293722376684;12732.108752387245;13170.07809453329;14078.577642670736;12184.57353992606;13104.868951310365;13136.671583210114;13714.451421943011;13923.930380348034;8322.334213263046;8325.292350150063;8405.15948405179;8432.283255923316;8434.493930364199;9014.549272536478;9340.392874463138;12598.118131730691;13189.340532973505;13214.801777973531 12:06:32 INFO - PROCESS | 32076 | |3;mootools.html;1190.1966172833336;1277.827493288406;1303.1920209470127;1312.6455856918633;1623.2370785730702;5670.71646417679;6415.101885736;6478.125453063835;6526.6736663166885;6546.3126371731;6416.9358306416925;6615.23924748654;6618.768343107992;6621;6635.900461493069;1971.8028197180274;2004.7995200479982;2009.5076706206926;2009.6382651122792;2010.2260629657542;1975.664137096697;2009.5980803839218;2017.5561376497146;2022.7471566054244;2028.421899758569;1971.714101455288;1993.9700904486444;2013.013623324575;2021.3834780391974;2030.6344857925642;1989.4827344890289;2007.15699406249;2012.0643900586151;2018.8485863560293;2020.3635854705867;1965.852561057912;1978.8120128587905;1985.1166231027198;1987.1455274232073;1995.4712001319663;6631.10480085192;6788.015737718003;6800.081988931481;6805.489588280899;6812;3867.0719027433493;3904.629060239301;3911.8044097794996;3921.627445392683;3930.2925473414775;2417.7098748150333;2466.691663542057;2484.689413823272;2509.8117641176987;2510.1214574898822;779.3570304498754;792.5918152151646;800.6437135474716;807.5760225881401;808.0061524325055;8567.100454452255;8633.827323453559;8645.221930026264;8652.307815374756;8666.090060543615;3552.609212986569;3559.875404360835;3604.936543719609;3608.4767708682093;3613.4941108244866;7587.62061896914;7594.81012974669;7601.847963040708;7610;7624.008878845714;3937.3897045957924;3944.60553944609;3952.3676211805973;3954.8220330085214;3956.3076461619676;3078.553609726577;3111.5643809866638;3582.731295152874;3597.5503062117236;3612.313660404515;3281.0812972367776;3287.474004159323;3319.883804066846;3320.8505617247283;3332.283559034819;1000.1548691355792;1008.7831116310028;1011.0647650922867;1015.674984005126;1021.1473419694489;831.9292860106838;834.3408707121428;834.390894646899;1002.6490728245202;1143.5368675686361;6240.563160578716;6326.051092336186;6400.423961843457;6414.486841052704;6435.613863168225;418.4580967646905;422.51832910482074;426.46052743279773;428.96782741294527;433.20074462616424;4742.620590352763;4784.449788274393;4788;4791.47293797682;4797.592204662573;7703.499272547267;7781.572013539197;7887.566183859828;8028.197180282042;8036;7787.338076263468;7789.1821358756515;7793.532388056735;7794.142644309121;7797.064352277763;6231.065340199007;6300.558960872787;6342.841428964312;6372.044193370939;6372.681365931685;5841.591088623755;6183.165272688129;6203.96898015507;6205.22434695663;6206.193194884636;7068.5758854468895;7087.078679771596;7189.712411503481;7245.275472452712;7267.600281984542;7230.855382892208;7349.301816327654;7422;7450.105987281561;7452.701891924262;4891.828785992473;4992.550670439678;5777.595568310178;5829.53363730892;5845.240118784531;6129.754809807736;6169.290531588925;6205.317415084427;6245.843853903689;6258.155149054819;5761.078227483583;5908.350081490947;5940.16837642739;5962.135490353961;6051.394860513913;5774.82675519735;5853.853653658693;5920.940790592039;5932.139839723302;5936.28764548257;5845.830833833335;5853.560982926383;5886.23478947734;6068.21113255274;6081.27024757032;5448.972755136199;5536.335639723259;5543.445655434424;5546.334439867242;5547.44525547442;5581.10702287632;5590.105583106683;5601.103823388238;5614.21401003868;5615.213870058114 12:06:32 INFO - PROCESS | 32076 | |4;prototype.html;283.5788853552474;287.47679223812656;290.0862283806011;302.2745411013567;302.3846472428608;5282.128448805943;5291.68249905006;5338.345113014968;5352.411234764178;5389.056915039872;5246.1606143017125;5281.656692314997;5281.947180528194;5288.101022826119;5290.100682883909;4102.569230230828;4106.79466026699;4115.979420102895;4127.133302006582;4128.112455821998;3888.572257051722;3978.204359128186;3982.9203415931665;4039.353703407455;4124.958750412503;4078.877633670995;4091.2226676931436;4095.1604920991126;4105.117399759051;4107.055377263231;4085.407615895693;4086.080631857838;4087.3255912774357;4095.4061661059277;4097.938530922039;3348.631650518441;3452.4993875887853;3530.38218311797;3609.729270304738;3623.673869351771;5127.307813445174;5131.179011358202;5140.768665410065;5142.717150556718;5146.305248791403;4728.71627702339;4734.26618874075;4734.479207287196;4736.9526304736855;4740;5570.582206334541;5580.91628625571;5583.972080139573;5586.692731899744;5589.0219211638205;3696.704263658901;3865.130345672201;3878.108035151931;3881.8253178606747;3884.9028774280587;5836.5914385993;5889.85275368115;5931.73307201177;5935.73289201987;5936.436038576328;3938.6455219029854;3957.5448823385677;3961.564227934925;3970.50368703912;3971.5829837867186;4023.6982226332557;4038.1318016626565;4040.1313717550865;4041.595840415935;4041.7574945503366;4473.776311184428;4638.002829391697;4648.070385922829;4661.557152070548;4670.276107203321;5604.579656525777;5613.915791263134;5615.691136987505;5616.634918730269;5617.045102332613;1390.7496650602989;1427.0510110776218;1427.6288165077156;1428.264443811438;1428.292994967477;928.007032475245;930.3580529434669;945.9763505912407;954.3939598355095;955.4744890310302;4955.603551715854;4972.428170760337;4978.178600530872;4982.576480999083;4984.501549844987;5853.88292234153;5854.414558544111;5859.2090067841145;5859.912101318484;5863.67749773758;4953;4956.553910148104;4970.378702662168;4970.428400733889;4977.726225057657;3049.420610084077;3106.378724255158;3153.0068028570927;3153.4639111351125;3157.463231250693;5317.946820531823;5403.756830942617;5486.478784515464;5552.944470555323;5608.411116832755;6060.33336333003;6068.180795592627;6077.088436734525;6082.482988945989;6091.939080609226;5595.63628364155;5600.299962504687;5621.74702138413;5631.465010823965;5658.179563963202;5689.800856969986;5857.882842343214;5877.4122587740885;5891.941080589139;5899.056151015817;5723.542116630576;5724.771009159587;5731;5733.283339582552;5738.311402631711;5585.888282234414;5587.664740115606;5591.4688104629995;5594.944050559605;5604.327480702342;3973.5430425501436;3997.5602683704187;4016.6184212499766;4017.5379831319774;4023.8994025149605;5724.914126288026;5843.152742852348;5882.382349853204;5887.941120588911;5891.1457838614015;5618.044932361427;5643.294588176478;5656.632318899258;5668.26312579362;5678.3186017678145;5641.548676105984;5670.064439367623;5673.858153546194;5675.57433192504;5680.233168522197;5426.158945363475;5561.304836895388;5561.6663000220115;5580.553555715452;5582.162675598693;5703.714814259188;5712.0860662293835;5721.056025755704;5722.799702010409;5724.141378793048;5576.052071147996;5578.330600327987;5584.609077364546;5588.524975377139;5595.328560572757 12:06:32 INFO - PROCESS | 32076 | |5;yui.html;663.4957432351412;705.5413980912408;746.5110352718967;749.5540153608605;758.9810254743634;10398.688039358822;10599.364038157715;10607.31052481588;10607.416592087442;10610.257281990263;10211.48942552873;10234.488275586209;10241.23190760694;10256.538455769489;11427.42862856858;608.1000119822643;612.7793994162121;612.7824622259101;614.6189362595197;617.2038070888559;741.3772431157853;741.4624397311933;741.8293792427745;745.9701611935516;755.3126654744184;763.0500027465813;767.9040119985002;769.8575763483746;775.14733792828;783.4046124945054;759.9240075992384;762.0360244290977;767.2136060537938;781.5232708048086;785.5365334452644;575.0368133376619;576.5445298214405;577.1717585265158;577.5725962787549;577.711144427786;11132.387718675469;11140.832887506695;11195.720106997309;11253.099752019818;11262.718432039183;10482.68551943443;10806.891931080667;10812.026917577456;10869.347839129678;11365.431728413547;8451.70419035337;8667.869981950276;8682.652693892236;8728.03991560934;9010.774730631787;3122.73456756176;3168.30297334586;3173.5557022016937;3190.7128358447617;3222.7099561039618;33992.32015359704;34367.82816085903;37582.8120859394;38388.232235355135;39412.40881386781;8820.162084601952;8841.778955526162;8899.288056955427;8930.642774288955;8931.866022009675;15177.924110379377;15429.691406172038;15437.30532126057;15452.38190472391;15454.613634659;6236.875262494725;6283.120363149163;6293.842653933688;6296.212973378328;6492.318306577836;3566.3402270580027;3653.0319465341704;3654.744167908274;3656.1590834108306;3719.9956011876643;2433.6471211674207;2470.518248941439;2474.74015228402;2483.3543278747293;2501.3996640806076;452.3305507848403;456.0150075836178;456.8583739040908;456.8720758187713;457.99542004580195;437.91241751649795;443.2641814587769;464.9070185962821;522.2062465053098;551.3328872064766;6591.901121483182;7152.856942861114;7189.964050179716;7198.460115491359;7379.926200737924;455.9908801823945;484.5905210097462;509.3785581590454;554.9218177923622;555.0508630242331;3279.5900512435946;3362.36115138123;3377.257003459235;3396.23584693442;3478.9652103479148;50119.49880501221;50575.49424505782;50615;50727;50851.237231441555;42132.789336053735;43281.35077973833;43669;44031.339529907076;44805.55194448079;36160.63839361625;41381.37927931084;41771.16457670891;41865.58134418617;41880.79059604683;7540.622968851645;7622.847543049219;7819.061712594297;7919.445638805229;8039.1156972734125;30321.696783031886;30590.08229753111;31061.8446907764;31089.222769430944;32313.35373292568;36377.636223637426;38626.6137338623;38981.80509097436;39168;39214.80392598019;8973.50645714492;9148.359614826899;9175.587098580447;9270.212031977357;9355.625774969198;10472.528736207041;10485.37087774736;10492.213084018882;10605.681829545127;10667;9696.272779541703;9719.562619682272;9842.507874606385;9956.601735930772;10554.525046372779;9292.117248861347;9324.300677449353;9351.111644393772;9371.953140234255;9581.904180958101;9616.326857119935;9715.70852874415;9844.704658860246;9850.556724947251;9970.55132519024;8804.515751633466;8907.955460222658;8992.28061755045;9033.051529589562;9164.037776033421;8426.4944103354;8844.159804818531;8891.656288916563;9067.09329067088;9092.318076144184 12:06:32 INFO - PROCESS | 32076 | __end_tp_report 12:06:32 INFO - PROCESS | 32076 | __start_cc_report 12:06:32 INFO - PROCESS | 32076 | _x_x_mozilla_cycle_collect,1005 12:06:32 INFO - PROCESS | 32076 | __end_cc_report 12:06:32 INFO - PROCESS | 32076 | __startTimestamp1452024392597__endTimestamp 12:06:32 INFO - PROCESS | 32076 | 12:06:32 INFO - PROCESS | 32076 | ------- Summary: start ------- 12:06:32 INFO - PROCESS | 32076 | Number of tests: 6 12:06:32 INFO - PROCESS | 32076 | 12:06:32 INFO - PROCESS | 32076 | [#0] dojo.html Cycles:165 Average:4534.05 Median:4639.37 stddev:465.89 (10.0%) stddev-sans-first:441.47 12:06:32 INFO - PROCESS | 32076 | Values: 2583.1 2683.2 2700.7 2700.9 2717.9 4398.9 4512.3 4578.8 4587.9 4594.5 4556.0 4581.3 4611.5 4623.5 4643.2 4198.8 4220.8 4281.9 4318.8 4340.6 4086.1 4297.1 4316.2 4350.6 4363.7 4151.5 4178.1 4181.5 4253.9 4260.6 4174.3 4180.3 4194.6 4213.2 4234.8 4087.4 4157.9 4177.1 4179.7 4211.5 4430.5 4434.3 4436.3 4554.6 4595.1 4882.4 4918.0 4922.7 4925.1 4964.8 4750.5 4940.7 4946.5 4953.5 4996.1 4495.7 4506.1 4532.6 4595.0 4656.4 5061.6 5072.4 5081.0 5081.2 5087.1 4639.4 4872.9 4881.3 4883.7 4921.7 4774.3 4779.7 4873.3 4920.7 4922.6 4770.9 4792.0 4802.3 4810.9 4834.4 4618.6 4765.9 4776.0 4779.3 4817.2 3975.7 4043.9 4116.9 4135.4 4153.6 3617.3 3620.7 3621.7 3630.3 3642.1 4084.4 4277.1 4280.9 4281.5 4322.7 4839.9 4873.1 4888.4 4974.0 5012.4 4252.5 4262.3 4272.5 4289.7 4325.9 4201.4 4386.3 4394.6 4399.6 4426.9 4608.7 4631.5 4632.3 4637.1 4757.0 4953.8 4959.6 4967.0 4970.3 5022.9 4704.7 4711.3 4714.1 4734.4 4763.5 4660.1 4773.6 4791.9 4894.8 4934.6 4878.2 4964.1 4985.5 4990.0 5033.7 4787.3 4818.4 4820.6 4831.8 4865.1 4598.0 4707.0 4709.3 4828.2 4862.6 4551.6 4596.0 4616.1 4735.7 4765.5 4832.3 4833.6 4854.0 4855.3 4884.7 4737.3 4738.0 4739.0 4739.8 4790.0 12:06:32 INFO - PROCESS | 32076 | 12:06:32 INFO - PROCESS | 32076 | [#1] ext.html Cycles:180 Average:41301.98 Median:19045.71 stddev:68902.88 (361.8%) stddev-sans-first:69028.09 12:06:32 INFO - PROCESS | 32076 | Values: 505.5 512.0 516.4 535.7 547.8 24782.8 25160.9 25165.1 25176.9 25219.0 25546.2 32213.2 32645.3 32656.0 32775.3 7619.2 7694.6 7696.3 7775.5 7779.5 6932.1 7111.9 7482.3 7591.8 7604.1 9767.1 9991.4 9991.5 9992.0 9994.9 9581.1 9684.3 9696.1 9709.4 9709.6 6946.9 7121.1 9464.7 9521.5 9724.6 32249.0 32683.0 32722.5 32824.8 32921.7 2745.4 2799.2 2888.0 3363.7 3402.2 26229.0 26516.6 26711.2 26714.3 27177.9 3441.8 3473.8 3490.7 3515.8 3555.0 214493.0 216332.0 216787.0 217311.0 217614.0 53772.7 54227.5 54266.7 54301.7 54305.2 49710.8 50742.0 58116.0 58502.7 60323.4 12847.6 13051.4 13071.7 13108.3 13130.1 9576.5 9698.1 9700.9 9703.0 9707.9 17943.3 18139.2 18235.8 18240.5 18273.5 7213.9 7453.2 7496.7 7540.5 7595.5 790.5 862.2 874.7 901.4 953.4 26026.9 27556.6 29010.0 29070.6 31724.0 881.4 907.2 915.5 923.7 929.4 13088.7 13089.3 13232.2 13315.0 13382.9 317981.0 325150.0 325627.0 325912.0 326045.0 45319.3 45864.8 45866.5 45891.3 46289.5 1083.0 1141.8 1146.4 1155.7 1249.1 23329.0 23686.8 24353.8 27173.6 29019.0 39688.2 42111.4 42848.6 42877.8 42976.1 233250.0 234093.0 236862.0 237883.0 238159.0 37815.4 38065.2 38229.0 38235.0 38404.8 41037.4 41082.0 41317.2 41359.4 41965.0 33345.8 33824.5 34570.0 34617.7 35072.8 30008.5 30078.0 30140.8 30358.4 30421.2 30470.4 35179.8 35545.6 35690.5 35693.5 25956.4 27714.2 28001.0 28006.2 28047.6 21543.6 21891.7 22025.4 22034.9 22038.8 12:06:32 INFO - PROCESS | 32076 | 12:06:32 INFO - PROCESS | 32076 | [#2] jquery.html Cycles:180 Average:27877.15 Median:364.01 stddev:85725.79 (23550.3%) stddev-sans-first:85941.29 12:06:32 INFO - PROCESS | 32076 | Values: 315.8 318.2 325.2 331.3 332.1 12155.7 12558.9 14528.2 14888.1 15011.2 9907.4 10066.9 10194.9 14989.3 15399.4 4425.9 4537.1 4538.3 4539.0 4540.1 3344.0 3438.2 4704.0 6178.8 6406.5 6324.2 6395.4 6405.1 6439.7 6439.9 6424.8 6435.3 6445.0 6506.1 6520.8 6112.6 6231.8 6245.3 6245.9 6270.5 17632.4 19784.0 20338.9 21275.4 21557.9 1844.1 1860.3 1893.7 1932.4 1954.9 13583.5 13754.9 13818.4 13914.1 14067.6 1871.3 1899.3 1906.4 1907.7 1927.7 57613.7 60901.7 60946.7 61238.4 61927.0 15138.2 15186.8 15240.4 15262.5 15296.0 22381.0 22779.3 22835.3 22877.7 22915.0 8157.5 8234.7 8244.8 8268.7 8292.2 6763.5 6796.6 6808.6 6814.2 6849.0 7333.6 7385.4 7411.5 7417.0 7418.0 1668.1 1703.4 1705.1 1725.2 2133.8 353.4 360.8 367.2 837.5 860.1 7810.4 9323.0 9450.2 9543.2 9643.6 376.8 380.4 808.7 808.8 829.0 8732.9 9004.0 9235.6 9377.8 9422.1 514365.0 520334.0 526725.0 530203.0 535707.0 66290.7 69107.7 70395.3 70422.3 70562.0 1089.9 1090.6 1093.3 1117.5 1118.2 14317.4 14453.5 14623.3 14631.6 14734.6 31508.5 32135.8 32162.8 32411.8 32960.2 41612.0 44460.3 44760.0 45029.1 45232.0 8809.7 8952.8 8992.5 9059.7 9064.4 10313.2 14957.6 15345.5 15682.5 15720.2 12843.8 12853.7 12980.8 13244.9 13516.4 10464.1 11771.3 12732.1 13170.1 14078.6 12184.6 13104.9 13136.7 13714.5 13923.9 8322.3 8325.3 8405.2 8432.3 8434.5 9014.5 9340.4 12598.1 13189.3 13214.8 12:06:32 INFO - PROCESS | 32076 | 12:06:32 INFO - PROCESS | 32076 | [#3] mootools.html Cycles:180 Average:4595.36 Median:5767.95 stddev:2385.49 (41.4%) stddev-sans-first:2378.45 12:06:32 INFO - PROCESS | 32076 | Values: 1190.2 1277.8 1303.2 1312.6 1623.2 5670.7 6415.1 6478.1 6526.7 6546.3 6416.9 6615.2 6618.8 6621.0 6635.9 1971.8 2004.8 2009.5 2009.6 2010.2 1975.7 2009.6 2017.6 2022.7 2028.4 1971.7 1994.0 2013.0 2021.4 2030.6 1989.5 2007.2 2012.1 2018.8 2020.4 1965.9 1978.8 1985.1 1987.1 1995.5 6631.1 6788.0 6800.1 6805.5 6812.0 3867.1 3904.6 3911.8 3921.6 3930.3 2417.7 2466.7 2484.7 2509.8 2510.1 779.4 792.6 800.6 807.6 808.0 8567.1 8633.8 8645.2 8652.3 8666.1 3552.6 3559.9 3604.9 3608.5 3613.5 7587.6 7594.8 7601.8 7610.0 7624.0 3937.4 3944.6 3952.4 3954.8 3956.3 3078.6 3111.6 3582.7 3597.6 3612.3 3281.1 3287.5 3319.9 3320.9 3332.3 1000.2 1008.8 1011.1 1015.7 1021.1 831.9 834.3 834.4 1002.6 1143.5 6240.6 6326.1 6400.4 6414.5 6435.6 418.5 422.5 426.5 429.0 433.2 4742.6 4784.4 4788.0 4791.5 4797.6 7703.5 7781.6 7887.6 8028.2 8036.0 7787.3 7789.2 7793.5 7794.1 7797.1 6231.1 6300.6 6342.8 6372.0 6372.7 5841.6 6183.2 6204.0 6205.2 6206.2 7068.6 7087.1 7189.7 7245.3 7267.6 7230.9 7349.3 7422.0 7450.1 7452.7 4891.8 4992.6 5777.6 5829.5 5845.2 6129.8 6169.3 6205.3 6245.8 6258.2 5761.1 5908.4 5940.2 5962.1 6051.4 5774.8 5853.9 5920.9 5932.1 5936.3 5845.8 5853.6 5886.2 6068.2 6081.3 5449.0 5536.3 5543.4 5546.3 5547.4 5581.1 5590.1 5601.1 5614.2 5615.2 12:06:32 INFO - PROCESS | 32076 | 12:06:32 INFO - PROCESS | 32076 | [#4] prototype.html Cycles:180 Average:4660.84 Median:5290.89 stddev:1394.69 (26.4%) stddev-sans-first:1359.36 12:06:32 INFO - PROCESS | 32076 | Values: 283.6 287.5 290.1 302.3 302.4 5282.1 5291.7 5338.3 5352.4 5389.1 5246.2 5281.7 5281.9 5288.1 5290.1 4102.6 4106.8 4116.0 4127.1 4128.1 3888.6 3978.2 3982.9 4039.4 4125.0 4078.9 4091.2 4095.2 4105.1 4107.1 4085.4 4086.1 4087.3 4095.4 4097.9 3348.6 3452.5 3530.4 3609.7 3623.7 5127.3 5131.2 5140.8 5142.7 5146.3 4728.7 4734.3 4734.5 4737.0 4740.0 5570.6 5580.9 5584.0 5586.7 5589.0 3696.7 3865.1 3878.1 3881.8 3884.9 5836.6 5889.9 5931.7 5935.7 5936.4 3938.6 3957.5 3961.6 3970.5 3971.6 4023.7 4038.1 4040.1 4041.6 4041.8 4473.8 4638.0 4648.1 4661.6 4670.3 5604.6 5613.9 5615.7 5616.6 5617.0 1390.7 1427.1 1427.6 1428.3 1428.3 928.0 930.4 946.0 954.4 955.5 4955.6 4972.4 4978.2 4982.6 4984.5 5853.9 5854.4 5859.2 5859.9 5863.7 4953.0 4956.6 4970.4 4970.4 4977.7 3049.4 3106.4 3153.0 3153.5 3157.5 5317.9 5403.8 5486.5 5552.9 5608.4 6060.3 6068.2 6077.1 6082.5 6091.9 5595.6 5600.3 5621.7 5631.5 5658.2 5689.8 5857.9 5877.4 5891.9 5899.1 5723.5 5724.8 5731.0 5733.3 5738.3 5585.9 5587.7 5591.5 5594.9 5604.3 3973.5 3997.6 4016.6 4017.5 4023.9 5724.9 5843.2 5882.4 5887.9 5891.1 5618.0 5643.3 5656.6 5668.3 5678.3 5641.5 5670.1 5673.9 5675.6 5680.2 5426.2 5561.3 5561.7 5580.6 5582.2 5703.7 5712.1 5721.1 5722.8 5724.1 5576.1 5578.3 5584.6 5588.5 5595.3 12:06:32 INFO - PROCESS | 32076 | 12:06:32 INFO - PROCESS | 32076 | [#5] yui.html Cycles:180 Average:11761.47 Median:25680.31 stddev:13604.90 (53.0%) stddev-sans-first:13617.54 12:06:32 INFO - PROCESS | 32076 | Values: 663.5 705.5 746.5 749.6 759.0 10398.7 10599.4 10607.3 10607.4 10610.3 10211.5 10234.5 10241.2 10256.5 11427.4 608.1 612.8 612.8 614.6 617.2 741.4 741.5 741.8 746.0 755.3 763.1 767.9 769.9 775.1 783.4 759.9 762.0 767.2 781.5 785.5 575.0 576.5 577.2 577.6 577.7 11132.4 11140.8 11195.7 11253.1 11262.7 10482.7 10806.9 10812.0 10869.3 11365.4 8451.7 8667.9 8682.7 8728.0 9010.8 3122.7 3168.3 3173.6 3190.7 3222.7 33992.3 34367.8 37582.8 38388.2 39412.4 8820.2 8841.8 8899.3 8930.6 8931.9 15177.9 15429.7 15437.3 15452.4 15454.6 6236.9 6283.1 6293.8 6296.2 6492.3 3566.3 3653.0 3654.7 3656.2 3720.0 2433.6 2470.5 2474.7 2483.4 2501.4 452.3 456.0 456.9 456.9 458.0 437.9 443.3 464.9 522.2 551.3 6591.9 7152.9 7190.0 7198.5 7379.9 456.0 484.6 509.4 554.9 555.1 3279.6 3362.4 3377.3 3396.2 3479.0 50119.5 50575.5 50615.0 50727.0 50851.2 42132.8 43281.4 43669.0 44031.3 44805.6 36160.6 41381.4 41771.2 41865.6 41880.8 7540.6 7622.8 7819.1 7919.4 8039.1 30321.7 30590.1 31061.8 31089.2 32313.4 36377.6 38626.6 38981.8 39168.0 39214.8 8973.5 9148.4 9175.6 9270.2 9355.6 10472.5 10485.4 10492.2 10605.7 10667.0 9696.3 9719.6 9842.5 9956.6 10554.5 9292.1 9324.3 9351.1 9372.0 9581.9 9616.3 9715.7 9844.7 9850.6 9970.6 8804.5 8908.0 8992.3 9033.1 9164.0 8426.5 8844.2 8891.7 9067.1 9092.3 12:06:32 INFO - PROCESS | 32076 | -------- Summary: end -------- 12:06:32 INFO - PROCESS | 32076 | 12:06:33 INFO - TEST-INFO | 32076: exit 0 12:06:33 INFO - TEST-OK | dromaeo_css | took 1118196ms 12:06:33 INFO - TEST-START | kraken 12:06:33 INFO - operating with platform_type : linux_ 12:06:33 INFO - Initialising browser for kraken test... 12:06:33 INFO - TEST-INFO | started process 32259 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOOurpP/profile http://localhost:50747/getInfo.html) 12:06:37 INFO - PROCESS | 32259 | __metrics Screen width/height:1600/1200 12:06:37 INFO - PROCESS | 32259 | colorDepth:24 12:06:37 INFO - PROCESS | 32259 | Browser inner width/height: 1024/697 12:06:37 INFO - PROCESS | 32259 | __metrics 12:06:37 INFO - PROCESS | 32259 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:06:37 INFO - PROCESS | 32259 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:06:39 INFO - TEST-INFO | 32259: exit 0 12:06:39 INFO - Browser initialized. 12:06:39 INFO - Running cycle 1/1 for kraken test... 12:06:39 INFO - TEST-INFO | started process 32342 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOOurpP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:06:51 INFO - PROCESS | 32342 | RSS: Main: 149798912 12:06:51 INFO - PROCESS | 32342 | 12:06:53 INFO - PROCESS | 32342 | Cycle 1(1): loaded http://localhost:50747/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50747/tests/kraken/driver.html?testName=audio-beat-detection) 12:06:54 INFO - PROCESS | 32342 | RSS: Main: 186413056 12:06:54 INFO - PROCESS | 32342 | 12:06:57 INFO - PROCESS | 32342 | Cycle 1(1): loaded http://localhost:50747/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50747/tests/kraken/driver.html?testName=audio-dft) 12:06:57 INFO - PROCESS | 32342 | RSS: Main: 174727168 12:06:57 INFO - PROCESS | 32342 | 12:07:00 INFO - PROCESS | 32342 | Cycle 1(1): loaded http://localhost:50747/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50747/tests/kraken/driver.html?testName=audio-fft) 12:07:01 INFO - PROCESS | 32342 | RSS: Main: 161579008 12:07:01 INFO - PROCESS | 32342 | 12:07:03 INFO - PROCESS | 32342 | Cycle 1(1): loaded http://localhost:50747/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50747/tests/kraken/driver.html?testName=audio-oscillator) 12:07:03 INFO - PROCESS | 32342 | RSS: Main: 164352000 12:07:03 INFO - PROCESS | 32342 | 12:07:06 INFO - PROCESS | 32342 | Cycle 1(1): loaded http://localhost:50747/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50747/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:07:06 INFO - PROCESS | 32342 | RSS: Main: 166227968 12:07:06 INFO - PROCESS | 32342 | 12:07:09 INFO - PROCESS | 32342 | Cycle 1(1): loaded http://localhost:50747/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50747/tests/kraken/driver.html?testName=imaging-darkroom) 12:07:10 INFO - PROCESS | 32342 | RSS: Main: 165896192 12:07:10 INFO - PROCESS | 32342 | 12:07:13 INFO - PROCESS | 32342 | Cycle 1(1): loaded http://localhost:50747/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50747/tests/kraken/driver.html?testName=imaging-desaturate) 12:07:14 INFO - PROCESS | 32342 | RSS: Main: 167038976 12:07:14 INFO - PROCESS | 32342 | 12:07:17 INFO - PROCESS | 32342 | Cycle 1(1): loaded http://localhost:50747/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50747/tests/kraken/driver.html?testName=json-parse-financial) 12:07:17 INFO - PROCESS | 32342 | RSS: Main: 164929536 12:07:17 INFO - PROCESS | 32342 | 12:07:19 INFO - PROCESS | 32342 | Cycle 1(1): loaded http://localhost:50747/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50747/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:07:20 INFO - PROCESS | 32342 | RSS: Main: 174964736 12:07:20 INFO - PROCESS | 32342 | 12:07:21 INFO - PROCESS | 32342 | Cycle 1(1): loaded http://localhost:50747/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50747/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:07:22 INFO - PROCESS | 32342 | RSS: Main: 173772800 12:07:22 INFO - PROCESS | 32342 | 12:07:24 INFO - PROCESS | 32342 | Cycle 1(1): loaded http://localhost:50747/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50747/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:07:25 INFO - PROCESS | 32342 | RSS: Main: 187260928 12:07:25 INFO - PROCESS | 32342 | 12:07:27 INFO - PROCESS | 32342 | Cycle 1(1): loaded http://localhost:50747/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:07:28 INFO - PROCESS | 32342 | RSS: Main: 192864256 12:07:28 INFO - PROCESS | 32342 | 12:07:30 INFO - PROCESS | 32342 | Cycle 1(1): loaded http://localhost:50747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:07:31 INFO - PROCESS | 32342 | RSS: Main: 189820928 12:07:31 INFO - PROCESS | 32342 | 12:07:33 INFO - PROCESS | 32342 | Cycle 1(1): loaded http://localhost:50747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50747/tests/kraken/driver.html?testName=ai-astar) 12:07:33 INFO - PROCESS | 32342 | RSS: Main: 248737792 12:07:33 INFO - PROCESS | 32342 | 12:07:33 INFO - PROCESS | 32342 | __start_tp_report 12:07:33 INFO - PROCESS | 32342 | _x_x_mozilla_page_load 12:07:33 INFO - PROCESS | 32342 | _x_x_mozilla_page_load_details 12:07:33 INFO - PROCESS | 32342 | |i|pagename|runs| 12:07:33 INFO - PROCESS | 32342 | |0;ai-astar;115;114;108;114;116;113;107;115;116;119 12:07:33 INFO - PROCESS | 32342 | |1;audio-beat-detection;160;136;161;169;137;163;160;140;163;133 12:07:33 INFO - PROCESS | 32342 | |2;audio-dft;161;163;162;160;167;161;164;162;164;163 12:07:33 INFO - PROCESS | 32342 | |3;audio-fft;72;73;85;98;72;73;83;98;92;73 12:07:33 INFO - PROCESS | 32342 | |4;audio-oscillator;99;100;132;99;99;98;129;99;98;134 12:07:33 INFO - PROCESS | 32342 | |5;imaging-gaussian-blur;109;109;110;109;109;108;109;109;110;109 12:07:33 INFO - PROCESS | 32342 | |6;imaging-darkroom;147;146;146;147;146;147;146;147;147;146 12:07:33 INFO - PROCESS | 32342 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;96;96 12:07:33 INFO - PROCESS | 32342 | |8;json-parse-financial;70;71;70;70;71;71;70;80;68;71 12:07:33 INFO - PROCESS | 32342 | |9;json-stringify-tinderbox;66;67;67;68;68;68;67;68;68;67 12:07:33 INFO - PROCESS | 32342 | |10;stanford-crypto-aes;86;86;87;86;85;86;84;85;86;86 12:07:33 INFO - PROCESS | 32342 | |11;stanford-crypto-ccm;130;120;127;127;126;122;124;139;125;121 12:07:33 INFO - PROCESS | 32342 | |12;stanford-crypto-pbkdf2;137;139;149;149;149;137;148;149;156;139 12:07:33 INFO - PROCESS | 32342 | |13;stanford-crypto-sha256-iterative;72;69;70;71;70;70;71;72;70;70 12:07:33 INFO - PROCESS | 32342 | __end_tp_report 12:07:33 INFO - PROCESS | 32342 | __start_cc_report 12:07:33 INFO - PROCESS | 32342 | _x_x_mozilla_cycle_collect,1033 12:07:33 INFO - PROCESS | 32342 | __end_cc_report 12:07:33 INFO - PROCESS | 32342 | __startTimestamp1452024453579__endTimestamp 12:07:33 INFO - PROCESS | 32342 | 12:07:33 INFO - PROCESS | 32342 | ------- Summary: start ------- 12:07:33 INFO - PROCESS | 32342 | Number of tests: 14 12:07:33 INFO - PROCESS | 32342 | 12:07:33 INFO - PROCESS | 32342 | [#0] ai-astar Cycles:10 Average:113.70 Median:115.00 stddev:3.65 (3.2%) stddev-sans-first:3.84 12:07:33 INFO - PROCESS | 32342 | Values: 115.0 114.0 108.0 114.0 116.0 113.0 107.0 115.0 116.0 119.0 12:07:33 INFO - PROCESS | 32342 | 12:07:33 INFO - PROCESS | 32342 | [#1] audio-beat-detection Cycles:10 Average:152.20 Median:160.50 stddev:13.85 (8.6%) stddev-sans-first:14.40 12:07:33 INFO - PROCESS | 32342 | Values: 160.0 136.0 161.0 169.0 137.0 163.0 160.0 140.0 163.0 133.0 12:07:33 INFO - PROCESS | 32342 | 12:07:33 INFO - PROCESS | 32342 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:2.00 (1.2%) stddev-sans-first:2.03 12:07:33 INFO - PROCESS | 32342 | Values: 161.0 163.0 162.0 160.0 167.0 161.0 164.0 162.0 164.0 163.0 12:07:33 INFO - PROCESS | 32342 | 12:07:33 INFO - PROCESS | 32342 | [#3] audio-fft Cycles:10 Average:81.90 Median:84.00 stddev:10.88 (12.9%) stddev-sans-first:10.93 12:07:33 INFO - PROCESS | 32342 | Values: 72.0 73.0 85.0 98.0 72.0 73.0 83.0 98.0 92.0 73.0 12:07:33 INFO - PROCESS | 32342 | 12:07:33 INFO - PROCESS | 32342 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:98.50 stddev:15.90 (16.1%) stddev-sans-first:16.48 12:07:33 INFO - PROCESS | 32342 | Values: 99.0 100.0 132.0 99.0 99.0 98.0 129.0 99.0 98.0 134.0 12:07:33 INFO - PROCESS | 32342 | 12:07:33 INFO - PROCESS | 32342 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 12:07:33 INFO - PROCESS | 32342 | Values: 109.0 109.0 110.0 109.0 109.0 108.0 109.0 109.0 110.0 109.0 12:07:33 INFO - PROCESS | 32342 | 12:07:33 INFO - PROCESS | 32342 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 12:07:33 INFO - PROCESS | 32342 | Values: 147.0 146.0 146.0 147.0 146.0 147.0 146.0 147.0 147.0 146.0 12:07:33 INFO - PROCESS | 32342 | 12:07:33 INFO - PROCESS | 32342 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 12:07:33 INFO - PROCESS | 32342 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 12:07:33 INFO - PROCESS | 32342 | 12:07:33 INFO - PROCESS | 32342 | [#8] json-parse-financial Cycles:10 Average:71.20 Median:71.00 stddev:3.22 (4.5%) stddev-sans-first:3.39 12:07:33 INFO - PROCESS | 32342 | Values: 70.0 71.0 70.0 70.0 71.0 71.0 70.0 80.0 68.0 71.0 12:07:33 INFO - PROCESS | 32342 | 12:07:33 INFO - PROCESS | 32342 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.53 12:07:33 INFO - PROCESS | 32342 | Values: 66.0 67.0 67.0 68.0 68.0 68.0 67.0 68.0 68.0 67.0 12:07:33 INFO - PROCESS | 32342 | 12:07:33 INFO - PROCESS | 32342 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:86.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 12:07:33 INFO - PROCESS | 32342 | Values: 86.0 86.0 87.0 86.0 85.0 86.0 84.0 85.0 86.0 86.0 12:07:33 INFO - PROCESS | 32342 | 12:07:33 INFO - PROCESS | 32342 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:126.50 stddev:5.47 (4.3%) stddev-sans-first:5.61 12:07:33 INFO - PROCESS | 32342 | Values: 130.0 120.0 127.0 127.0 126.0 122.0 124.0 139.0 125.0 121.0 12:07:33 INFO - PROCESS | 32342 | 12:07:33 INFO - PROCESS | 32342 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.20 Median:149.00 stddev:6.61 (4.4%) stddev-sans-first:6.31 12:07:33 INFO - PROCESS | 32342 | Values: 137.0 139.0 149.0 149.0 149.0 137.0 148.0 149.0 156.0 139.0 12:07:33 INFO - PROCESS | 32342 | 12:07:33 INFO - PROCESS | 32342 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:70.50 stddev:0.97 (1.4%) stddev-sans-first:0.87 12:07:33 INFO - PROCESS | 32342 | Values: 72.0 69.0 70.0 71.0 70.0 70.0 71.0 72.0 70.0 70.0 12:07:33 INFO - PROCESS | 32342 | -------- Summary: end -------- 12:07:33 INFO - PROCESS | 32342 | 12:07:34 INFO - TEST-INFO | 32342: exit 0 12:07:34 INFO - TEST-OK | kraken | took 61137ms 12:07:34 INFO - TEST-START | v8_7 12:07:34 INFO - operating with platform_type : linux_ 12:07:34 INFO - Initialising browser for v8_7 test... 12:07:34 INFO - TEST-INFO | started process 32591 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpswkuAN/profile http://localhost:50747/getInfo.html) 12:07:38 INFO - PROCESS | 32591 | __metrics Screen width/height:1600/1200 12:07:38 INFO - PROCESS | 32591 | colorDepth:24 12:07:38 INFO - PROCESS | 32591 | Browser inner width/height: 1024/697 12:07:38 INFO - PROCESS | 32591 | __metrics 12:07:38 INFO - PROCESS | 32591 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:07:38 INFO - PROCESS | 32591 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:07:40 INFO - TEST-INFO | 32591: exit 0 12:07:40 INFO - Browser initialized. 12:07:40 INFO - Running cycle 1/1 for v8_7 test... 12:07:40 INFO - TEST-INFO | started process 32677 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpswkuAN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:07:52 INFO - PROCESS | 32677 | RSS: Main: 149889024 12:07:52 INFO - PROCESS | 32677 | 12:08:13 INFO - PROCESS | 32677 | Cycle 1(1): loaded http://localhost:50747/tests/v8_7/run.html (next: http://localhost:50747/tests/v8_7/run.html) 12:08:13 INFO - PROCESS | 32677 | RSS: Main: 447172608 12:08:13 INFO - PROCESS | 32677 | 12:08:13 INFO - PROCESS | 32677 | __start_tp_report 12:08:13 INFO - PROCESS | 32677 | _x_x_mozilla_page_load 12:08:13 INFO - PROCESS | 32677 | _x_x_mozilla_page_load_details 12:08:13 INFO - PROCESS | 32677 | |i|pagename|runs| 12:08:13 INFO - PROCESS | 32677 | |0;Richards;167.64459346186086 12:08:13 INFO - PROCESS | 32677 | |1;DeltaBlue;187.79342723004694 12:08:13 INFO - PROCESS | 32677 | |2;Encrypt;278.6291446085261 12:08:13 INFO - PROCESS | 32677 | |3;Decrypt;5181.347150259067 12:08:13 INFO - PROCESS | 32677 | |4;RayTrace;2018.1451612903227 12:08:13 INFO - PROCESS | 32677 | |5;Earley;811.6883116883117 12:08:13 INFO - PROCESS | 32677 | |6;Boyer;12280.487804878048 12:08:13 INFO - PROCESS | 32677 | |7;RegExp;27297.297297297297 12:08:13 INFO - PROCESS | 32677 | |8;Splay;612.7450980392157 12:08:13 INFO - PROCESS | 32677 | |9;NavierStokes;4882.926829268293 12:08:13 INFO - PROCESS | 32677 | __end_tp_report 12:08:13 INFO - PROCESS | 32677 | __startTimestamp1452024493852__endTimestamp 12:08:13 INFO - PROCESS | 32677 | 12:08:13 INFO - PROCESS | 32677 | ------- Summary: start ------- 12:08:13 INFO - PROCESS | 32677 | Number of tests: 10 12:08:13 INFO - PROCESS | 32677 | 12:08:13 INFO - PROCESS | 32677 | [#0] Richards Cycles:1 Average:167.64 Median:167.64 stddev:0.00 (0.0%) 12:08:13 INFO - PROCESS | 32677 | Values: 167.6 12:08:13 INFO - PROCESS | 32677 | 12:08:13 INFO - PROCESS | 32677 | [#1] DeltaBlue Cycles:1 Average:187.79 Median:187.79 stddev:0.00 (0.0%) 12:08:13 INFO - PROCESS | 32677 | Values: 187.8 12:08:13 INFO - PROCESS | 32677 | 12:08:13 INFO - PROCESS | 32677 | [#2] Encrypt Cycles:1 Average:278.63 Median:278.63 stddev:0.00 (0.0%) 12:08:13 INFO - PROCESS | 32677 | Values: 278.6 12:08:13 INFO - PROCESS | 32677 | 12:08:13 INFO - PROCESS | 32677 | [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 12:08:13 INFO - PROCESS | 32677 | Values: 5181.3 12:08:13 INFO - PROCESS | 32677 | 12:08:13 INFO - PROCESS | 32677 | [#4] RayTrace Cycles:1 Average:2018.15 Median:2018.15 stddev:0.00 (0.0%) 12:08:13 INFO - PROCESS | 32677 | Values: 2018.1 12:08:13 INFO - PROCESS | 32677 | 12:08:13 INFO - PROCESS | 32677 | [#5] Earley Cycles:1 Average:811.69 Median:811.69 stddev:0.00 (0.0%) 12:08:13 INFO - PROCESS | 32677 | Values: 811.7 12:08:13 INFO - PROCESS | 32677 | 12:08:13 INFO - PROCESS | 32677 | [#6] Boyer Cycles:1 Average:12280.49 Median:12280.49 stddev:0.00 (0.0%) 12:08:13 INFO - PROCESS | 32677 | Values: 12280.5 12:08:13 INFO - PROCESS | 32677 | 12:08:13 INFO - PROCESS | 32677 | [#7] RegExp Cycles:1 Average:27297.30 Median:27297.30 stddev:0.00 (0.0%) 12:08:13 INFO - PROCESS | 32677 | Values: 27297.3 12:08:13 INFO - PROCESS | 32677 | 12:08:13 INFO - PROCESS | 32677 | [#8] Splay Cycles:1 Average:612.75 Median:612.75 stddev:0.00 (0.0%) 12:08:13 INFO - PROCESS | 32677 | Values: 612.7 12:08:13 INFO - PROCESS | 32677 | 12:08:13 INFO - PROCESS | 32677 | [#9] NavierStokes Cycles:1 Average:4882.93 Median:4882.93 stddev:0.00 (0.0%) 12:08:13 INFO - PROCESS | 32677 | Values: 4882.9 12:08:13 INFO - PROCESS | 32677 | -------- Summary: end -------- 12:08:13 INFO - PROCESS | 32677 | 12:08:14 INFO - TEST-INFO | 32677: exit 0 12:08:14 INFO - TEST-OK | v8_7 | took 40224ms 12:08:14 INFO - SUITE-END | took 1219s 12:08:14 INFO - Completed test suite (00:20:19) 12:08:14 INFO - Working with test: dromaeo_css 12:08:14 INFO - Generating results file: dromaeo_css 12:08:14 INFO - Working with test: kraken 12:08:14 INFO - Generating results file: kraken 12:08:14 INFO - javascript benchmark 12:08:14 INFO - Working with test: v8_7 12:08:14 INFO - Generating results file: v8_7 12:08:14 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:08:14 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 12:08:14 INFO - process_Request line: dromaeo_css 6140.87 graph.html#tests=[[72,132,35]] 12:08:14 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:08:14 INFO - process_Request line: kraken 1536.20 graph.html#tests=[[232,132,35]] 12:08:14 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:08:14 INFO - process_Request line: v8_7 19594.22 graph.html#tests=[[230,132,35]] 12:08:15 INFO - RETURN: dromaeo_css: 6140.87 12:08:15 INFO - RETURN: kraken: 1536.20 12:08:15 INFO - RETURN: v8_7: 19594.22 12:08:15 INFO - javascript benchmark 12:08:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2583.0830055330352, 2683.235277945786, 2700.743429374209, 2700.864956752162, 2717.850518221498, 4398.912021759571, 4512.278035514319, 4578.771061446931, 4587.885302867426, 4594.540545945404, 4556.0, 4581.31280307954, 4611.538846115395, 4623.514530974249, 4643.214071557064, 4198.8320467181275, 4220.767857767822, 4281.9357709634305, 4318.827246910136, 4340.587644173815, 4086.080631857823, 4297.05464797744, 4316.20150272199, 4350.56494350564, 4363.650907927358, 4151.501819781615, 4178.080822219137, 4181.456410666594, 4253.936190957138, 4260.573942605745, 4174.31123864562, 4180.331147016494, 4194.643455306303, 4213.199492096523, 4234.809433575497, 4087.3664581989838, 4157.91684166318, 4177.143685544456, 4179.665626749853, 4211.4946206455115, 4430.490493593245, 4434.268345722952, 4436.268015777393, 4554.567316104964, 4595.149897268982, 4882.36529251195, 4917.950820491785, 4922.729249891255, 4925.088858561177, 4964.801407943678, 4750.501197374295, 4940.6788558743565, 4946.480619534969, 4953.455119936804, 4996.075725990703, 4495.730256184606, 4506.098780243964, 4532.5694059065, 4594.97702511492, 4656.371389862393, 5061.569766569883, 5072.442031376546, 5080.983803239367, 5081.2378143278065, 5087.109755792721, 4639.373684552542, 4872.926906096412, 4881.316615673809, 4883.731394773322, 4921.655484116149, 4774.3077253798, 4779.713217206979, 4873.342098816685, 4920.6555541111775, 4922.630802689741, 4770.880727981828, 4792.0, 4802.27965805125, 4810.927836082462, 4834.419869615669, 4618.584327410549, 4765.9046819064115, 4776.020915712271, 4779.30700048498, 4817.205161148371, 3975.7018223633345, 4043.8786836394956, 4116.91766164681, 4135.421041054255, 4153.563875793058, 3617.3488772021287, 3620.6560376764164, 3621.6921561667555, 3630.2739452109686, 3642.1076836174775, 4084.3873418986796, 4277.101808620162, 4280.850170244026, 4281.529031806499, 4322.7190232634775, 4839.927401088987, 4873.074115917964, 4888.364512613409, 4973.950260497421, 5012.398512178562, 4252.468441444819, 4262.295081967163, 4272.487301523837, 4289.721168124062, 4325.9134817303475, 4201.369794530845, 4386.298192289219, 4394.604485596312, 4399.604035636744, 4426.911461770746, 4608.654350923761, 4631.536846315342, 4632.305154226893, 4637.1421287062, 4757.0, 4953.7523123844385, 4959.628027897994, 4967.03142887148, 4970.304157417892, 5022.949770502249, 4704.717716936994, 4711.293306004127, 4714.127886340901, 4734.384530011076, 4763.54746299101, 4660.067986402801, 4773.64197685182, 4791.9281210782565, 4894.828680996148, 4934.55588996992, 4878.195097808822, 4964.131277026434, 4985.52637499437, 4989.975050124726, 5033.748312584283, 4787.281907713871, 4818.4217893852965, 4820.590249828804, 4831.830885918976, 4865.1242776300605, 4598.0, 4707.035057813072, 4709.270063140219, 4828.155072862165, 4862.562369386772, 4551.635869130396, 4596.0, 4616.146012987608, 4735.668503204881, 4765.475797662324, 4832.347633069631, 4833.564979151753, 4854.0, 4855.320255164351, 4884.65807393479, 4737.336772851734, 4737.952620473889, 4739.0, 4739.7867095981455, 4790.0419916016235], "unit": "score", "name": "dojo.html", "value": 4505.8860896666865}, {"lowerIsBetter": false, "replicates": [505.5071305477158, 512.0118171928182, 516.3519782672745, 535.6571794051806, 547.8027909952414, 24782.75217247827, 25160.874195629043, 25165.119220827273, 25176.87411562942, 25219.0, 25546.233612991593, 32213.19467013326, 32645.347093058124, 32656.0, 32775.344493110126, 7619.238076192378, 7694.576798276093, 7696.345810606105, 7775.533467991939, 7779.455438119334, 6932.098827152463, 7111.928880711178, 7482.326590606845, 7591.81020474487, 7604.0875094988405, 9767.120959113678, 9991.350562213469, 9991.500424978758, 9991.950040249789, 9994.90005099947, 9581.137697607213, 9684.322097453181, 9696.0788725071, 9709.417434953926, 9709.611615535336, 6946.895796563055, 7121.145462544528, 9464.716058518256, 9521.476318802463, 9724.611015559369, 32249.0, 32683.0, 32722.509162362585, 32824.83587582071, 32921.6707832921, 2745.409736906575, 2799.244204064891, 2887.985560072186, 3363.747718921091, 3402.2004828865197, 26229.0, 26516.60225096625, 26711.19866404011, 26714.332141696417, 27177.86411067932, 3441.7934923904645, 3473.774204676688, 3490.6683865033037, 3515.771474854152, 3554.964450355515, 214493.0, 216332.0, 216787.0, 217310.99999999843, 217614.0, 53772.73113634407, 54227.45772542303, 54266.728666356415, 54301.72849135729, 54305.185422218696, 49710.75144624326, 50742.0, 58116.0, 58502.70748646229, 60323.39676603265, 12847.586765455793, 13051.412686429134, 13071.673208169872, 13108.279044652445, 13130.146540474838, 9576.467765157542, 9698.127168554864, 9700.90299097014, 9702.951485242529, 9707.854382184272, 17943.282268709365, 18139.183736731615, 18235.817641823676, 18240.543986400447, 18273.45179644586, 7213.89179162313, 7453.217412171753, 7496.662650180755, 7540.509866858746, 7595.506292090997, 790.4980337485738, 862.2326129744532, 874.6676263020012, 901.3825529512305, 953.3850666320185, 26026.86986565055, 27556.586651200247, 29010.0, 29070.563941540895, 31724.0, 881.352206128495, 907.2288554728428, 915.4507295622707, 923.7136487688838, 929.4098247612679, 13088.672783180496, 13089.280089595164, 13232.19134898461, 13315.0, 13382.866171338357, 317981.0, 325150.0, 325627.0, 325912.0, 326045.0, 45319.32021019687, 45864.77067614641, 45866.541334586225, 45891.311630325574, 46289.5371046292, 1082.9729256768644, 1141.760230351619, 1146.4439746722999, 1155.6590805712335, 1249.1006475337742, 23329.0, 23686.763132368455, 24353.756462435147, 27173.59239611368, 29019.0, 39688.206235874546, 42111.36832947447, 42848.57151428446, 42877.78561107299, 42976.14047719091, 233250.0, 234093.0, 236862.0, 237883.0, 238159.0, 37815.43276850905, 38065.23869522649, 38229.0, 38235.0, 38404.80797595994, 41037.38443923403, 41082.0, 41317.1736565273, 41359.37960930528, 41965.0, 33345.83327083349, 33824.49263261004, 34570.0, 34617.65382346144, 35072.82463587768, 30008.549871752377, 30078.0, 30140.84929575426, 30358.392832142792, 30421.197350331207, 30470.390592188476, 35179.824100879334, 35545.644543554234, 35690.46464303089, 35693.46459803053, 25956.35109122287, 27714.168574942785, 28001.0, 28006.159815205578, 28047.579286310312, 21543.56912861765, 21891.67162492596, 22025.449363766034, 22034.88982555077, 22038.779612203674], "unit": "score", "name": "ext.html", "value": 16625.85677072018}, {"lowerIsBetter": false, "replicates": [315.760022382989, 318.1989936956825, 325.21298457732286, 331.30702112206626, 332.106633156808, 12155.696107597314, 12558.937205313983, 14528.200948947817, 14888.106713597179, 15011.249437528135, 9907.356021858574, 10066.899331006687, 10194.898051019487, 14989.325480353384, 15399.384024639028, 4425.933610995829, 4537.115262523809, 4538.251188553884, 4539.024109816389, 4540.091981603676, 3343.9665603343897, 3438.157651375404, 4703.976480117594, 6178.8455288617915, 6406.519511036668, 6324.209473815773, 6395.424411802936, 6405.071264666621, 6439.710213040401, 6439.903401448982, 6424.775132870351, 6435.324290949429, 6445.0, 6506.056621789838, 6520.836979075538, 6112.602680825732, 6231.750729970796, 6245.281792593864, 6245.937540624581, 6270.46701030413, 17632.382866599608, 19784.0, 20338.898305508526, 21275.36173914785, 21557.89221053885, 1844.0779610194902, 1860.2837907405747, 1893.6780747272996, 1932.3526618582791, 1954.853385996056, 13583.52457663977, 13754.862451375458, 13818.447262109503, 13914.09558378702, 14067.648308792259, 1871.2889102141235, 1899.2782742557877, 1906.3804263614243, 1907.6661584222845, 1927.7204805303293, 57613.71193144008, 60901.6954915227, 60946.695266523384, 61238.38761612416, 61927.0, 15138.243087845563, 15186.848131518544, 15240.390384384722, 15262.542123736306, 15296.0, 22381.0, 22779.316620501413, 22835.31494055181, 22877.656835147485, 22915.0, 8157.510549366938, 8234.694285600042, 8244.793880153044, 8268.710595129141, 8292.212239837207, 6763.526553141233, 6796.558223715443, 6808.6255255960405, 6814.182298124158, 6849.0, 7333.633318334062, 7385.3722433592675, 7411.518251313755, 7417.0, 7418.0, 1668.1325710630404, 1703.3867807589259, 1705.1303835044216, 1725.2495164603188, 2133.7730804786997, 353.38510990876205, 360.7817270551331, 367.2398135858747, 837.5226121111031, 860.1484530314943, 7810.375169986388, 9322.95338523303, 9450.243980481682, 9543.188828949478, 9643.614255429704, 376.8266597365243, 380.3894748927986, 808.6926967752216, 808.8382323535317, 828.9502629842108, 8732.91267087321, 9004.0, 9235.58439870194, 9377.812443751223, 9422.104900034486, 514365.0, 520334.0, 526725.0, 530202.9797020344, 535707.0, 66290.66854665696, 69107.65446172738, 70395.2960470399, 70422.29577704157, 70562.0, 1089.8801131875487, 1090.5583238788304, 1093.2507987220542, 1117.5473933057124, 1118.1781390677845, 14317.427302907767, 14453.49412770548, 14623.341949612506, 14631.634209144857, 14734.63163420923, 31508.527372088978, 32135.839320803247, 32162.83918580392, 32411.837940810146, 32960.1759956003, 41612.0, 44460.33309500425, 44760.0, 45029.09941801211, 45232.0, 8809.678548217818, 8952.820943581222, 8992.46045237288, 9059.728208153765, 9064.365494415328, 10313.22650801208, 14957.551273461813, 15345.462908798585, 15682.529524114294, 15720.213989300719, 12843.807342889677, 12853.678658033625, 12980.805287920877, 13244.933775331061, 13516.391762370913, 10464.11055060298, 11771.293722376684, 12732.108752387245, 13170.07809453329, 14078.577642670736, 12184.57353992606, 13104.868951310365, 13136.671583210114, 13714.451421943011, 13923.930380348034, 8322.334213263046, 8325.292350150063, 8405.15948405179, 8432.283255923316, 8434.493930364199, 9014.549272536478, 9340.392874463138, 12598.118131730691, 13189.340532973505, 13214.801777973531], "unit": "score", "name": "jquery.html", "value": 8523.670679119723}, {"lowerIsBetter": false, "replicates": [1190.1966172833336, 1277.827493288406, 1303.1920209470127, 1312.6455856918633, 1623.2370785730702, 5670.71646417679, 6415.101885736, 6478.125453063835, 6526.6736663166885, 6546.3126371731, 6416.9358306416925, 6615.23924748654, 6618.768343107992, 6621.0, 6635.900461493069, 1971.8028197180274, 2004.7995200479982, 2009.5076706206926, 2009.6382651122792, 2010.2260629657542, 1975.664137096697, 2009.5980803839218, 2017.5561376497146, 2022.7471566054244, 2028.421899758569, 1971.714101455288, 1993.9700904486444, 2013.013623324575, 2021.3834780391974, 2030.6344857925642, 1989.4827344890289, 2007.15699406249, 2012.0643900586151, 2018.8485863560293, 2020.3635854705867, 1965.852561057912, 1978.8120128587905, 1985.1166231027198, 1987.1455274232073, 1995.4712001319663, 6631.10480085192, 6788.015737718003, 6800.081988931481, 6805.489588280899, 6812.0, 3867.0719027433493, 3904.629060239301, 3911.8044097794996, 3921.627445392683, 3930.2925473414775, 2417.7098748150333, 2466.691663542057, 2484.689413823272, 2509.8117641176987, 2510.1214574898822, 779.3570304498754, 792.5918152151646, 800.6437135474716, 807.5760225881401, 808.0061524325055, 8567.100454452255, 8633.827323453559, 8645.221930026264, 8652.307815374756, 8666.090060543615, 3552.609212986569, 3559.875404360835, 3604.936543719609, 3608.4767708682093, 3613.4941108244866, 7587.62061896914, 7594.81012974669, 7601.847963040708, 7610.0, 7624.008878845714, 3937.3897045957924, 3944.60553944609, 3952.3676211805973, 3954.8220330085214, 3956.3076461619676, 3078.553609726577, 3111.5643809866638, 3582.731295152874, 3597.5503062117236, 3612.313660404515, 3281.0812972367776, 3287.474004159323, 3319.883804066846, 3320.8505617247283, 3332.283559034819, 1000.1548691355792, 1008.7831116310028, 1011.0647650922867, 1015.674984005126, 1021.1473419694489, 831.9292860106838, 834.3408707121428, 834.390894646899, 1002.6490728245202, 1143.5368675686361, 6240.563160578716, 6326.051092336186, 6400.423961843457, 6414.486841052704, 6435.613863168225, 418.4580967646905, 422.51832910482074, 426.46052743279773, 428.96782741294527, 433.20074462616424, 4742.620590352763, 4784.449788274393, 4788.0, 4791.47293797682, 4797.592204662573, 7703.499272547267, 7781.572013539197, 7887.566183859828, 8028.197180282042, 8036.0, 7787.338076263468, 7789.1821358756515, 7793.532388056735, 7794.142644309121, 7797.064352277763, 6231.065340199007, 6300.558960872787, 6342.841428964312, 6372.044193370939, 6372.681365931685, 5841.591088623755, 6183.165272688129, 6203.96898015507, 6205.22434695663, 6206.193194884636, 7068.5758854468895, 7087.078679771596, 7189.712411503481, 7245.275472452712, 7267.600281984542, 7230.855382892208, 7349.301816327654, 7422.0, 7450.105987281561, 7452.701891924262, 4891.828785992473, 4992.550670439678, 5777.595568310178, 5829.53363730892, 5845.240118784531, 6129.754809807736, 6169.290531588925, 6205.317415084427, 6245.843853903689, 6258.155149054819, 5761.078227483583, 5908.350081490947, 5940.16837642739, 5962.135490353961, 6051.394860513913, 5774.82675519735, 5853.853653658693, 5920.940790592039, 5932.139839723302, 5936.28764548257, 5845.830833833335, 5853.560982926383, 5886.23478947734, 6068.21113255274, 6081.27024757032, 5448.972755136199, 5536.335639723259, 5543.445655434424, 5546.334439867242, 5547.44525547442, 5581.10702287632, 5590.105583106683, 5601.103823388238, 5614.21401003868, 5615.213870058114], "unit": "score", "name": "mootools.html", "value": 3714.6865907915676}, {"lowerIsBetter": false, "replicates": [283.5788853552474, 287.47679223812656, 290.0862283806011, 302.2745411013567, 302.3846472428608, 5282.128448805943, 5291.68249905006, 5338.345113014968, 5352.411234764178, 5389.056915039872, 5246.1606143017125, 5281.656692314997, 5281.947180528194, 5288.101022826119, 5290.100682883909, 4102.569230230828, 4106.79466026699, 4115.979420102895, 4127.133302006582, 4128.112455821998, 3888.572257051722, 3978.204359128186, 3982.9203415931665, 4039.353703407455, 4124.958750412503, 4078.877633670995, 4091.2226676931436, 4095.1604920991126, 4105.117399759051, 4107.055377263231, 4085.407615895693, 4086.080631857838, 4087.3255912774357, 4095.4061661059277, 4097.938530922039, 3348.631650518441, 3452.4993875887853, 3530.38218311797, 3609.729270304738, 3623.673869351771, 5127.307813445174, 5131.179011358202, 5140.768665410065, 5142.717150556718, 5146.305248791403, 4728.71627702339, 4734.26618874075, 4734.479207287196, 4736.9526304736855, 4740.0, 5570.582206334541, 5580.91628625571, 5583.972080139573, 5586.692731899744, 5589.0219211638205, 3696.704263658901, 3865.130345672201, 3878.108035151931, 3881.8253178606747, 3884.9028774280587, 5836.5914385993, 5889.85275368115, 5931.73307201177, 5935.73289201987, 5936.436038576328, 3938.6455219029854, 3957.5448823385677, 3961.564227934925, 3970.50368703912, 3971.5829837867186, 4023.6982226332557, 4038.1318016626565, 4040.1313717550865, 4041.595840415935, 4041.7574945503366, 4473.776311184428, 4638.002829391697, 4648.070385922829, 4661.557152070548, 4670.276107203321, 5604.579656525777, 5613.915791263134, 5615.691136987505, 5616.634918730269, 5617.045102332613, 1390.7496650602989, 1427.0510110776218, 1427.6288165077156, 1428.264443811438, 1428.292994967477, 928.007032475245, 930.3580529434669, 945.9763505912407, 954.3939598355095, 955.4744890310302, 4955.603551715854, 4972.428170760337, 4978.178600530872, 4982.576480999083, 4984.501549844987, 5853.88292234153, 5854.414558544111, 5859.2090067841145, 5859.912101318484, 5863.67749773758, 4953.0, 4956.553910148104, 4970.378702662168, 4970.428400733889, 4977.726225057657, 3049.420610084077, 3106.378724255158, 3153.0068028570927, 3153.4639111351125, 3157.463231250693, 5317.946820531823, 5403.756830942617, 5486.478784515464, 5552.944470555323, 5608.411116832755, 6060.33336333003, 6068.180795592627, 6077.088436734525, 6082.482988945989, 6091.939080609226, 5595.63628364155, 5600.299962504687, 5621.74702138413, 5631.465010823965, 5658.179563963202, 5689.800856969986, 5857.882842343214, 5877.4122587740885, 5891.941080589139, 5899.056151015817, 5723.542116630576, 5724.771009159587, 5731.0, 5733.283339582552, 5738.311402631711, 5585.888282234414, 5587.664740115606, 5591.4688104629995, 5594.944050559605, 5604.327480702342, 3973.5430425501436, 3997.5602683704187, 4016.6184212499766, 4017.5379831319774, 4023.8994025149605, 5724.914126288026, 5843.152742852348, 5882.382349853204, 5887.941120588911, 5891.1457838614015, 5618.044932361427, 5643.294588176478, 5656.632318899258, 5668.26312579362, 5678.3186017678145, 5641.548676105984, 5670.064439367623, 5673.858153546194, 5675.57433192504, 5680.233168522197, 5426.158945363475, 5561.304836895388, 5561.6663000220115, 5580.553555715452, 5582.162675598693, 5703.714814259188, 5712.0860662293835, 5721.056025755704, 5722.799702010409, 5724.141378793048, 5576.052071147996, 5578.330600327987, 5584.609077364546, 5588.524975377139, 5595.328560572757], "unit": "score", "name": "prototype.html", "value": 4206.172077875344}, {"lowerIsBetter": false, "replicates": [663.4957432351412, 705.5413980912408, 746.5110352718967, 749.5540153608605, 758.9810254743634, 10398.688039358822, 10599.364038157715, 10607.31052481588, 10607.416592087442, 10610.257281990263, 10211.48942552873, 10234.488275586209, 10241.23190760694, 10256.538455769489, 11427.42862856858, 608.1000119822643, 612.7793994162121, 612.7824622259101, 614.6189362595197, 617.2038070888559, 741.3772431157853, 741.4624397311933, 741.8293792427745, 745.9701611935516, 755.3126654744184, 763.0500027465813, 767.9040119985002, 769.8575763483746, 775.14733792828, 783.4046124945054, 759.9240075992384, 762.0360244290977, 767.2136060537938, 781.5232708048086, 785.5365334452644, 575.0368133376619, 576.5445298214405, 577.1717585265158, 577.5725962787549, 577.711144427786, 11132.387718675469, 11140.832887506695, 11195.720106997309, 11253.099752019818, 11262.718432039183, 10482.68551943443, 10806.891931080667, 10812.026917577456, 10869.347839129678, 11365.431728413547, 8451.70419035337, 8667.869981950276, 8682.652693892236, 8728.03991560934, 9010.774730631787, 3122.73456756176, 3168.30297334586, 3173.5557022016937, 3190.7128358447617, 3222.7099561039618, 33992.32015359704, 34367.82816085903, 37582.8120859394, 38388.232235355135, 39412.40881386781, 8820.162084601952, 8841.778955526162, 8899.288056955427, 8930.642774288955, 8931.866022009675, 15177.924110379377, 15429.691406172038, 15437.30532126057, 15452.38190472391, 15454.613634659, 6236.875262494725, 6283.120363149163, 6293.842653933688, 6296.212973378328, 6492.318306577836, 3566.3402270580027, 3653.0319465341704, 3654.744167908274, 3656.1590834108306, 3719.9956011876643, 2433.6471211674207, 2470.518248941439, 2474.74015228402, 2483.3543278747293, 2501.3996640806076, 452.3305507848403, 456.0150075836178, 456.8583739040908, 456.8720758187713, 457.99542004580195, 437.91241751649795, 443.2641814587769, 464.9070185962821, 522.2062465053098, 551.3328872064766, 6591.901121483182, 7152.856942861114, 7189.964050179716, 7198.460115491359, 7379.926200737924, 455.9908801823945, 484.5905210097462, 509.3785581590454, 554.9218177923622, 555.0508630242331, 3279.5900512435946, 3362.36115138123, 3377.257003459235, 3396.23584693442, 3478.9652103479148, 50119.49880501221, 50575.49424505782, 50615.0, 50727.0, 50851.237231441555, 42132.789336053735, 43281.35077973833, 43669.0, 44031.339529907076, 44805.55194448079, 36160.63839361625, 41381.37927931084, 41771.16457670891, 41865.58134418617, 41880.79059604683, 7540.622968851645, 7622.847543049219, 7819.061712594297, 7919.445638805229, 8039.1156972734125, 30321.696783031886, 30590.08229753111, 31061.8446907764, 31089.222769430944, 32313.35373292568, 36377.636223637426, 38626.6137338623, 38981.80509097436, 39168.0, 39214.80392598019, 8973.50645714492, 9148.359614826899, 9175.587098580447, 9270.212031977357, 9355.625774969198, 10472.528736207041, 10485.37087774736, 10492.213084018882, 10605.681829545127, 10667.0, 9696.272779541703, 9719.562619682272, 9842.507874606385, 9956.601735930772, 10554.525046372779, 9292.117248861347, 9324.300677449353, 9351.111644393772, 9371.953140234255, 9581.904180958101, 9616.326857119935, 9715.70852874415, 9844.704658860246, 9850.556724947251, 9970.55132519024, 8804.515751633466, 8907.955460222658, 8992.28061755045, 9033.051529589562, 9164.037776033421, 8426.4944103354, 8844.159804818531, 8891.656288916563, 9067.09329067088, 9092.318076144184], "unit": "score", "name": "yui.html", "value": 5374.399152530003}], "name": "dromaeo_css", "value": 6140.871644791555}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 114.0, 108.0, 114.0, 116.0, 113.0, 107.0, 115.0, 116.0, 119.0], "unit": "score", "name": "ai-astar", "value": 113.7}, {"lowerIsBetter": true, "replicates": [160.0, 136.0, 161.0, 169.0, 137.0, 163.0, 160.0, 140.0, 163.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 152.2}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 162.0, 160.0, 167.0, 161.0, 164.0, 162.0, 164.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.7}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 85.0, 98.0, 72.0, 73.0, 83.0, 98.0, 92.0, 73.0], "unit": "score", "name": "audio-fft", "value": 81.9}, {"lowerIsBetter": true, "replicates": [99.0, 100.0, 132.0, 99.0, 99.0, 98.0, 129.0, 99.0, 98.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 108.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 70.0, 70.0, 71.0, 71.0, 70.0, 80.0, 68.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 71.2}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 68.0, 68.0, 68.0, 67.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 87.0, 86.0, 85.0, 86.0, 84.0, 85.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [130.0, 120.0, 127.0, 127.0, 126.0, 122.0, 124.0, 139.0, 125.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.1}, {"lowerIsBetter": true, "replicates": [137.0, 139.0, 149.0, 149.0, 149.0, 137.0, 148.0, 149.0, 156.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.2}, {"lowerIsBetter": true, "replicates": [72.0, 69.0, 70.0, 71.0, 70.0, 70.0, 71.0, 72.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.5}], "name": "kraken", "value": 1536.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.64459346186086], "unit": "score", "name": "Richards", "value": 210.57643000000002}, {"lowerIsBetter": false, "replicates": [187.79342723004694], "unit": "score", "name": "DeltaBlue", "value": 352.0783499999999}, {"lowerIsBetter": false, "replicates": [278.6291446085261], "unit": "score", "name": "Encrypt", "value": 955.3236090000001}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [2018.1451612903227], "unit": "score", "name": "RayTrace", "value": 366.667876123876}, {"lowerIsBetter": false, "replicates": [811.6883116883117], "unit": "score", "name": "Earley", "value": 821.0824160000001}, {"lowerIsBetter": false, "replicates": [12280.487804878048], "unit": "score", "name": "Boyer", "value": 54.27007547169812}, {"lowerIsBetter": false, "replicates": [27297.297297297297], "unit": "score", "name": "RegExp", "value": 33.37271782178218}, {"lowerIsBetter": false, "replicates": [612.7450980392157], "unit": "score", "name": "Splay", "value": 132.99331200000003}, {"lowerIsBetter": false, "replicates": [4882.926829268293], "unit": "score", "name": "NavierStokes", "value": 303.91608391608383}], "name": "v8_7", "value": 19594.223299449557}]} 12:08:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19594.22"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1536.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6140.87"}}} 12:08:15 INFO - Return code: 0 12:08:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:08:15 INFO - # TBPL SUCCESS # 12:08:15 INFO - Running post-action listener: _resource_record_post_action 12:08:15 INFO - Running post-run listener: _resource_record_post_run 12:08:16 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 0; Write bytes: 546324480; Read time: 0; Write time: 386720 12:08:16 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 231387136; Read time: 0; Write time: 212040 12:08:16 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 0; Write bytes: 314937344; Read time: 0; Write time: 174680 12:08:16 INFO - Running post-run listener: _upload_blobber_files 12:08:16 INFO - Blob upload gear active. 12:08:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:08:16 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 12:08:16 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:08:16 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:08:16 INFO - (blobuploader) - INFO - Open directory for files ... 12:08:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:08:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:08:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:17 INFO - (blobuploader) - INFO - Done attempting. 12:08:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:08:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:08:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:18 INFO - (blobuploader) - INFO - Done attempting. 12:08:18 INFO - (blobuploader) - INFO - Iteration through files over. 12:08:18 INFO - Return code: 0 12:08:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:08:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:08:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dc211ed30fe496468806d4bc78d303254edb9a11edfa7ca94edf9e3af1cb833440a6a94500158c468d180f65631c900ed55aee88f4dfda0c131f682223434a4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/140d85f04375ecaf72863196d17682607307ae6ea6a900e05e1369741308b0149b308efa9c88266ec6201fae0fabaf0b343a71280367e62fedffe51ef3a5513f"} 12:08:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:08:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:08:18 INFO - Contents: 12:08:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dc211ed30fe496468806d4bc78d303254edb9a11edfa7ca94edf9e3af1cb833440a6a94500158c468d180f65631c900ed55aee88f4dfda0c131f682223434a4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/140d85f04375ecaf72863196d17682607307ae6ea6a900e05e1369741308b0149b308efa9c88266ec6201fae0fabaf0b343a71280367e62fedffe51ef3a5513f"} 12:08:18 INFO - Copying logs to upload dir... 12:08:18 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1286.811716 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-01-05 12:08:17.857996) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 12:08:17.862934) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1452019095.232496-1284594825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dc211ed30fe496468806d4bc78d303254edb9a11edfa7ca94edf9e3af1cb833440a6a94500158c468d180f65631c900ed55aee88f4dfda0c131f682223434a4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/140d85f04375ecaf72863196d17682607307ae6ea6a900e05e1369741308b0149b308efa9c88266ec6201fae0fabaf0b343a71280367e62fedffe51ef3a5513f"} build_url:https://queue.taskcluster.net/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011197 build_url: 'https://queue.taskcluster.net/v1/task/Mgq8ouDWSJ2r0UoYI8SJ-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dc211ed30fe496468806d4bc78d303254edb9a11edfa7ca94edf9e3af1cb833440a6a94500158c468d180f65631c900ed55aee88f4dfda0c131f682223434a4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/140d85f04375ecaf72863196d17682607307ae6ea6a900e05e1369741308b0149b308efa9c88266ec6201fae0fabaf0b343a71280367e62fedffe51ef3a5513f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 12:08:17.890009) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 12:08:17.890361) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1452019095.232496-1284594825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 12:08:17.971346) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 12:08:17.974698) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 12:08:17.975022) ========= ========= Total master_lag: 0.28 =========