builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-014 starttime: 1453322712.57 results: success (0) buildid: 20160120120527 builduid: 4d87dddaf649492a906c5dc7a335844b revision: 55dd1f2654bdf945bdb9300abaac4c0b4ac0abd3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 12:45:12.567467) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 12:45:12.568205) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 12:45:12.568519) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006373 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 12:45:12.593920) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 12:45:12.594228) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 12:45:12.608281) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:45:12.608595) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004638 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:45:12.666000) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 12:45:12.666267) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 12:45:12.666603) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:45:12.666882) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-20 12:45:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 28.8M=0s 2016-01-20 12:45:13 (28.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163413 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:45:12.842287) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:45:12.842569) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022240 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:45:12.891801) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:45:12.892118) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 55dd1f2654bdf945bdb9300abaac4c0b4ac0abd3 --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 55dd1f2654bdf945bdb9300abaac4c0b4ac0abd3 --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=fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-20 12:45:13,474 truncating revision to first 12 chars 2016-01-20 12:45:13,474 Setting DEBUG logging. 2016-01-20 12:45:13,475 attempt 1/10 2016-01-20 12:45:13,475 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/55dd1f2654bd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-20 12:45:13,734 unpacking tar archive at: fx-team-55dd1f2654bd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.550716 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 12:45:13.455136) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 12:45:13.455441) ========= echo 55dd1f2654bdf945bdb9300abaac4c0b4ac0abd3 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'55dd1f2654bdf945bdb9300abaac4c0b4ac0abd3'] 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=fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 55dd1f2654bdf945bdb9300abaac4c0b4ac0abd3 program finished with exit code 0 elapsedTime=0.004703 script_repo_revision: '55dd1f2654bdf945bdb9300abaac4c0b4ac0abd3' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 12:45:13.505598) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 12:45:13.505882) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 12:45:13.517803) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 12:45:13.518069) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/55dd1f2654bdf945bdb9300abaac4c0b4ac0abd3 ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 12:45:13.518425) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-20 12:45:13.518706) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:45:14 INFO - MultiFileLogger online at 20160120 12:45:14 in /builds/slave/test 12:45:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 12:45:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:45:14 INFO - {'append_to_log': False, 12:45:14 INFO - 'base_work_dir': '/builds/slave/test', 12:45:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:45:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:45:14 INFO - 'branch': 'Fx-Team-Non-PGO', 12:45:14 INFO - 'buildbot_json_path': 'buildprops.json', 12:45:14 INFO - 'config_files': ('talos/linux_config.py',), 12:45:14 INFO - 'default_actions': ('clobber', 12:45:14 INFO - 'read-buildbot-config', 12:45:14 INFO - 'download-and-extract', 12:45:14 INFO - 'populate-webroot', 12:45:14 INFO - 'create-virtualenv', 12:45:14 INFO - 'install', 12:45:14 INFO - 'run-tests'), 12:45:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:45:14 INFO - 'download_minidump_stackwalk': True, 12:45:14 INFO - 'download_symbols': 'ondemand', 12:45:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:45:14 INFO - 'tooltool.py': '/tools/tooltool.py', 12:45:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:45:14 INFO - '/tools/misc-python/virtualenv.py')}, 12:45:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:45:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:45:14 INFO - 'installer_path': 'installer.exe', 12:45:14 INFO - 'log_level': 'info', 12:45:14 INFO - 'log_name': 'talos', 12:45:14 INFO - 'log_to_console': True, 12:45:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:45:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:45:14 INFO - 'opt_config_files': (), 12:45:14 INFO - 'pip_index': False, 12:45:14 INFO - 'sps_profile': False, 12:45:14 INFO - 'sps_profile_interval': 0, 12:45:14 INFO - 'suite': 'dromaeojs-e10s', 12:45:14 INFO - 'system_bits': '32', 12:45:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:45:14 INFO - 'title': 'talos-linux64-ix-014', 12:45:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:45:14 INFO - 'use_talos_json': True, 12:45:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:45:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:45:14 INFO - 'work_dir': 'build'} 12:45:14 INFO - ##### 12:45:14 INFO - ##### Running clobber step. 12:45:14 INFO - ##### 12:45:14 INFO - Running pre-action listener: _resource_record_pre_action 12:45:14 INFO - Running main action method: clobber 12:45:14 INFO - rmtree: /builds/slave/test/build 12:45:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:45:14 INFO - Running post-action listener: _resource_record_post_action 12:45:14 INFO - ##### 12:45:14 INFO - ##### Running read-buildbot-config step. 12:45:14 INFO - ##### 12:45:14 INFO - Running pre-action listener: _resource_record_pre_action 12:45:14 INFO - Running main action method: read_buildbot_config 12:45:14 INFO - Using buildbot properties: 12:45:14 INFO - { 12:45:14 INFO - "project": "", 12:45:14 INFO - "product": "firefox", 12:45:14 INFO - "script_repo_revision": "production", 12:45:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:45:14 INFO - "repository": "", 12:45:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 12:45:14 INFO - "buildid": "20160120120527", 12:45:14 INFO - "pgo_build": "False", 12:45:14 INFO - "basedir": "/builds/slave/test", 12:45:14 INFO - "buildnumber": 721, 12:45:14 INFO - "slavename": "talos-linux64-ix-014", 12:45:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:45:14 INFO - "platform": "ubuntu64_hw", 12:45:14 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:45:14 INFO - "branch": "fx-team", 12:45:14 INFO - "repo_path": "integration/fx-team", 12:45:14 INFO - "revision": "55dd1f2654bdf945bdb9300abaac4c0b4ac0abd3", 12:45:14 INFO - "stage_platform": "linux64", 12:45:14 INFO - "builduid": "4d87dddaf649492a906c5dc7a335844b", 12:45:14 INFO - "slavebuilddir": "test" 12:45:14 INFO - } 12:45:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/CX5usBX_SGqRO9M5w1uBIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 12:45:14 INFO - Running post-action listener: _resource_record_post_action 12:45:14 INFO - ##### 12:45:14 INFO - ##### Running download-and-extract step. 12:45:14 INFO - ##### 12:45:14 INFO - Running pre-action listener: _resource_record_pre_action 12:45:14 INFO - Running main action method: download_and_extract 12:45:14 INFO - mkdir: /builds/slave/test/build/tests 12:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:14 INFO - https://queue.taskcluster.net/v1/task/CX5usBX_SGqRO9M5w1uBIg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:45:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CX5usBX_SGqRO9M5w1uBIg/artifacts/public/build/test_packages.json 12:45:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CX5usBX_SGqRO9M5w1uBIg/artifacts/public/build/test_packages.json 12:45:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CX5usBX_SGqRO9M5w1uBIg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:45:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CX5usBX_SGqRO9M5w1uBIg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:45:15 INFO - Downloaded 1448 bytes. 12:45:15 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:45:15 INFO - Using the following test package requirements: 12:45:15 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:45:15 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:45:15 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:45:15 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:15 INFO - u'jsshell-linux-x86_64.zip'], 12:45:15 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:45:15 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:45:15 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:45:15 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:45:15 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:45:15 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:45:15 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:45:15 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:45:15 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')]} 12:45:15 INFO - https://queue.taskcluster.net/v1/task/CX5usBX_SGqRO9M5w1uBIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:45:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CX5usBX_SGqRO9M5w1uBIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:45:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CX5usBX_SGqRO9M5w1uBIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:45:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CX5usBX_SGqRO9M5w1uBIg/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 12:45:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CX5usBX_SGqRO9M5w1uBIg/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 12:45:16 INFO - Downloaded 21217723 bytes. 12:45:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:45:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:45:17 INFO - Return code: 0 12:45:17 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 12:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:17 INFO - https://queue.taskcluster.net/v1/task/CX5usBX_SGqRO9M5w1uBIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:45:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CX5usBX_SGqRO9M5w1uBIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:45:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CX5usBX_SGqRO9M5w1uBIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:45:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CX5usBX_SGqRO9M5w1uBIg/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 12:45:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CX5usBX_SGqRO9M5w1uBIg/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 12:45:19 INFO - Downloaded 21217723 bytes. 12:45:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:45:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:45:20 INFO - Return code: 0 12:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:20 INFO - https://queue.taskcluster.net/v1/task/CX5usBX_SGqRO9M5w1uBIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:45:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CX5usBX_SGqRO9M5w1uBIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:45:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CX5usBX_SGqRO9M5w1uBIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:45:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CX5usBX_SGqRO9M5w1uBIg/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 12:45:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CX5usBX_SGqRO9M5w1uBIg/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 12:45:21 INFO - Downloaded 11132144 bytes. 12:45:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:45:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:45:21 INFO - Return code: 0 12:45:21 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')]} 12:45:21 INFO - https://queue.taskcluster.net/v1/task/CX5usBX_SGqRO9M5w1uBIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:45:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CX5usBX_SGqRO9M5w1uBIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:45:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CX5usBX_SGqRO9M5w1uBIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:45:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CX5usBX_SGqRO9M5w1uBIg/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 12:45:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CX5usBX_SGqRO9M5w1uBIg/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 12:45:23 INFO - Downloaded 54189883 bytes. 12:45:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CX5usBX_SGqRO9M5w1uBIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:45:23 INFO - mkdir: /builds/slave/test/properties 12:45:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:45:23 INFO - Writing to file /builds/slave/test/properties/build_url 12:45:23 INFO - Contents: 12:45:23 INFO - build_url:https://queue.taskcluster.net/v1/task/CX5usBX_SGqRO9M5w1uBIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:45:23 INFO - Running post-action listener: _resource_record_post_action 12:45:23 INFO - Running post-action listener: set_extra_try_arguments 12:45:23 INFO - ##### 12:45:23 INFO - ##### Running populate-webroot step. 12:45:23 INFO - ##### 12:45:23 INFO - Running pre-action listener: _resource_record_pre_action 12:45:23 INFO - Running main action method: populate_webroot 12:45:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:45:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:45:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:45:23 INFO - '--tppagecycles', 12:45:23 INFO - '7'], 12:45:23 INFO - 'tests': ['tsvgm']}}, 12:45:23 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:45:23 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:45:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:45:23 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:45:23 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:45:23 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:45:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:45:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:23 INFO - 'talos_options': ['--e10s'], 12:45:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:45:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:23 INFO - 'tests': ['damp', 'tps']}, 12:45:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:23 INFO - 'talos_options': ['--e10s'], 12:45:23 INFO - 'tests': ['damp', 'tps']}, 12:45:23 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:45:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:45:23 INFO - 'other': {'tests': ['a11yr', 12:45:23 INFO - 'ts_paint', 12:45:23 INFO - 'tpaint', 12:45:23 INFO - 'sessionrestore', 12:45:23 INFO - 'sessionrestore_no_auto_restore']}, 12:45:23 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:45:23 INFO - 'tests': ['a11yr', 12:45:23 INFO - 'ts_paint', 12:45:23 INFO - 'tpaint', 12:45:23 INFO - 'sessionrestore', 12:45:23 INFO - 'sessionrestore_no_auto_restore']}, 12:45:23 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:45:23 INFO - 'tests': ['a11yr', 12:45:23 INFO - 'ts_paint', 12:45:23 INFO - 'tpaint', 12:45:23 INFO - 'sessionrestore', 12:45:23 INFO - 'sessionrestore_no_auto_restore']}, 12:45:23 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:45:23 INFO - 'tests': ['a11yr', 12:45:23 INFO - 'ts_paint', 12:45:23 INFO - 'tpaint', 12:45:23 INFO - 'sessionrestore', 12:45:23 INFO - 'sessionrestore_no_auto_restore']}, 12:45:23 INFO - 'other_l64': {'tests': ['a11yr', 12:45:23 INFO - 'ts_paint', 12:45:23 INFO - 'tpaint', 12:45:23 INFO - 'sessionrestore', 12:45:23 INFO - 'sessionrestore_no_auto_restore']}, 12:45:23 INFO - 'other_nol64': {'tests': ['a11yr', 12:45:23 INFO - 'ts_paint', 12:45:23 INFO - 'tpaint', 12:45:23 INFO - 'sessionrestore', 12:45:23 INFO - 'sessionrestore_no_auto_restore']}, 12:45:23 INFO - 'svgr': {'tests': ['tsvgx', 12:45:23 INFO - 'tsvgr_opacity', 12:45:23 INFO - 'tart', 12:45:23 INFO - 'tscrollx', 12:45:23 INFO - 'cart']}, 12:45:23 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:45:23 INFO - 'tests': ['tsvgx', 12:45:23 INFO - 'tsvgr_opacity', 12:45:23 INFO - 'tart', 12:45:23 INFO - 'tscrollx', 12:45:23 INFO - 'cart']}, 12:45:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:23 INFO - 'tests': ['tp5o']}, 12:45:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:23 INFO - 'talos_options': ['--e10s'], 12:45:23 INFO - 'tests': ['tp5o']}, 12:45:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:23 INFO - 'talos_options': ['--xperf_path', 12:45:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:45:23 INFO - 'tests': ['tp5n']}, 12:45:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:45:23 INFO - 'talos_options': ['--e10s', 12:45:23 INFO - '--xperf_path', 12:45:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:45:23 INFO - 'tests': ['tp5n']}}, 12:45:23 INFO - 'talos.zip': {'path': '', 12:45:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:45:23 INFO - Running post-action listener: _resource_record_post_action 12:45:23 INFO - ##### 12:45:23 INFO - ##### Running create-virtualenv step. 12:45:23 INFO - ##### 12:45:23 INFO - Running pre-action listener: _resource_record_pre_action 12:45:23 INFO - Running main action method: create_virtualenv 12:45:23 INFO - Creating virtualenv /builds/slave/test/build/venv 12:45:23 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 12:45:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:45:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:45:23 INFO - Using real prefix '/usr' 12:45:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:45:24 INFO - Installing distribute.............................................................................................................................................................................................done. 12:45:26 INFO - Installing pip.................done. 12:45:26 INFO - Return code: 0 12:45:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:45:26 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')]} 12:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:26 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')]} 12:45:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f689f150f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1113dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a63d0>, '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 0x1111ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1112360>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886', '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 12:45:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 12:45:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 12:45:26 INFO - Using env: {'DISPLAY': ':0', 12:45:26 INFO - 'HOME': '/home/cltbld', 12:45:26 INFO - 'LANG': 'en_US.UTF-8', 12:45:26 INFO - 'LANGUAGE': 'en_US:en', 12:45:26 INFO - 'LOGNAME': 'cltbld', 12:45:26 INFO - 'MAIL': '/var/mail/cltbld', 12:45:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:26 INFO - 'MOZ_NO_REMOTE': '1', 12:45:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:26 INFO - 'NO_EM_RESTART': '1', 12:45:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:26 INFO - 'PWD': '/builds/slave/test', 12:45:26 INFO - 'SHELL': '/bin/bash', 12:45:26 INFO - 'SHLVL': '1', 12:45:26 INFO - 'TERM': 'linux', 12:45:26 INFO - 'TMOUT': '86400', 12:45:26 INFO - 'USER': 'cltbld', 12:45:26 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886', 12:45:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:26 INFO - '_': '/tools/buildbot/bin/python'} 12:45:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:26 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 12:45:26 INFO - Cleaning up... 12:45:26 INFO - Return code: 0 12:45:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:45:26 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')]} 12:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:26 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')]} 12:45:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f689f150f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1113dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a63d0>, '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 0x1111ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1112360>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886', '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 12:45:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 12:45:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 12:45:26 INFO - Using env: {'DISPLAY': ':0', 12:45:26 INFO - 'HOME': '/home/cltbld', 12:45:26 INFO - 'LANG': 'en_US.UTF-8', 12:45:26 INFO - 'LANGUAGE': 'en_US:en', 12:45:26 INFO - 'LOGNAME': 'cltbld', 12:45:26 INFO - 'MAIL': '/var/mail/cltbld', 12:45:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:26 INFO - 'MOZ_NO_REMOTE': '1', 12:45:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:26 INFO - 'NO_EM_RESTART': '1', 12:45:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:26 INFO - 'PWD': '/builds/slave/test', 12:45:26 INFO - 'SHELL': '/bin/bash', 12:45:26 INFO - 'SHLVL': '1', 12:45:26 INFO - 'TERM': 'linux', 12:45:26 INFO - 'TMOUT': '86400', 12:45:26 INFO - 'USER': 'cltbld', 12:45:26 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886', 12:45:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:26 INFO - '_': '/tools/buildbot/bin/python'} 12:45:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:26 INFO - Downloading/unpacking psutil>=0.7.1 12:45:26 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 12:45:26 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 12:45:26 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 12:45:26 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 12:45:26 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 12:45:26 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 12:45:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:45:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:45:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:45:28 INFO - Installing collected packages: psutil 12:45:28 INFO - Running setup.py install for psutil 12:45:28 INFO - building 'psutil._psutil_linux' extension 12:45:28 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 12:45:28 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 12:45:28 INFO - building 'psutil._psutil_posix' extension 12:45:28 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 12:45:28 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 12:45:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:45:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:45:28 INFO - Successfully installed psutil 12:45:28 INFO - Cleaning up... 12:45:28 INFO - Return code: 0 12:45:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:45: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')]} 12:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45: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')]} 12:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f689f150f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1113dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a63d0>, '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 0x1111ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1112360>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886', '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 12:45:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 12:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 12:45:28 INFO - Using env: {'DISPLAY': ':0', 12:45:28 INFO - 'HOME': '/home/cltbld', 12:45:28 INFO - 'LANG': 'en_US.UTF-8', 12:45:28 INFO - 'LANGUAGE': 'en_US:en', 12:45:28 INFO - 'LOGNAME': 'cltbld', 12:45:28 INFO - 'MAIL': '/var/mail/cltbld', 12:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:28 INFO - 'MOZ_NO_REMOTE': '1', 12:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:28 INFO - 'NO_EM_RESTART': '1', 12:45:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:28 INFO - 'PWD': '/builds/slave/test', 12:45:28 INFO - 'SHELL': '/bin/bash', 12:45:28 INFO - 'SHLVL': '1', 12:45:28 INFO - 'TERM': 'linux', 12:45:28 INFO - 'TMOUT': '86400', 12:45:28 INFO - 'USER': 'cltbld', 12:45:28 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886', 12:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:28 INFO - '_': '/tools/buildbot/bin/python'} 12:45:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:45:29 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 12:45:29 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 12:45:29 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 12:45:29 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 12:45:29 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 12:45:29 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 12:45:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:45:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:45:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:45:30 INFO - Installing collected packages: mozsystemmonitor 12:45:30 INFO - Running setup.py install for mozsystemmonitor 12:45:31 INFO - Successfully installed mozsystemmonitor 12:45:31 INFO - Cleaning up... 12:45:31 INFO - Return code: 0 12:45:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:45:31 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')]} 12:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:31 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')]} 12:45:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f689f150f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1113dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a63d0>, '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 0x1111ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1112360>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886', '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 12:45:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 12:45:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 12:45:31 INFO - Using env: {'DISPLAY': ':0', 12:45:31 INFO - 'HOME': '/home/cltbld', 12:45:31 INFO - 'LANG': 'en_US.UTF-8', 12:45:31 INFO - 'LANGUAGE': 'en_US:en', 12:45:31 INFO - 'LOGNAME': 'cltbld', 12:45:31 INFO - 'MAIL': '/var/mail/cltbld', 12:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:31 INFO - 'MOZ_NO_REMOTE': '1', 12:45:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:31 INFO - 'NO_EM_RESTART': '1', 12:45:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:31 INFO - 'PWD': '/builds/slave/test', 12:45:31 INFO - 'SHELL': '/bin/bash', 12:45:31 INFO - 'SHLVL': '1', 12:45:31 INFO - 'TERM': 'linux', 12:45:31 INFO - 'TMOUT': '86400', 12:45:31 INFO - 'USER': 'cltbld', 12:45:31 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886', 12:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:31 INFO - '_': '/tools/buildbot/bin/python'} 12:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:31 INFO - Downloading/unpacking blobuploader==1.2.4 12:45:31 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 12:45:31 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 12:45:31 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 12:45:31 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 12:45:31 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 12:45:31 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 12:45:33 INFO - Downloading blobuploader-1.2.4.tar.gz 12:45:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:45:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:45:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:45:33 INFO - Downloading docopt-0.6.1.tar.gz 12:45:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:45:33 INFO - Installing collected packages: blobuploader, requests, docopt 12:45:33 INFO - Running setup.py install for blobuploader 12:45:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:45:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:45:34 INFO - Running setup.py install for requests 12:45:34 INFO - Running setup.py install for docopt 12:45:34 INFO - Successfully installed blobuploader requests docopt 12:45:34 INFO - Cleaning up... 12:45:34 INFO - Return code: 0 12:45:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f689f150f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1113dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a63d0>, '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 0x1111ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1112360>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886', '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 12:45:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 12:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 12:45:34 INFO - Using env: {'DISPLAY': ':0', 12:45:34 INFO - 'HOME': '/home/cltbld', 12:45:34 INFO - 'LANG': 'en_US.UTF-8', 12:45:34 INFO - 'LANGUAGE': 'en_US:en', 12:45:34 INFO - 'LOGNAME': 'cltbld', 12:45:34 INFO - 'MAIL': '/var/mail/cltbld', 12:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:34 INFO - 'MOZ_NO_REMOTE': '1', 12:45:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:34 INFO - 'NO_EM_RESTART': '1', 12:45:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:34 INFO - 'PWD': '/builds/slave/test', 12:45:34 INFO - 'SHELL': '/bin/bash', 12:45:34 INFO - 'SHLVL': '1', 12:45:34 INFO - 'TERM': 'linux', 12:45:34 INFO - 'TMOUT': '86400', 12:45:34 INFO - 'USER': 'cltbld', 12:45:34 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886', 12:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:34 INFO - '_': '/tools/buildbot/bin/python'} 12:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:45:34 INFO - Running setup.py (path:/tmp/pip-ZnW6Sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:45:34 INFO - Running setup.py (path:/tmp/pip-f5UJy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:45:34 INFO - Running setup.py (path:/tmp/pip-MemM1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:45:34 INFO - Running setup.py (path:/tmp/pip-kuCVwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:45:35 INFO - Running setup.py (path:/tmp/pip-jPfTji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:45:35 INFO - Running setup.py (path:/tmp/pip-gjg4gx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:45:35 INFO - Running setup.py (path:/tmp/pip-qiOyq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:45:35 INFO - Running setup.py (path:/tmp/pip-pj371u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:45:35 INFO - Running setup.py (path:/tmp/pip-4LoOS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:45:35 INFO - Running setup.py (path:/tmp/pip-pxGPnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:45:35 INFO - Running setup.py (path:/tmp/pip-DrQwq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:45:35 INFO - Running setup.py (path:/tmp/pip-3uQhXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:45:35 INFO - Running setup.py (path:/tmp/pip-dcQbFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:45:35 INFO - Running setup.py (path:/tmp/pip-ferMrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:45:35 INFO - Running setup.py (path:/tmp/pip-mSbbq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:45:35 INFO - Running setup.py (path:/tmp/pip-YIdL4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:45:35 INFO - Running setup.py (path:/tmp/pip-t7rwSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:45:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:45:36 INFO - Running setup.py install for manifestparser 12:45:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:45:36 INFO - Running setup.py install for mozcrash 12:45:36 INFO - Running setup.py install for mozdebug 12:45:36 INFO - Running setup.py install for mozdevice 12:45:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:45:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:45:36 INFO - Running setup.py install for mozfile 12:45:36 INFO - Running setup.py install for mozhttpd 12:45:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:45:36 INFO - Running setup.py install for mozinfo 12:45:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:45:36 INFO - Running setup.py install for mozInstall 12:45:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:45:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:45:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:45:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:45:36 INFO - Running setup.py install for mozleak 12:45:36 INFO - Running setup.py install for mozlog 12:45:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:45:37 INFO - Running setup.py install for moznetwork 12:45:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:45:37 INFO - Running setup.py install for mozprocess 12:45:37 INFO - Running setup.py install for mozprofile 12:45:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:45:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:45:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:45:37 INFO - Running setup.py install for mozrunner 12:45:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:45:37 INFO - Running setup.py install for mozscreenshot 12:45:37 INFO - Running setup.py install for moztest 12:45:37 INFO - Running setup.py install for mozversion 12:45:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:45:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:45:37 INFO - Cleaning up... 12:45:37 INFO - Return code: 0 12:45:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:45:37 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')]} 12:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:37 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')]} 12:45:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f689f150f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1113dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a63d0>, '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 0x1111ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1112360>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886', '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 12:45:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 12:45:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 12:45:37 INFO - Using env: {'DISPLAY': ':0', 12:45:37 INFO - 'HOME': '/home/cltbld', 12:45:37 INFO - 'LANG': 'en_US.UTF-8', 12:45:37 INFO - 'LANGUAGE': 'en_US:en', 12:45:37 INFO - 'LOGNAME': 'cltbld', 12:45:37 INFO - 'MAIL': '/var/mail/cltbld', 12:45:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:37 INFO - 'MOZ_NO_REMOTE': '1', 12:45:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:37 INFO - 'NO_EM_RESTART': '1', 12:45:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:37 INFO - 'PWD': '/builds/slave/test', 12:45:37 INFO - 'SHELL': '/bin/bash', 12:45:37 INFO - 'SHLVL': '1', 12:45:37 INFO - 'TERM': 'linux', 12:45:37 INFO - 'TMOUT': '86400', 12:45:37 INFO - 'USER': 'cltbld', 12:45:37 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886', 12:45:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:37 INFO - '_': '/tools/buildbot/bin/python'} 12:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:45:38 INFO - Running setup.py (path:/tmp/pip-vKABoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:45:38 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)) 12:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:45:38 INFO - Running setup.py (path:/tmp/pip-9fwxJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:45:38 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)) 12:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:45:38 INFO - Running setup.py (path:/tmp/pip-IFVufI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:45:38 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)) 12:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:45:38 INFO - Running setup.py (path:/tmp/pip-tFPOS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:45:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:45:38 INFO - Running setup.py (path:/tmp/pip-hSMqGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:45:38 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)) 12:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:45:38 INFO - Running setup.py (path:/tmp/pip-QnoEyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:45:38 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)) 12:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:45:38 INFO - Running setup.py (path:/tmp/pip-LXoecH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:45:38 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)) 12:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:45:38 INFO - Running setup.py (path:/tmp/pip-XsR3HG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:45:38 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)) 12:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:45:38 INFO - Running setup.py (path:/tmp/pip-5WvZlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:45:38 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)) 12:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:45:38 INFO - Running setup.py (path:/tmp/pip-kWb3Cf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:45:38 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)) 12:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:45:38 INFO - Running setup.py (path:/tmp/pip-LLeTQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:45:38 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)) 12:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:45:38 INFO - Running setup.py (path:/tmp/pip-7EYk4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:45:38 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)) 12:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:45:38 INFO - Running setup.py (path:/tmp/pip-g3gYg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:45:38 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)) 12:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:45:38 INFO - Running setup.py (path:/tmp/pip-in3cnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:45:39 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)) 12:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:45:39 INFO - Running setup.py (path:/tmp/pip-vYJ5cr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:45:39 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)) 12:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:45:39 INFO - Running setup.py (path:/tmp/pip-WxSlXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:45:39 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)) 12:45:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:45:39 INFO - Running setup.py (path:/tmp/pip-S2idlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:45:39 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)) 12:45:39 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)) 12:45:39 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)) 12:45:39 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)) 12:45:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:45:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:45:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:45:39 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 12:45:39 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 12:45:39 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 12:45:39 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 12:45:39 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 12:45:39 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 12:45:41 INFO - Downloading blessings-1.6.tar.gz 12:45:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:45:41 INFO - Installing collected packages: blessings 12:45:41 INFO - Running setup.py install for blessings 12:45:41 INFO - Successfully installed blessings 12:45:41 INFO - Cleaning up... 12:45:41 INFO - Return code: 0 12:45:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:45:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:45:41 INFO - Reading from file tmpfile_stdout 12:45:41 INFO - Current package versions: 12:45:41 INFO - argparse == 1.2.1 12:45:41 INFO - blessings == 1.6 12:45:41 INFO - blobuploader == 1.2.4 12:45:41 INFO - docopt == 0.6.1 12:45:41 INFO - manifestparser == 1.1 12:45:41 INFO - mozInstall == 1.12 12:45:41 INFO - mozcrash == 0.16 12:45:41 INFO - mozdebug == 0.1 12:45:41 INFO - mozdevice == 0.48 12:45:41 INFO - mozfile == 1.2 12:45:41 INFO - mozhttpd == 0.7 12:45:41 INFO - mozinfo == 0.9 12:45:41 INFO - mozleak == 0.1 12:45:41 INFO - mozlog == 3.1 12:45:41 INFO - moznetwork == 0.27 12:45:41 INFO - mozprocess == 0.22 12:45:41 INFO - mozprofile == 0.28 12:45:41 INFO - mozrunner == 6.11 12:45:41 INFO - mozscreenshot == 0.1 12:45:41 INFO - mozsystemmonitor == 0.0 12:45:41 INFO - moztest == 0.7 12:45:41 INFO - mozversion == 1.4 12:45:41 INFO - psutil == 3.1.1 12:45:41 INFO - requests == 1.2.3 12:45:41 INFO - wsgiref == 0.1.2 12:45:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f689f150f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1113dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a63d0>, '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 0x1111ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1112360>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886', '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 12:45:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 12:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 12:45:41 INFO - Using env: {'DISPLAY': ':0', 12:45:41 INFO - 'HOME': '/home/cltbld', 12:45:41 INFO - 'LANG': 'en_US.UTF-8', 12:45:41 INFO - 'LANGUAGE': 'en_US:en', 12:45:41 INFO - 'LOGNAME': 'cltbld', 12:45:41 INFO - 'MAIL': '/var/mail/cltbld', 12:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:41 INFO - 'MOZ_NO_REMOTE': '1', 12:45:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:41 INFO - 'NO_EM_RESTART': '1', 12:45:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:41 INFO - 'PWD': '/builds/slave/test', 12:45:41 INFO - 'SHELL': '/bin/bash', 12:45:41 INFO - 'SHLVL': '1', 12:45:41 INFO - 'TERM': 'linux', 12:45:41 INFO - 'TMOUT': '86400', 12:45:41 INFO - 'USER': 'cltbld', 12:45:41 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886', 12:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:41 INFO - '_': '/tools/buildbot/bin/python'} 12:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:41 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)) 12:45:41 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)) 12:45:41 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)) 12:45:41 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)) 12:45:41 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)) 12:45:41 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)) 12:45:41 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)) 12:45:41 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)) 12:45:41 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)) 12:45:41 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)) 12:45:41 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)) 12:45:41 INFO - Cleaning up... 12:45:41 INFO - Return code: 0 12:45:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f689f150f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1113dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a63d0>, '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 0x1111ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1112360>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886', '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 12:45:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 12:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 12:45:41 INFO - Using env: {'DISPLAY': ':0', 12:45:41 INFO - 'HOME': '/home/cltbld', 12:45:41 INFO - 'LANG': 'en_US.UTF-8', 12:45:41 INFO - 'LANGUAGE': 'en_US:en', 12:45:41 INFO - 'LOGNAME': 'cltbld', 12:45:41 INFO - 'MAIL': '/var/mail/cltbld', 12:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:41 INFO - 'MOZ_NO_REMOTE': '1', 12:45:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:41 INFO - 'NO_EM_RESTART': '1', 12:45:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:41 INFO - 'PWD': '/builds/slave/test', 12:45:41 INFO - 'SHELL': '/bin/bash', 12:45:41 INFO - 'SHLVL': '1', 12:45:41 INFO - 'TERM': 'linux', 12:45:41 INFO - 'TMOUT': '86400', 12:45:41 INFO - 'USER': 'cltbld', 12:45:41 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886', 12:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:41 INFO - '_': '/tools/buildbot/bin/python'} 12:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:41 INFO - Downloading/unpacking jsonschema 12:45:41 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 12:45:41 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 12:45:41 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 12:45:41 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 12:45:41 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 12:45:41 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 12:45:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:45:43 INFO - Downloading/unpacking functools32 (from jsonschema) 12:45:43 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 12:45:43 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 12:45:43 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 12:45:43 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 12:45:43 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 12:45:43 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 12:45:43 INFO - Downloading functools32-3.2.3-2.tar.gz 12:45:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:45:43 INFO - warning: no files found matching '*.txt' 12:45:43 INFO - no previously-included directories found matching 'build' 12:45:43 INFO - no previously-included directories found matching 'dist' 12:45:43 INFO - no previously-included directories found matching '.git*' 12:45:43 INFO - Installing collected packages: jsonschema, functools32 12:45:43 INFO - Running setup.py install for functools32 12:45:44 INFO - warning: no files found matching '*.txt' 12:45:44 INFO - no previously-included directories found matching 'build' 12:45:44 INFO - no previously-included directories found matching 'dist' 12:45:44 INFO - no previously-included directories found matching '.git*' 12:45:44 INFO - Successfully installed jsonschema functools32 12:45:44 INFO - Cleaning up... 12:45:44 INFO - Return code: 0 12:45:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:45:44 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')]} 12:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:45:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:44 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')]} 12:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:45:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:45:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f689f150f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1113dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a63d0>, '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 0x1111ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1112360>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886', '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 12:45:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 12:45:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 12:45:44 INFO - Using env: {'DISPLAY': ':0', 12:45:44 INFO - 'HOME': '/home/cltbld', 12:45:44 INFO - 'LANG': 'en_US.UTF-8', 12:45:44 INFO - 'LANGUAGE': 'en_US:en', 12:45:44 INFO - 'LOGNAME': 'cltbld', 12:45:44 INFO - 'MAIL': '/var/mail/cltbld', 12:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:45:44 INFO - 'MOZ_NO_REMOTE': '1', 12:45:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:45:44 INFO - 'NO_EM_RESTART': '1', 12:45:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:45:44 INFO - 'PWD': '/builds/slave/test', 12:45:44 INFO - 'SHELL': '/bin/bash', 12:45:44 INFO - 'SHLVL': '1', 12:45:44 INFO - 'TERM': 'linux', 12:45:44 INFO - 'TMOUT': '86400', 12:45:44 INFO - 'USER': 'cltbld', 12:45:44 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886', 12:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:45:44 INFO - '_': '/tools/buildbot/bin/python'} 12:45:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:45:44 INFO - Downloading/unpacking flake8 12:45:44 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 12:45:44 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 12:45:44 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 12:45:44 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 12:45:44 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 12:45:44 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 12:45:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:45:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:45:46 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 12:45:46 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 12:45:46 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 12:45:46 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 12:45:46 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 12:45:46 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 12:45:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:45:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:45:46 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 12:45:46 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 12:45:46 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 12:45:46 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 12:45:46 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 12:45:46 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 12:45:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:45:46 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 12:45:46 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 12:45:46 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 12:45:46 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 12:45:46 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 12:45:46 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 12:45:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:45:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:45:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:45:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:45:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:45:46 INFO - no previously-included directories found matching 'docs/_build' 12:45:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:45:46 INFO - Running setup.py install for pep8 12:45:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:45:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:45:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:45:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:45:46 INFO - no previously-included directories found matching 'docs/_build' 12:45:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:45:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:45:46 INFO - Cleaning up... 12:45:47 INFO - Return code: 0 12:45:47 INFO - Running post-action listener: _resource_record_post_action 12:45:47 INFO - Running post-action listener: _start_resource_monitoring 12:45:47 INFO - Starting resource monitoring. 12:45:47 INFO - ##### 12:45:47 INFO - ##### Running install step. 12:45:47 INFO - ##### 12:45:47 INFO - Running pre-action listener: _resource_record_pre_action 12:45:47 INFO - Running main action method: install 12:45:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:45:47 INFO - Reading from file tmpfile_stdout 12:45:47 INFO - Detecting whether we're running mozinstall >=1.0... 12:45:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:45:47 INFO - Reading from file tmpfile_stdout 12:45:47 INFO - Output received: 12:45:47 INFO - Usage: mozinstall [options] installer 12:45:47 INFO - Options: 12:45:47 INFO - -h, --help show this help message and exit 12:45:47 INFO - -d DEST, --destination=DEST 12:45:47 INFO - Directory to install application into. [default: 12:45:47 INFO - "/builds/slave/test"] 12:45:47 INFO - --app=APP Application being installed. [default: firefox] 12:45:47 INFO - mkdir: /builds/slave/test/build/application 12:45:47 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'] 12:45:47 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 12:46:03 INFO - Reading from file tmpfile_stdout 12:46:03 INFO - Output received: 12:46:03 INFO - /builds/slave/test/build/application/firefox/firefox 12:46:03 INFO - Running post-action listener: _resource_record_post_action 12:46:03 INFO - ##### 12:46:03 INFO - ##### Running run-tests step. 12:46:03 INFO - ##### 12:46:03 INFO - Running pre-action listener: _resource_record_pre_action 12:46:03 INFO - Running main action method: run_tests 12:46:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:46:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:46:03 INFO - Python 2.7.3 12:46:03 INFO - Return code: 0 12:46:03 INFO - grabbing minidump binary from tooltool 12:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:03 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 0x11a63d0>, '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 0x1111ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1112360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:46:03 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 12:46:03 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 12:46:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:46:03 INFO - Return code: 0 12:46:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:46:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:46:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:46:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:46:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:46:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:46:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:46:04 INFO - Return code: 0 12:46:04 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CX5usBX_SGqRO9M5w1uBIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:46:04 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CX5usBX_SGqRO9M5w1uBIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:46:04 INFO - Using env: {'DISPLAY': ':0', 12:46:04 INFO - 'HOME': '/home/cltbld', 12:46:04 INFO - 'LANG': 'en_US.UTF-8', 12:46:04 INFO - 'LANGUAGE': 'en_US:en', 12:46:04 INFO - 'LOGNAME': 'cltbld', 12:46:04 INFO - 'MAIL': '/var/mail/cltbld', 12:46:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:46:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:46:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:04 INFO - 'MOZ_NO_REMOTE': '1', 12:46:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:46:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:46:04 INFO - 'NO_EM_RESTART': '1', 12:46:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:46:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:04 INFO - 'PWD': '/builds/slave/test', 12:46:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:46:04 INFO - 'SHELL': '/bin/bash', 12:46:04 INFO - 'SHLVL': '1', 12:46:04 INFO - 'TERM': 'linux', 12:46:04 INFO - 'TMOUT': '86400', 12:46:04 INFO - 'USER': 'cltbld', 12:46:04 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886', 12:46:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:04 INFO - '_': '/tools/buildbot/bin/python'} 12:46:04 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CX5usBX_SGqRO9M5w1uBIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:46:04 INFO - mozversion application_buildid: 20160120120527 12:46:04 INFO - mozversion application_changeset: 55dd1f2654bdf945bdb9300abaac4c0b4ac0abd3 12:46:04 INFO - mozversion application_display_name: Nightly 12:46:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:46:04 INFO - mozversion application_name: Firefox 12:46:04 INFO - mozversion application_remotingname: firefox 12:46:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:46:04 INFO - mozversion application_vendor: Mozilla 12:46:04 INFO - mozversion application_version: 46.0a1 12:46:04 INFO - mozversion platform_buildid: 20160120120527 12:46:04 INFO - mozversion platform_changeset: 55dd1f2654bdf945bdb9300abaac4c0b4ac0abd3 12:46:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:46:04 INFO - mozversion platform_version: 46.0a1 12:46:04 INFO - using testdate: 1453322764 12:46:04 INFO - actual date: 1453322764 12:46:04 INFO - starting webserver on 'localhost:43158' 12:46:04 INFO - SUITE-START | Running 3 tests 12:46:04 INFO - TEST-START | dromaeo_css 12:46:04 INFO - operating with platform_type : linux_ 12:46:04 INFO - Initialising browser for dromaeo_css test... 12:46:04 INFO - TEST-INFO | started process 29903 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNNVtEX/profile http://localhost:43158/getInfo.html) 12:46:08 INFO - PROCESS | 29903 | 12:46:08 INFO - PROCESS | 29903 | (process:29982): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:46:09 INFO - PROCESS | 29903 | __metrics Screen width/height:1600/1200 12:46:09 INFO - PROCESS | 29903 | colorDepth:24 12:46:09 INFO - PROCESS | 29903 | Browser inner width/height: 1024/697 12:46:09 INFO - PROCESS | 29903 | __metrics 12:46:10 INFO - PROCESS | 29903 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:46:11 INFO - TEST-INFO | 29903: exit 0 12:46:11 INFO - Browser initialized. 12:46:11 INFO - Running cycle 1/1 for dromaeo_css test... 12:46:11 INFO - TEST-INFO | started process 30031 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNNVtEX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:46:11 INFO - PROCESS | 30031 | -- checkerboarding starts below -- 12:46:11 INFO - PROCESS | 30031 | RENDERTRACE 0.035098 rect red 0 0 10 10 // viewport 12:46:11 INFO - PROCESS | 30031 | RENDERTRACE 35.5429 rect brown 0 0 10 10 // page 12:46:11 INFO - PROCESS | 30031 | RENDERTRACE 35.5639 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 12:46:11 INFO - PROCESS | 30031 | Checkerboarded for 1 frames (50.2761 ms), 100 peak, 1 severity. 12:46:12 INFO - PROCESS | 30031 | 12:46:12 INFO - PROCESS | 30031 | (process:30089): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:46:22 INFO - PROCESS | 30031 | RSS: Main: 149831680 12:46:22 INFO - PROCESS | 30031 | 12:47:12 INFO - PROCESS | 30031 | 1453322832664 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] 12:49:24 INFO - PROCESS | 30031 | Cycle 1(1): loaded http://localhost:43158/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43158/tests/dromaeo/cssquery-ext.html) 12:49:25 INFO - PROCESS | 30031 | RSS: Main: 154042368 12:49:25 INFO - PROCESS | 30031 | 12:52:27 INFO - PROCESS | 30031 | Cycle 1(1): loaded http://localhost:43158/tests/dromaeo/cssquery-ext.html (next: http://localhost:43158/tests/dromaeo/cssquery-jquery.html) 12:52:27 INFO - PROCESS | 30031 | RSS: Main: 153661440 12:52:27 INFO - PROCESS | 30031 | 12:55:29 INFO - PROCESS | 30031 | Cycle 1(1): loaded http://localhost:43158/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43158/tests/dromaeo/cssquery-mootools.html) 12:55:30 INFO - PROCESS | 30031 | RSS: Main: 152600576 12:55:30 INFO - PROCESS | 30031 | 12:58:32 INFO - PROCESS | 30031 | Cycle 1(1): loaded http://localhost:43158/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43158/tests/dromaeo/cssquery-prototype.html) 12:58:32 INFO - PROCESS | 30031 | RSS: Main: 150687744 12:58:32 INFO - PROCESS | 30031 | 13:01:35 INFO - PROCESS | 30031 | Cycle 1(1): loaded http://localhost:43158/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43158/tests/dromaeo/cssquery-yui.html) 13:01:36 INFO - PROCESS | 30031 | RSS: Main: 150528000 13:01:36 INFO - PROCESS | 30031 | 13:04:38 INFO - PROCESS | 30031 | Cycle 1(1): loaded http://localhost:43158/tests/dromaeo/cssquery-yui.html (next: http://localhost:43158/tests/dromaeo/cssquery-dojo.html) 13:04:38 INFO - PROCESS | 30031 | RSS: Main: 153509888 13:04:38 INFO - PROCESS | 30031 | 13:04:38 INFO - PROCESS | 30031 | __start_tp_report 13:04:38 INFO - PROCESS | 30031 | _x_x_mozilla_page_load 13:04:38 INFO - PROCESS | 30031 | _x_x_mozilla_page_load_details 13:04:38 INFO - PROCESS | 30031 | |i|pagename|runs| 13:04:38 INFO - PROCESS | 30031 | |0;dojo.html;2554.846709197447;2588.8576128312934;2592.6111083337505;2599.2202339298206;2601.479704059188;4458.464984201896;4458.55414458554;4524.570165834245;4540.046590216054;4557.361969324297;4532.478764942032;4543.159515489637;4580.450345958489;4605.608523275526;4612.97693511532;4183.435236243106;4194.475690538683;4261.062566235423;4267.1252393259465;4289.270823959934;4267.189234045537;4304.440422745054;4316.179925814101;4342.392065110887;4395.230834603947;4136.524299705542;4140.772257525835;4209.5579964103945;4215.262329092412;4221.029163292429;4158.480189976253;4187.890209094592;4197.91604167918;4199.0552125771455;4229.154169166149;4181.268278051329;4188.015816283171;4195.077083041726;4213.2837417639075;4215.093754842693;4288.828446862121;4393.472783266028;4417.646588272931;4419.845305414327;4482.529334419904;4840.443349014838;4849.612031037508;4865.781039853215;4865.82969596066;4917.901641967176;4719.244920812654;4838;4854.732989685566;4859.781309841065;4893.779779909913;4467.776611169428;4481.820727170942;4508.526604706459;4523.7285762854335;4555.589996900295;4952.62855285855;4970.801167953314;4975.527324904128;4976.42771081323;5026.874328141753;4612.584867361887;4687.554682305175;4772.331873537708;4773.284007398918;4822.71063736177;4885.706857588556;4905.3623029006;4931.161702510582;4937.407511098691;4990.950090499121;4793.38184786608;4805.543473370024;4821.879453013703;4826.806927722922;4854.368932038883;4720.12677654635;4805;4811.663183577186;4830.8792280193275;4846.29728689338;4079.303809400938;4087.4890638670167;4091.243120022805;4097.037196258877;4106.301928672133;3557.6975957043423;3558.484019817112;3591.479235510836;3593.047842321787;3610.9638903610626;4124.711270211056;4217.831286748496;4233.555476674905;4280.122574872144;4309.525952145262;4818.349522814446;4831.782569784368;4856.708597484162;4866.46468888422;4909.091818013679;4170.666346692318;4219.641330486943;4226.76752778594;4234.216669916075;4263.936040959388;4289.420928174719;4332.848350307724;4346.065595896897;4387.166438376698;4392.714473559208;4627.9074418511445;4633.606143477842;4644.349791029191;4660.7669616519715;4712.057588482248;4785.59322457581;4913.729744864067;4923.8276660316715;4932.4081110267;4986.7257300848805;4563.087382523442;4657.0685862826895;4682.367880336111;4687.554682305175;4725.36207611968;4817.229243321192;4833.540813622701;4838.903221935612;4845.079434907357;4863;4721.669483136147;4812.398450193726;4914.410270767531;4922.138625740409;4972.65191436596;4723.858284251478;4731.148393289241;4752.786124624331;4759.16714574941;4782.497837726988;4738.597219236403;4747.382840230748;4749.073930583503;4759.381280433521;4809.374781278411;4485.798139083814;4532.4334458192725;4662.5104364042645;4669.556392142741;4673.252279635242;4807.375041244755;4837.927431088607;4839.41926968766;4848.0546293472435;4874.195757699939;4726.314684370678;4740.881477963078;4744.1460537102275;4750.406199225097;4792.856214313576 13:04:38 INFO - PROCESS | 30031 | |1;ext.html;499.84005118362137;514.5626217714943;556.5992485410505;565.4091474409242;566.0264345326037;24218.87890560547;31023.379532409366;31453.21366965827;31455.52816707751;31498.68501314986;34788.652113478856;35251.294974100565;35271.470927936105;35280;35299.11752206196;7445.329920307171;7678.462507624468;7696.615169241543;7735.30382265596;7759.379249660014;7537.585432801194;7674.5395276283325;7677.654505547236;7678.155402905676;7747.031621047369;7828.608569571498;7858.1356050834365;7892.644830982591;7892.881606775903;7909.485883417588;7656.846863062736;7662.272084151997;7693.461457697963;7736.6518506667335;7795.220477952216;7563.470557061008;7611.2388761124;7621.695132194705;7650;7693.422993275527;35520;35907.10232244189;36001.81999089988;36019.279614407824;36074;2824.5216215140936;2877.352595665979;2879.280179955011;2894.2619631993916;3270.9018729438153;27008.459830803273;27029.594556081676;27212.45575088487;27366.45267094647;27728.30679233015;3434.759566830323;3474.270403215328;3508.333416650854;3537.4163263061564;3586.37238483267;158408;158498;159030;159755;160026.19986899992;43290;44074.77962610166;51227;51994.22008669873;52040.47959520432;45460.3180952286;45974.77012614915;46011.30983035257;46071.76964115225;46199.30701039487;13611.931940340235;13799.655008624664;13865.09876858001;13869.237191954338;13906.930465347608;10555.683329500127;10593.947030264953;10595.94702026485;10780.29928054674;10793.352398856094;17307.826921730873;17528.12359382026;17604.735928961076;17621.471355859343;17739.556511087325;6930.757423490254;7076.646167691595;7116.466265030143;7131.750388736369;7169.390601798906;857.8241460500707;898.6540182029966;922.2022950148073;988.8417853143462;1007.3250921882357;25823.741762582133;26162.73837261641;26222.606660900103;26230.606540901903;26260.86869565678;976.472704739447;988.6687959533493;1012.7518757904361;1082.7617924056854;1102.0247081333077;13022.088453808332;13080.476780928846;13152;13225.669358265928;14353.067050641675;243872;247270;249165.05009699112;249632;249639;44323.11353772906;44718.77640611776;44799.77600112044;44933.32600011003;44961.550384495735;1211.5335595795682;1215.3740823475916;1234.1299383934304;1235.8764123587748;1358.4090920449637;25313.62029569521;26335;26561.867190663925;26662.866685666446;26956.73043269542;39459;40769;40813;40863.7956810214;40899.591004089576;168683.15658421628;168935;170017.8994630163;170218.14890925467;170408;27484.312892177855;27487.17538473849;27636.723632763416;27639.86180069087;28171.859140704164;32067.518987215677;32068.19829504188;32238.67761322357;32931.50602740913;33382.49926251157;28300.85849570739;28652.713472865005;28774.7122528772;29758.702412975592;30314.39371212519;30230;30260.24349391283;30384;30861;32018.839905800323;28779.71220287854;28839;29175.7082429173;29231.561526577545;29311.413771724874;25017.374565636004;26349.341266467723;26439;26537.33656658599;26959.191224263304;21146.788532115097;21235;21548;22827.771722282563;23467.647985280575 13:04:38 INFO - PROCESS | 30031 | |2;jquery.html;342.8611412377987;344.65706621911204;344.84309639114207;345.62154440887235;347.01620904735074;13863.306834658264;13937.651558711037;14934.551963441087;15280.847191528068;15589.532314030568;9666.420014799118;9959.651412200574;11876.049916006721;15161.545153645407;15169.696606067899;4466.196084704752;4675.976620116895;4683.2975053741875;4931.112399768041;5148.459411761749;5077.619178561604;5124.308218390525;5125.589952803785;5136.460671629481;5402.486763757437;5826.096954971986;5832.125181222829;5921.407859214087;6162;6217.253929528463;6203.379662033805;6237.844053898643;6272.466840318579;6697.995300704884;6733.629650369227;6142.600730952474;6353.618782873043;6432;6439.35606439357;6448.097266382711;19358.709619355723;19540;19926.900365498226;20742.896285518626;20843.5831283375;1796.7843858736906;1902.4387805597244;1963.803619638039;2005.7720776987535;2116.8518203725744;13169.604911852659;13304.268265245408;13488.932555337258;13570.45718171272;13726.313684315845;1828.7988321284647;1897.2221389230488;1948.1720268885667;1949.220311875247;2001.6997450382414;56011.43988560103;56164.43835561633;56539.43460565424;57625.423745762426;57934.7103264481;14322.785158222636;14650.194239316726;14664.780028299583;14709.338079786436;14798.704025919422;21883.12467501314;22016;22063.66904496434;22150.560213586064;22181;8674.30605551567;8688.609012594448;8698.565071746387;8705.869411958825;8810;7239.855202895913;7298.379637730853;7313.268673132644;7358.41132709382;7377.33603975634;7248.6738096785775;7289.489735718449;7357.632118394059;7366.410687145016;7464.104307483137;1707.4792188382414;1719.7764290642137;1802.837744602992;2840;2921.8539073046263;832.904216015166;843.5191940593925;860.4536119564121;923.8706581078654;927.7495076329353;14953.252337383088;15047.322870470636;15408.306626201847;15561.844381556266;15803.20983950798;851.7189327521903;869.5478351257311;871.8822958900594;874.8381549413378;912.5802131019806;8669.783255418539;8716.607752651145;8729.825403491895;8995.235404990519;9094.636214551476;378490;382587;383972.041817281;397614;397950;60030;60464.697676511336;62875;63375.36624633787;64323;1026.90757831794;1030.2479190191352;1030.922680798928;1045.4668119259234;1049.679847646475;13589.660258493617;13629.727405452033;13696.452141914211;13769.242691652054;13960.441582336593;30133.547996779627;30181.849090754407;30190.396192076474;30626.540601890545;30720.231994200323;37882;38182.809085954395;38903;39346.40980385354;39606.80196598999;4910.337104490991;6528.608283503005;6539.790138824333;6584.539082264196;6711.664416779239;7127.144742630918;7349.448791340564;8200.876986845322;9945.900540994788;9954.701358959242;6341.112244285711;6550.443212327005;6747.831304217434;6837.282085381163;7074.610896400747;2809.7471227589617;6636.800895973129;6737.326267373223;6741.528093033637;6747.898781518379;5825.650460972355;6225.252969643671;6522.184726909137;6542.901856472062;6795.3204679531655;8716.738497845075;8860.911390886267;9020.097990200928;9095.95452022762;9164.495952722664;8716.210812539926;8835.249003834746;9092.22716069115;9115.726528204164;9165.220956218796 13:04:38 INFO - PROCESS | 30031 | |3;mootools.html;1326.6932071909168;1349.7368013237417;1422.2177802208782;1637.737961926092;1647.0611751301756;5719.428057194278;5897.911531327033;6264.874702505953;6349.968250158749;6375.203099612549;6400.967995160017;6565.507586930976;6614.669266536666;6618.470522358211;6642.833929151761;2017.3443630820007;2045.7340545729035;2048.702938073978;2048.8565800393976;2050.05697379205;1974.062320397814;1987.2746447546613;1992.4819546917834;1993.710911917771;1998.8700734452286;1985.4341512668893;1986.04669758516;1991.2234228650839;1994.1425187169511;1995.49114975681;1980.2969945669297;1985.8411327093797;1989.45290045238;1993.2624928776302;1997.9400617981485;1968.4783532363936;1973.0726558517474;1974.3879397386856;1982.4548249231432;1997.2310660395851;6864.279250678656;6868.931310686879;6932.341427564374;6940.618265995368;6945.6527173641625;3860.36304009838;3890.1441682830014;3901.5708272090046;3913.099987002977;3939.3500072488005;2537.644729737838;2570.5887058070807;2602.817802753808;2646.192911162095;2648.430587423694;841.4488510025943;847.9915200847975;850.5832142250315;875.0374587953264;876.7588913048899;9132.497712625804;9138.497382643953;9152.405093668956;9173.678921237792;9176.715259863624;3567.5362202913457;3593.4317024935813;3616.0598244456105;3628.8004159771467;3647.6899463545365;7786.961065194751;7793.493422927491;7802;7840.13758486566;7847.293743563107;3947.17109407022;3957.940630890539;3976.2842688315804;3977.6817854571564;3999.3601023836045;3032.6664066952617;3091.4280858040884;3496.73774466916;3621.420572708354;3621.583517895476;3242.124626350872;3259.6088469383826;3264.037109052835;3267.5098735189913;3329.217633856042;1035.1201478743008;1057.143713591993;1070.7216123807866;1073.0878753059837;1074.5648012554927;1146.5070019891527;1147.7647082348099;1161.1291531351487;1164.3596022187933;1182.2020136407891;6362.236531616236;6440.388163124496;6441.710123044474;6446.323136070739;6463.159789227464;996.1881066930429;1012.6911292055994;1025.7999690060515;1038.2939601071193;1059.4014381874217;5066.670666406745;5108.208227724708;5115.56517696;5135.409427915837;5136.178211486144;7612.934189213514;7946.523208607502;7975.122736498981;7987.8402431951035;8040.919590804134;7788.260115289038;7822.295993360625;7881.290683838482;7894.486858354188;7952.801179970431;6096.420840020191;6136.711290629018;6207.131001659771;6207.255129384413;6383.234011918692;6380.968095159495;6474.902876456951;6475.061116138039;6477.740890364333;6490.513211509061;7145.678444469907;7185.568865868065;7249.311315425026;7258;7263.636818158965;6703.128593282842;6709.429698475684;6766.86466270662;7429.33136017761;7444.330010299099;5216.9739151304;5340.092184328596;5955.76176952917;6067.726952287246;6081.239845019372;5902.2327097477055;5997.910031349446;6015.187949626919;6020.90968635462;6024.096385542029;5650.3219613646625;5674.375818659862;5703.914441283467;5793.971030144822;5809.738561764815;5611.523020543136;5628.324601047901;5733.283339582552;5761.279840019997;5847.38602446754;5735.8852822944145;5770.682612456355;5784.248047753765;5860.853478663067;5941.346451890375;5439.265699130567;5472.616916815785;5483.287172667688;5504.449555044624;5508.55931525485;5543.1685247213245;5559.610827242054;5590.329160500766;5603.2155498231095;5615.691136987505 13:04:38 INFO - PROCESS | 30031 | |4;prototype.html;286.6116412261386;292.93262549613587;293.9941201175978;295.4121298615754;297.85405151475777;5550.16747487877;5567.248421463101;5659.688717120562;5666.716664166785;5686;5530.446955304467;5553.444655534445;5558.305211848519;5562.249096371988;5565.888682226353;4294.570542945696;4296.226679197744;4296.871093867189;4296.97851510742;4300.462442194726;4014.4781178446906;4117.402976568395;4166.166766646667;4257.787110644471;4289.335153051282;4233.280342341794;4237.915241695165;4237.978810105945;4246.9150616987645;4260.147970405916;4222.767747773886;4236.279832428495;4238.004069043803;4279.422277992462;4281.657467402601;3732.720045996561;3733.775973441575;3734.6825519830845;3737.0844143185095;3739.7756134631736;5171.198464238049;5327.360716713981;5334.27987221724;5358.624896257264;5358.812441564565;4770.141374552579;4818.879528011793;4825.9758701206265;4830.9275360869615;4837.32277481153;5808.041673123929;5809.2447981762525;5810.070388737781;5836.095405212156;5854.736536855852;3902.551206611219;3919.118198405336;3925.941110883339;3933.665638420709;3935.2129574085297;5987.850303742442;6023.608465449775;6140.815775526741;6154.169187159766;6161.675239823459;4082.2651922653613;4087.325591277406;4089.89775255621;4090.1615168890307;4094.3653733671326;4140.130572579732;4155.355919832431;4156.231097247019;4160.271952408317;4169.082801783664;4769.451513075971;4813.989062296957;4820.084184005028;4829.13075646387;4841.273808928619;5632.97183514088;5846.883062338729;5847.678377689268;5857.472827445466;5864.501517370986;1453.4840131753076;1461.8391976882535;1465.0403985389587;1466.2375564706292;1466.523379901515;961.9470929098827;981.3523074770617;986.2061040862031;988.9554970026367;992.1764935103846;5064.240363945364;5065.6200784941275;5075.238714192827;5087.26234695967;5103.795848166032;5915;6065.211522502046;6068.2111325528285;6123.050927106306;6133.44798968095;5128.1794912813775;5143.305653736773;5152.433232344439;5155.484451554815;5169.327987361694;3229.725473334746;3266.183454136466;3270.5094235864335;3270.591176102987;3299.604047514266;5660.320761508646;5729;5752.884942301131;5769.942300577024;5791.739371728282;6332.461740751995;6340.636763095957;6348.746050158034;6359.141515895295;6367.808965731036;5762.135679648086;5784.132380142844;5802.912956305659;5808.564357673107;5809.535237181015;6094.573379863367;6116.29662588808;6126.908096378469;6138.232720909887;6149.754009839557;5903.793367232126;5942.613730107702;6051;6088.847778805565;6096.359882212304;5745.827625171251;5768.221290125947;5778.624389414675;5786.710664466676;5791.478766910998;3991.900202494961;4026.7382620129597;4039.8990025249605;4043.1509383029893;4055.7769322686354;6010.218671572842;6137.570370074231;6139.386061393825;6144.846378840565;6146.078088286793;5879.382664820132;5906.527477801679;5909.52723782105;5911.142884281841;5914.704264786657;5885.323187833454;5886.38192989747;5891.381404952418;5907.645541267538;5913.615614985012;5624.578156638187;5762.279715035621;5770.538356931519;5773.047447171338;5780.075187969905;5909.113632954919;5931.1399847021075;5941.643501389931;5964.254468191476;5968.4926781224085;5773;5801.3908539602735;5838.678872662044;5839;5843.561732869966 13:04:38 INFO - PROCESS | 30031 | |5;yui.html;685.4858855858106;741.770051284102;757.984840303194;770.1583489234158;782.9021372328459;11250.099992000642;11412;11475.483603237843;11493.138014648894;11493.712657183574;10463.162946964243;10822.458877056155;11368.204225704205;11406.54373825048;11545.422728863565;719.2771264878803;739.1573606089036;741.5439504704594;742.5655991245128;742.8699977503942;742.754890886009;747.7196051480695;750.0249675421957;751.864664360415;754.3286475037221;777.1373775109623;782.7338704840353;783.0798811396586;783.8275579372557;785.0265670568483;776.1423626892259;776.735909790671;776.8718161503346;776.9456138070337;780.3484090784174;575.7006356694495;579.4176852263448;580.0574067140896;580.1240127407602;581.4882903045335;9915.65295214664;9927.851082233772;9938.900610993942;9997.100260976475;10011;9666.806663866753;9962.800743985152;9971.850422243671;9973;10164.542595583216;10538;10755.516001779939;10912.672619821418;10957.780844383147;11032.558697652084;3972.483577134983;4036;4047.817848196838;4108.404281379183;4162.854300099482;36103;36244.81877590595;39186;39769.00577485557;40495.392569111485;8025.23760242776;8741.256993155526;9163.770905727277;9277.67528136512;9518.428894266366;15087.170205638577;15212.46756363522;15217.163056032025;15243.314050867737;15303.61740956485;6597.208334999831;6776.15298087739;6855.451563874878;6903.551269167488;6907.585544867324;3658.6158453362546;3785.848566057327;3846.4614953906475;3850.7497012694084;3873.070463088895;2645.5105805426056;2664.6136310234906;2673.31830383251;2681.986590067076;2683.9731602683723;475.4467815910202;484.10440684732964;484.88605177783194;491.83769356112396;492.12401924574317;529.8119167695489;535.1785010009617;558.6815515156403;559.0496156533827;568.2924758675475;7396.852062958818;7504.512206706547;7673.884891726629;7677.30904218623;7803.609819509002;520.9244659524423;528.4213785904428;529.4652401074942;530.6762874646463;533.3013751984912;3485.581730192393;3558.146044949245;3566.3045706087582;3581.7850928944345;3606.1705807664384;43539.564604354186;46068.53931460709;47323.76338118287;47492.5250747495;47602.76198618985;37744.62255377466;38601.42097868534;39214.60785392167;39287.21425571472;39294.803525982185;38425.039374015316;38433.42349864754;38888.41667374992;38901.805490972365;39153.60846391557;7473.140588832354;7484.288992545699;7556.1310449299035;7593.772186834404;7706.190849960673;29705.702942970292;29944.850275748482;30099.849500753233;30482.390352193277;30493.54259686062;37882.43176352302;37894.62105378911;38233;38615.42076868793;38687.226255475296;9035.283296173706;9248.815023699623;9266.953665231631;9309.627614895327;9717.028297170227;10252.487375631337;10294.433806140734;10363.430011349448;10436.060754532129;10447.634332798316;9916.206703463562;10021.599136034478;10044.54799534008;10045.69862904114;10123.139533139765;9531.428114313163;9570.377925434825;9602.519874006412;9614.759631009281;9615.51922403863;9910.108090271622;9994.900050999397;10040.397576145455;10089.19286457067;10090.495475226357;8593.914060859312;8622;8637.95681021616;8710;8774.736757897019;8604.956975215084;8660.826783464421;8669.089745576875;8676.869846952428;8797.12028797115 13:04:38 INFO - PROCESS | 30031 | __end_tp_report 13:04:38 INFO - PROCESS | 30031 | __start_cc_report 13:04:38 INFO - PROCESS | 30031 | _x_x_mozilla_cycle_collect,321 13:04:38 INFO - PROCESS | 30031 | __end_cc_report 13:04:38 INFO - PROCESS | 30031 | __startTimestamp1453323878952__endTimestamp 13:04:38 INFO - PROCESS | 30031 | 13:04:38 INFO - PROCESS | 30031 | ------- Summary: start ------- 13:04:38 INFO - PROCESS | 30031 | Number of tests: 6 13:04:38 INFO - PROCESS | 30031 | 13:04:38 INFO - PROCESS | 30031 | [#0] dojo.html Cycles:165 Average:4505.11 Median:4657.07 stddev:466.00 (10.0%) stddev-sans-first:441.60 13:04:38 INFO - PROCESS | 30031 | Values: 2554.8 2588.9 2592.6 2599.2 2601.5 4458.5 4458.6 4524.6 4540.0 4557.4 4532.5 4543.2 4580.5 4605.6 4613.0 4183.4 4194.5 4261.1 4267.1 4289.3 4267.2 4304.4 4316.2 4342.4 4395.2 4136.5 4140.8 4209.6 4215.3 4221.0 4158.5 4187.9 4197.9 4199.1 4229.2 4181.3 4188.0 4195.1 4213.3 4215.1 4288.8 4393.5 4417.6 4419.8 4482.5 4840.4 4849.6 4865.8 4865.8 4917.9 4719.2 4838.0 4854.7 4859.8 4893.8 4467.8 4481.8 4508.5 4523.7 4555.6 4952.6 4970.8 4975.5 4976.4 5026.9 4612.6 4687.6 4772.3 4773.3 4822.7 4885.7 4905.4 4931.2 4937.4 4991.0 4793.4 4805.5 4821.9 4826.8 4854.4 4720.1 4805.0 4811.7 4830.9 4846.3 4079.3 4087.5 4091.2 4097.0 4106.3 3557.7 3558.5 3591.5 3593.0 3611.0 4124.7 4217.8 4233.6 4280.1 4309.5 4818.3 4831.8 4856.7 4866.5 4909.1 4170.7 4219.6 4226.8 4234.2 4263.9 4289.4 4332.8 4346.1 4387.2 4392.7 4627.9 4633.6 4644.3 4660.8 4712.1 4785.6 4913.7 4923.8 4932.4 4986.7 4563.1 4657.1 4682.4 4687.6 4725.4 4817.2 4833.5 4838.9 4845.1 4863.0 4721.7 4812.4 4914.4 4922.1 4972.7 4723.9 4731.1 4752.8 4759.2 4782.5 4738.6 4747.4 4749.1 4759.4 4809.4 4485.8 4532.4 4662.5 4669.6 4673.3 4807.4 4837.9 4839.4 4848.1 4874.2 4726.3 4740.9 4744.1 4750.4 4792.9 13:04:38 INFO - PROCESS | 30031 | 13:04:38 INFO - PROCESS | 30031 | [#1] ext.html Cycles:180 Average:34611.78 Median:30349.20 stddev:50951.83 (167.9%) stddev-sans-first:51030.38 13:04:38 INFO - PROCESS | 30031 | Values: 499.8 514.6 556.6 565.4 566.0 24218.9 31023.4 31453.2 31455.5 31498.7 34788.7 35251.3 35271.5 35280.0 35299.1 7445.3 7678.5 7696.6 7735.3 7759.4 7537.6 7674.5 7677.7 7678.2 7747.0 7828.6 7858.1 7892.6 7892.9 7909.5 7656.8 7662.3 7693.5 7736.7 7795.2 7563.5 7611.2 7621.7 7650.0 7693.4 35520.0 35907.1 36001.8 36019.3 36074.0 2824.5 2877.4 2879.3 2894.3 3270.9 27008.5 27029.6 27212.5 27366.5 27728.3 3434.8 3474.3 3508.3 3537.4 3586.4 158408.0 158498.0 159030.0 159755.0 160026.2 43290.0 44074.8 51227.0 51994.2 52040.5 45460.3 45974.8 46011.3 46071.8 46199.3 13611.9 13799.7 13865.1 13869.2 13906.9 10555.7 10593.9 10595.9 10780.3 10793.4 17307.8 17528.1 17604.7 17621.5 17739.6 6930.8 7076.6 7116.5 7131.8 7169.4 857.8 898.7 922.2 988.8 1007.3 25823.7 26162.7 26222.6 26230.6 26260.9 976.5 988.7 1012.8 1082.8 1102.0 13022.1 13080.5 13152.0 13225.7 14353.1 243872.0 247270.0 249165.1 249632.0 249639.0 44323.1 44718.8 44799.8 44933.3 44961.6 1211.5 1215.4 1234.1 1235.9 1358.4 25313.6 26335.0 26561.9 26662.9 26956.7 39459.0 40769.0 40813.0 40863.8 40899.6 168683.2 168935.0 170017.9 170218.1 170408.0 27484.3 27487.2 27636.7 27639.9 28171.9 32067.5 32068.2 32238.7 32931.5 33382.5 28300.9 28652.7 28774.7 29758.7 30314.4 30230.0 30260.2 30384.0 30861.0 32018.8 28779.7 28839.0 29175.7 29231.6 29311.4 25017.4 26349.3 26439.0 26537.3 26959.2 21146.8 21235.0 21548.0 22827.8 23467.6 13:04:38 INFO - PROCESS | 30031 | 13:04:38 INFO - PROCESS | 30031 | [#2] jquery.html Cycles:180 Average:22907.45 Median:56087.94 stddev:63482.68 (113.2%) stddev-sans-first:63638.16 13:04:38 INFO - PROCESS | 30031 | Values: 342.9 344.7 344.8 345.6 347.0 13863.3 13937.7 14934.6 15280.8 15589.5 9666.4 9959.7 11876.0 15161.5 15169.7 4466.2 4676.0 4683.3 4931.1 5148.5 5077.6 5124.3 5125.6 5136.5 5402.5 5826.1 5832.1 5921.4 6162.0 6217.3 6203.4 6237.8 6272.5 6698.0 6733.6 6142.6 6353.6 6432.0 6439.4 6448.1 19358.7 19540.0 19926.9 20742.9 20843.6 1796.8 1902.4 1963.8 2005.8 2116.9 13169.6 13304.3 13488.9 13570.5 13726.3 1828.8 1897.2 1948.2 1949.2 2001.7 56011.4 56164.4 56539.4 57625.4 57934.7 14322.8 14650.2 14664.8 14709.3 14798.7 21883.1 22016.0 22063.7 22150.6 22181.0 8674.3 8688.6 8698.6 8705.9 8810.0 7239.9 7298.4 7313.3 7358.4 7377.3 7248.7 7289.5 7357.6 7366.4 7464.1 1707.5 1719.8 1802.8 2840.0 2921.9 832.9 843.5 860.5 923.9 927.7 14953.3 15047.3 15408.3 15561.8 15803.2 851.7 869.5 871.9 874.8 912.6 8669.8 8716.6 8729.8 8995.2 9094.6 378490.0 382587.0 383972.0 397614.0 397950.0 60030.0 60464.7 62875.0 63375.4 64323.0 1026.9 1030.2 1030.9 1045.5 1049.7 13589.7 13629.7 13696.5 13769.2 13960.4 30133.5 30181.8 30190.4 30626.5 30720.2 37882.0 38182.8 38903.0 39346.4 39606.8 4910.3 6528.6 6539.8 6584.5 6711.7 7127.1 7349.4 8200.9 9945.9 9954.7 6341.1 6550.4 6747.8 6837.3 7074.6 2809.7 6636.8 6737.3 6741.5 6747.9 5825.7 6225.3 6522.2 6542.9 6795.3 8716.7 8860.9 9020.1 9096.0 9164.5 8716.2 8835.2 9092.2 9115.7 9165.2 13:04:38 INFO - PROCESS | 30031 | 13:04:38 INFO - PROCESS | 30031 | [#3] mootools.html Cycles:180 Average:4642.88 Median:5613.61 stddev:2362.60 (42.1%) stddev-sans-first:2356.08 13:04:38 INFO - PROCESS | 30031 | Values: 1326.7 1349.7 1422.2 1637.7 1647.1 5719.4 5897.9 6264.9 6350.0 6375.2 6401.0 6565.5 6614.7 6618.5 6642.8 2017.3 2045.7 2048.7 2048.9 2050.1 1974.1 1987.3 1992.5 1993.7 1998.9 1985.4 1986.0 1991.2 1994.1 1995.5 1980.3 1985.8 1989.5 1993.3 1997.9 1968.5 1973.1 1974.4 1982.5 1997.2 6864.3 6868.9 6932.3 6940.6 6945.7 3860.4 3890.1 3901.6 3913.1 3939.4 2537.6 2570.6 2602.8 2646.2 2648.4 841.4 848.0 850.6 875.0 876.8 9132.5 9138.5 9152.4 9173.7 9176.7 3567.5 3593.4 3616.1 3628.8 3647.7 7787.0 7793.5 7802.0 7840.1 7847.3 3947.2 3957.9 3976.3 3977.7 3999.4 3032.7 3091.4 3496.7 3621.4 3621.6 3242.1 3259.6 3264.0 3267.5 3329.2 1035.1 1057.1 1070.7 1073.1 1074.6 1146.5 1147.8 1161.1 1164.4 1182.2 6362.2 6440.4 6441.7 6446.3 6463.2 996.2 1012.7 1025.8 1038.3 1059.4 5066.7 5108.2 5115.6 5135.4 5136.2 7612.9 7946.5 7975.1 7987.8 8040.9 7788.3 7822.3 7881.3 7894.5 7952.8 6096.4 6136.7 6207.1 6207.3 6383.2 6381.0 6474.9 6475.1 6477.7 6490.5 7145.7 7185.6 7249.3 7258.0 7263.6 6703.1 6709.4 6766.9 7429.3 7444.3 5217.0 5340.1 5955.8 6067.7 6081.2 5902.2 5997.9 6015.2 6020.9 6024.1 5650.3 5674.4 5703.9 5794.0 5809.7 5611.5 5628.3 5733.3 5761.3 5847.4 5735.9 5770.7 5784.2 5860.9 5941.3 5439.3 5472.6 5483.3 5504.4 5508.6 5543.2 5559.6 5590.3 5603.2 5615.7 13:04:38 INFO - PROCESS | 30031 | 13:04:38 INFO - PROCESS | 30031 | [#4] prototype.html Cycles:180 Average:4840.59 Median:5566.57 stddev:1456.39 (26.2%) stddev-sans-first:1419.80 13:04:38 INFO - PROCESS | 30031 | Values: 286.6 292.9 294.0 295.4 297.9 5550.2 5567.2 5659.7 5666.7 5686.0 5530.4 5553.4 5558.3 5562.2 5565.9 4294.6 4296.2 4296.9 4297.0 4300.5 4014.5 4117.4 4166.2 4257.8 4289.3 4233.3 4237.9 4238.0 4246.9 4260.1 4222.8 4236.3 4238.0 4279.4 4281.7 3732.7 3733.8 3734.7 3737.1 3739.8 5171.2 5327.4 5334.3 5358.6 5358.8 4770.1 4818.9 4826.0 4830.9 4837.3 5808.0 5809.2 5810.1 5836.1 5854.7 3902.6 3919.1 3925.9 3933.7 3935.2 5987.9 6023.6 6140.8 6154.2 6161.7 4082.3 4087.3 4089.9 4090.2 4094.4 4140.1 4155.4 4156.2 4160.3 4169.1 4769.5 4814.0 4820.1 4829.1 4841.3 5633.0 5846.9 5847.7 5857.5 5864.5 1453.5 1461.8 1465.0 1466.2 1466.5 961.9 981.4 986.2 989.0 992.2 5064.2 5065.6 5075.2 5087.3 5103.8 5915.0 6065.2 6068.2 6123.1 6133.4 5128.2 5143.3 5152.4 5155.5 5169.3 3229.7 3266.2 3270.5 3270.6 3299.6 5660.3 5729.0 5752.9 5769.9 5791.7 6332.5 6340.6 6348.7 6359.1 6367.8 5762.1 5784.1 5802.9 5808.6 5809.5 6094.6 6116.3 6126.9 6138.2 6149.8 5903.8 5942.6 6051.0 6088.8 6096.4 5745.8 5768.2 5778.6 5786.7 5791.5 3991.9 4026.7 4039.9 4043.2 4055.8 6010.2 6137.6 6139.4 6144.8 6146.1 5879.4 5906.5 5909.5 5911.1 5914.7 5885.3 5886.4 5891.4 5907.6 5913.6 5624.6 5762.3 5770.5 5773.0 5780.1 5909.1 5931.1 5941.6 5964.3 5968.5 5773.0 5801.4 5838.7 5839.0 5843.6 13:04:38 INFO - PROCESS | 30031 | 13:04:38 INFO - PROCESS | 30031 | [#5] yui.html Cycles:180 Average:11580.41 Median:528.94 stddev:12861.62 (2431.6%) stddev-sans-first:12871.68 13:04:38 INFO - PROCESS | 30031 | Values: 685.5 741.8 758.0 770.2 782.9 11250.1 11412.0 11475.5 11493.1 11493.7 10463.2 10822.5 11368.2 11406.5 11545.4 719.3 739.2 741.5 742.6 742.9 742.8 747.7 750.0 751.9 754.3 777.1 782.7 783.1 783.8 785.0 776.1 776.7 776.9 776.9 780.3 575.7 579.4 580.1 580.1 581.5 9915.7 9927.9 9938.9 9997.1 10011.0 9666.8 9962.8 9971.9 9973.0 10164.5 10538.0 10755.5 10912.7 10957.8 11032.6 3972.5 4036.0 4047.8 4108.4 4162.9 36103.0 36244.8 39186.0 39769.0 40495.4 8025.2 8741.3 9163.8 9277.7 9518.4 15087.2 15212.5 15217.2 15243.3 15303.6 6597.2 6776.2 6855.5 6903.6 6907.6 3658.6 3785.8 3846.5 3850.7 3873.1 2645.5 2664.6 2673.3 2682.0 2684.0 475.4 484.1 484.9 491.8 492.1 529.8 535.2 558.7 559.0 568.3 7396.9 7504.5 7673.9 7677.3 7803.6 520.9 528.4 529.5 530.7 533.3 3485.6 3558.1 3566.3 3581.8 3606.2 43539.6 46068.5 47323.8 47492.5 47602.8 37744.6 38601.4 39214.6 39287.2 39294.8 38425.0 38433.4 38888.4 38901.8 39153.6 7473.1 7484.3 7556.1 7593.8 7706.2 29705.7 29944.9 30099.8 30482.4 30493.5 37882.4 37894.6 38233.0 38615.4 38687.2 9035.3 9248.8 9267.0 9309.6 9717.0 10252.5 10294.4 10363.4 10436.1 10447.6 9916.2 10021.6 10044.5 10045.7 10123.1 9531.4 9570.4 9602.5 9614.8 9615.5 9910.1 9994.9 10040.4 10089.2 10090.5 8593.9 8622.0 8638.0 8710.0 8774.7 8605.0 8660.8 8669.1 8676.9 8797.1 13:04:38 INFO - PROCESS | 30031 | -------- Summary: end -------- 13:04:38 INFO - PROCESS | 30031 | 13:04:39 INFO - TEST-INFO | 30031: exit 0 13:04:39 INFO - TEST-OK | dromaeo_css | took 1114724ms 13:04:39 INFO - TEST-START | kraken 13:04:39 INFO - operating with platform_type : linux_ 13:04:39 INFO - Initialising browser for kraken test... 13:04:39 INFO - TEST-INFO | started process 30274 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKMDLGa/profile http://localhost:43158/getInfo.html) 13:04:43 INFO - PROCESS | 30274 | 13:04:43 INFO - PROCESS | 30274 | (process:30347): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:04:44 INFO - PROCESS | 30274 | __metrics Screen width/height:1600/1200 13:04:44 INFO - PROCESS | 30274 | colorDepth:24 13:04:44 INFO - PROCESS | 30274 | Browser inner width/height: 1024/697 13:04:44 INFO - PROCESS | 30274 | __metrics 13:04:44 INFO - PROCESS | 30274 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:04:45 INFO - TEST-INFO | 30274: exit 0 13:04:45 INFO - Browser initialized. 13:04:45 INFO - Running cycle 1/1 for kraken test... 13:04:45 INFO - TEST-INFO | started process 30396 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKMDLGa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:04:46 INFO - PROCESS | 30396 | -- checkerboarding starts below -- 13:04:46 INFO - PROCESS | 30396 | RENDERTRACE 0.073212 rect red 0 0 10 10 // viewport 13:04:46 INFO - PROCESS | 30396 | RENDERTRACE 12.0352 rect brown 0 0 10 10 // page 13:04:46 INFO - PROCESS | 30396 | RENDERTRACE 12.0525 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 13:04:46 INFO - PROCESS | 30396 | Checkerboarded for 1 frames (12.0763 ms), 100 peak, 2 severity. 13:04:46 INFO - PROCESS | 30396 | 13:04:46 INFO - PROCESS | 30396 | (process:30451): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:04:57 INFO - PROCESS | 30396 | RSS: Main: 150454272 13:04:57 INFO - PROCESS | 30396 | 13:04:59 INFO - PROCESS | 30396 | Cycle 1(1): loaded http://localhost:43158/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43158/tests/kraken/driver.html?testName=audio-beat-detection) 13:05:00 INFO - PROCESS | 30396 | RSS: Main: 149094400 13:05:00 INFO - PROCESS | 30396 | 13:05:03 INFO - PROCESS | 30396 | Cycle 1(1): loaded http://localhost:43158/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43158/tests/kraken/driver.html?testName=audio-dft) 13:05:03 INFO - PROCESS | 30396 | RSS: Main: 152211456 13:05:03 INFO - PROCESS | 30396 | 13:05:06 INFO - PROCESS | 30396 | Cycle 1(1): loaded http://localhost:43158/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43158/tests/kraken/driver.html?testName=audio-fft) 13:05:07 INFO - PROCESS | 30396 | RSS: Main: 147857408 13:05:07 INFO - PROCESS | 30396 | 13:05:09 INFO - PROCESS | 30396 | Cycle 1(1): loaded http://localhost:43158/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43158/tests/kraken/driver.html?testName=audio-oscillator) 13:05:10 INFO - PROCESS | 30396 | RSS: Main: 147181568 13:05:10 INFO - PROCESS | 30396 | 13:05:12 INFO - PROCESS | 30396 | Cycle 1(1): loaded http://localhost:43158/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43158/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:05:12 INFO - PROCESS | 30396 | RSS: Main: 148365312 13:05:12 INFO - PROCESS | 30396 | 13:05:16 INFO - PROCESS | 30396 | Cycle 1(1): loaded http://localhost:43158/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43158/tests/kraken/driver.html?testName=imaging-darkroom) 13:05:16 INFO - PROCESS | 30396 | RSS: Main: 147460096 13:05:16 INFO - PROCESS | 30396 | 13:05:20 INFO - PROCESS | 30396 | Cycle 1(1): loaded http://localhost:43158/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43158/tests/kraken/driver.html?testName=imaging-desaturate) 13:05:20 INFO - PROCESS | 30396 | RSS: Main: 147148800 13:05:20 INFO - PROCESS | 30396 | 13:05:23 INFO - PROCESS | 30396 | Cycle 1(1): loaded http://localhost:43158/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43158/tests/kraken/driver.html?testName=json-parse-financial) 13:05:24 INFO - PROCESS | 30396 | RSS: Main: 147906560 13:05:24 INFO - PROCESS | 30396 | 13:05:26 INFO - PROCESS | 30396 | Cycle 1(1): loaded http://localhost:43158/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43158/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:05:26 INFO - PROCESS | 30396 | RSS: Main: 149180416 13:05:26 INFO - PROCESS | 30396 | 13:05:28 INFO - PROCESS | 30396 | Cycle 1(1): loaded http://localhost:43158/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43158/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:05:29 INFO - PROCESS | 30396 | RSS: Main: 148557824 13:05:29 INFO - PROCESS | 30396 | 13:05:31 INFO - PROCESS | 30396 | Cycle 1(1): loaded http://localhost:43158/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43158/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:05:31 INFO - PROCESS | 30396 | RSS: Main: 148623360 13:05:31 INFO - PROCESS | 30396 | 13:05:34 INFO - PROCESS | 30396 | Cycle 1(1): loaded http://localhost:43158/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43158/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:05:35 INFO - PROCESS | 30396 | RSS: Main: 148938752 13:05:35 INFO - PROCESS | 30396 | 13:05:37 INFO - PROCESS | 30396 | Cycle 1(1): loaded http://localhost:43158/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43158/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:05:38 INFO - PROCESS | 30396 | RSS: Main: 149843968 13:05:38 INFO - PROCESS | 30396 | 13:05:40 INFO - PROCESS | 30396 | Cycle 1(1): loaded http://localhost:43158/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43158/tests/kraken/driver.html?testName=ai-astar) 13:05:40 INFO - PROCESS | 30396 | RSS: Main: 149532672 13:05:40 INFO - PROCESS | 30396 | 13:05:40 INFO - PROCESS | 30396 | __start_tp_report 13:05:40 INFO - PROCESS | 30396 | _x_x_mozilla_page_load 13:05:40 INFO - PROCESS | 30396 | _x_x_mozilla_page_load_details 13:05:40 INFO - PROCESS | 30396 | |i|pagename|runs| 13:05:40 INFO - PROCESS | 30396 | |0;ai-astar;118;112;114;116;118;126;118;116;115;117 13:05:40 INFO - PROCESS | 30396 | |1;audio-beat-detection;162;134;172;170;137;160;155;139;187;135 13:05:40 INFO - PROCESS | 30396 | |2;audio-dft;164;163;166;166;167;169;164;164;163;163 13:05:40 INFO - PROCESS | 30396 | |3;audio-fft;75;77;75;78;77;129;74;74;75;74 13:05:40 INFO - PROCESS | 30396 | |4;audio-oscillator;98;99;130;97;98;98;147;99;98;137 13:05:40 INFO - PROCESS | 30396 | |5;imaging-gaussian-blur;111;111;111;110;109;110;110;110;110;110 13:05:40 INFO - PROCESS | 30396 | |6;imaging-darkroom;148;148;148;148;148;149;147;148;148;150 13:05:40 INFO - PROCESS | 30396 | |7;imaging-desaturate;96;99;96;97;96;96;97;97;97;96 13:05:40 INFO - PROCESS | 30396 | |8;json-parse-financial;77;72;73;73;73;73;72;72;82;71 13:05:40 INFO - PROCESS | 30396 | |9;json-stringify-tinderbox;70;69;69;69;68;69;69;68;68;69 13:05:40 INFO - PROCESS | 30396 | |10;stanford-crypto-aes;83;83;84;89;85;85;83;85;83;84 13:05:40 INFO - PROCESS | 30396 | |11;stanford-crypto-ccm;130;119;121;128;124;137;131;134;128;136 13:05:40 INFO - PROCESS | 30396 | |12;stanford-crypto-pbkdf2;151;154;153;158;147;150;147;148;150;148 13:05:40 INFO - PROCESS | 30396 | |13;stanford-crypto-sha256-iterative;71;75;73;72;73;71;76;72;73;73 13:05:40 INFO - PROCESS | 30396 | __end_tp_report 13:05:40 INFO - PROCESS | 30396 | __start_cc_report 13:05:40 INFO - PROCESS | 30396 | _x_x_mozilla_cycle_collect,811 13:05:40 INFO - PROCESS | 30396 | __end_cc_report 13:05:40 INFO - PROCESS | 30396 | __startTimestamp1453323940451__endTimestamp 13:05:40 INFO - PROCESS | 30396 | 13:05:40 INFO - PROCESS | 30396 | ------- Summary: start ------- 13:05:40 INFO - PROCESS | 30396 | Number of tests: 14 13:05:40 INFO - PROCESS | 30396 | 13:05:40 INFO - PROCESS | 30396 | [#0] ai-astar Cycles:10 Average:117.00 Median:117.50 stddev:3.71 (3.2%) stddev-sans-first:3.92 13:05:40 INFO - PROCESS | 30396 | Values: 118.0 112.0 114.0 116.0 118.0 126.0 118.0 116.0 115.0 117.0 13:05:40 INFO - PROCESS | 30396 | 13:05:40 INFO - PROCESS | 30396 | [#1] audio-beat-detection Cycles:10 Average:155.10 Median:161.00 stddev:18.36 (11.4%) stddev-sans-first:19.30 13:05:40 INFO - PROCESS | 30396 | Values: 162.0 134.0 172.0 170.0 137.0 160.0 155.0 139.0 187.0 135.0 13:05:40 INFO - PROCESS | 30396 | 13:05:40 INFO - PROCESS | 30396 | [#2] audio-dft Cycles:10 Average:164.90 Median:165.00 stddev:2.02 (1.2%) stddev-sans-first:2.12 13:05:40 INFO - PROCESS | 30396 | Values: 164.0 163.0 166.0 166.0 167.0 169.0 164.0 164.0 163.0 163.0 13:05:40 INFO - PROCESS | 30396 | 13:05:40 INFO - PROCESS | 30396 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.00 stddev:17.00 (22.7%) stddev-sans-first:17.90 13:05:40 INFO - PROCESS | 30396 | Values: 75.0 77.0 75.0 78.0 77.0 129.0 74.0 74.0 75.0 74.0 13:05:40 INFO - PROCESS | 30396 | 13:05:40 INFO - PROCESS | 30396 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:98.00 stddev:19.68 (20.1%) stddev-sans-first:20.38 13:05:40 INFO - PROCESS | 30396 | Values: 98.0 99.0 130.0 97.0 98.0 98.0 147.0 99.0 98.0 137.0 13:05:40 INFO - PROCESS | 30396 | 13:05:40 INFO - PROCESS | 30396 | [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 13:05:40 INFO - PROCESS | 30396 | Values: 111.0 111.0 111.0 110.0 109.0 110.0 110.0 110.0 110.0 110.0 13:05:40 INFO - PROCESS | 30396 | 13:05:40 INFO - PROCESS | 30396 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 13:05:40 INFO - PROCESS | 30396 | Values: 148.0 148.0 148.0 148.0 148.0 149.0 147.0 148.0 148.0 150.0 13:05:40 INFO - PROCESS | 30396 | 13:05:40 INFO - PROCESS | 30396 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.95 (1.0%) stddev-sans-first:0.97 13:05:40 INFO - PROCESS | 30396 | Values: 96.0 99.0 96.0 97.0 96.0 96.0 97.0 97.0 97.0 96.0 13:05:40 INFO - PROCESS | 30396 | 13:05:40 INFO - PROCESS | 30396 | [#8] json-parse-financial Cycles:10 Average:73.80 Median:73.00 stddev:3.29 (4.5%) stddev-sans-first:3.28 13:05:40 INFO - PROCESS | 30396 | Values: 77.0 72.0 73.0 73.0 73.0 73.0 72.0 72.0 82.0 71.0 13:05:40 INFO - PROCESS | 30396 | 13:05:40 INFO - PROCESS | 30396 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.63 (0.9%) stddev-sans-first:0.50 13:05:40 INFO - PROCESS | 30396 | Values: 70.0 69.0 69.0 69.0 68.0 69.0 69.0 68.0 68.0 69.0 13:05:40 INFO - PROCESS | 30396 | 13:05:40 INFO - PROCESS | 30396 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.50 stddev:1.84 (2.2%) stddev-sans-first:1.88 13:05:40 INFO - PROCESS | 30396 | Values: 83.0 83.0 84.0 89.0 85.0 85.0 83.0 85.0 83.0 84.0 13:05:40 INFO - PROCESS | 30396 | 13:05:40 INFO - PROCESS | 30396 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:130.50 stddev:6.09 (4.7%) stddev-sans-first:6.44 13:05:40 INFO - PROCESS | 30396 | Values: 130.0 119.0 121.0 128.0 124.0 137.0 131.0 134.0 128.0 136.0 13:05:40 INFO - PROCESS | 30396 | 13:05:40 INFO - PROCESS | 30396 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.60 Median:150.50 stddev:3.53 (2.3%) stddev-sans-first:3.75 13:05:40 INFO - PROCESS | 30396 | Values: 151.0 154.0 153.0 158.0 147.0 150.0 147.0 148.0 150.0 148.0 13:05:40 INFO - PROCESS | 30396 | 13:05:40 INFO - PROCESS | 30396 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.90 Median:73.00 stddev:1.60 (2.2%) stddev-sans-first:1.54 13:05:40 INFO - PROCESS | 30396 | Values: 71.0 75.0 73.0 72.0 73.0 71.0 76.0 72.0 73.0 73.0 13:05:40 INFO - PROCESS | 30396 | -------- Summary: end -------- 13:05:40 INFO - PROCESS | 30396 | 13:05:41 INFO - TEST-INFO | 30396: exit 0 13:05:41 INFO - TEST-OK | kraken | took 61762ms 13:05:41 INFO - TEST-START | v8_7 13:05:41 INFO - operating with platform_type : linux_ 13:05:41 INFO - Initialising browser for v8_7 test... 13:05:41 INFO - TEST-INFO | started process 30679 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc7SDEa/profile http://localhost:43158/getInfo.html) 13:05:44 INFO - PROCESS | 30679 | -- checkerboarding starts below -- 13:05:44 INFO - PROCESS | 30679 | RENDERTRACE 0.042692 rect red 0 0 1024 768 // viewport 13:05:44 INFO - PROCESS | 30679 | RENDERTRACE 293.673 rect brown 0 0 1024 768 // page 13:05:44 INFO - PROCESS | 30679 | RENDERTRACE 293.703 rect lightgreen 0 0 1024 768 // painted displayport (this layertree updated) 13:05:44 INFO - PROCESS | 30679 | Checkerboarded for 1 frames (299.829 ms), 786432 peak, 13756 severity. 13:05:45 INFO - PROCESS | 30679 | 13:05:45 INFO - PROCESS | 30679 | (process:30749): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:05:45 INFO - PROCESS | 30679 | __metrics Screen width/height:1600/1200 13:05:45 INFO - PROCESS | 30679 | colorDepth:24 13:05:45 INFO - PROCESS | 30679 | Browser inner width/height: 1024/697 13:05:45 INFO - PROCESS | 30679 | __metrics 13:05:46 INFO - PROCESS | 30679 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:05:46 INFO - TEST-INFO | 30679: exit 0 13:05:46 INFO - Browser initialized. 13:05:46 INFO - Running cycle 1/1 for v8_7 test... 13:05:46 INFO - TEST-INFO | started process 30798 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc7SDEa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:05:47 INFO - PROCESS | 30798 | -- checkerboarding starts below -- 13:05:47 INFO - PROCESS | 30798 | RENDERTRACE 0.052249 rect red 0 0 10 10 // viewport 13:05:47 INFO - PROCESS | 30798 | RENDERTRACE 29.7663 rect brown 0 0 10 10 // page 13:05:47 INFO - PROCESS | 30798 | RENDERTRACE 29.7909 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 13:05:47 INFO - PROCESS | 30798 | Checkerboarded for 1 frames (29.841 ms), 100 peak, 2 severity. 13:05:48 INFO - PROCESS | 30798 | 13:05:48 INFO - PROCESS | 30798 | (process:30853): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:05:58 INFO - PROCESS | 30798 | RSS: Main: 150491136 13:05:58 INFO - PROCESS | 30798 | 13:06:21 INFO - PROCESS | 30798 | Cycle 1(1): loaded http://localhost:43158/tests/v8_7/run.html (next: http://localhost:43158/tests/v8_7/run.html) 13:06:21 INFO - PROCESS | 30798 | RSS: Main: 145117184 13:06:21 INFO - PROCESS | 30798 | 13:06:21 INFO - PROCESS | 30798 | __start_tp_report 13:06:21 INFO - PROCESS | 30798 | _x_x_mozilla_page_load 13:06:21 INFO - PROCESS | 30798 | _x_x_mozilla_page_load_details 13:06:21 INFO - PROCESS | 30798 | |i|pagename|runs| 13:06:21 INFO - PROCESS | 30798 | |0;Richards;169.09029421711193 13:06:21 INFO - PROCESS | 30798 | |1;DeltaBlue;187.82870022539444 13:06:21 INFO - PROCESS | 30798 | |2;Encrypt;278.55153203342616 13:06:21 INFO - PROCESS | 30798 | |3;Decrypt;5284.210526315789 13:06:21 INFO - PROCESS | 30798 | |4;RayTrace;1071.8113612004288 13:06:21 INFO - PROCESS | 30798 | |5;Earley;707.2135785007072 13:06:21 INFO - PROCESS | 30798 | |6;Boyer;12395.061728395061 13:06:21 INFO - PROCESS | 30798 | |7;RegExp;43553.1914893617 13:06:21 INFO - PROCESS | 30798 | |8;Splay;677.9661016949152 13:06:21 INFO - PROCESS | 30798 | |9;NavierStokes;4845.410628019324 13:06:21 INFO - PROCESS | 30798 | __end_tp_report 13:06:21 INFO - PROCESS | 30798 | __startTimestamp1453323981658__endTimestamp 13:06:21 INFO - PROCESS | 30798 | 13:06:21 INFO - PROCESS | 30798 | ------- Summary: start ------- 13:06:21 INFO - PROCESS | 30798 | Number of tests: 10 13:06:21 INFO - PROCESS | 30798 | 13:06:21 INFO - PROCESS | 30798 | [#0] Richards Cycles:1 Average:169.09 Median:169.09 stddev:0.00 (0.0%) 13:06:21 INFO - PROCESS | 30798 | Values: 169.1 13:06:21 INFO - PROCESS | 30798 | 13:06:21 INFO - PROCESS | 30798 | [#1] DeltaBlue Cycles:1 Average:187.83 Median:187.83 stddev:0.00 (0.0%) 13:06:21 INFO - PROCESS | 30798 | Values: 187.8 13:06:21 INFO - PROCESS | 30798 | 13:06:21 INFO - PROCESS | 30798 | [#2] Encrypt Cycles:1 Average:278.55 Median:278.55 stddev:0.00 (0.0%) 13:06:21 INFO - PROCESS | 30798 | Values: 278.6 13:06:21 INFO - PROCESS | 30798 | 13:06:21 INFO - PROCESS | 30798 | [#3] Decrypt Cycles:1 Average:5284.21 Median:5284.21 stddev:0.00 (0.0%) 13:06:21 INFO - PROCESS | 30798 | Values: 5284.2 13:06:21 INFO - PROCESS | 30798 | 13:06:21 INFO - PROCESS | 30798 | [#4] RayTrace Cycles:1 Average:1071.81 Median:1071.81 stddev:0.00 (0.0%) 13:06:21 INFO - PROCESS | 30798 | Values: 1071.8 13:06:21 INFO - PROCESS | 30798 | 13:06:21 INFO - PROCESS | 30798 | [#5] Earley Cycles:1 Average:707.21 Median:707.21 stddev:0.00 (0.0%) 13:06:21 INFO - PROCESS | 30798 | Values: 707.2 13:06:21 INFO - PROCESS | 30798 | 13:06:21 INFO - PROCESS | 30798 | [#6] Boyer Cycles:1 Average:12395.06 Median:12395.06 stddev:0.00 (0.0%) 13:06:21 INFO - PROCESS | 30798 | Values: 12395.1 13:06:21 INFO - PROCESS | 30798 | 13:06:21 INFO - PROCESS | 30798 | [#7] RegExp Cycles:1 Average:43553.19 Median:43553.19 stddev:0.00 (0.0%) 13:06:21 INFO - PROCESS | 30798 | Values: 43553.2 13:06:21 INFO - PROCESS | 30798 | 13:06:21 INFO - PROCESS | 30798 | [#8] Splay Cycles:1 Average:677.97 Median:677.97 stddev:0.00 (0.0%) 13:06:21 INFO - PROCESS | 30798 | Values: 678.0 13:06:21 INFO - PROCESS | 30798 | 13:06:21 INFO - PROCESS | 30798 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 13:06:21 INFO - PROCESS | 30798 | Values: 4845.4 13:06:21 INFO - PROCESS | 30798 | -------- Summary: end -------- 13:06:21 INFO - PROCESS | 30798 | 13:06:22 INFO - TEST-INFO | 30798: exit 0 13:06:22 INFO - TEST-OK | v8_7 | took 41195ms 13:06:22 INFO - SUITE-END | took 1217s 13:06:22 INFO - Completed test suite (00:20:17) 13:06:22 INFO - Working with test: dromaeo_css 13:06:22 INFO - Generating results file: dromaeo_css 13:06:22 INFO - Working with test: kraken 13:06:22 INFO - Generating results file: kraken 13:06:22 INFO - javascript benchmark 13:06:22 INFO - Working with test: v8_7 13:06:22 INFO - Generating results file: v8_7 13:06:22 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:06:22 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 13:06:22 INFO - process_Request line: dromaeo_css 6116.32 graph.html#tests=[[72,132,43]] 13:06:22 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:06:22 INFO - process_Request line: kraken 1562.30 graph.html#tests=[[232,132,43]] 13:06:22 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:06:22 INFO - process_Request line: v8_7 19971.27 graph.html#tests=[[230,132,43]] 13:06:22 INFO - RETURN: dromaeo_css: 6116.32 13:06:22 INFO - RETURN: kraken: 1562.30 13:06:22 INFO - RETURN: v8_7: 19971.27 13:06:22 INFO - javascript benchmark 13:06:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2554.846709197447, 2588.8576128312934, 2592.6111083337505, 2599.2202339298206, 2601.479704059188, 4458.464984201896, 4458.55414458554, 4524.570165834245, 4540.046590216054, 4557.361969324297, 4532.478764942032, 4543.159515489637, 4580.450345958489, 4605.608523275526, 4612.97693511532, 4183.435236243106, 4194.475690538683, 4261.062566235423, 4267.1252393259465, 4289.270823959934, 4267.189234045537, 4304.440422745054, 4316.179925814101, 4342.392065110887, 4395.230834603947, 4136.524299705542, 4140.772257525835, 4209.5579964103945, 4215.262329092412, 4221.029163292429, 4158.480189976253, 4187.890209094592, 4197.91604167918, 4199.0552125771455, 4229.154169166149, 4181.268278051329, 4188.015816283171, 4195.077083041726, 4213.2837417639075, 4215.093754842693, 4288.828446862121, 4393.472783266028, 4417.646588272931, 4419.845305414327, 4482.529334419904, 4840.443349014838, 4849.612031037508, 4865.781039853215, 4865.82969596066, 4917.901641967176, 4719.244920812654, 4838.0, 4854.732989685566, 4859.781309841065, 4893.779779909913, 4467.776611169428, 4481.820727170942, 4508.526604706459, 4523.7285762854335, 4555.589996900295, 4952.62855285855, 4970.801167953314, 4975.527324904128, 4976.42771081323, 5026.874328141753, 4612.584867361887, 4687.554682305175, 4772.331873537708, 4773.284007398918, 4822.71063736177, 4885.706857588556, 4905.3623029006, 4931.161702510582, 4937.407511098691, 4990.950090499121, 4793.38184786608, 4805.543473370024, 4821.879453013703, 4826.806927722922, 4854.368932038883, 4720.12677654635, 4805.0, 4811.663183577186, 4830.8792280193275, 4846.29728689338, 4079.303809400938, 4087.4890638670167, 4091.243120022805, 4097.037196258877, 4106.301928672133, 3557.6975957043423, 3558.484019817112, 3591.479235510836, 3593.047842321787, 3610.9638903610626, 4124.711270211056, 4217.831286748496, 4233.555476674905, 4280.122574872144, 4309.525952145262, 4818.349522814446, 4831.782569784368, 4856.708597484162, 4866.46468888422, 4909.091818013679, 4170.666346692318, 4219.641330486943, 4226.76752778594, 4234.216669916075, 4263.936040959388, 4289.420928174719, 4332.848350307724, 4346.065595896897, 4387.166438376698, 4392.714473559208, 4627.9074418511445, 4633.606143477842, 4644.349791029191, 4660.7669616519715, 4712.057588482248, 4785.59322457581, 4913.729744864067, 4923.8276660316715, 4932.4081110267, 4986.7257300848805, 4563.087382523442, 4657.0685862826895, 4682.367880336111, 4687.554682305175, 4725.36207611968, 4817.229243321192, 4833.540813622701, 4838.903221935612, 4845.079434907357, 4863.0, 4721.669483136147, 4812.398450193726, 4914.410270767531, 4922.138625740409, 4972.65191436596, 4723.858284251478, 4731.148393289241, 4752.786124624331, 4759.16714574941, 4782.497837726988, 4738.597219236403, 4747.382840230748, 4749.073930583503, 4759.381280433521, 4809.374781278411, 4485.798139083814, 4532.4334458192725, 4662.5104364042645, 4669.556392142741, 4673.252279635242, 4807.375041244755, 4837.927431088607, 4839.41926968766, 4848.0546293472435, 4874.195757699939, 4726.314684370678, 4740.881477963078, 4744.1460537102275, 4750.406199225097, 4792.856214313576], "unit": "score", "name": "dojo.html", "value": 4475.938142915438}, {"lowerIsBetter": false, "replicates": [499.84005118362137, 514.5626217714943, 556.5992485410505, 565.4091474409242, 566.0264345326037, 24218.87890560547, 31023.379532409366, 31453.21366965827, 31455.52816707751, 31498.68501314986, 34788.652113478856, 35251.294974100565, 35271.470927936105, 35280.0, 35299.11752206196, 7445.329920307171, 7678.462507624468, 7696.615169241543, 7735.30382265596, 7759.379249660014, 7537.585432801194, 7674.5395276283325, 7677.654505547236, 7678.155402905676, 7747.031621047369, 7828.608569571498, 7858.1356050834365, 7892.644830982591, 7892.881606775903, 7909.485883417588, 7656.846863062736, 7662.272084151997, 7693.461457697963, 7736.6518506667335, 7795.220477952216, 7563.470557061008, 7611.2388761124, 7621.695132194705, 7650.0, 7693.422993275527, 35520.0, 35907.10232244189, 36001.81999089988, 36019.279614407824, 36074.0, 2824.5216215140936, 2877.352595665979, 2879.280179955011, 2894.2619631993916, 3270.9018729438153, 27008.459830803273, 27029.594556081676, 27212.45575088487, 27366.45267094647, 27728.30679233015, 3434.759566830323, 3474.270403215328, 3508.333416650854, 3537.4163263061564, 3586.37238483267, 158408.0, 158498.0, 159030.0, 159755.0, 160026.19986899992, 43290.0, 44074.77962610166, 51227.0, 51994.22008669873, 52040.47959520432, 45460.3180952286, 45974.77012614915, 46011.30983035257, 46071.76964115225, 46199.30701039487, 13611.931940340235, 13799.655008624664, 13865.09876858001, 13869.237191954338, 13906.930465347608, 10555.683329500127, 10593.947030264953, 10595.94702026485, 10780.29928054674, 10793.352398856094, 17307.826921730873, 17528.12359382026, 17604.735928961076, 17621.471355859343, 17739.556511087325, 6930.757423490254, 7076.646167691595, 7116.466265030143, 7131.750388736369, 7169.390601798906, 857.8241460500707, 898.6540182029966, 922.2022950148073, 988.8417853143462, 1007.3250921882357, 25823.741762582133, 26162.73837261641, 26222.606660900103, 26230.606540901903, 26260.86869565678, 976.472704739447, 988.6687959533493, 1012.7518757904361, 1082.7617924056854, 1102.0247081333077, 13022.088453808332, 13080.476780928846, 13152.0, 13225.669358265928, 14353.067050641675, 243872.0, 247270.0, 249165.05009699112, 249632.0, 249639.0, 44323.11353772906, 44718.77640611776, 44799.77600112044, 44933.32600011003, 44961.550384495735, 1211.5335595795682, 1215.3740823475916, 1234.1299383934304, 1235.8764123587748, 1358.4090920449637, 25313.62029569521, 26335.0, 26561.867190663925, 26662.866685666446, 26956.73043269542, 39459.0, 40769.0, 40813.0, 40863.7956810214, 40899.591004089576, 168683.15658421628, 168935.0, 170017.8994630163, 170218.14890925467, 170408.0, 27484.312892177855, 27487.17538473849, 27636.723632763416, 27639.86180069087, 28171.859140704164, 32067.518987215677, 32068.19829504188, 32238.67761322357, 32931.50602740913, 33382.49926251157, 28300.85849570739, 28652.713472865005, 28774.7122528772, 29758.702412975592, 30314.39371212519, 30230.0, 30260.24349391283, 30384.0, 30861.0, 32018.839905800323, 28779.71220287854, 28839.0, 29175.7082429173, 29231.561526577545, 29311.413771724874, 25017.374565636004, 26349.341266467723, 26439.0, 26537.33656658599, 26959.191224263304, 21146.788532115097, 21235.0, 21548.0, 22827.771722282563, 23467.647985280575], "unit": "score", "name": "ext.html", "value": 15720.403801446748}, {"lowerIsBetter": false, "replicates": [342.8611412377987, 344.65706621911204, 344.84309639114207, 345.62154440887235, 347.01620904735074, 13863.306834658264, 13937.651558711037, 14934.551963441087, 15280.847191528068, 15589.532314030568, 9666.420014799118, 9959.651412200574, 11876.049916006721, 15161.545153645407, 15169.696606067899, 4466.196084704752, 4675.976620116895, 4683.2975053741875, 4931.112399768041, 5148.459411761749, 5077.619178561604, 5124.308218390525, 5125.589952803785, 5136.460671629481, 5402.486763757437, 5826.096954971986, 5832.125181222829, 5921.407859214087, 6162.0, 6217.253929528463, 6203.379662033805, 6237.844053898643, 6272.466840318579, 6697.995300704884, 6733.629650369227, 6142.600730952474, 6353.618782873043, 6432.0, 6439.35606439357, 6448.097266382711, 19358.709619355723, 19540.0, 19926.900365498226, 20742.896285518626, 20843.5831283375, 1796.7843858736906, 1902.4387805597244, 1963.803619638039, 2005.7720776987535, 2116.8518203725744, 13169.604911852659, 13304.268265245408, 13488.932555337258, 13570.45718171272, 13726.313684315845, 1828.7988321284647, 1897.2221389230488, 1948.1720268885667, 1949.220311875247, 2001.6997450382414, 56011.43988560103, 56164.43835561633, 56539.43460565424, 57625.423745762426, 57934.7103264481, 14322.785158222636, 14650.194239316726, 14664.780028299583, 14709.338079786436, 14798.704025919422, 21883.12467501314, 22016.0, 22063.66904496434, 22150.560213586064, 22181.0, 8674.30605551567, 8688.609012594448, 8698.565071746387, 8705.869411958825, 8810.0, 7239.855202895913, 7298.379637730853, 7313.268673132644, 7358.41132709382, 7377.33603975634, 7248.6738096785775, 7289.489735718449, 7357.632118394059, 7366.410687145016, 7464.104307483137, 1707.4792188382414, 1719.7764290642137, 1802.837744602992, 2840.0, 2921.8539073046263, 832.904216015166, 843.5191940593925, 860.4536119564121, 923.8706581078654, 927.7495076329353, 14953.252337383088, 15047.322870470636, 15408.306626201847, 15561.844381556266, 15803.20983950798, 851.7189327521903, 869.5478351257311, 871.8822958900594, 874.8381549413378, 912.5802131019806, 8669.783255418539, 8716.607752651145, 8729.825403491895, 8995.235404990519, 9094.636214551476, 378490.0, 382587.0, 383972.041817281, 397614.0, 397950.0, 60030.0, 60464.697676511336, 62875.0, 63375.36624633787, 64323.0, 1026.90757831794, 1030.2479190191352, 1030.922680798928, 1045.4668119259234, 1049.679847646475, 13589.660258493617, 13629.727405452033, 13696.452141914211, 13769.242691652054, 13960.441582336593, 30133.547996779627, 30181.849090754407, 30190.396192076474, 30626.540601890545, 30720.231994200323, 37882.0, 38182.809085954395, 38903.0, 39346.40980385354, 39606.80196598999, 4910.337104490991, 6528.608283503005, 6539.790138824333, 6584.539082264196, 6711.664416779239, 7127.144742630918, 7349.448791340564, 8200.876986845322, 9945.900540994788, 9954.701358959242, 6341.112244285711, 6550.443212327005, 6747.831304217434, 6837.282085381163, 7074.610896400747, 2809.7471227589617, 6636.800895973129, 6737.326267373223, 6741.528093033637, 6747.898781518379, 5825.650460972355, 6225.252969643671, 6522.184726909137, 6542.901856472062, 6795.3204679531655, 8716.738497845075, 8860.911390886267, 9020.097990200928, 9095.95452022762, 9164.495952722664, 8716.210812539926, 8835.249003834746, 9092.22716069115, 9115.726528204164, 9165.220956218796], "unit": "score", "name": "jquery.html", "value": 8010.1949435986635}, {"lowerIsBetter": false, "replicates": [1326.6932071909168, 1349.7368013237417, 1422.2177802208782, 1637.737961926092, 1647.0611751301756, 5719.428057194278, 5897.911531327033, 6264.874702505953, 6349.968250158749, 6375.203099612549, 6400.967995160017, 6565.507586930976, 6614.669266536666, 6618.470522358211, 6642.833929151761, 2017.3443630820007, 2045.7340545729035, 2048.702938073978, 2048.8565800393976, 2050.05697379205, 1974.062320397814, 1987.2746447546613, 1992.4819546917834, 1993.710911917771, 1998.8700734452286, 1985.4341512668893, 1986.04669758516, 1991.2234228650839, 1994.1425187169511, 1995.49114975681, 1980.2969945669297, 1985.8411327093797, 1989.45290045238, 1993.2624928776302, 1997.9400617981485, 1968.4783532363936, 1973.0726558517474, 1974.3879397386856, 1982.4548249231432, 1997.2310660395851, 6864.279250678656, 6868.931310686879, 6932.341427564374, 6940.618265995368, 6945.6527173641625, 3860.36304009838, 3890.1441682830014, 3901.5708272090046, 3913.099987002977, 3939.3500072488005, 2537.644729737838, 2570.5887058070807, 2602.817802753808, 2646.192911162095, 2648.430587423694, 841.4488510025943, 847.9915200847975, 850.5832142250315, 875.0374587953264, 876.7588913048899, 9132.497712625804, 9138.497382643953, 9152.405093668956, 9173.678921237792, 9176.715259863624, 3567.5362202913457, 3593.4317024935813, 3616.0598244456105, 3628.8004159771467, 3647.6899463545365, 7786.961065194751, 7793.493422927491, 7802.0, 7840.13758486566, 7847.293743563107, 3947.17109407022, 3957.940630890539, 3976.2842688315804, 3977.6817854571564, 3999.3601023836045, 3032.6664066952617, 3091.4280858040884, 3496.73774466916, 3621.420572708354, 3621.583517895476, 3242.124626350872, 3259.6088469383826, 3264.037109052835, 3267.5098735189913, 3329.217633856042, 1035.1201478743008, 1057.143713591993, 1070.7216123807866, 1073.0878753059837, 1074.5648012554927, 1146.5070019891527, 1147.7647082348099, 1161.1291531351487, 1164.3596022187933, 1182.2020136407891, 6362.236531616236, 6440.388163124496, 6441.710123044474, 6446.323136070739, 6463.159789227464, 996.1881066930429, 1012.6911292055994, 1025.7999690060515, 1038.2939601071193, 1059.4014381874217, 5066.670666406745, 5108.208227724708, 5115.56517696, 5135.409427915837, 5136.178211486144, 7612.934189213514, 7946.523208607502, 7975.122736498981, 7987.8402431951035, 8040.919590804134, 7788.260115289038, 7822.295993360625, 7881.290683838482, 7894.486858354188, 7952.801179970431, 6096.420840020191, 6136.711290629018, 6207.131001659771, 6207.255129384413, 6383.234011918692, 6380.968095159495, 6474.902876456951, 6475.061116138039, 6477.740890364333, 6490.513211509061, 7145.678444469907, 7185.568865868065, 7249.311315425026, 7258.0, 7263.636818158965, 6703.128593282842, 6709.429698475684, 6766.86466270662, 7429.33136017761, 7444.330010299099, 5216.9739151304, 5340.092184328596, 5955.76176952917, 6067.726952287246, 6081.239845019372, 5902.2327097477055, 5997.910031349446, 6015.187949626919, 6020.90968635462, 6024.096385542029, 5650.3219613646625, 5674.375818659862, 5703.914441283467, 5793.971030144822, 5809.738561764815, 5611.523020543136, 5628.324601047901, 5733.283339582552, 5761.279840019997, 5847.38602446754, 5735.8852822944145, 5770.682612456355, 5784.248047753765, 5860.853478663067, 5941.346451890375, 5439.265699130567, 5472.616916815785, 5483.287172667688, 5504.449555044624, 5508.55931525485, 5543.1685247213245, 5559.610827242054, 5590.329160500766, 5603.2155498231095, 5615.691136987505], "unit": "score", "name": "mootools.html", "value": 3863.9623271099035}, {"lowerIsBetter": false, "replicates": [286.6116412261386, 292.93262549613587, 293.9941201175978, 295.4121298615754, 297.85405151475777, 5550.16747487877, 5567.248421463101, 5659.688717120562, 5666.716664166785, 5686.0, 5530.446955304467, 5553.444655534445, 5558.305211848519, 5562.249096371988, 5565.888682226353, 4294.570542945696, 4296.226679197744, 4296.871093867189, 4296.97851510742, 4300.462442194726, 4014.4781178446906, 4117.402976568395, 4166.166766646667, 4257.787110644471, 4289.335153051282, 4233.280342341794, 4237.915241695165, 4237.978810105945, 4246.9150616987645, 4260.147970405916, 4222.767747773886, 4236.279832428495, 4238.004069043803, 4279.422277992462, 4281.657467402601, 3732.720045996561, 3733.775973441575, 3734.6825519830845, 3737.0844143185095, 3739.7756134631736, 5171.198464238049, 5327.360716713981, 5334.27987221724, 5358.624896257264, 5358.812441564565, 4770.141374552579, 4818.879528011793, 4825.9758701206265, 4830.9275360869615, 4837.32277481153, 5808.041673123929, 5809.2447981762525, 5810.070388737781, 5836.095405212156, 5854.736536855852, 3902.551206611219, 3919.118198405336, 3925.941110883339, 3933.665638420709, 3935.2129574085297, 5987.850303742442, 6023.608465449775, 6140.815775526741, 6154.169187159766, 6161.675239823459, 4082.2651922653613, 4087.325591277406, 4089.89775255621, 4090.1615168890307, 4094.3653733671326, 4140.130572579732, 4155.355919832431, 4156.231097247019, 4160.271952408317, 4169.082801783664, 4769.451513075971, 4813.989062296957, 4820.084184005028, 4829.13075646387, 4841.273808928619, 5632.97183514088, 5846.883062338729, 5847.678377689268, 5857.472827445466, 5864.501517370986, 1453.4840131753076, 1461.8391976882535, 1465.0403985389587, 1466.2375564706292, 1466.523379901515, 961.9470929098827, 981.3523074770617, 986.2061040862031, 988.9554970026367, 992.1764935103846, 5064.240363945364, 5065.6200784941275, 5075.238714192827, 5087.26234695967, 5103.795848166032, 5915.0, 6065.211522502046, 6068.2111325528285, 6123.050927106306, 6133.44798968095, 5128.1794912813775, 5143.305653736773, 5152.433232344439, 5155.484451554815, 5169.327987361694, 3229.725473334746, 3266.183454136466, 3270.5094235864335, 3270.591176102987, 3299.604047514266, 5660.320761508646, 5729.0, 5752.884942301131, 5769.942300577024, 5791.739371728282, 6332.461740751995, 6340.636763095957, 6348.746050158034, 6359.141515895295, 6367.808965731036, 5762.135679648086, 5784.132380142844, 5802.912956305659, 5808.564357673107, 5809.535237181015, 6094.573379863367, 6116.29662588808, 6126.908096378469, 6138.232720909887, 6149.754009839557, 5903.793367232126, 5942.613730107702, 6051.0, 6088.847778805565, 6096.359882212304, 5745.827625171251, 5768.221290125947, 5778.624389414675, 5786.710664466676, 5791.478766910998, 3991.900202494961, 4026.7382620129597, 4039.8990025249605, 4043.1509383029893, 4055.7769322686354, 6010.218671572842, 6137.570370074231, 6139.386061393825, 6144.846378840565, 6146.078088286793, 5879.382664820132, 5906.527477801679, 5909.52723782105, 5911.142884281841, 5914.704264786657, 5885.323187833454, 5886.38192989747, 5891.381404952418, 5907.645541267538, 5913.615614985012, 5624.578156638187, 5762.279715035621, 5770.538356931519, 5773.047447171338, 5780.075187969905, 5909.113632954919, 5931.1399847021075, 5941.643501389931, 5964.254468191476, 5968.4926781224085, 5773.0, 5801.3908539602735, 5838.678872662044, 5839.0, 5843.561732869966], "unit": "score", "name": "prototype.html", "value": 4362.359691827605}, {"lowerIsBetter": false, "replicates": [685.4858855858106, 741.770051284102, 757.984840303194, 770.1583489234158, 782.9021372328459, 11250.099992000642, 11412.0, 11475.483603237843, 11493.138014648894, 11493.712657183574, 10463.162946964243, 10822.458877056155, 11368.204225704205, 11406.54373825048, 11545.422728863565, 719.2771264878803, 739.1573606089036, 741.5439504704594, 742.5655991245128, 742.8699977503942, 742.754890886009, 747.7196051480695, 750.0249675421957, 751.864664360415, 754.3286475037221, 777.1373775109623, 782.7338704840353, 783.0798811396586, 783.8275579372557, 785.0265670568483, 776.1423626892259, 776.735909790671, 776.8718161503346, 776.9456138070337, 780.3484090784174, 575.7006356694495, 579.4176852263448, 580.0574067140896, 580.1240127407602, 581.4882903045335, 9915.65295214664, 9927.851082233772, 9938.900610993942, 9997.100260976475, 10011.0, 9666.806663866753, 9962.800743985152, 9971.850422243671, 9973.0, 10164.542595583216, 10538.0, 10755.516001779939, 10912.672619821418, 10957.780844383147, 11032.558697652084, 3972.483577134983, 4036.0, 4047.817848196838, 4108.404281379183, 4162.854300099482, 36103.0, 36244.81877590595, 39186.0, 39769.00577485557, 40495.392569111485, 8025.23760242776, 8741.256993155526, 9163.770905727277, 9277.67528136512, 9518.428894266366, 15087.170205638577, 15212.46756363522, 15217.163056032025, 15243.314050867737, 15303.61740956485, 6597.208334999831, 6776.15298087739, 6855.451563874878, 6903.551269167488, 6907.585544867324, 3658.6158453362546, 3785.848566057327, 3846.4614953906475, 3850.7497012694084, 3873.070463088895, 2645.5105805426056, 2664.6136310234906, 2673.31830383251, 2681.986590067076, 2683.9731602683723, 475.4467815910202, 484.10440684732964, 484.88605177783194, 491.83769356112396, 492.12401924574317, 529.8119167695489, 535.1785010009617, 558.6815515156403, 559.0496156533827, 568.2924758675475, 7396.852062958818, 7504.512206706547, 7673.884891726629, 7677.30904218623, 7803.609819509002, 520.9244659524423, 528.4213785904428, 529.4652401074942, 530.6762874646463, 533.3013751984912, 3485.581730192393, 3558.146044949245, 3566.3045706087582, 3581.7850928944345, 3606.1705807664384, 43539.564604354186, 46068.53931460709, 47323.76338118287, 47492.5250747495, 47602.76198618985, 37744.62255377466, 38601.42097868534, 39214.60785392167, 39287.21425571472, 39294.803525982185, 38425.039374015316, 38433.42349864754, 38888.41667374992, 38901.805490972365, 39153.60846391557, 7473.140588832354, 7484.288992545699, 7556.1310449299035, 7593.772186834404, 7706.190849960673, 29705.702942970292, 29944.850275748482, 30099.849500753233, 30482.390352193277, 30493.54259686062, 37882.43176352302, 37894.62105378911, 38233.0, 38615.42076868793, 38687.226255475296, 9035.283296173706, 9248.815023699623, 9266.953665231631, 9309.627614895327, 9717.028297170227, 10252.487375631337, 10294.433806140734, 10363.430011349448, 10436.060754532129, 10447.634332798316, 9916.206703463562, 10021.599136034478, 10044.54799534008, 10045.69862904114, 10123.139533139765, 9531.428114313163, 9570.377925434825, 9602.519874006412, 9614.759631009281, 9615.51922403863, 9910.108090271622, 9994.900050999397, 10040.397576145455, 10089.19286457067, 10090.495475226357, 8593.914060859312, 8622.0, 8637.95681021616, 8710.0, 8774.736757897019, 8604.956975215084, 8660.826783464421, 8669.089745576875, 8676.869846952428, 8797.12028797115], "unit": "score", "name": "yui.html", "value": 5510.039311657066}], "name": "dromaeo_css", "value": 6116.3254237570245}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [118.0, 112.0, 114.0, 116.0, 118.0, 126.0, 118.0, 116.0, 115.0, 117.0], "unit": "score", "name": "ai-astar", "value": 117.0}, {"lowerIsBetter": true, "replicates": [162.0, 134.0, 172.0, 170.0, 137.0, 160.0, 155.0, 139.0, 187.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 155.1}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 166.0, 166.0, 167.0, 169.0, 164.0, 164.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.9}, {"lowerIsBetter": true, "replicates": [75.0, 77.0, 75.0, 78.0, 77.0, 129.0, 74.0, 74.0, 75.0, 74.0], "unit": "score", "name": "audio-fft", "value": 80.8}, {"lowerIsBetter": true, "replicates": [98.0, 99.0, 130.0, 97.0, 98.0, 98.0, 147.0, 99.0, 98.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [111.0, 111.0, 111.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 148.0, 148.0, 149.0, 147.0, 148.0, 148.0, 150.0], "unit": "score", "name": "imaging-darkroom", "value": 148.2}, {"lowerIsBetter": true, "replicates": [96.0, 99.0, 96.0, 97.0, 96.0, 96.0, 97.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [77.0, 72.0, 73.0, 73.0, 73.0, 73.0, 72.0, 72.0, 82.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 73.8}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 69.0, 68.0, 69.0, 69.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 84.0, 89.0, 85.0, 85.0, 83.0, 85.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [130.0, 119.0, 121.0, 128.0, 124.0, 137.0, 131.0, 134.0, 128.0, 136.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.8}, {"lowerIsBetter": true, "replicates": [151.0, 154.0, 153.0, 158.0, 147.0, 150.0, 147.0, 148.0, 150.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.6}, {"lowerIsBetter": true, "replicates": [71.0, 75.0, 73.0, 72.0, 73.0, 71.0, 76.0, 72.0, 73.0, 73.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.9}], "name": "kraken", "value": 1562.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.09029421711193], "unit": "score", "name": "Richards", "value": 208.77602800000008}, {"lowerIsBetter": false, "replicates": [187.82870022539444], "unit": "score", "name": "DeltaBlue", "value": 352.01223200000004}, {"lowerIsBetter": false, "replicates": [278.55153203342616], "unit": "score", "name": "Encrypt", "value": 955.5897900000004}, {"lowerIsBetter": false, "replicates": [5284.210526315789], "unit": "score", "name": "Decrypt", "value": 50.37289840637447}, {"lowerIsBetter": false, "replicates": [1071.8113612004288], "unit": "score", "name": "RayTrace", "value": 690.4097369999998}, {"lowerIsBetter": false, "replicates": [707.2135785007072], "unit": "score", "name": "Earley", "value": 942.3786820000003}, {"lowerIsBetter": false, "replicates": [12395.061728395061], "unit": "score", "name": "Boyer", "value": 53.768429282868496}, {"lowerIsBetter": false, "replicates": [43553.1914893617], "unit": "score", "name": "RegExp", "value": 20.91660723009281}, {"lowerIsBetter": false, "replicates": [677.9661016949152], "unit": "score", "name": "Splay", "value": 120.19922500000001}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19971.274217385046}]} 13:06:22 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "19971.27"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1562.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6116.32"}}} 13:06:22 INFO - Return code: 0 13:06:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:06:23 INFO - # TBPL SUCCESS # 13:06:23 INFO - Running post-action listener: _resource_record_post_action 13:06:23 INFO - Running post-run listener: _resource_record_post_run 13:06:24 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 0; Write bytes: 551702528; Read time: 0; Write time: 619444 13:06:24 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 243585024; Read time: 0; Write time: 422172 13:06:24 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 308056064; Read time: 0; Write time: 197248 13:06:24 INFO - Running post-run listener: _upload_blobber_files 13:06:24 INFO - Blob upload gear active. 13:06:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:06:24 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 13:06:24 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'] 13:06:24 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 13:06:24 INFO - (blobuploader) - INFO - Open directory for files ... 13:06:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:06:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:06:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:06:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:06:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:06:25 INFO - (blobuploader) - INFO - Done attempting. 13:06:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:06:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:06:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:06:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:06:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:06:26 INFO - (blobuploader) - INFO - Done attempting. 13:06:26 INFO - (blobuploader) - INFO - Iteration through files over. 13:06:26 INFO - Return code: 0 13:06:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:06:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:06:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99b662dc2527251a270ec84f8f1517160be5a679976232435d8b986ed0ab176eacd036ea1ff46033b4e179fb5b4191ebf48fb3b0ba0d6535b11771620cec006f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6a6296fa50c2649007e9471902c68f805046bd5152bd780d94a27e4c3ab4ffbe7c8081b50e1e1da5052401a5145bc4e7c08a399ebc3ec016766e18b6db420b98"} 13:06:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:06:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:06:26 INFO - Contents: 13:06:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99b662dc2527251a270ec84f8f1517160be5a679976232435d8b986ed0ab176eacd036ea1ff46033b4e179fb5b4191ebf48fb3b0ba0d6535b11771620cec006f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6a6296fa50c2649007e9471902c68f805046bd5152bd780d94a27e4c3ab4ffbe7c8081b50e1e1da5052401a5145bc4e7c08a399ebc3ec016766e18b6db420b98"} 13:06:26 INFO - Running post-run listener: copy_logs_to_upload_dir 13:06:26 INFO - Copying logs to upload dir... 13:06:26 INFO - mkdir: /builds/slave/test/build/upload/logs 13:06:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.153205 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-20 13:06:25.704514) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 13:06:25.708393) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99b662dc2527251a270ec84f8f1517160be5a679976232435d8b986ed0ab176eacd036ea1ff46033b4e179fb5b4191ebf48fb3b0ba0d6535b11771620cec006f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6a6296fa50c2649007e9471902c68f805046bd5152bd780d94a27e4c3ab4ffbe7c8081b50e1e1da5052401a5145bc4e7c08a399ebc3ec016766e18b6db420b98"} build_url:https://queue.taskcluster.net/v1/task/CX5usBX_SGqRO9M5w1uBIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011243 build_url: 'https://queue.taskcluster.net/v1/task/CX5usBX_SGqRO9M5w1uBIg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99b662dc2527251a270ec84f8f1517160be5a679976232435d8b986ed0ab176eacd036ea1ff46033b4e179fb5b4191ebf48fb3b0ba0d6535b11771620cec006f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6a6296fa50c2649007e9471902c68f805046bd5152bd780d94a27e4c3ab4ffbe7c8081b50e1e1da5052401a5145bc4e7c08a399ebc3ec016766e18b6db420b98"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 13:06:25.737222) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 13:06:25.737939) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453322482.228310-1825382886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004607 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 13:06:25.820895) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 13:06:25.821236) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 13:06:25.821571) ========= ========= Total master_lag: 0.30 =========