builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-030 starttime: 1450826807.29 results: success (0) buildid: 20151222145526 builduid: 8f74816a8deb4e7e9514cbe5a098c421 revision: 5c7d3bb49bee4bc49b9a3e0be8aedafa6ced283b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 15:26:47.286779) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 15:26:47.287229) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 15:26:47.287519) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450826806.678814-1364486985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004926 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 15:26:47.308536) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 15:26:47.308814) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 15:26:47.321760) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 15:26:47.322051) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450826806.678814-1364486985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 15:26:47.370725) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 15:26:47.371028) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 15:26:47.371398) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 15:26:47.371675) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450826806.678814-1364486985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-22 15:26:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.1M=0s 2015-12-22 15:26:47 (47.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104913 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 15:26:47.488835) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 15:26:47.489151) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450826806.678814-1364486985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014854 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 15:26:47.539932) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 15:26:47.540382) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5c7d3bb49bee4bc49b9a3e0be8aedafa6ced283b --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 5c7d3bb49bee4bc49b9a3e0be8aedafa6ced283b --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=23f5739b2d6aa5d9caf5c428000001ae-1450826806.678814-1364486985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-22 15:26:47,651 truncating revision to first 12 chars 2015-12-22 15:26:47,651 Setting DEBUG logging. 2015-12-22 15:26:47,651 attempt 1/10 2015-12-22 15:26:47,651 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5c7d3bb49bee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-22 15:26:47,899 unpacking tar archive at: fx-team-5c7d3bb49bee/testing/mozharness/ program finished with exit code 0 elapsedTime=0.516993 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 15:26:48.070331) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 15:26:48.070649) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 15:26:48.077660) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 15:26:48.077913) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 15:26:48.078300) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-22 15:26:48.078575) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --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', '--system-bits', '64', '--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=23f5739b2d6aa5d9caf5c428000001ae-1450826806.678814-1364486985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:26:48 INFO - MultiFileLogger online at 20151222 15:26:48 in /builds/slave/test 15:26:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:26:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:26:48 INFO - {'append_to_log': False, 15:26:48 INFO - 'base_work_dir': '/builds/slave/test', 15:26:48 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:26:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:26:48 INFO - 'branch': 'Fx-Team-Non-PGO', 15:26:48 INFO - 'buildbot_json_path': 'buildprops.json', 15:26:48 INFO - 'config_files': ('talos/linux_config.py',), 15:26:48 INFO - 'default_actions': ('clobber', 15:26:48 INFO - 'read-buildbot-config', 15:26:48 INFO - 'download-and-extract', 15:26:48 INFO - 'populate-webroot', 15:26:48 INFO - 'create-virtualenv', 15:26:48 INFO - 'install', 15:26:48 INFO - 'run-tests'), 15:26:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:26:48 INFO - 'download_minidump_stackwalk': True, 15:26:48 INFO - 'download_symbols': 'ondemand', 15:26:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:26:48 INFO - 'tooltool.py': '/tools/tooltool.py', 15:26:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:26:48 INFO - '/tools/misc-python/virtualenv.py')}, 15:26:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:26:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:26:48 INFO - 'installer_path': 'installer.exe', 15:26:48 INFO - 'log_level': 'info', 15:26:48 INFO - 'log_name': 'talos', 15:26:48 INFO - 'log_to_console': True, 15:26:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:26:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:26:48 INFO - 'opt_config_files': (), 15:26:48 INFO - 'pip_index': False, 15:26:48 INFO - 'sps_profile': False, 15:26:48 INFO - 'sps_profile_interval': 0, 15:26:48 INFO - 'suite': 'dromaeojs', 15:26:48 INFO - 'system_bits': '64', 15:26:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:26:48 INFO - 'title': 'talos-linux64-ix-030', 15:26:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:26:48 INFO - 'use_talos_json': True, 15:26:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:26:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:26:48 INFO - 'work_dir': 'build'} 15:26:48 INFO - ##### 15:26:48 INFO - ##### Running clobber step. 15:26:48 INFO - ##### 15:26:48 INFO - Running pre-action listener: _resource_record_pre_action 15:26:48 INFO - Running main action method: clobber 15:26:48 INFO - rmtree: /builds/slave/test/build 15:26:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:26:49 INFO - Running post-action listener: _resource_record_post_action 15:26:49 INFO - ##### 15:26:49 INFO - ##### Running read-buildbot-config step. 15:26:49 INFO - ##### 15:26:49 INFO - Running pre-action listener: _resource_record_pre_action 15:26:49 INFO - Running main action method: read_buildbot_config 15:26:49 INFO - Using buildbot properties: 15:26:49 INFO - { 15:26:49 INFO - "project": "", 15:26:49 INFO - "product": "firefox", 15:26:49 INFO - "script_repo_revision": "production", 15:26:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:26:49 INFO - "repository": "", 15:26:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:26:49 INFO - "buildid": "20151222145526", 15:26:49 INFO - "pgo_build": "False", 15:26:49 INFO - "basedir": "/builds/slave/test", 15:26:49 INFO - "buildnumber": 2245, 15:26:49 INFO - "slavename": "talos-linux64-ix-030", 15:26:49 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:26:49 INFO - "platform": "ubuntu64_hw", 15:26:49 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:26:49 INFO - "branch": "fx-team", 15:26:49 INFO - "repo_path": "integration/fx-team", 15:26:49 INFO - "revision": "5c7d3bb49bee4bc49b9a3e0be8aedafa6ced283b", 15:26:49 INFO - "stage_platform": "linux64", 15:26:49 INFO - "builduid": "8f74816a8deb4e7e9514cbe5a098c421", 15:26:49 INFO - "slavebuilddir": "test" 15:26:49 INFO - } 15:26:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/QJrYdSZcSk299hoRXiaxLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 15:26:49 INFO - Running post-action listener: _resource_record_post_action 15:26:49 INFO - ##### 15:26:49 INFO - ##### Running download-and-extract step. 15:26:49 INFO - ##### 15:26:49 INFO - Running pre-action listener: _resource_record_pre_action 15:26:49 INFO - Running main action method: download_and_extract 15:26:49 INFO - mkdir: /builds/slave/test/build/tests 15:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:49 INFO - https://queue.taskcluster.net/v1/task/QJrYdSZcSk299hoRXiaxLg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:26:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJrYdSZcSk299hoRXiaxLg/artifacts/public/build/test_packages.json 15:26:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJrYdSZcSk299hoRXiaxLg/artifacts/public/build/test_packages.json 15:26:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJrYdSZcSk299hoRXiaxLg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:26:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJrYdSZcSk299hoRXiaxLg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:26:49 INFO - Downloaded 1302 bytes. 15:26:49 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:26:49 INFO - Using the following test package requirements: 15:26:49 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:26:49 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:49 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:26:49 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:49 INFO - u'jsshell-linux-x86_64.zip'], 15:26:49 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:49 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:26:49 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:26:49 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:49 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:26:49 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:49 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:26:49 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:49 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:26:49 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:26:49 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:26:49 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:26:49 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:49 INFO - https://queue.taskcluster.net/v1/task/QJrYdSZcSk299hoRXiaxLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:26:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJrYdSZcSk299hoRXiaxLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:26:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJrYdSZcSk299hoRXiaxLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:26:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJrYdSZcSk299hoRXiaxLg/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 15:26:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJrYdSZcSk299hoRXiaxLg/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 15:26:50 INFO - Downloaded 21926924 bytes. 15:26:50 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 15:26:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:26:50 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 15:26:51 INFO - Return code: 0 15:26:51 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 15:26:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:51 INFO - https://queue.taskcluster.net/v1/task/QJrYdSZcSk299hoRXiaxLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:26:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJrYdSZcSk299hoRXiaxLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:26:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJrYdSZcSk299hoRXiaxLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:26:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJrYdSZcSk299hoRXiaxLg/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 15:26:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJrYdSZcSk299hoRXiaxLg/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 15:26:52 INFO - Downloaded 21926924 bytes. 15:26:52 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 15:26:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:26:52 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 15:26:54 INFO - Return code: 0 15:26: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')]} 15:26:54 INFO - https://queue.taskcluster.net/v1/task/QJrYdSZcSk299hoRXiaxLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:26:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJrYdSZcSk299hoRXiaxLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:26:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJrYdSZcSk299hoRXiaxLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:26:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJrYdSZcSk299hoRXiaxLg/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 15:26:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJrYdSZcSk299hoRXiaxLg/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 15:26:54 INFO - Downloaded 11132277 bytes. 15:26:54 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 15:26:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:26:54 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 15:26:55 INFO - Return code: 0 15:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:55 INFO - https://queue.taskcluster.net/v1/task/QJrYdSZcSk299hoRXiaxLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:26:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJrYdSZcSk299hoRXiaxLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:26:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJrYdSZcSk299hoRXiaxLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:26:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJrYdSZcSk299hoRXiaxLg/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 15:26:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QJrYdSZcSk299hoRXiaxLg/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 15:26:56 INFO - Downloaded 53327358 bytes. 15:26:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QJrYdSZcSk299hoRXiaxLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:26:56 INFO - mkdir: /builds/slave/test/properties 15:26:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:26:56 INFO - Writing to file /builds/slave/test/properties/build_url 15:26:56 INFO - Contents: 15:26:56 INFO - build_url:https://queue.taskcluster.net/v1/task/QJrYdSZcSk299hoRXiaxLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:26:56 INFO - Running post-action listener: _resource_record_post_action 15:26:56 INFO - Running post-action listener: set_extra_try_arguments 15:26:56 INFO - ##### 15:26:56 INFO - ##### Running populate-webroot step. 15:26:56 INFO - ##### 15:26:56 INFO - Running pre-action listener: _resource_record_pre_action 15:26:56 INFO - Running main action method: populate_webroot 15:26:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:26:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:26:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:26:56 INFO - '--tppagecycles', 15:26:56 INFO - '7'], 15:26:56 INFO - 'tests': ['tsvgm']}}, 15:26:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:26:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:26:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:26:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:26:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:26:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:26:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:26:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:56 INFO - 'talos_options': ['--e10s'], 15:26:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:26:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:56 INFO - 'tests': ['damp', 'tps']}, 15:26:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:56 INFO - 'talos_options': ['--e10s'], 15:26:56 INFO - 'tests': ['damp', 'tps']}, 15:26:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:26:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:26:56 INFO - 'other': {'tests': ['a11yr', 15:26:56 INFO - 'ts_paint', 15:26:56 INFO - 'tpaint', 15:26:56 INFO - 'sessionrestore', 15:26:56 INFO - 'sessionrestore_no_auto_restore']}, 15:26:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:26:56 INFO - 'tests': ['a11yr', 15:26:56 INFO - 'ts_paint', 15:26:56 INFO - 'tpaint', 15:26:56 INFO - 'sessionrestore', 15:26:56 INFO - 'sessionrestore_no_auto_restore']}, 15:26:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:26:56 INFO - 'tests': ['a11yr', 15:26:56 INFO - 'ts_paint', 15:26:56 INFO - 'tpaint', 15:26:56 INFO - 'sessionrestore', 15:26:56 INFO - 'sessionrestore_no_auto_restore']}, 15:26:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:26:56 INFO - 'tests': ['a11yr', 15:26:56 INFO - 'ts_paint', 15:26:56 INFO - 'tpaint', 15:26:56 INFO - 'sessionrestore', 15:26:56 INFO - 'sessionrestore_no_auto_restore']}, 15:26:56 INFO - 'other_l64': {'tests': ['a11yr', 15:26:56 INFO - 'ts_paint', 15:26:56 INFO - 'tpaint', 15:26:56 INFO - 'sessionrestore', 15:26:56 INFO - 'sessionrestore_no_auto_restore']}, 15:26:56 INFO - 'other_nol64': {'tests': ['a11yr', 15:26:56 INFO - 'ts_paint', 15:26:56 INFO - 'tpaint', 15:26:56 INFO - 'sessionrestore', 15:26:56 INFO - 'sessionrestore_no_auto_restore']}, 15:26:56 INFO - 'svgr': {'tests': ['tsvgx', 15:26:56 INFO - 'tsvgr_opacity', 15:26:56 INFO - 'tart', 15:26:56 INFO - 'tscrollx', 15:26:56 INFO - 'cart']}, 15:26:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:26:56 INFO - 'tests': ['tsvgx', 15:26:56 INFO - 'tsvgr_opacity', 15:26:56 INFO - 'tart', 15:26:56 INFO - 'tscrollx', 15:26:56 INFO - 'cart']}, 15:26:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:56 INFO - 'tests': ['tp5o']}, 15:26:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:56 INFO - 'talos_options': ['--e10s'], 15:26:56 INFO - 'tests': ['tp5o']}, 15:26:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:56 INFO - 'talos_options': ['--xperf_path', 15:26:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:26:56 INFO - 'tests': ['tp5n']}, 15:26:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:56 INFO - 'talos_options': ['--e10s', 15:26:56 INFO - '--xperf_path', 15:26:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:26:56 INFO - 'tests': ['tp5n']}}, 15:26:56 INFO - 'talos.zip': {'path': '', 15:26:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:26:56 INFO - Running post-action listener: _resource_record_post_action 15:26:56 INFO - ##### 15:26:56 INFO - ##### Running create-virtualenv step. 15:26:56 INFO - ##### 15:26:56 INFO - Running pre-action listener: _resource_record_pre_action 15:26:56 INFO - Running main action method: create_virtualenv 15:26:56 INFO - Creating virtualenv /builds/slave/test/build/venv 15:26:56 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 15:26:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:26:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:26:56 INFO - Using real prefix '/usr' 15:26:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:26:57 INFO - Installing distribute.............................................................................................................................................................................................done. 15:26:59 INFO - Installing pip.................done. 15:26:59 INFO - Return code: 0 15:26:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffcc3c68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c803d0>, '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 0x2bebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bec360>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450826806.678814-1364486985', '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 15:26:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:26:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:26:59 INFO - Using env: {'DISPLAY': ':0', 15:26:59 INFO - 'HOME': '/home/cltbld', 15:26:59 INFO - 'LANG': 'en_US.UTF-8', 15:26:59 INFO - 'LANGUAGE': 'en_US:en', 15:26:59 INFO - 'LOGNAME': 'cltbld', 15:26:59 INFO - 'MAIL': '/var/mail/cltbld', 15:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:59 INFO - 'MOZ_NO_REMOTE': '1', 15:26:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:59 INFO - 'NO_EM_RESTART': '1', 15:26:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:59 INFO - 'PWD': '/builds/slave/test', 15:26:59 INFO - 'SHELL': '/bin/bash', 15:26:59 INFO - 'SHLVL': '1', 15:26:59 INFO - 'TERM': 'linux', 15:26:59 INFO - 'TMOUT': '86400', 15:26:59 INFO - 'USER': 'cltbld', 15:26:59 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450826806.678814-1364486985', 15:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:59 INFO - '_': '/tools/buildbot/bin/python'} 15:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:59 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 15:26:59 INFO - Cleaning up... 15:26:59 INFO - Return code: 0 15:26:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffcc3c68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c803d0>, '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 0x2bebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bec360>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450826806.678814-1364486985', '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 15:26:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:26:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:26:59 INFO - Using env: {'DISPLAY': ':0', 15:26:59 INFO - 'HOME': '/home/cltbld', 15:26:59 INFO - 'LANG': 'en_US.UTF-8', 15:26:59 INFO - 'LANGUAGE': 'en_US:en', 15:26:59 INFO - 'LOGNAME': 'cltbld', 15:26:59 INFO - 'MAIL': '/var/mail/cltbld', 15:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:59 INFO - 'MOZ_NO_REMOTE': '1', 15:26:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:26:59 INFO - 'NO_EM_RESTART': '1', 15:26:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:59 INFO - 'PWD': '/builds/slave/test', 15:26:59 INFO - 'SHELL': '/bin/bash', 15:26:59 INFO - 'SHLVL': '1', 15:26:59 INFO - 'TERM': 'linux', 15:26:59 INFO - 'TMOUT': '86400', 15:26:59 INFO - 'USER': 'cltbld', 15:26:59 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450826806.678814-1364486985', 15:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:59 INFO - '_': '/tools/buildbot/bin/python'} 15:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:59 INFO - Downloading/unpacking psutil>=0.7.1 15:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:01 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:27:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:27:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:27:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:27:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:27:01 INFO - Installing collected packages: psutil 15:27:01 INFO - Running setup.py install for psutil 15:27:01 INFO - building 'psutil._psutil_linux' extension 15:27:01 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 15:27:01 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 15:27:01 INFO - building 'psutil._psutil_posix' extension 15:27:01 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 15:27:01 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 15:27:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:27:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:27:01 INFO - Successfully installed psutil 15:27:01 INFO - Cleaning up... 15:27:01 INFO - Return code: 0 15:27:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:01 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 0x7ffcc3c68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c803d0>, '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 0x2bebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bec360>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450826806.678814-1364486985', '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 15:27:01 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 15:27:01 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 15:27:01 INFO - Using env: {'DISPLAY': ':0', 15:27:01 INFO - 'HOME': '/home/cltbld', 15:27:01 INFO - 'LANG': 'en_US.UTF-8', 15:27:01 INFO - 'LANGUAGE': 'en_US:en', 15:27:01 INFO - 'LOGNAME': 'cltbld', 15:27:01 INFO - 'MAIL': '/var/mail/cltbld', 15:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:01 INFO - 'MOZ_NO_REMOTE': '1', 15:27:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:01 INFO - 'NO_EM_RESTART': '1', 15:27:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:01 INFO - 'PWD': '/builds/slave/test', 15:27:01 INFO - 'SHELL': '/bin/bash', 15:27:01 INFO - 'SHLVL': '1', 15:27:01 INFO - 'TERM': 'linux', 15:27:01 INFO - 'TMOUT': '86400', 15:27:01 INFO - 'USER': 'cltbld', 15:27:01 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450826806.678814-1364486985', 15:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:01 INFO - '_': '/tools/buildbot/bin/python'} 15:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:27:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:27:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:27:03 INFO - Installing collected packages: mozsystemmonitor 15:27:03 INFO - Running setup.py install for mozsystemmonitor 15:27:03 INFO - Successfully installed mozsystemmonitor 15:27:03 INFO - Cleaning up... 15:27:03 INFO - Return code: 0 15:27:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7ffcc3c68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c803d0>, '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 0x2bebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bec360>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450826806.678814-1364486985', '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 15:27:03 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 15:27:03 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 15:27:03 INFO - Using env: {'DISPLAY': ':0', 15:27:03 INFO - 'HOME': '/home/cltbld', 15:27:03 INFO - 'LANG': 'en_US.UTF-8', 15:27:03 INFO - 'LANGUAGE': 'en_US:en', 15:27:03 INFO - 'LOGNAME': 'cltbld', 15:27:03 INFO - 'MAIL': '/var/mail/cltbld', 15:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:03 INFO - 'MOZ_NO_REMOTE': '1', 15:27:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:03 INFO - 'NO_EM_RESTART': '1', 15:27:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:03 INFO - 'PWD': '/builds/slave/test', 15:27:03 INFO - 'SHELL': '/bin/bash', 15:27:03 INFO - 'SHLVL': '1', 15:27:03 INFO - 'TERM': 'linux', 15:27:03 INFO - 'TMOUT': '86400', 15:27:03 INFO - 'USER': 'cltbld', 15:27:03 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450826806.678814-1364486985', 15:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:03 INFO - '_': '/tools/buildbot/bin/python'} 15:27:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:04 INFO - Downloading/unpacking blobuploader==1.2.4 15:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:05 INFO - Downloading blobuploader-1.2.4.tar.gz 15:27:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:27:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:27:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:05 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 15:27:05 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 15:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:27:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:27:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:06 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 15:27:06 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 15:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:06 INFO - Downloading docopt-0.6.1.tar.gz 15:27:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:27:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:27:06 INFO - Installing collected packages: blobuploader, requests, docopt 15:27:06 INFO - Running setup.py install for blobuploader 15:27:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:27:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:27:06 INFO - Running setup.py install for requests 15:27:06 INFO - Running setup.py install for docopt 15:27:07 INFO - Successfully installed blobuploader requests docopt 15:27:07 INFO - Cleaning up... 15:27:07 INFO - Return code: 0 15:27:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:07 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 0x7ffcc3c68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c803d0>, '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 0x2bebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bec360>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450826806.678814-1364486985', '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 15:27:07 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 15:27:07 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 15:27:07 INFO - Using env: {'DISPLAY': ':0', 15:27:07 INFO - 'HOME': '/home/cltbld', 15:27:07 INFO - 'LANG': 'en_US.UTF-8', 15:27:07 INFO - 'LANGUAGE': 'en_US:en', 15:27:07 INFO - 'LOGNAME': 'cltbld', 15:27:07 INFO - 'MAIL': '/var/mail/cltbld', 15:27:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:07 INFO - 'MOZ_NO_REMOTE': '1', 15:27:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:07 INFO - 'NO_EM_RESTART': '1', 15:27:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:07 INFO - 'PWD': '/builds/slave/test', 15:27:07 INFO - 'SHELL': '/bin/bash', 15:27:07 INFO - 'SHLVL': '1', 15:27:07 INFO - 'TERM': 'linux', 15:27:07 INFO - 'TMOUT': '86400', 15:27:07 INFO - 'USER': 'cltbld', 15:27:07 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450826806.678814-1364486985', 15:27:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:07 INFO - '_': '/tools/buildbot/bin/python'} 15:27:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:27:07 INFO - Running setup.py (path:/tmp/pip-VTSV8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:27:07 INFO - Running setup.py (path:/tmp/pip-IjqBkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:27:07 INFO - Running setup.py (path:/tmp/pip-6Dq75I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:27:07 INFO - Running setup.py (path:/tmp/pip-GlIlDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:27:07 INFO - Running setup.py (path:/tmp/pip-Tzwdz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:27:07 INFO - Running setup.py (path:/tmp/pip-xCoPwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:27:07 INFO - Running setup.py (path:/tmp/pip-NCn3Ip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:27:07 INFO - Running setup.py (path:/tmp/pip-uf767z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:27:07 INFO - Running setup.py (path:/tmp/pip-fcXTgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:27:07 INFO - Running setup.py (path:/tmp/pip-qdhztQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:27:08 INFO - Running setup.py (path:/tmp/pip-tqmKGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:27:08 INFO - Running setup.py (path:/tmp/pip-Y3TUkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:27:08 INFO - Running setup.py (path:/tmp/pip-nCswNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:27:08 INFO - Running setup.py (path:/tmp/pip-UniIlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:08 INFO - Running setup.py (path:/tmp/pip-g01yn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:27:08 INFO - Running setup.py (path:/tmp/pip-pzNb4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:27:08 INFO - Running setup.py (path:/tmp/pip-rpZbwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:27:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:27:08 INFO - Running setup.py install for manifestparser 15:27:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:27:08 INFO - Running setup.py install for mozcrash 15:27:08 INFO - Running setup.py install for mozdebug 15:27:08 INFO - Running setup.py install for mozdevice 15:27:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:27:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:27:08 INFO - Running setup.py install for mozfile 15:27:09 INFO - Running setup.py install for mozhttpd 15:27:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:27:09 INFO - Running setup.py install for mozinfo 15:27:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:27:09 INFO - Running setup.py install for mozInstall 15:27:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:27:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:27:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:27:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:27:09 INFO - Running setup.py install for mozleak 15:27:09 INFO - Running setup.py install for mozlog 15:27:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:27:09 INFO - Running setup.py install for moznetwork 15:27:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:27:09 INFO - Running setup.py install for mozprocess 15:27:09 INFO - Running setup.py install for mozprofile 15:27:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:27:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:27:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:27:09 INFO - Running setup.py install for mozrunner 15:27:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:27:10 INFO - Running setup.py install for mozscreenshot 15:27:10 INFO - Running setup.py install for moztest 15:27:10 INFO - Running setup.py install for mozversion 15:27:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:27:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:27:10 INFO - Cleaning up... 15:27:10 INFO - Return code: 0 15:27:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27:10 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')]} 15:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:10 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')]} 15:27:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:10 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 0x7ffcc3c68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c803d0>, '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 0x2bebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bec360>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450826806.678814-1364486985', '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 15:27:10 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 15:27:10 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 15:27:10 INFO - Using env: {'DISPLAY': ':0', 15:27:10 INFO - 'HOME': '/home/cltbld', 15:27:10 INFO - 'LANG': 'en_US.UTF-8', 15:27:10 INFO - 'LANGUAGE': 'en_US:en', 15:27:10 INFO - 'LOGNAME': 'cltbld', 15:27:10 INFO - 'MAIL': '/var/mail/cltbld', 15:27:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:10 INFO - 'MOZ_NO_REMOTE': '1', 15:27:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:10 INFO - 'NO_EM_RESTART': '1', 15:27:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:10 INFO - 'PWD': '/builds/slave/test', 15:27:10 INFO - 'SHELL': '/bin/bash', 15:27:10 INFO - 'SHLVL': '1', 15:27:10 INFO - 'TERM': 'linux', 15:27:10 INFO - 'TMOUT': '86400', 15:27:10 INFO - 'USER': 'cltbld', 15:27:10 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450826806.678814-1364486985', 15:27:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:10 INFO - '_': '/tools/buildbot/bin/python'} 15:27:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:27:10 INFO - Running setup.py (path:/tmp/pip-Qkkc8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:27:10 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)) 15:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:27:10 INFO - Running setup.py (path:/tmp/pip-kcJ2Pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:27:10 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)) 15:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:27:10 INFO - Running setup.py (path:/tmp/pip-vki0E1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:27:10 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)) 15:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:27:10 INFO - Running setup.py (path:/tmp/pip-ch02PA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:27:10 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)) 15:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:27:10 INFO - Running setup.py (path:/tmp/pip-DG6919-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:27:10 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)) 15:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:27:10 INFO - Running setup.py (path:/tmp/pip-_CjMRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:27:10 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)) 15:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:27:10 INFO - Running setup.py (path:/tmp/pip-46y5GC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:27:11 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)) 15:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:27:11 INFO - Running setup.py (path:/tmp/pip-Jgql3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:27:11 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)) 15:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:27:11 INFO - Running setup.py (path:/tmp/pip-01JpYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:27:11 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)) 15:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:27:11 INFO - Running setup.py (path:/tmp/pip-IhlOti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:27:11 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)) 15:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:27:11 INFO - Running setup.py (path:/tmp/pip-Yi5Vmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:27:11 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)) 15:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:27:11 INFO - Running setup.py (path:/tmp/pip-AeUGZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:27:11 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)) 15:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:27:11 INFO - Running setup.py (path:/tmp/pip-7dJjoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:27:11 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)) 15:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:27:11 INFO - Running setup.py (path:/tmp/pip-Wl2f4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:27:11 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)) 15:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:11 INFO - Running setup.py (path:/tmp/pip-uXSDA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:11 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)) 15:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:27:11 INFO - Running setup.py (path:/tmp/pip-oPsEpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:27:11 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)) 15:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:27:11 INFO - Running setup.py (path:/tmp/pip-LJs0sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:27:11 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)) 15:27:11 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)) 15:27:11 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)) 15:27:11 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)) 15:27:11 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)) 15:27:11 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)) 15:27:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:13 INFO - Downloading blessings-1.5.1.tar.gz 15:27:13 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 15:27:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:27:13 INFO - Installing collected packages: blessings 15:27:13 INFO - Running setup.py install for blessings 15:27:13 INFO - Successfully installed blessings 15:27:13 INFO - Cleaning up... 15:27:13 INFO - Return code: 0 15:27:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:27:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:27:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:27:13 INFO - Reading from file tmpfile_stdout 15:27:13 INFO - Current package versions: 15:27:13 INFO - argparse == 1.2.1 15:27:13 INFO - blessings == 1.5.1 15:27:13 INFO - blobuploader == 1.2.4 15:27:13 INFO - docopt == 0.6.1 15:27:13 INFO - manifestparser == 1.1 15:27:13 INFO - mozInstall == 1.12 15:27:13 INFO - mozcrash == 0.16 15:27:13 INFO - mozdebug == 0.1 15:27:13 INFO - mozdevice == 0.47 15:27:13 INFO - mozfile == 1.2 15:27:13 INFO - mozhttpd == 0.7 15:27:13 INFO - mozinfo == 0.9 15:27:13 INFO - mozleak == 0.1 15:27:13 INFO - mozlog == 3.1 15:27:13 INFO - moznetwork == 0.27 15:27:13 INFO - mozprocess == 0.22 15:27:13 INFO - mozprofile == 0.28 15:27:13 INFO - mozrunner == 6.11 15:27:13 INFO - mozscreenshot == 0.1 15:27:13 INFO - mozsystemmonitor == 0.0 15:27:13 INFO - moztest == 0.7 15:27:13 INFO - mozversion == 1.4 15:27:13 INFO - psutil == 3.1.1 15:27:13 INFO - requests == 1.2.3 15:27:13 INFO - wsgiref == 0.1.2 15:27:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27: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')]} 15:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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')]} 15:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:13 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 0x7ffcc3c68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c803d0>, '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 0x2bebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bec360>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450826806.678814-1364486985', '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 15:27:13 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 15:27:13 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 15:27:13 INFO - Using env: {'DISPLAY': ':0', 15:27:13 INFO - 'HOME': '/home/cltbld', 15:27:13 INFO - 'LANG': 'en_US.UTF-8', 15:27:13 INFO - 'LANGUAGE': 'en_US:en', 15:27:13 INFO - 'LOGNAME': 'cltbld', 15:27:13 INFO - 'MAIL': '/var/mail/cltbld', 15:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:13 INFO - 'MOZ_NO_REMOTE': '1', 15:27:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:13 INFO - 'NO_EM_RESTART': '1', 15:27:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:13 INFO - 'PWD': '/builds/slave/test', 15:27:13 INFO - 'SHELL': '/bin/bash', 15:27:13 INFO - 'SHLVL': '1', 15:27:13 INFO - 'TERM': 'linux', 15:27:13 INFO - 'TMOUT': '86400', 15:27:13 INFO - 'USER': 'cltbld', 15:27:13 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450826806.678814-1364486985', 15:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:13 INFO - '_': '/tools/buildbot/bin/python'} 15:27:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:14 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)) 15:27:14 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)) 15:27:14 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)) 15:27:14 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)) 15:27:14 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)) 15:27:14 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)) 15:27:14 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)) 15:27:14 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)) 15:27:14 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)) 15:27:14 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)) 15:27:14 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)) 15:27:14 INFO - Cleaning up... 15:27:14 INFO - Return code: 0 15:27:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:27:14 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')]} 15:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:14 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')]} 15:27:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:14 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 0x7ffcc3c68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c803d0>, '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 0x2bebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bec360>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450826806.678814-1364486985', '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 15:27:14 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 15:27:14 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 15:27:14 INFO - Using env: {'DISPLAY': ':0', 15:27:14 INFO - 'HOME': '/home/cltbld', 15:27:14 INFO - 'LANG': 'en_US.UTF-8', 15:27:14 INFO - 'LANGUAGE': 'en_US:en', 15:27:14 INFO - 'LOGNAME': 'cltbld', 15:27:14 INFO - 'MAIL': '/var/mail/cltbld', 15:27:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:14 INFO - 'MOZ_NO_REMOTE': '1', 15:27:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:14 INFO - 'NO_EM_RESTART': '1', 15:27:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:14 INFO - 'PWD': '/builds/slave/test', 15:27:14 INFO - 'SHELL': '/bin/bash', 15:27:14 INFO - 'SHLVL': '1', 15:27:14 INFO - 'TERM': 'linux', 15:27:14 INFO - 'TMOUT': '86400', 15:27:14 INFO - 'USER': 'cltbld', 15:27:14 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450826806.678814-1364486985', 15:27:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:14 INFO - '_': '/tools/buildbot/bin/python'} 15:27:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:14 INFO - Downloading/unpacking jsonschema 15:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:14 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 15:27:14 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 15:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:27:16 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 15:27:16 INFO - Downloading/unpacking functools32 (from jsonschema) 15:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:16 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 15:27:16 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 15:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:16 INFO - Downloading functools32-3.2.3-2.tar.gz 15:27:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 15:27:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:27:16 INFO - warning: no files found matching '*.txt' 15:27:16 INFO - no previously-included directories found matching 'build' 15:27:16 INFO - no previously-included directories found matching 'dist' 15:27:16 INFO - no previously-included directories found matching '.git*' 15:27:16 INFO - Installing collected packages: jsonschema, functools32 15:27:16 INFO - Running setup.py install for functools32 15:27:16 INFO - warning: no files found matching '*.txt' 15:27:16 INFO - no previously-included directories found matching 'build' 15:27:16 INFO - no previously-included directories found matching 'dist' 15:27:16 INFO - no previously-included directories found matching '.git*' 15:27:16 INFO - Successfully installed jsonschema functools32 15:27:16 INFO - Cleaning up... 15:27:16 INFO - Return code: 0 15:27:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:27:16 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')]} 15:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:16 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')]} 15:27:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:16 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 0x7ffcc3c68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c803d0>, '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 0x2bebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bec360>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1450826806.678814-1364486985', '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 15:27:16 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 15:27:16 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 15:27:16 INFO - Using env: {'DISPLAY': ':0', 15:27:16 INFO - 'HOME': '/home/cltbld', 15:27:16 INFO - 'LANG': 'en_US.UTF-8', 15:27:16 INFO - 'LANGUAGE': 'en_US:en', 15:27:16 INFO - 'LOGNAME': 'cltbld', 15:27:16 INFO - 'MAIL': '/var/mail/cltbld', 15:27:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:16 INFO - 'MOZ_NO_REMOTE': '1', 15:27:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:16 INFO - 'NO_EM_RESTART': '1', 15:27:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:16 INFO - 'PWD': '/builds/slave/test', 15:27:16 INFO - 'SHELL': '/bin/bash', 15:27:16 INFO - 'SHLVL': '1', 15:27:16 INFO - 'TERM': 'linux', 15:27:16 INFO - 'TMOUT': '86400', 15:27:16 INFO - 'USER': 'cltbld', 15:27:16 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450826806.678814-1364486985', 15:27:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:16 INFO - '_': '/tools/buildbot/bin/python'} 15:27:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:16 INFO - Downloading/unpacking flake8 15:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:16 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 15:27:16 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 15:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:27:18 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 15:27:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:27:18 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 15:27:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27:18 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 15:27:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 15:27:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:27:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:27:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:27:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:27:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:27:19 INFO - no previously-included directories found matching 'docs/_build' 15:27:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:27:19 INFO - Running setup.py install for pep8 15:27:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:27:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:27:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:27:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:27:19 INFO - no previously-included directories found matching 'docs/_build' 15:27:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:27:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:27:19 INFO - Cleaning up... 15:27:19 INFO - Return code: 0 15:27:19 INFO - Running post-action listener: _resource_record_post_action 15:27:19 INFO - Running post-action listener: _start_resource_monitoring 15:27:19 INFO - Starting resource monitoring. 15:27:19 INFO - ##### 15:27:19 INFO - ##### Running install step. 15:27:19 INFO - ##### 15:27:19 INFO - Running pre-action listener: _resource_record_pre_action 15:27:19 INFO - Running main action method: install 15:27:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:27:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:27:19 INFO - Reading from file tmpfile_stdout 15:27:19 INFO - Detecting whether we're running mozinstall >=1.0... 15:27:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:27:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:27:19 INFO - Reading from file tmpfile_stdout 15:27:19 INFO - Output received: 15:27:19 INFO - Usage: mozinstall [options] installer 15:27:19 INFO - Options: 15:27:19 INFO - -h, --help show this help message and exit 15:27:19 INFO - -d DEST, --destination=DEST 15:27:19 INFO - Directory to install application into. [default: 15:27:19 INFO - "/builds/slave/test"] 15:27:19 INFO - --app=APP Application being installed. [default: firefox] 15:27:19 INFO - mkdir: /builds/slave/test/build/application 15:27:19 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'] 15:27:19 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 15:27:35 INFO - Reading from file tmpfile_stdout 15:27:35 INFO - Output received: 15:27:35 INFO - /builds/slave/test/build/application/firefox/firefox 15:27:35 INFO - Running post-action listener: _resource_record_post_action 15:27:35 INFO - ##### 15:27:35 INFO - ##### Running run-tests step. 15:27:35 INFO - ##### 15:27:35 INFO - Running pre-action listener: _resource_record_pre_action 15:27:35 INFO - Running main action method: run_tests 15:27:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:27:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:27:35 INFO - Python 2.7.3 15:27:35 INFO - Return code: 0 15:27:35 INFO - grabbing minidump binary from tooltool 15:27: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')]} 15:27:35 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 0x2c803d0>, '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 0x2bebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bec360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:27:35 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 15:27:35 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 15:27:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:27:35 INFO - Return code: 0 15:27:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:27:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:27:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:27:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:27:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:27:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:27:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:27:36 INFO - Return code: 0 15:27:36 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/QJrYdSZcSk299hoRXiaxLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 15:27:36 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/QJrYdSZcSk299hoRXiaxLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 15:27:36 INFO - Using env: {'DISPLAY': ':0', 15:27:36 INFO - 'HOME': '/home/cltbld', 15:27:36 INFO - 'LANG': 'en_US.UTF-8', 15:27:36 INFO - 'LANGUAGE': 'en_US:en', 15:27:36 INFO - 'LOGNAME': 'cltbld', 15:27:36 INFO - 'MAIL': '/var/mail/cltbld', 15:27:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:27:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:27:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:36 INFO - 'MOZ_NO_REMOTE': '1', 15:27:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:27:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:36 INFO - 'NO_EM_RESTART': '1', 15:27:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:36 INFO - 'PWD': '/builds/slave/test', 15:27:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:27:36 INFO - 'SHELL': '/bin/bash', 15:27:36 INFO - 'SHLVL': '1', 15:27:36 INFO - 'TERM': 'linux', 15:27:36 INFO - 'TMOUT': '86400', 15:27:36 INFO - 'USER': 'cltbld', 15:27:36 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1450826806.678814-1364486985', 15:27:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:36 INFO - '_': '/tools/buildbot/bin/python'} 15:27:36 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/QJrYdSZcSk299hoRXiaxLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 15:27:36 INFO - mozversion application_buildid: 20151222145526 15:27:36 INFO - mozversion application_changeset: 5c7d3bb49bee4bc49b9a3e0be8aedafa6ced283b 15:27:36 INFO - mozversion application_display_name: Nightly 15:27:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:27:36 INFO - mozversion application_name: Firefox 15:27:36 INFO - mozversion application_remotingname: firefox 15:27:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:27:36 INFO - mozversion application_vendor: Mozilla 15:27:36 INFO - mozversion application_version: 46.0a1 15:27:36 INFO - mozversion platform_buildid: 20151222145526 15:27:36 INFO - mozversion platform_changeset: 5c7d3bb49bee4bc49b9a3e0be8aedafa6ced283b 15:27:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:27:36 INFO - mozversion platform_version: 46.0a1 15:27:36 INFO - using testdate: 1450826856 15:27:36 INFO - actual date: 1450826856 15:27:36 INFO - starting webserver on 'localhost:54195' 15:27:36 INFO - SUITE-START | Running 3 tests 15:27:36 INFO - TEST-START | dromaeo_css 15:27:36 INFO - operating with platform_type : linux_ 15:27:36 INFO - Initialising browser for dromaeo_css test... 15:27:36 INFO - TEST-INFO | started process 6137 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmbQhDf/profile http://localhost:54195/getInfo.html) 15:27:40 INFO - PROCESS | 6137 | __metrics Screen width/height:1600/1200 15:27:40 INFO - PROCESS | 6137 | colorDepth:24 15:27:40 INFO - PROCESS | 6137 | Browser inner width/height: 1024/697 15:27:40 INFO - PROCESS | 6137 | __metrics 15:27:40 INFO - PROCESS | 6137 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:27:40 INFO - PROCESS | 6137 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:27:41 INFO - TEST-INFO | 6137: exit 0 15:27:41 INFO - Browser initialized. 15:27:41 INFO - Running cycle 1/1 for dromaeo_css test... 15:27:41 INFO - TEST-INFO | started process 6229 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmbQhDf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:27:53 INFO - PROCESS | 6229 | RSS: Main: 150056960 15:27:53 INFO - PROCESS | 6229 | 15:28:44 INFO - PROCESS | 6229 | 1450826924775 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] 15:30:58 INFO - PROCESS | 6229 | Cycle 1(1): loaded http://localhost:54195/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54195/tests/dromaeo/cssquery-ext.html) 15:30:59 INFO - PROCESS | 6229 | RSS: Main: 248049664 15:30:59 INFO - PROCESS | 6229 | 15:34:01 INFO - PROCESS | 6229 | Cycle 1(1): loaded http://localhost:54195/tests/dromaeo/cssquery-ext.html (next: http://localhost:54195/tests/dromaeo/cssquery-jquery.html) 15:34:02 INFO - PROCESS | 6229 | RSS: Main: 236847104 15:34:02 INFO - PROCESS | 6229 | 15:37:04 INFO - PROCESS | 6229 | Cycle 1(1): loaded http://localhost:54195/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54195/tests/dromaeo/cssquery-mootools.html) 15:37:05 INFO - PROCESS | 6229 | RSS: Main: 239439872 15:37:05 INFO - PROCESS | 6229 | 15:40:07 INFO - PROCESS | 6229 | Cycle 1(1): loaded http://localhost:54195/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54195/tests/dromaeo/cssquery-prototype.html) 15:40:07 INFO - PROCESS | 6229 | RSS: Main: 215367680 15:40:07 INFO - PROCESS | 6229 | 15:43:10 INFO - PROCESS | 6229 | Cycle 1(1): loaded http://localhost:54195/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54195/tests/dromaeo/cssquery-yui.html) 15:43:11 INFO - PROCESS | 6229 | RSS: Main: 219582464 15:43:11 INFO - PROCESS | 6229 | 15:46:13 INFO - PROCESS | 6229 | Cycle 1(1): loaded http://localhost:54195/tests/dromaeo/cssquery-yui.html (next: http://localhost:54195/tests/dromaeo/cssquery-dojo.html) 15:46:13 INFO - PROCESS | 6229 | RSS: Main: 234967040 15:46:13 INFO - PROCESS | 6229 | 15:46:13 INFO - PROCESS | 6229 | __start_tp_report 15:46:13 INFO - PROCESS | 6229 | _x_x_mozilla_page_load 15:46:13 INFO - PROCESS | 6229 | _x_x_mozilla_page_load_details 15:46:13 INFO - PROCESS | 6229 | |i|pagename|runs| 15:46:13 INFO - PROCESS | 6229 | |0;dojo.html;2590.1288088297583;2657.189557185059;2664.933376665583;2670.412509247965;2676.4513274778665;4385.583369579893;4500.212462819002;4596.931046034308;4597.448306203252;4650.0467404182145;4557.703749256304;4562.931556026662;4650.186217411956;4654.39492865927;4682.812687492505;4301.053768171005;4306.870793876173;4328.242557552431;4349.891252718691;4361.171377438292;4149.439825623533;4338.939003973119;4342.717723347972;4389.31965545341;4393.824247030131;4136.296829538986;4203.579642035803;4208.579142085798;4229.957700423018;4233.491980962273;4292.59220374064;4314.3528470729325;4318.265894797892;4344.543822898613;4353.172897149531;4077.55146933837;4300.376445415397;4309.741415515079;4314.525402205755;4356.041670832412;4526.54734526548;4530.977345113286;4531.977340113312;4586.128635559233;4616.215243408628;4939.53074457926;4951.678140920829;4953.455119936804;4960.90078198434;4995.900081998339;4747.667663263573;4981.750912454363;4983.003399320114;4983.377077865267;4990.30135780991;4489.663275254369;4583.106294272585;4591.816327346869;4594.150082234763;4609.3086037094035;5091.439941606421;5120.359955005624;5127.794888204505;5129.769160387791;5130.9230361544605;4908.754562271872;4917.827876024394;4922.409310882717;4928.112939670822;4967.105920934194;4736.076465089343;4828.2998965150555;4832.830850920272;4871.561559459595;4989.101961646866;4910.238912968495;4946.233333833262;4955.801767929314;4971.875703107451;4979.45226025137;4945.505449455026;4963.70217786934;4966.428860680996;4968.403791545038;5017.67385119966;4018.0758425562285;4097.8770636880945;4135.359019352005;4170.124273902454;4197.97901010493;3604.8017359045502;3698.1124530113116;3705;3731.7014638828828;3743.47591337213;4368.257396242583;4390.143921935192;4390.714603550759;4395.077033822869;4420.270655341833;4769.046190761862;4868.342773725572;4871.756412179377;5066;5100.69395836251;4190.790460476964;4259.765712885821;4268.850590229327;4291.570842915746;4303.913921721611;4446.866594002185;4451.3323001550025;4488.663350248745;4490.595846373777;4529.048899731093;4581;4693.9765301173275;4697.966447381571;4780.235162374073;4807.278908163804;4872.074305881871;4920.630952678492;4933.753312334441;4940.580050695731;4953.2570114483115;4713.717176969393;4753.738544380092;4764.2615394613895;4765.35667684872;4801.255805350176;4922.85231443043;4945.8021679132435;4951.97524012392;4997.475265097258;5004.824831130893;4799.66402351832;4806.2310030394965;4906.681065730716;4910.410750709938;4922.950770492393;4755.595774359218;4758.286257061469;4760.285957106324;4764.404449443819;4802.51974802517;4703.082898834831;4748.810047598057;4755.714657120584;4763.618910487222;4799.568038876518;4574.245249533789;4696.765161741968;4700.976495117503;4731.479537250969;4872.805087796449;4912.631552633496;4917.459079501181;4926.285688575065;4932.28481870134;4946.134426475281;4827.879303017453;4833.299171620025;4834.395700537433;4871.074495845778;4877.463479017234 15:46:13 INFO - PROCESS | 6229 | |1;ext.html;539.0109149710281;539.6303532080525;544.3603765575448;561.8679610291583;569.2429069337782;26821.731782682167;32712.67287327126;33186.17034574137;33235.83382083086;33248.66751332486;38346.616533834655;38750;38971.22057558847;38986;39044.414333784945;6941.722331106775;7075.46933979951;7810.258025487598;7914.52512849228;7980.561069141195;10025.348352357074;10282.948585257102;10287.12559432449;10290.331128476662;10312.226583006268;10076.94961525195;10197.796044079114;10198.847017294747;10199.541020654051;10199.898001020007;7171.605561694105;7372.741954031583;9954.552045157949;10292.794144117075;10586.947065264701;9981.90018099817;10069.899301007043;10122.240831937634;10128.848067278997;10143.23925705575;35665.46501802475;36017;36069.45895811565;36095;36112;2883.1206482022976;2894.421115776853;2952.46855565998;3530.1880567469625;3637.672609465161;26881.462370752477;26993.46013079747;27251.727482725117;27263.318417039733;28356.716432835612;3132.733717634004;3207.06994971458;3221.500667396557;3242.0922141800334;3319.551860498826;311113;315034;315931;316520;316618;53589.732051339495;54227;54267.2012959097;54307.72846135744;54333.72833135888;57953;58318;58377.416225837194;58452;58518;13683.589492315246;13884.236366999912;13890.4443822248;14079.296035198404;14086.71826563463;10548.367097974146;10573.04842564173;10591.57633694659;10592.629257975934;10599.682009539727;18993.93969623657;19175;19226;19275.710864337045;19399.127039283267;7431.777046688608;7682;7761;7795.493292935941;7795.610219489003;804.5494523067101;841.9747407577782;863.7624653220415;890.4568213389826;1053.6786280184617;30323.090307290815;30881.610327534865;31224.21939451532;31274.21814454657;31535.84232078871;818.7380038387658;910.7859652981545;933.869258303838;940.5391358234416;1026.414943482223;13079.869201307865;13206.669833254053;13324.533641322507;13435.932820335836;13448.32758362078;298827;300075;303870;304228;304918;45058;45462.31806522905;45554.316685249745;45561.316580251325;45577;1204.765070811201;1223.9816402753966;1242.0746543824907;1246.9875301247052;1249.194269696059;24069.518609627357;24694.629580556666;24977.375565611004;24986.125485607918;25079.122230722565;36374.72566477899;37048.25903481969;37050.62949370472;37054.888353349445;37082.629173707915;241391;243774;243868;243989;244448;23738.762612373655;24224.394390140387;24912.750872491044;28622.28444288826;29022.419551609273;32095.679043209268;32267.838660807483;32518.83740581282;32607;34047.319053618296;29030.564541531472;29948.550771738006;30221.848890755406;31032.22419439532;31113.84443077861;27555.448891022468;30475.390492190476;30649.233769155948;30744.385112298078;30856;27398.315042124108;28116.90382239235;28128.85935570391;28425.85787071134;30484.542731858597;27714.861425692743;33722;34736.478952815225;34750.35121312226;34831.47752783659;22793;23014;23430.53138937246;23459.88270058639;23475.41311467227 15:46:13 INFO - PROCESS | 6229 | |2;jquery.html;333.93989081965236;334.79744754423575;339.434840989752;339.8419734823307;340.484166487771;12618.873811261885;12940.288284144368;15072.623184420381;15180.772288415668;15932.601684957883;12862;14968.775468367983;15671.60820979476;16032.43886463974;16127.758083628754;4836.274558816171;4881.902361952759;4887.584555312803;4890.437599676047;4898.02039592083;3703.907402314937;3791.6777073948747;3798.1074447504816;4921.80312787488;5635.520980716624;5761.395053519383;5788.47903688668;5808.634970781863;5811.506021988136;5818.5926985111055;5634.774609015655;5748.540116790647;5765.019946609086;5769.163471296639;5769.509591684691;5023.34696489454;5041.193409054534;5050.116229659831;5050.747462626854;5052.444231134609;18896.905515472474;19096.140673669717;19339.51651208731;19404.12681429325;19418;1761.2778760708047;1784.348712719861;1793.757842691246;1912.4071537823181;2001.169514651418;12501.749965000648;12802.871971280261;12858.099933004694;13124.14693044949;13239.933800331033;1747.5718448979953;1767.6641438126715;1789.6062866169423;1793.022802572588;1806.9819301806945;52512;52804;52976.735116324555;52978.470215298126;54092;9083.545822708838;9278.814423711623;9452.05479452063;9454.621815127455;9489.810203795885;11843.170978031627;11846.170768046153;11849.526018959317;11854.525818967144;11861.051115910706;7164.426845852319;7180.748673796392;7217.819554511179;7218.169910460364;7223.422126229889;6732.663366831639;6786.423154031962;6793.184817821893;6798.66006699663;6813.931860681429;5629.324481062217;5714.428557144335;5716.28546431696;5750.539956803445;5777.133429985452;1527.9923600381926;1604.5908293385112;1637.7625244339742;1692.3484458483572;1713.2119225156569;386.0811269179391;388.20611848769335;402.42654217740187;829.1832544943226;835.4068611286054;9167;9549.809003819884;9959.808842054736;10174.796504069876;10217.13154381886;409.65588905319674;413.13860600647985;421.2880232407222;427.4912853704082;443.5054913771122;5442.945570544244;9012.729618111336;9305.348625596278;9332.58003389849;9458.054194580625;295084;298391;299405;299479;300931;47491.05017899692;60391.39608603946;64392;65159.67420162869;66914;1007.4509392381024;1029.130384824822;1029.6190409548365;1036.5024788101603;1047.675220681591;14364.209968451836;14425.78361324602;14479.131252124906;14669.413223470941;15046.688565650034;32108.518372223967;32782.83608581942;33398;33934.83032584821;34200.82899585486;36697.44953825748;37649;37997.81001094977;38456.423153653275;39486.210275794896;8829.470231785857;9091.59087841062;9264.768380790265;9273.814523709623;9281.071892810665;16550.337986480405;16785.244663989906;16798.412055578487;16868.325266989184;16941.152942352586;13982.091164074303;14052.78920816209;14092;14254;14396.496122635657;8487.36344774132;8747.212750852454;13907;14143.64640883986;14205.28973551339;8267.586620669063;8536.658533658832;9553.570089346134;9593.376430531993;9798.608055677692;13524.459021639024;13619.387127579084;13655.522056727967;14016.088954217943;14026.368813403216;14505.564833055025;14630.85369146295;14889.73437257802;14891;15023.248837558296 15:46:13 INFO - PROCESS | 6229 | |3;mootools.html;1413.5829930170598;1424.7577911755;1427.828660560733;1655.1724137931035;1726.3267325742959;5505.174223866422;6733.528652994292;6963.825904352394;6993.335633114859;6993.720251189959;6976.372126508626;6979.616121113337;7053.788386348405;7054.717811287555;7067.1872734635535;1732.2031865341958;1767.6111255523829;2058.4853786553363;2093.3510611710344;2094.7486301643826;2057.351934140748;2075.2217918280644;2091.3307741522717;2092;2094.413564202026;2023.079498828037;2023.1300540767463;2028.9188432462759;2071.6167509010806;2075.1595603780415;2032.5833204193252;2058.9485262868475;2077.0549400022956;2098.318046634842;2103.3584756649216;2058.742657167854;2073.056759174572;2078;2079.054030416157;2083.7916208379042;6826.317368263134;6897.2757860424435;6905.447564194903;6907.861842763116;6912.827179320507;4069.4302797608357;4147.523034851;4151.169766046773;4153.231652144333;4159.292920203573;2659.3085797692547;2720.4151107511784;2729.1676038808155;2738.835669859815;2743.862806859649;876.5573385440375;898.5417437107058;898.865170224465;911.9224865886407;918.8193171774304;9114.77213069672;9121.133492318218;9125;9127.726168214964;9127.908720912772;3729.850805967785;3794.4877441545036;3820.083180036827;3866.9613303867163;3875.9806200968815;7949.64226609804;7953.443258971932;7961.800954976056;7965.721199757981;7967.601619919097;4227.408162857202;4247.5752424757275;4249.617534421917;4250.0437401584395;4250.4474418326035;3811.5235595550557;3816.8282427290837;3865.5747867734526;3870.148567315186;3876.2247550490015;2868.5697145428353;2944.0579014715086;3223.62928263248;3287.769856110097;3364.192593777476;1051.994740026295;1062.198040479433;1067.4822710985165;1074.99462502687;1079.4386918802336;859.239572977919;864.0581765875227;864.4769914201943;872.6901949807853;1119.138263537072;6489.545731798728;6551.475881929529;6553.639549824806;6560.212774467094;6575.8027259181345;1020.5560581147076;1038.2732087538752;1044.2846650044744;1054.773223756896;1057.1922013357091;4920.704757714549;4922;4927.852164435001;4937.08663897173;4957.429895561984;7962;7972.920270797334;8106.7162649308175;8155.673773049011;8165.836683266421;8058.516489010678;8062.435629505995;8065.435419520577;8069.394795390369;8092.919070809335;6454.709538070798;6461.515386346043;6484.092227088211;6512;6517.576357536745;6098.725557350019;6217.658028808459;6258.593191442542;6262.968685156545;6303.590266632654;7276.272372762682;7321.341079302888;7392.926070739439;7440.441966852616;7448.478606497493;7404.703811847466;7564.357029652541;7565.2812982766545;7584.810379740551;7628.8855667163925;6079.939200608114;6153.323134455296;6154.846128846814;6155.507559395327;6163.260408750799;5280.762365693477;5493.340799104133;6086.695665216633;6511.9348806511325;6522.869542609026;5492;6369.267534233622;6387.457066149429;6430.903536446864;6475.967620161869;6189.6286222826775;6200.534959877937;6238.875222495615;6264.154339164154;6359.236891572856;6171.1360409543595;6215.223097112861;6221;6223.439890409703;6232.127502149793;5834.03738383162;5907.793227237198;5918.585699001201;5924.437178468211;5939.10913362999;5897.144913987534;5987.670678112746;5989.311229208697;5990.161377407079;5990.580659353804 15:46:13 INFO - PROCESS | 6229 | |4;prototype.html;307.40517099412637;308.2786280104556;312.10114869176766;313.30446408972074;318.79756354714755;5275.1296036154035;5356.812511562096;5407.324084489439;5410.377806552247;5413.188021796727;5292.311999440068;5295.602829787762;5297.682139071649;5299.231611416342;5330.680159190451;3977.801109944491;4072.063425412157;4177.624013838754;4180.289350810354;4182.16356728654;4076.51081870176;4173.895652608679;4195.119025004753;4196.202721482909;4197.202531519017;4127.917441651165;4146.751194928299;4148.875533733978;4158;4158.4594002779595;3958.1687845552324;4051.918961620751;4090.1206240658103;4114.362273847559;4139.896502587444;3624.8731294404834;3635.563732352108;3642.6721595056574;3643.7631553949172;3644;5140.820071297487;5190.636655434121;5195.974020129913;5204.479552044765;5208.218767184915;4779.068081724065;4791.712497250176;4797.136515427222;4797.928031079537;4798.47216806151;5499.662643376549;5603.2435621191025;5615.129654903497;5620.91568626471;5630.09918413056;4008.819603117867;4014.1770936957855;4014.879553613396;4015.959840401588;4019.5578486366476;5837.9124313135335;5914.083317085859;5921.141434492018;5921.526277897758;5923.407659234128;4165.416841642173;4174.186033723456;4181.540030596632;4190.727602705814;4191.371294305878;4063.674906007512;4228.78856057202;4246.44796176495;4248.681348898845;4252.638525725286;4778.1399348116975;4781.6891902026255;4784.186688263004;4785.353977213032;4786.090642777861;5623.606347555714;5632.127020311858;5632.436756324335;5633.63381380209;5637.774489020393;1484.3023778823936;1503.090630168754;1504.9774253386208;1505.224809223251;1507.0656193160312;1020.4183615339185;1037.1650821089095;1038.2783965144151;1043.9321444106108;1067.9839802402971;4983.476734942851;5000.374953130859;5003.4746351633285;5004.474530174352;5011.699298042129;5874.50066744323;5878.764849406061;5880.206172166788;5883.441073098049;5884;4968.8509344719;4968.8757781055765;4978.751062446936;4980.352554168007;4985.825496107691;2914.1403286030672;2997.145813443158;3117.4544454720335;3137.215696075981;3169.3978144152998;5521.834344969658;5609;5617.550595952396;5617.578681598897;5619.606627536115;6001.609895356788;6055.728297057579;6057.57596968208;6067.45392914631;6074.665893375906;5571.888562228733;5583.944160558342;5606.074997625346;5609.831705048855;5611.102223644279;5720;5875.618084824644;5916.142159386779;5916.319623243382;5935.376785437639;5766.596338256281;5768.105943578752;5770.903528329604;5772.6536407815665;5774.307083150049;5595.552355811444;5596.860078497907;5599.80400685974;5602.85992850182;5604.355499117653;3927.194925040417;3991.780452075164;4072.674186065167;4088.5911408858874;4091.0795071108764;5855.882882342244;5858.619189752652;5861.765529378948;5864.736086876015;5867.413258674099;5601.187827764869;5635.690037048002;5640.492355687844;5655.6323838951985;5656.095024796177;5643.1535269709875;5649.604527683023;5651.587103224194;5657.519110875457;5658.236138121301;5393.6224464287125;5521.723913804374;5523.033469142803;5524.779008839601;5525.033119204043;5660.745266462936;5673.971630141823;5680.034394152921;5681.545476361798;5685.061964775766;5375.220593013913;5443.618946673695;5514.862128446821;5602.9914615368;5607.971960140173 15:46:13 INFO - PROCESS | 6229 | |5;yui.html;706.2090458686268;734.8934404511344;782.2646712090637;796.3947399976018;805.8630032894407;11683.532658693654;11921.642350729471;11974.101942354315;12026.338551379682;12099.395030248485;10981.725456863562;11780.234284771484;11887.940560297186;11892.821607675893;11906.464209110589;805.8468890910723;824.4558591329724;824.4846970643348;825.0594322472386;825.1336097098053;813.7843471480063;819;821.7699044267584;822.0587427395628;822.0628483528752;848.7368915636142;852.5140669818206;854.6367793687689;860.9483430994129;861.2593169873935;849.7705619482767;854.1117238072397;855.1918437076964;855.8630619100976;856.1096459681954;630.574362305442;633.0251412824246;633.297040285283;633.4172561243666;633.8573820890309;11843.703907402298;11963.282203067844;11976.161668683195;11984.161108722394;11999.94000030003;11246.606368777053;11556.479958401893;11561.884381156166;11570.59502917394;11834.230774999598;9615.615375385047;9738.610455581767;9750.804983900282;9763.170130538912;9773.657921972697;3250.106220789302;3269.395161895033;3294.67053294671;3338.065341704327;3403.1322012886803;38588.614113858785;38945;39044.41433378502;39063.21873562513;39070.21859562821;9293.914294563772;9474.194693450996;9582.952085239529;9589.520523973773;9706.417614943126;15542.145182014872;15643.374265029499;15781.28984195714;15805.446809361618;15822;6303.149074874925;6383.872322553523;6399.680015999182;6482.967585162044;6664.400203981665;3712.1647629283193;3712.6844218241754;3748.381517049711;3750.6061863504483;3754.5869954305003;2689.166358428854;2707.323169207698;2734.753872151516;2736.3432776133586;2737.9726202737716;491.17482629182604;497.957673597741;498.9126902791997;500.8923081537487;507.4925074925075;471.85844246725844;494.76004137993044;546.8878879829625;588.0679123589074;592.0911400999445;7615.7334493292465;7774.805629859299;7877.251661092187;8233.50598964064;8400.495970241805;480.4162942025386;537.6156048425395;567.3107174782576;577.5466258986676;590.094205394717;3675.2833197526224;3889.53325600924;4027.093903871664;4046.9392959105635;4142.378643203544;51892.70268243324;52148;52172.21741673878;52177.47822521802;52213;37603.81198094047;37743.81128094342;41747.37378939318;45439.77280113578;47640;41490;41713.374299385534;42492.57507424886;42501.57498424976;42679.14641707148;7798.610069496616;7873.803154920944;8064.959675201587;8071.919280807351;8209.79475513117;29496.262593435335;30028;30337.393252135276;30637.846810765805;30671.2332191697;40142.799286003385;40615.79692101521;40770;40942.38586421266;41002.58997409988;9476.715698529055;9785.119339259501;10017.39895606266;10154.796904062025;10344.32761870476;10169.44068076263;10413.843792343272;10744.30162039465;10879.238453308193;10945.83581246298;10427.374357538572;10599.947000264949;10600.310979786598;10667.253292269466;10788.892111078789;10236.53935572886;10571.841422378517;10631.521581528696;10984.340939543334;11031;9373.343865929319;9833.459159746282;10079.294449388766;10093.041161089684;10105.19158467306;8912.643494260157;9051.637934482547;9164.450132992042;9319.301052421231;9613.03869613033;8701;8981.730548083568;9204.974905520774;9252.95373523128;9254.074592540692 15:46:13 INFO - PROCESS | 6229 | __end_tp_report 15:46:13 INFO - PROCESS | 6229 | __start_cc_report 15:46:13 INFO - PROCESS | 6229 | _x_x_mozilla_cycle_collect,880 15:46:13 INFO - PROCESS | 6229 | __end_cc_report 15:46:13 INFO - PROCESS | 6229 | __startTimestamp1450827973952__endTimestamp 15:46:13 INFO - PROCESS | 6229 | 15:46:13 INFO - PROCESS | 6229 | ------- Summary: start ------- 15:46:13 INFO - PROCESS | 6229 | Number of tests: 6 15:46:13 INFO - PROCESS | 6229 | 15:46:13 INFO - PROCESS | 6229 | [#0] dojo.html Cycles:165 Average:4583.67 Median:4713.72 stddev:469.90 (10.0%) stddev-sans-first:444.55 15:46:13 INFO - PROCESS | 6229 | Values: 2590.1 2657.2 2664.9 2670.4 2676.5 4385.6 4500.2 4596.9 4597.4 4650.0 4557.7 4562.9 4650.2 4654.4 4682.8 4301.1 4306.9 4328.2 4349.9 4361.2 4149.4 4338.9 4342.7 4389.3 4393.8 4136.3 4203.6 4208.6 4230.0 4233.5 4292.6 4314.4 4318.3 4344.5 4353.2 4077.6 4300.4 4309.7 4314.5 4356.0 4526.5 4531.0 4532.0 4586.1 4616.2 4939.5 4951.7 4953.5 4960.9 4995.9 4747.7 4981.8 4983.0 4983.4 4990.3 4489.7 4583.1 4591.8 4594.2 4609.3 5091.4 5120.4 5127.8 5129.8 5130.9 4908.8 4917.8 4922.4 4928.1 4967.1 4736.1 4828.3 4832.8 4871.6 4989.1 4910.2 4946.2 4955.8 4971.9 4979.5 4945.5 4963.7 4966.4 4968.4 5017.7 4018.1 4097.9 4135.4 4170.1 4198.0 3604.8 3698.1 3705.0 3731.7 3743.5 4368.3 4390.1 4390.7 4395.1 4420.3 4769.0 4868.3 4871.8 5066.0 5100.7 4190.8 4259.8 4268.9 4291.6 4303.9 4446.9 4451.3 4488.7 4490.6 4529.0 4581.0 4694.0 4698.0 4780.2 4807.3 4872.1 4920.6 4933.8 4940.6 4953.3 4713.7 4753.7 4764.3 4765.4 4801.3 4922.9 4945.8 4952.0 4997.5 5004.8 4799.7 4806.2 4906.7 4910.4 4923.0 4755.6 4758.3 4760.3 4764.4 4802.5 4703.1 4748.8 4755.7 4763.6 4799.6 4574.2 4696.8 4701.0 4731.5 4872.8 4912.6 4917.5 4926.3 4932.3 4946.1 4827.9 4833.3 4834.4 4871.1 4877.5 15:46:13 INFO - PROCESS | 6229 | 15:46:13 INFO - PROCESS | 6229 | [#1] ext.html Cycles:180 Average:43651.11 Median:30800.19 stddev:75622.17 (245.5%) stddev-sans-first:75765.03 15:46:13 INFO - PROCESS | 6229 | Values: 539.0 539.6 544.4 561.9 569.2 26821.7 32712.7 33186.2 33235.8 33248.7 38346.6 38750.0 38971.2 38986.0 39044.4 6941.7 7075.5 7810.3 7914.5 7980.6 10025.3 10282.9 10287.1 10290.3 10312.2 10076.9 10197.8 10198.8 10199.5 10199.9 7171.6 7372.7 9954.6 10292.8 10586.9 9981.9 10069.9 10122.2 10128.8 10143.2 35665.5 36017.0 36069.5 36095.0 36112.0 2883.1 2894.4 2952.5 3530.2 3637.7 26881.5 26993.5 27251.7 27263.3 28356.7 3132.7 3207.1 3221.5 3242.1 3319.6 311113.0 315034.0 315931.0 316520.0 316618.0 53589.7 54227.0 54267.2 54307.7 54333.7 57953.0 58318.0 58377.4 58452.0 58518.0 13683.6 13884.2 13890.4 14079.3 14086.7 10548.4 10573.0 10591.6 10592.6 10599.7 18993.9 19175.0 19226.0 19275.7 19399.1 7431.8 7682.0 7761.0 7795.5 7795.6 804.5 842.0 863.8 890.5 1053.7 30323.1 30881.6 31224.2 31274.2 31535.8 818.7 910.8 933.9 940.5 1026.4 13079.9 13206.7 13324.5 13435.9 13448.3 298827.0 300075.0 303870.0 304228.0 304918.0 45058.0 45462.3 45554.3 45561.3 45577.0 1204.8 1224.0 1242.1 1247.0 1249.2 24069.5 24694.6 24977.4 24986.1 25079.1 36374.7 37048.3 37050.6 37054.9 37082.6 241391.0 243774.0 243868.0 243989.0 244448.0 23738.8 24224.4 24912.8 28622.3 29022.4 32095.7 32267.8 32518.8 32607.0 34047.3 29030.6 29948.6 30221.8 31032.2 31113.8 27555.4 30475.4 30649.2 30744.4 30856.0 27398.3 28116.9 28128.9 28425.9 30484.5 27714.9 33722.0 34736.5 34750.4 34831.5 22793.0 23014.0 23430.5 23459.9 23475.4 15:46:13 INFO - PROCESS | 6229 | 15:46:13 INFO - PROCESS | 6229 | [#2] jquery.html Cycles:180 Average:20626.06 Median:20200.68 stddev:49036.83 (242.7%) stddev-sans-first:49150.73 15:46:13 INFO - PROCESS | 6229 | Values: 333.9 334.8 339.4 339.8 340.5 12618.9 12940.3 15072.6 15180.8 15932.6 12862.0 14968.8 15671.6 16032.4 16127.8 4836.3 4881.9 4887.6 4890.4 4898.0 3703.9 3791.7 3798.1 4921.8 5635.5 5761.4 5788.5 5808.6 5811.5 5818.6 5634.8 5748.5 5765.0 5769.2 5769.5 5023.3 5041.2 5050.1 5050.7 5052.4 18896.9 19096.1 19339.5 19404.1 19418.0 1761.3 1784.3 1793.8 1912.4 2001.2 12501.7 12802.9 12858.1 13124.1 13239.9 1747.6 1767.7 1789.6 1793.0 1807.0 52512.0 52804.0 52976.7 52978.5 54092.0 9083.5 9278.8 9452.1 9454.6 9489.8 11843.2 11846.2 11849.5 11854.5 11861.1 7164.4 7180.7 7217.8 7218.2 7223.4 6732.7 6786.4 6793.2 6798.7 6813.9 5629.3 5714.4 5716.3 5750.5 5777.1 1528.0 1604.6 1637.8 1692.3 1713.2 386.1 388.2 402.4 829.2 835.4 9167.0 9549.8 9959.8 10174.8 10217.1 409.7 413.1 421.3 427.5 443.5 5442.9 9012.7 9305.3 9332.6 9458.1 295084.0 298391.0 299405.0 299479.0 300931.0 47491.1 60391.4 64392.0 65159.7 66914.0 1007.5 1029.1 1029.6 1036.5 1047.7 14364.2 14425.8 14479.1 14669.4 15046.7 32108.5 32782.8 33398.0 33934.8 34200.8 36697.4 37649.0 37997.8 38456.4 39486.2 8829.5 9091.6 9264.8 9273.8 9281.1 16550.3 16785.2 16798.4 16868.3 16941.2 13982.1 14052.8 14092.0 14254.0 14396.5 8487.4 8747.2 13907.0 14143.6 14205.3 8267.6 8536.7 9553.6 9593.4 9798.6 13524.5 13619.4 13655.5 14016.1 14026.4 14505.6 14630.9 14889.7 14891.0 15023.2 15:46:13 INFO - PROCESS | 6229 | 15:46:13 INFO - PROCESS | 6229 | [#3] mootools.html Cycles:180 Average:4810.35 Median:6083.32 stddev:2447.39 (40.2%) stddev-sans-first:2440.94 15:46:13 INFO - PROCESS | 6229 | Values: 1413.6 1424.8 1427.8 1655.2 1726.3 5505.2 6733.5 6963.8 6993.3 6993.7 6976.4 6979.6 7053.8 7054.7 7067.2 1732.2 1767.6 2058.5 2093.4 2094.7 2057.4 2075.2 2091.3 2092.0 2094.4 2023.1 2023.1 2028.9 2071.6 2075.2 2032.6 2058.9 2077.1 2098.3 2103.4 2058.7 2073.1 2078.0 2079.1 2083.8 6826.3 6897.3 6905.4 6907.9 6912.8 4069.4 4147.5 4151.2 4153.2 4159.3 2659.3 2720.4 2729.2 2738.8 2743.9 876.6 898.5 898.9 911.9 918.8 9114.8 9121.1 9125.0 9127.7 9127.9 3729.9 3794.5 3820.1 3867.0 3876.0 7949.6 7953.4 7961.8 7965.7 7967.6 4227.4 4247.6 4249.6 4250.0 4250.4 3811.5 3816.8 3865.6 3870.1 3876.2 2868.6 2944.1 3223.6 3287.8 3364.2 1052.0 1062.2 1067.5 1075.0 1079.4 859.2 864.1 864.5 872.7 1119.1 6489.5 6551.5 6553.6 6560.2 6575.8 1020.6 1038.3 1044.3 1054.8 1057.2 4920.7 4922.0 4927.9 4937.1 4957.4 7962.0 7972.9 8106.7 8155.7 8165.8 8058.5 8062.4 8065.4 8069.4 8092.9 6454.7 6461.5 6484.1 6512.0 6517.6 6098.7 6217.7 6258.6 6263.0 6303.6 7276.3 7321.3 7392.9 7440.4 7448.5 7404.7 7564.4 7565.3 7584.8 7628.9 6079.9 6153.3 6154.8 6155.5 6163.3 5280.8 5493.3 6086.7 6511.9 6522.9 5492.0 6369.3 6387.5 6430.9 6476.0 6189.6 6200.5 6238.9 6264.2 6359.2 6171.1 6215.2 6221.0 6223.4 6232.1 5834.0 5907.8 5918.6 5924.4 5939.1 5897.1 5987.7 5989.3 5990.2 5990.6 15:46:13 INFO - PROCESS | 6229 | 15:46:13 INFO - PROCESS | 6229 | [#4] prototype.html Cycles:180 Average:4701.42 Median:5283.72 stddev:1371.74 (26.0%) stddev-sans-first:1335.35 15:46:13 INFO - PROCESS | 6229 | Values: 307.4 308.3 312.1 313.3 318.8 5275.1 5356.8 5407.3 5410.4 5413.2 5292.3 5295.6 5297.7 5299.2 5330.7 3977.8 4072.1 4177.6 4180.3 4182.2 4076.5 4173.9 4195.1 4196.2 4197.2 4127.9 4146.8 4148.9 4158.0 4158.5 3958.2 4051.9 4090.1 4114.4 4139.9 3624.9 3635.6 3642.7 3643.8 3644.0 5140.8 5190.6 5196.0 5204.5 5208.2 4779.1 4791.7 4797.1 4797.9 4798.5 5499.7 5603.2 5615.1 5620.9 5630.1 4008.8 4014.2 4014.9 4016.0 4019.6 5837.9 5914.1 5921.1 5921.5 5923.4 4165.4 4174.2 4181.5 4190.7 4191.4 4063.7 4228.8 4246.4 4248.7 4252.6 4778.1 4781.7 4784.2 4785.4 4786.1 5623.6 5632.1 5632.4 5633.6 5637.8 1484.3 1503.1 1505.0 1505.2 1507.1 1020.4 1037.2 1038.3 1043.9 1068.0 4983.5 5000.4 5003.5 5004.5 5011.7 5874.5 5878.8 5880.2 5883.4 5884.0 4968.9 4968.9 4978.8 4980.4 4985.8 2914.1 2997.1 3117.5 3137.2 3169.4 5521.8 5609.0 5617.6 5617.6 5619.6 6001.6 6055.7 6057.6 6067.5 6074.7 5571.9 5583.9 5606.1 5609.8 5611.1 5720.0 5875.6 5916.1 5916.3 5935.4 5766.6 5768.1 5770.9 5772.7 5774.3 5595.6 5596.9 5599.8 5602.9 5604.4 3927.2 3991.8 4072.7 4088.6 4091.1 5855.9 5858.6 5861.8 5864.7 5867.4 5601.2 5635.7 5640.5 5655.6 5656.1 5643.2 5649.6 5651.6 5657.5 5658.2 5393.6 5521.7 5523.0 5524.8 5525.0 5660.7 5674.0 5680.0 5681.5 5685.1 5375.2 5443.6 5514.9 5603.0 5608.0 15:46:13 INFO - PROCESS | 6229 | 15:46:13 INFO - PROCESS | 6229 | [#5] yui.html Cycles:180 Average:12246.98 Median:24055.93 stddev:13864.28 (57.6%) stddev-sans-first:13876.08 15:46:13 INFO - PROCESS | 6229 | Values: 706.2 734.9 782.3 796.4 805.9 11683.5 11921.6 11974.1 12026.3 12099.4 10981.7 11780.2 11887.9 11892.8 11906.5 805.8 824.5 824.5 825.1 825.1 813.8 819.0 821.8 822.1 822.1 848.7 852.5 854.6 860.9 861.3 849.8 854.1 855.2 855.9 856.1 630.6 633.0 633.3 633.4 633.9 11843.7 11963.3 11976.2 11984.2 11999.9 11246.6 11556.5 11561.9 11570.6 11834.2 9615.6 9738.6 9750.8 9763.2 9773.7 3250.1 3269.4 3294.7 3338.1 3403.1 38588.6 38945.0 39044.4 39063.2 39070.2 9293.9 9474.2 9583.0 9589.5 9706.4 15542.1 15643.4 15781.3 15805.4 15822.0 6303.1 6383.9 6399.7 6483.0 6664.4 3712.2 3712.7 3748.4 3750.6 3754.6 2689.2 2707.3 2734.8 2736.3 2738.0 491.2 498.0 498.9 500.9 507.5 471.9 494.8 546.9 588.1 592.1 7615.7 7774.8 7877.3 8233.5 8400.5 480.4 537.6 567.3 577.5 590.1 3675.3 3889.5 4027.1 4046.9 4142.4 51892.7 52148.0 52172.2 52177.5 52213.0 37603.8 37743.8 41747.4 45439.8 47640.0 41490.0 41713.4 42492.6 42501.6 42679.1 7798.6 7873.8 8065.0 8071.9 8209.8 29496.3 30028.0 30337.4 30637.8 30671.2 40142.8 40615.8 40770.0 40942.4 41002.6 9476.7 9785.1 10017.4 10154.8 10344.3 10169.4 10413.8 10744.3 10879.2 10945.8 10427.4 10599.9 10600.3 10667.3 10788.9 10236.5 10571.8 10631.5 10984.3 11031.0 9373.3 9833.5 10079.3 10093.0 10105.2 8912.6 9051.6 9164.5 9319.3 9613.0 8701.0 8981.7 9205.0 9253.0 9254.1 15:46:13 INFO - PROCESS | 6229 | -------- Summary: end -------- 15:46:13 INFO - PROCESS | 6229 | 15:46:14 INFO - TEST-INFO | 6229: exit 0 15:46:14 INFO - TEST-OK | dromaeo_css | took 1118412ms 15:46:14 INFO - TEST-START | kraken 15:46:14 INFO - operating with platform_type : linux_ 15:46:14 INFO - Initialising browser for kraken test... 15:46:14 INFO - TEST-INFO | started process 6415 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFhCh54/profile http://localhost:54195/getInfo.html) 15:46:19 INFO - PROCESS | 6415 | __metrics Screen width/height:1600/1200 15:46:19 INFO - PROCESS | 6415 | colorDepth:24 15:46:19 INFO - PROCESS | 6415 | Browser inner width/height: 1024/697 15:46:19 INFO - PROCESS | 6415 | __metrics 15:46:19 INFO - PROCESS | 6415 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:46:19 INFO - PROCESS | 6415 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:46:19 ERROR - PROCESS | 6415 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 15:46:20 INFO - TEST-INFO | 6415: exit 0 15:46:20 INFO - Browser initialized. 15:46:20 INFO - Running cycle 1/1 for kraken test... 15:46:20 INFO - TEST-INFO | started process 6494 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFhCh54/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:46:32 INFO - PROCESS | 6494 | RSS: Main: 150278144 15:46:32 INFO - PROCESS | 6494 | 15:46:34 INFO - PROCESS | 6494 | Cycle 1(1): loaded http://localhost:54195/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54195/tests/kraken/driver.html?testName=audio-beat-detection) 15:46:35 INFO - PROCESS | 6494 | RSS: Main: 183283712 15:46:35 INFO - PROCESS | 6494 | 15:46:37 INFO - PROCESS | 6494 | Cycle 1(1): loaded http://localhost:54195/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54195/tests/kraken/driver.html?testName=audio-dft) 15:46:38 INFO - PROCESS | 6494 | RSS: Main: 174153728 15:46:38 INFO - PROCESS | 6494 | 15:46:41 INFO - PROCESS | 6494 | Cycle 1(1): loaded http://localhost:54195/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54195/tests/kraken/driver.html?testName=audio-fft) 15:46:42 INFO - PROCESS | 6494 | RSS: Main: 162791424 15:46:42 INFO - PROCESS | 6494 | 15:46:44 INFO - PROCESS | 6494 | Cycle 1(1): loaded http://localhost:54195/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54195/tests/kraken/driver.html?testName=audio-oscillator) 15:46:44 INFO - PROCESS | 6494 | RSS: Main: 162938880 15:46:44 INFO - PROCESS | 6494 | 15:46:46 INFO - PROCESS | 6494 | Cycle 1(1): loaded http://localhost:54195/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54195/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:46:47 INFO - PROCESS | 6494 | RSS: Main: 165216256 15:46:47 INFO - PROCESS | 6494 | 15:46:50 INFO - PROCESS | 6494 | Cycle 1(1): loaded http://localhost:54195/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54195/tests/kraken/driver.html?testName=imaging-darkroom) 15:46:51 INFO - PROCESS | 6494 | RSS: Main: 165924864 15:46:51 INFO - PROCESS | 6494 | 15:46:54 INFO - PROCESS | 6494 | Cycle 1(1): loaded http://localhost:54195/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54195/tests/kraken/driver.html?testName=imaging-desaturate) 15:46:55 INFO - PROCESS | 6494 | RSS: Main: 166014976 15:46:55 INFO - PROCESS | 6494 | 15:46:57 INFO - PROCESS | 6494 | Cycle 1(1): loaded http://localhost:54195/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54195/tests/kraken/driver.html?testName=json-parse-financial) 15:46:58 INFO - PROCESS | 6494 | RSS: Main: 166047744 15:46:58 INFO - PROCESS | 6494 | 15:47:00 INFO - PROCESS | 6494 | Cycle 1(1): loaded http://localhost:54195/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54195/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:47:00 INFO - PROCESS | 6494 | RSS: Main: 177111040 15:47:00 INFO - PROCESS | 6494 | 15:47:02 INFO - PROCESS | 6494 | Cycle 1(1): loaded http://localhost:54195/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54195/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:47:03 INFO - PROCESS | 6494 | RSS: Main: 175173632 15:47:03 INFO - PROCESS | 6494 | 15:47:05 INFO - PROCESS | 6494 | Cycle 1(1): loaded http://localhost:54195/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54195/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:47:05 INFO - PROCESS | 6494 | RSS: Main: 186589184 15:47:05 INFO - PROCESS | 6494 | 15:47:08 INFO - PROCESS | 6494 | Cycle 1(1): loaded http://localhost:54195/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54195/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:47:09 INFO - PROCESS | 6494 | RSS: Main: 190554112 15:47:09 INFO - PROCESS | 6494 | 15:47:11 INFO - PROCESS | 6494 | Cycle 1(1): loaded http://localhost:54195/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54195/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:47:12 INFO - PROCESS | 6494 | RSS: Main: 189087744 15:47:12 INFO - PROCESS | 6494 | 15:47:14 INFO - PROCESS | 6494 | Cycle 1(1): loaded http://localhost:54195/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54195/tests/kraken/driver.html?testName=ai-astar) 15:47:14 INFO - PROCESS | 6494 | RSS: Main: 246403072 15:47:14 INFO - PROCESS | 6494 | 15:47:14 INFO - PROCESS | 6494 | __start_tp_report 15:47:14 INFO - PROCESS | 6494 | _x_x_mozilla_page_load 15:47:14 INFO - PROCESS | 6494 | _x_x_mozilla_page_load_details 15:47:14 INFO - PROCESS | 6494 | |i|pagename|runs| 15:47:14 INFO - PROCESS | 6494 | |0;ai-astar;111;115;107;112;114;113;103;113;112;103 15:47:14 INFO - PROCESS | 6494 | |1;audio-beat-detection;155;128;156;173;130;160;148;129;169;130 15:47:14 INFO - PROCESS | 6494 | |2;audio-dft;161;159;162;161;165;162;162;162;162;161 15:47:14 INFO - PROCESS | 6494 | |3;audio-fft;72;75;85;89;71;72;71;96;88;73 15:47:14 INFO - PROCESS | 6494 | |4;audio-oscillator;94;95;135;95;94;95;143;94;95;128 15:47:14 INFO - PROCESS | 6494 | |5;imaging-gaussian-blur;109;109;110;110;109;109;110;110;110;109 15:47:14 INFO - PROCESS | 6494 | |6;imaging-darkroom;147;146;146;147;146;147;146;146;145;145 15:47:14 INFO - PROCESS | 6494 | |7;imaging-desaturate;95;96;96;95;95;96;95;95;97;95 15:47:14 INFO - PROCESS | 6494 | |8;json-parse-financial;71;70;71;71;70;71;71;71;71;70 15:47:14 INFO - PROCESS | 6494 | |9;json-stringify-tinderbox;67;68;67;69;68;69;68;68;73;68 15:47:14 INFO - PROCESS | 6494 | |10;stanford-crypto-aes;87;84;85;84;84;84;86;85;85;86 15:47:14 INFO - PROCESS | 6494 | |11;stanford-crypto-ccm;118;121;120;118;118;121;124;122;123;128 15:47:14 INFO - PROCESS | 6494 | |12;stanford-crypto-pbkdf2;138;150;148;148;148;137;147;155;145;138 15:47:14 INFO - PROCESS | 6494 | |13;stanford-crypto-sha256-iterative;71;70;70;69;70;70;70;71;68;68 15:47:14 INFO - PROCESS | 6494 | __end_tp_report 15:47:14 INFO - PROCESS | 6494 | __start_cc_report 15:47:14 INFO - PROCESS | 6494 | _x_x_mozilla_cycle_collect,983 15:47:14 INFO - PROCESS | 6494 | __end_cc_report 15:47:14 INFO - PROCESS | 6494 | __startTimestamp1450828034273__endTimestamp 15:47:14 INFO - PROCESS | 6494 | 15:47:14 INFO - PROCESS | 6494 | ------- Summary: start ------- 15:47:14 INFO - PROCESS | 6494 | Number of tests: 14 15:47:14 INFO - PROCESS | 6494 | 15:47:14 INFO - PROCESS | 6494 | [#0] ai-astar Cycles:10 Average:110.30 Median:112.50 stddev:4.40 (3.9%) stddev-sans-first:4.66 15:47:14 INFO - PROCESS | 6494 | Values: 111.0 115.0 107.0 112.0 114.0 113.0 103.0 113.0 112.0 103.0 15:47:14 INFO - PROCESS | 6494 | 15:47:14 INFO - PROCESS | 6494 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:155.50 stddev:17.42 (11.2%) stddev-sans-first:18.28 15:47:14 INFO - PROCESS | 6494 | Values: 155.0 128.0 156.0 173.0 130.0 160.0 148.0 129.0 169.0 130.0 15:47:14 INFO - PROCESS | 6494 | 15:47:14 INFO - PROCESS | 6494 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.49 (0.9%) stddev-sans-first:1.56 15:47:14 INFO - PROCESS | 6494 | Values: 161.0 159.0 162.0 161.0 165.0 162.0 162.0 162.0 162.0 161.0 15:47:14 INFO - PROCESS | 6494 | 15:47:14 INFO - PROCESS | 6494 | [#3] audio-fft Cycles:10 Average:79.20 Median:80.00 stddev:9.33 (11.7%) stddev-sans-first:9.53 15:47:14 INFO - PROCESS | 6494 | Values: 72.0 75.0 85.0 89.0 71.0 72.0 71.0 96.0 88.0 73.0 15:47:14 INFO - PROCESS | 6494 | 15:47:14 INFO - PROCESS | 6494 | [#4] audio-oscillator Cycles:10 Average:106.80 Median:94.50 stddev:20.01 (21.2%) stddev-sans-first:20.68 15:47:14 INFO - PROCESS | 6494 | Values: 94.0 95.0 135.0 95.0 94.0 95.0 143.0 94.0 95.0 128.0 15:47:14 INFO - PROCESS | 6494 | 15:47:14 INFO - PROCESS | 6494 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 15:47:14 INFO - PROCESS | 6494 | Values: 109.0 109.0 110.0 110.0 109.0 109.0 110.0 110.0 110.0 109.0 15:47:14 INFO - PROCESS | 6494 | 15:47:14 INFO - PROCESS | 6494 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 15:47:14 INFO - PROCESS | 6494 | Values: 147.0 146.0 146.0 147.0 146.0 147.0 146.0 146.0 145.0 145.0 15:47:14 INFO - PROCESS | 6494 | 15:47:14 INFO - PROCESS | 6494 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 15:47:14 INFO - PROCESS | 6494 | Values: 95.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 97.0 95.0 15:47:14 INFO - PROCESS | 6494 | 15:47:14 INFO - PROCESS | 6494 | [#8] json-parse-financial Cycles:10 Average:70.70 Median:71.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 15:47:14 INFO - PROCESS | 6494 | Values: 71.0 70.0 71.0 71.0 70.0 71.0 71.0 71.0 71.0 70.0 15:47:14 INFO - PROCESS | 6494 | 15:47:14 INFO - PROCESS | 6494 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.00 stddev:1.72 (2.5%) stddev-sans-first:1.73 15:47:14 INFO - PROCESS | 6494 | Values: 67.0 68.0 67.0 69.0 68.0 69.0 68.0 68.0 73.0 68.0 15:47:14 INFO - PROCESS | 6494 | 15:47:14 INFO - PROCESS | 6494 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.00 stddev:1.05 (1.2%) stddev-sans-first:0.83 15:47:14 INFO - PROCESS | 6494 | Values: 87.0 84.0 85.0 84.0 84.0 84.0 86.0 85.0 85.0 86.0 15:47:14 INFO - PROCESS | 6494 | 15:47:14 INFO - PROCESS | 6494 | [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:121.50 stddev:3.16 (2.6%) stddev-sans-first:3.12 15:47:14 INFO - PROCESS | 6494 | Values: 118.0 121.0 120.0 118.0 118.0 121.0 124.0 122.0 123.0 128.0 15:47:14 INFO - PROCESS | 6494 | 15:47:14 INFO - PROCESS | 6494 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.40 Median:148.00 stddev:5.93 (4.0%) stddev-sans-first:5.65 15:47:14 INFO - PROCESS | 6494 | Values: 138.0 150.0 148.0 148.0 148.0 137.0 147.0 155.0 145.0 138.0 15:47:14 INFO - PROCESS | 6494 | 15:47:14 INFO - PROCESS | 6494 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:1.06 (1.5%) stddev-sans-first:1.01 15:47:14 INFO - PROCESS | 6494 | Values: 71.0 70.0 70.0 69.0 70.0 70.0 70.0 71.0 68.0 68.0 15:47:14 INFO - PROCESS | 6494 | -------- Summary: end -------- 15:47:14 INFO - PROCESS | 6494 | 15:47:15 INFO - TEST-INFO | 6494: exit 0 15:47:15 INFO - TEST-OK | kraken | took 60513ms 15:47:15 INFO - TEST-START | v8_7 15:47:15 INFO - operating with platform_type : linux_ 15:47:15 INFO - Initialising browser for v8_7 test... 15:47:15 INFO - TEST-INFO | started process 6743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKMV0D9/profile http://localhost:54195/getInfo.html) 15:47:19 INFO - PROCESS | 6743 | __metrics Screen width/height:1600/1200 15:47:19 INFO - PROCESS | 6743 | colorDepth:24 15:47:19 INFO - PROCESS | 6743 | Browser inner width/height: 1024/697 15:47:19 INFO - PROCESS | 6743 | __metrics 15:47:19 INFO - PROCESS | 6743 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:47:19 INFO - PROCESS | 6743 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:47:19 ERROR - PROCESS | 6743 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 15:47:20 INFO - TEST-INFO | 6743: exit 0 15:47:20 INFO - Browser initialized. 15:47:20 INFO - Running cycle 1/1 for v8_7 test... 15:47:20 INFO - TEST-INFO | started process 6824 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKMV0D9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:47:32 INFO - PROCESS | 6824 | RSS: Main: 150061056 15:47:32 INFO - PROCESS | 6824 | 15:47:54 INFO - PROCESS | 6824 | Cycle 1(1): loaded http://localhost:54195/tests/v8_7/run.html (next: http://localhost:54195/tests/v8_7/run.html) 15:47:54 INFO - PROCESS | 6824 | RSS: Main: 454914048 15:47:54 INFO - PROCESS | 6824 | 15:47:54 INFO - PROCESS | 6824 | __start_tp_report 15:47:54 INFO - PROCESS | 6824 | _x_x_mozilla_page_load 15:47:54 INFO - PROCESS | 6824 | _x_x_mozilla_page_load_details 15:47:54 INFO - PROCESS | 6824 | |i|pagename|runs| 15:47:54 INFO - PROCESS | 6824 | |0;Richards;167.81339150864238 15:47:54 INFO - PROCESS | 6824 | |1;DeltaBlue;186.53236336504384 15:47:54 INFO - PROCESS | 6824 | |2;Encrypt;278.08676307007784 15:47:54 INFO - PROCESS | 6824 | |3;Decrypt;5180.412371134021 15:47:54 INFO - PROCESS | 6824 | |4;RayTrace;1968.5039370078741 15:47:54 INFO - PROCESS | 6824 | |5;Earley;788.6435331230284 15:47:54 INFO - PROCESS | 6824 | |6;Boyer;11894.117647058823 15:47:54 INFO - PROCESS | 6824 | |7;RegExp;27135.135135135137 15:47:54 INFO - PROCESS | 6824 | |8;Splay;609.7560975609756 15:47:54 INFO - PROCESS | 6824 | |9;NavierStokes;4850.241545893719 15:47:54 INFO - PROCESS | 6824 | __end_tp_report 15:47:54 INFO - PROCESS | 6824 | __startTimestamp1450828074414__endTimestamp 15:47:54 INFO - PROCESS | 6824 | 15:47:54 INFO - PROCESS | 6824 | ------- Summary: start ------- 15:47:54 INFO - PROCESS | 6824 | Number of tests: 10 15:47:54 INFO - PROCESS | 6824 | 15:47:54 INFO - PROCESS | 6824 | [#0] Richards Cycles:1 Average:167.81 Median:167.81 stddev:0.00 (0.0%) 15:47:54 INFO - PROCESS | 6824 | Values: 167.8 15:47:54 INFO - PROCESS | 6824 | 15:47:54 INFO - PROCESS | 6824 | [#1] DeltaBlue Cycles:1 Average:186.53 Median:186.53 stddev:0.00 (0.0%) 15:47:54 INFO - PROCESS | 6824 | Values: 186.5 15:47:54 INFO - PROCESS | 6824 | 15:47:54 INFO - PROCESS | 6824 | [#2] Encrypt Cycles:1 Average:278.09 Median:278.09 stddev:0.00 (0.0%) 15:47:54 INFO - PROCESS | 6824 | Values: 278.1 15:47:54 INFO - PROCESS | 6824 | 15:47:54 INFO - PROCESS | 6824 | [#3] Decrypt Cycles:1 Average:5180.41 Median:5180.41 stddev:0.00 (0.0%) 15:47:54 INFO - PROCESS | 6824 | Values: 5180.4 15:47:54 INFO - PROCESS | 6824 | 15:47:54 INFO - PROCESS | 6824 | [#4] RayTrace Cycles:1 Average:1968.50 Median:1968.50 stddev:0.00 (0.0%) 15:47:54 INFO - PROCESS | 6824 | Values: 1968.5 15:47:54 INFO - PROCESS | 6824 | 15:47:54 INFO - PROCESS | 6824 | [#5] Earley Cycles:1 Average:788.64 Median:788.64 stddev:0.00 (0.0%) 15:47:54 INFO - PROCESS | 6824 | Values: 788.6 15:47:54 INFO - PROCESS | 6824 | 15:47:54 INFO - PROCESS | 6824 | [#6] Boyer Cycles:1 Average:11894.12 Median:11894.12 stddev:0.00 (0.0%) 15:47:54 INFO - PROCESS | 6824 | Values: 11894.1 15:47:54 INFO - PROCESS | 6824 | 15:47:54 INFO - PROCESS | 6824 | [#7] RegExp Cycles:1 Average:27135.14 Median:27135.14 stddev:0.00 (0.0%) 15:47:54 INFO - PROCESS | 6824 | Values: 27135.1 15:47:54 INFO - PROCESS | 6824 | 15:47:54 INFO - PROCESS | 6824 | [#8] Splay Cycles:1 Average:609.76 Median:609.76 stddev:0.00 (0.0%) 15:47:54 INFO - PROCESS | 6824 | Values: 609.8 15:47:54 INFO - PROCESS | 6824 | 15:47:54 INFO - PROCESS | 6824 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 15:47:54 INFO - PROCESS | 6824 | Values: 4850.2 15:47:54 INFO - PROCESS | 6824 | -------- Summary: end -------- 15:47:54 INFO - PROCESS | 6824 | 15:47:55 INFO - TEST-INFO | 6824: exit 0 15:47:55 INFO - TEST-OK | v8_7 | took 40174ms 15:47:55 INFO - SUITE-END | took 1219s 15:47:55 INFO - Completed test suite (00:20:19) 15:47:55 INFO - Working with test: dromaeo_css 15:47:55 INFO - Generating results file: dromaeo_css 15:47:55 INFO - Working with test: kraken 15:47:55 INFO - Generating results file: kraken 15:47:55 INFO - javascript benchmark 15:47:55 INFO - Working with test: v8_7 15:47:55 INFO - Generating results file: v8_7 15:47:55 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:47:55 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 15:47:55 INFO - process_Request line: dromaeo_css 6257.09 graph.html#tests=[[72,132,35]] 15:47:55 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:47:55 INFO - process_Request line: kraken 1517.50 graph.html#tests=[[232,132,35]] 15:47:55 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:47:55 INFO - process_Request line: v8_7 19812.41 graph.html#tests=[[230,132,35]] 15:47:55 INFO - RETURN: dromaeo_css: 6257.09 15:47:55 INFO - RETURN: kraken: 1517.50 15:47:55 INFO - RETURN: v8_7: 19812.41 15:47:55 INFO - javascript benchmark 15:47:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2590.1288088297583, 2657.189557185059, 2664.933376665583, 2670.412509247965, 2676.4513274778665, 4385.583369579893, 4500.212462819002, 4596.931046034308, 4597.448306203252, 4650.0467404182145, 4557.703749256304, 4562.931556026662, 4650.186217411956, 4654.39492865927, 4682.812687492505, 4301.053768171005, 4306.870793876173, 4328.242557552431, 4349.891252718691, 4361.171377438292, 4149.439825623533, 4338.939003973119, 4342.717723347972, 4389.31965545341, 4393.824247030131, 4136.296829538986, 4203.579642035803, 4208.579142085798, 4229.957700423018, 4233.491980962273, 4292.59220374064, 4314.3528470729325, 4318.265894797892, 4344.543822898613, 4353.172897149531, 4077.55146933837, 4300.376445415397, 4309.741415515079, 4314.525402205755, 4356.041670832412, 4526.54734526548, 4530.977345113286, 4531.977340113312, 4586.128635559233, 4616.215243408628, 4939.53074457926, 4951.678140920829, 4953.455119936804, 4960.90078198434, 4995.900081998339, 4747.667663263573, 4981.750912454363, 4983.003399320114, 4983.377077865267, 4990.30135780991, 4489.663275254369, 4583.106294272585, 4591.816327346869, 4594.150082234763, 4609.3086037094035, 5091.439941606421, 5120.359955005624, 5127.794888204505, 5129.769160387791, 5130.9230361544605, 4908.754562271872, 4917.827876024394, 4922.409310882717, 4928.112939670822, 4967.105920934194, 4736.076465089343, 4828.2998965150555, 4832.830850920272, 4871.561559459595, 4989.101961646866, 4910.238912968495, 4946.233333833262, 4955.801767929314, 4971.875703107451, 4979.45226025137, 4945.505449455026, 4963.70217786934, 4966.428860680996, 4968.403791545038, 5017.67385119966, 4018.0758425562285, 4097.8770636880945, 4135.359019352005, 4170.124273902454, 4197.97901010493, 3604.8017359045502, 3698.1124530113116, 3705.0, 3731.7014638828828, 3743.47591337213, 4368.257396242583, 4390.143921935192, 4390.714603550759, 4395.077033822869, 4420.270655341833, 4769.046190761862, 4868.342773725572, 4871.756412179377, 5066.0, 5100.69395836251, 4190.790460476964, 4259.765712885821, 4268.850590229327, 4291.570842915746, 4303.913921721611, 4446.866594002185, 4451.3323001550025, 4488.663350248745, 4490.595846373777, 4529.048899731093, 4581.0, 4693.9765301173275, 4697.966447381571, 4780.235162374073, 4807.278908163804, 4872.074305881871, 4920.630952678492, 4933.753312334441, 4940.580050695731, 4953.2570114483115, 4713.717176969393, 4753.738544380092, 4764.2615394613895, 4765.35667684872, 4801.255805350176, 4922.85231443043, 4945.8021679132435, 4951.97524012392, 4997.475265097258, 5004.824831130893, 4799.66402351832, 4806.2310030394965, 4906.681065730716, 4910.410750709938, 4922.950770492393, 4755.595774359218, 4758.286257061469, 4760.285957106324, 4764.404449443819, 4802.51974802517, 4703.082898834831, 4748.810047598057, 4755.714657120584, 4763.618910487222, 4799.568038876518, 4574.245249533789, 4696.765161741968, 4700.976495117503, 4731.479537250969, 4872.805087796449, 4912.631552633496, 4917.459079501181, 4926.285688575065, 4932.28481870134, 4946.134426475281, 4827.879303017453, 4833.299171620025, 4834.395700537433, 4871.074495845778, 4877.463479017234], "unit": "score", "name": "dojo.html", "value": 4554.798777564947}, {"lowerIsBetter": false, "replicates": [539.0109149710281, 539.6303532080525, 544.3603765575448, 561.8679610291583, 569.2429069337782, 26821.731782682167, 32712.67287327126, 33186.17034574137, 33235.83382083086, 33248.66751332486, 38346.616533834655, 38750.0, 38971.22057558847, 38986.0, 39044.414333784945, 6941.722331106775, 7075.46933979951, 7810.258025487598, 7914.52512849228, 7980.561069141195, 10025.348352357074, 10282.948585257102, 10287.12559432449, 10290.331128476662, 10312.226583006268, 10076.94961525195, 10197.796044079114, 10198.847017294747, 10199.541020654051, 10199.898001020007, 7171.605561694105, 7372.741954031583, 9954.552045157949, 10292.794144117075, 10586.947065264701, 9981.90018099817, 10069.899301007043, 10122.240831937634, 10128.848067278997, 10143.23925705575, 35665.46501802475, 36017.0, 36069.45895811565, 36095.0, 36112.0, 2883.1206482022976, 2894.421115776853, 2952.46855565998, 3530.1880567469625, 3637.672609465161, 26881.462370752477, 26993.46013079747, 27251.727482725117, 27263.318417039733, 28356.716432835612, 3132.733717634004, 3207.06994971458, 3221.500667396557, 3242.0922141800334, 3319.551860498826, 311113.0, 315034.0, 315931.0, 316520.0, 316618.0, 53589.732051339495, 54227.0, 54267.2012959097, 54307.72846135744, 54333.72833135888, 57953.0, 58318.0, 58377.416225837194, 58452.0, 58518.0, 13683.589492315246, 13884.236366999912, 13890.4443822248, 14079.296035198404, 14086.71826563463, 10548.367097974146, 10573.04842564173, 10591.57633694659, 10592.629257975934, 10599.682009539727, 18993.93969623657, 19175.0, 19226.0, 19275.710864337045, 19399.127039283267, 7431.777046688608, 7682.0, 7761.0, 7795.493292935941, 7795.610219489003, 804.5494523067101, 841.9747407577782, 863.7624653220415, 890.4568213389826, 1053.6786280184617, 30323.090307290815, 30881.610327534865, 31224.21939451532, 31274.21814454657, 31535.84232078871, 818.7380038387658, 910.7859652981545, 933.869258303838, 940.5391358234416, 1026.414943482223, 13079.869201307865, 13206.669833254053, 13324.533641322507, 13435.932820335836, 13448.32758362078, 298827.0, 300075.0, 303870.0, 304228.0, 304918.0, 45058.0, 45462.31806522905, 45554.316685249745, 45561.316580251325, 45577.0, 1204.765070811201, 1223.9816402753966, 1242.0746543824907, 1246.9875301247052, 1249.194269696059, 24069.518609627357, 24694.629580556666, 24977.375565611004, 24986.125485607918, 25079.122230722565, 36374.72566477899, 37048.25903481969, 37050.62949370472, 37054.888353349445, 37082.629173707915, 241391.0, 243774.0, 243868.0, 243989.0, 244448.0, 23738.762612373655, 24224.394390140387, 24912.750872491044, 28622.28444288826, 29022.419551609273, 32095.679043209268, 32267.838660807483, 32518.83740581282, 32607.0, 34047.319053618296, 29030.564541531472, 29948.550771738006, 30221.848890755406, 31032.22419439532, 31113.84443077861, 27555.448891022468, 30475.390492190476, 30649.233769155948, 30744.385112298078, 30856.0, 27398.315042124108, 28116.90382239235, 28128.85935570391, 28425.85787071134, 30484.542731858597, 27714.861425692743, 33722.0, 34736.478952815225, 34750.35121312226, 34831.47752783659, 22793.0, 23014.0, 23430.53138937246, 23459.88270058639, 23475.41311467227], "unit": "score", "name": "ext.html", "value": 17083.817810892764}, {"lowerIsBetter": false, "replicates": [333.93989081965236, 334.79744754423575, 339.434840989752, 339.8419734823307, 340.484166487771, 12618.873811261885, 12940.288284144368, 15072.623184420381, 15180.772288415668, 15932.601684957883, 12862.0, 14968.775468367983, 15671.60820979476, 16032.43886463974, 16127.758083628754, 4836.274558816171, 4881.902361952759, 4887.584555312803, 4890.437599676047, 4898.02039592083, 3703.907402314937, 3791.6777073948747, 3798.1074447504816, 4921.80312787488, 5635.520980716624, 5761.395053519383, 5788.47903688668, 5808.634970781863, 5811.506021988136, 5818.5926985111055, 5634.774609015655, 5748.540116790647, 5765.019946609086, 5769.163471296639, 5769.509591684691, 5023.34696489454, 5041.193409054534, 5050.116229659831, 5050.747462626854, 5052.444231134609, 18896.905515472474, 19096.140673669717, 19339.51651208731, 19404.12681429325, 19418.0, 1761.2778760708047, 1784.348712719861, 1793.757842691246, 1912.4071537823181, 2001.169514651418, 12501.749965000648, 12802.871971280261, 12858.099933004694, 13124.14693044949, 13239.933800331033, 1747.5718448979953, 1767.6641438126715, 1789.6062866169423, 1793.022802572588, 1806.9819301806945, 52512.0, 52804.0, 52976.735116324555, 52978.470215298126, 54092.0, 9083.545822708838, 9278.814423711623, 9452.05479452063, 9454.621815127455, 9489.810203795885, 11843.170978031627, 11846.170768046153, 11849.526018959317, 11854.525818967144, 11861.051115910706, 7164.426845852319, 7180.748673796392, 7217.819554511179, 7218.169910460364, 7223.422126229889, 6732.663366831639, 6786.423154031962, 6793.184817821893, 6798.66006699663, 6813.931860681429, 5629.324481062217, 5714.428557144335, 5716.28546431696, 5750.539956803445, 5777.133429985452, 1527.9923600381926, 1604.5908293385112, 1637.7625244339742, 1692.3484458483572, 1713.2119225156569, 386.0811269179391, 388.20611848769335, 402.42654217740187, 829.1832544943226, 835.4068611286054, 9167.0, 9549.809003819884, 9959.808842054736, 10174.796504069876, 10217.13154381886, 409.65588905319674, 413.13860600647985, 421.2880232407222, 427.4912853704082, 443.5054913771122, 5442.945570544244, 9012.729618111336, 9305.348625596278, 9332.58003389849, 9458.054194580625, 295084.0, 298391.0, 299405.0, 299479.0, 300931.0, 47491.05017899692, 60391.39608603946, 64392.0, 65159.67420162869, 66914.0, 1007.4509392381024, 1029.130384824822, 1029.6190409548365, 1036.5024788101603, 1047.675220681591, 14364.209968451836, 14425.78361324602, 14479.131252124906, 14669.413223470941, 15046.688565650034, 32108.518372223967, 32782.83608581942, 33398.0, 33934.83032584821, 34200.82899585486, 36697.44953825748, 37649.0, 37997.81001094977, 38456.423153653275, 39486.210275794896, 8829.470231785857, 9091.59087841062, 9264.768380790265, 9273.814523709623, 9281.071892810665, 16550.337986480405, 16785.244663989906, 16798.412055578487, 16868.325266989184, 16941.152942352586, 13982.091164074303, 14052.78920816209, 14092.0, 14254.0, 14396.496122635657, 8487.36344774132, 8747.212750852454, 13907.0, 14143.64640883986, 14205.28973551339, 8267.586620669063, 8536.658533658832, 9553.570089346134, 9593.376430531993, 9798.608055677692, 13524.459021639024, 13619.387127579084, 13655.522056727967, 14016.088954217943, 14026.368813403216, 14505.564833055025, 14630.85369146295, 14889.73437257802, 14891.0, 15023.248837558296], "unit": "score", "name": "jquery.html", "value": 7887.2383814289215}, {"lowerIsBetter": false, "replicates": [1413.5829930170598, 1424.7577911755, 1427.828660560733, 1655.1724137931035, 1726.3267325742959, 5505.174223866422, 6733.528652994292, 6963.825904352394, 6993.335633114859, 6993.720251189959, 6976.372126508626, 6979.616121113337, 7053.788386348405, 7054.717811287555, 7067.1872734635535, 1732.2031865341958, 1767.6111255523829, 2058.4853786553363, 2093.3510611710344, 2094.7486301643826, 2057.351934140748, 2075.2217918280644, 2091.3307741522717, 2092.0, 2094.413564202026, 2023.079498828037, 2023.1300540767463, 2028.9188432462759, 2071.6167509010806, 2075.1595603780415, 2032.5833204193252, 2058.9485262868475, 2077.0549400022956, 2098.318046634842, 2103.3584756649216, 2058.742657167854, 2073.056759174572, 2078.0, 2079.054030416157, 2083.7916208379042, 6826.317368263134, 6897.2757860424435, 6905.447564194903, 6907.861842763116, 6912.827179320507, 4069.4302797608357, 4147.523034851, 4151.169766046773, 4153.231652144333, 4159.292920203573, 2659.3085797692547, 2720.4151107511784, 2729.1676038808155, 2738.835669859815, 2743.862806859649, 876.5573385440375, 898.5417437107058, 898.865170224465, 911.9224865886407, 918.8193171774304, 9114.77213069672, 9121.133492318218, 9125.0, 9127.726168214964, 9127.908720912772, 3729.850805967785, 3794.4877441545036, 3820.083180036827, 3866.9613303867163, 3875.9806200968815, 7949.64226609804, 7953.443258971932, 7961.800954976056, 7965.721199757981, 7967.601619919097, 4227.408162857202, 4247.5752424757275, 4249.617534421917, 4250.0437401584395, 4250.4474418326035, 3811.5235595550557, 3816.8282427290837, 3865.5747867734526, 3870.148567315186, 3876.2247550490015, 2868.5697145428353, 2944.0579014715086, 3223.62928263248, 3287.769856110097, 3364.192593777476, 1051.994740026295, 1062.198040479433, 1067.4822710985165, 1074.99462502687, 1079.4386918802336, 859.239572977919, 864.0581765875227, 864.4769914201943, 872.6901949807853, 1119.138263537072, 6489.545731798728, 6551.475881929529, 6553.639549824806, 6560.212774467094, 6575.8027259181345, 1020.5560581147076, 1038.2732087538752, 1044.2846650044744, 1054.773223756896, 1057.1922013357091, 4920.704757714549, 4922.0, 4927.852164435001, 4937.08663897173, 4957.429895561984, 7962.0, 7972.920270797334, 8106.7162649308175, 8155.673773049011, 8165.836683266421, 8058.516489010678, 8062.435629505995, 8065.435419520577, 8069.394795390369, 8092.919070809335, 6454.709538070798, 6461.515386346043, 6484.092227088211, 6512.0, 6517.576357536745, 6098.725557350019, 6217.658028808459, 6258.593191442542, 6262.968685156545, 6303.590266632654, 7276.272372762682, 7321.341079302888, 7392.926070739439, 7440.441966852616, 7448.478606497493, 7404.703811847466, 7564.357029652541, 7565.2812982766545, 7584.810379740551, 7628.8855667163925, 6079.939200608114, 6153.323134455296, 6154.846128846814, 6155.507559395327, 6163.260408750799, 5280.762365693477, 5493.340799104133, 6086.695665216633, 6511.9348806511325, 6522.869542609026, 5492.0, 6369.267534233622, 6387.457066149429, 6430.903536446864, 6475.967620161869, 6189.6286222826775, 6200.534959877937, 6238.875222495615, 6264.154339164154, 6359.236891572856, 6171.1360409543595, 6215.223097112861, 6221.0, 6223.439890409703, 6232.127502149793, 5834.03738383162, 5907.793227237198, 5918.585699001201, 5924.437178468211, 5939.10913362999, 5897.144913987534, 5987.670678112746, 5989.311229208697, 5990.161377407079, 5990.580659353804], "unit": "score", "name": "mootools.html", "value": 3976.7298785467547}, {"lowerIsBetter": false, "replicates": [307.40517099412637, 308.2786280104556, 312.10114869176766, 313.30446408972074, 318.79756354714755, 5275.1296036154035, 5356.812511562096, 5407.324084489439, 5410.377806552247, 5413.188021796727, 5292.311999440068, 5295.602829787762, 5297.682139071649, 5299.231611416342, 5330.680159190451, 3977.801109944491, 4072.063425412157, 4177.624013838754, 4180.289350810354, 4182.16356728654, 4076.51081870176, 4173.895652608679, 4195.119025004753, 4196.202721482909, 4197.202531519017, 4127.917441651165, 4146.751194928299, 4148.875533733978, 4158.0, 4158.4594002779595, 3958.1687845552324, 4051.918961620751, 4090.1206240658103, 4114.362273847559, 4139.896502587444, 3624.8731294404834, 3635.563732352108, 3642.6721595056574, 3643.7631553949172, 3644.0, 5140.820071297487, 5190.636655434121, 5195.974020129913, 5204.479552044765, 5208.218767184915, 4779.068081724065, 4791.712497250176, 4797.136515427222, 4797.928031079537, 4798.47216806151, 5499.662643376549, 5603.2435621191025, 5615.129654903497, 5620.91568626471, 5630.09918413056, 4008.819603117867, 4014.1770936957855, 4014.879553613396, 4015.959840401588, 4019.5578486366476, 5837.9124313135335, 5914.083317085859, 5921.141434492018, 5921.526277897758, 5923.407659234128, 4165.416841642173, 4174.186033723456, 4181.540030596632, 4190.727602705814, 4191.371294305878, 4063.674906007512, 4228.78856057202, 4246.44796176495, 4248.681348898845, 4252.638525725286, 4778.1399348116975, 4781.6891902026255, 4784.186688263004, 4785.353977213032, 4786.090642777861, 5623.606347555714, 5632.127020311858, 5632.436756324335, 5633.63381380209, 5637.774489020393, 1484.3023778823936, 1503.090630168754, 1504.9774253386208, 1505.224809223251, 1507.0656193160312, 1020.4183615339185, 1037.1650821089095, 1038.2783965144151, 1043.9321444106108, 1067.9839802402971, 4983.476734942851, 5000.374953130859, 5003.4746351633285, 5004.474530174352, 5011.699298042129, 5874.50066744323, 5878.764849406061, 5880.206172166788, 5883.441073098049, 5884.0, 4968.8509344719, 4968.8757781055765, 4978.751062446936, 4980.352554168007, 4985.825496107691, 2914.1403286030672, 2997.145813443158, 3117.4544454720335, 3137.215696075981, 3169.3978144152998, 5521.834344969658, 5609.0, 5617.550595952396, 5617.578681598897, 5619.606627536115, 6001.609895356788, 6055.728297057579, 6057.57596968208, 6067.45392914631, 6074.665893375906, 5571.888562228733, 5583.944160558342, 5606.074997625346, 5609.831705048855, 5611.102223644279, 5720.0, 5875.618084824644, 5916.142159386779, 5916.319623243382, 5935.376785437639, 5766.596338256281, 5768.105943578752, 5770.903528329604, 5772.6536407815665, 5774.307083150049, 5595.552355811444, 5596.860078497907, 5599.80400685974, 5602.85992850182, 5604.355499117653, 3927.194925040417, 3991.780452075164, 4072.674186065167, 4088.5911408858874, 4091.0795071108764, 5855.882882342244, 5858.619189752652, 5861.765529378948, 5864.736086876015, 5867.413258674099, 5601.187827764869, 5635.690037048002, 5640.492355687844, 5655.6323838951985, 5656.095024796177, 5643.1535269709875, 5649.604527683023, 5651.587103224194, 5657.519110875457, 5658.236138121301, 5393.6224464287125, 5521.723913804374, 5523.033469142803, 5524.779008839601, 5525.033119204043, 5660.745266462936, 5673.971630141823, 5680.034394152921, 5681.545476361798, 5685.061964775766, 5375.220593013913, 5443.618946673695, 5514.862128446821, 5602.9914615368, 5607.971960140173], "unit": "score", "name": "prototype.html", "value": 4266.191845925322}, {"lowerIsBetter": false, "replicates": [706.2090458686268, 734.8934404511344, 782.2646712090637, 796.3947399976018, 805.8630032894407, 11683.532658693654, 11921.642350729471, 11974.101942354315, 12026.338551379682, 12099.395030248485, 10981.725456863562, 11780.234284771484, 11887.940560297186, 11892.821607675893, 11906.464209110589, 805.8468890910723, 824.4558591329724, 824.4846970643348, 825.0594322472386, 825.1336097098053, 813.7843471480063, 819.0, 821.7699044267584, 822.0587427395628, 822.0628483528752, 848.7368915636142, 852.5140669818206, 854.6367793687689, 860.9483430994129, 861.2593169873935, 849.7705619482767, 854.1117238072397, 855.1918437076964, 855.8630619100976, 856.1096459681954, 630.574362305442, 633.0251412824246, 633.297040285283, 633.4172561243666, 633.8573820890309, 11843.703907402298, 11963.282203067844, 11976.161668683195, 11984.161108722394, 11999.94000030003, 11246.606368777053, 11556.479958401893, 11561.884381156166, 11570.59502917394, 11834.230774999598, 9615.615375385047, 9738.610455581767, 9750.804983900282, 9763.170130538912, 9773.657921972697, 3250.106220789302, 3269.395161895033, 3294.67053294671, 3338.065341704327, 3403.1322012886803, 38588.614113858785, 38945.0, 39044.41433378502, 39063.21873562513, 39070.21859562821, 9293.914294563772, 9474.194693450996, 9582.952085239529, 9589.520523973773, 9706.417614943126, 15542.145182014872, 15643.374265029499, 15781.28984195714, 15805.446809361618, 15822.0, 6303.149074874925, 6383.872322553523, 6399.680015999182, 6482.967585162044, 6664.400203981665, 3712.1647629283193, 3712.6844218241754, 3748.381517049711, 3750.6061863504483, 3754.5869954305003, 2689.166358428854, 2707.323169207698, 2734.753872151516, 2736.3432776133586, 2737.9726202737716, 491.17482629182604, 497.957673597741, 498.9126902791997, 500.8923081537487, 507.4925074925075, 471.85844246725844, 494.76004137993044, 546.8878879829625, 588.0679123589074, 592.0911400999445, 7615.7334493292465, 7774.805629859299, 7877.251661092187, 8233.50598964064, 8400.495970241805, 480.4162942025386, 537.6156048425395, 567.3107174782576, 577.5466258986676, 590.094205394717, 3675.2833197526224, 3889.53325600924, 4027.093903871664, 4046.9392959105635, 4142.378643203544, 51892.70268243324, 52148.0, 52172.21741673878, 52177.47822521802, 52213.0, 37603.81198094047, 37743.81128094342, 41747.37378939318, 45439.77280113578, 47640.0, 41490.0, 41713.374299385534, 42492.57507424886, 42501.57498424976, 42679.14641707148, 7798.610069496616, 7873.803154920944, 8064.959675201587, 8071.919280807351, 8209.79475513117, 29496.262593435335, 30028.0, 30337.393252135276, 30637.846810765805, 30671.2332191697, 40142.799286003385, 40615.79692101521, 40770.0, 40942.38586421266, 41002.58997409988, 9476.715698529055, 9785.119339259501, 10017.39895606266, 10154.796904062025, 10344.32761870476, 10169.44068076263, 10413.843792343272, 10744.30162039465, 10879.238453308193, 10945.83581246298, 10427.374357538572, 10599.947000264949, 10600.310979786598, 10667.253292269466, 10788.892111078789, 10236.53935572886, 10571.841422378517, 10631.521581528696, 10984.340939543334, 11031.0, 9373.343865929319, 9833.459159746282, 10079.294449388766, 10093.041161089684, 10105.19158467306, 8912.643494260157, 9051.637934482547, 9164.450132992042, 9319.301052421231, 9613.03869613033, 8701.0, 8981.730548083568, 9204.974905520774, 9252.95373523128, 9254.074592540692], "unit": "score", "name": "yui.html", "value": 5762.9251564746155}], "name": "dromaeo_css", "value": 6257.089695890568}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 115.0, 107.0, 112.0, 114.0, 113.0, 103.0, 113.0, 112.0, 103.0], "unit": "score", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [155.0, 128.0, 156.0, 173.0, 130.0, 160.0, 148.0, 129.0, 169.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 147.8}, {"lowerIsBetter": true, "replicates": [161.0, 159.0, 162.0, 161.0, 165.0, 162.0, 162.0, 162.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 85.0, 89.0, 71.0, 72.0, 71.0, 96.0, 88.0, 73.0], "unit": "score", "name": "audio-fft", "value": 79.2}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 135.0, 95.0, 94.0, 95.0, 143.0, 94.0, 95.0, 128.0], "unit": "score", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 97.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 71.0, 71.0, 70.0, 71.0, 71.0, 71.0, 71.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 70.7}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 69.0, 68.0, 69.0, 68.0, 68.0, 73.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 85.0, 84.0, 84.0, 84.0, 86.0, 85.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [118.0, 121.0, 120.0, 118.0, 118.0, 121.0, 124.0, 122.0, 123.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.3}, {"lowerIsBetter": true, "replicates": [138.0, 150.0, 148.0, 148.0, 148.0, 137.0, 147.0, 155.0, 145.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.4}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 70.0, 69.0, 70.0, 70.0, 70.0, 71.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1517.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.81339150864238], "unit": "score", "name": "Richards", "value": 210.36461799999995}, {"lowerIsBetter": false, "replicates": [186.53236336504384], "unit": "score", "name": "DeltaBlue", "value": 354.4585980000001}, {"lowerIsBetter": false, "replicates": [278.08676307007784], "unit": "score", "name": "Encrypt", "value": 957.1868759999999}, {"lowerIsBetter": false, "replicates": [5180.412371134021], "unit": "score", "name": "Decrypt", "value": 51.38220298507464}, {"lowerIsBetter": false, "replicates": [1968.5039370078741], "unit": "score", "name": "RayTrace", "value": 375.9144119999999}, {"lowerIsBetter": false, "replicates": [788.6435331230284], "unit": "score", "name": "Earley", "value": 845.075084}, {"lowerIsBetter": false, "replicates": [11894.117647058823], "unit": "score", "name": "Boyer", "value": 56.0329920870425}, {"lowerIsBetter": false, "replicates": [27135.135135135137], "unit": "score", "name": "RegExp", "value": 33.572156374501965}, {"lowerIsBetter": false, "replicates": [609.7560975609756], "unit": "score", "name": "Splay", "value": 133.64524}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 19812.409810880894}]} 15:47:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19812.41"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1517.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6257.09"}}} 15:47:55 INFO - Return code: 0 15:47:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:47:55 ERROR - # TBPL SUCCESS # 15:47:55 INFO - Running post-action listener: _resource_record_post_action 15:47:55 INFO - Running post-run listener: _resource_record_post_run 15:47:56 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 0; Write bytes: 569667584; Read time: 0; Write time: 584984 15:47:56 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 228274176; Read time: 0; Write time: 337944 15:47:56 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 0; Write bytes: 320110592; Read time: 0; Write time: 201072 15:47:56 INFO - Running post-run listener: _upload_blobber_files 15:47:56 INFO - Blob upload gear active. 15:47:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:47:56 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 15:47:56 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'] 15:47:56 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 15:47:57 INFO - (blobuploader) - INFO - Open directory for files ... 15:47:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:47:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:47:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:47:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:47:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:47:58 INFO - (blobuploader) - INFO - Done attempting. 15:47:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:47:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:47:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:47:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:47:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:47:59 INFO - (blobuploader) - INFO - Done attempting. 15:47:59 INFO - (blobuploader) - INFO - Iteration through files over. 15:47:59 INFO - Return code: 0 15:47:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:47:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:47:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4e2a8073b632fc6c53d68f674dcc7bea60e78c72117317dc70291a614a98e21497bf1367583537d2b77b1417833d11a72707924a4907711d8063a65bc49f36f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1a1d904cc5e1762e8ce199d7bf1a5c04f1d808de7638af4b6577838e316b8f9e15976c0eff7514ebca6798e1db0e42536eaa1b4d2f97e45efce05c3fb4461aee"} 15:47:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:47:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:47:59 INFO - Contents: 15:47:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4e2a8073b632fc6c53d68f674dcc7bea60e78c72117317dc70291a614a98e21497bf1367583537d2b77b1417833d11a72707924a4907711d8063a65bc49f36f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1a1d904cc5e1762e8ce199d7bf1a5c04f1d808de7638af4b6577838e316b8f9e15976c0eff7514ebca6798e1db0e42536eaa1b4d2f97e45efce05c3fb4461aee"} 15:47:59 INFO - Copying logs to upload dir... 15:47:59 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1271.000426 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-22 15:47:59.114172) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 15:47:59.117677) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450826806.678814-1364486985 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/4e2a8073b632fc6c53d68f674dcc7bea60e78c72117317dc70291a614a98e21497bf1367583537d2b77b1417833d11a72707924a4907711d8063a65bc49f36f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1a1d904cc5e1762e8ce199d7bf1a5c04f1d808de7638af4b6577838e316b8f9e15976c0eff7514ebca6798e1db0e42536eaa1b4d2f97e45efce05c3fb4461aee"} build_url:https://queue.taskcluster.net/v1/task/QJrYdSZcSk299hoRXiaxLg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011390 build_url: 'https://queue.taskcluster.net/v1/task/QJrYdSZcSk299hoRXiaxLg/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/4e2a8073b632fc6c53d68f674dcc7bea60e78c72117317dc70291a614a98e21497bf1367583537d2b77b1417833d11a72707924a4907711d8063a65bc49f36f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1a1d904cc5e1762e8ce199d7bf1a5c04f1d808de7638af4b6577838e316b8f9e15976c0eff7514ebca6798e1db0e42536eaa1b4d2f97e45efce05c3fb4461aee"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 15:47:59.144044) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 15:47:59.144405) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1450826806.678814-1364486985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 15:47:59.227573) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 15:47:59.227950) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 15:47:59.228308) ========= ========= Total master_lag: 0.25 =========