builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-049 starttime: 1452687870.31 results: success (0) buildid: 20160113030032 builduid: 34a46952d24f4a34a08a9f77f46225eb revision: cae1c805bf9116cfb91d9e0f8b2496cfb37b1f56 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.313301) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.313952) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.314247) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1452687695.80604-343224222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006341 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.342792) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.343084) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.359941) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.360200) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1452687695.80604-343224222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004590 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.409819) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.410200) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.410704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.411117) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1452687695.80604-343224222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 04:24:30-- 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% 219M=0s 2016-01-13 04:24:31 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167961 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.591302) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.591618) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1452687695.80604-343224222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014695 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.643253) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.643624) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cae1c805bf9116cfb91d9e0f8b2496cfb37b1f56 --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 cae1c805bf9116cfb91d9e0f8b2496cfb37b1f56 --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=8c719f637fb0c43bc4e5671e000001d0-1452687695.80604-343224222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 04:24:31,145 truncating revision to first 12 chars 2016-01-13 04:24:31,145 Setting DEBUG logging. 2016-01-13 04:24:31,145 attempt 1/10 2016-01-13 04:24:31,145 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cae1c805bf91?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 04:24:31,411 unpacking tar archive at: fx-team-cae1c805bf91/testing/mozharness/ program finished with exit code 0 elapsedTime=0.542124 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:31.202097) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:31.202415) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:31.216808) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:31.217193) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:31.217697) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-13 04:24:31.218089) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1452687695.80604-343224222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:24:31 INFO - MultiFileLogger online at 20160113 04:24:31 in /builds/slave/test 04:24:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:24:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:24:31 INFO - {'append_to_log': False, 04:24:31 INFO - 'base_work_dir': '/builds/slave/test', 04:24:31 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:24:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:24:31 INFO - 'branch': 'Fx-Team-Non-PGO', 04:24:31 INFO - 'buildbot_json_path': 'buildprops.json', 04:24:31 INFO - 'config_files': ('talos/linux_config.py',), 04:24:31 INFO - 'default_actions': ('clobber', 04:24:31 INFO - 'read-buildbot-config', 04:24:31 INFO - 'download-and-extract', 04:24:31 INFO - 'populate-webroot', 04:24:31 INFO - 'create-virtualenv', 04:24:31 INFO - 'install', 04:24:31 INFO - 'run-tests'), 04:24:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:24:31 INFO - 'download_minidump_stackwalk': True, 04:24:31 INFO - 'download_symbols': 'ondemand', 04:24:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:24:31 INFO - 'tooltool.py': '/tools/tooltool.py', 04:24:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:24:31 INFO - '/tools/misc-python/virtualenv.py')}, 04:24:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:24:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:24:31 INFO - 'installer_path': 'installer.exe', 04:24:31 INFO - 'log_level': 'info', 04:24:31 INFO - 'log_name': 'talos', 04:24:31 INFO - 'log_to_console': True, 04:24:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:24:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:24:31 INFO - 'opt_config_files': (), 04:24:31 INFO - 'pip_index': False, 04:24:31 INFO - 'sps_profile': False, 04:24:31 INFO - 'sps_profile_interval': 0, 04:24:31 INFO - 'suite': 'dromaeojs', 04:24:31 INFO - 'system_bits': '32', 04:24:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:24:31 INFO - 'title': 'talos-linux64-ix-049', 04:24:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:24:31 INFO - 'use_talos_json': True, 04:24:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:24:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:24:31 INFO - 'work_dir': 'build'} 04:24:31 INFO - ##### 04:24:31 INFO - ##### Running clobber step. 04:24:31 INFO - ##### 04:24:31 INFO - Running pre-action listener: _resource_record_pre_action 04:24:31 INFO - Running main action method: clobber 04:24:31 INFO - rmtree: /builds/slave/test/build 04:24:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:24:32 INFO - Running post-action listener: _resource_record_post_action 04:24:32 INFO - ##### 04:24:32 INFO - ##### Running read-buildbot-config step. 04:24:32 INFO - ##### 04:24:32 INFO - Running pre-action listener: _resource_record_pre_action 04:24:32 INFO - Running main action method: read_buildbot_config 04:24:32 INFO - Using buildbot properties: 04:24:32 INFO - { 04:24:32 INFO - "project": "", 04:24:32 INFO - "product": "firefox", 04:24:32 INFO - "script_repo_revision": "production", 04:24:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:24:32 INFO - "repository": "", 04:24:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:24:32 INFO - "buildid": "20160113030032", 04:24:32 INFO - "pgo_build": "False", 04:24:32 INFO - "basedir": "/builds/slave/test", 04:24:32 INFO - "buildnumber": 1127, 04:24:32 INFO - "slavename": "talos-linux64-ix-049", 04:24:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:24:32 INFO - "platform": "ubuntu64_hw", 04:24:32 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:24:32 INFO - "branch": "fx-team", 04:24:32 INFO - "repo_path": "integration/fx-team", 04:24:32 INFO - "revision": "cae1c805bf9116cfb91d9e0f8b2496cfb37b1f56", 04:24:32 INFO - "stage_platform": "linux64", 04:24:32 INFO - "builduid": "34a46952d24f4a34a08a9f77f46225eb", 04:24:32 INFO - "slavebuilddir": "test" 04:24:32 INFO - } 04:24:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:24:32 INFO - Running post-action listener: _resource_record_post_action 04:24:32 INFO - ##### 04:24:32 INFO - ##### Running download-and-extract step. 04:24:32 INFO - ##### 04:24:32 INFO - Running pre-action listener: _resource_record_pre_action 04:24:32 INFO - Running main action method: download_and_extract 04:24:32 INFO - mkdir: /builds/slave/test/build/tests 04:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:32 INFO - https://queue.taskcluster.net/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:24:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/test_packages.json 04:24:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/test_packages.json 04:24:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:24:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:24:34 INFO - Downloaded 1448 bytes. 04:24:34 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:24:34 INFO - Using the following test package requirements: 04:24:34 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:24:34 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:24:34 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:24:34 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:34 INFO - u'jsshell-linux-x86_64.zip'], 04:24:34 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:24:34 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:24:34 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:24:34 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:24:34 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:24:34 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:24:34 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:24:34 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:24:34 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')]} 04:24:34 INFO - https://queue.taskcluster.net/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:24:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:24:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:24:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/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 04:24:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/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 04:24:38 INFO - Downloaded 22760804 bytes. 04:24:38 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 04:24:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:24:38 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 04:24:39 INFO - Return code: 0 04:24:39 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 04:24:39 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')]} 04:24:39 INFO - https://queue.taskcluster.net/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:24:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:24:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:24:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/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 04:24:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/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 04:24:42 INFO - Downloaded 22760804 bytes. 04:24:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:24:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:24:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:24:43 INFO - Return code: 0 04:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:24:43 INFO - https://queue.taskcluster.net/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:24:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:24:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:24:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/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 04:24:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/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 04:24:45 INFO - Downloaded 11132279 bytes. 04:24:45 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 04:24:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:24:45 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 04:24:45 INFO - Return code: 0 04:24:45 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')]} 04:24:45 INFO - https://queue.taskcluster.net/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:24:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:24:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:24:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/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 04:24:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/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 04:24:48 INFO - Downloaded 53904425 bytes. 04:24:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:24:48 INFO - mkdir: /builds/slave/test/properties 04:24:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:24:48 INFO - Writing to file /builds/slave/test/properties/build_url 04:24:48 INFO - Contents: 04:24:48 INFO - build_url:https://queue.taskcluster.net/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:24:48 INFO - Running post-action listener: _resource_record_post_action 04:24:48 INFO - Running post-action listener: set_extra_try_arguments 04:24:48 INFO - ##### 04:24:48 INFO - ##### Running populate-webroot step. 04:24:48 INFO - ##### 04:24:48 INFO - Running pre-action listener: _resource_record_pre_action 04:24:48 INFO - Running main action method: populate_webroot 04:24:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:24:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:24:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:24:48 INFO - '--tppagecycles', 04:24:48 INFO - '7'], 04:24:48 INFO - 'tests': ['tsvgm']}}, 04:24:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:24:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:24:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:24:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:24:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:24:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:24:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:24:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:48 INFO - 'talos_options': ['--e10s'], 04:24:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:24:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:48 INFO - 'tests': ['damp', 'tps']}, 04:24:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:48 INFO - 'talos_options': ['--e10s'], 04:24:48 INFO - 'tests': ['damp', 'tps']}, 04:24:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:24:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:24:48 INFO - 'other': {'tests': ['a11yr', 04:24:48 INFO - 'ts_paint', 04:24:48 INFO - 'tpaint', 04:24:48 INFO - 'sessionrestore', 04:24:48 INFO - 'sessionrestore_no_auto_restore']}, 04:24:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:24:48 INFO - 'tests': ['a11yr', 04:24:48 INFO - 'ts_paint', 04:24:48 INFO - 'tpaint', 04:24:48 INFO - 'sessionrestore', 04:24:48 INFO - 'sessionrestore_no_auto_restore']}, 04:24:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:24:48 INFO - 'tests': ['a11yr', 04:24:48 INFO - 'ts_paint', 04:24:48 INFO - 'tpaint', 04:24:48 INFO - 'sessionrestore', 04:24:48 INFO - 'sessionrestore_no_auto_restore']}, 04:24:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:24:48 INFO - 'tests': ['a11yr', 04:24:48 INFO - 'ts_paint', 04:24:48 INFO - 'tpaint', 04:24:48 INFO - 'sessionrestore', 04:24:48 INFO - 'sessionrestore_no_auto_restore']}, 04:24:48 INFO - 'other_l64': {'tests': ['a11yr', 04:24:48 INFO - 'ts_paint', 04:24:48 INFO - 'tpaint', 04:24:48 INFO - 'sessionrestore', 04:24:48 INFO - 'sessionrestore_no_auto_restore']}, 04:24:48 INFO - 'other_nol64': {'tests': ['a11yr', 04:24:48 INFO - 'ts_paint', 04:24:48 INFO - 'tpaint', 04:24:48 INFO - 'sessionrestore', 04:24:48 INFO - 'sessionrestore_no_auto_restore']}, 04:24:48 INFO - 'svgr': {'tests': ['tsvgx', 04:24:48 INFO - 'tsvgr_opacity', 04:24:48 INFO - 'tart', 04:24:48 INFO - 'tscrollx', 04:24:48 INFO - 'cart']}, 04:24:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:24:48 INFO - 'tests': ['tsvgx', 04:24:48 INFO - 'tsvgr_opacity', 04:24:48 INFO - 'tart', 04:24:48 INFO - 'tscrollx', 04:24:48 INFO - 'cart']}, 04:24:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:48 INFO - 'tests': ['tp5o']}, 04:24:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:48 INFO - 'talos_options': ['--e10s'], 04:24:48 INFO - 'tests': ['tp5o']}, 04:24:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:48 INFO - 'talos_options': ['--xperf_path', 04:24:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:24:48 INFO - 'tests': ['tp5n']}, 04:24:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:48 INFO - 'talos_options': ['--e10s', 04:24:48 INFO - '--xperf_path', 04:24:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:24:48 INFO - 'tests': ['tp5n']}}, 04:24:48 INFO - 'talos.zip': {'path': '', 04:24:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:24:48 INFO - Running post-action listener: _resource_record_post_action 04:24:48 INFO - ##### 04:24:48 INFO - ##### Running create-virtualenv step. 04:24:48 INFO - ##### 04:24:48 INFO - Running pre-action listener: _resource_record_pre_action 04:24:48 INFO - Running main action method: create_virtualenv 04:24:48 INFO - Creating virtualenv /builds/slave/test/build/venv 04:24:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:24:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:24:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:24:48 INFO - Using real prefix '/usr' 04:24:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:24:49 INFO - Installing distribute.............................................................................................................................................................................................done. 04:24:51 INFO - Installing pip.................done. 04:24:51 INFO - Return code: 0 04:24:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:24: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')]} 04:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24: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')]} 04:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f72747f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23443d0>, '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 0x22afed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b0360>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452687695.80604-343224222', '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 04:24:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:24:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:24:51 INFO - Using env: {'DISPLAY': ':0', 04:24:51 INFO - 'HOME': '/home/cltbld', 04:24:51 INFO - 'LANG': 'en_US.UTF-8', 04:24:51 INFO - 'LANGUAGE': 'en_US:en', 04:24:51 INFO - 'LOGNAME': 'cltbld', 04:24:51 INFO - 'MAIL': '/var/mail/cltbld', 04:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:51 INFO - 'MOZ_NO_REMOTE': '1', 04:24:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:51 INFO - 'NO_EM_RESTART': '1', 04:24:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:51 INFO - 'PWD': '/builds/slave/test', 04:24:51 INFO - 'SHELL': '/bin/bash', 04:24:51 INFO - 'SHLVL': '1', 04:24:51 INFO - 'TERM': 'linux', 04:24:51 INFO - 'TMOUT': '86400', 04:24:51 INFO - 'USER': 'cltbld', 04:24:51 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452687695.80604-343224222', 04:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:51 INFO - '_': '/tools/buildbot/bin/python'} 04:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:24:51 INFO - Cleaning up... 04:24:51 INFO - Return code: 0 04:24:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:24: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')]} 04:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24: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')]} 04:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f72747f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23443d0>, '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 0x22afed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b0360>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452687695.80604-343224222', '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 04:24:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:24:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:24:51 INFO - Using env: {'DISPLAY': ':0', 04:24:51 INFO - 'HOME': '/home/cltbld', 04:24:51 INFO - 'LANG': 'en_US.UTF-8', 04:24:51 INFO - 'LANGUAGE': 'en_US:en', 04:24:51 INFO - 'LOGNAME': 'cltbld', 04:24:51 INFO - 'MAIL': '/var/mail/cltbld', 04:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:51 INFO - 'MOZ_NO_REMOTE': '1', 04:24:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:51 INFO - 'NO_EM_RESTART': '1', 04:24:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:51 INFO - 'PWD': '/builds/slave/test', 04:24:51 INFO - 'SHELL': '/bin/bash', 04:24:51 INFO - 'SHLVL': '1', 04:24:51 INFO - 'TERM': 'linux', 04:24:51 INFO - 'TMOUT': '86400', 04:24:51 INFO - 'USER': 'cltbld', 04:24:51 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452687695.80604-343224222', 04:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:51 INFO - '_': '/tools/buildbot/bin/python'} 04:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:51 INFO - Downloading/unpacking psutil>=0.7.1 04:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:53 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:24:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:24:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:24:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:24:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:24:53 INFO - Installing collected packages: psutil 04:24:53 INFO - Running setup.py install for psutil 04:24:53 INFO - building 'psutil._psutil_linux' extension 04:24:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:24:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:24:53 INFO - building 'psutil._psutil_posix' extension 04:24:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:24:54 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 04:24:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:24:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:24:54 INFO - Successfully installed psutil 04:24:54 INFO - Cleaning up... 04:24:54 INFO - Return code: 0 04:24:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:54 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 0x7f72747f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23443d0>, '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 0x22afed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b0360>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452687695.80604-343224222', '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 04:24:54 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 04:24:54 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 04:24:54 INFO - Using env: {'DISPLAY': ':0', 04:24:54 INFO - 'HOME': '/home/cltbld', 04:24:54 INFO - 'LANG': 'en_US.UTF-8', 04:24:54 INFO - 'LANGUAGE': 'en_US:en', 04:24:54 INFO - 'LOGNAME': 'cltbld', 04:24:54 INFO - 'MAIL': '/var/mail/cltbld', 04:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:54 INFO - 'MOZ_NO_REMOTE': '1', 04:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:54 INFO - 'NO_EM_RESTART': '1', 04:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:54 INFO - 'PWD': '/builds/slave/test', 04:24:54 INFO - 'SHELL': '/bin/bash', 04:24:54 INFO - 'SHLVL': '1', 04:24:54 INFO - 'TERM': 'linux', 04:24:54 INFO - 'TMOUT': '86400', 04:24:54 INFO - 'USER': 'cltbld', 04:24:54 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452687695.80604-343224222', 04:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:54 INFO - '_': '/tools/buildbot/bin/python'} 04:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:24:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:24:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:24:56 INFO - Installing collected packages: mozsystemmonitor 04:24:56 INFO - Running setup.py install for mozsystemmonitor 04:24:56 INFO - Successfully installed mozsystemmonitor 04:24:56 INFO - Cleaning up... 04:24:56 INFO - Return code: 0 04:24:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f72747f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23443d0>, '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 0x22afed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b0360>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452687695.80604-343224222', '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 04:24:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:24:56 INFO - Using env: {'DISPLAY': ':0', 04:24:56 INFO - 'HOME': '/home/cltbld', 04:24:56 INFO - 'LANG': 'en_US.UTF-8', 04:24:56 INFO - 'LANGUAGE': 'en_US:en', 04:24:56 INFO - 'LOGNAME': 'cltbld', 04:24:56 INFO - 'MAIL': '/var/mail/cltbld', 04:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:56 INFO - 'MOZ_NO_REMOTE': '1', 04:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:56 INFO - 'NO_EM_RESTART': '1', 04:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:56 INFO - 'PWD': '/builds/slave/test', 04:24:56 INFO - 'SHELL': '/bin/bash', 04:24:56 INFO - 'SHLVL': '1', 04:24:56 INFO - 'TERM': 'linux', 04:24:56 INFO - 'TMOUT': '86400', 04:24:56 INFO - 'USER': 'cltbld', 04:24:56 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452687695.80604-343224222', 04:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:56 INFO - '_': '/tools/buildbot/bin/python'} 04:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:56 INFO - Downloading/unpacking blobuploader==1.2.4 04:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:58 INFO - Downloading blobuploader-1.2.4.tar.gz 04:24:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:24:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:24:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:58 INFO - Downloading docopt-0.6.1.tar.gz 04:24:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:24:58 INFO - Installing collected packages: blobuploader, requests, docopt 04:24:58 INFO - Running setup.py install for blobuploader 04:24:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:24:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:24:58 INFO - Running setup.py install for requests 04:24:59 INFO - Running setup.py install for docopt 04:24:59 INFO - Successfully installed blobuploader requests docopt 04:24:59 INFO - Cleaning up... 04:24:59 INFO - Return code: 0 04:24:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24: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')]} 04:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24: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')]} 04:24:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:59 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 0x7f72747f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23443d0>, '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 0x22afed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b0360>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452687695.80604-343224222', '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 04:24:59 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 04:24:59 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 04:24:59 INFO - Using env: {'DISPLAY': ':0', 04:24:59 INFO - 'HOME': '/home/cltbld', 04:24:59 INFO - 'LANG': 'en_US.UTF-8', 04:24:59 INFO - 'LANGUAGE': 'en_US:en', 04:24:59 INFO - 'LOGNAME': 'cltbld', 04:24:59 INFO - 'MAIL': '/var/mail/cltbld', 04:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:59 INFO - 'MOZ_NO_REMOTE': '1', 04:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:59 INFO - 'NO_EM_RESTART': '1', 04:24:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:59 INFO - 'PWD': '/builds/slave/test', 04:24:59 INFO - 'SHELL': '/bin/bash', 04:24:59 INFO - 'SHLVL': '1', 04:24:59 INFO - 'TERM': 'linux', 04:24:59 INFO - 'TMOUT': '86400', 04:24:59 INFO - 'USER': 'cltbld', 04:24:59 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452687695.80604-343224222', 04:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:59 INFO - '_': '/tools/buildbot/bin/python'} 04:24:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:24:59 INFO - Running setup.py (path:/tmp/pip-2ZkIUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:24:59 INFO - Running setup.py (path:/tmp/pip-1Pa_bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:24:59 INFO - Running setup.py (path:/tmp/pip-Ugu1BC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:24:59 INFO - Running setup.py (path:/tmp/pip-2CgxQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:24:59 INFO - Running setup.py (path:/tmp/pip-Ue4K3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:00 INFO - Running setup.py (path:/tmp/pip-8sgiEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:00 INFO - Running setup.py (path:/tmp/pip-bFlNvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:00 INFO - Running setup.py (path:/tmp/pip-D9qoRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:25:00 INFO - Running setup.py (path:/tmp/pip-W8cldh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:25:00 INFO - Running setup.py (path:/tmp/pip-WZHCCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:25:00 INFO - Running setup.py (path:/tmp/pip-E83HHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:25:00 INFO - Running setup.py (path:/tmp/pip-ZOQNW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:25:00 INFO - Running setup.py (path:/tmp/pip-EXf93H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:25:00 INFO - Running setup.py (path:/tmp/pip-c6MezQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:00 INFO - Running setup.py (path:/tmp/pip-Kdw3eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:25:00 INFO - Running setup.py (path:/tmp/pip-OrTP7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:25:00 INFO - Running setup.py (path:/tmp/pip-P1qaxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:25:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:25:00 INFO - Running setup.py install for manifestparser 04:25:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:25:01 INFO - Running setup.py install for mozcrash 04:25:01 INFO - Running setup.py install for mozdebug 04:25:01 INFO - Running setup.py install for mozdevice 04:25:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:25:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:25:01 INFO - Running setup.py install for mozfile 04:25:01 INFO - Running setup.py install for mozhttpd 04:25:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:25:01 INFO - Running setup.py install for mozinfo 04:25:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:25:01 INFO - Running setup.py install for mozInstall 04:25:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:25:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:25:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:25:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:25:01 INFO - Running setup.py install for mozleak 04:25:01 INFO - Running setup.py install for mozlog 04:25:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:25:01 INFO - Running setup.py install for moznetwork 04:25:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:25:02 INFO - Running setup.py install for mozprocess 04:25:02 INFO - Running setup.py install for mozprofile 04:25:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:25:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:25:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:25:02 INFO - Running setup.py install for mozrunner 04:25:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:25:02 INFO - Running setup.py install for mozscreenshot 04:25:02 INFO - Running setup.py install for moztest 04:25:02 INFO - Running setup.py install for mozversion 04:25:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:25:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:25:02 INFO - Cleaning up... 04:25:02 INFO - Return code: 0 04:25:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f72747f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23443d0>, '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 0x22afed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b0360>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452687695.80604-343224222', '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 04:25:02 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 04:25:02 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 04:25:02 INFO - Using env: {'DISPLAY': ':0', 04:25:02 INFO - 'HOME': '/home/cltbld', 04:25:02 INFO - 'LANG': 'en_US.UTF-8', 04:25:02 INFO - 'LANGUAGE': 'en_US:en', 04:25:02 INFO - 'LOGNAME': 'cltbld', 04:25:02 INFO - 'MAIL': '/var/mail/cltbld', 04:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:02 INFO - 'MOZ_NO_REMOTE': '1', 04:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:02 INFO - 'NO_EM_RESTART': '1', 04:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:02 INFO - 'PWD': '/builds/slave/test', 04:25:02 INFO - 'SHELL': '/bin/bash', 04:25:02 INFO - 'SHLVL': '1', 04:25:02 INFO - 'TERM': 'linux', 04:25:02 INFO - 'TMOUT': '86400', 04:25:02 INFO - 'USER': 'cltbld', 04:25:02 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452687695.80604-343224222', 04:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:02 INFO - '_': '/tools/buildbot/bin/python'} 04:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:25:02 INFO - Running setup.py (path:/tmp/pip-DVxstA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:25:02 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)) 04:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:25:02 INFO - Running setup.py (path:/tmp/pip-RCuSMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:25:03 INFO - Running setup.py (path:/tmp/pip-roooBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:25:03 INFO - Running setup.py (path:/tmp/pip-rV5ioI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 04:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:25:03 INFO - Running setup.py (path:/tmp/pip-AHF0Xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:03 INFO - Running setup.py (path:/tmp/pip-63oIpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:03 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)) 04:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:03 INFO - Running setup.py (path:/tmp/pip-Kg8iZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:03 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)) 04:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:03 INFO - Running setup.py (path:/tmp/pip-M4QjdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:25:03 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)) 04:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:25:03 INFO - Running setup.py (path:/tmp/pip-tLXmWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:25:03 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)) 04:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:25:03 INFO - Running setup.py (path:/tmp/pip-fhvHE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:25:03 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)) 04:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:25:03 INFO - Running setup.py (path:/tmp/pip-02JoZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:25:03 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)) 04:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:25:03 INFO - Running setup.py (path:/tmp/pip-qgEgC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:25:03 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)) 04:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:25:03 INFO - Running setup.py (path:/tmp/pip-n6fPbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:25:03 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)) 04:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:25:03 INFO - Running setup.py (path:/tmp/pip-umlibe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:25:03 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)) 04:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:03 INFO - Running setup.py (path:/tmp/pip-dxPtTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:03 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)) 04:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:25:04 INFO - Running setup.py (path:/tmp/pip-BK69G6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:25:04 INFO - Running setup.py (path:/tmp/pip-qBYcs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:25:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25:05 INFO - Downloading blessings-1.5.1.tar.gz 04:25:05 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 04:25:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:25:05 INFO - Installing collected packages: blessings 04:25:05 INFO - Running setup.py install for blessings 04:25:06 INFO - Successfully installed blessings 04:25:06 INFO - Cleaning up... 04:25:06 INFO - Return code: 0 04:25:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:25:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:25:06 INFO - Reading from file tmpfile_stdout 04:25:06 INFO - Current package versions: 04:25:06 INFO - argparse == 1.2.1 04:25:06 INFO - blessings == 1.5.1 04:25:06 INFO - blobuploader == 1.2.4 04:25:06 INFO - docopt == 0.6.1 04:25:06 INFO - manifestparser == 1.1 04:25:06 INFO - mozInstall == 1.12 04:25:06 INFO - mozcrash == 0.16 04:25:06 INFO - mozdebug == 0.1 04:25:06 INFO - mozdevice == 0.48 04:25:06 INFO - mozfile == 1.2 04:25:06 INFO - mozhttpd == 0.7 04:25:06 INFO - mozinfo == 0.9 04:25:06 INFO - mozleak == 0.1 04:25:06 INFO - mozlog == 3.1 04:25:06 INFO - moznetwork == 0.27 04:25:06 INFO - mozprocess == 0.22 04:25:06 INFO - mozprofile == 0.28 04:25:06 INFO - mozrunner == 6.11 04:25:06 INFO - mozscreenshot == 0.1 04:25:06 INFO - mozsystemmonitor == 0.0 04:25:06 INFO - moztest == 0.7 04:25:06 INFO - mozversion == 1.4 04:25:06 INFO - psutil == 3.1.1 04:25:06 INFO - requests == 1.2.3 04:25:06 INFO - wsgiref == 0.1.2 04:25:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f72747f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23443d0>, '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 0x22afed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b0360>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452687695.80604-343224222', '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 04:25:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:25:06 INFO - Using env: {'DISPLAY': ':0', 04:25:06 INFO - 'HOME': '/home/cltbld', 04:25:06 INFO - 'LANG': 'en_US.UTF-8', 04:25:06 INFO - 'LANGUAGE': 'en_US:en', 04:25:06 INFO - 'LOGNAME': 'cltbld', 04:25:06 INFO - 'MAIL': '/var/mail/cltbld', 04:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:06 INFO - 'MOZ_NO_REMOTE': '1', 04:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:06 INFO - 'NO_EM_RESTART': '1', 04:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:06 INFO - 'PWD': '/builds/slave/test', 04:25:06 INFO - 'SHELL': '/bin/bash', 04:25:06 INFO - 'SHLVL': '1', 04:25:06 INFO - 'TERM': 'linux', 04:25:06 INFO - 'TMOUT': '86400', 04:25:06 INFO - 'USER': 'cltbld', 04:25:06 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452687695.80604-343224222', 04:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:06 INFO - '_': '/tools/buildbot/bin/python'} 04:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:06 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)) 04:25:06 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)) 04:25:06 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)) 04:25:06 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)) 04:25:06 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)) 04:25:06 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)) 04:25:06 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)) 04:25:06 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)) 04:25:06 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)) 04:25:06 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)) 04:25:06 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)) 04:25:06 INFO - Cleaning up... 04:25:06 INFO - Return code: 0 04:25:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f72747f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23443d0>, '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 0x22afed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b0360>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452687695.80604-343224222', '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 04:25:06 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 04:25:06 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 04:25:06 INFO - Using env: {'DISPLAY': ':0', 04:25:06 INFO - 'HOME': '/home/cltbld', 04:25:06 INFO - 'LANG': 'en_US.UTF-8', 04:25:06 INFO - 'LANGUAGE': 'en_US:en', 04:25:06 INFO - 'LOGNAME': 'cltbld', 04:25:06 INFO - 'MAIL': '/var/mail/cltbld', 04:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:06 INFO - 'MOZ_NO_REMOTE': '1', 04:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:06 INFO - 'NO_EM_RESTART': '1', 04:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:06 INFO - 'PWD': '/builds/slave/test', 04:25:06 INFO - 'SHELL': '/bin/bash', 04:25:06 INFO - 'SHLVL': '1', 04:25:06 INFO - 'TERM': 'linux', 04:25:06 INFO - 'TMOUT': '86400', 04:25:06 INFO - 'USER': 'cltbld', 04:25:06 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452687695.80604-343224222', 04:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:06 INFO - '_': '/tools/buildbot/bin/python'} 04:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:06 INFO - Downloading/unpacking jsonschema 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:25:08 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 04:25:08 INFO - Downloading/unpacking functools32 (from jsonschema) 04:25:08 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 04:25:08 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 04:25:08 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 04:25:08 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 04:25:08 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 04:25:08 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 04:25:08 INFO - Downloading functools32-3.2.3-2.tar.gz 04:25:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:25:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:25:08 INFO - warning: no files found matching '*.txt' 04:25:08 INFO - no previously-included directories found matching 'build' 04:25:08 INFO - no previously-included directories found matching 'dist' 04:25:08 INFO - no previously-included directories found matching '.git*' 04:25:08 INFO - Installing collected packages: jsonschema, functools32 04:25:08 INFO - Running setup.py install for functools32 04:25:08 INFO - warning: no files found matching '*.txt' 04:25:08 INFO - no previously-included directories found matching 'build' 04:25:08 INFO - no previously-included directories found matching 'dist' 04:25:08 INFO - no previously-included directories found matching '.git*' 04:25:08 INFO - Successfully installed jsonschema functools32 04:25:08 INFO - Cleaning up... 04:25:08 INFO - Return code: 0 04:25:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:25:08 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')]} 04:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:08 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')]} 04:25:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:08 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 0x7f72747f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b1dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23443d0>, '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 0x22afed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b0360>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452687695.80604-343224222', '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 04:25:08 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 04:25:08 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 04:25:08 INFO - Using env: {'DISPLAY': ':0', 04:25:08 INFO - 'HOME': '/home/cltbld', 04:25:08 INFO - 'LANG': 'en_US.UTF-8', 04:25:08 INFO - 'LANGUAGE': 'en_US:en', 04:25:08 INFO - 'LOGNAME': 'cltbld', 04:25:08 INFO - 'MAIL': '/var/mail/cltbld', 04:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:08 INFO - 'MOZ_NO_REMOTE': '1', 04:25:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:08 INFO - 'NO_EM_RESTART': '1', 04:25:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:08 INFO - 'PWD': '/builds/slave/test', 04:25:08 INFO - 'SHELL': '/bin/bash', 04:25:08 INFO - 'SHLVL': '1', 04:25:08 INFO - 'TERM': 'linux', 04:25:08 INFO - 'TMOUT': '86400', 04:25:08 INFO - 'USER': 'cltbld', 04:25:08 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452687695.80604-343224222', 04:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:08 INFO - '_': '/tools/buildbot/bin/python'} 04:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:09 INFO - Downloading/unpacking flake8 04:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:25:10 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 04:25:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:25:10 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 04:25:10 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 04:25:10 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 04:25:10 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 04:25:10 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 04:25:10 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 04:25:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:25:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:25:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:25:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:25:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:25:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:25:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:25:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:25:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:25:11 INFO - no previously-included directories found matching 'docs/_build' 04:25:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:25:11 INFO - Running setup.py install for pep8 04:25:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:25:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:25:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:25:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:25:11 INFO - no previously-included directories found matching 'docs/_build' 04:25:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:25:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:25:11 INFO - Cleaning up... 04:25:11 INFO - Return code: 0 04:25:11 INFO - Running post-action listener: _resource_record_post_action 04:25:11 INFO - Running post-action listener: _start_resource_monitoring 04:25:11 INFO - Starting resource monitoring. 04:25:11 INFO - ##### 04:25:11 INFO - ##### Running install step. 04:25:11 INFO - ##### 04:25:11 INFO - Running pre-action listener: _resource_record_pre_action 04:25:11 INFO - Running main action method: install 04:25:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:25:12 INFO - Reading from file tmpfile_stdout 04:25:12 INFO - Detecting whether we're running mozinstall >=1.0... 04:25:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:25:12 INFO - Reading from file tmpfile_stdout 04:25:12 INFO - Output received: 04:25:12 INFO - Usage: mozinstall [options] installer 04:25:12 INFO - Options: 04:25:12 INFO - -h, --help show this help message and exit 04:25:12 INFO - -d DEST, --destination=DEST 04:25:12 INFO - Directory to install application into. [default: 04:25:12 INFO - "/builds/slave/test"] 04:25:12 INFO - --app=APP Application being installed. [default: firefox] 04:25:12 INFO - mkdir: /builds/slave/test/build/application 04:25:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:25:27 INFO - Reading from file tmpfile_stdout 04:25:27 INFO - Output received: 04:25:27 INFO - /builds/slave/test/build/application/firefox/firefox 04:25:27 INFO - Running post-action listener: _resource_record_post_action 04:25:27 INFO - ##### 04:25:27 INFO - ##### Running run-tests step. 04:25:27 INFO - ##### 04:25:27 INFO - Running pre-action listener: _resource_record_pre_action 04:25:27 INFO - Running main action method: run_tests 04:25:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:25:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:25:27 INFO - Python 2.7.3 04:25:27 INFO - Return code: 0 04:25:27 INFO - grabbing minidump binary from tooltool 04:25:27 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')]} 04:25:27 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 0x23443d0>, '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 0x22afed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22b0360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:25:27 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 04:25:27 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 04:25:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:25:27 INFO - Return code: 0 04:25:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:25:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:25:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:25:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:25:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:25:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:25:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:25:28 INFO - Return code: 0 04:25:28 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/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 04:25:28 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/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 04:25:28 INFO - Using env: {'DISPLAY': ':0', 04:25:28 INFO - 'HOME': '/home/cltbld', 04:25:28 INFO - 'LANG': 'en_US.UTF-8', 04:25:28 INFO - 'LANGUAGE': 'en_US:en', 04:25:28 INFO - 'LOGNAME': 'cltbld', 04:25:28 INFO - 'MAIL': '/var/mail/cltbld', 04:25:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:25:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:28 INFO - 'MOZ_NO_REMOTE': '1', 04:25:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:25:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:28 INFO - 'NO_EM_RESTART': '1', 04:25:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:28 INFO - 'PWD': '/builds/slave/test', 04:25:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:25:28 INFO - 'SHELL': '/bin/bash', 04:25:28 INFO - 'SHLVL': '1', 04:25:28 INFO - 'TERM': 'linux', 04:25:28 INFO - 'TMOUT': '86400', 04:25:28 INFO - 'USER': 'cltbld', 04:25:28 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452687695.80604-343224222', 04:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:28 INFO - '_': '/tools/buildbot/bin/python'} 04:25:28 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/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 04:25:28 INFO - mozversion application_buildid: 20160113030032 04:25:28 INFO - mozversion application_changeset: cae1c805bf9116cfb91d9e0f8b2496cfb37b1f56 04:25:28 INFO - mozversion application_display_name: Nightly 04:25:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:25:28 INFO - mozversion application_name: Firefox 04:25:28 INFO - mozversion application_remotingname: firefox 04:25:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:25:28 INFO - mozversion application_vendor: Mozilla 04:25:28 INFO - mozversion application_version: 46.0a1 04:25:28 INFO - mozversion platform_buildid: 20160113030032 04:25:28 INFO - mozversion platform_changeset: cae1c805bf9116cfb91d9e0f8b2496cfb37b1f56 04:25:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:25:28 INFO - mozversion platform_version: 46.0a1 04:25:28 INFO - using testdate: 1452687928 04:25:28 INFO - actual date: 1452687928 04:25:29 INFO - starting webserver on 'localhost:48185' 04:25:29 INFO - SUITE-START | Running 3 tests 04:25:29 INFO - TEST-START | dromaeo_css 04:25:29 INFO - operating with platform_type : linux_ 04:25:29 INFO - Initialising browser for dromaeo_css test... 04:25:29 INFO - TEST-INFO | started process 974 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7LFEKb/profile http://localhost:48185/getInfo.html) 04:25:33 INFO - PROCESS | 974 | __metrics Screen width/height:1600/1200 04:25:33 INFO - PROCESS | 974 | colorDepth:24 04:25:33 INFO - PROCESS | 974 | Browser inner width/height: 1024/697 04:25:33 INFO - PROCESS | 974 | __metrics 04:25:33 INFO - PROCESS | 974 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:25:33 INFO - PROCESS | 974 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:25:34 INFO - TEST-INFO | 974: exit 0 04:25:34 INFO - Browser initialized. 04:25:34 INFO - Running cycle 1/1 for dromaeo_css test... 04:25:34 INFO - TEST-INFO | started process 1075 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7LFEKb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:25:46 INFO - PROCESS | 1075 | RSS: Main: 149360640 04:25:46 INFO - PROCESS | 1075 | 04:26:37 INFO - PROCESS | 1075 | 1452687997551 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] 04:28:48 INFO - PROCESS | 1075 | Cycle 1(1): loaded http://localhost:48185/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48185/tests/dromaeo/cssquery-ext.html) 04:28:49 INFO - PROCESS | 1075 | RSS: Main: 256069632 04:28:49 INFO - PROCESS | 1075 | 04:31:52 INFO - PROCESS | 1075 | Cycle 1(1): loaded http://localhost:48185/tests/dromaeo/cssquery-ext.html (next: http://localhost:48185/tests/dromaeo/cssquery-jquery.html) 04:31:52 INFO - PROCESS | 1075 | RSS: Main: 228425728 04:31:52 INFO - PROCESS | 1075 | 04:34:55 INFO - PROCESS | 1075 | Cycle 1(1): loaded http://localhost:48185/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48185/tests/dromaeo/cssquery-mootools.html) 04:34:55 INFO - PROCESS | 1075 | RSS: Main: 230723584 04:34:55 INFO - PROCESS | 1075 | 04:37:57 INFO - PROCESS | 1075 | Cycle 1(1): loaded http://localhost:48185/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48185/tests/dromaeo/cssquery-prototype.html) 04:37:58 INFO - PROCESS | 1075 | RSS: Main: 211304448 04:37:58 INFO - PROCESS | 1075 | 04:41:01 INFO - PROCESS | 1075 | Cycle 1(1): loaded http://localhost:48185/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48185/tests/dromaeo/cssquery-yui.html) 04:41:01 INFO - PROCESS | 1075 | RSS: Main: 213975040 04:41:01 INFO - PROCESS | 1075 | 04:44:04 INFO - PROCESS | 1075 | Cycle 1(1): loaded http://localhost:48185/tests/dromaeo/cssquery-yui.html (next: http://localhost:48185/tests/dromaeo/cssquery-dojo.html) 04:44:04 INFO - PROCESS | 1075 | RSS: Main: 271327232 04:44:04 INFO - PROCESS | 1075 | 04:44:04 INFO - PROCESS | 1075 | __start_tp_report 04:44:04 INFO - PROCESS | 1075 | _x_x_mozilla_page_load 04:44:04 INFO - PROCESS | 1075 | _x_x_mozilla_page_load_details 04:44:04 INFO - PROCESS | 1075 | |i|pagename|runs| 04:44:04 INFO - PROCESS | 1075 | |0;dojo.html;2571.8207912142766;2627;2635.4597307551953;2647.2852329870934;2657.0434643528333;4268.7438753674805;4348.717333373336;4422.756748378842;4423.447069116361;4427.490838553564;4415.977920110395;4421.66837487189;4428.645708343332;4454.510003899569;4475.888102797432;4019.1157945252;4055.2497787909183;4067.1865626874596;4186.455760751098;4213.789310534461;3960.7029472789513;4147.56210854386;4178.707490475668;4203.6637069034405;4216.515100763406;4082.306007978636;4099.631033206996;4107.856225032139;4119;4134.255833949888;4048.8785336439955;4087.6729861611298;4092.1201941582704;4098.221337945811;4106.137711080677;3931;4011.1576568920564;4030.5163380394542;4033.3143365627916;4046.9595304046875;4225.936610950838;4274.786260686953;4321.783910804447;4323.546027667081;4357.651387888993;4645.907081858344;4670.159371313196;4675.345451636774;4677.18149323867;4713.363695901044;4663.183942809995;4703.106409782131;4709.434867815849;4732.455767586737;4749.121412538691;4319.920019995001;4368.716033457815;4405.07493426384;4424;4465.754383508938;4829.372181616367;4862.1005114053305;4863.878403039882;4872.049950259665;4910.607151427877;4525.909481810345;4624.722516648944;4661.114388266218;4683.95316046842;4713.622910167247;4679.181143299909;4681.461631912373;4695.718256904596;4749.097671442415;4783.330333753277;4665.183592871234;4682.461516925598;4684.227102528044;4694.460137084211;4712.52874712526;4571.977140114344;4655.86032419028;4656.930146047812;4668.346431499593;4701.882452938704;3914.1584559319313;3936.0553467167674;3942.743721658083;3974.7615143091507;3987.1626958338493;3492.8253587320532;3496.1609213788506;3500.842462089212;3533.152043509539;3533.2403533239963;3961.782101984361;4068.4304197412384;4071.5114186297833;4109.363048727452;4110.753354798721;4628.74541900192;4649.697769644962;4677.508861569554;4686;4710.670253082251;4065.79671016448;4067.328890732996;4085.4893138357706;4092.3043082676018;4124.340105583093;4198.1393814268;4210.031692710632;4210.642095421862;4244.72409293395;4262.552431994658;4334.653227741773;4399.978000109979;4400.163968845909;4438.245498265367;4473.2842745161915;4757.643176761688;4761.500042495627;4776.02091571234;4781.091592597395;4823.27650852375;4497.955020449754;4506.301523263899;4508.45898492183;4513.774311284357;4548.317752337176;4569.748663823389;4635.327877457682;4637.814487420465;4642.396488456614;4734.100520901018;4660.254359302496;4677.134730074947;4680.344751734828;4680.859574212779;4724.00795832879;4533.501314855297;4534.773261336986;4536.6824322297125;4555.544445555418;4577.198990176639;4497.235469970047;4567.81728730847;4568.81724731007;4581.450225972904;4661.021185551072;4451.132029254394;4458.2420988431395;4463.910721785481;4486.214912390254;4507.752073635981;4566.908661826811;4569.680122391401;4579.290210017452;4606.677532572822;4607.815687372467;4402.911941761083;4475.843345482893;4495.190865644216;4507.7971491282315;4556.2937744649635 04:44:04 INFO - PROCESS | 1075 | |1;ext.html;471.87731189890627;485.04446240905406;492.7363860334722;516.1328967334877;519.5376115257419;25204.74795252047;25673.74326256737;25678.61482077768;25716.35709107271;32871;36645.63354366455;36846;37102.628973710256;37134.62865371346;37233.255334893285;7573.583452910101;7749.031371078615;7755.573443460607;7760.417968652374;7760.805979850493;7452.366548843354;7605.049368828896;7611.391088712918;7615.200403957588;7619.047619047619;7603.771886843404;7778.494397864149;7791.4935529190425;7811.296983271504;7811.414143939199;7695.307422332017;7703.1526532081425;7758;7758.495697779626;7770.261825126604;7675.846483070307;7786.182450842636;7789.493682910593;7791.571463569501;7795.883061754022;36975.81512092449;37514.06214844623;37552.812235938916;37555.624443755485;37599;2935.5743417204385;3026.742726868219;3204.7436205103536;3574.749767516275;3649.835757390924;27465.588016179772;27910.441791164267;27926.86036569804;28074.719252807416;29265.268368290752;3158.6999235072863;3209.277912469699;3226.2740883301303;3233.0122260116914;3243.5783348164823;213093;215131.99999999843;215461;215548;215561.99999999843;46226;47194.5280547197;54281;54354.45645543494;54548.45451545513;40696;57103.71448142816;58550;58586.4141358581;58632.7068364664;11925;12073.517059317704;12088.456019479145;12129.514819407124;12161.331126787934;8869.157430044135;9422.528873556432;9514.952425237969;10143.949280253551;10363.94818025905;17788.644227115386;17823.197956092008;17876.642467150843;17977.460676179737;17998.820011799715;6738.460923126138;6922.965385173143;6956.7217311307995;6961.65191740411;7043.471739619549;787.7676085554775;832.433944917462;869.9608517616722;879.305348774461;888.4180861535705;23841.52316953651;25519.744802552108;25865.612015819777;26333.47333053328;26363.340916477242;883.2933653077512;950.0309684122157;962.3215632978734;963.9518024098767;1025.9538320775582;13591.78654617052;13745.175289482662;13911.721765564633;13921.860781392057;13935.860641393456;261195;263658;264171;264513;265064;46336.53663463322;46647.201167930034;46653.5334646656;46678;46751.29873051907;1186.6143503361443;1195.8266051422495;1202.5730865542782;1214.7752665756864;1214.8481439820023;25208.36979075538;25961.610575841754;26395.736042639328;26483.337916552242;26566.601500977886;40502.59497404988;40530.79734601308;40757.79621101876;40819.795901020305;40937.795311023256;245306;247001;247086;247451;247518;24232;29412.411751765274;30582.388352232385;30638;30908.845455772578;35656.82171589125;36226.27547449089;36472;36557.634423656484;36687.41407324084;30791.84604076965;31166.22084447907;31211.843940780152;32857.671423285465;33488.33023339471;28446.146615601567;29366.853165734035;29584;32885.50671739974;36500.81749591341;31345.373092537564;31532.369352613277;31555.52666709955;33103.8344808284;33927.4910876342;25098.498030039664;25625.487490249718;25949;26184.73815261823;26261;20861.37415877526;21077;21247.575048499253;21255.893720531298;21288 04:44:04 INFO - PROCESS | 1075 | |2;jquery.html;327.2848825316683;340.8892110064229;342.54077629299184;344.5624057447044;347.74440786022285;11777.764444711102;12177.147599668027;14056.961740547615;14230.003899727024;15808.525744227663;13937.721245575083;14408.423663053465;14475.394429002801;15203.92398038011;15205.619859503518;4318.52496225415;4844.442889067758;5040.873978150557;5821.592488525805;5822.53419726423;3686.225892562565;3834.616538346157;5508.504234618884;5731.512821410185;5755.280589926259;4691.3432119503295;4879.438864530571;5650.0959846424585;5665;5688.772449102031;4976.601871850261;4984.925226121611;4993.500649935014;5010.348654674869;5013.523715247045;4617.538246175389;4791.47293797682;4791.976040119812;4795.232762757942;4807.807687692488;11017.669469915916;11058.612948546843;11197.72005699864;16919.407820726214;17780.46658600244;1689.6705142497217;1738.209114852739;1777.5467255849676;1829.86276029297;1932.9079070325222;8075.717349892784;8819.51492667903;9668.564914578861;9789.265805064648;12210.450529726095;1638.3037209186168;1785.7857057153224;1883.6326916251337;1918.8957373386863;1943.4849764812336;40919.59080409187;41863.37204941928;42045;42886.785566072285;43674.781626091986;8320.958395208107;8538.658453661908;8745.650173992968;8904.109589041174;9108.954455227815;11642.35967021805;11664.650060498028;11667;11678.591249306404;11685.707857303465;6028.216331876915;6069.878602427927;6115.113308570232;6116.327204007555;6151.415615516608;5806.4193580641595;5813.389594092644;6009.909851352233;6178.5366097542865;6203.286622038433;3502.422100353464;3626.220362622049;3776.811159442017;3832.7317087803585;3914.5693973662874;2740.4242560527778;2842.5167721487396;2848.643919510061;2951.896683616106;2962.525995840655;711.9359257666835;739.2275072549199;764.4992529892818;842.8946381702287;877.9561021948876;12231;13751.174929504261;13981.720365592631;14275.500357487437;14922.328495217524;842.8187939593017;849.8512760266929;858.5149390594295;881.352206128495;938.8310104181177;6730.360615741497;8293.917060829315;8560.914390856136;8681.609327580274;8990.730278091667;453362;458030;458358;459124;460296;61494.85305087292;66340.6682966582;66670.66664666742;66673;68605.65697171583;1022.6267412394423;1024.5696807340785;1028.8456731490337;1029.0738335497963;1030.2427715629008;13565.59303220905;13834.169949802641;13835.723285534434;14074;14271.14373137615;29564.408711826072;29607.85196074006;29983.250418738833;31033;31291.374172516877;39542;39931.800340999274;40003.79998099991;40281.79859100686;42491.57508425;6264.843378915563;6528.445082168069;6536.281009089092;6552.410283074356;6701.061851340914;8937.329700272636;9486.667966621135;9779.168770654574;9823.410595364301;10099.545520451451;8386.496810191407;8572.185642363966;9065.909340906506;9259.583318750538;9387.29595280343;8874.556272186494;9069.319801015083;9106.544672766468;9124.133207345292;9454.196393306645;8932;9164.175224229852;9299.395539289924;9390.906090939003;9730.708078757365;6620.006998950196;6625.50308726857;6636.170478690164;6749.527533072638;6834.555753875982;8601.139886011599;8603.397762156588;8793.472391656522;8853.468791872509;8976.461412315282 04:44:04 INFO - PROCESS | 1075 | |3;mootools.html;1207.3842340406402;1356.1117468058421;1375.8555351688076;1473.8378778334381;1696.9575760605983;5934.05055191169;6086.147939288503;6480.222373315203;6603.075569420273;6625.569337993027;6410.102585638003;6420.646864422455;6476.1257230273895;6482.611043337403;6483.448906842924;1740.8694347923956;1792.0233472757313;2018.7072874433236;2044.94887627809;2046.5190680190144;2039.377989713137;2093.099967014183;2096.2139197800825;2097.182098981391;2104.8000439958255;1904.6190761847618;1930.3340347580133;1931.111688623235;1996.2414282572602;2008.5079155606898;1972.6054789042248;1979.9604007919834;1984.8015198480036;1986.5629561496448;1986.8311193548566;2029.9289524866706;2041.989790051055;2043.2644248070683;2048.8873111978837;2052.568960518293;6756.560823546453;6785.457163426914;6799.354061364212;6803.047573339736;6806.659667016629;3950.2692001979726;4025.0943537704075;4026.7583944963394;4049.311617025113;4054.0472988847596;2593.5590949538623;2648.0599387217453;2741.4380052089273;2753.6420265365373;2763.5440152374836;795.367682692261;803.441608082383;816.5998660656236;849.9107593702633;852.6972924611797;9177.954110229473;9180.6786762463;9188.540572971391;9188.586513606904;9213.262938964866;3686.3364594372733;3745.3071181831447;3808.8286027128847;3817.3510503213965;3824.7131465140224;7952.443328966917;7973.60131993398;8002.51984880909;8008.039035315799;8008.599570021475;4228.090960443519;4228.9577104228565;4229.555896630871;4231.4710661167355;4234.174336004511;3834.271488417192;3835.0795809006195;3839.520059992501;3844.59631738669;3845.7115716321387;2960;3017.9245518862203;3022.5163973764093;3236.886708965175;3323.4350160472777;924.7040946897063;1011.1809434358194;1011.7470632341915;1013.159077965287;1025.9640912568025;1023.6366090038078;1044.8276034454382;1057.2176589323844;1072.7157303314627;1073.8872418396113;6110.694465276719;6120.234970628671;6142.969285153635;6147.508199344042;6151.446369826737;1016;1016.9796604067877;1020.0921180149672;1023.923205759571;1053.7102296868422;5115.309433226466;5175.818846340435;5191;5209.6874187548865;5212.50481204285;7977.282044616012;8141.0230772307705;8247.546384948886;8396;8401.537915414588;8301.086880443147;8303.916960830315;8304.70933517324;8314.085450600429;8315.708950186714;6269.749210031548;6426.3573642635365;6468.159139311953;6560;6605.86788264232;6120.204373431426;6121.785737499345;6148.846278843064;6169.9691501544;6181.938180618316;7359.374453171326;7438.925610743823;7479.401647868266;7501.024866767285;7586;7422.628868556659;7690.423218258541;7691.50005249657;7703.961480192564;7709.151993280847;5940.524758019262;6004.699765011645;6011.639301641915;6014.939850601613;6017.518598512196;6107.908381374372;6192.287886892885;6248.562600618095;6256.906146407899;6270.561060725706;5343.9198412024625;5357.651752636066;5404.675719456845;5603.635763675348;5619.578531610064;5627.662340259598;5768.480836724715;5799.246098007232;5813.970930145322;5839.941600583939;5760.94239057604;5875.970620146872;6020.066889632114;6021.096835474714;6037.78867739627;5594.776208951596;5647.350554686263;5652.6043176978865;5661;5664.178694089252;5719.056355701429;5782.681952492485;5821.068629019336;5823.359430462561;5833.125031245348 04:44:04 INFO - PROCESS | 1075 | |4;prototype.html;298.1859523500843;299.4295866374557;301.4829567292095;305.04824946167946;310.76692480639514;5192.299039629654;5205.869853253671;5207.088759467088;5232.633715639907;5280.260763493114;4934.4325402578625;5079.873003174923;5085.771140298686;5090.9236361454605;5182.2226666000115;3943.38877473992;3962.62355076268;3977.4232736253225;3980.8208630611693;3995.740276882008;4023.3361495353233;4032.2540330039037;4044.211378781139;4044.858429954952;4048.57489963554;3963.9207215855668;3993.98003009986;4000.119973605802;4000.519937607491;4004.079061815784;3836.5971572984854;3936.9409458857854;3944.0337117406134;4023.8189281482405;4051.0885050863612;3575.106223444139;3589.28214357127;3590.6409359063887;3599.2441587266703;3606.062423769839;5025.472325405816;5025.773840177201;5032.094223039851;5035.043341765053;5055.090083784918;4640.211164102111;4650.162970665279;4651.069786042771;4652.278896771006;4655.09141252085;5328.680279183222;5447.237386765856;5448.91826622601;5449.863753406157;5462.5083742462975;3897.2010737798682;3899.610038996106;3901.141748815256;3902.746321489094;3904.6681032112306;5720;5732.455416735404;5735.4551317624755;5736.139579063132;5739.8565035874435;4017.5580686124504;4017.9397309040387;4018.799060046986;4024.2555127301544;4026.1947610478023;3963.4451176835264;4043.3732771420478;4066.268071747055;4075.714699971033;4084.7753373564738;4600.171969045537;4603.355530225771;4606.539346065367;4614.630829533629;4616.1229366420275;5458.044842152607;5460.863478412992;5471.972640136853;5476.17857321397;5479.369872464717;1419.3541938417995;1436.2603259321459;1436.6192958865909;1437.1664434627892;1438.5612388221484;961.0677642686583;972.4408465132577;984.8325784616633;991.0584944302797;993.4734590666958;4829.903401932012;4832.879178020507;4834;4834.8791280218275;4836.395450568679;5668.433156684298;5674.375818659944;5678.801241956512;5680.147977803363;5683;4829.9275510867365;4830.4444988826735;4836.685615434985;4839.1531481991215;4841.080194762983;2857.8571071446345;2934.6478422589;3026.228311780526;3032.696730326994;3067.739242164441;5390.326209223847;5391.137418013099;5396.4873337033705;5399.83800485986;5401.459854014645;5837.620554663933;5863.003289440805;5872.530197584183;5878.441548052928;5881.5882888198275;5372.435894231127;5387.326584176978;5390.892182156414;5391.029614669397;5398.136298192192;5556.861078473071;5720.542356611378;5724.599278050663;5732.656040637575;5734.139879018181;5579.246801681721;5588.832335029955;5594.188842617717;5594.468525490072;5601.29983752031;5375.274337964324;5378.4183591875335;5388.865278368072;5389.407165211745;5392.7573259202645;3958.6833053355085;3964.464797252334;3965.722399432012;3969.6824254060184;3969.9603003970747;5496.422875598005;5744.281964754406;5752.6836024019085;5760.596758226884;5805.245318108618;5549.306336707911;5553.694546799965;5557.944420555743;5558.72206389687;5564.276644036249;5550.195221692751;5553.6390134641115;5556.111022236423;5560.666360018412;5567.3040869891265;5316.122839731401;5438.891222175614;5442.836714898559;5444.6188766785945;5445.26488924006;5572.108462645957;5576.079946808731;5577.553795696415;5581.7767289309595;5586.1062230043;5136.152534831711;5221.660592061504;5326.680399176062;5340.385855626652;5355.303810504765 04:44:04 INFO - PROCESS | 1075 | |5;yui.html;689.9172099348079;696.0533674203086;737.4985010193067;766.9118051424086;786.5398741736086;11575.479103440344;11621.012213961823;11627.6511704649;11710.941445292783;11766.352850593225;10975.780484390307;11029;11035.117190624751;11061.059809916167;11064.17018723595;585.5198737035632;600.1717629671069;758.5903612049486;781.3709963479397;783.1463704562026;762.8092976755811;766.1419210484265;766.367746609047;768.1703759939252;768.4044865229436;628.0171531553104;635.0347471842796;812.6911773526052;813.2721214513007;816.302061737215;794.527256282511;806.3186607316867;809.8137428391474;812.0539571399313;812.3257696112242;597.7967491053063;603.3122240645667;603.5141710922705;603.8218725475995;605.678990135229;10176.440295783728;10254.230932680079;10260.076593106656;10274.7431314217;10281.280310378277;11538.596149134824;12149.392530373534;12196.268223906594;12472.75054498914;12616.68458288541;9422.434653920718;9453.952730236373;9547.427154370691;9693.563789629414;9922.553485093116;3162.3517178978254;3246.594175728034;3261.2825178460703;3261.2988207535495;3320.767546271762;41241.1751764966;41522;41535.7923210382;41645.375319370236;41742.37386439206;8898.955505222433;9221.631134754534;9251.398659087137;9294.117058879396;9516.38143520669;15595.220238988006;15609.453669121527;15636;15650.37398504047;15665.29506172225;6564.4420224281475;6670.566413183127;6720.193576770819;6730.0577919091365;6808.353206445379;3672.3022625701033;3746.325661380923;3766.7928263945746;3778.6410291022307;3782.5460944686265;2699.5275826730244;2743.0810678422554;2745.5607102863446;2747.079728291005;2748;496.14415133893743;498.2675467063411;506.29119233073993;506.53398873036895;506.78208370400347;528.8175579425092;530.3768072514857;562.7073921560766;588.4762561320429;604.2477115990532;7481.8877716834295;7567.545947243183;7614.2766437188375;7660.923390766021;7804;443.62513675943774;475.74547617024723;506.67319578872156;524.3759925688419;528.8598521391834;3533.6643018913164;3628.1111127773866;3989.900252493711;4029.194161167778;4116.176764647083;43410.78294608507;44520;44777.55222447799;44854.77572612116;46261;40507.1898562033;41224.79387603043;41372.1725565487;41485.585144148776;41489.377659335136;35558.46662300068;36461.63538364582;36504;36632.26735465329;37153.07117322034;8111.83776324482;8143.470674406145;8257.463264887763;8325.167483251626;8449.28181104613;28242.717572824007;28624.85687571549;28652.14043578696;29058.854705726335;29108.272293191993;35893.82053089822;36017.27965440729;36254.637453625124;36758.63241367552;36992.6300737;10183.7454063649;10255.641052563124;10269.897301027193;10299.7425064371;10406.843897341394;10961.461130996322;11507.482163302504;11589.362585057903;11651.76696466049;11897.762044758883;10288.176945844465;10389.792204155723;10559.155267578422;11069.225154239126;11120.944395277971;9781.902180978099;10441.269111162146;10741.624043158452;10774.838377424188;10888.836667450152;8848.867266991128;8857.689980850639;8961.910380896368;10532.420716860646;11162.497687603915;8350.665973361241;8360.66557337724;8370.288525475402;8444.366672499464;8530.957345213234;9134.817303654023;9139.680111196076;9176.816463670822;9277.350585458953;9521.095495927875 04:44:04 INFO - PROCESS | 1075 | __end_tp_report 04:44:04 INFO - PROCESS | 1075 | __start_cc_report 04:44:04 INFO - PROCESS | 1075 | _x_x_mozilla_cycle_collect,889 04:44:04 INFO - PROCESS | 1075 | __end_cc_report 04:44:04 INFO - PROCESS | 1075 | __startTimestamp1452689044528__endTimestamp 04:44:04 INFO - PROCESS | 1075 | 04:44:04 INFO - PROCESS | 1075 | ------- Summary: start ------- 04:44:04 INFO - PROCESS | 1075 | Number of tests: 6 04:44:04 INFO - PROCESS | 1075 | 04:44:04 INFO - PROCESS | 1075 | [#0] dojo.html Cycles:165 Average:4356.49 Median:4473.28 stddev:428.90 (9.6%) stddev-sans-first:406.72 04:44:04 INFO - PROCESS | 1075 | Values: 2571.8 2627.0 2635.5 2647.3 2657.0 4268.7 4348.7 4422.8 4423.4 4427.5 4416.0 4421.7 4428.6 4454.5 4475.9 4019.1 4055.2 4067.2 4186.5 4213.8 3960.7 4147.6 4178.7 4203.7 4216.5 4082.3 4099.6 4107.9 4119.0 4134.3 4048.9 4087.7 4092.1 4098.2 4106.1 3931.0 4011.2 4030.5 4033.3 4047.0 4225.9 4274.8 4321.8 4323.5 4357.7 4645.9 4670.2 4675.3 4677.2 4713.4 4663.2 4703.1 4709.4 4732.5 4749.1 4319.9 4368.7 4405.1 4424.0 4465.8 4829.4 4862.1 4863.9 4872.0 4910.6 4525.9 4624.7 4661.1 4684.0 4713.6 4679.2 4681.5 4695.7 4749.1 4783.3 4665.2 4682.5 4684.2 4694.5 4712.5 4572.0 4655.9 4656.9 4668.3 4701.9 3914.2 3936.1 3942.7 3974.8 3987.2 3492.8 3496.2 3500.8 3533.2 3533.2 3961.8 4068.4 4071.5 4109.4 4110.8 4628.7 4649.7 4677.5 4686.0 4710.7 4065.8 4067.3 4085.5 4092.3 4124.3 4198.1 4210.0 4210.6 4244.7 4262.6 4334.7 4400.0 4400.2 4438.2 4473.3 4757.6 4761.5 4776.0 4781.1 4823.3 4498.0 4506.3 4508.5 4513.8 4548.3 4569.7 4635.3 4637.8 4642.4 4734.1 4660.3 4677.1 4680.3 4680.9 4724.0 4533.5 4534.8 4536.7 4555.5 4577.2 4497.2 4567.8 4568.8 4581.5 4661.0 4451.1 4458.2 4463.9 4486.2 4507.8 4566.9 4569.7 4579.3 4606.7 4607.8 4402.9 4475.8 4495.2 4507.8 4556.3 04:44:04 INFO - PROCESS | 1075 | 04:44:04 INFO - PROCESS | 1075 | [#1] ext.html Cycles:180 Average:39365.20 Median:32878.25 stddev:63321.62 (192.6%) stddev-sans-first:63431.91 04:44:04 INFO - PROCESS | 1075 | Values: 471.9 485.0 492.7 516.1 519.5 25204.7 25673.7 25678.6 25716.4 32871.0 36645.6 36846.0 37102.6 37134.6 37233.3 7573.6 7749.0 7755.6 7760.4 7760.8 7452.4 7605.0 7611.4 7615.2 7619.0 7603.8 7778.5 7791.5 7811.3 7811.4 7695.3 7703.2 7758.0 7758.5 7770.3 7675.8 7786.2 7789.5 7791.6 7795.9 36975.8 37514.1 37552.8 37555.6 37599.0 2935.6 3026.7 3204.7 3574.7 3649.8 27465.6 27910.4 27926.9 28074.7 29265.3 3158.7 3209.3 3226.3 3233.0 3243.6 213093.0 215132.0 215461.0 215548.0 215562.0 46226.0 47194.5 54281.0 54354.5 54548.5 40696.0 57103.7 58550.0 58586.4 58632.7 11925.0 12073.5 12088.5 12129.5 12161.3 8869.2 9422.5 9515.0 10143.9 10363.9 17788.6 17823.2 17876.6 17977.5 17998.8 6738.5 6923.0 6956.7 6961.7 7043.5 787.8 832.4 870.0 879.3 888.4 23841.5 25519.7 25865.6 26333.5 26363.3 883.3 950.0 962.3 964.0 1026.0 13591.8 13745.2 13911.7 13921.9 13935.9 261195.0 263658.0 264171.0 264513.0 265064.0 46336.5 46647.2 46653.5 46678.0 46751.3 1186.6 1195.8 1202.6 1214.8 1214.8 25208.4 25961.6 26395.7 26483.3 26566.6 40502.6 40530.8 40757.8 40819.8 40937.8 245306.0 247001.0 247086.0 247451.0 247518.0 24232.0 29412.4 30582.4 30638.0 30908.8 35656.8 36226.3 36472.0 36557.6 36687.4 30791.8 31166.2 31211.8 32857.7 33488.3 28446.1 29366.9 29584.0 32885.5 36500.8 31345.4 31532.4 31555.5 33103.8 33927.5 25098.5 25625.5 25949.0 26184.7 26261.0 20861.4 21077.0 21247.6 21255.9 21288.0 04:44:04 INFO - PROCESS | 1075 | 04:44:04 INFO - PROCESS | 1075 | [#2] jquery.html Cycles:180 Average:23728.71 Median:4826.13 stddev:74770.92 (1549.3%) stddev-sans-first:74960.02 04:44:04 INFO - PROCESS | 1075 | Values: 327.3 340.9 342.5 344.6 347.7 11777.8 12177.1 14057.0 14230.0 15808.5 13937.7 14408.4 14475.4 15203.9 15205.6 4318.5 4844.4 5040.9 5821.6 5822.5 3686.2 3834.6 5508.5 5731.5 5755.3 4691.3 4879.4 5650.1 5665.0 5688.8 4976.6 4984.9 4993.5 5010.3 5013.5 4617.5 4791.5 4792.0 4795.2 4807.8 11017.7 11058.6 11197.7 16919.4 17780.5 1689.7 1738.2 1777.5 1829.9 1932.9 8075.7 8819.5 9668.6 9789.3 12210.5 1638.3 1785.8 1883.6 1918.9 1943.5 40919.6 41863.4 42045.0 42886.8 43674.8 8321.0 8538.7 8745.7 8904.1 9109.0 11642.4 11664.7 11667.0 11678.6 11685.7 6028.2 6069.9 6115.1 6116.3 6151.4 5806.4 5813.4 6009.9 6178.5 6203.3 3502.4 3626.2 3776.8 3832.7 3914.6 2740.4 2842.5 2848.6 2951.9 2962.5 711.9 739.2 764.5 842.9 878.0 12231.0 13751.2 13981.7 14275.5 14922.3 842.8 849.9 858.5 881.4 938.8 6730.4 8293.9 8560.9 8681.6 8990.7 453362.0 458030.0 458358.0 459124.0 460296.0 61494.9 66340.7 66670.7 66673.0 68605.7 1022.6 1024.6 1028.8 1029.1 1030.2 13565.6 13834.2 13835.7 14074.0 14271.1 29564.4 29607.9 29983.3 31033.0 31291.4 39542.0 39931.8 40003.8 40281.8 42491.6 6264.8 6528.4 6536.3 6552.4 6701.1 8937.3 9486.7 9779.2 9823.4 10099.5 8386.5 8572.2 9065.9 9259.6 9387.3 8874.6 9069.3 9106.5 9124.1 9454.2 8932.0 9164.2 9299.4 9390.9 9730.7 6620.0 6625.5 6636.2 6749.5 6834.6 8601.1 8603.4 8793.5 8853.5 8976.5 04:44:04 INFO - PROCESS | 1075 | 04:44:04 INFO - PROCESS | 1075 | [#3] mootools.html Cycles:180 Average:4727.40 Median:5740.00 stddev:2431.35 (42.4%) stddev-sans-first:2423.77 04:44:04 INFO - PROCESS | 1075 | Values: 1207.4 1356.1 1375.9 1473.8 1697.0 5934.1 6086.1 6480.2 6603.1 6625.6 6410.1 6420.6 6476.1 6482.6 6483.4 1740.9 1792.0 2018.7 2044.9 2046.5 2039.4 2093.1 2096.2 2097.2 2104.8 1904.6 1930.3 1931.1 1996.2 2008.5 1972.6 1980.0 1984.8 1986.6 1986.8 2029.9 2042.0 2043.3 2048.9 2052.6 6756.6 6785.5 6799.4 6803.0 6806.7 3950.3 4025.1 4026.8 4049.3 4054.0 2593.6 2648.1 2741.4 2753.6 2763.5 795.4 803.4 816.6 849.9 852.7 9178.0 9180.7 9188.5 9188.6 9213.3 3686.3 3745.3 3808.8 3817.4 3824.7 7952.4 7973.6 8002.5 8008.0 8008.6 4228.1 4229.0 4229.6 4231.5 4234.2 3834.3 3835.1 3839.5 3844.6 3845.7 2960.0 3017.9 3022.5 3236.9 3323.4 924.7 1011.2 1011.7 1013.2 1026.0 1023.6 1044.8 1057.2 1072.7 1073.9 6110.7 6120.2 6143.0 6147.5 6151.4 1016.0 1017.0 1020.1 1023.9 1053.7 5115.3 5175.8 5191.0 5209.7 5212.5 7977.3 8141.0 8247.5 8396.0 8401.5 8301.1 8303.9 8304.7 8314.1 8315.7 6269.7 6426.4 6468.2 6560.0 6605.9 6120.2 6121.8 6148.8 6170.0 6181.9 7359.4 7438.9 7479.4 7501.0 7586.0 7422.6 7690.4 7691.5 7704.0 7709.2 5940.5 6004.7 6011.6 6014.9 6017.5 6107.9 6192.3 6248.6 6256.9 6270.6 5343.9 5357.7 5404.7 5603.6 5619.6 5627.7 5768.5 5799.2 5814.0 5839.9 5760.9 5876.0 6020.1 6021.1 6037.8 5594.8 5647.4 5652.6 5661.0 5664.2 5719.1 5782.7 5821.1 5823.4 5833.1 04:44:04 INFO - PROCESS | 1075 | 04:44:04 INFO - PROCESS | 1075 | [#4] prototype.html Cycles:180 Average:4560.41 Median:5187.26 stddev:1335.40 (25.7%) stddev-sans-first:1300.26 04:44:04 INFO - PROCESS | 1075 | Values: 298.2 299.4 301.5 305.0 310.8 5192.3 5205.9 5207.1 5232.6 5280.3 4934.4 5079.9 5085.8 5090.9 5182.2 3943.4 3962.6 3977.4 3980.8 3995.7 4023.3 4032.3 4044.2 4044.9 4048.6 3963.9 3994.0 4000.1 4000.5 4004.1 3836.6 3936.9 3944.0 4023.8 4051.1 3575.1 3589.3 3590.6 3599.2 3606.1 5025.5 5025.8 5032.1 5035.0 5055.1 4640.2 4650.2 4651.1 4652.3 4655.1 5328.7 5447.2 5448.9 5449.9 5462.5 3897.2 3899.6 3901.1 3902.7 3904.7 5720.0 5732.5 5735.5 5736.1 5739.9 4017.6 4017.9 4018.8 4024.3 4026.2 3963.4 4043.4 4066.3 4075.7 4084.8 4600.2 4603.4 4606.5 4614.6 4616.1 5458.0 5460.9 5472.0 5476.2 5479.4 1419.4 1436.3 1436.6 1437.2 1438.6 961.1 972.4 984.8 991.1 993.5 4829.9 4832.9 4834.0 4834.9 4836.4 5668.4 5674.4 5678.8 5680.1 5683.0 4829.9 4830.4 4836.7 4839.2 4841.1 2857.9 2934.6 3026.2 3032.7 3067.7 5390.3 5391.1 5396.5 5399.8 5401.5 5837.6 5863.0 5872.5 5878.4 5881.6 5372.4 5387.3 5390.9 5391.0 5398.1 5556.9 5720.5 5724.6 5732.7 5734.1 5579.2 5588.8 5594.2 5594.5 5601.3 5375.3 5378.4 5388.9 5389.4 5392.8 3958.7 3964.5 3965.7 3969.7 3970.0 5496.4 5744.3 5752.7 5760.6 5805.2 5549.3 5553.7 5557.9 5558.7 5564.3 5550.2 5553.6 5556.1 5560.7 5567.3 5316.1 5438.9 5442.8 5444.6 5445.3 5572.1 5576.1 5577.6 5581.8 5586.1 5136.2 5221.7 5326.7 5340.4 5355.3 04:44:04 INFO - PROCESS | 1075 | 04:44:04 INFO - PROCESS | 1075 | [#5] yui.html Cycles:180 Average:11698.82 Median:42576.58 stddev:12785.51 (30.0%) stddev-sans-first:12794.64 04:44:04 INFO - PROCESS | 1075 | Values: 689.9 696.1 737.5 766.9 786.5 11575.5 11621.0 11627.7 11710.9 11766.4 10975.8 11029.0 11035.1 11061.1 11064.2 585.5 600.2 758.6 781.4 783.1 762.8 766.1 766.4 768.2 768.4 628.0 635.0 812.7 813.3 816.3 794.5 806.3 809.8 812.1 812.3 597.8 603.3 603.5 603.8 605.7 10176.4 10254.2 10260.1 10274.7 10281.3 11538.6 12149.4 12196.3 12472.8 12616.7 9422.4 9454.0 9547.4 9693.6 9922.6 3162.4 3246.6 3261.3 3261.3 3320.8 41241.2 41522.0 41535.8 41645.4 41742.4 8899.0 9221.6 9251.4 9294.1 9516.4 15595.2 15609.5 15636.0 15650.4 15665.3 6564.4 6670.6 6720.2 6730.1 6808.4 3672.3 3746.3 3766.8 3778.6 3782.5 2699.5 2743.1 2745.6 2747.1 2748.0 496.1 498.3 506.3 506.5 506.8 528.8 530.4 562.7 588.5 604.2 7481.9 7567.5 7614.3 7660.9 7804.0 443.6 475.7 506.7 524.4 528.9 3533.7 3628.1 3989.9 4029.2 4116.2 43410.8 44520.0 44777.6 44854.8 46261.0 40507.2 41224.8 41372.2 41485.6 41489.4 35558.5 36461.6 36504.0 36632.3 37153.1 8111.8 8143.5 8257.5 8325.2 8449.3 28242.7 28624.9 28652.1 29058.9 29108.3 35893.8 36017.3 36254.6 36758.6 36992.6 10183.7 10255.6 10269.9 10299.7 10406.8 10961.5 11507.5 11589.4 11651.8 11897.8 10288.2 10389.8 10559.2 11069.2 11120.9 9781.9 10441.3 10741.6 10774.8 10888.8 8848.9 8857.7 8961.9 10532.4 11162.5 8350.7 8360.7 8370.3 8444.4 8531.0 9134.8 9139.7 9176.8 9277.4 9521.1 04:44:04 INFO - PROCESS | 1075 | -------- Summary: end -------- 04:44:04 INFO - PROCESS | 1075 | 04:44:05 INFO - TEST-INFO | 1075: exit 0 04:44:05 INFO - TEST-OK | dromaeo_css | took 1116262ms 04:44:05 INFO - TEST-START | kraken 04:44:05 INFO - operating with platform_type : linux_ 04:44:05 INFO - Initialising browser for kraken test... 04:44:05 INFO - TEST-INFO | started process 1338 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVfabsh/profile http://localhost:48185/getInfo.html) 04:44:09 INFO - PROCESS | 1338 | __metrics Screen width/height:1600/1200 04:44:09 INFO - PROCESS | 1338 | colorDepth:24 04:44:09 INFO - PROCESS | 1338 | Browser inner width/height: 1024/697 04:44:09 INFO - PROCESS | 1338 | __metrics 04:44:09 INFO - PROCESS | 1338 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:44:09 INFO - PROCESS | 1338 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:44:10 INFO - TEST-INFO | 1338: exit 0 04:44:10 INFO - Browser initialized. 04:44:10 INFO - Running cycle 1/1 for kraken test... 04:44:10 INFO - TEST-INFO | started process 1423 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVfabsh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:44:22 INFO - PROCESS | 1423 | RSS: Main: 150806528 04:44:22 INFO - PROCESS | 1423 | 04:44:24 INFO - PROCESS | 1423 | Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48185/tests/kraken/driver.html?testName=audio-beat-detection) 04:44:25 INFO - PROCESS | 1423 | RSS: Main: 188149760 04:44:25 INFO - PROCESS | 1423 | 04:44:28 INFO - PROCESS | 1423 | Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48185/tests/kraken/driver.html?testName=audio-dft) 04:44:28 INFO - PROCESS | 1423 | RSS: Main: 178454528 04:44:28 INFO - PROCESS | 1423 | 04:44:31 INFO - PROCESS | 1423 | Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48185/tests/kraken/driver.html?testName=audio-fft) 04:44:32 INFO - PROCESS | 1423 | RSS: Main: 163336192 04:44:32 INFO - PROCESS | 1423 | 04:44:34 INFO - PROCESS | 1423 | Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48185/tests/kraken/driver.html?testName=audio-oscillator) 04:44:34 INFO - PROCESS | 1423 | RSS: Main: 162615296 04:44:34 INFO - PROCESS | 1423 | 04:44:37 INFO - PROCESS | 1423 | Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48185/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:44:37 INFO - PROCESS | 1423 | RSS: Main: 166100992 04:44:37 INFO - PROCESS | 1423 | 04:44:40 INFO - PROCESS | 1423 | Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48185/tests/kraken/driver.html?testName=imaging-darkroom) 04:44:41 INFO - PROCESS | 1423 | RSS: Main: 166305792 04:44:41 INFO - PROCESS | 1423 | 04:44:44 INFO - PROCESS | 1423 | Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48185/tests/kraken/driver.html?testName=imaging-desaturate) 04:44:45 INFO - PROCESS | 1423 | RSS: Main: 167378944 04:44:45 INFO - PROCESS | 1423 | 04:44:48 INFO - PROCESS | 1423 | Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48185/tests/kraken/driver.html?testName=json-parse-financial) 04:44:48 INFO - PROCESS | 1423 | RSS: Main: 167510016 04:44:48 INFO - PROCESS | 1423 | 04:44:50 INFO - PROCESS | 1423 | Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48185/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:44:51 INFO - PROCESS | 1423 | RSS: Main: 177594368 04:44:51 INFO - PROCESS | 1423 | 04:44:52 INFO - PROCESS | 1423 | Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48185/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:44:53 INFO - PROCESS | 1423 | RSS: Main: 176103424 04:44:53 INFO - PROCESS | 1423 | 04:44:55 INFO - PROCESS | 1423 | Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48185/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:44:56 INFO - PROCESS | 1423 | RSS: Main: 184758272 04:44:56 INFO - PROCESS | 1423 | 04:44:58 INFO - PROCESS | 1423 | Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48185/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:44:59 INFO - PROCESS | 1423 | RSS: Main: 189022208 04:44:59 INFO - PROCESS | 1423 | 04:45:01 INFO - PROCESS | 1423 | Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48185/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:45:02 INFO - PROCESS | 1423 | RSS: Main: 187944960 04:45:02 INFO - PROCESS | 1423 | 04:45:04 INFO - PROCESS | 1423 | Cycle 1(1): loaded http://localhost:48185/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48185/tests/kraken/driver.html?testName=ai-astar) 04:45:04 INFO - PROCESS | 1423 | RSS: Main: 245350400 04:45:04 INFO - PROCESS | 1423 | 04:45:04 INFO - PROCESS | 1423 | __start_tp_report 04:45:04 INFO - PROCESS | 1423 | _x_x_mozilla_page_load 04:45:04 INFO - PROCESS | 1423 | _x_x_mozilla_page_load_details 04:45:04 INFO - PROCESS | 1423 | |i|pagename|runs| 04:45:04 INFO - PROCESS | 1423 | |0;ai-astar;113;117;109;114;115;115;106;113;114;114 04:45:04 INFO - PROCESS | 1423 | |1;audio-beat-detection;162;136;154;164;142;159;160;140;176;132 04:45:04 INFO - PROCESS | 1423 | |2;audio-dft;162;162;160;162;161;160;161;163;162;161 04:45:04 INFO - PROCESS | 1423 | |3;audio-fft;71;72;95;92;72;73;72;107;91;74 04:45:04 INFO - PROCESS | 1423 | |4;audio-oscillator;98;97;132;96;97;97;138;98;96;130 04:45:04 INFO - PROCESS | 1423 | |5;imaging-gaussian-blur;110;109;110;109;109;111;109;109;109;109 04:45:04 INFO - PROCESS | 1423 | |6;imaging-darkroom;149;149;149;147;147;147;148;146;149;148 04:45:04 INFO - PROCESS | 1423 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;96 04:45:04 INFO - PROCESS | 1423 | |8;json-parse-financial;68;67;67;66;67;66;68;75;65;66 04:45:04 INFO - PROCESS | 1423 | |9;json-stringify-tinderbox;66;67;67;67;67;67;66;67;67;67 04:45:04 INFO - PROCESS | 1423 | |10;stanford-crypto-aes;92;86;84;84;82;82;84;84;84;83 04:45:04 INFO - PROCESS | 1423 | |11;stanford-crypto-ccm;128;122;119;120;119;121;121;120;120;121 04:45:04 INFO - PROCESS | 1423 | |12;stanford-crypto-pbkdf2;150;136;135;149;148;135;147;145;148;145 04:45:04 INFO - PROCESS | 1423 | |13;stanford-crypto-sha256-iterative;72;71;72;72;73;69;71;71;70;69 04:45:04 INFO - PROCESS | 1423 | __end_tp_report 04:45:04 INFO - PROCESS | 1423 | __start_cc_report 04:45:04 INFO - PROCESS | 1423 | _x_x_mozilla_cycle_collect,997 04:45:04 INFO - PROCESS | 1423 | __end_cc_report 04:45:04 INFO - PROCESS | 1423 | __startTimestamp1452689104509__endTimestamp 04:45:04 INFO - PROCESS | 1423 | 04:45:04 INFO - PROCESS | 1423 | ------- Summary: start ------- 04:45:04 INFO - PROCESS | 1423 | Number of tests: 14 04:45:04 INFO - PROCESS | 1423 | 04:45:04 INFO - PROCESS | 1423 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.00 stddev:3.20 (2.8%) stddev-sans-first:3.39 04:45:04 INFO - PROCESS | 1423 | Values: 113.0 117.0 109.0 114.0 115.0 115.0 106.0 113.0 114.0 114.0 04:45:04 INFO - PROCESS | 1423 | 04:45:04 INFO - PROCESS | 1423 | [#1] audio-beat-detection Cycles:10 Average:152.50 Median:159.50 stddev:14.28 (9.0%) stddev-sans-first:14.72 04:45:04 INFO - PROCESS | 1423 | Values: 162.0 136.0 154.0 164.0 142.0 159.0 160.0 140.0 176.0 132.0 04:45:04 INFO - PROCESS | 1423 | 04:45:04 INFO - PROCESS | 1423 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 04:45:04 INFO - PROCESS | 1423 | Values: 162.0 162.0 160.0 162.0 161.0 160.0 161.0 163.0 162.0 161.0 04:45:04 INFO - PROCESS | 1423 | 04:45:04 INFO - PROCESS | 1423 | [#3] audio-fft Cycles:10 Average:81.90 Median:73.50 stddev:13.08 (17.8%) stddev-sans-first:13.27 04:45:04 INFO - PROCESS | 1423 | Values: 71.0 72.0 95.0 92.0 72.0 73.0 72.0 107.0 91.0 74.0 04:45:04 INFO - PROCESS | 1423 | 04:45:04 INFO - PROCESS | 1423 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:97.00 stddev:17.67 (18.2%) stddev-sans-first:18.38 04:45:04 INFO - PROCESS | 1423 | Values: 98.0 97.0 132.0 96.0 97.0 97.0 138.0 98.0 96.0 130.0 04:45:04 INFO - PROCESS | 1423 | 04:45:04 INFO - PROCESS | 1423 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 04:45:04 INFO - PROCESS | 1423 | Values: 110.0 109.0 110.0 109.0 109.0 111.0 109.0 109.0 109.0 109.0 04:45:04 INFO - PROCESS | 1423 | 04:45:04 INFO - PROCESS | 1423 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.50 stddev:1.10 (0.7%) stddev-sans-first:1.09 04:45:04 INFO - PROCESS | 1423 | Values: 149.0 149.0 149.0 147.0 147.0 147.0 148.0 146.0 149.0 148.0 04:45:04 INFO - PROCESS | 1423 | 04:45:04 INFO - PROCESS | 1423 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:45:04 INFO - PROCESS | 1423 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 04:45:04 INFO - PROCESS | 1423 | 04:45:04 INFO - PROCESS | 1423 | [#8] json-parse-financial Cycles:10 Average:67.50 Median:67.00 stddev:2.80 (4.2%) stddev-sans-first:2.96 04:45:04 INFO - PROCESS | 1423 | Values: 68.0 67.0 67.0 66.0 67.0 66.0 68.0 75.0 65.0 66.0 04:45:04 INFO - PROCESS | 1423 | 04:45:04 INFO - PROCESS | 1423 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 04:45:04 INFO - PROCESS | 1423 | Values: 66.0 67.0 67.0 67.0 67.0 67.0 66.0 67.0 67.0 67.0 04:45:04 INFO - PROCESS | 1423 | 04:45:04 INFO - PROCESS | 1423 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.00 stddev:2.88 (3.4%) stddev-sans-first:1.22 04:45:04 INFO - PROCESS | 1423 | Values: 92.0 86.0 84.0 84.0 82.0 82.0 84.0 84.0 84.0 83.0 04:45:04 INFO - PROCESS | 1423 | 04:45:04 INFO - PROCESS | 1423 | [#11] stanford-crypto-ccm Cycles:10 Average:121.10 Median:121.00 stddev:2.60 (2.1%) stddev-sans-first:1.00 04:45:04 INFO - PROCESS | 1423 | Values: 128.0 122.0 119.0 120.0 119.0 121.0 121.0 120.0 120.0 121.0 04:45:04 INFO - PROCESS | 1423 | 04:45:04 INFO - PROCESS | 1423 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.80 Median:147.50 stddev:6.05 (4.1%) stddev-sans-first:5.99 04:45:04 INFO - PROCESS | 1423 | Values: 150.0 136.0 135.0 149.0 148.0 135.0 147.0 145.0 148.0 145.0 04:45:04 INFO - PROCESS | 1423 | 04:45:04 INFO - PROCESS | 1423 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:71.50 stddev:1.33 (1.9%) stddev-sans-first:1.36 04:45:04 INFO - PROCESS | 1423 | Values: 72.0 71.0 72.0 72.0 73.0 69.0 71.0 71.0 70.0 69.0 04:45:04 INFO - PROCESS | 1423 | -------- Summary: end -------- 04:45:04 INFO - PROCESS | 1423 | 04:45:05 INFO - TEST-INFO | 1423: exit 0 04:45:05 INFO - TEST-OK | kraken | took 60223ms 04:45:05 INFO - TEST-START | v8_7 04:45:05 INFO - operating with platform_type : linux_ 04:45:05 INFO - Initialising browser for v8_7 test... 04:45:05 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk5W7AO/profile http://localhost:48185/getInfo.html) 04:45:09 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 04:45:09 INFO - PROCESS | 1667 | colorDepth:24 04:45:09 INFO - PROCESS | 1667 | Browser inner width/height: 1024/697 04:45:09 INFO - PROCESS | 1667 | __metrics 04:45:09 INFO - PROCESS | 1667 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:45:09 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:45:10 INFO - TEST-INFO | 1667: exit 0 04:45:10 INFO - Browser initialized. 04:45:10 INFO - Running cycle 1/1 for v8_7 test... 04:45:10 INFO - TEST-INFO | started process 1749 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk5W7AO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:45:22 INFO - PROCESS | 1749 | RSS: Main: 150454272 04:45:22 INFO - PROCESS | 1749 | 04:45:44 INFO - PROCESS | 1749 | Cycle 1(1): loaded http://localhost:48185/tests/v8_7/run.html (next: http://localhost:48185/tests/v8_7/run.html) 04:45:45 INFO - PROCESS | 1749 | RSS: Main: 448724992 04:45:45 INFO - PROCESS | 1749 | 04:45:45 INFO - PROCESS | 1749 | __start_tp_report 04:45:45 INFO - PROCESS | 1749 | _x_x_mozilla_page_load 04:45:45 INFO - PROCESS | 1749 | _x_x_mozilla_page_load_details 04:45:45 INFO - PROCESS | 1749 | |i|pagename|runs| 04:45:45 INFO - PROCESS | 1749 | |0;Richards;171.35023989033584 04:45:45 INFO - PROCESS | 1749 | |1;DeltaBlue;189.07165815844206 04:45:45 INFO - PROCESS | 1749 | |2;Encrypt;279.6420581655481 04:45:45 INFO - PROCESS | 1749 | |3;Decrypt;5159.79381443299 04:45:45 INFO - PROCESS | 1749 | |4;RayTrace;1974.3589743589744 04:45:45 INFO - PROCESS | 1749 | |5;Earley;801.924619085806 04:45:45 INFO - PROCESS | 1749 | |6;Boyer;12365.853658536585 04:45:45 INFO - PROCESS | 1749 | |7;RegExp;44217.391304347824 04:45:45 INFO - PROCESS | 1749 | |8;Splay;595.7320687611144 04:45:45 INFO - PROCESS | 1749 | |9;NavierStokes;4830.917874396136 04:45:45 INFO - PROCESS | 1749 | __end_tp_report 04:45:45 INFO - PROCESS | 1749 | __startTimestamp1452689145202__endTimestamp 04:45:45 INFO - PROCESS | 1749 | 04:45:45 INFO - PROCESS | 1749 | ------- Summary: start ------- 04:45:45 INFO - PROCESS | 1749 | Number of tests: 10 04:45:45 INFO - PROCESS | 1749 | 04:45:45 INFO - PROCESS | 1749 | [#0] Richards Cycles:1 Average:171.35 Median:171.35 stddev:0.00 (0.0%) 04:45:45 INFO - PROCESS | 1749 | Values: 171.4 04:45:45 INFO - PROCESS | 1749 | 04:45:45 INFO - PROCESS | 1749 | [#1] DeltaBlue Cycles:1 Average:189.07 Median:189.07 stddev:0.00 (0.0%) 04:45:45 INFO - PROCESS | 1749 | Values: 189.1 04:45:45 INFO - PROCESS | 1749 | 04:45:45 INFO - PROCESS | 1749 | [#2] Encrypt Cycles:1 Average:279.64 Median:279.64 stddev:0.00 (0.0%) 04:45:45 INFO - PROCESS | 1749 | Values: 279.6 04:45:45 INFO - PROCESS | 1749 | 04:45:45 INFO - PROCESS | 1749 | [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 04:45:45 INFO - PROCESS | 1749 | Values: 5159.8 04:45:45 INFO - PROCESS | 1749 | 04:45:45 INFO - PROCESS | 1749 | [#4] RayTrace Cycles:1 Average:1974.36 Median:1974.36 stddev:0.00 (0.0%) 04:45:45 INFO - PROCESS | 1749 | Values: 1974.4 04:45:45 INFO - PROCESS | 1749 | 04:45:45 INFO - PROCESS | 1749 | [#5] Earley Cycles:1 Average:801.92 Median:801.92 stddev:0.00 (0.0%) 04:45:45 INFO - PROCESS | 1749 | Values: 801.9 04:45:45 INFO - PROCESS | 1749 | 04:45:45 INFO - PROCESS | 1749 | [#6] Boyer Cycles:1 Average:12365.85 Median:12365.85 stddev:0.00 (0.0%) 04:45:45 INFO - PROCESS | 1749 | Values: 12365.9 04:45:45 INFO - PROCESS | 1749 | 04:45:45 INFO - PROCESS | 1749 | [#7] RegExp Cycles:1 Average:44217.39 Median:44217.39 stddev:0.00 (0.0%) 04:45:45 INFO - PROCESS | 1749 | Values: 44217.4 04:45:45 INFO - PROCESS | 1749 | 04:45:45 INFO - PROCESS | 1749 | [#8] Splay Cycles:1 Average:595.73 Median:595.73 stddev:0.00 (0.0%) 04:45:45 INFO - PROCESS | 1749 | Values: 595.7 04:45:45 INFO - PROCESS | 1749 | 04:45:45 INFO - PROCESS | 1749 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 04:45:45 INFO - PROCESS | 1749 | Values: 4830.9 04:45:45 INFO - PROCESS | 1749 | -------- Summary: end -------- 04:45:45 INFO - PROCESS | 1749 | 04:45:46 INFO - TEST-INFO | 1749: exit 0 04:45:46 INFO - TEST-OK | v8_7 | took 40646ms 04:45:46 INFO - SUITE-END | took 1217s 04:45:46 INFO - Completed test suite (00:20:17) 04:45:46 INFO - Working with test: dromaeo_css 04:45:46 INFO - Generating results file: dromaeo_css 04:45:46 INFO - Working with test: kraken 04:45:46 INFO - Generating results file: kraken 04:45:46 INFO - javascript benchmark 04:45:46 INFO - Working with test: v8_7 04:45:46 INFO - Generating results file: v8_7 04:45:46 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:45:46 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 04:45:46 INFO - process_Request line: dromaeo_css 5992.47 graph.html#tests=[[72,132,35]] 04:45:46 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:45:46 INFO - process_Request line: kraken 1523.90 graph.html#tests=[[232,132,35]] 04:45:46 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:45:46 INFO - process_Request line: v8_7 18771.49 graph.html#tests=[[230,132,35]] 04:45:46 INFO - RETURN: dromaeo_css: 5992.47 04:45:46 INFO - RETURN: kraken: 1523.90 04:45:46 INFO - RETURN: v8_7: 18771.49 04:45:46 INFO - javascript benchmark 04:45:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2571.8207912142766, 2627.0, 2635.4597307551953, 2647.2852329870934, 2657.0434643528333, 4268.7438753674805, 4348.717333373336, 4422.756748378842, 4423.447069116361, 4427.490838553564, 4415.977920110395, 4421.66837487189, 4428.645708343332, 4454.510003899569, 4475.888102797432, 4019.1157945252, 4055.2497787909183, 4067.1865626874596, 4186.455760751098, 4213.789310534461, 3960.7029472789513, 4147.56210854386, 4178.707490475668, 4203.6637069034405, 4216.515100763406, 4082.306007978636, 4099.631033206996, 4107.856225032139, 4119.0, 4134.255833949888, 4048.8785336439955, 4087.6729861611298, 4092.1201941582704, 4098.221337945811, 4106.137711080677, 3931.0, 4011.1576568920564, 4030.5163380394542, 4033.3143365627916, 4046.9595304046875, 4225.936610950838, 4274.786260686953, 4321.783910804447, 4323.546027667081, 4357.651387888993, 4645.907081858344, 4670.159371313196, 4675.345451636774, 4677.18149323867, 4713.363695901044, 4663.183942809995, 4703.106409782131, 4709.434867815849, 4732.455767586737, 4749.121412538691, 4319.920019995001, 4368.716033457815, 4405.07493426384, 4424.0, 4465.754383508938, 4829.372181616367, 4862.1005114053305, 4863.878403039882, 4872.049950259665, 4910.607151427877, 4525.909481810345, 4624.722516648944, 4661.114388266218, 4683.95316046842, 4713.622910167247, 4679.181143299909, 4681.461631912373, 4695.718256904596, 4749.097671442415, 4783.330333753277, 4665.183592871234, 4682.461516925598, 4684.227102528044, 4694.460137084211, 4712.52874712526, 4571.977140114344, 4655.86032419028, 4656.930146047812, 4668.346431499593, 4701.882452938704, 3914.1584559319313, 3936.0553467167674, 3942.743721658083, 3974.7615143091507, 3987.1626958338493, 3492.8253587320532, 3496.1609213788506, 3500.842462089212, 3533.152043509539, 3533.2403533239963, 3961.782101984361, 4068.4304197412384, 4071.5114186297833, 4109.363048727452, 4110.753354798721, 4628.74541900192, 4649.697769644962, 4677.508861569554, 4686.0, 4710.670253082251, 4065.79671016448, 4067.328890732996, 4085.4893138357706, 4092.3043082676018, 4124.340105583093, 4198.1393814268, 4210.031692710632, 4210.642095421862, 4244.72409293395, 4262.552431994658, 4334.653227741773, 4399.978000109979, 4400.163968845909, 4438.245498265367, 4473.2842745161915, 4757.643176761688, 4761.500042495627, 4776.02091571234, 4781.091592597395, 4823.27650852375, 4497.955020449754, 4506.301523263899, 4508.45898492183, 4513.774311284357, 4548.317752337176, 4569.748663823389, 4635.327877457682, 4637.814487420465, 4642.396488456614, 4734.100520901018, 4660.254359302496, 4677.134730074947, 4680.344751734828, 4680.859574212779, 4724.00795832879, 4533.501314855297, 4534.773261336986, 4536.6824322297125, 4555.544445555418, 4577.198990176639, 4497.235469970047, 4567.81728730847, 4568.81724731007, 4581.450225972904, 4661.021185551072, 4451.132029254394, 4458.2420988431395, 4463.910721785481, 4486.214912390254, 4507.752073635981, 4566.908661826811, 4569.680122391401, 4579.290210017452, 4606.677532572822, 4607.815687372467, 4402.911941761083, 4475.843345482893, 4495.190865644216, 4507.7971491282315, 4556.2937744649635], "unit": "score", "name": "dojo.html", "value": 4331.5883189536}, {"lowerIsBetter": false, "replicates": [471.87731189890627, 485.04446240905406, 492.7363860334722, 516.1328967334877, 519.5376115257419, 25204.74795252047, 25673.74326256737, 25678.61482077768, 25716.35709107271, 32871.0, 36645.63354366455, 36846.0, 37102.628973710256, 37134.62865371346, 37233.255334893285, 7573.583452910101, 7749.031371078615, 7755.573443460607, 7760.417968652374, 7760.805979850493, 7452.366548843354, 7605.049368828896, 7611.391088712918, 7615.200403957588, 7619.047619047619, 7603.771886843404, 7778.494397864149, 7791.4935529190425, 7811.296983271504, 7811.414143939199, 7695.307422332017, 7703.1526532081425, 7758.0, 7758.495697779626, 7770.261825126604, 7675.846483070307, 7786.182450842636, 7789.493682910593, 7791.571463569501, 7795.883061754022, 36975.81512092449, 37514.06214844623, 37552.812235938916, 37555.624443755485, 37599.0, 2935.5743417204385, 3026.742726868219, 3204.7436205103536, 3574.749767516275, 3649.835757390924, 27465.588016179772, 27910.441791164267, 27926.86036569804, 28074.719252807416, 29265.268368290752, 3158.6999235072863, 3209.277912469699, 3226.2740883301303, 3233.0122260116914, 3243.5783348164823, 213093.0, 215131.99999999843, 215461.0, 215548.0, 215561.99999999843, 46226.0, 47194.5280547197, 54281.0, 54354.45645543494, 54548.45451545513, 40696.0, 57103.71448142816, 58550.0, 58586.4141358581, 58632.7068364664, 11925.0, 12073.517059317704, 12088.456019479145, 12129.514819407124, 12161.331126787934, 8869.157430044135, 9422.528873556432, 9514.952425237969, 10143.949280253551, 10363.94818025905, 17788.644227115386, 17823.197956092008, 17876.642467150843, 17977.460676179737, 17998.820011799715, 6738.460923126138, 6922.965385173143, 6956.7217311307995, 6961.65191740411, 7043.471739619549, 787.7676085554775, 832.433944917462, 869.9608517616722, 879.305348774461, 888.4180861535705, 23841.52316953651, 25519.744802552108, 25865.612015819777, 26333.47333053328, 26363.340916477242, 883.2933653077512, 950.0309684122157, 962.3215632978734, 963.9518024098767, 1025.9538320775582, 13591.78654617052, 13745.175289482662, 13911.721765564633, 13921.860781392057, 13935.860641393456, 261195.0, 263658.0, 264171.0, 264513.0, 265064.0, 46336.53663463322, 46647.201167930034, 46653.5334646656, 46678.0, 46751.29873051907, 1186.6143503361443, 1195.8266051422495, 1202.5730865542782, 1214.7752665756864, 1214.8481439820023, 25208.36979075538, 25961.610575841754, 26395.736042639328, 26483.337916552242, 26566.601500977886, 40502.59497404988, 40530.79734601308, 40757.79621101876, 40819.795901020305, 40937.795311023256, 245306.0, 247001.0, 247086.0, 247451.0, 247518.0, 24232.0, 29412.411751765274, 30582.388352232385, 30638.0, 30908.845455772578, 35656.82171589125, 36226.27547449089, 36472.0, 36557.634423656484, 36687.41407324084, 30791.84604076965, 31166.22084447907, 31211.843940780152, 32857.671423285465, 33488.33023339471, 28446.146615601567, 29366.853165734035, 29584.0, 32885.50671739974, 36500.81749591341, 31345.373092537564, 31532.369352613277, 31555.52666709955, 33103.8344808284, 33927.4910876342, 25098.498030039664, 25625.487490249718, 25949.0, 26184.73815261823, 26261.0, 20861.37415877526, 21077.0, 21247.575048499253, 21255.893720531298, 21288.0], "unit": "score", "name": "ext.html", "value": 16094.914727170179}, {"lowerIsBetter": false, "replicates": [327.2848825316683, 340.8892110064229, 342.54077629299184, 344.5624057447044, 347.74440786022285, 11777.764444711102, 12177.147599668027, 14056.961740547615, 14230.003899727024, 15808.525744227663, 13937.721245575083, 14408.423663053465, 14475.394429002801, 15203.92398038011, 15205.619859503518, 4318.52496225415, 4844.442889067758, 5040.873978150557, 5821.592488525805, 5822.53419726423, 3686.225892562565, 3834.616538346157, 5508.504234618884, 5731.512821410185, 5755.280589926259, 4691.3432119503295, 4879.438864530571, 5650.0959846424585, 5665.0, 5688.772449102031, 4976.601871850261, 4984.925226121611, 4993.500649935014, 5010.348654674869, 5013.523715247045, 4617.538246175389, 4791.47293797682, 4791.976040119812, 4795.232762757942, 4807.807687692488, 11017.669469915916, 11058.612948546843, 11197.72005699864, 16919.407820726214, 17780.46658600244, 1689.6705142497217, 1738.209114852739, 1777.5467255849676, 1829.86276029297, 1932.9079070325222, 8075.717349892784, 8819.51492667903, 9668.564914578861, 9789.265805064648, 12210.450529726095, 1638.3037209186168, 1785.7857057153224, 1883.6326916251337, 1918.8957373386863, 1943.4849764812336, 40919.59080409187, 41863.37204941928, 42045.0, 42886.785566072285, 43674.781626091986, 8320.958395208107, 8538.658453661908, 8745.650173992968, 8904.109589041174, 9108.954455227815, 11642.35967021805, 11664.650060498028, 11667.0, 11678.591249306404, 11685.707857303465, 6028.216331876915, 6069.878602427927, 6115.113308570232, 6116.327204007555, 6151.415615516608, 5806.4193580641595, 5813.389594092644, 6009.909851352233, 6178.5366097542865, 6203.286622038433, 3502.422100353464, 3626.220362622049, 3776.811159442017, 3832.7317087803585, 3914.5693973662874, 2740.4242560527778, 2842.5167721487396, 2848.643919510061, 2951.896683616106, 2962.525995840655, 711.9359257666835, 739.2275072549199, 764.4992529892818, 842.8946381702287, 877.9561021948876, 12231.0, 13751.174929504261, 13981.720365592631, 14275.500357487437, 14922.328495217524, 842.8187939593017, 849.8512760266929, 858.5149390594295, 881.352206128495, 938.8310104181177, 6730.360615741497, 8293.917060829315, 8560.914390856136, 8681.609327580274, 8990.730278091667, 453362.0, 458030.0, 458358.0, 459124.0, 460296.0, 61494.85305087292, 66340.6682966582, 66670.66664666742, 66673.0, 68605.65697171583, 1022.6267412394423, 1024.5696807340785, 1028.8456731490337, 1029.0738335497963, 1030.2427715629008, 13565.59303220905, 13834.169949802641, 13835.723285534434, 14074.0, 14271.14373137615, 29564.408711826072, 29607.85196074006, 29983.250418738833, 31033.0, 31291.374172516877, 39542.0, 39931.800340999274, 40003.79998099991, 40281.79859100686, 42491.57508425, 6264.843378915563, 6528.445082168069, 6536.281009089092, 6552.410283074356, 6701.061851340914, 8937.329700272636, 9486.667966621135, 9779.168770654574, 9823.410595364301, 10099.545520451451, 8386.496810191407, 8572.185642363966, 9065.909340906506, 9259.583318750538, 9387.29595280343, 8874.556272186494, 9069.319801015083, 9106.544672766468, 9124.133207345292, 9454.196393306645, 8932.0, 9164.175224229852, 9299.395539289924, 9390.906090939003, 9730.708078757365, 6620.006998950196, 6625.50308726857, 6636.170478690164, 6749.527533072638, 6834.555753875982, 8601.139886011599, 8603.397762156588, 8793.472391656522, 8853.468791872509, 8976.461412315282], "unit": "score", "name": "jquery.html", "value": 7389.076394806238}, {"lowerIsBetter": false, "replicates": [1207.3842340406402, 1356.1117468058421, 1375.8555351688076, 1473.8378778334381, 1696.9575760605983, 5934.05055191169, 6086.147939288503, 6480.222373315203, 6603.075569420273, 6625.569337993027, 6410.102585638003, 6420.646864422455, 6476.1257230273895, 6482.611043337403, 6483.448906842924, 1740.8694347923956, 1792.0233472757313, 2018.7072874433236, 2044.94887627809, 2046.5190680190144, 2039.377989713137, 2093.099967014183, 2096.2139197800825, 2097.182098981391, 2104.8000439958255, 1904.6190761847618, 1930.3340347580133, 1931.111688623235, 1996.2414282572602, 2008.5079155606898, 1972.6054789042248, 1979.9604007919834, 1984.8015198480036, 1986.5629561496448, 1986.8311193548566, 2029.9289524866706, 2041.989790051055, 2043.2644248070683, 2048.8873111978837, 2052.568960518293, 6756.560823546453, 6785.457163426914, 6799.354061364212, 6803.047573339736, 6806.659667016629, 3950.2692001979726, 4025.0943537704075, 4026.7583944963394, 4049.311617025113, 4054.0472988847596, 2593.5590949538623, 2648.0599387217453, 2741.4380052089273, 2753.6420265365373, 2763.5440152374836, 795.367682692261, 803.441608082383, 816.5998660656236, 849.9107593702633, 852.6972924611797, 9177.954110229473, 9180.6786762463, 9188.540572971391, 9188.586513606904, 9213.262938964866, 3686.3364594372733, 3745.3071181831447, 3808.8286027128847, 3817.3510503213965, 3824.7131465140224, 7952.443328966917, 7973.60131993398, 8002.51984880909, 8008.039035315799, 8008.599570021475, 4228.090960443519, 4228.9577104228565, 4229.555896630871, 4231.4710661167355, 4234.174336004511, 3834.271488417192, 3835.0795809006195, 3839.520059992501, 3844.59631738669, 3845.7115716321387, 2960.0, 3017.9245518862203, 3022.5163973764093, 3236.886708965175, 3323.4350160472777, 924.7040946897063, 1011.1809434358194, 1011.7470632341915, 1013.159077965287, 1025.9640912568025, 1023.6366090038078, 1044.8276034454382, 1057.2176589323844, 1072.7157303314627, 1073.8872418396113, 6110.694465276719, 6120.234970628671, 6142.969285153635, 6147.508199344042, 6151.446369826737, 1016.0, 1016.9796604067877, 1020.0921180149672, 1023.923205759571, 1053.7102296868422, 5115.309433226466, 5175.818846340435, 5191.0, 5209.6874187548865, 5212.50481204285, 7977.282044616012, 8141.0230772307705, 8247.546384948886, 8396.0, 8401.537915414588, 8301.086880443147, 8303.916960830315, 8304.70933517324, 8314.085450600429, 8315.708950186714, 6269.749210031548, 6426.3573642635365, 6468.159139311953, 6560.0, 6605.86788264232, 6120.204373431426, 6121.785737499345, 6148.846278843064, 6169.9691501544, 6181.938180618316, 7359.374453171326, 7438.925610743823, 7479.401647868266, 7501.024866767285, 7586.0, 7422.628868556659, 7690.423218258541, 7691.50005249657, 7703.961480192564, 7709.151993280847, 5940.524758019262, 6004.699765011645, 6011.639301641915, 6014.939850601613, 6017.518598512196, 6107.908381374372, 6192.287886892885, 6248.562600618095, 6256.906146407899, 6270.561060725706, 5343.9198412024625, 5357.651752636066, 5404.675719456845, 5603.635763675348, 5619.578531610064, 5627.662340259598, 5768.480836724715, 5799.246098007232, 5813.970930145322, 5839.941600583939, 5760.94239057604, 5875.970620146872, 6020.066889632114, 6021.096835474714, 6037.78867739627, 5594.776208951596, 5647.350554686263, 5652.6043176978865, 5661.0, 5664.178694089252, 5719.056355701429, 5782.681952492485, 5821.068629019336, 5823.359430462561, 5833.125031245348], "unit": "score", "name": "mootools.html", "value": 3901.669168394423}, {"lowerIsBetter": false, "replicates": [298.1859523500843, 299.4295866374557, 301.4829567292095, 305.04824946167946, 310.76692480639514, 5192.299039629654, 5205.869853253671, 5207.088759467088, 5232.633715639907, 5280.260763493114, 4934.4325402578625, 5079.873003174923, 5085.771140298686, 5090.9236361454605, 5182.2226666000115, 3943.38877473992, 3962.62355076268, 3977.4232736253225, 3980.8208630611693, 3995.740276882008, 4023.3361495353233, 4032.2540330039037, 4044.211378781139, 4044.858429954952, 4048.57489963554, 3963.9207215855668, 3993.98003009986, 4000.119973605802, 4000.519937607491, 4004.079061815784, 3836.5971572984854, 3936.9409458857854, 3944.0337117406134, 4023.8189281482405, 4051.0885050863612, 3575.106223444139, 3589.28214357127, 3590.6409359063887, 3599.2441587266703, 3606.062423769839, 5025.472325405816, 5025.773840177201, 5032.094223039851, 5035.043341765053, 5055.090083784918, 4640.211164102111, 4650.162970665279, 4651.069786042771, 4652.278896771006, 4655.09141252085, 5328.680279183222, 5447.237386765856, 5448.91826622601, 5449.863753406157, 5462.5083742462975, 3897.2010737798682, 3899.610038996106, 3901.141748815256, 3902.746321489094, 3904.6681032112306, 5720.0, 5732.455416735404, 5735.4551317624755, 5736.139579063132, 5739.8565035874435, 4017.5580686124504, 4017.9397309040387, 4018.799060046986, 4024.2555127301544, 4026.1947610478023, 3963.4451176835264, 4043.3732771420478, 4066.268071747055, 4075.714699971033, 4084.7753373564738, 4600.171969045537, 4603.355530225771, 4606.539346065367, 4614.630829533629, 4616.1229366420275, 5458.044842152607, 5460.863478412992, 5471.972640136853, 5476.17857321397, 5479.369872464717, 1419.3541938417995, 1436.2603259321459, 1436.6192958865909, 1437.1664434627892, 1438.5612388221484, 961.0677642686583, 972.4408465132577, 984.8325784616633, 991.0584944302797, 993.4734590666958, 4829.903401932012, 4832.879178020507, 4834.0, 4834.8791280218275, 4836.395450568679, 5668.433156684298, 5674.375818659944, 5678.801241956512, 5680.147977803363, 5683.0, 4829.9275510867365, 4830.4444988826735, 4836.685615434985, 4839.1531481991215, 4841.080194762983, 2857.8571071446345, 2934.6478422589, 3026.228311780526, 3032.696730326994, 3067.739242164441, 5390.326209223847, 5391.137418013099, 5396.4873337033705, 5399.83800485986, 5401.459854014645, 5837.620554663933, 5863.003289440805, 5872.530197584183, 5878.441548052928, 5881.5882888198275, 5372.435894231127, 5387.326584176978, 5390.892182156414, 5391.029614669397, 5398.136298192192, 5556.861078473071, 5720.542356611378, 5724.599278050663, 5732.656040637575, 5734.139879018181, 5579.246801681721, 5588.832335029955, 5594.188842617717, 5594.468525490072, 5601.29983752031, 5375.274337964324, 5378.4183591875335, 5388.865278368072, 5389.407165211745, 5392.7573259202645, 3958.6833053355085, 3964.464797252334, 3965.722399432012, 3969.6824254060184, 3969.9603003970747, 5496.422875598005, 5744.281964754406, 5752.6836024019085, 5760.596758226884, 5805.245318108618, 5549.306336707911, 5553.694546799965, 5557.944420555743, 5558.72206389687, 5564.276644036249, 5550.195221692751, 5553.6390134641115, 5556.111022236423, 5560.666360018412, 5567.3040869891265, 5316.122839731401, 5438.891222175614, 5442.836714898559, 5444.6188766785945, 5445.26488924006, 5572.108462645957, 5576.079946808731, 5577.553795696415, 5581.7767289309595, 5586.1062230043, 5136.152534831711, 5221.660592061504, 5326.680399176062, 5340.385855626652, 5355.303810504765], "unit": "score", "name": "prototype.html", "value": 4134.428978940098}, {"lowerIsBetter": false, "replicates": [689.9172099348079, 696.0533674203086, 737.4985010193067, 766.9118051424086, 786.5398741736086, 11575.479103440344, 11621.012213961823, 11627.6511704649, 11710.941445292783, 11766.352850593225, 10975.780484390307, 11029.0, 11035.117190624751, 11061.059809916167, 11064.17018723595, 585.5198737035632, 600.1717629671069, 758.5903612049486, 781.3709963479397, 783.1463704562026, 762.8092976755811, 766.1419210484265, 766.367746609047, 768.1703759939252, 768.4044865229436, 628.0171531553104, 635.0347471842796, 812.6911773526052, 813.2721214513007, 816.302061737215, 794.527256282511, 806.3186607316867, 809.8137428391474, 812.0539571399313, 812.3257696112242, 597.7967491053063, 603.3122240645667, 603.5141710922705, 603.8218725475995, 605.678990135229, 10176.440295783728, 10254.230932680079, 10260.076593106656, 10274.7431314217, 10281.280310378277, 11538.596149134824, 12149.392530373534, 12196.268223906594, 12472.75054498914, 12616.68458288541, 9422.434653920718, 9453.952730236373, 9547.427154370691, 9693.563789629414, 9922.553485093116, 3162.3517178978254, 3246.594175728034, 3261.2825178460703, 3261.2988207535495, 3320.767546271762, 41241.1751764966, 41522.0, 41535.7923210382, 41645.375319370236, 41742.37386439206, 8898.955505222433, 9221.631134754534, 9251.398659087137, 9294.117058879396, 9516.38143520669, 15595.220238988006, 15609.453669121527, 15636.0, 15650.37398504047, 15665.29506172225, 6564.4420224281475, 6670.566413183127, 6720.193576770819, 6730.0577919091365, 6808.353206445379, 3672.3022625701033, 3746.325661380923, 3766.7928263945746, 3778.6410291022307, 3782.5460944686265, 2699.5275826730244, 2743.0810678422554, 2745.5607102863446, 2747.079728291005, 2748.0, 496.14415133893743, 498.2675467063411, 506.29119233073993, 506.53398873036895, 506.78208370400347, 528.8175579425092, 530.3768072514857, 562.7073921560766, 588.4762561320429, 604.2477115990532, 7481.8877716834295, 7567.545947243183, 7614.2766437188375, 7660.923390766021, 7804.0, 443.62513675943774, 475.74547617024723, 506.67319578872156, 524.3759925688419, 528.8598521391834, 3533.6643018913164, 3628.1111127773866, 3989.900252493711, 4029.194161167778, 4116.176764647083, 43410.78294608507, 44520.0, 44777.55222447799, 44854.77572612116, 46261.0, 40507.1898562033, 41224.79387603043, 41372.1725565487, 41485.585144148776, 41489.377659335136, 35558.46662300068, 36461.63538364582, 36504.0, 36632.26735465329, 37153.07117322034, 8111.83776324482, 8143.470674406145, 8257.463264887763, 8325.167483251626, 8449.28181104613, 28242.717572824007, 28624.85687571549, 28652.14043578696, 29058.854705726335, 29108.272293191993, 35893.82053089822, 36017.27965440729, 36254.637453625124, 36758.63241367552, 36992.6300737, 10183.7454063649, 10255.641052563124, 10269.897301027193, 10299.7425064371, 10406.843897341394, 10961.461130996322, 11507.482163302504, 11589.362585057903, 11651.76696466049, 11897.762044758883, 10288.176945844465, 10389.792204155723, 10559.155267578422, 11069.225154239126, 11120.944395277971, 9781.902180978099, 10441.269111162146, 10741.624043158452, 10774.838377424188, 10888.836667450152, 8848.867266991128, 8857.689980850639, 8961.910380896368, 10532.420716860646, 11162.497687603915, 8350.665973361241, 8360.66557337724, 8370.288525475402, 8444.366672499464, 8530.957345213234, 9134.817303654023, 9139.680111196076, 9176.816463670822, 9277.350585458953, 9521.095495927875], "unit": "score", "name": "yui.html", "value": 5571.846611640192}], "name": "dromaeo_css", "value": 5992.4732057917045}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 117.0, 109.0, 114.0, 115.0, 115.0, 106.0, 113.0, 114.0, 114.0], "unit": "score", "name": "ai-astar", "value": 113.0}, {"lowerIsBetter": true, "replicates": [162.0, 136.0, 154.0, 164.0, 142.0, 159.0, 160.0, 140.0, 176.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 152.5}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 160.0, 162.0, 161.0, 160.0, 161.0, 163.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 95.0, 92.0, 72.0, 73.0, 72.0, 107.0, 91.0, 74.0], "unit": "score", "name": "audio-fft", "value": 81.9}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 132.0, 96.0, 97.0, 97.0, 138.0, 98.0, 96.0, 130.0], "unit": "score", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 109.0, 109.0, 111.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [149.0, 149.0, 149.0, 147.0, 147.0, 147.0, 148.0, 146.0, 149.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 66.0, 67.0, 66.0, 68.0, 75.0, 65.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 67.5}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.8}, {"lowerIsBetter": true, "replicates": [92.0, 86.0, 84.0, 84.0, 82.0, 82.0, 84.0, 84.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [128.0, 122.0, 119.0, 120.0, 119.0, 121.0, 121.0, 120.0, 120.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.1}, {"lowerIsBetter": true, "replicates": [150.0, 136.0, 135.0, 149.0, 148.0, 135.0, 147.0, 145.0, 148.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.8}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 72.0, 72.0, 73.0, 69.0, 71.0, 71.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.0}], "name": "kraken", "value": 1523.8999999999996}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [171.35023989033584], "unit": "score", "name": "Richards", "value": 206.02247199999996}, {"lowerIsBetter": false, "replicates": [189.07165815844206], "unit": "score", "name": "DeltaBlue", "value": 349.698102}, {"lowerIsBetter": false, "replicates": [279.6420581655481], "unit": "score", "name": "Encrypt", "value": 951.8632560000003}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [1974.3589743589744], "unit": "score", "name": "RayTrace", "value": 374.7996233766234}, {"lowerIsBetter": false, "replicates": [801.924619085806], "unit": "score", "name": "Earley", "value": 831.079361}, {"lowerIsBetter": false, "replicates": [12365.853658536585], "unit": "score", "name": "Boyer", "value": 53.89542998027611}, {"lowerIsBetter": false, "replicates": [44217.391304347824], "unit": "score", "name": "RegExp", "value": 20.602413962635193}, {"lowerIsBetter": false, "replicates": [595.7320687611144], "unit": "score", "name": "Splay", "value": 136.79136019900503}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 18771.488235619778}]} 04:45:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "18771.49"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1523.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "5992.47"}}} 04:45:46 INFO - Return code: 0 04:45:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:45:46 INFO - # TBPL SUCCESS # 04:45:46 INFO - Running post-action listener: _resource_record_post_action 04:45:46 INFO - Running post-run listener: _resource_record_post_run 04:45:47 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 543354880; Read time: 0; Write time: 508884 04:45:47 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 231153664; Read time: 0; Write time: 266584 04:45:47 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 311336960; Read time: 0; Write time: 242264 04:45:47 INFO - Running post-run listener: _upload_blobber_files 04:45:47 INFO - Blob upload gear active. 04:45:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:45:47 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 04:45:47 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'] 04:45:47 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 04:45:48 INFO - (blobuploader) - INFO - Open directory for files ... 04:45:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:45:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:45:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:45:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:45:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:45:49 INFO - (blobuploader) - INFO - Done attempting. 04:45:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:45:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:45:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:45:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:45:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:45:50 INFO - (blobuploader) - INFO - Done attempting. 04:45:50 INFO - (blobuploader) - INFO - Iteration through files over. 04:45:50 INFO - Return code: 0 04:45:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:45:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:45:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4191d310c49e48eef35ff207cb5ccf2322d201475db3f067dc46726cbaeb1f6f5cf2e021eb870a609db4ba7cc59366e95ee1eab5c18794f5ea02dfabaf45a800", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/936d97b66e50b2dae4f4932b8246534c8b379dbb834b9f2dc5efa1f941cc30901b58c434dfef61ef5b4deab7c641056f5b3a9bcf15a3b11e8b3df4d982d1847a"} 04:45:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:45:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:45:50 INFO - Contents: 04:45:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4191d310c49e48eef35ff207cb5ccf2322d201475db3f067dc46726cbaeb1f6f5cf2e021eb870a609db4ba7cc59366e95ee1eab5c18794f5ea02dfabaf45a800", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/936d97b66e50b2dae4f4932b8246534c8b379dbb834b9f2dc5efa1f941cc30901b58c434dfef61ef5b4deab7c641056f5b3a9bcf15a3b11e8b3df4d982d1847a"} 04:45:50 INFO - Copying logs to upload dir... 04:45:50 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1278.499654 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-13 04:45:49.725910) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 04:45:49.729969) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1452687695.80604-343224222 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/4191d310c49e48eef35ff207cb5ccf2322d201475db3f067dc46726cbaeb1f6f5cf2e021eb870a609db4ba7cc59366e95ee1eab5c18794f5ea02dfabaf45a800", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/936d97b66e50b2dae4f4932b8246534c8b379dbb834b9f2dc5efa1f941cc30901b58c434dfef61ef5b4deab7c641056f5b3a9bcf15a3b11e8b3df4d982d1847a"} build_url:https://queue.taskcluster.net/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011411 build_url: 'https://queue.taskcluster.net/v1/task/R7B95WoPSWSa1w0EpH2WcQ/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/4191d310c49e48eef35ff207cb5ccf2322d201475db3f067dc46726cbaeb1f6f5cf2e021eb870a609db4ba7cc59366e95ee1eab5c18794f5ea02dfabaf45a800", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/936d97b66e50b2dae4f4932b8246534c8b379dbb834b9f2dc5efa1f941cc30901b58c434dfef61ef5b4deab7c641056f5b3a9bcf15a3b11e8b3df4d982d1847a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 04:45:49.755011) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:45:49.755323) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1452687695.80604-343224222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:45:49.837406) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 04:45:49.837762) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 04:45:49.838052) ========= ========= Total master_lag: 0.23 =========