builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-050 starttime: 1451456664.78 results: success (0) buildid: 20151229214837 builduid: 977d3643e568423e87146a3593f9e966 revision: 804529fa0c027b32e26edf310eb9c7cd65de9aa1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 22:24:24.781522) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 22:24:24.782256) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 22:24:24.782743) ========= 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=d3f2be9b0713ec03b22325b2000001be-1451444517.521689-948692660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006414 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 22:24:24.837760) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 22:24:24.838112) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 22:24:24.892972) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:24:24.893261) ========= 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=d3f2be9b0713ec03b22325b2000001be-1451444517.521689-948692660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004650 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:24:24.952224) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 22:24:24.952508) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 22:24:24.952862) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:24:24.953158) ========= 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=d3f2be9b0713ec03b22325b2000001be-1451444517.521689-948692660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-29 22:24:26-- 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% 77.6M=0s 2015-12-29 22:24:26 (77.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171330 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:24:25.138933) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:24:25.139236) ========= 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=d3f2be9b0713ec03b22325b2000001be-1451444517.521689-948692660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015507 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:24:25.190460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:24:25.191060) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 804529fa0c027b32e26edf310eb9c7cd65de9aa1 --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 804529fa0c027b32e26edf310eb9c7cd65de9aa1 --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=d3f2be9b0713ec03b22325b2000001be-1451444517.521689-948692660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-29 22:24:26,489 truncating revision to first 12 chars 2015-12-29 22:24:26,489 Setting DEBUG logging. 2015-12-29 22:24:26,489 attempt 1/10 2015-12-29 22:24:26,489 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/804529fa0c02?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-29 22:24:26,963 unpacking tar archive at: fx-team-804529fa0c02/testing/mozharness/ program finished with exit code 0 elapsedTime=0.751390 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:24:25.955555) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 22:24:25.955858) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 22:24:25.965933) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 22:24:25.966277) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 22:24:25.966707) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2015-12-29 22:24:25.967003) ========= /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=d3f2be9b0713ec03b22325b2000001be-1451444517.521689-948692660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:24:27 INFO - MultiFileLogger online at 20151229 22:24:27 in /builds/slave/test 22:24:27 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 22:24:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:24:27 INFO - {'append_to_log': False, 22:24:27 INFO - 'base_work_dir': '/builds/slave/test', 22:24:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:24:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:24:27 INFO - 'branch': 'Fx-Team-Non-PGO', 22:24:27 INFO - 'buildbot_json_path': 'buildprops.json', 22:24:27 INFO - 'config_files': ('talos/linux_config.py',), 22:24:27 INFO - 'default_actions': ('clobber', 22:24:27 INFO - 'read-buildbot-config', 22:24:27 INFO - 'download-and-extract', 22:24:27 INFO - 'populate-webroot', 22:24:27 INFO - 'create-virtualenv', 22:24:27 INFO - 'install', 22:24:27 INFO - 'run-tests'), 22:24:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:24:27 INFO - 'download_minidump_stackwalk': True, 22:24:27 INFO - 'download_symbols': 'ondemand', 22:24:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:24:27 INFO - 'tooltool.py': '/tools/tooltool.py', 22:24:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:24:27 INFO - '/tools/misc-python/virtualenv.py')}, 22:24:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:24:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:24:27 INFO - 'installer_path': 'installer.exe', 22:24:27 INFO - 'log_level': 'info', 22:24:27 INFO - 'log_name': 'talos', 22:24:27 INFO - 'log_to_console': True, 22:24:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:24:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:24:27 INFO - 'opt_config_files': (), 22:24:27 INFO - 'pip_index': False, 22:24:27 INFO - 'sps_profile': False, 22:24:27 INFO - 'sps_profile_interval': 0, 22:24:27 INFO - 'suite': 'dromaeojs', 22:24:27 INFO - 'system_bits': '32', 22:24:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:24:27 INFO - 'title': 'talos-linux64-ix-050', 22:24:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:24:27 INFO - 'use_talos_json': True, 22:24:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:24:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:24:27 INFO - 'work_dir': 'build'} 22:24:27 INFO - ##### 22:24:27 INFO - ##### Running clobber step. 22:24:27 INFO - ##### 22:24:27 INFO - Running pre-action listener: _resource_record_pre_action 22:24:27 INFO - Running main action method: clobber 22:24:27 INFO - rmtree: /builds/slave/test/build 22:24:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:24:28 INFO - Running post-action listener: _resource_record_post_action 22:24:28 INFO - ##### 22:24:28 INFO - ##### Running read-buildbot-config step. 22:24:28 INFO - ##### 22:24:28 INFO - Running pre-action listener: _resource_record_pre_action 22:24:28 INFO - Running main action method: read_buildbot_config 22:24:28 INFO - Using buildbot properties: 22:24:28 INFO - { 22:24:28 INFO - "project": "", 22:24:28 INFO - "product": "firefox", 22:24:28 INFO - "script_repo_revision": "production", 22:24:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:24:28 INFO - "repository": "", 22:24:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 22:24:28 INFO - "buildid": "20151229214837", 22:24:28 INFO - "pgo_build": "False", 22:24:28 INFO - "basedir": "/builds/slave/test", 22:24:28 INFO - "buildnumber": 2266, 22:24:28 INFO - "slavename": "talos-linux64-ix-050", 22:24:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:24:28 INFO - "platform": "ubuntu64_hw", 22:24:28 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:24:28 INFO - "branch": "fx-team", 22:24:28 INFO - "repo_path": "integration/fx-team", 22:24:28 INFO - "revision": "804529fa0c027b32e26edf310eb9c7cd65de9aa1", 22:24:28 INFO - "stage_platform": "linux64", 22:24:28 INFO - "builduid": "977d3643e568423e87146a3593f9e966", 22:24:28 INFO - "slavebuilddir": "test" 22:24:28 INFO - } 22:24:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/kF9lWKrhQjSIYmWqxh1jZA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:24:28 INFO - Running post-action listener: _resource_record_post_action 22:24:28 INFO - ##### 22:24:28 INFO - ##### Running download-and-extract step. 22:24:28 INFO - ##### 22:24:28 INFO - Running pre-action listener: _resource_record_pre_action 22:24:28 INFO - Running main action method: download_and_extract 22:24:28 INFO - mkdir: /builds/slave/test/build/tests 22:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:28 INFO - https://queue.taskcluster.net/v1/task/kF9lWKrhQjSIYmWqxh1jZA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:24:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kF9lWKrhQjSIYmWqxh1jZA/artifacts/public/build/test_packages.json 22:24:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kF9lWKrhQjSIYmWqxh1jZA/artifacts/public/build/test_packages.json 22:24:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kF9lWKrhQjSIYmWqxh1jZA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:24:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kF9lWKrhQjSIYmWqxh1jZA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:24:28 INFO - Downloaded 1302 bytes. 22:24:28 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:24:28 INFO - Using the following test package requirements: 22:24:28 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:24:28 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:24:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:24:28 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:24:28 INFO - u'jsshell-linux-x86_64.zip'], 22:24:28 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:24:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:24:28 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:24:28 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:24:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:24:28 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:24:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:24:28 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:24:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:24:28 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:24:28 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:24:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:24:28 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:28 INFO - https://queue.taskcluster.net/v1/task/kF9lWKrhQjSIYmWqxh1jZA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:24:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kF9lWKrhQjSIYmWqxh1jZA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:24:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kF9lWKrhQjSIYmWqxh1jZA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:24:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kF9lWKrhQjSIYmWqxh1jZA/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 22:24:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kF9lWKrhQjSIYmWqxh1jZA/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 22:24:31 INFO - Downloaded 21943114 bytes. 22:24:31 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 22:24:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:24:31 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 22:24:32 INFO - Return code: 0 22:24:32 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 22: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')]} 22:24:32 INFO - https://queue.taskcluster.net/v1/task/kF9lWKrhQjSIYmWqxh1jZA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:24:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kF9lWKrhQjSIYmWqxh1jZA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:24:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kF9lWKrhQjSIYmWqxh1jZA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:24:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kF9lWKrhQjSIYmWqxh1jZA/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 22:24:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kF9lWKrhQjSIYmWqxh1jZA/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 22:24:47 INFO - Downloaded 21943114 bytes. 22:24:47 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 22:24:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:24:47 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 22:24:48 INFO - Return code: 0 22:24:48 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')]} 22:24:48 INFO - https://queue.taskcluster.net/v1/task/kF9lWKrhQjSIYmWqxh1jZA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:24:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kF9lWKrhQjSIYmWqxh1jZA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:24:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kF9lWKrhQjSIYmWqxh1jZA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:24:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kF9lWKrhQjSIYmWqxh1jZA/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 22:24:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kF9lWKrhQjSIYmWqxh1jZA/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 22:24:49 INFO - Downloaded 11132270 bytes. 22:24:49 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 22:24:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:24:49 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 22:24:49 INFO - Return code: 0 22:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:49 INFO - https://queue.taskcluster.net/v1/task/kF9lWKrhQjSIYmWqxh1jZA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:24:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kF9lWKrhQjSIYmWqxh1jZA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:24:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kF9lWKrhQjSIYmWqxh1jZA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:24:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kF9lWKrhQjSIYmWqxh1jZA/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 22:24:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kF9lWKrhQjSIYmWqxh1jZA/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 22:24:52 INFO - Downloaded 53321829 bytes. 22:24:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/kF9lWKrhQjSIYmWqxh1jZA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:24:52 INFO - mkdir: /builds/slave/test/properties 22:24:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:24:52 INFO - Writing to file /builds/slave/test/properties/build_url 22:24:52 INFO - Contents: 22:24:52 INFO - build_url:https://queue.taskcluster.net/v1/task/kF9lWKrhQjSIYmWqxh1jZA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:24:52 INFO - Running post-action listener: _resource_record_post_action 22:24:52 INFO - Running post-action listener: set_extra_try_arguments 22:24:52 INFO - ##### 22:24:52 INFO - ##### Running populate-webroot step. 22:24:52 INFO - ##### 22:24:52 INFO - Running pre-action listener: _resource_record_pre_action 22:24:52 INFO - Running main action method: populate_webroot 22:24:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:24:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:24:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:24:52 INFO - '--tppagecycles', 22:24:52 INFO - '7'], 22:24:52 INFO - 'tests': ['tsvgm']}}, 22:24:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:24:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:24:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:24:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:24:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:24:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:24:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:24:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:52 INFO - 'talos_options': ['--e10s'], 22:24:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:24:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:52 INFO - 'tests': ['damp', 'tps']}, 22:24:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:52 INFO - 'talos_options': ['--e10s'], 22:24:52 INFO - 'tests': ['damp', 'tps']}, 22:24:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:24:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:24:52 INFO - 'other': {'tests': ['a11yr', 22:24:52 INFO - 'ts_paint', 22:24:52 INFO - 'tpaint', 22:24:52 INFO - 'sessionrestore', 22:24:52 INFO - 'sessionrestore_no_auto_restore']}, 22:24:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:24:52 INFO - 'tests': ['a11yr', 22:24:52 INFO - 'ts_paint', 22:24:52 INFO - 'tpaint', 22:24:52 INFO - 'sessionrestore', 22:24:52 INFO - 'sessionrestore_no_auto_restore']}, 22:24:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:24:52 INFO - 'tests': ['a11yr', 22:24:52 INFO - 'ts_paint', 22:24:52 INFO - 'tpaint', 22:24:52 INFO - 'sessionrestore', 22:24:52 INFO - 'sessionrestore_no_auto_restore']}, 22:24:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:24:52 INFO - 'tests': ['a11yr', 22:24:52 INFO - 'ts_paint', 22:24:52 INFO - 'tpaint', 22:24:52 INFO - 'sessionrestore', 22:24:52 INFO - 'sessionrestore_no_auto_restore']}, 22:24:52 INFO - 'other_l64': {'tests': ['a11yr', 22:24:52 INFO - 'ts_paint', 22:24:52 INFO - 'tpaint', 22:24:52 INFO - 'sessionrestore', 22:24:52 INFO - 'sessionrestore_no_auto_restore']}, 22:24:52 INFO - 'other_nol64': {'tests': ['a11yr', 22:24:52 INFO - 'ts_paint', 22:24:52 INFO - 'tpaint', 22:24:52 INFO - 'sessionrestore', 22:24:52 INFO - 'sessionrestore_no_auto_restore']}, 22:24:52 INFO - 'svgr': {'tests': ['tsvgx', 22:24:52 INFO - 'tsvgr_opacity', 22:24:52 INFO - 'tart', 22:24:52 INFO - 'tscrollx', 22:24:52 INFO - 'cart']}, 22:24:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:24:52 INFO - 'tests': ['tsvgx', 22:24:52 INFO - 'tsvgr_opacity', 22:24:52 INFO - 'tart', 22:24:52 INFO - 'tscrollx', 22:24:52 INFO - 'cart']}, 22:24:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:52 INFO - 'tests': ['tp5o']}, 22:24:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:52 INFO - 'talos_options': ['--e10s'], 22:24:52 INFO - 'tests': ['tp5o']}, 22:24:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:52 INFO - 'talos_options': ['--xperf_path', 22:24:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:24:52 INFO - 'tests': ['tp5n']}, 22:24:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:52 INFO - 'talos_options': ['--e10s', 22:24:52 INFO - '--xperf_path', 22:24:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:24:52 INFO - 'tests': ['tp5n']}}, 22:24:52 INFO - 'talos.zip': {'path': '', 22:24:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:24:52 INFO - Running post-action listener: _resource_record_post_action 22:24:52 INFO - ##### 22:24:52 INFO - ##### Running create-virtualenv step. 22:24:52 INFO - ##### 22:24:52 INFO - Running pre-action listener: _resource_record_pre_action 22:24:52 INFO - Running main action method: create_virtualenv 22:24:52 INFO - Creating virtualenv /builds/slave/test/build/venv 22:24:52 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 22:24:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:24:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:24:52 INFO - Using real prefix '/usr' 22:24:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:24:52 INFO - Installing distribute.............................................................................................................................................................................................done. 22:24:54 INFO - Installing pip.................done. 22:24:54 INFO - Return code: 0 22:24:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22: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')]} 22:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22: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')]} 22:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdd6a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18103d0>, '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 0x177bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177c360>, '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': 'd3f2be9b0713ec03b22325b2000001be-1451444517.521689-948692660', '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 22: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', 'pip>=1.5'] in /builds/slave/test/build 22: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 pip>=1.5 22:24:54 INFO - Using env: {'DISPLAY': ':0', 22:24:54 INFO - 'HOME': '/home/cltbld', 22:24:54 INFO - 'LANG': 'en_US.UTF-8', 22:24:54 INFO - 'LANGUAGE': 'en_US:en', 22:24:54 INFO - 'LOGNAME': 'cltbld', 22:24:54 INFO - 'MAIL': '/var/mail/cltbld', 22:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:54 INFO - 'MOZ_NO_REMOTE': '1', 22:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:54 INFO - 'NO_EM_RESTART': '1', 22:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:54 INFO - 'PWD': '/builds/slave/test', 22:24:54 INFO - 'SHELL': '/bin/bash', 22:24:54 INFO - 'SHLVL': '1', 22:24:54 INFO - 'TERM': 'linux', 22:24:54 INFO - 'TMOUT': '86400', 22:24:54 INFO - 'USER': 'cltbld', 22:24:54 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1451444517.521689-948692660', 22:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:54 INFO - '_': '/tools/buildbot/bin/python'} 22:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:54 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 22:24:54 INFO - Cleaning up... 22:24:54 INFO - Return code: 0 22:24:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22: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')]} 22:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22: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')]} 22:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22: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', '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 0x7fcdd6a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18103d0>, '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 0x177bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177c360>, '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': 'd3f2be9b0713ec03b22325b2000001be-1451444517.521689-948692660', '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 22: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', 'psutil>=0.7.1'] in /builds/slave/test/build 22: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 psutil>=0.7.1 22:24:54 INFO - Using env: {'DISPLAY': ':0', 22:24:54 INFO - 'HOME': '/home/cltbld', 22:24:54 INFO - 'LANG': 'en_US.UTF-8', 22:24:54 INFO - 'LANGUAGE': 'en_US:en', 22:24:54 INFO - 'LOGNAME': 'cltbld', 22:24:54 INFO - 'MAIL': '/var/mail/cltbld', 22:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:54 INFO - 'MOZ_NO_REMOTE': '1', 22:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:54 INFO - 'NO_EM_RESTART': '1', 22:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:54 INFO - 'PWD': '/builds/slave/test', 22:24:54 INFO - 'SHELL': '/bin/bash', 22:24:54 INFO - 'SHLVL': '1', 22:24:54 INFO - 'TERM': 'linux', 22:24:54 INFO - 'TMOUT': '86400', 22:24:54 INFO - 'USER': 'cltbld', 22:24:54 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1451444517.521689-948692660', 22:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:54 INFO - '_': '/tools/buildbot/bin/python'} 22:24:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:55 INFO - Downloading/unpacking psutil>=0.7.1 22:24:55 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 22:24:55 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 22:24:55 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 22:24:55 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 22:24:55 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 22:24:55 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 22:24:56 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:24:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:24:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:24:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:24:57 INFO - Installing collected packages: psutil 22:24:57 INFO - Running setup.py install for psutil 22:24:57 INFO - building 'psutil._psutil_linux' extension 22:24:57 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 22:24:57 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 22:24:57 INFO - building 'psutil._psutil_posix' extension 22:24:57 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 22:24:57 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 22:24:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:24:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:24:57 INFO - Successfully installed psutil 22:24:57 INFO - Cleaning up... 22:24:57 INFO - Return code: 0 22:24:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:24:57 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')]} 22:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:57 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')]} 22:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:57 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 0x7fcdd6a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18103d0>, '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 0x177bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177c360>, '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': 'd3f2be9b0713ec03b22325b2000001be-1451444517.521689-948692660', '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 22:24:57 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 22:24:57 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 22:24:57 INFO - Using env: {'DISPLAY': ':0', 22:24:57 INFO - 'HOME': '/home/cltbld', 22:24:57 INFO - 'LANG': 'en_US.UTF-8', 22:24:57 INFO - 'LANGUAGE': 'en_US:en', 22:24:57 INFO - 'LOGNAME': 'cltbld', 22:24:57 INFO - 'MAIL': '/var/mail/cltbld', 22:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:57 INFO - 'MOZ_NO_REMOTE': '1', 22:24:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:57 INFO - 'NO_EM_RESTART': '1', 22:24:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:57 INFO - 'PWD': '/builds/slave/test', 22:24:57 INFO - 'SHELL': '/bin/bash', 22:24:57 INFO - 'SHLVL': '1', 22:24:57 INFO - 'TERM': 'linux', 22:24:57 INFO - 'TMOUT': '86400', 22:24:57 INFO - 'USER': 'cltbld', 22:24:57 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1451444517.521689-948692660', 22:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:57 INFO - '_': '/tools/buildbot/bin/python'} 22:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:24:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:24:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:24:59 INFO - Installing collected packages: mozsystemmonitor 22:24:59 INFO - Running setup.py install for mozsystemmonitor 22:24:59 INFO - Successfully installed mozsystemmonitor 22:24:59 INFO - Cleaning up... 22:24:59 INFO - Return code: 0 22:24:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22: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')]} 22:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22: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')]} 22:24:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcdd6a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18103d0>, '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 0x177bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177c360>, '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': 'd3f2be9b0713ec03b22325b2000001be-1451444517.521689-948692660', '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 22:24:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:24:59 INFO - Using env: {'DISPLAY': ':0', 22:24:59 INFO - 'HOME': '/home/cltbld', 22:24:59 INFO - 'LANG': 'en_US.UTF-8', 22:24:59 INFO - 'LANGUAGE': 'en_US:en', 22:24:59 INFO - 'LOGNAME': 'cltbld', 22:24:59 INFO - 'MAIL': '/var/mail/cltbld', 22:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:59 INFO - 'MOZ_NO_REMOTE': '1', 22:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:59 INFO - 'NO_EM_RESTART': '1', 22:24:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:59 INFO - 'PWD': '/builds/slave/test', 22:24:59 INFO - 'SHELL': '/bin/bash', 22:24:59 INFO - 'SHLVL': '1', 22:24:59 INFO - 'TERM': 'linux', 22:24:59 INFO - 'TMOUT': '86400', 22:24:59 INFO - 'USER': 'cltbld', 22:24:59 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1451444517.521689-948692660', 22:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:59 INFO - '_': '/tools/buildbot/bin/python'} 22:24:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:59 INFO - Downloading/unpacking blobuploader==1.2.4 22:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:25:01 INFO - Downloading blobuploader-1.2.4.tar.gz 22:25:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:25:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:25:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:25:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:25:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:25:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:25:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:25:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:25:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:25:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:25:02 INFO - Downloading docopt-0.6.1.tar.gz 22:25:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:25:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:25:02 INFO - Installing collected packages: blobuploader, requests, docopt 22:25:02 INFO - Running setup.py install for blobuploader 22:25:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:25:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:25:02 INFO - Running setup.py install for requests 22:25:02 INFO - Running setup.py install for docopt 22:25:02 INFO - Successfully installed blobuploader requests docopt 22:25:02 INFO - Cleaning up... 22:25:02 INFO - Return code: 0 22:25:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22: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')]} 22:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22: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')]} 22:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:02 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 0x7fcdd6a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18103d0>, '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 0x177bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177c360>, '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': 'd3f2be9b0713ec03b22325b2000001be-1451444517.521689-948692660', '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 22:25:02 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 22:25:02 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 22:25:02 INFO - Using env: {'DISPLAY': ':0', 22:25:02 INFO - 'HOME': '/home/cltbld', 22:25:02 INFO - 'LANG': 'en_US.UTF-8', 22:25:02 INFO - 'LANGUAGE': 'en_US:en', 22:25:02 INFO - 'LOGNAME': 'cltbld', 22:25:02 INFO - 'MAIL': '/var/mail/cltbld', 22:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:25:02 INFO - 'MOZ_NO_REMOTE': '1', 22:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:25:02 INFO - 'NO_EM_RESTART': '1', 22:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:25:02 INFO - 'PWD': '/builds/slave/test', 22:25:02 INFO - 'SHELL': '/bin/bash', 22:25:02 INFO - 'SHLVL': '1', 22:25:02 INFO - 'TERM': 'linux', 22:25:02 INFO - 'TMOUT': '86400', 22:25:02 INFO - 'USER': 'cltbld', 22:25:02 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1451444517.521689-948692660', 22:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:25:02 INFO - '_': '/tools/buildbot/bin/python'} 22:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:25:03 INFO - Running setup.py (path:/tmp/pip-68hyVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:25:03 INFO - Running setup.py (path:/tmp/pip-9kznkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:25:03 INFO - Running setup.py (path:/tmp/pip-JC_Bp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:25:03 INFO - Running setup.py (path:/tmp/pip-C0I7ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:25:03 INFO - Running setup.py (path:/tmp/pip-kMe99P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:25:03 INFO - Running setup.py (path:/tmp/pip-wT_AXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:25:03 INFO - Running setup.py (path:/tmp/pip-IFBRHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:25:03 INFO - Running setup.py (path:/tmp/pip-FhTzrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:25:03 INFO - Running setup.py (path:/tmp/pip-T1m8r_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:25:03 INFO - Running setup.py (path:/tmp/pip-vvNqc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:25:03 INFO - Running setup.py (path:/tmp/pip-e_ArgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:25:03 INFO - Running setup.py (path:/tmp/pip-SA2k_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:25:03 INFO - Running setup.py (path:/tmp/pip-ulbeFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:25:04 INFO - Running setup.py (path:/tmp/pip-s3gpAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:25:04 INFO - Running setup.py (path:/tmp/pip-iTNxmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:25:04 INFO - Running setup.py (path:/tmp/pip-dhS9ok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:25:04 INFO - Running setup.py (path:/tmp/pip-IAnShu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:25:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:25:04 INFO - Running setup.py install for manifestparser 22:25:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:25:04 INFO - Running setup.py install for mozcrash 22:25:04 INFO - Running setup.py install for mozdebug 22:25:04 INFO - Running setup.py install for mozdevice 22:25:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:25:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:25:04 INFO - Running setup.py install for mozfile 22:25:04 INFO - Running setup.py install for mozhttpd 22:25:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:25:04 INFO - Running setup.py install for mozinfo 22:25:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:25:05 INFO - Running setup.py install for mozInstall 22:25:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:25:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:25:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:25:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:25:05 INFO - Running setup.py install for mozleak 22:25:05 INFO - Running setup.py install for mozlog 22:25:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:25:05 INFO - Running setup.py install for moznetwork 22:25:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:25:05 INFO - Running setup.py install for mozprocess 22:25:05 INFO - Running setup.py install for mozprofile 22:25:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:25:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:25:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:25:05 INFO - Running setup.py install for mozrunner 22:25:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:25:05 INFO - Running setup.py install for mozscreenshot 22:25:05 INFO - Running setup.py install for moztest 22:25:05 INFO - Running setup.py install for mozversion 22:25:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:25:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:25:06 INFO - Cleaning up... 22:25:06 INFO - Return code: 0 22:25:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22: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')]} 22:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:25:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22: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')]} 22:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:25:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22: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/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 0x7fcdd6a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18103d0>, '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 0x177bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177c360>, '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': 'd3f2be9b0713ec03b22325b2000001be-1451444517.521689-948692660', '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 22: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/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 22: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/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 22:25:06 INFO - Using env: {'DISPLAY': ':0', 22:25:06 INFO - 'HOME': '/home/cltbld', 22:25:06 INFO - 'LANG': 'en_US.UTF-8', 22:25:06 INFO - 'LANGUAGE': 'en_US:en', 22:25:06 INFO - 'LOGNAME': 'cltbld', 22:25:06 INFO - 'MAIL': '/var/mail/cltbld', 22:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:25:06 INFO - 'MOZ_NO_REMOTE': '1', 22:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:25:06 INFO - 'NO_EM_RESTART': '1', 22:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:25:06 INFO - 'PWD': '/builds/slave/test', 22:25:06 INFO - 'SHELL': '/bin/bash', 22:25:06 INFO - 'SHLVL': '1', 22:25:06 INFO - 'TERM': 'linux', 22:25:06 INFO - 'TMOUT': '86400', 22:25:06 INFO - 'USER': 'cltbld', 22:25:06 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1451444517.521689-948692660', 22:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:25:06 INFO - '_': '/tools/buildbot/bin/python'} 22:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:25:06 INFO - Running setup.py (path:/tmp/pip-wTpAl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:25:06 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)) 22:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:25:06 INFO - Running setup.py (path:/tmp/pip-5DHcZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:25:06 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)) 22:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:25:06 INFO - Running setup.py (path:/tmp/pip-0ZsWgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:25:06 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)) 22:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:25:06 INFO - Running setup.py (path:/tmp/pip-c9G7ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:25:06 INFO - Running setup.py (path:/tmp/pip-KQndYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:25:06 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)) 22:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:25:06 INFO - Running setup.py (path:/tmp/pip-ARgAWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:25:06 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)) 22:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:25:06 INFO - Running setup.py (path:/tmp/pip-e20Rad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:25:06 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)) 22:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:25:06 INFO - Running setup.py (path:/tmp/pip-IkfOTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:25:06 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)) 22:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:25:06 INFO - Running setup.py (path:/tmp/pip-Z8FCwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:25:06 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)) 22:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:25:06 INFO - Running setup.py (path:/tmp/pip-cvy_Uw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:25:07 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)) 22:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:25:07 INFO - Running setup.py (path:/tmp/pip-Z5X_0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:25:07 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)) 22:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:25:07 INFO - Running setup.py (path:/tmp/pip-ARmSgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:25:07 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)) 22:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:25:07 INFO - Running setup.py (path:/tmp/pip-3UWQmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:25:07 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)) 22:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:25:07 INFO - Running setup.py (path:/tmp/pip-YVKrzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:25:07 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)) 22:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:25:07 INFO - Running setup.py (path:/tmp/pip-TV22mt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:25:07 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)) 22:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:25:07 INFO - Running setup.py (path:/tmp/pip-V4s7fc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:25:07 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)) 22:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:25:07 INFO - Running setup.py (path:/tmp/pip-O6i1Nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:25:07 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)) 22:25:07 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)) 22:25:07 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)) 22:25:07 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)) 22:25:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:25:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:25:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:25:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:25:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:25:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:25:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:25:09 INFO - Downloading blessings-1.5.1.tar.gz 22:25:09 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 22:25:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:25:09 INFO - Installing collected packages: blessings 22:25:09 INFO - Running setup.py install for blessings 22:25:09 INFO - Successfully installed blessings 22:25:09 INFO - Cleaning up... 22:25:09 INFO - Return code: 0 22:25:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:25:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:25:09 INFO - Reading from file tmpfile_stdout 22:25:09 INFO - Current package versions: 22:25:09 INFO - argparse == 1.2.1 22:25:09 INFO - blessings == 1.5.1 22:25:09 INFO - blobuploader == 1.2.4 22:25:09 INFO - docopt == 0.6.1 22:25:09 INFO - manifestparser == 1.1 22:25:09 INFO - mozInstall == 1.12 22:25:09 INFO - mozcrash == 0.16 22:25:09 INFO - mozdebug == 0.1 22:25:09 INFO - mozdevice == 0.47 22:25:09 INFO - mozfile == 1.2 22:25:09 INFO - mozhttpd == 0.7 22:25:09 INFO - mozinfo == 0.9 22:25:09 INFO - mozleak == 0.1 22:25:09 INFO - mozlog == 3.1 22:25:09 INFO - moznetwork == 0.27 22:25:09 INFO - mozprocess == 0.22 22:25:09 INFO - mozprofile == 0.28 22:25:09 INFO - mozrunner == 6.11 22:25:09 INFO - mozscreenshot == 0.1 22:25:09 INFO - mozsystemmonitor == 0.0 22:25:09 INFO - moztest == 0.7 22:25:09 INFO - mozversion == 1.4 22:25:09 INFO - psutil == 3.1.1 22:25:09 INFO - requests == 1.2.3 22:25:09 INFO - wsgiref == 0.1.2 22:25:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:25:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:25:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fcdd6a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18103d0>, '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 0x177bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177c360>, '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': 'd3f2be9b0713ec03b22325b2000001be-1451444517.521689-948692660', '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 22:25:09 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 22:25:09 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 22:25:09 INFO - Using env: {'DISPLAY': ':0', 22:25:09 INFO - 'HOME': '/home/cltbld', 22:25:09 INFO - 'LANG': 'en_US.UTF-8', 22:25:09 INFO - 'LANGUAGE': 'en_US:en', 22:25:09 INFO - 'LOGNAME': 'cltbld', 22:25:09 INFO - 'MAIL': '/var/mail/cltbld', 22:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:25:09 INFO - 'MOZ_NO_REMOTE': '1', 22:25:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:25:09 INFO - 'NO_EM_RESTART': '1', 22:25:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:25:09 INFO - 'PWD': '/builds/slave/test', 22:25:09 INFO - 'SHELL': '/bin/bash', 22:25:09 INFO - 'SHLVL': '1', 22:25:09 INFO - 'TERM': 'linux', 22:25:09 INFO - 'TMOUT': '86400', 22:25:09 INFO - 'USER': 'cltbld', 22:25:09 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1451444517.521689-948692660', 22:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:25:09 INFO - '_': '/tools/buildbot/bin/python'} 22:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:25:09 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)) 22:25:09 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)) 22:25:09 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)) 22:25:09 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)) 22:25:09 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)) 22:25:09 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)) 22:25:09 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)) 22:25:09 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)) 22:25:09 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)) 22:25:09 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)) 22:25:09 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)) 22:25:09 INFO - Cleaning up... 22:25:09 INFO - Return code: 0 22:25:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:25:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:25:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcdd6a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18103d0>, '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 0x177bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177c360>, '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': 'd3f2be9b0713ec03b22325b2000001be-1451444517.521689-948692660', '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 22:25:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:25:09 INFO - Using env: {'DISPLAY': ':0', 22:25:09 INFO - 'HOME': '/home/cltbld', 22:25:09 INFO - 'LANG': 'en_US.UTF-8', 22:25:09 INFO - 'LANGUAGE': 'en_US:en', 22:25:09 INFO - 'LOGNAME': 'cltbld', 22:25:09 INFO - 'MAIL': '/var/mail/cltbld', 22:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:25:09 INFO - 'MOZ_NO_REMOTE': '1', 22:25:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:25:09 INFO - 'NO_EM_RESTART': '1', 22:25:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:25:09 INFO - 'PWD': '/builds/slave/test', 22:25:09 INFO - 'SHELL': '/bin/bash', 22:25:09 INFO - 'SHLVL': '1', 22:25:09 INFO - 'TERM': 'linux', 22:25:09 INFO - 'TMOUT': '86400', 22:25:09 INFO - 'USER': 'cltbld', 22:25:09 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1451444517.521689-948692660', 22:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:25:09 INFO - '_': '/tools/buildbot/bin/python'} 22:25:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:25:10 INFO - Downloading/unpacking jsonschema 22: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 22: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 22: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 22: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 22: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 22: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 22:25:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:25:11 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 22:25:11 INFO - Downloading/unpacking functools32 (from jsonschema) 22: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 22: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 22: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 22: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 22: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 22: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 22:25:11 INFO - Downloading functools32-3.2.3-2.tar.gz 22:25:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:25:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:25:12 INFO - warning: no files found matching '*.txt' 22:25:12 INFO - no previously-included directories found matching 'build' 22:25:12 INFO - no previously-included directories found matching 'dist' 22:25:12 INFO - no previously-included directories found matching '.git*' 22:25:12 INFO - Installing collected packages: jsonschema, functools32 22:25:12 INFO - Running setup.py install for functools32 22:25:12 INFO - warning: no files found matching '*.txt' 22:25:12 INFO - no previously-included directories found matching 'build' 22:25:12 INFO - no previously-included directories found matching 'dist' 22:25:12 INFO - no previously-included directories found matching '.git*' 22:25:12 INFO - Successfully installed jsonschema functools32 22:25:12 INFO - Cleaning up... 22:25:12 INFO - Return code: 0 22:25:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:25:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:25:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:12 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 0x7fcdd6a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18103d0>, '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 0x177bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177c360>, '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': 'd3f2be9b0713ec03b22325b2000001be-1451444517.521689-948692660', '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 22:25:12 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 22:25:12 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 22:25:12 INFO - Using env: {'DISPLAY': ':0', 22:25:12 INFO - 'HOME': '/home/cltbld', 22:25:12 INFO - 'LANG': 'en_US.UTF-8', 22:25:12 INFO - 'LANGUAGE': 'en_US:en', 22:25:12 INFO - 'LOGNAME': 'cltbld', 22:25:12 INFO - 'MAIL': '/var/mail/cltbld', 22:25:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:25:12 INFO - 'MOZ_NO_REMOTE': '1', 22:25:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:25:12 INFO - 'NO_EM_RESTART': '1', 22:25:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:25:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:25:12 INFO - 'PWD': '/builds/slave/test', 22:25:12 INFO - 'SHELL': '/bin/bash', 22:25:12 INFO - 'SHLVL': '1', 22:25:12 INFO - 'TERM': 'linux', 22:25:12 INFO - 'TMOUT': '86400', 22:25:12 INFO - 'USER': 'cltbld', 22:25:12 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1451444517.521689-948692660', 22:25:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:25:12 INFO - '_': '/tools/buildbot/bin/python'} 22:25:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:25:12 INFO - Downloading/unpacking flake8 22:25:12 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 22:25:12 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 22:25:12 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 22:25:12 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 22:25:12 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 22:25:12 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 22:25:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:25:14 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 22:25:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:25:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:25:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:25:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:25:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:25:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:25:14 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 22:25:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:25:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:25:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:25:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:25:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:25:14 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 22:25:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:25:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:25:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:25:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:25:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:25:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:25:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:25:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:25:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:25:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:25:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:25:14 INFO - no previously-included directories found matching 'docs/_build' 22:25:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:25:14 INFO - Running setup.py install for pep8 22:25:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:25:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:25:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:25:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:25:14 INFO - no previously-included directories found matching 'docs/_build' 22:25:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:25:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:25:14 INFO - Cleaning up... 22:25:15 INFO - Return code: 0 22:25:15 INFO - Running post-action listener: _resource_record_post_action 22:25:15 INFO - Running post-action listener: _start_resource_monitoring 22:25:15 INFO - Starting resource monitoring. 22:25:15 INFO - ##### 22:25:15 INFO - ##### Running install step. 22:25:15 INFO - ##### 22:25:15 INFO - Running pre-action listener: _resource_record_pre_action 22:25:15 INFO - Running main action method: install 22:25:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:25:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:25:15 INFO - Reading from file tmpfile_stdout 22:25:15 INFO - Detecting whether we're running mozinstall >=1.0... 22:25:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:25:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:25:15 INFO - Reading from file tmpfile_stdout 22:25:15 INFO - Output received: 22:25:15 INFO - Usage: mozinstall [options] installer 22:25:15 INFO - Options: 22:25:15 INFO - -h, --help show this help message and exit 22:25:15 INFO - -d DEST, --destination=DEST 22:25:15 INFO - Directory to install application into. [default: 22:25:15 INFO - "/builds/slave/test"] 22:25:15 INFO - --app=APP Application being installed. [default: firefox] 22:25:15 INFO - mkdir: /builds/slave/test/build/application 22:25:15 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'] 22:25:15 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 22:25:30 INFO - Reading from file tmpfile_stdout 22:25:30 INFO - Output received: 22:25:30 INFO - /builds/slave/test/build/application/firefox/firefox 22:25:30 INFO - Running post-action listener: _resource_record_post_action 22:25:30 INFO - ##### 22:25:30 INFO - ##### Running run-tests step. 22:25:30 INFO - ##### 22:25:30 INFO - Running pre-action listener: _resource_record_pre_action 22:25:30 INFO - Running main action method: run_tests 22:25:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:25:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:25:30 INFO - Python 2.7.3 22:25:30 INFO - Return code: 0 22:25:30 INFO - grabbing minidump binary from tooltool 22:25:30 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')]} 22:25:30 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 0x18103d0>, '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 0x177bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177c360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:25:30 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 22:25:30 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 22:25:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:25:30 INFO - Return code: 0 22:25:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:25:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:25:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:25:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:25:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:25:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:25:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:25:31 INFO - Return code: 0 22:25:31 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/kF9lWKrhQjSIYmWqxh1jZA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 22:25:31 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/kF9lWKrhQjSIYmWqxh1jZA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 22:25:31 INFO - Using env: {'DISPLAY': ':0', 22:25:31 INFO - 'HOME': '/home/cltbld', 22:25:31 INFO - 'LANG': 'en_US.UTF-8', 22:25:31 INFO - 'LANGUAGE': 'en_US:en', 22:25:31 INFO - 'LOGNAME': 'cltbld', 22:25:31 INFO - 'MAIL': '/var/mail/cltbld', 22:25:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:25:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:25:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:25:31 INFO - 'MOZ_NO_REMOTE': '1', 22:25:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:25:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:25:31 INFO - 'NO_EM_RESTART': '1', 22:25:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:25:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:25:31 INFO - 'PWD': '/builds/slave/test', 22:25:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:25:31 INFO - 'SHELL': '/bin/bash', 22:25:31 INFO - 'SHLVL': '1', 22:25:31 INFO - 'TERM': 'linux', 22:25:31 INFO - 'TMOUT': '86400', 22:25:31 INFO - 'USER': 'cltbld', 22:25:31 INFO - 'XDG_SESSION_COOKIE': 'd3f2be9b0713ec03b22325b2000001be-1451444517.521689-948692660', 22:25:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:25:31 INFO - '_': '/tools/buildbot/bin/python'} 22:25:31 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/kF9lWKrhQjSIYmWqxh1jZA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 22:25:32 INFO - mozversion application_buildid: 20151229214837 22:25:32 INFO - mozversion application_changeset: 804529fa0c027b32e26edf310eb9c7cd65de9aa1 22:25:32 INFO - mozversion application_display_name: Nightly 22:25:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:25:32 INFO - mozversion application_name: Firefox 22:25:32 INFO - mozversion application_remotingname: firefox 22:25:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:25:32 INFO - mozversion application_vendor: Mozilla 22:25:32 INFO - mozversion application_version: 46.0a1 22:25:32 INFO - mozversion platform_buildid: 20151229214837 22:25:32 INFO - mozversion platform_changeset: 804529fa0c027b32e26edf310eb9c7cd65de9aa1 22:25:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:25:32 INFO - mozversion platform_version: 46.0a1 22:25:32 INFO - using testdate: 1451456732 22:25:32 INFO - actual date: 1451456732 22:25:32 INFO - starting webserver on 'localhost:50523' 22:25:32 INFO - SUITE-START | Running 3 tests 22:25:32 INFO - TEST-START | dromaeo_css 22:25:32 INFO - operating with platform_type : linux_ 22:25:32 INFO - Initialising browser for dromaeo_css test... 22:25:32 INFO - TEST-INFO | started process 19154 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNbMySb/profile http://localhost:50523/getInfo.html) 22:25:36 INFO - PROCESS | 19154 | __metrics Screen width/height:1600/1200 22:25:36 INFO - PROCESS | 19154 | colorDepth:24 22:25:36 INFO - PROCESS | 19154 | Browser inner width/height: 1024/697 22:25:36 INFO - PROCESS | 19154 | __metrics 22:25:36 INFO - PROCESS | 19154 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:25:36 INFO - PROCESS | 19154 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:25:37 INFO - TEST-INFO | 19154: exit 0 22:25:37 INFO - Browser initialized. 22:25:37 INFO - Running cycle 1/1 for dromaeo_css test... 22:25:37 INFO - TEST-INFO | started process 19245 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNbMySb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:25:49 INFO - PROCESS | 19245 | RSS: Main: 150654976 22:25:49 INFO - PROCESS | 19245 | 22:26:40 INFO - PROCESS | 19245 | 1451456800491 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] 22:28:52 INFO - PROCESS | 19245 | Cycle 1(1): loaded http://localhost:50523/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50523/tests/dromaeo/cssquery-ext.html) 22:28:53 INFO - PROCESS | 19245 | RSS: Main: 298328064 22:28:53 INFO - PROCESS | 19245 | 22:31:56 INFO - PROCESS | 19245 | Cycle 1(1): loaded http://localhost:50523/tests/dromaeo/cssquery-ext.html (next: http://localhost:50523/tests/dromaeo/cssquery-jquery.html) 22:31:56 INFO - PROCESS | 19245 | RSS: Main: 233193472 22:31:56 INFO - PROCESS | 19245 | 22:34:59 INFO - PROCESS | 19245 | Cycle 1(1): loaded http://localhost:50523/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50523/tests/dromaeo/cssquery-mootools.html) 22:34:59 INFO - PROCESS | 19245 | RSS: Main: 227991552 22:34:59 INFO - PROCESS | 19245 | 22:38:01 INFO - PROCESS | 19245 | Cycle 1(1): loaded http://localhost:50523/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50523/tests/dromaeo/cssquery-prototype.html) 22:38:02 INFO - PROCESS | 19245 | RSS: Main: 214351872 22:38:02 INFO - PROCESS | 19245 | 22:41:04 INFO - PROCESS | 19245 | Cycle 1(1): loaded http://localhost:50523/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50523/tests/dromaeo/cssquery-yui.html) 22:41:05 INFO - PROCESS | 19245 | RSS: Main: 219246592 22:41:05 INFO - PROCESS | 19245 | 22:44:08 INFO - PROCESS | 19245 | Cycle 1(1): loaded http://localhost:50523/tests/dromaeo/cssquery-yui.html (next: http://localhost:50523/tests/dromaeo/cssquery-dojo.html) 22:44:08 INFO - PROCESS | 19245 | RSS: Main: 262135808 22:44:08 INFO - PROCESS | 19245 | 22:44:08 INFO - PROCESS | 19245 | __start_tp_report 22:44:08 INFO - PROCESS | 19245 | _x_x_mozilla_page_load 22:44:08 INFO - PROCESS | 19245 | _x_x_mozilla_page_load_details 22:44:08 INFO - PROCESS | 19245 | |i|pagename|runs| 22:44:08 INFO - PROCESS | 19245 | |0;dojo.html;2584.7544483274087;2710.3224193951514;2724.9318767030836;2732.549129393649;2739.246707155532;4520.615747661453;4621.191291523986;4623;4628.398308219931;4634.6292296616275;4594.74728889911;4604.56256655618;4719.221328480805;4723.929141062887;4724.126036683216;4277.059047009653;4311.655067594601;4317.568243175689;4323;4329.567043295661;4157.438745769327;4369.497507786597;4381.145676593065;4382.4741031076155;4441.733495990235;4184.874453766407;4230.471191101113;4310.568943105664;4343.587359200902;4346.326319420495;4238.830446782125;4243.236217480852;4255.085156691295;4286.485621725382;4295.312749959991;4065.7560546367313;4242.193983143224;4261.275583150872;4263.637590804786;4292.527821939584;4407.382966384709;4426.535213802569;4470.932936005963;4565.497795242521;4594.931076033862;5023.497650234984;5039.143345631252;5047.596192304607;5101.591872650216;5103.260027296058;4864.975675121602;5072.365954255718;5080.13637681595;5083.491650834924;5088.77100530477;4529.682922195448;4551.294549344857;4553.225951588238;4609.446866376056;4671.27595222741;5118.539331460186;5119.539241468286;5125.308083408692;5131.486851314913;5142.922856157086;4723.692959957661;4920.4833492483485;4925.753712314442;4932.235503496964;4967.528084831935;4901.264810278415;4929.507049295042;4929.926051109236;4991.900161996812;5080.542751152414;4951.851444456672;4953.18272485036;4953.504649535018;4979.651424400329;4999.250112483084;4917.311576379309;4917.950820491821;4924.532169443897;4925.507449255046;4971.45314015458;4065.918681626351;4143.958560414358;4176.9582304176565;4212.431321771583;4249.213895429355;3649;3651;3683.5763887152784;3698.0939669780537;3746.1571146492365;4305.289627211538;4325.891852703645;4327.502337231259;4363.716358436692;4364.5635436456105;4819.3012013257885;4978.253262010655;4984.576311013604;4988.650794444354;5006.674566153189;4276.593723596254;4289.463817022872;4373.868783936487;4378.7372757634;4396.49440314368;4460.77696115193;4470.485894122217;4473.194824931544;4474.060447306102;4516.638668906479;4726.503717109654;4732.219183834766;4773.570378665937;4777.8088876445245;4824.975875120672;4787.3537072496165;4898.21628539432;4904;4906.55840974314;4946.579540739078;4738.976305118453;4741.478437371818;4744.1697702901165;4765.904681906273;4787.808487660454;4899.608031357554;4902.2156454967035;4904.6566740327835;4905.166121759238;4955.876103097307;4811.879703007313;4930.5069493050405;4935.358403407534;4940.357753492023;5033.446320904624;4676.181668208118;4683.695559788603;4685.390899183084;4685.6251499879245;4690.648201384842;4632.420947381577;4666.370040044686;4666.696664716783;4669.789859456265;4678.508756580646;4675.929861052019;4763.333133361263;4788.545088216614;4796.25658023007;4803.903921921612;4865.9026819464125;4893.388326459192;4895.412550493964;4895.877603059952;4937.703737775745;4606.700564463299;4782.617390608673;4789.4971028041555;4797.136515427256;4818.229083346648 22:44:08 INFO - PROCESS | 19245 | |1;ext.html;506.0208496559158;526.2422112158491;533.5758072332495;534.7566857080029;548.4899043889184;25759.0984315549;26205;33452.4982125268;34023.65976340236;34023.82988085062;36759.816200918955;37202.255954880886;37280.627193728054;37308.81345593268;37412.62587374126;6785.660716964157;7552.773416797491;7717.8070548236465;7719.575423351714;7720.845583088335;6852.862942741167;6953.304669533057;6956.617386043766;6964.651767411635;9745.269104817167;9657.082577155194;9791;9798.755031124243;9801;9805.705828825146;9658.517074146264;9789.706308810712;9791.510424478747;9795.559199836025;9798.559064842028;6931.1682598088555;7000.544964577337;9507.19188868947;9704;9898.356606820606;33961.830190849134;34360.82819585911;34372.48441273383;34387.828060859785;34412.48381274283;2618.2276228512633;2626.9868650656626;2640.1815437214523;2652.880620372088;2795.594638777386;26379.467650442286;27602.5859612106;28746.425071498663;28915;28961.56557651637;3194.669261859585;3240.4005259027153;3247.8213698246586;3272.9345413091605;3350.430426827421;222935;223923.88038059868;224058;224554;224881;49872.75063624659;53804;53910.1131460397;54200.45799542033;54387.45612543903;44992;57054.429455705744;58260;58310.416895831346;58317.41682583205;12535.686607834694;12753.936230318976;12807;12817.807732884014;12824.294663793395;8568.271696905833;8604.913950860411;8623.698170564001;8671.132886711279;8682.6092825823;17727.911360443115;17910.641787164182;17927.73108403349;18527.444176674722;18708.345207917657;6924.446044316443;6942.965285173542;6951.965240173868;7134.571925684476;7138;819.2749416766086;823.5347028928636;878.2359347367703;955.6607404371487;972.5429048347407;26146.477070458484;26428.207153785417;26601.86699066531;26715.86642066816;26745.46509069808;897.3763234551924;955.2644463762864;955.3837774635322;974.7563109222694;981.7398389426808;13840.515581954583;14071;14559.636009099857;14852.480163194236;14858.851411485746;258988;261509;263134;263882;264266;45181.54818451839;45562;45591.54408455939;45598.77200614042;45781;1101.5043230546287;1107.092184408777;1110.9055730262858;1123.4495097402378;1123.752774389633;20849;24892.87553562293;25009.374765631004;26455.470890582466;27167;34743.65256347404;35048.824755876056;35113.824430877685;35131.29737405289;35387;157179.21410392874;158369.2081539585;158776;159196;159872.20063899606;23022.42443938915;26028.089016884318;28521;28680.569791452726;28804.135875923756;31976.52035219427;32214.83892580522;32246.355072897943;32594.83702581472;32993.175170619965;30655.846720766254;30788;31209.219769505944;31630.841845790623;31769.20576985594;24727.50544989126;29537;31181.53227701632;31374.37251255008;31595.84202078975;28522.42955140844;28531.857340713163;28595.28511787222;28836.7116328834;28838.855805720836;27396.45207095887;27884.860575696992;30012.69987300099;30042.849785751805;30163.547546787253;21510.8924455383;22646.886765566065;22992;23024.07903683834;23039.6544051836 22:44:08 INFO - PROCESS | 19245 | |2;jquery.html;335.8153015841287;337.54937158892886;339.97960122392675;341.17776159455707;343.5327953982585;12069.3965301735;12443.626691199279;14398.280085995697;14552.92723536382;14941.701165976687;9516.809663806736;9818.361806482573;9835.557399917003;14951.401943922257;15398.153101579408;4389.297712366022;4507.6619253555955;4509.098180363941;4514.5711157440155;4516.954830451687;3433.5536380270655;3868.7678739275734;5210.739463026853;5223.268742376071;5226.817061402851;5164.561012313958;5184.455632158626;5184.585233181337;5190.195519694454;5209.505097015777;5195.40252870919;5792.420757924174;5793.768249270003;5803.071508558653;5804.680742559158;5134.05020071288;5143.691378517301;5148.897022059576;5149.176131818891;5216;11464.082873370195;11468.139889508237;11480.196386252966;11484.885151148465;12570.937145314216;1650.7111255530235;1675.1875340459867;1676.773635559196;1724.7585338052684;1728.2309372329319;8623;8692.434991725517;8931.196192342655;8951.462912225288;9104.954475227647;1680.73108302671;1703.3101593854508;1734.1469570768963;1741.4427383237369;1782.785352842942;53425;55835.72082139563;56702.865942681325;57422.425775742544;58493.41506584965;9898;9978.553109799184;10008.599656013677;10038.999999999854;10047.346922450017;12848.229106253655;12876.871231287754;12883.742325153631;12885.871141288655;12894.613161605166;6817.250102488722;7075.327843854826;7087.291270872872;7157.320054594805;7165.6775445105095;6865.038894554767;6868.381845633917;6892.207396149407;6904.033435319059;6914.965425172842;3982.980085099614;3987.760734355948;4231.7672528010635;4256.233877901946;4283.657307415399;1626.341331760639;1661.9916900415421;1716.3477878406375;2785.623940768011;2893.7974341796294;732.1543617122232;832.7168762620738;848.7750746052301;907.8275127725711;962.3648392061345;13290.269035202964;15132.167730774912;16078.598035048983;16111.355545778271;16161.838381616268;758.525921299188;761.3794757272805;790.6125998260811;811.0348685064754;833.7998880268813;8479.364047696448;8720.389572729848;8727.258183054384;8820.823583528294;9157.954210228907;301245;339957;519490;528072;531447;69047.65476172588;69951;71181.64409178024;71817.64091179614;72124;1091.6561283195767;1099.2085698297053;1106.253279036647;1118.7370967822555;1119.345183067898;13798.862011379757;14709.705805884036;14859.925700371428;14863.033902796284;15130.697386051997;31669.841650791597;32139.51790723188;32695.50956735603;33960;35112.64887351094;36204.63795362013;36973.26053478861;37015.25969480649;37617.81191094027;37697.43453848139;8380.742888566763;8568.91431085706;8643.87034194475;8650.480971141751;8652.78368040804;10137.797244055226;10226.335288206243;12866;16231.51305460838;16565.58586035359;12651.367431628198;12770.744585108432;13226.470941162246;14063.085899416505;14344.641383965485;13648.181109133484;13692.520761773689;13778.242196679279;13992.440302387791;14035.649108771953;10622.937706229624;11016.283941543774;13043.413046412745;13884.51404200848;13975.930120349332;8372;8660.047394786443;8660.307175425825;8662;8672.609732562176;9170.495622740813;9275.953620231856;9750.75623109428;14331.498397556035;14338.784918226027 22:44:08 INFO - PROCESS | 19245 | |3;mootools.html;1222.5904322052113;1409.3305679802093;1409.7532931736946;1506.7890495330648;1725.4047353662982;6001.189839371684;6130.662813545253;6917.273686262945;7019.68411421486;7022.754203602875;6792.966035169829;6796.3203679632015;6864.725410983568;6867.278935711754;6878.174619045709;2044.8875311857842;2068.4518602570256;2075;2078.864873783207;2079.261862038977;2091.5398612305266;2096.5282811367474;2109.5253567947243;2146.0450099705636;2160.373491687417;2042.7957204279528;2076.6677331626943;2101.726775519188;2104.4844013216707;2104.6527322991687;2063;2077.6779599162155;2083.322920050982;2084.4163634182455;2085.7705652378227;2053.938381848547;2090.028136916326;2092.246791155183;2105.768365479796;2106.65240235361;7102.360787529095;7167.390771784405;7187.568745875212;7189.281071892821;7196;4115.691323150746;4191.245575796355;4205.789710514462;4208;4215.051613386994;2669.305980445079;2697.568389057761;2708.5801700736415;2744.2590500564734;2753.6420265365373;848.2535368875411;857.1771099744253;860.3590325207698;873.7243624308517;878.7934835313696;9302.86045709315;9361.578728957213;9385.624575016991;9431.292653051049;9438.103380178873;3749.531308586427;3756.3238617048646;3836.3861782114727;3847.826847791856;3857.72995890285;7972;8001.039875214895;8005.679772809139;8013.5191888485715;8022.919770802334;4049.7367671101283;4061.2283666103344;4064.4919385076864;4095.672346212296;4110;3328.8668453262085;3406.9488957665653;3740.214554943492;3769.792661403594;3789.696824254053;3380.966190338065;3403.8127902965575;3422.5550678412146;3436.6563343665434;3448.20691241016;1076.1175835814556;1083.1334932054326;1088.7495875948575;1096.5175322857917;1102.6471529110609;1099.1866019145775;1108.2851560743275;1127.6504283672089;1128.4245035032193;1131.1911982932243;6337.746490140435;6542.051402546604;6566.770163044366;6567;6578.27638959714;1093.9006298669785;1104.0836106031975;1104.3318792130806;1116.5198964445203;1130.5647325779635;5227.294315267466;5286.048511268009;5298.894022119536;5301.946980530145;5303.496167864047;8176.509409435453;8198.631061602242;8315.750527484186;8417.957910210409;8434.198751118634;8271.421000530025;8283.420160588701;8301.46040507365;8308.54303013328;8362.331013519026;6685.699143538553;6798.320167983261;6855.211650660238;6882.449404047664;6887.9999999999;6535.44448721864;6543.5419520635005;6563.474922006132;6564.376384243489;6564.6389448580785;7571.848563028819;7777.494462859896;7783.377329813715;7789.922100778919;7913.723019694514;7850.0972388173805;7944.245296696805;8034.638441270274;8064.274215320649;8078.23256790604;5110.923336149886;5207.635465517377;5215.947840521546;5930.851728706644;6041.607295525777;6001.879962400641;6668.166479190101;6678.83302917431;6692;6699.296573859675;6103.328633850184;6279.246490421178;6428.453581445442;6448.613083215022;6456.289808121197;6261.499080073492;6284.371562843862;6303.621782693053;6405.295417503978;6409.551331406757;6351.714172862325;6390.105385245976;6392.648404337806;6393.1688880445245;6399.136116624382;5699.316082070178;5727.226824378822;5745.2818397700285;5746.396628353963;5748.798792042258;5705.201271821865;5830.096335068071;5834.212381328466;5848.736806843617;5850.561207909339 22:44:08 INFO - PROCESS | 19245 | |4;prototype.html;314.3289077818856;316.29781884217033;319.0492332848114;322.86116969703016;323.11144353029175;5223.477652234779;5233.241180028894;5271.2356708277275;5273.261743355928;5277.973610131949;5234.581233501321;5252.212168174776;5252.65857719248;5253.921191182126;5263.4210236874005;3901.1807520420743;3971.046948732298;4020.6582440492593;4157.771322577257;4162.042730172055;4127.380892866079;4149.9792501037455;4152.896177595554;4158.9376159357635;4166.64583510402;4111.629953304202;4115.032967252693;4121.526024507175;4121.8969525761795;4128.360104183841;3892.766434013954;3981.6615587675083;3990.840366385341;4075.572064933169;4098.856540021085;3615.204654975901;3626.963730362689;3631.1829838286176;3631.8184090795353;3643.0528062703625;4944.9258261126115;4993;5002.824901128443;5011.949880501221;5013.874653133665;4759.286107083931;4764.380630518011;4769.689970151963;4773.594244489223;4774.212254977924;5386.407495175527;5529.281193444866;5540.778368865241;5543.417941116165;5551.555875529948;3953.940690889639;3969.583193764642;3969.7419667721506;3973.523177218752;3973.7417067890783;5795.681237531934;5867.735951882176;5869.589128760946;5871.412858714094;5879.764809407661;4095.1400205957084;4095.9385609215888;4096.774677392712;4098.262312783728;4117.238310912491;3958.089639382958;4094.467719196485;4116.938245926313;4165.083681590046;4175.478065241845;4671.883202919954;4676.976615116971;4677.111348843709;4677.906441871143;4685.718856868531;5519.8896022080135;5540.750666220029;5544.140658197985;5549.611527193058;5551.805686800943;1420.6093324335684;1445.075151902783;1445.2195814260392;1445.3423692220015;1447.3993292783377;950.3727539823822;950.8954015058338;961.3318743473219;976.8339382305026;982.1651596143221;4924.3352147460355;4928.704277743347;4932.8520144395725;4938.358013458299;4939.604831613534;5761.107028410603;5764.048931926269;5766.192733017381;5766.94233057664;5768.798092066758;4918.704877707349;4920;4924.507549245119;4924.532169443897;4925.901481970341;2872.339361946722;2972.554116882485;3053.2519532714628;3060.969390306113;3090.5364195370876;5427.0773968425465;5514.09017512106;5518.944810551923;5528.977139229255;5530.142827861688;5942.257217847769;5947.286325640865;5947.940520594825;5955.493783028404;5966.284045914518;5513;5513.448655134454;5514.420985796514;5515.117581186991;5524.281843360337;5609.859753506195;5691.914621280767;5740.598158129058;5767.480926716616;5797.159411885169;5660.094384898561;5668.348139963957;5669;5671.829845104653;5672.971635141798;5529.640573362719;5532.557395408277;5534.695591742493;5535.640183388067;5536.2249285100925;3916.3538016227003;4016.7389119707127;4050.959490405058;4055.0673345130194;4057.5130984282073;5694.430556944272;5705.771769129188;5742.224799651994;5772.480476757112;5774.740136693943;5517.5585953124455;5559.610827242216;5563.8887222256135;5564.944350556442;5569.220309156641;5515.7242137893745;5519.503244707996;5523.088690366045;5524.91712624319;5530.529904957963;5308.654937429054;5375.758090885998;5408.215808707794;5412.1340585507705;5413.485718856702;5573.331200255995;5588.30146231721;5588.804391846266;5592.944070559405;5595.63628364155;5243.737813109406;5330.253764472899;5415.620906536662;5457.126859702428;5460.2355670207 22:44:08 INFO - PROCESS | 19245 | |5;yui.html;723.8877973914043;735.1692587376264;736.5563495548728;751.6091632351175;771.9228077192284;11022.228444008913;11187.6643700689;11206.15953803465;11209.439528023586;11220.382878941655;10097.343672661273;10678.25252232342;10748.247622666417;10757.193210509224;10780.353178809277;597.14011822975;763.9465237433382;764.9617519124049;765.1201118713496;765.2271206081841;764.9732259370924;771.2518856709012;772.7720322504847;774.3418094619584;774.3456779021745;793.4485532554877;793.7380664380769;797.2067792546395;797.2505844506175;797.3501596199109;791.3155120820448;796.8645330293864;797.0077253819004;797.182887540273;797.2386371015696;588.3381196154327;589.3075636127533;589.5224867857049;589.5313225985352;589.631480324797;9864.112229899272;9973.451460169688;9975.102240798364;9979.950100249525;9993.200543956465;8836.160564746338;9634.42193468387;9721.756956076084;9747.220222382264;9852.65515706954;7968.163342848975;8301.709440169625;8309.95845020771;8320.583970801496;8359.958200209021;2990.745786608141;3040.619922509686;3047.9847600761855;3097.132802815215;3121.297708015701;33680.49479257813;33783.15542111467;37687.05782355436;37915.05212369685;38338.80830595857;9485.288603354638;9519.762005949768;9539.952300238594;9697.224222062217;9952.402855828528;16116.919415402848;16163.919180404022;16170.191490425432;16174.838251617333;16201.756973645404;6209.689515524296;6335.144755458046;6345.777897773556;6441.355864413521;6538.673066346663;3403.4724617684296;3435.1927297085167;3482.8084455355197;3495.143689796016;3520.9647903520636;2677.9598306025423;2704.6889607694975;2706.972930270672;2708.1469337159124;2712.850793206353;473.4247888815106;474.20097136325404;478.273025001995;487.765872381259;488.9437714662788;367.2599711581166;393.1365328343688;402.5953916314086;411.41168129574993;415.6757728971407;6583.473322134218;6868.759593414206;6918.723251070001;6944.861102778017;6951.93048069523;409.33891764799637;489.98775030623807;503.5442924153647;512.9307543481657;520.7630528109701;3439.174598096439;3555.4133567961;3589.4974703541525;3595.334863050344;3820.522434695663;40337.59662403397;41240.79379603143;41391.58608413878;41465.1706965859;41613.58386416158;36557.817210914305;36883.815580921924;42844;43182.56817431848;43241.783791080845;31494.685053149635;32550;37059.81470092632;41263.58736412657;41295.380569290886;6930.410915072275;7133.357997780225;7164.426845852215;7370.5946172961;7525.887111693439;30032.549511757778;30302;30845.537316939815;31760.205994850312;31986.6801331993;33207.833960830045;35896.28207435889;39875.60124398719;42955.35566966561;43375;9249.953750231205;9793.167580755715;9821.410715357102;10342.069213770797;10698.518566664363;10456.63401780934;10537.051665350155;10584.153267738717;10851.348919064882;11173.88826111761;9466.290028247771;9694.951525242328;9881.20950323958;9995.850062249217;10536;10063.547140378554;10175.28772985884;10190.592376304865;10201.948990255001;10265.692029239135;9805.509724513604;10001.249906256915;10048.296619236875;10082.798344032932;10091.646792362231;8782.165694259034;8818.735437936872;8946.955265223633;9307.488088154945;9352.158305752515;8121.309688676292;8375.162483751576;8429.367797415096;8532.146785321418;8618.655253789779 22:44:08 INFO - PROCESS | 19245 | __end_tp_report 22:44:08 INFO - PROCESS | 19245 | __start_cc_report 22:44:08 INFO - PROCESS | 19245 | _x_x_mozilla_cycle_collect,1299 22:44:08 INFO - PROCESS | 19245 | __end_cc_report 22:44:08 INFO - PROCESS | 19245 | __startTimestamp1451457848256__endTimestamp 22:44:08 INFO - PROCESS | 19245 | 22:44:08 INFO - PROCESS | 19245 | ------- Summary: start ------- 22:44:08 INFO - PROCESS | 19245 | Number of tests: 6 22:44:08 INFO - PROCESS | 19245 | 22:44:08 INFO - PROCESS | 19245 | [#0] dojo.html Cycles:165 Average:4589.88 Median:4685.63 stddev:467.39 (10.0%) stddev-sans-first:441.56 22:44:08 INFO - PROCESS | 19245 | Values: 2584.8 2710.3 2724.9 2732.5 2739.2 4520.6 4621.2 4623.0 4628.4 4634.6 4594.7 4604.6 4719.2 4723.9 4724.1 4277.1 4311.7 4317.6 4323.0 4329.6 4157.4 4369.5 4381.1 4382.5 4441.7 4184.9 4230.5 4310.6 4343.6 4346.3 4238.8 4243.2 4255.1 4286.5 4295.3 4065.8 4242.2 4261.3 4263.6 4292.5 4407.4 4426.5 4470.9 4565.5 4594.9 5023.5 5039.1 5047.6 5101.6 5103.3 4865.0 5072.4 5080.1 5083.5 5088.8 4529.7 4551.3 4553.2 4609.4 4671.3 5118.5 5119.5 5125.3 5131.5 5142.9 4723.7 4920.5 4925.8 4932.2 4967.5 4901.3 4929.5 4929.9 4991.9 5080.5 4951.9 4953.2 4953.5 4979.7 4999.3 4917.3 4918.0 4924.5 4925.5 4971.5 4065.9 4144.0 4177.0 4212.4 4249.2 3649.0 3651.0 3683.6 3698.1 3746.2 4305.3 4325.9 4327.5 4363.7 4364.6 4819.3 4978.3 4984.6 4988.7 5006.7 4276.6 4289.5 4373.9 4378.7 4396.5 4460.8 4470.5 4473.2 4474.1 4516.6 4726.5 4732.2 4773.6 4777.8 4825.0 4787.4 4898.2 4904.0 4906.6 4946.6 4739.0 4741.5 4744.2 4765.9 4787.8 4899.6 4902.2 4904.7 4905.2 4955.9 4811.9 4930.5 4935.4 4940.4 5033.4 4676.2 4683.7 4685.4 4685.6 4690.6 4632.4 4666.4 4666.7 4669.8 4678.5 4675.9 4763.3 4788.5 4796.3 4803.9 4865.9 4893.4 4895.4 4895.9 4937.7 4606.7 4782.6 4789.5 4797.1 4818.2 22:44:08 INFO - PROCESS | 19245 | 22:44:08 INFO - PROCESS | 19245 | [#1] ext.html Cycles:180 Average:36953.53 Median:17743.38 stddev:57165.53 (322.2%) stddev-sans-first:57260.39 22:44:08 INFO - PROCESS | 19245 | Values: 506.0 526.2 533.6 534.8 548.5 25759.1 26205.0 33452.5 34023.7 34023.8 36759.8 37202.3 37280.6 37308.8 37412.6 6785.7 7552.8 7717.8 7719.6 7720.8 6852.9 6953.3 6956.6 6964.7 9745.3 9657.1 9791.0 9798.8 9801.0 9805.7 9658.5 9789.7 9791.5 9795.6 9798.6 6931.2 7000.5 9507.2 9704.0 9898.4 33961.8 34360.8 34372.5 34387.8 34412.5 2618.2 2627.0 2640.2 2652.9 2795.6 26379.5 27602.6 28746.4 28915.0 28961.6 3194.7 3240.4 3247.8 3272.9 3350.4 222935.0 223923.9 224058.0 224554.0 224881.0 49872.8 53804.0 53910.1 54200.5 54387.5 44992.0 57054.4 58260.0 58310.4 58317.4 12535.7 12753.9 12807.0 12817.8 12824.3 8568.3 8604.9 8623.7 8671.1 8682.6 17727.9 17910.6 17927.7 18527.4 18708.3 6924.4 6943.0 6952.0 7134.6 7138.0 819.3 823.5 878.2 955.7 972.5 26146.5 26428.2 26601.9 26715.9 26745.5 897.4 955.3 955.4 974.8 981.7 13840.5 14071.0 14559.6 14852.5 14858.9 258988.0 261509.0 263134.0 263882.0 264266.0 45181.5 45562.0 45591.5 45598.8 45781.0 1101.5 1107.1 1110.9 1123.4 1123.8 20849.0 24892.9 25009.4 26455.5 27167.0 34743.7 35048.8 35113.8 35131.3 35387.0 157179.2 158369.2 158776.0 159196.0 159872.2 23022.4 26028.1 28521.0 28680.6 28804.1 31976.5 32214.8 32246.4 32594.8 32993.2 30655.8 30788.0 31209.2 31630.8 31769.2 24727.5 29537.0 31181.5 31374.4 31595.8 28522.4 28531.9 28595.3 28836.7 28838.9 27396.5 27884.9 30012.7 30042.8 30163.5 21510.9 22646.9 22992.0 23024.1 23039.7 22:44:08 INFO - PROCESS | 19245 | 22:44:08 INFO - PROCESS | 19245 | [#2] jquery.html Cycles:180 Average:24517.91 Median:3925.87 stddev:74580.61 (1899.7%) stddev-sans-first:74767.73 22:44:08 INFO - PROCESS | 19245 | Values: 335.8 337.5 340.0 341.2 343.5 12069.4 12443.6 14398.3 14552.9 14941.7 9516.8 9818.4 9835.6 14951.4 15398.2 4389.3 4507.7 4509.1 4514.6 4517.0 3433.6 3868.8 5210.7 5223.3 5226.8 5164.6 5184.5 5184.6 5190.2 5209.5 5195.4 5792.4 5793.8 5803.1 5804.7 5134.1 5143.7 5148.9 5149.2 5216.0 11464.1 11468.1 11480.2 11484.9 12570.9 1650.7 1675.2 1676.8 1724.8 1728.2 8623.0 8692.4 8931.2 8951.5 9105.0 1680.7 1703.3 1734.1 1741.4 1782.8 53425.0 55835.7 56702.9 57422.4 58493.4 9898.0 9978.6 10008.6 10039.0 10047.3 12848.2 12876.9 12883.7 12885.9 12894.6 6817.3 7075.3 7087.3 7157.3 7165.7 6865.0 6868.4 6892.2 6904.0 6915.0 3983.0 3987.8 4231.8 4256.2 4283.7 1626.3 1662.0 1716.3 2785.6 2893.8 732.2 832.7 848.8 907.8 962.4 13290.3 15132.2 16078.6 16111.4 16161.8 758.5 761.4 790.6 811.0 833.8 8479.4 8720.4 8727.3 8820.8 9158.0 301245.0 339957.0 519490.0 528072.0 531447.0 69047.7 69951.0 71181.6 71817.6 72124.0 1091.7 1099.2 1106.3 1118.7 1119.3 13798.9 14709.7 14859.9 14863.0 15130.7 31669.8 32139.5 32695.5 33960.0 35112.6 36204.6 36973.3 37015.3 37617.8 37697.4 8380.7 8568.9 8643.9 8650.5 8652.8 10137.8 10226.3 12866.0 16231.5 16565.6 12651.4 12770.7 13226.5 14063.1 14344.6 13648.2 13692.5 13778.2 13992.4 14035.6 10622.9 11016.3 13043.4 13884.5 13975.9 8372.0 8660.0 8660.3 8662.0 8672.6 9170.5 9276.0 9750.8 14331.5 14338.8 22:44:08 INFO - PROCESS | 19245 | 22:44:08 INFO - PROCESS | 19245 | [#3] mootools.html Cycles:180 Average:4892.22 Median:5841.47 stddev:2508.18 (42.9%) stddev-sans-first:2500.05 22:44:08 INFO - PROCESS | 19245 | Values: 1222.6 1409.3 1409.8 1506.8 1725.4 6001.2 6130.7 6917.3 7019.7 7022.8 6793.0 6796.3 6864.7 6867.3 6878.2 2044.9 2068.5 2075.0 2078.9 2079.3 2091.5 2096.5 2109.5 2146.0 2160.4 2042.8 2076.7 2101.7 2104.5 2104.7 2063.0 2077.7 2083.3 2084.4 2085.8 2053.9 2090.0 2092.2 2105.8 2106.7 7102.4 7167.4 7187.6 7189.3 7196.0 4115.7 4191.2 4205.8 4208.0 4215.1 2669.3 2697.6 2708.6 2744.3 2753.6 848.3 857.2 860.4 873.7 878.8 9302.9 9361.6 9385.6 9431.3 9438.1 3749.5 3756.3 3836.4 3847.8 3857.7 7972.0 8001.0 8005.7 8013.5 8022.9 4049.7 4061.2 4064.5 4095.7 4110.0 3328.9 3406.9 3740.2 3769.8 3789.7 3381.0 3403.8 3422.6 3436.7 3448.2 1076.1 1083.1 1088.7 1096.5 1102.6 1099.2 1108.3 1127.7 1128.4 1131.2 6337.7 6542.1 6566.8 6567.0 6578.3 1093.9 1104.1 1104.3 1116.5 1130.6 5227.3 5286.0 5298.9 5301.9 5303.5 8176.5 8198.6 8315.8 8418.0 8434.2 8271.4 8283.4 8301.5 8308.5 8362.3 6685.7 6798.3 6855.2 6882.4 6888.0 6535.4 6543.5 6563.5 6564.4 6564.6 7571.8 7777.5 7783.4 7789.9 7913.7 7850.1 7944.2 8034.6 8064.3 8078.2 5110.9 5207.6 5215.9 5930.9 6041.6 6001.9 6668.2 6678.8 6692.0 6699.3 6103.3 6279.2 6428.5 6448.6 6456.3 6261.5 6284.4 6303.6 6405.3 6409.6 6351.7 6390.1 6392.6 6393.2 6399.1 5699.3 5727.2 5745.3 5746.4 5748.8 5705.2 5830.1 5834.2 5848.7 5850.6 22:44:08 INFO - PROCESS | 19245 | 22:44:08 INFO - PROCESS | 19245 | [#4] prototype.html Cycles:180 Average:4622.64 Median:5253.29 stddev:1350.38 (25.7%) stddev-sans-first:1314.88 22:44:08 INFO - PROCESS | 19245 | Values: 314.3 316.3 319.0 322.9 323.1 5223.5 5233.2 5271.2 5273.3 5278.0 5234.6 5252.2 5252.7 5253.9 5263.4 3901.2 3971.0 4020.7 4157.8 4162.0 4127.4 4150.0 4152.9 4158.9 4166.6 4111.6 4115.0 4121.5 4121.9 4128.4 3892.8 3981.7 3990.8 4075.6 4098.9 3615.2 3627.0 3631.2 3631.8 3643.1 4944.9 4993.0 5002.8 5011.9 5013.9 4759.3 4764.4 4769.7 4773.6 4774.2 5386.4 5529.3 5540.8 5543.4 5551.6 3953.9 3969.6 3969.7 3973.5 3973.7 5795.7 5867.7 5869.6 5871.4 5879.8 4095.1 4095.9 4096.8 4098.3 4117.2 3958.1 4094.5 4116.9 4165.1 4175.5 4671.9 4677.0 4677.1 4677.9 4685.7 5519.9 5540.8 5544.1 5549.6 5551.8 1420.6 1445.1 1445.2 1445.3 1447.4 950.4 950.9 961.3 976.8 982.2 4924.3 4928.7 4932.9 4938.4 4939.6 5761.1 5764.0 5766.2 5766.9 5768.8 4918.7 4920.0 4924.5 4924.5 4925.9 2872.3 2972.6 3053.3 3061.0 3090.5 5427.1 5514.1 5518.9 5529.0 5530.1 5942.3 5947.3 5947.9 5955.5 5966.3 5513.0 5513.4 5514.4 5515.1 5524.3 5609.9 5691.9 5740.6 5767.5 5797.2 5660.1 5668.3 5669.0 5671.8 5673.0 5529.6 5532.6 5534.7 5535.6 5536.2 3916.4 4016.7 4051.0 4055.1 4057.5 5694.4 5705.8 5742.2 5772.5 5774.7 5517.6 5559.6 5563.9 5564.9 5569.2 5515.7 5519.5 5523.1 5524.9 5530.5 5308.7 5375.8 5408.2 5412.1 5413.5 5573.3 5588.3 5588.8 5592.9 5595.6 5243.7 5330.3 5415.6 5457.1 5460.2 22:44:08 INFO - PROCESS | 19245 | 22:44:08 INFO - PROCESS | 19245 | [#5] yui.html Cycles:180 Average:11319.45 Median:483.02 stddev:12545.30 (2597.3%) stddev-sans-first:12555.25 22:44:08 INFO - PROCESS | 19245 | Values: 723.9 735.2 736.6 751.6 771.9 11022.2 11187.7 11206.2 11209.4 11220.4 10097.3 10678.3 10748.2 10757.2 10780.4 597.1 763.9 765.0 765.1 765.2 765.0 771.3 772.8 774.3 774.3 793.4 793.7 797.2 797.3 797.4 791.3 796.9 797.0 797.2 797.2 588.3 589.3 589.5 589.5 589.6 9864.1 9973.5 9975.1 9980.0 9993.2 8836.2 9634.4 9721.8 9747.2 9852.7 7968.2 8301.7 8310.0 8320.6 8360.0 2990.7 3040.6 3048.0 3097.1 3121.3 33680.5 33783.2 37687.1 37915.1 38338.8 9485.3 9519.8 9540.0 9697.2 9952.4 16116.9 16163.9 16170.2 16174.8 16201.8 6209.7 6335.1 6345.8 6441.4 6538.7 3403.5 3435.2 3482.8 3495.1 3521.0 2678.0 2704.7 2707.0 2708.1 2712.9 473.4 474.2 478.3 487.8 488.9 367.3 393.1 402.6 411.4 415.7 6583.5 6868.8 6918.7 6944.9 6951.9 409.3 490.0 503.5 512.9 520.8 3439.2 3555.4 3589.5 3595.3 3820.5 40337.6 41240.8 41391.6 41465.2 41613.6 36557.8 36883.8 42844.0 43182.6 43241.8 31494.7 32550.0 37059.8 41263.6 41295.4 6930.4 7133.4 7164.4 7370.6 7525.9 30032.5 30302.0 30845.5 31760.2 31986.7 33207.8 35896.3 39875.6 42955.4 43375.0 9250.0 9793.2 9821.4 10342.1 10698.5 10456.6 10537.1 10584.2 10851.3 11173.9 9466.3 9695.0 9881.2 9995.9 10536.0 10063.5 10175.3 10190.6 10201.9 10265.7 9805.5 10001.2 10048.3 10082.8 10091.6 8782.2 8818.7 8947.0 9307.5 9352.2 8121.3 8375.2 8429.4 8532.1 8618.7 22:44:08 INFO - PROCESS | 19245 | -------- Summary: end -------- 22:44:08 INFO - PROCESS | 19245 | 22:44:09 INFO - TEST-INFO | 19245: exit 0 22:44:09 INFO - TEST-OK | dromaeo_css | took 1116919ms 22:44:09 INFO - TEST-START | kraken 22:44:09 INFO - operating with platform_type : linux_ 22:44:09 INFO - Initialising browser for kraken test... 22:44:09 INFO - TEST-INFO | started process 19447 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkh11CL/profile http://localhost:50523/getInfo.html) 22:44:12 INFO - PROCESS | 19447 | __metrics Screen width/height:1600/1200 22:44:12 INFO - PROCESS | 19447 | colorDepth:24 22:44:12 INFO - PROCESS | 19447 | Browser inner width/height: 1024/697 22:44:12 INFO - PROCESS | 19447 | __metrics 22:44:13 INFO - PROCESS | 19447 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:44:13 INFO - PROCESS | 19447 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:44:14 INFO - TEST-INFO | 19447: exit 0 22:44:14 INFO - Browser initialized. 22:44:14 INFO - Running cycle 1/1 for kraken test... 22:44:14 INFO - TEST-INFO | started process 19528 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkh11CL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:44:26 INFO - PROCESS | 19528 | RSS: Main: 148766720 22:44:26 INFO - PROCESS | 19528 | 22:44:28 INFO - PROCESS | 19528 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50523/tests/kraken/driver.html?testName=audio-beat-detection) 22:44:29 INFO - PROCESS | 19528 | RSS: Main: 185528320 22:44:29 INFO - PROCESS | 19528 | 22:44:32 INFO - PROCESS | 19528 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50523/tests/kraken/driver.html?testName=audio-dft) 22:44:32 INFO - PROCESS | 19528 | RSS: Main: 176545792 22:44:32 INFO - PROCESS | 19528 | 22:44:35 INFO - PROCESS | 19528 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50523/tests/kraken/driver.html?testName=audio-fft) 22:44:36 INFO - PROCESS | 19528 | RSS: Main: 161554432 22:44:36 INFO - PROCESS | 19528 | 22:44:38 INFO - PROCESS | 19528 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50523/tests/kraken/driver.html?testName=audio-oscillator) 22:44:38 INFO - PROCESS | 19528 | RSS: Main: 164003840 22:44:38 INFO - PROCESS | 19528 | 22:44:41 INFO - PROCESS | 19528 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50523/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:44:41 INFO - PROCESS | 19528 | RSS: Main: 165724160 22:44:41 INFO - PROCESS | 19528 | 22:44:44 INFO - PROCESS | 19528 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50523/tests/kraken/driver.html?testName=imaging-darkroom) 22:44:45 INFO - PROCESS | 19528 | RSS: Main: 165376000 22:44:45 INFO - PROCESS | 19528 | 22:44:48 INFO - PROCESS | 19528 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50523/tests/kraken/driver.html?testName=imaging-desaturate) 22:44:49 INFO - PROCESS | 19528 | RSS: Main: 165969920 22:44:49 INFO - PROCESS | 19528 | 22:44:52 INFO - PROCESS | 19528 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50523/tests/kraken/driver.html?testName=json-parse-financial) 22:44:52 INFO - PROCESS | 19528 | RSS: Main: 166531072 22:44:52 INFO - PROCESS | 19528 | 22:44:54 INFO - PROCESS | 19528 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50523/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:44:55 INFO - PROCESS | 19528 | RSS: Main: 177463296 22:44:55 INFO - PROCESS | 19528 | 22:44:56 INFO - PROCESS | 19528 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50523/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:44:57 INFO - PROCESS | 19528 | RSS: Main: 178241536 22:44:57 INFO - PROCESS | 19528 | 22:44:59 INFO - PROCESS | 19528 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50523/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:45:00 INFO - PROCESS | 19528 | RSS: Main: 190394368 22:45:00 INFO - PROCESS | 19528 | 22:45:02 INFO - PROCESS | 19528 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50523/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:45:03 INFO - PROCESS | 19528 | RSS: Main: 194441216 22:45:03 INFO - PROCESS | 19528 | 22:45:05 INFO - PROCESS | 19528 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50523/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:45:06 INFO - PROCESS | 19528 | RSS: Main: 191709184 22:45:06 INFO - PROCESS | 19528 | 22:45:08 INFO - PROCESS | 19528 | Cycle 1(1): loaded http://localhost:50523/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50523/tests/kraken/driver.html?testName=ai-astar) 22:45:08 INFO - PROCESS | 19528 | RSS: Main: 249896960 22:45:08 INFO - PROCESS | 19528 | 22:45:08 INFO - PROCESS | 19528 | __start_tp_report 22:45:08 INFO - PROCESS | 19528 | _x_x_mozilla_page_load 22:45:08 INFO - PROCESS | 19528 | _x_x_mozilla_page_load_details 22:45:08 INFO - PROCESS | 19528 | |i|pagename|runs| 22:45:08 INFO - PROCESS | 19528 | |0;ai-astar;111;115;108;113;114;113;100;113;113;102 22:45:08 INFO - PROCESS | 19528 | |1;audio-beat-detection;162;144;152;164;137;156;154;134;166;132 22:45:08 INFO - PROCESS | 19528 | |2;audio-dft;161;161;162;160;160;163;162;161;160;161 22:45:08 INFO - PROCESS | 19528 | |3;audio-fft;73;73;88;90;73;72;73;109;87;73 22:45:08 INFO - PROCESS | 19528 | |4;audio-oscillator;98;97;140;100;97;97;134;97;97;132 22:45:08 INFO - PROCESS | 19528 | |5;imaging-gaussian-blur;110;109;110;110;109;110;109;109;110;110 22:45:08 INFO - PROCESS | 19528 | |6;imaging-darkroom;148;146;147;147;147;147;147;147;147;146 22:45:08 INFO - PROCESS | 19528 | |7;imaging-desaturate;96;95;95;96;96;95;96;95;96;96 22:45:08 INFO - PROCESS | 19528 | |8;json-parse-financial;70;69;76;71;70;70;69;79;68;69 22:45:08 INFO - PROCESS | 19528 | |9;json-stringify-tinderbox;68;69;69;69;69;69;69;70;71;71 22:45:08 INFO - PROCESS | 19528 | |10;stanford-crypto-aes;83;83;89;83;84;84;84;93;94;85 22:45:08 INFO - PROCESS | 19528 | |11;stanford-crypto-ccm;122;139;123;122;123;128;124;128;122;122 22:45:08 INFO - PROCESS | 19528 | |12;stanford-crypto-pbkdf2;148;150;148;147;154;139;164;147;147;138 22:45:08 INFO - PROCESS | 19528 | |13;stanford-crypto-sha256-iterative;70;72;69;69;70;70;69;70;70;73 22:45:08 INFO - PROCESS | 19528 | __end_tp_report 22:45:08 INFO - PROCESS | 19528 | __start_cc_report 22:45:08 INFO - PROCESS | 19528 | _x_x_mozilla_cycle_collect,999 22:45:08 INFO - PROCESS | 19528 | __end_cc_report 22:45:08 INFO - PROCESS | 19528 | __startTimestamp1451457908594__endTimestamp 22:45:08 INFO - PROCESS | 19528 | 22:45:08 INFO - PROCESS | 19528 | ------- Summary: start ------- 22:45:08 INFO - PROCESS | 19528 | Number of tests: 14 22:45:08 INFO - PROCESS | 19528 | 22:45:08 INFO - PROCESS | 19528 | [#0] ai-astar Cycles:10 Average:110.20 Median:113.00 stddev:5.22 (4.6%) stddev-sans-first:5.53 22:45:08 INFO - PROCESS | 19528 | Values: 111.0 115.0 108.0 113.0 114.0 113.0 100.0 113.0 113.0 102.0 22:45:08 INFO - PROCESS | 19528 | 22:45:08 INFO - PROCESS | 19528 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:155.00 stddev:12.64 (8.2%) stddev-sans-first:12.65 22:45:08 INFO - PROCESS | 19528 | Values: 162.0 144.0 152.0 164.0 137.0 156.0 154.0 134.0 166.0 132.0 22:45:08 INFO - PROCESS | 19528 | 22:45:08 INFO - PROCESS | 19528 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 22:45:08 INFO - PROCESS | 19528 | Values: 161.0 161.0 162.0 160.0 160.0 163.0 162.0 161.0 160.0 161.0 22:45:08 INFO - PROCESS | 19528 | 22:45:08 INFO - PROCESS | 19528 | [#3] audio-fft Cycles:10 Average:81.10 Median:73.00 stddev:12.25 (16.8%) stddev-sans-first:12.64 22:45:08 INFO - PROCESS | 19528 | Values: 73.0 73.0 88.0 90.0 73.0 72.0 73.0 109.0 87.0 73.0 22:45:08 INFO - PROCESS | 19528 | 22:45:08 INFO - PROCESS | 19528 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:97.00 stddev:18.37 (18.9%) stddev-sans-first:19.06 22:45:08 INFO - PROCESS | 19528 | Values: 98.0 97.0 140.0 100.0 97.0 97.0 134.0 97.0 97.0 132.0 22:45:08 INFO - PROCESS | 19528 | 22:45:08 INFO - PROCESS | 19528 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 22:45:08 INFO - PROCESS | 19528 | Values: 110.0 109.0 110.0 110.0 109.0 110.0 109.0 109.0 110.0 110.0 22:45:08 INFO - PROCESS | 19528 | 22:45:08 INFO - PROCESS | 19528 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 22:45:08 INFO - PROCESS | 19528 | Values: 148.0 146.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 146.0 22:45:08 INFO - PROCESS | 19528 | 22:45:08 INFO - PROCESS | 19528 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 22:45:08 INFO - PROCESS | 19528 | Values: 96.0 95.0 95.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 22:45:08 INFO - PROCESS | 19528 | 22:45:08 INFO - PROCESS | 19528 | [#8] json-parse-financial Cycles:10 Average:71.10 Median:70.00 stddev:3.54 (5.1%) stddev-sans-first:3.73 22:45:08 INFO - PROCESS | 19528 | Values: 70.0 69.0 76.0 71.0 70.0 70.0 69.0 79.0 68.0 69.0 22:45:08 INFO - PROCESS | 19528 | 22:45:08 INFO - PROCESS | 19528 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.00 stddev:0.97 (1.4%) stddev-sans-first:0.88 22:45:08 INFO - PROCESS | 19528 | Values: 68.0 69.0 69.0 69.0 69.0 69.0 69.0 70.0 71.0 71.0 22:45:08 INFO - PROCESS | 19528 | 22:45:08 INFO - PROCESS | 19528 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:84.50 stddev:4.24 (5.0%) stddev-sans-first:4.33 22:45:08 INFO - PROCESS | 19528 | Values: 83.0 83.0 89.0 83.0 84.0 84.0 84.0 93.0 94.0 85.0 22:45:08 INFO - PROCESS | 19528 | 22:45:08 INFO - PROCESS | 19528 | [#11] stanford-crypto-ccm Cycles:10 Average:125.30 Median:123.50 stddev:5.36 (4.3%) stddev-sans-first:5.55 22:45:08 INFO - PROCESS | 19528 | Values: 122.0 139.0 123.0 122.0 123.0 128.0 124.0 128.0 122.0 122.0 22:45:08 INFO - PROCESS | 19528 | 22:45:08 INFO - PROCESS | 19528 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.20 Median:148.00 stddev:7.30 (4.9%) stddev-sans-first:7.74 22:45:08 INFO - PROCESS | 19528 | Values: 148.0 150.0 148.0 147.0 154.0 139.0 164.0 147.0 147.0 138.0 22:45:08 INFO - PROCESS | 19528 | 22:45:08 INFO - PROCESS | 19528 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.00 stddev:1.32 (1.9%) stddev-sans-first:1.39 22:45:08 INFO - PROCESS | 19528 | Values: 70.0 72.0 69.0 69.0 70.0 70.0 69.0 70.0 70.0 73.0 22:45:08 INFO - PROCESS | 19528 | -------- Summary: end -------- 22:45:08 INFO - PROCESS | 19528 | 22:45:09 INFO - TEST-INFO | 19528: exit 0 22:45:09 INFO - TEST-OK | kraken | took 60554ms 22:45:09 INFO - TEST-START | v8_7 22:45:09 INFO - operating with platform_type : linux_ 22:45:09 INFO - Initialising browser for v8_7 test... 22:45:09 INFO - TEST-INFO | started process 19774 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzLnFr0/profile http://localhost:50523/getInfo.html) 22:45:13 INFO - PROCESS | 19774 | __metrics Screen width/height:1600/1200 22:45:13 INFO - PROCESS | 19774 | colorDepth:24 22:45:13 INFO - PROCESS | 19774 | Browser inner width/height: 1024/697 22:45:13 INFO - PROCESS | 19774 | __metrics 22:45:14 INFO - PROCESS | 19774 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:45:14 INFO - PROCESS | 19774 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:45:15 INFO - TEST-INFO | 19774: exit 0 22:45:15 INFO - Browser initialized. 22:45:15 INFO - Running cycle 1/1 for v8_7 test... 22:45:15 INFO - TEST-INFO | started process 19856 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzLnFr0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:45:26 INFO - PROCESS | 19856 | RSS: Main: 150827008 22:45:26 INFO - PROCESS | 19856 | 22:45:48 INFO - PROCESS | 19856 | Cycle 1(1): loaded http://localhost:50523/tests/v8_7/run.html (next: http://localhost:50523/tests/v8_7/run.html) 22:45:48 INFO - PROCESS | 19856 | RSS: Main: 448872448 22:45:48 INFO - PROCESS | 19856 | 22:45:48 INFO - PROCESS | 19856 | __start_tp_report 22:45:48 INFO - PROCESS | 19856 | _x_x_mozilla_page_load 22:45:48 INFO - PROCESS | 19856 | _x_x_mozilla_page_load_details 22:45:48 INFO - PROCESS | 19856 | |i|pagename|runs| 22:45:48 INFO - PROCESS | 19856 | |0;Richards;167.61649346295675 22:45:48 INFO - PROCESS | 19856 | |1;DeltaBlue;187.72292096865027 22:45:48 INFO - PROCESS | 19856 | |2;Encrypt;278.39643652561244 22:45:48 INFO - PROCESS | 19856 | |3;Decrypt;5251.308900523561 22:45:48 INFO - PROCESS | 19856 | |4;RayTrace;2012.0724346076458 22:45:48 INFO - PROCESS | 19856 | |5;Earley;813.0081300813008 22:45:48 INFO - PROCESS | 19856 | |6;Boyer;12395.061728395061 22:45:48 INFO - PROCESS | 19856 | |7;RegExp;26763.157894736843 22:45:48 INFO - PROCESS | 19856 | |8;Splay;609.3845216331505 22:45:48 INFO - PROCESS | 19856 | |9;NavierStokes;4835.748792270531 22:45:48 INFO - PROCESS | 19856 | __end_tp_report 22:45:48 INFO - PROCESS | 19856 | __startTimestamp1451457948514__endTimestamp 22:45:48 INFO - PROCESS | 19856 | 22:45:48 INFO - PROCESS | 19856 | ------- Summary: start ------- 22:45:48 INFO - PROCESS | 19856 | Number of tests: 10 22:45:48 INFO - PROCESS | 19856 | 22:45:48 INFO - PROCESS | 19856 | [#0] Richards Cycles:1 Average:167.62 Median:167.62 stddev:0.00 (0.0%) 22:45:48 INFO - PROCESS | 19856 | Values: 167.6 22:45:48 INFO - PROCESS | 19856 | 22:45:48 INFO - PROCESS | 19856 | [#1] DeltaBlue Cycles:1 Average:187.72 Median:187.72 stddev:0.00 (0.0%) 22:45:48 INFO - PROCESS | 19856 | Values: 187.7 22:45:48 INFO - PROCESS | 19856 | 22:45:48 INFO - PROCESS | 19856 | [#2] Encrypt Cycles:1 Average:278.40 Median:278.40 stddev:0.00 (0.0%) 22:45:48 INFO - PROCESS | 19856 | Values: 278.4 22:45:48 INFO - PROCESS | 19856 | 22:45:48 INFO - PROCESS | 19856 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 22:45:48 INFO - PROCESS | 19856 | Values: 5251.3 22:45:48 INFO - PROCESS | 19856 | 22:45:48 INFO - PROCESS | 19856 | [#4] RayTrace Cycles:1 Average:2012.07 Median:2012.07 stddev:0.00 (0.0%) 22:45:48 INFO - PROCESS | 19856 | Values: 2012.1 22:45:48 INFO - PROCESS | 19856 | 22:45:48 INFO - PROCESS | 19856 | [#5] Earley Cycles:1 Average:813.01 Median:813.01 stddev:0.00 (0.0%) 22:45:48 INFO - PROCESS | 19856 | Values: 813.0 22:45:48 INFO - PROCESS | 19856 | 22:45:48 INFO - PROCESS | 19856 | [#6] Boyer Cycles:1 Average:12395.06 Median:12395.06 stddev:0.00 (0.0%) 22:45:48 INFO - PROCESS | 19856 | Values: 12395.1 22:45:48 INFO - PROCESS | 19856 | 22:45:48 INFO - PROCESS | 19856 | [#7] RegExp Cycles:1 Average:26763.16 Median:26763.16 stddev:0.00 (0.0%) 22:45:48 INFO - PROCESS | 19856 | Values: 26763.2 22:45:48 INFO - PROCESS | 19856 | 22:45:48 INFO - PROCESS | 19856 | [#8] Splay Cycles:1 Average:609.38 Median:609.38 stddev:0.00 (0.0%) 22:45:48 INFO - PROCESS | 19856 | Values: 609.4 22:45:48 INFO - PROCESS | 19856 | 22:45:48 INFO - PROCESS | 19856 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 22:45:48 INFO - PROCESS | 19856 | Values: 4835.7 22:45:48 INFO - PROCESS | 19856 | -------- Summary: end -------- 22:45:48 INFO - PROCESS | 19856 | 22:45:49 INFO - TEST-INFO | 19856: exit 0 22:45:49 INFO - TEST-OK | v8_7 | took 39863ms 22:45:49 INFO - SUITE-END | took 1217s 22:45:49 INFO - Completed test suite (00:20:17) 22:45:49 INFO - Working with test: dromaeo_css 22:45:49 INFO - Generating results file: dromaeo_css 22:45:49 INFO - Working with test: kraken 22:45:49 INFO - Generating results file: kraken 22:45:49 INFO - javascript benchmark 22:45:49 INFO - Working with test: v8_7 22:45:49 INFO - Generating results file: v8_7 22:45:49 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:45:49 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 22:45:49 INFO - process_Request line: dromaeo_css 6116.20 graph.html#tests=[[72,132,35]] 22:45:49 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:45:49 INFO - process_Request line: kraken 1533.90 graph.html#tests=[[232,132,35]] 22:45:49 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:45:49 INFO - process_Request line: v8_7 19623.42 graph.html#tests=[[230,132,35]] 22:45:49 INFO - RETURN: dromaeo_css: 6116.20 22:45:49 INFO - RETURN: kraken: 1533.90 22:45:49 INFO - RETURN: v8_7: 19623.42 22:45:49 INFO - javascript benchmark 22:45:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2584.7544483274087, 2710.3224193951514, 2724.9318767030836, 2732.549129393649, 2739.246707155532, 4520.615747661453, 4621.191291523986, 4623.0, 4628.398308219931, 4634.6292296616275, 4594.74728889911, 4604.56256655618, 4719.221328480805, 4723.929141062887, 4724.126036683216, 4277.059047009653, 4311.655067594601, 4317.568243175689, 4323.0, 4329.567043295661, 4157.438745769327, 4369.497507786597, 4381.145676593065, 4382.4741031076155, 4441.733495990235, 4184.874453766407, 4230.471191101113, 4310.568943105664, 4343.587359200902, 4346.326319420495, 4238.830446782125, 4243.236217480852, 4255.085156691295, 4286.485621725382, 4295.312749959991, 4065.7560546367313, 4242.193983143224, 4261.275583150872, 4263.637590804786, 4292.527821939584, 4407.382966384709, 4426.535213802569, 4470.932936005963, 4565.497795242521, 4594.931076033862, 5023.497650234984, 5039.143345631252, 5047.596192304607, 5101.591872650216, 5103.260027296058, 4864.975675121602, 5072.365954255718, 5080.13637681595, 5083.491650834924, 5088.77100530477, 4529.682922195448, 4551.294549344857, 4553.225951588238, 4609.446866376056, 4671.27595222741, 5118.539331460186, 5119.539241468286, 5125.308083408692, 5131.486851314913, 5142.922856157086, 4723.692959957661, 4920.4833492483485, 4925.753712314442, 4932.235503496964, 4967.528084831935, 4901.264810278415, 4929.507049295042, 4929.926051109236, 4991.900161996812, 5080.542751152414, 4951.851444456672, 4953.18272485036, 4953.504649535018, 4979.651424400329, 4999.250112483084, 4917.311576379309, 4917.950820491821, 4924.532169443897, 4925.507449255046, 4971.45314015458, 4065.918681626351, 4143.958560414358, 4176.9582304176565, 4212.431321771583, 4249.213895429355, 3649.0, 3651.0, 3683.5763887152784, 3698.0939669780537, 3746.1571146492365, 4305.289627211538, 4325.891852703645, 4327.502337231259, 4363.716358436692, 4364.5635436456105, 4819.3012013257885, 4978.253262010655, 4984.576311013604, 4988.650794444354, 5006.674566153189, 4276.593723596254, 4289.463817022872, 4373.868783936487, 4378.7372757634, 4396.49440314368, 4460.77696115193, 4470.485894122217, 4473.194824931544, 4474.060447306102, 4516.638668906479, 4726.503717109654, 4732.219183834766, 4773.570378665937, 4777.8088876445245, 4824.975875120672, 4787.3537072496165, 4898.21628539432, 4904.0, 4906.55840974314, 4946.579540739078, 4738.976305118453, 4741.478437371818, 4744.1697702901165, 4765.904681906273, 4787.808487660454, 4899.608031357554, 4902.2156454967035, 4904.6566740327835, 4905.166121759238, 4955.876103097307, 4811.879703007313, 4930.5069493050405, 4935.358403407534, 4940.357753492023, 5033.446320904624, 4676.181668208118, 4683.695559788603, 4685.390899183084, 4685.6251499879245, 4690.648201384842, 4632.420947381577, 4666.370040044686, 4666.696664716783, 4669.789859456265, 4678.508756580646, 4675.929861052019, 4763.333133361263, 4788.545088216614, 4796.25658023007, 4803.903921921612, 4865.9026819464125, 4893.388326459192, 4895.412550493964, 4895.877603059952, 4937.703737775745, 4606.700564463299, 4782.617390608673, 4789.4971028041555, 4797.136515427256, 4818.229083346648], "unit": "score", "name": "dojo.html", "value": 4561.643606884735}, {"lowerIsBetter": false, "replicates": [506.0208496559158, 526.2422112158491, 533.5758072332495, 534.7566857080029, 548.4899043889184, 25759.0984315549, 26205.0, 33452.4982125268, 34023.65976340236, 34023.82988085062, 36759.816200918955, 37202.255954880886, 37280.627193728054, 37308.81345593268, 37412.62587374126, 6785.660716964157, 7552.773416797491, 7717.8070548236465, 7719.575423351714, 7720.845583088335, 6852.862942741167, 6953.304669533057, 6956.617386043766, 6964.651767411635, 9745.269104817167, 9657.082577155194, 9791.0, 9798.755031124243, 9801.0, 9805.705828825146, 9658.517074146264, 9789.706308810712, 9791.510424478747, 9795.559199836025, 9798.559064842028, 6931.1682598088555, 7000.544964577337, 9507.19188868947, 9704.0, 9898.356606820606, 33961.830190849134, 34360.82819585911, 34372.48441273383, 34387.828060859785, 34412.48381274283, 2618.2276228512633, 2626.9868650656626, 2640.1815437214523, 2652.880620372088, 2795.594638777386, 26379.467650442286, 27602.5859612106, 28746.425071498663, 28915.0, 28961.56557651637, 3194.669261859585, 3240.4005259027153, 3247.8213698246586, 3272.9345413091605, 3350.430426827421, 222935.0, 223923.88038059868, 224058.0, 224554.0, 224881.0, 49872.75063624659, 53804.0, 53910.1131460397, 54200.45799542033, 54387.45612543903, 44992.0, 57054.429455705744, 58260.0, 58310.416895831346, 58317.41682583205, 12535.686607834694, 12753.936230318976, 12807.0, 12817.807732884014, 12824.294663793395, 8568.271696905833, 8604.913950860411, 8623.698170564001, 8671.132886711279, 8682.6092825823, 17727.911360443115, 17910.641787164182, 17927.73108403349, 18527.444176674722, 18708.345207917657, 6924.446044316443, 6942.965285173542, 6951.965240173868, 7134.571925684476, 7138.0, 819.2749416766086, 823.5347028928636, 878.2359347367703, 955.6607404371487, 972.5429048347407, 26146.477070458484, 26428.207153785417, 26601.86699066531, 26715.86642066816, 26745.46509069808, 897.3763234551924, 955.2644463762864, 955.3837774635322, 974.7563109222694, 981.7398389426808, 13840.515581954583, 14071.0, 14559.636009099857, 14852.480163194236, 14858.851411485746, 258988.0, 261509.0, 263134.0, 263882.0, 264266.0, 45181.54818451839, 45562.0, 45591.54408455939, 45598.77200614042, 45781.0, 1101.5043230546287, 1107.092184408777, 1110.9055730262858, 1123.4495097402378, 1123.752774389633, 20849.0, 24892.87553562293, 25009.374765631004, 26455.470890582466, 27167.0, 34743.65256347404, 35048.824755876056, 35113.824430877685, 35131.29737405289, 35387.0, 157179.21410392874, 158369.2081539585, 158776.0, 159196.0, 159872.20063899606, 23022.42443938915, 26028.089016884318, 28521.0, 28680.569791452726, 28804.135875923756, 31976.52035219427, 32214.83892580522, 32246.355072897943, 32594.83702581472, 32993.175170619965, 30655.846720766254, 30788.0, 31209.219769505944, 31630.841845790623, 31769.20576985594, 24727.50544989126, 29537.0, 31181.53227701632, 31374.37251255008, 31595.84202078975, 28522.42955140844, 28531.857340713163, 28595.28511787222, 28836.7116328834, 28838.855805720836, 27396.45207095887, 27884.860575696992, 30012.69987300099, 30042.849785751805, 30163.547546787253, 21510.8924455383, 22646.886765566065, 22992.0, 23024.07903683834, 23039.6544051836], "unit": "score", "name": "ext.html", "value": 15951.280822037033}, {"lowerIsBetter": false, "replicates": [335.8153015841287, 337.54937158892886, 339.97960122392675, 341.17776159455707, 343.5327953982585, 12069.3965301735, 12443.626691199279, 14398.280085995697, 14552.92723536382, 14941.701165976687, 9516.809663806736, 9818.361806482573, 9835.557399917003, 14951.401943922257, 15398.153101579408, 4389.297712366022, 4507.6619253555955, 4509.098180363941, 4514.5711157440155, 4516.954830451687, 3433.5536380270655, 3868.7678739275734, 5210.739463026853, 5223.268742376071, 5226.817061402851, 5164.561012313958, 5184.455632158626, 5184.585233181337, 5190.195519694454, 5209.505097015777, 5195.40252870919, 5792.420757924174, 5793.768249270003, 5803.071508558653, 5804.680742559158, 5134.05020071288, 5143.691378517301, 5148.897022059576, 5149.176131818891, 5216.0, 11464.082873370195, 11468.139889508237, 11480.196386252966, 11484.885151148465, 12570.937145314216, 1650.7111255530235, 1675.1875340459867, 1676.773635559196, 1724.7585338052684, 1728.2309372329319, 8623.0, 8692.434991725517, 8931.196192342655, 8951.462912225288, 9104.954475227647, 1680.73108302671, 1703.3101593854508, 1734.1469570768963, 1741.4427383237369, 1782.785352842942, 53425.0, 55835.72082139563, 56702.865942681325, 57422.425775742544, 58493.41506584965, 9898.0, 9978.553109799184, 10008.599656013677, 10038.999999999854, 10047.346922450017, 12848.229106253655, 12876.871231287754, 12883.742325153631, 12885.871141288655, 12894.613161605166, 6817.250102488722, 7075.327843854826, 7087.291270872872, 7157.320054594805, 7165.6775445105095, 6865.038894554767, 6868.381845633917, 6892.207396149407, 6904.033435319059, 6914.965425172842, 3982.980085099614, 3987.760734355948, 4231.7672528010635, 4256.233877901946, 4283.657307415399, 1626.341331760639, 1661.9916900415421, 1716.3477878406375, 2785.623940768011, 2893.7974341796294, 732.1543617122232, 832.7168762620738, 848.7750746052301, 907.8275127725711, 962.3648392061345, 13290.269035202964, 15132.167730774912, 16078.598035048983, 16111.355545778271, 16161.838381616268, 758.525921299188, 761.3794757272805, 790.6125998260811, 811.0348685064754, 833.7998880268813, 8479.364047696448, 8720.389572729848, 8727.258183054384, 8820.823583528294, 9157.954210228907, 301245.0, 339957.0, 519490.0, 528072.0, 531447.0, 69047.65476172588, 69951.0, 71181.64409178024, 71817.64091179614, 72124.0, 1091.6561283195767, 1099.2085698297053, 1106.253279036647, 1118.7370967822555, 1119.345183067898, 13798.862011379757, 14709.705805884036, 14859.925700371428, 14863.033902796284, 15130.697386051997, 31669.841650791597, 32139.51790723188, 32695.50956735603, 33960.0, 35112.64887351094, 36204.63795362013, 36973.26053478861, 37015.25969480649, 37617.81191094027, 37697.43453848139, 8380.742888566763, 8568.91431085706, 8643.87034194475, 8650.480971141751, 8652.78368040804, 10137.797244055226, 10226.335288206243, 12866.0, 16231.51305460838, 16565.58586035359, 12651.367431628198, 12770.744585108432, 13226.470941162246, 14063.085899416505, 14344.641383965485, 13648.181109133484, 13692.520761773689, 13778.242196679279, 13992.440302387791, 14035.649108771953, 10622.937706229624, 11016.283941543774, 13043.413046412745, 13884.51404200848, 13975.930120349332, 8372.0, 8660.047394786443, 8660.307175425825, 8662.0, 8672.609732562176, 9170.495622740813, 9275.953620231856, 9750.75623109428, 14331.498397556035, 14338.784918226027], "unit": "score", "name": "jquery.html", "value": 7936.556330147647}, {"lowerIsBetter": false, "replicates": [1222.5904322052113, 1409.3305679802093, 1409.7532931736946, 1506.7890495330648, 1725.4047353662982, 6001.189839371684, 6130.662813545253, 6917.273686262945, 7019.68411421486, 7022.754203602875, 6792.966035169829, 6796.3203679632015, 6864.725410983568, 6867.278935711754, 6878.174619045709, 2044.8875311857842, 2068.4518602570256, 2075.0, 2078.864873783207, 2079.261862038977, 2091.5398612305266, 2096.5282811367474, 2109.5253567947243, 2146.0450099705636, 2160.373491687417, 2042.7957204279528, 2076.6677331626943, 2101.726775519188, 2104.4844013216707, 2104.6527322991687, 2063.0, 2077.6779599162155, 2083.322920050982, 2084.4163634182455, 2085.7705652378227, 2053.938381848547, 2090.028136916326, 2092.246791155183, 2105.768365479796, 2106.65240235361, 7102.360787529095, 7167.390771784405, 7187.568745875212, 7189.281071892821, 7196.0, 4115.691323150746, 4191.245575796355, 4205.789710514462, 4208.0, 4215.051613386994, 2669.305980445079, 2697.568389057761, 2708.5801700736415, 2744.2590500564734, 2753.6420265365373, 848.2535368875411, 857.1771099744253, 860.3590325207698, 873.7243624308517, 878.7934835313696, 9302.86045709315, 9361.578728957213, 9385.624575016991, 9431.292653051049, 9438.103380178873, 3749.531308586427, 3756.3238617048646, 3836.3861782114727, 3847.826847791856, 3857.72995890285, 7972.0, 8001.039875214895, 8005.679772809139, 8013.5191888485715, 8022.919770802334, 4049.7367671101283, 4061.2283666103344, 4064.4919385076864, 4095.672346212296, 4110.0, 3328.8668453262085, 3406.9488957665653, 3740.214554943492, 3769.792661403594, 3789.696824254053, 3380.966190338065, 3403.8127902965575, 3422.5550678412146, 3436.6563343665434, 3448.20691241016, 1076.1175835814556, 1083.1334932054326, 1088.7495875948575, 1096.5175322857917, 1102.6471529110609, 1099.1866019145775, 1108.2851560743275, 1127.6504283672089, 1128.4245035032193, 1131.1911982932243, 6337.746490140435, 6542.051402546604, 6566.770163044366, 6567.0, 6578.27638959714, 1093.9006298669785, 1104.0836106031975, 1104.3318792130806, 1116.5198964445203, 1130.5647325779635, 5227.294315267466, 5286.048511268009, 5298.894022119536, 5301.946980530145, 5303.496167864047, 8176.509409435453, 8198.631061602242, 8315.750527484186, 8417.957910210409, 8434.198751118634, 8271.421000530025, 8283.420160588701, 8301.46040507365, 8308.54303013328, 8362.331013519026, 6685.699143538553, 6798.320167983261, 6855.211650660238, 6882.449404047664, 6887.9999999999, 6535.44448721864, 6543.5419520635005, 6563.474922006132, 6564.376384243489, 6564.6389448580785, 7571.848563028819, 7777.494462859896, 7783.377329813715, 7789.922100778919, 7913.723019694514, 7850.0972388173805, 7944.245296696805, 8034.638441270274, 8064.274215320649, 8078.23256790604, 5110.923336149886, 5207.635465517377, 5215.947840521546, 5930.851728706644, 6041.607295525777, 6001.879962400641, 6668.166479190101, 6678.83302917431, 6692.0, 6699.296573859675, 6103.328633850184, 6279.246490421178, 6428.453581445442, 6448.613083215022, 6456.289808121197, 6261.499080073492, 6284.371562843862, 6303.621782693053, 6405.295417503978, 6409.551331406757, 6351.714172862325, 6390.105385245976, 6392.648404337806, 6393.1688880445245, 6399.136116624382, 5699.316082070178, 5727.226824378822, 5745.2818397700285, 5746.396628353963, 5748.798792042258, 5705.201271821865, 5830.096335068071, 5834.212381328466, 5848.736806843617, 5850.561207909339], "unit": "score", "name": "mootools.html", "value": 4048.803519797945}, {"lowerIsBetter": false, "replicates": [314.3289077818856, 316.29781884217033, 319.0492332848114, 322.86116969703016, 323.11144353029175, 5223.477652234779, 5233.241180028894, 5271.2356708277275, 5273.261743355928, 5277.973610131949, 5234.581233501321, 5252.212168174776, 5252.65857719248, 5253.921191182126, 5263.4210236874005, 3901.1807520420743, 3971.046948732298, 4020.6582440492593, 4157.771322577257, 4162.042730172055, 4127.380892866079, 4149.9792501037455, 4152.896177595554, 4158.9376159357635, 4166.64583510402, 4111.629953304202, 4115.032967252693, 4121.526024507175, 4121.8969525761795, 4128.360104183841, 3892.766434013954, 3981.6615587675083, 3990.840366385341, 4075.572064933169, 4098.856540021085, 3615.204654975901, 3626.963730362689, 3631.1829838286176, 3631.8184090795353, 3643.0528062703625, 4944.9258261126115, 4993.0, 5002.824901128443, 5011.949880501221, 5013.874653133665, 4759.286107083931, 4764.380630518011, 4769.689970151963, 4773.594244489223, 4774.212254977924, 5386.407495175527, 5529.281193444866, 5540.778368865241, 5543.417941116165, 5551.555875529948, 3953.940690889639, 3969.583193764642, 3969.7419667721506, 3973.523177218752, 3973.7417067890783, 5795.681237531934, 5867.735951882176, 5869.589128760946, 5871.412858714094, 5879.764809407661, 4095.1400205957084, 4095.9385609215888, 4096.774677392712, 4098.262312783728, 4117.238310912491, 3958.089639382958, 4094.467719196485, 4116.938245926313, 4165.083681590046, 4175.478065241845, 4671.883202919954, 4676.976615116971, 4677.111348843709, 4677.906441871143, 4685.718856868531, 5519.8896022080135, 5540.750666220029, 5544.140658197985, 5549.611527193058, 5551.805686800943, 1420.6093324335684, 1445.075151902783, 1445.2195814260392, 1445.3423692220015, 1447.3993292783377, 950.3727539823822, 950.8954015058338, 961.3318743473219, 976.8339382305026, 982.1651596143221, 4924.3352147460355, 4928.704277743347, 4932.8520144395725, 4938.358013458299, 4939.604831613534, 5761.107028410603, 5764.048931926269, 5766.192733017381, 5766.94233057664, 5768.798092066758, 4918.704877707349, 4920.0, 4924.507549245119, 4924.532169443897, 4925.901481970341, 2872.339361946722, 2972.554116882485, 3053.2519532714628, 3060.969390306113, 3090.5364195370876, 5427.0773968425465, 5514.09017512106, 5518.944810551923, 5528.977139229255, 5530.142827861688, 5942.257217847769, 5947.286325640865, 5947.940520594825, 5955.493783028404, 5966.284045914518, 5513.0, 5513.448655134454, 5514.420985796514, 5515.117581186991, 5524.281843360337, 5609.859753506195, 5691.914621280767, 5740.598158129058, 5767.480926716616, 5797.159411885169, 5660.094384898561, 5668.348139963957, 5669.0, 5671.829845104653, 5672.971635141798, 5529.640573362719, 5532.557395408277, 5534.695591742493, 5535.640183388067, 5536.2249285100925, 3916.3538016227003, 4016.7389119707127, 4050.959490405058, 4055.0673345130194, 4057.5130984282073, 5694.430556944272, 5705.771769129188, 5742.224799651994, 5772.480476757112, 5774.740136693943, 5517.5585953124455, 5559.610827242216, 5563.8887222256135, 5564.944350556442, 5569.220309156641, 5515.7242137893745, 5519.503244707996, 5523.088690366045, 5524.91712624319, 5530.529904957963, 5308.654937429054, 5375.758090885998, 5408.215808707794, 5412.1340585507705, 5413.485718856702, 5573.331200255995, 5588.30146231721, 5588.804391846266, 5592.944070559405, 5595.63628364155, 5243.737813109406, 5330.253764472899, 5415.620906536662, 5457.126859702428, 5460.2355670207], "unit": "score", "name": "prototype.html", "value": 4192.698789415677}, {"lowerIsBetter": false, "replicates": [723.8877973914043, 735.1692587376264, 736.5563495548728, 751.6091632351175, 771.9228077192284, 11022.228444008913, 11187.6643700689, 11206.15953803465, 11209.439528023586, 11220.382878941655, 10097.343672661273, 10678.25252232342, 10748.247622666417, 10757.193210509224, 10780.353178809277, 597.14011822975, 763.9465237433382, 764.9617519124049, 765.1201118713496, 765.2271206081841, 764.9732259370924, 771.2518856709012, 772.7720322504847, 774.3418094619584, 774.3456779021745, 793.4485532554877, 793.7380664380769, 797.2067792546395, 797.2505844506175, 797.3501596199109, 791.3155120820448, 796.8645330293864, 797.0077253819004, 797.182887540273, 797.2386371015696, 588.3381196154327, 589.3075636127533, 589.5224867857049, 589.5313225985352, 589.631480324797, 9864.112229899272, 9973.451460169688, 9975.102240798364, 9979.950100249525, 9993.200543956465, 8836.160564746338, 9634.42193468387, 9721.756956076084, 9747.220222382264, 9852.65515706954, 7968.163342848975, 8301.709440169625, 8309.95845020771, 8320.583970801496, 8359.958200209021, 2990.745786608141, 3040.619922509686, 3047.9847600761855, 3097.132802815215, 3121.297708015701, 33680.49479257813, 33783.15542111467, 37687.05782355436, 37915.05212369685, 38338.80830595857, 9485.288603354638, 9519.762005949768, 9539.952300238594, 9697.224222062217, 9952.402855828528, 16116.919415402848, 16163.919180404022, 16170.191490425432, 16174.838251617333, 16201.756973645404, 6209.689515524296, 6335.144755458046, 6345.777897773556, 6441.355864413521, 6538.673066346663, 3403.4724617684296, 3435.1927297085167, 3482.8084455355197, 3495.143689796016, 3520.9647903520636, 2677.9598306025423, 2704.6889607694975, 2706.972930270672, 2708.1469337159124, 2712.850793206353, 473.4247888815106, 474.20097136325404, 478.273025001995, 487.765872381259, 488.9437714662788, 367.2599711581166, 393.1365328343688, 402.5953916314086, 411.41168129574993, 415.6757728971407, 6583.473322134218, 6868.759593414206, 6918.723251070001, 6944.861102778017, 6951.93048069523, 409.33891764799637, 489.98775030623807, 503.5442924153647, 512.9307543481657, 520.7630528109701, 3439.174598096439, 3555.4133567961, 3589.4974703541525, 3595.334863050344, 3820.522434695663, 40337.59662403397, 41240.79379603143, 41391.58608413878, 41465.1706965859, 41613.58386416158, 36557.817210914305, 36883.815580921924, 42844.0, 43182.56817431848, 43241.783791080845, 31494.685053149635, 32550.0, 37059.81470092632, 41263.58736412657, 41295.380569290886, 6930.410915072275, 7133.357997780225, 7164.426845852215, 7370.5946172961, 7525.887111693439, 30032.549511757778, 30302.0, 30845.537316939815, 31760.205994850312, 31986.6801331993, 33207.833960830045, 35896.28207435889, 39875.60124398719, 42955.35566966561, 43375.0, 9249.953750231205, 9793.167580755715, 9821.410715357102, 10342.069213770797, 10698.518566664363, 10456.63401780934, 10537.051665350155, 10584.153267738717, 10851.348919064882, 11173.88826111761, 9466.290028247771, 9694.951525242328, 9881.20950323958, 9995.850062249217, 10536.0, 10063.547140378554, 10175.28772985884, 10190.592376304865, 10201.948990255001, 10265.692029239135, 9805.509724513604, 10001.249906256915, 10048.296619236875, 10082.798344032932, 10091.646792362231, 8782.165694259034, 8818.735437936872, 8946.955265223633, 9307.488088154945, 9352.158305752515, 8121.309688676292, 8375.162483751576, 8429.367797415096, 8532.146785321418, 8618.655253789779], "unit": "score", "name": "yui.html", "value": 5339.207821594298}], "name": "dromaeo_css", "value": 6116.198639970137}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 115.0, 108.0, 113.0, 114.0, 113.0, 100.0, 113.0, 113.0, 102.0], "unit": "score", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [162.0, 144.0, 152.0, 164.0, 137.0, 156.0, 154.0, 134.0, 166.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 150.1}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 162.0, 160.0, 160.0, 163.0, 162.0, 161.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 88.0, 90.0, 73.0, 72.0, 73.0, 109.0, 87.0, 73.0], "unit": "score", "name": "audio-fft", "value": 81.1}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 140.0, 100.0, 97.0, 97.0, 134.0, 97.0, 97.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 76.0, 71.0, 70.0, 70.0, 69.0, 79.0, 68.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 71.1}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 70.0, 71.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 89.0, 83.0, 84.0, 84.0, 84.0, 93.0, 94.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.2}, {"lowerIsBetter": true, "replicates": [122.0, 139.0, 123.0, 122.0, 123.0, 128.0, 124.0, 128.0, 122.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.3}, {"lowerIsBetter": true, "replicates": [148.0, 150.0, 148.0, 147.0, 154.0, 139.0, 164.0, 147.0, 147.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.2}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 69.0, 69.0, 70.0, 70.0, 69.0, 70.0, 70.0, 73.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.2}], "name": "kraken", "value": 1533.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.61649346295675], "unit": "score", "name": "Richards", "value": 210.61173199999993}, {"lowerIsBetter": false, "replicates": [187.72292096865027], "unit": "score", "name": "DeltaBlue", "value": 352.210586}, {"lowerIsBetter": false, "replicates": [278.39643652561244], "unit": "score", "name": "Encrypt", "value": 956.1221520000003}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [2012.0724346076458], "unit": "score", "name": "RayTrace", "value": 367.77453300000013}, {"lowerIsBetter": false, "replicates": [813.0081300813008], "unit": "score", "name": "Earley", "value": 819.7494899999999}, {"lowerIsBetter": false, "replicates": [12395.061728395061], "unit": "score", "name": "Boyer", "value": 53.768429282868496}, {"lowerIsBetter": false, "replicates": [26763.157894736843], "unit": "score", "name": "RegExp", "value": 34.0387708947886}, {"lowerIsBetter": false, "replicates": [609.3845216331505], "unit": "score", "name": "Splay", "value": 133.72673099999997}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19623.42039988826}]} 22:45:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19623.42"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1533.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6116.20"}}} 22:45:49 INFO - Return code: 0 22:45:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:45:49 INFO - # TBPL SUCCESS # 22:45:49 INFO - Running post-action listener: _resource_record_post_action 22:45:49 INFO - Running post-run listener: _resource_record_post_run 22:45:51 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 28672; Write bytes: 546508800; Read time: 24; Write time: 422632 22:45:51 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 227512320; Read time: 0; Write time: 203608 22:45:51 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 28672; Write bytes: 318619648; Read time: 24; Write time: 219004 22:45:51 INFO - Running post-run listener: _upload_blobber_files 22:45:51 INFO - Blob upload gear active. 22:45:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:45:51 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 22:45:51 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'] 22:45:51 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 22:45:51 INFO - (blobuploader) - INFO - Open directory for files ... 22:45:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:45:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:45:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:45:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:45:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:45:52 INFO - (blobuploader) - INFO - Done attempting. 22:45:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:45:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:45:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:45:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:45:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:45:52 INFO - (blobuploader) - INFO - Done attempting. 22:45:52 INFO - (blobuploader) - INFO - Iteration through files over. 22:45:52 INFO - Return code: 0 22:45:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:45:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:45:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ff8bc392d9c4c1672548c8530451cde026af77b8e1e09715d414e22d7261abcdd4bd8fd15a4a202ecf3c62da3e527fcb91eeb7312a027e03a090cbe35ad1d17a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dcd960af19d2884f7f8d8a0eeeb907883e7a4ee685263f7363bfba0ac496a457d1ee4b786cb78fa34f873357fa02e047b8c296310e93b365f727a19730372a91"} 22:45:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:45:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:45:52 INFO - Contents: 22:45:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ff8bc392d9c4c1672548c8530451cde026af77b8e1e09715d414e22d7261abcdd4bd8fd15a4a202ecf3c62da3e527fcb91eeb7312a027e03a090cbe35ad1d17a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dcd960af19d2884f7f8d8a0eeeb907883e7a4ee685263f7363bfba0ac496a457d1ee4b786cb78fa34f873357fa02e047b8c296310e93b365f727a19730372a91"} 22:45:52 INFO - Copying logs to upload dir... 22:45:52 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1285.782754 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2015-12-29 22:45:51.765832) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 22:45:51.773636) ========= 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=d3f2be9b0713ec03b22325b2000001be-1451444517.521689-948692660 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/ff8bc392d9c4c1672548c8530451cde026af77b8e1e09715d414e22d7261abcdd4bd8fd15a4a202ecf3c62da3e527fcb91eeb7312a027e03a090cbe35ad1d17a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dcd960af19d2884f7f8d8a0eeeb907883e7a4ee685263f7363bfba0ac496a457d1ee4b786cb78fa34f873357fa02e047b8c296310e93b365f727a19730372a91"} build_url:https://queue.taskcluster.net/v1/task/kF9lWKrhQjSIYmWqxh1jZA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011501 build_url: 'https://queue.taskcluster.net/v1/task/kF9lWKrhQjSIYmWqxh1jZA/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/ff8bc392d9c4c1672548c8530451cde026af77b8e1e09715d414e22d7261abcdd4bd8fd15a4a202ecf3c62da3e527fcb91eeb7312a027e03a090cbe35ad1d17a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dcd960af19d2884f7f8d8a0eeeb907883e7a4ee685263f7363bfba0ac496a457d1ee4b786cb78fa34f873357fa02e047b8c296310e93b365f727a19730372a91"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 22:45:51.801558) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:45:51.801936) ========= 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=d3f2be9b0713ec03b22325b2000001be-1451444517.521689-948692660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004578 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 22:45:51.888403) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 22:45:51.892802) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 22:45:51.893269) ========= ========= Total master_lag: 0.28 =========