builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1451955504.62 results: success (0) buildid: 20160104143020 builduid: c829b276792e400885306680b1b0f714 revision: 1d259b3dbc70b520ffd62ae6dae536e75e7586d4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:24.621997) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:24.622441) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:24.622747) ========= bash -c pwd in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1451955126.892664-789759957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006317 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:24.647348) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:24.647657) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:24.664213) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:24.664474) ========= rm -rf properties in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1451955126.892664-789759957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004660 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:24.713737) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:24.714065) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:24.714456) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:24.714740) ========= 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-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1451955126.892664-789759957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-04 16:58:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-01-04 16:58:25 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177785 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:24.904871) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:24.905225) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1451955126.892664-789759957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017300 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:24.956322) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-04 16:58:24.956690) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1d259b3dbc70b520ffd62ae6dae536e75e7586d4 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 1d259b3dbc70b520ffd62ae6dae536e75e7586d4 --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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1451955126.892664-789759957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-04 16:58:25,238 truncating revision to first 12 chars 2016-01-04 16:58:25,238 Setting DEBUG logging. 2016-01-04 16:58:25,238 attempt 1/10 2016-01-04 16:58:25,238 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1d259b3dbc70?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-04 16:58:26,310 unpacking tar archive at: fx-team-1d259b3dbc70/testing/mozharness/ program finished with exit code 0 elapsedTime=1.348352 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-04 16:58:26.320429) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:26.320739) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:26.329301) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:26.329607) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 16:58:26.330027) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-01-04 16:58:26.330307) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1451955126.892664-789759957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:58:26 INFO - MultiFileLogger online at 20160104 16:58:26 in /builds/slave/test-pgo 16:58:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:58:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:58:26 INFO - {'append_to_log': False, 16:58:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:58:26 INFO - 'blob_upload_branch': 'Fx-Team', 16:58:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:58:26 INFO - 'branch': 'Fx-Team', 16:58:26 INFO - 'buildbot_json_path': 'buildprops.json', 16:58:26 INFO - 'config_files': ('talos/linux_config.py',), 16:58:26 INFO - 'default_actions': ('clobber', 16:58:26 INFO - 'read-buildbot-config', 16:58:26 INFO - 'download-and-extract', 16:58:26 INFO - 'populate-webroot', 16:58:26 INFO - 'create-virtualenv', 16:58:26 INFO - 'install', 16:58:26 INFO - 'run-tests'), 16:58:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:58:26 INFO - 'download_minidump_stackwalk': True, 16:58:26 INFO - 'download_symbols': 'ondemand', 16:58:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:58:26 INFO - 'tooltool.py': '/tools/tooltool.py', 16:58:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:58:26 INFO - '/tools/misc-python/virtualenv.py')}, 16:58:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:58:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:58:26 INFO - 'installer_path': 'installer.exe', 16:58:26 INFO - 'log_level': 'info', 16:58:26 INFO - 'log_name': 'talos', 16:58:26 INFO - 'log_to_console': True, 16:58:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:58:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:58:26 INFO - 'opt_config_files': (), 16:58:26 INFO - 'pip_index': False, 16:58:26 INFO - 'sps_profile': False, 16:58:26 INFO - 'sps_profile_interval': 0, 16:58:26 INFO - 'suite': 'dromaeojs', 16:58:26 INFO - 'system_bits': '32', 16:58:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:58:26 INFO - 'title': 'talos-linux64-ix-018', 16:58:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:58:26 INFO - 'use_talos_json': True, 16:58:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:58:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:58:26 INFO - 'work_dir': 'build'} 16:58:26 INFO - ##### 16:58:26 INFO - ##### Running clobber step. 16:58:26 INFO - ##### 16:58:26 INFO - Running pre-action listener: _resource_record_pre_action 16:58:26 INFO - Running main action method: clobber 16:58:26 INFO - rmtree: /builds/slave/test-pgo/build 16:58:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:58:27 INFO - Running post-action listener: _resource_record_post_action 16:58:27 INFO - ##### 16:58:27 INFO - ##### Running read-buildbot-config step. 16:58:27 INFO - ##### 16:58:27 INFO - Running pre-action listener: _resource_record_pre_action 16:58:27 INFO - Running main action method: read_buildbot_config 16:58:27 INFO - Using buildbot properties: 16:58:27 INFO - { 16:58:27 INFO - "project": "", 16:58:27 INFO - "product": "firefox", 16:58:27 INFO - "script_repo_revision": "production", 16:58:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:58:27 INFO - "repository": "", 16:58:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 16:58:27 INFO - "buildid": "20160104143020", 16:58:27 INFO - "pgo_build": "True", 16:58:27 INFO - "basedir": "/builds/slave/test-pgo", 16:58:27 INFO - "buildnumber": 868, 16:58:27 INFO - "slavename": "talos-linux64-ix-018", 16:58:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:58:27 INFO - "platform": "ubuntu64_hw", 16:58:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:58:27 INFO - "branch": "fx-team", 16:58:27 INFO - "repo_path": "integration/fx-team", 16:58:27 INFO - "revision": "1d259b3dbc70b520ffd62ae6dae536e75e7586d4", 16:58:27 INFO - "stage_platform": "linux64-pgo", 16:58:27 INFO - "builduid": "c829b276792e400885306680b1b0f714", 16:58:27 INFO - "slavebuilddir": "test" 16:58:27 INFO - } 16:58:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:58:27 INFO - Running post-action listener: _resource_record_post_action 16:58:27 INFO - ##### 16:58:27 INFO - ##### Running download-and-extract step. 16:58:27 INFO - ##### 16:58:27 INFO - Running pre-action listener: _resource_record_pre_action 16:58:27 INFO - Running main action method: download_and_extract 16:58:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:27 INFO - https://queue.taskcluster.net/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:58:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/test_packages.json 16:58:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/test_packages.json 16:58:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:58:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:58:30 INFO - Downloaded 1302 bytes. 16:58:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:58:30 INFO - Using the following test package requirements: 16:58:30 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:58:30 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:58:30 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:30 INFO - u'jsshell-linux-x86_64.zip'], 16:58:30 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:58:30 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:58:30 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:58:30 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:58:30 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:58:30 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:58:30 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:58:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:30 INFO - https://queue.taskcluster.net/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:58:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:58:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:58:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:58:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:58:31 INFO - Downloaded 23198212 bytes. 16:58:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:58:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:58:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:58:32 INFO - Return code: 0 16:58:32 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:32 INFO - https://queue.taskcluster.net/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:58:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:58:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:58:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:58:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:58:33 INFO - Downloaded 23198212 bytes. 16:58:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:58:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:58:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:58:34 INFO - Return code: 0 16:58: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')]} 16:58:34 INFO - https://queue.taskcluster.net/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:58:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:58:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:58:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:58:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:58:35 INFO - Downloaded 11132285 bytes. 16:58:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 16:58:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:58:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 16:58:35 INFO - Return code: 0 16:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:35 INFO - https://queue.taskcluster.net/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:58:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:58:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:58:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:58:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:58:39 INFO - Downloaded 54987672 bytes. 16:58:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:58:39 INFO - mkdir: /builds/slave/test-pgo/properties 16:58:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:58:39 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:58:39 INFO - Contents: 16:58:39 INFO - build_url:https://queue.taskcluster.net/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:58:39 INFO - Running post-action listener: _resource_record_post_action 16:58:39 INFO - Running post-action listener: set_extra_try_arguments 16:58:39 INFO - ##### 16:58:39 INFO - ##### Running populate-webroot step. 16:58:39 INFO - ##### 16:58:39 INFO - Running pre-action listener: _resource_record_pre_action 16:58:39 INFO - Running main action method: populate_webroot 16:58:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:58:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:58:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:58:39 INFO - '--tppagecycles', 16:58:39 INFO - '7'], 16:58:39 INFO - 'tests': ['tsvgm']}}, 16:58:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:58:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:58:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:58:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:58:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:58:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:58:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:58:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:39 INFO - 'talos_options': ['--e10s'], 16:58:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:58:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:39 INFO - 'tests': ['damp', 'tps']}, 16:58:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:39 INFO - 'talos_options': ['--e10s'], 16:58:39 INFO - 'tests': ['damp', 'tps']}, 16:58:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:58:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:58:39 INFO - 'other': {'tests': ['a11yr', 16:58:39 INFO - 'ts_paint', 16:58:39 INFO - 'tpaint', 16:58:39 INFO - 'sessionrestore', 16:58:39 INFO - 'sessionrestore_no_auto_restore']}, 16:58:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:58:39 INFO - 'tests': ['a11yr', 16:58:39 INFO - 'ts_paint', 16:58:39 INFO - 'tpaint', 16:58:39 INFO - 'sessionrestore', 16:58:39 INFO - 'sessionrestore_no_auto_restore']}, 16:58:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:58:39 INFO - 'tests': ['a11yr', 16:58:39 INFO - 'ts_paint', 16:58:39 INFO - 'tpaint', 16:58:39 INFO - 'sessionrestore', 16:58:39 INFO - 'sessionrestore_no_auto_restore']}, 16:58:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:58:39 INFO - 'tests': ['a11yr', 16:58:39 INFO - 'ts_paint', 16:58:39 INFO - 'tpaint', 16:58:39 INFO - 'sessionrestore', 16:58:39 INFO - 'sessionrestore_no_auto_restore']}, 16:58:39 INFO - 'other_l64': {'tests': ['a11yr', 16:58:39 INFO - 'ts_paint', 16:58:39 INFO - 'tpaint', 16:58:39 INFO - 'sessionrestore', 16:58:39 INFO - 'sessionrestore_no_auto_restore']}, 16:58:39 INFO - 'other_nol64': {'tests': ['a11yr', 16:58:39 INFO - 'ts_paint', 16:58:39 INFO - 'tpaint', 16:58:39 INFO - 'sessionrestore', 16:58:39 INFO - 'sessionrestore_no_auto_restore']}, 16:58:39 INFO - 'svgr': {'tests': ['tsvgx', 16:58:39 INFO - 'tsvgr_opacity', 16:58:39 INFO - 'tart', 16:58:39 INFO - 'tscrollx', 16:58:39 INFO - 'cart']}, 16:58:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:58:39 INFO - 'tests': ['tsvgx', 16:58:39 INFO - 'tsvgr_opacity', 16:58:39 INFO - 'tart', 16:58:39 INFO - 'tscrollx', 16:58:39 INFO - 'cart']}, 16:58:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:39 INFO - 'tests': ['tp5o']}, 16:58:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:39 INFO - 'talos_options': ['--e10s'], 16:58:39 INFO - 'tests': ['tp5o']}, 16:58:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:39 INFO - 'talos_options': ['--xperf_path', 16:58:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:58:39 INFO - 'tests': ['tp5n']}, 16:58:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:39 INFO - 'talos_options': ['--e10s', 16:58:39 INFO - '--xperf_path', 16:58:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:58:39 INFO - 'tests': ['tp5n']}}, 16:58:39 INFO - 'talos.zip': {'path': '', 16:58:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:58:39 INFO - Running post-action listener: _resource_record_post_action 16:58:39 INFO - ##### 16:58:39 INFO - ##### Running create-virtualenv step. 16:58:39 INFO - ##### 16:58:39 INFO - Running pre-action listener: _resource_record_pre_action 16:58:39 INFO - Running main action method: create_virtualenv 16:58:39 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:58:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 16:58:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:58:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:58:39 INFO - Using real prefix '/usr' 16:58:39 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:58:39 INFO - Installing distribute.............................................................................................................................................................................................done. 16:58:41 INFO - Installing pip.................done. 16:58:41 INFO - Return code: 0 16:58:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:58: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')]} 16:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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')]} 16:58:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5dde54df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x156d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fe840>, '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 0x156b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156bb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1451955126.892664-789759957', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 16:58:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 16:58:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:58:41 INFO - Using env: {'DISPLAY': ':0', 16:58:41 INFO - 'HOME': '/home/cltbld', 16:58:41 INFO - 'LANG': 'en_US.UTF-8', 16:58:41 INFO - 'LANGUAGE': 'en_US:en', 16:58:41 INFO - 'LOGNAME': 'cltbld', 16:58:41 INFO - 'MAIL': '/var/mail/cltbld', 16:58:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:41 INFO - 'MOZ_NO_REMOTE': '1', 16:58:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:41 INFO - 'NO_EM_RESTART': '1', 16:58:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:41 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:41 INFO - 'SHELL': '/bin/bash', 16:58:41 INFO - 'SHLVL': '1', 16:58:41 INFO - 'TERM': 'linux', 16:58:41 INFO - 'TMOUT': '86400', 16:58:41 INFO - 'USER': 'cltbld', 16:58:41 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1451955126.892664-789759957', 16:58:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:41 INFO - '_': '/tools/buildbot/bin/python'} 16:58:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:41 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 16:58:41 INFO - Cleaning up... 16:58:41 INFO - Return code: 0 16:58:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:58: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')]} 16:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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')]} 16:58:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5dde54df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x156d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fe840>, '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 0x156b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156bb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1451955126.892664-789759957', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 16:58:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 16:58:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:58:41 INFO - Using env: {'DISPLAY': ':0', 16:58:41 INFO - 'HOME': '/home/cltbld', 16:58:41 INFO - 'LANG': 'en_US.UTF-8', 16:58:41 INFO - 'LANGUAGE': 'en_US:en', 16:58:41 INFO - 'LOGNAME': 'cltbld', 16:58:41 INFO - 'MAIL': '/var/mail/cltbld', 16:58:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:41 INFO - 'MOZ_NO_REMOTE': '1', 16:58:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:41 INFO - 'NO_EM_RESTART': '1', 16:58:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:41 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:41 INFO - 'SHELL': '/bin/bash', 16:58:41 INFO - 'SHLVL': '1', 16:58:41 INFO - 'TERM': 'linux', 16:58:41 INFO - 'TMOUT': '86400', 16:58:41 INFO - 'USER': 'cltbld', 16:58:41 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1451955126.892664-789759957', 16:58:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:41 INFO - '_': '/tools/buildbot/bin/python'} 16:58:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:42 INFO - Downloading/unpacking psutil>=0.7.1 16:58:42 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 16:58:42 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 16:58:42 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 16:58:42 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 16:58:42 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 16:58:42 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 16:58:43 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 16:58:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:58:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:58:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:58:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:58:43 INFO - Installing collected packages: psutil 16:58:43 INFO - Running setup.py install for psutil 16:58:43 INFO - building 'psutil._psutil_linux' extension 16:58:43 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 16:58:44 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 16:58:44 INFO - building 'psutil._psutil_posix' extension 16:58:44 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 16:58:44 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 16:58:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:58:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:58:44 INFO - Successfully installed psutil 16:58:44 INFO - Cleaning up... 16:58:44 INFO - Return code: 0 16:58:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:58: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')]} 16:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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')]} 16:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5dde54df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x156d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fe840>, '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 0x156b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156bb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1451955126.892664-789759957', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 16:58:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 16:58:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:58:44 INFO - Using env: {'DISPLAY': ':0', 16:58:44 INFO - 'HOME': '/home/cltbld', 16:58:44 INFO - 'LANG': 'en_US.UTF-8', 16:58:44 INFO - 'LANGUAGE': 'en_US:en', 16:58:44 INFO - 'LOGNAME': 'cltbld', 16:58:44 INFO - 'MAIL': '/var/mail/cltbld', 16:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:44 INFO - 'MOZ_NO_REMOTE': '1', 16:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:44 INFO - 'NO_EM_RESTART': '1', 16:58:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:44 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:44 INFO - 'SHELL': '/bin/bash', 16:58:44 INFO - 'SHLVL': '1', 16:58:44 INFO - 'TERM': 'linux', 16:58:44 INFO - 'TMOUT': '86400', 16:58:44 INFO - 'USER': 'cltbld', 16:58:44 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1451955126.892664-789759957', 16:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:44 INFO - '_': '/tools/buildbot/bin/python'} 16:58:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:58: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 16:58: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 16:58: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 16:58: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 16:58: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 16:58: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 16:58:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:58:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:58:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:58:46 INFO - Installing collected packages: mozsystemmonitor 16:58:46 INFO - Running setup.py install for mozsystemmonitor 16:58:46 INFO - Successfully installed mozsystemmonitor 16:58:46 INFO - Cleaning up... 16:58:46 INFO - Return code: 0 16:58:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:58:46 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')]} 16:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:46 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')]} 16:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5dde54df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x156d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fe840>, '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 0x156b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156bb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1451955126.892664-789759957', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 16:58:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 16:58:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:58:46 INFO - Using env: {'DISPLAY': ':0', 16:58:46 INFO - 'HOME': '/home/cltbld', 16:58:46 INFO - 'LANG': 'en_US.UTF-8', 16:58:46 INFO - 'LANGUAGE': 'en_US:en', 16:58:46 INFO - 'LOGNAME': 'cltbld', 16:58:46 INFO - 'MAIL': '/var/mail/cltbld', 16:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:46 INFO - 'MOZ_NO_REMOTE': '1', 16:58:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:46 INFO - 'NO_EM_RESTART': '1', 16:58:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:46 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:46 INFO - 'SHELL': '/bin/bash', 16:58:46 INFO - 'SHLVL': '1', 16:58:46 INFO - 'TERM': 'linux', 16:58:46 INFO - 'TMOUT': '86400', 16:58:46 INFO - 'USER': 'cltbld', 16:58:46 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1451955126.892664-789759957', 16:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:46 INFO - '_': '/tools/buildbot/bin/python'} 16:58:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:46 INFO - Downloading/unpacking blobuploader==1.2.4 16:58: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 16:58: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 16:58: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 16:58: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 16:58: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 16:58: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 16:58:48 INFO - Downloading blobuploader-1.2.4.tar.gz 16:58:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:58:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:58:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:58:48 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 16:58:48 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 16:58:48 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 16:58:48 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 16:58:48 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 16:58:48 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 16:58:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:58:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:58:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:58:48 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 16:58:48 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 16:58:48 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 16:58:48 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 16:58:48 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 16:58:48 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 16:58:49 INFO - Downloading docopt-0.6.1.tar.gz 16:58:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:58:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:58:49 INFO - Installing collected packages: blobuploader, requests, docopt 16:58:49 INFO - Running setup.py install for blobuploader 16:58:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:58:49 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:58:49 INFO - Running setup.py install for requests 16:58:49 INFO - Running setup.py install for docopt 16:58:49 INFO - Successfully installed blobuploader requests docopt 16:58:49 INFO - Cleaning up... 16:58:49 INFO - Return code: 0 16:58:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7f5dde54df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x156d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fe840>, '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 0x156b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156bb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1451955126.892664-789759957', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 16:58:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 16:58:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 16:58:49 INFO - Using env: {'DISPLAY': ':0', 16:58:49 INFO - 'HOME': '/home/cltbld', 16:58:49 INFO - 'LANG': 'en_US.UTF-8', 16:58:49 INFO - 'LANGUAGE': 'en_US:en', 16:58:49 INFO - 'LOGNAME': 'cltbld', 16:58:49 INFO - 'MAIL': '/var/mail/cltbld', 16:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:49 INFO - 'MOZ_NO_REMOTE': '1', 16:58:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:49 INFO - 'NO_EM_RESTART': '1', 16:58:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:49 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:49 INFO - 'SHELL': '/bin/bash', 16:58:49 INFO - 'SHLVL': '1', 16:58:49 INFO - 'TERM': 'linux', 16:58:49 INFO - 'TMOUT': '86400', 16:58:49 INFO - 'USER': 'cltbld', 16:58:49 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1451955126.892664-789759957', 16:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:49 INFO - '_': '/tools/buildbot/bin/python'} 16:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:58:49 INFO - Running setup.py (path:/tmp/pip-00fH7R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:58:49 INFO - Running setup.py (path:/tmp/pip-UZfeDf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:58:50 INFO - Running setup.py (path:/tmp/pip-WCdkD0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:58:50 INFO - Running setup.py (path:/tmp/pip-bH_FRK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:58:50 INFO - Running setup.py (path:/tmp/pip-aWTMWa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:58:50 INFO - Running setup.py (path:/tmp/pip-CxBn1B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:58:50 INFO - Running setup.py (path:/tmp/pip-jZPg0P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:58:50 INFO - Running setup.py (path:/tmp/pip-6SKxlj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:58:50 INFO - Running setup.py (path:/tmp/pip-XXzk3y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:58:50 INFO - Running setup.py (path:/tmp/pip-1Tfqbf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:58:50 INFO - Running setup.py (path:/tmp/pip-MFOvVF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:58:50 INFO - Running setup.py (path:/tmp/pip-1jXh1Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:58:50 INFO - Running setup.py (path:/tmp/pip-S3AOfj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:58:50 INFO - Running setup.py (path:/tmp/pip-BjhnAE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:58:50 INFO - Running setup.py (path:/tmp/pip-MIfGc7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:58:50 INFO - Running setup.py (path:/tmp/pip-y6ujUw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:58:51 INFO - Running setup.py (path:/tmp/pip-40H8Nh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:58:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:58:51 INFO - Running setup.py install for manifestparser 16:58:51 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:58:51 INFO - Running setup.py install for mozcrash 16:58:51 INFO - Running setup.py install for mozdebug 16:58:51 INFO - Running setup.py install for mozdevice 16:58:51 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:58:51 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:58:51 INFO - Running setup.py install for mozfile 16:58:51 INFO - Running setup.py install for mozhttpd 16:58:51 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:58:51 INFO - Running setup.py install for mozinfo 16:58:51 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:58:51 INFO - Running setup.py install for mozInstall 16:58:51 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:58:51 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:58:51 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:58:51 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:58:51 INFO - Running setup.py install for mozleak 16:58:52 INFO - Running setup.py install for mozlog 16:58:52 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:58:52 INFO - Running setup.py install for moznetwork 16:58:52 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:58:52 INFO - Running setup.py install for mozprocess 16:58:52 INFO - Running setup.py install for mozprofile 16:58:52 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:58:52 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:58:52 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:58:52 INFO - Running setup.py install for mozrunner 16:58:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:58:52 INFO - Running setup.py install for mozscreenshot 16:58:52 INFO - Running setup.py install for moztest 16:58:52 INFO - Running setup.py install for mozversion 16:58:52 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:58:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:58:52 INFO - Cleaning up... 16:58:52 INFO - Return code: 0 16:58:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7f5dde54df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x156d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fe840>, '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 0x156b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156bb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1451955126.892664-789759957', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 16:58:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 16:58:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 16:58:52 INFO - Using env: {'DISPLAY': ':0', 16:58:52 INFO - 'HOME': '/home/cltbld', 16:58:52 INFO - 'LANG': 'en_US.UTF-8', 16:58:52 INFO - 'LANGUAGE': 'en_US:en', 16:58:52 INFO - 'LOGNAME': 'cltbld', 16:58:52 INFO - 'MAIL': '/var/mail/cltbld', 16:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:52 INFO - 'MOZ_NO_REMOTE': '1', 16:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:52 INFO - 'NO_EM_RESTART': '1', 16:58:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:52 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:52 INFO - 'SHELL': '/bin/bash', 16:58:52 INFO - 'SHLVL': '1', 16:58:52 INFO - 'TERM': 'linux', 16:58:52 INFO - 'TMOUT': '86400', 16:58:52 INFO - 'USER': 'cltbld', 16:58:52 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1451955126.892664-789759957', 16:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:52 INFO - '_': '/tools/buildbot/bin/python'} 16:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:58:53 INFO - Running setup.py (path:/tmp/pip-o7GxwR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 16:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:58:53 INFO - Running setup.py (path:/tmp/pip-ohx1Bl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:58:53 INFO - Running setup.py (path:/tmp/pip-EOlRRf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 16:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:58:53 INFO - Running setup.py (path:/tmp/pip-oZopR3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:58:53 INFO - Running setup.py (path:/tmp/pip-9CFgkC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 16:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:58:53 INFO - Running setup.py (path:/tmp/pip-Ifc1ix-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 16:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:58:53 INFO - Running setup.py (path:/tmp/pip-dEjnhj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 16:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:58:53 INFO - Running setup.py (path:/tmp/pip-x704Jd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 16:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:58:53 INFO - Running setup.py (path:/tmp/pip-LGtTao-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 16:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:58:53 INFO - Running setup.py (path:/tmp/pip-HxkRWE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:58:53 INFO - Running setup.py (path:/tmp/pip-duefRW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 16:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:58:53 INFO - Running setup.py (path:/tmp/pip-OMdXsa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 16:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:58:54 INFO - Running setup.py (path:/tmp/pip-Xgm1jt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 16:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:58:54 INFO - Running setup.py (path:/tmp/pip-4VHCuP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 16:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:58:54 INFO - Running setup.py (path:/tmp/pip-IkVIR8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 16:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:58:54 INFO - Running setup.py (path:/tmp/pip-oCflzA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 16:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:58:54 INFO - Running setup.py (path:/tmp/pip-Cro1Bu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 16:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 16:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:58:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:56 INFO - Downloading blessings-1.5.1.tar.gz 16:58:56 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 16:58:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:58:56 INFO - Installing collected packages: blessings 16:58:56 INFO - Running setup.py install for blessings 16:58:56 INFO - Successfully installed blessings 16:58:56 INFO - Cleaning up... 16:58:56 INFO - Return code: 0 16:58:56 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:58:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:58:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:58:56 INFO - Reading from file tmpfile_stdout 16:58:56 INFO - Current package versions: 16:58:56 INFO - argparse == 1.2.1 16:58:56 INFO - blessings == 1.5.1 16:58:56 INFO - blobuploader == 1.2.4 16:58:56 INFO - docopt == 0.6.1 16:58:56 INFO - manifestparser == 1.1 16:58:56 INFO - mozInstall == 1.12 16:58:56 INFO - mozcrash == 0.16 16:58:56 INFO - mozdebug == 0.1 16:58:56 INFO - mozdevice == 0.47 16:58:56 INFO - mozfile == 1.2 16:58:56 INFO - mozhttpd == 0.7 16:58:56 INFO - mozinfo == 0.9 16:58:56 INFO - mozleak == 0.1 16:58:56 INFO - mozlog == 3.1 16:58:56 INFO - moznetwork == 0.27 16:58:56 INFO - mozprocess == 0.22 16:58:56 INFO - mozprofile == 0.28 16:58:56 INFO - mozrunner == 6.11 16:58:56 INFO - mozscreenshot == 0.1 16:58:56 INFO - mozsystemmonitor == 0.0 16:58:56 INFO - moztest == 0.7 16:58:56 INFO - mozversion == 1.4 16:58:56 INFO - psutil == 3.1.1 16:58:56 INFO - requests == 1.2.3 16:58:56 INFO - wsgiref == 0.1.2 16:58:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7f5dde54df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x156d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fe840>, '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 0x156b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156bb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1451955126.892664-789759957', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 16:58:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/talos 16:58:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 16:58:56 INFO - Using env: {'DISPLAY': ':0', 16:58:56 INFO - 'HOME': '/home/cltbld', 16:58:56 INFO - 'LANG': 'en_US.UTF-8', 16:58:56 INFO - 'LANGUAGE': 'en_US:en', 16:58:56 INFO - 'LOGNAME': 'cltbld', 16:58:56 INFO - 'MAIL': '/var/mail/cltbld', 16:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:56 INFO - 'MOZ_NO_REMOTE': '1', 16:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:56 INFO - 'NO_EM_RESTART': '1', 16:58:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:56 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:56 INFO - 'SHELL': '/bin/bash', 16:58:56 INFO - 'SHLVL': '1', 16:58:56 INFO - 'TERM': 'linux', 16:58:56 INFO - 'TMOUT': '86400', 16:58:56 INFO - 'USER': 'cltbld', 16:58:56 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1451955126.892664-789759957', 16:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:56 INFO - '_': '/tools/buildbot/bin/python'} 16:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 16:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 16:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 16:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 16:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 16:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 16:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 16:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 16:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 16:58:56 INFO - Cleaning up... 16:58:56 INFO - Return code: 0 16:58:56 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5dde54df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x156d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fe840>, '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 0x156b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156bb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1451955126.892664-789759957', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 16:58:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 16:58:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:58:56 INFO - Using env: {'DISPLAY': ':0', 16:58:56 INFO - 'HOME': '/home/cltbld', 16:58:56 INFO - 'LANG': 'en_US.UTF-8', 16:58:56 INFO - 'LANGUAGE': 'en_US:en', 16:58:56 INFO - 'LOGNAME': 'cltbld', 16:58:56 INFO - 'MAIL': '/var/mail/cltbld', 16:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:56 INFO - 'MOZ_NO_REMOTE': '1', 16:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:56 INFO - 'NO_EM_RESTART': '1', 16:58:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:56 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:56 INFO - 'SHELL': '/bin/bash', 16:58:56 INFO - 'SHLVL': '1', 16:58:56 INFO - 'TERM': 'linux', 16:58:56 INFO - 'TMOUT': '86400', 16:58:56 INFO - 'USER': 'cltbld', 16:58:56 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1451955126.892664-789759957', 16:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:56 INFO - '_': '/tools/buildbot/bin/python'} 16:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:56 INFO - Downloading/unpacking jsonschema 16:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:58:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 16:58:58 INFO - Downloading/unpacking functools32 (from jsonschema) 16:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:58 INFO - Downloading functools32-3.2.3-2.tar.gz 16:58:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 16:58:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:58:58 INFO - warning: no files found matching '*.txt' 16:58:58 INFO - no previously-included directories found matching 'build' 16:58:58 INFO - no previously-included directories found matching 'dist' 16:58:58 INFO - no previously-included directories found matching '.git*' 16:58:58 INFO - Installing collected packages: jsonschema, functools32 16:58:58 INFO - Running setup.py install for functools32 16:58:58 INFO - warning: no files found matching '*.txt' 16:58:58 INFO - no previously-included directories found matching 'build' 16:58:58 INFO - no previously-included directories found matching 'dist' 16:58:58 INFO - no previously-included directories found matching '.git*' 16:58:59 INFO - Successfully installed jsonschema functools32 16:58:59 INFO - Cleaning up... 16:58:59 INFO - Return code: 0 16:58:59 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5dde54df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x156d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fe840>, '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 0x156b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156bb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1451955126.892664-789759957', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 16:58:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 16:58:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:58:59 INFO - Using env: {'DISPLAY': ':0', 16:58:59 INFO - 'HOME': '/home/cltbld', 16:58:59 INFO - 'LANG': 'en_US.UTF-8', 16:58:59 INFO - 'LANGUAGE': 'en_US:en', 16:58:59 INFO - 'LOGNAME': 'cltbld', 16:58:59 INFO - 'MAIL': '/var/mail/cltbld', 16:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:59 INFO - 'MOZ_NO_REMOTE': '1', 16:58:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:59 INFO - 'NO_EM_RESTART': '1', 16:58:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:59 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:59 INFO - 'SHELL': '/bin/bash', 16:58:59 INFO - 'SHLVL': '1', 16:58:59 INFO - 'TERM': 'linux', 16:58:59 INFO - 'TMOUT': '86400', 16:58:59 INFO - 'USER': 'cltbld', 16:58:59 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1451955126.892664-789759957', 16:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:59 INFO - '_': '/tools/buildbot/bin/python'} 16:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:59 INFO - Downloading/unpacking flake8 16:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:59:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 16:59:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:59:00 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 16:59:00 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 16:59:00 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 16:59:00 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 16:59:00 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 16:59:00 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 16:59:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:59:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 16:59:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 16:59:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:59:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:59:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:59:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:59:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:59:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:59:01 INFO - no previously-included directories found matching 'docs/_build' 16:59:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:59:01 INFO - Running setup.py install for pep8 16:59:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:59:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:59:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:59:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:59:01 INFO - no previously-included directories found matching 'docs/_build' 16:59:01 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:59:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:59:01 INFO - Cleaning up... 16:59:01 INFO - Return code: 0 16:59:01 INFO - Running post-action listener: _resource_record_post_action 16:59:01 INFO - Running post-action listener: _start_resource_monitoring 16:59:01 INFO - Starting resource monitoring. 16:59:01 INFO - ##### 16:59:01 INFO - ##### Running install step. 16:59:01 INFO - ##### 16:59:01 INFO - Running pre-action listener: _resource_record_pre_action 16:59:01 INFO - Running main action method: install 16:59:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:59:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:59:02 INFO - Reading from file tmpfile_stdout 16:59:02 INFO - Detecting whether we're running mozinstall >=1.0... 16:59:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:59:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:59:02 INFO - Reading from file tmpfile_stdout 16:59:02 INFO - Output received: 16:59:02 INFO - Usage: mozinstall [options] installer 16:59:02 INFO - Options: 16:59:02 INFO - -h, --help show this help message and exit 16:59:02 INFO - -d DEST, --destination=DEST 16:59:02 INFO - Directory to install application into. [default: 16:59:02 INFO - "/builds/slave/test-pgo"] 16:59:02 INFO - --app=APP Application being installed. [default: firefox] 16:59:02 INFO - mkdir: /builds/slave/test-pgo/build/application 16:59:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 16:59:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 16:59:17 INFO - Reading from file tmpfile_stdout 16:59:17 INFO - Output received: 16:59:17 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:59:18 INFO - Running post-action listener: _resource_record_post_action 16:59:18 INFO - ##### 16:59:18 INFO - ##### Running run-tests step. 16:59:18 INFO - ##### 16:59:18 INFO - Running pre-action listener: _resource_record_pre_action 16:59:18 INFO - Running main action method: run_tests 16:59:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:59:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:59:18 INFO - Python 2.7.3 16:59:18 INFO - Return code: 0 16:59:18 INFO - grabbing minidump binary from tooltool 16:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:18 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-pgo/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 0x15fe840>, '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 0x156b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x156bb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:59:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 16:59:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:59:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:59:18 INFO - Return code: 0 16:59:18 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:59:18 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:59:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:59:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:59:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:59:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:59:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:59:19 INFO - Return code: 0 16:59:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 16:59:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 16:59:19 INFO - Using env: {'DISPLAY': ':0', 16:59:19 INFO - 'HOME': '/home/cltbld', 16:59:19 INFO - 'LANG': 'en_US.UTF-8', 16:59:19 INFO - 'LANGUAGE': 'en_US:en', 16:59:19 INFO - 'LOGNAME': 'cltbld', 16:59:19 INFO - 'MAIL': '/var/mail/cltbld', 16:59:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:59:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:19 INFO - 'MOZ_NO_REMOTE': '1', 16:59:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:59:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:19 INFO - 'NO_EM_RESTART': '1', 16:59:19 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:59:19 INFO - 'PWD': '/builds/slave/test-pgo', 16:59:19 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:59:19 INFO - 'SHELL': '/bin/bash', 16:59:19 INFO - 'SHLVL': '1', 16:59:19 INFO - 'TERM': 'linux', 16:59:19 INFO - 'TMOUT': '86400', 16:59:19 INFO - 'USER': 'cltbld', 16:59:19 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1451955126.892664-789759957', 16:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:19 INFO - '_': '/tools/buildbot/bin/python'} 16:59:19 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:59:19 INFO - mozversion application_buildid: 20160104143020 16:59:19 INFO - mozversion application_changeset: 1d259b3dbc70b520ffd62ae6dae536e75e7586d4 16:59:19 INFO - mozversion application_display_name: Nightly 16:59:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:59:19 INFO - mozversion application_name: Firefox 16:59:19 INFO - mozversion application_remotingname: firefox 16:59:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:59:19 INFO - mozversion application_vendor: Mozilla 16:59:19 INFO - mozversion application_version: 46.0a1 16:59:19 INFO - mozversion platform_buildid: 20160104143020 16:59:19 INFO - mozversion platform_changeset: 1d259b3dbc70b520ffd62ae6dae536e75e7586d4 16:59:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:59:19 INFO - mozversion platform_version: 46.0a1 16:59:19 INFO - using testdate: 1451955559 16:59:19 INFO - actual date: 1451955559 16:59:19 INFO - starting webserver on 'localhost:40358' 16:59:19 INFO - SUITE-START | Running 3 tests 16:59:19 INFO - TEST-START | dromaeo_css 16:59:19 INFO - operating with platform_type : linux_ 16:59:19 INFO - Initialising browser for dromaeo_css test... 16:59:19 INFO - TEST-INFO | started process 15782 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcoogIl/profile http://localhost:40358/getInfo.html) 16:59:23 INFO - PROCESS | 15782 | __metrics Screen width/height:1600/1200 16:59:23 INFO - PROCESS | 15782 | colorDepth:24 16:59:23 INFO - PROCESS | 15782 | Browser inner width/height: 1024/697 16:59:23 INFO - PROCESS | 15782 | __metrics 16:59:23 INFO - PROCESS | 15782 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:59:23 INFO - PROCESS | 15782 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:59:24 INFO - TEST-INFO | 15782: exit 0 16:59:24 INFO - Browser initialized. 16:59:24 INFO - Running cycle 1/1 for dromaeo_css test... 16:59:24 INFO - TEST-INFO | started process 15876 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcoogIl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:59:36 INFO - PROCESS | 15876 | RSS: Main: 150048768 16:59:36 INFO - PROCESS | 15876 | 17:00:26 INFO - PROCESS | 15876 | 1451955626840 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] 17:02:36 INFO - PROCESS | 15876 | Cycle 1(1): loaded http://localhost:40358/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40358/tests/dromaeo/cssquery-ext.html) 17:02:37 INFO - PROCESS | 15876 | RSS: Main: 265666560 17:02:37 INFO - PROCESS | 15876 | 17:05:39 INFO - PROCESS | 15876 | Cycle 1(1): loaded http://localhost:40358/tests/dromaeo/cssquery-ext.html (next: http://localhost:40358/tests/dromaeo/cssquery-jquery.html) 17:05:40 INFO - PROCESS | 15876 | RSS: Main: 230346752 17:05:40 INFO - PROCESS | 15876 | 17:08:42 INFO - PROCESS | 15876 | Cycle 1(1): loaded http://localhost:40358/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40358/tests/dromaeo/cssquery-mootools.html) 17:08:43 INFO - PROCESS | 15876 | RSS: Main: 232628224 17:08:43 INFO - PROCESS | 15876 | 17:11:44 INFO - PROCESS | 15876 | Cycle 1(1): loaded http://localhost:40358/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40358/tests/dromaeo/cssquery-prototype.html) 17:11:45 INFO - PROCESS | 15876 | RSS: Main: 212856832 17:11:45 INFO - PROCESS | 15876 | 17:14:47 INFO - PROCESS | 15876 | Cycle 1(1): loaded http://localhost:40358/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40358/tests/dromaeo/cssquery-yui.html) 17:14:48 INFO - PROCESS | 15876 | RSS: Main: 217538560 17:14:48 INFO - PROCESS | 15876 | 17:17:50 INFO - PROCESS | 15876 | Cycle 1(1): loaded http://localhost:40358/tests/dromaeo/cssquery-yui.html (next: http://localhost:40358/tests/dromaeo/cssquery-dojo.html) 17:17:51 INFO - PROCESS | 15876 | RSS: Main: 265965568 17:17:51 INFO - PROCESS | 15876 | 17:17:51 INFO - PROCESS | 15876 | __start_tp_report 17:17:51 INFO - PROCESS | 15876 | _x_x_mozilla_page_load 17:17:51 INFO - PROCESS | 15876 | _x_x_mozilla_page_load_details 17:17:51 INFO - PROCESS | 15876 | |i|pagename|runs| 17:17:51 INFO - PROCESS | 15876 | |0;dojo.html;3099.5040793473045;3129.499280115182;3162.952555711663;3177.2851108500577;3205.599300087489;5179.8446046618565;5259.86850328742;5266.499682530163;5271.551918086962;5307.150855863063;5260.526552610264;5270.5520030797425;5354.651947623402;5376.542993845518;5393.757280922358;4798.376211092553;4856.125897338477;4865.124277630025;4871.7076975381415;4924.532169443897;4870.561649451549;5003.39959204896;5036.924446133311;5043.84868453947;5091.109055915219;4753.738544380058;4842.055799119174;4967.006598680242;4975.90048199034;5023.874403139914;4791.089692958327;4862.683925544864;4885.2916327132725;4887.022595480918;4895.167821470359;4771.594414474774;4805.159097158018;4806.543378379049;4817.445993710698;4818.662693611449;5093.745312734385;5164.9741751291;5185.481451854785;5196.610254230948;5225.503577160163;5744;5770.596058275923;5772.480476757112;5776.162456443834;5777.162311464856;5779.739911703983;5810.389909059572;5814.302283725938;5814.767409303623;5825.854353641193;5198.116320225533;5291.947080529222;5304.098303288373;5311.707856067915;5382.730863456812;5795.478406943395;5801.477866991991;5807.8548036299435;5825.679587622637;5838.065909454467;5611.635243709227;5612.438756124355;5612.747426365823;5617.185508101303;5661.235733176051;5644.096944488862;5652.293463317085;5690.487856092972;5695.145728140812;5748.540116790647;5525.944740552623;5528.695921724263;5528.86177845549;5538.501534861882;5598.776048957996;5475.945240547543;5501.972490137604;5513.3108361454815;5516.668999860021;5535.889282214333;4325.15659446405;4354;4372.6939114261695;4416.24923762961;4443.178012067778;3885.475460812754;3912.882613521599;3927.293087244266;3949.0324870406935;3981.343078392033;5254.448282930313;5264.92102618461;5265.473452654704;5269.104252277122;5308.469153084738;5554.50009499147;5669.54643628517;5670.432956704379;5715.885682286331;5716.256886604798;5266.2890509781455;5348.117560602457;5358.410574836765;5358.946410535845;5371.811986580451;4903.166461701519;4920.5571498565305;4922.237053256751;4922.655414121049;4965.106280869478;5737.799177028784;5878.735456904449;5935.554833387427;5940.227770389908;5954.940450595525;5626.803061892978;5678.943210567842;5684.71576421169;5686.061799803151;5733.8566535836935;5900.262467191601;5904.114382842608;5913.852153696192;5920.703964801829;5921.792737254175;5524.723763811874;5637.774489020393;5643;5655.151727240782;5661.745221464962;5697;5706.90136909754;5714.714264286686;5738.626989245686;5816.534677225727;5582.665040097607;5603.8879222416135;5605.411431799603;5605.971970140124;5612.074007788669;5428.592855535771;5588.552915766648;5592.916106258491;5601.747921343468;5606.6636001840025;5534.1145416733125;5536.141898005815;5543.223948647274;5548.029094908295;5557.472040156179;5636.464535869086;5640.661560306395;5651.15232715096;5668.37647858727;5720.427957204246;5378.058839702958;5476.534494567847;5489.313835770528;5544.972275138599;5551.139573366135 17:17:51 INFO - PROCESS | 15876 | |1;ext.html;539.8677324055607;548.3474665148473;565.5051829649057;570.2159530645363;574.1674571870788;28000.85999570002;28436.28909277269;28479.572806407894;35094;35512;38159;38718.41922371159;38764.61235387645;38797.41803872944;38810.611893881054;8309.916900831005;8540.530270835101;8541.786455338635;8543.188397102265;8548.572571371407;7469.813254668622;7598.620068996555;9877.407355558653;9894.40633561985;9932.553035113437;10124.240681948846;10157.390556566592;10219.693409197736;10221.89778102217;10222.182225421948;7557.319841214317;7726.918231447546;10025.749356266115;10091.091801737879;10117.08946194846;10087.34432261908;10249.436281004542;10250.179985601135;10253.384796912209;10254;35591.28817423637;35986.460203096976;36009.45985810215;36022.819885900666;36049.45925811115;3152.2592190835135;3191.0745883693703;3438.673326034023;3842.846286148551;4015.036391266104;28736.281592960135;29464.26339341512;29960.250993725112;30324;31165.37669246625;3859.9333157761334;3898.8440462381473;3906.3978093104306;3950.328444164499;4058.208649313385;258578;258630.9999999981;259210;259604;260526;55790.442095578524;57282.713586432634;57285.71357143188;57309.71345143248;57318.426815731305;50736.74631626818;52045;57263.427365726646;60223;60357.698211508665;14643.48747793822;14706.852931470763;14748.926255368655;14803.111813291236;14916.328765205591;10535.525901334306;10622.628208012837;10647.680569582924;10658.467076646137;10696.94651526753;18191.727124093148;18226.817731822513;18252.087395630166;18260.178291976892;18290.63418731618;7522.097348318237;7876.133625301212;8007.319377852831;8008.079070906921;8079.515229086273;922.8846394200725;949.9810003800023;966.970990870261;993.1657407777357;1041.068243921686;28015.439691206062;28306.15081547557;28660.856695716804;28751.712482875322;28823.71176288252;832.2759199496477;854.9102344253764;955.3360414511986;961.8701475300885;998.7652901568125;12689.048321375934;12859.16415432994;12908.35458227085;12977.610671679864;13022.2837743925;330444;334833;334986;335786;336101;49135.77160571014;49378.75310623424;49425.25862112071;49443.75278123586;49508;1303.478608556585;1317.1504379675057;1318.2354234544134;1321.8744219299151;1325.9867401326055;21412.464688382915;25282.241532753313;25635.487290254463;26166.476670466865;26200.475990479703;41714.165716686104;42283;42290.154196916505;42293.15413691771;42317.36523952205;194319;194579;195185;196047;196163;28290.717092829633;30270;30877.228069298446;30922.226944326572;31110.844445777628;36966.63033369632;36979.260414792094;37060.62939370572;37220.44169337408;38043.42934855924;32201.51697724489;32217;33185.66814331826;33788.83105584457;34921.82539087288;27071.1878643641;28727;29050.41899162047;29935.70064299416;34340.111293879076;31194.37611247717;31682.683173167974;31730.365392692478;32218.35563288768;32231.194220144684;28680.71319286864;31128.22179445532;31453.842730787113;31727.84136079305;31760.841195793873;23543.41141471477;23724;23949;24150.87924560366;24207 17:17:51 INFO - PROCESS | 15876 | |2;jquery.html;359.74098648972745;362.93467175908324;364.50245415008504;365.77322060322587;366.3113346907814;14058.297085145727;14097.78853317201;16221.188940552984;17742.467725968225;18911.338103166374;10986.450677466135;11263.831042534348;16157.192140392992;16297.429589964353;16389.098599577017;4827.951720482794;4967.925481117786;4969.652124351279;4972.900541989158;4972.950270497303;3806.9428958565504;3869.361555343365;4927;6519.576227545194;6682.097916781246;6478.773242936498;6615.768448104317;6616.437602803743;6691.096701945224;6694.665266736668;6579.374959378852;6631.668416579176;6634.767783127591;6636.270010298863;6640;5942.940570594325;6112.449879510866;6125.111858780497;6316.715747791361;6322.58903171297;21017.369478915658;21116.5776684467;21428.714277143266;21503.139874405006;22318.330450086523;2129.095134567818;2148.6807695552257;2183.7816218378034;2205.63607004844;2217.168561789329;13694.863051369459;13878.722425551432;13947.093438926437;14046.929765351108;14360.640983975483;1940.1754254441805;1949.6685563454246;2018.7072874433125;2034.206659402834;2085.9165633374646;66163.3383666162;66464.3353566463;68991.31008689899;69203.30796692069;69535.00347460006;15565;15579.922100389425;15624.609384765245;15629.921850390903;15681.607959800867;23775.7622423777;23829.404264893168;23841.880790595937;24118.758812412;24130.87934560351;8932.687355942511;8944.731658050268;8947.284217262604;8956.776080597907;8998.055204203596;7536.623168841536;7569.583672898044;7597.392208623297;7606.467547271638;7681.193474685189;7034.718611255595;7625.565317873005;7870.29167374939;7950.562719050507;7999.080105787909;2569.717331093578;2945.2337910049064;3008.3983203359417;3076.461619216628;3086.6450358208645;383.4593223554774;410.24514892597165;426.2051274373272;465.46006632306364;749.5465243527697;9253.67612133572;10124.088832005154;10368.896311036793;10756.139508839275;11101.72245693848;444.19822220890956;463.9443266808005;469.2000139761698;471.36130543114274;495.1434019146824;5983.790567330209;6038;6073.787417440457;6080.331163572004;6105.45050945417;126166;126602;511052.4447377739;559779;564937;75631.62184189154;78015.60992195003;78433.0391740211;78621.60689196517;79744.60127699324;499.3234167702783;503.3582182717065;504.0976651793249;504.26125725811863;504.32672382369947;9654.27592930519;10086.193104551765;10401.27191096616;10452.947735261276;10453.163746900382;31483.685163148075;33323.16692082717;33639.83180084182;33760.3247935035;34353.65646343504;44034;44963;45017.774911126544;45407;47142.764286178346;9239.953800230956;9442.48066356357;9623.133917947418;9810.705678829647;9825.263105267277;16675.39332286154;16908.57728556796;16920;17104.230309636347;17273.56816079608;12603.18079324841;13495.325233738078;13499.797503037658;13851.376688049264;13924.303784810516;11062.502187401748;13519.864801351861;13865.653358666113;13988.860111398755;14719.411223551366;12691.555795547112;12786.936065319614;13214.405351759002;13228.735425291632;13229.206247625174;9045.276377889884;9062.410943288665;9225.677101301422;9245.815083698422;9297;12357.876421235673;12378.81431778506;13113.213207207598;13168.341582920624;13363.198208107544 17:17:51 INFO - PROCESS | 15876 | |3;mootools.html;1231.6489800406887;1450.4995776457122;1462.3492545817112;1608.7747715319858;1793.4888556761325;6871.622060786654;7405.740799072034;7482.027336446268;7502.17476077631;7507.887381689279;7330.486865919388;7553.8866916996285;7555.773326800191;7556.773296801091;7558.433117516181;2198.714167158267;2230.163688616769;2230.2751605728204;2232.497688020199;2234.72065991751;2211.0934516848097;2236.541508990653;2308.4690521180055;2313.571989181998;2325.290786310183;2302.804261637763;2308.319045881469;2316.1661801751357;2318.4783423729696;2340.356401989458;2262.694536237603;2277.1688333758143;2304.2396009316885;2304.758000409958;2304.9423764405856;2279.985406494111;2307.7576854430213;2308.1229132929548;2309.549637820626;2310.549442858643;7595.924040759577;7668.501547399401;7685;7692.230776922319;7707.229277072304;4633.027064316498;4715.7642117893965;4736.123817093814;4742.217534106868;4745.525447455261;2928.209383466452;2954.290970167166;3023.712747289004;3033.5752994580776;3041.6197975253094;1069.5775168808354;1070.6734445993968;1116.4083035990857;1116.7040734205443;1149.367847683779;10546.789064218749;10689.679309620724;10697.679069627924;10760.623378181726;10800.135989120772;4204.180184863983;4222.767747773902;4292.7424354538825;4317.546657600969;4324.048709283952;9329.11373419524;9364.719058428258;9388.061193880694;9393.342466027449;9411.341206115507;4807.471178170398;4812.5668689817385;4812.663113582015;4814.037192561432;4824;3758.229562939591;3805.809709514513;4086.244044851712;4375.890602734893;4380.7152535085115;3630.128769095398;3630.673239408466;3670.8531658733887;3679.2089700714473;3679.79761113136;1145.8166693329194;1152.6945359479744;1153.5789436855655;1156.2311063143084;1167.6963989362828;1300.0444673165405;1304.9934750326377;1324.0797645636383;1337.5786627212397;1337.652210425277;6991.755288564876;7060.92939070613;7173.461990350745;7175.497715159889;7182.7486037989465;481.8891654919388;486.7566216891554;495.86859482237236;496.11443573221624;496.26304937168277;5770.711464426762;5833.854153646108;5834.67909264986;5834.766609335664;5842.59101862874;8911.287097032222;9505.477198754135;9627.56675949584;9638.855417168748;9651.613935442503;9522.571484283224;9541.61833526665;9542.761430964281;9543.618255269712;9553.808923821623;7222.855542889218;7332;7344.816379590553;7386.372158366599;7419.740309089156;7029.753958611424;7101.964490177723;7112.822179445555;7118.60847653384;7127.2516385778745;8135.267825895698;8245.381596380175;8484.660613575636;8496;8517.701880434155;8491.91508084936;8545.786355340917;8695.434796738191;8695.652173912973;8706.390552661253;6142.293636231891;6257.5932564383165;6261.3112557617715;6828.897566536407;6926.44588432914;6863.313668633096;7093.751718689821;7201.387882030086;7218.566885986857;7223.3747406833045;6623.536352455282;6707.664616769044;6818.522703410912;6840.521163518506;6942.340477654615;6622.139121914313;6660.766873159416;6750.797476075725;6753.527253092237;6763.661816909036;6648.434883034996;6674.265830758515;6681.966590167018;6698.66506674674;6785.2536221016635;6134.539909506716;6156.138140660221;6185.876282474415;6195.938040619536;6205.193324867739;6107.816765497042;6141.723622437091;6145.9692701536205;6148.385161483816;6169.876602468015 17:17:51 INFO - PROCESS | 15876 | |4;prototype.html;341.67711512620576;349.98775042873507;351.1327022255029;354.20834435037705;356.36211181984265;5784.56615753818;5899.3805650406675;5904.527637788978;5943.910841337378;5950.047992321235;5674.517665998395;5841.707914604263;5887.116932460133;5894.322152952412;5895.498882594974;4541;4550.089982003596;4553.248713962209;4553.408056952591;4569.588737013668;4428.092241090569;4486.932696009562;4504.797284122206;4565.977170114144;4596.701214421052;4504.1892459357305;4515.954840451603;4520.864374068783;4530.8867278317975;4560.749158796265;4544.113897789933;4556.6582506312;4567.13224487348;4573.085382923396;4584.243599806061;4000.7999600020175;4024.7383920045104;4030.2141082488924;4036.2936486114813;4039.939400908989;5499.285092937933;5608.579356548275;5621;5655.745491452894;5677.545796336283;5281.102212623825;5283.207518872162;5285.709285989269;5296.232046353257;5296.285001524783;6063.120847477136;6316.873662526769;6317.778877739257;6320.936790632127;6325.462335701471;4305.160493703729;4318.460192475941;4377.255866502702;4385.429894113745;4386.539413361615;6417.967910160466;6573.967130164367;6576.276609572943;6580.407763301326;6580.901286480706;4527.004059106991;4530.818767249339;4531.252343363374;4532.410786597788;4538.29656403258;4499.977500112478;4590.127875703605;4591.770411479412;4593.127305811885;4614.446266448048;5236.188390799432;5241.842744717665;5245.737713114329;5280.6039547034125;5289.576833853283;6302.054691796267;6338.556301058881;6342.365763423621;6345.111684364193;6350.745970161234;1601.75973603958;1619.8299178586078;1619.9109049002182;1619.9551289418496;1622.6105734623604;1085.4138765066934;1090;1093.3002878157986;1111.483160330434;1116.9385683787307;5982.551308651781;5984.192134061933;5988.221531200916;5994.07091900756;6000.939990600038;6513.478921686348;6523.967380163069;6527.5757075789925;6528;6534.183227096613;5868.823935281948;5997.430244126801;6000.849978750479;6005;6006.429389208106;3510.087377281925;3541.061618671054;3546.946795798065;3548.2903419315726;3551.964480355215;6736.831579210461;6742.898856517156;6745.460363170934;6749.93250067493;6755.324467553303;6676.031975363642;6685.130932978779;6685.197776266782;6695.230048544382;6696.8995465068065;6563.212414510289;6798.014287928321;6812.863742725217;6817.897731534031;6828.419584335387;6305.747770089145;6448.9032664511005;6546.803595892131;6548.476121910331;6552.312007239171;6358.841028974312;6409.775657851953;6454.612723236621;6457.903131453126;6466.418022378009;6698.330166983263;6731.225909020525;6765.5264131512295;6775.356341147583;6782.084418603426;4577.473590536998;4601.516840731675;4639.698419602715;4651.162790697707;4659.301104834167;6460.709268083042;6473.449756770538;6475.8990971535895;6478.125453063776;6482.254540727877;6261.624302541862;6261.624302541862;6263.498920086291;6269.122322874892;6274.372562743689;6189.6286222826775;6299.96850015747;6301.275353334425;6302.306746257999;6308.936910630835;6197.783077592443;6200.410960958701;6200.906986395117;6206.906896396467;6215.782447614311;6309.779157729457;6319;6331.493480521639;6333.588316759396;6337.049442583465;6026.728797204224;6177.073438984188;6180;6180.381961803963;6189.938100618936 17:17:51 INFO - PROCESS | 15876 | |5;yui.html;682.8019874236471;694.84366017646;739.3900032473209;741.1661880384565;743.561298833688;12503.499860005611;12587;12882.935585322071;13066;13076.60770176895;13034.087613867034;13113.73772524549;13137.868621313784;13150.079494435393;13178.670533236675;677.8779819632464;683.0778449093733;804.8269622031262;808.1070417188995;813.1583810755869;801.0907619851481;808.4623725222749;814.722994181978;817.9591020448954;818.0837462042521;863.9049704532497;871.4640496094888;871.9738407847775;872.0102683454294;872.5331947408138;707.8018154916632;716.5485743981285;838.534613289624;857.5155037403847;858.5578427110044;627.2285089340137;628.8616504369031;628.9025201093838;628.9748410063592;629.5876201088295;13002.219866808022;13169.539066132735;13177.341132943315;13200;13218.933905330412;11534.711632209179;11967.1622986391;12105.394730263451;12208.084393670422;12345.69135771604;10716.303440276357;10760.838587421194;10858.457077146111;10959.726006849813;11069.612563560317;3560.537130173087;3563.8574457021687;3582.7850328980085;3608.4767708682357;3609.62098979606;44850.32724509102;45714.31428528575;45761.31358029632;45795.54204457946;45876.54123458756;9670.419774813534;10160.949195254125;10187.949060254652;10235.539400726986;10237.283390162765;18188.272469101088;18333.90833045853;18440.26238950427;18473;18506.907465462587;7109.938117945738;7326.487145899736;7427.740029098955;7603.771886843404;7648.885266721004;3989.7007724420782;4017.799110044486;4041.1715598302276;4108.938365924513;4111.773852438085;3125.1405863387295;3175.380800743879;3177.6504584495688;3183.7293830024246;3185.1718553176343;540.7215284128677;558.126531977454;572.2532095615262;576.8471355090904;577.2466930655451;496.6597880451902;543.9428859969726;579.7622974580486;600.2341409210939;630.9463695585927;8352.791180220544;8634.784130396665;8902.287816974627;8981.46111233315;9193.908060919439;537.965032272901;667.5927684112785;680.7175022365761;692.7679227458757;726.3027493606091;3359.10983589349;3555.6622120898473;3782.829772660182;3917.2557214129224;3975.662068724133;53199.73400132974;53585.73207133939;54481.727591362585;57069.714651427304;57312.71343643338;46155;46255;46578.767106164254;46855;47085.52914470811;48733.26900096501;49499.752501237264;49586.50413495891;50241.748791255806;50379.74810125999;8585.313174945864;8825.91174088251;8931.106889311017;8982.056884027083;9174.862377064215;35157.82421087878;35198;35884;36224;36879.44680829736;42850;42943.7852810734;43044.35433468563;44106.77946610247;44183.77908110439;11094.889051109709;11524.711882203012;11558.768824623628;11640.417979100841;11806.645800625995;12186.086043546593;12393.318367489876;12411.565595204125;12576.371181440709;12578;10892.836607450736;11140.164487663296;11152.16358773079;11471.311721296748;11513.597024104116;11129.63776508649;11549.076073914235;11661.941690291495;11668.533258669897;11957;11025.61410350634;11058.557657693602;11261.099112070851;11312;11625;9777.608895644094;10278.383297002203;10423;10744.570217191538;10767.6231331903;9043.18611324984;9111.908880911371;9368.578413971523;9535.38020028696;9841.26190535727 17:17:51 INFO - PROCESS | 15876 | __end_tp_report 17:17:51 INFO - PROCESS | 15876 | __start_cc_report 17:17:51 INFO - PROCESS | 15876 | _x_x_mozilla_cycle_collect,900 17:17:51 INFO - PROCESS | 15876 | __end_cc_report 17:17:51 INFO - PROCESS | 15876 | __startTimestamp1451956671233__endTimestamp 17:17:51 INFO - PROCESS | 15876 | 17:17:51 INFO - PROCESS | 15876 | ------- Summary: start ------- 17:17:51 INFO - PROCESS | 15876 | Number of tests: 6 17:17:51 INFO - PROCESS | 15876 | 17:17:51 INFO - PROCESS | 15876 | [#0] dojo.html Cycles:165 Average:5292.20 Median:5516.67 stddev:583.92 (10.6%) stddev-sans-first:559.80 17:17:51 INFO - PROCESS | 15876 | Values: 3099.5 3129.5 3163.0 3177.3 3205.6 5179.8 5259.9 5266.5 5271.6 5307.2 5260.5 5270.6 5354.7 5376.5 5393.8 4798.4 4856.1 4865.1 4871.7 4924.5 4870.6 5003.4 5036.9 5043.8 5091.1 4753.7 4842.1 4967.0 4975.9 5023.9 4791.1 4862.7 4885.3 4887.0 4895.2 4771.6 4805.2 4806.5 4817.4 4818.7 5093.7 5165.0 5185.5 5196.6 5225.5 5744.0 5770.6 5772.5 5776.2 5777.2 5779.7 5810.4 5814.3 5814.8 5825.9 5198.1 5291.9 5304.1 5311.7 5382.7 5795.5 5801.5 5807.9 5825.7 5838.1 5611.6 5612.4 5612.7 5617.2 5661.2 5644.1 5652.3 5690.5 5695.1 5748.5 5525.9 5528.7 5528.9 5538.5 5598.8 5475.9 5502.0 5513.3 5516.7 5535.9 4325.2 4354.0 4372.7 4416.2 4443.2 3885.5 3912.9 3927.3 3949.0 3981.3 5254.4 5264.9 5265.5 5269.1 5308.5 5554.5 5669.5 5670.4 5715.9 5716.3 5266.3 5348.1 5358.4 5358.9 5371.8 4903.2 4920.6 4922.2 4922.7 4965.1 5737.8 5878.7 5935.6 5940.2 5954.9 5626.8 5678.9 5684.7 5686.1 5733.9 5900.3 5904.1 5913.9 5920.7 5921.8 5524.7 5637.8 5643.0 5655.2 5661.7 5697.0 5706.9 5714.7 5738.6 5816.5 5582.7 5603.9 5605.4 5606.0 5612.1 5428.6 5588.6 5592.9 5601.7 5606.7 5534.1 5536.1 5543.2 5548.0 5557.5 5636.5 5640.7 5651.2 5668.4 5720.4 5378.1 5476.5 5489.3 5545.0 5551.1 17:17:51 INFO - PROCESS | 15876 | 17:17:51 INFO - PROCESS | 15876 | [#1] ext.html Cycles:180 Average:42296.87 Median:17696.30 stddev:70466.72 (398.2%) stddev-sans-first:70594.65 17:17:51 INFO - PROCESS | 15876 | Values: 539.9 548.3 565.5 570.2 574.2 28000.9 28436.3 28479.6 35094.0 35512.0 38159.0 38718.4 38764.6 38797.4 38810.6 8309.9 8540.5 8541.8 8543.2 8548.6 7469.8 7598.6 9877.4 9894.4 9932.6 10124.2 10157.4 10219.7 10221.9 10222.2 7557.3 7726.9 10025.7 10091.1 10117.1 10087.3 10249.4 10250.2 10253.4 10254.0 35591.3 35986.5 36009.5 36022.8 36049.5 3152.3 3191.1 3438.7 3842.8 4015.0 28736.3 29464.3 29960.3 30324.0 31165.4 3859.9 3898.8 3906.4 3950.3 4058.2 258578.0 258631.0 259210.0 259604.0 260526.0 55790.4 57282.7 57285.7 57309.7 57318.4 50736.7 52045.0 57263.4 60223.0 60357.7 14643.5 14706.9 14748.9 14803.1 14916.3 10535.5 10622.6 10647.7 10658.5 10696.9 18191.7 18226.8 18252.1 18260.2 18290.6 7522.1 7876.1 8007.3 8008.1 8079.5 922.9 950.0 967.0 993.2 1041.1 28015.4 28306.2 28660.9 28751.7 28823.7 832.3 854.9 955.3 961.9 998.8 12689.0 12859.2 12908.4 12977.6 13022.3 330444.0 334833.0 334986.0 335786.0 336101.0 49135.8 49378.8 49425.3 49443.8 49508.0 1303.5 1317.2 1318.2 1321.9 1326.0 21412.5 25282.2 25635.5 26166.5 26200.5 41714.2 42283.0 42290.2 42293.2 42317.4 194319.0 194579.0 195185.0 196047.0 196163.0 28290.7 30270.0 30877.2 30922.2 31110.8 36966.6 36979.3 37060.6 37220.4 38043.4 32201.5 32217.0 33185.7 33788.8 34921.8 27071.2 28727.0 29050.4 29935.7 34340.1 31194.4 31682.7 31730.4 32218.4 32231.2 28680.7 31128.2 31453.8 31727.8 31760.8 23543.4 23724.0 23949.0 24150.9 24207.0 17:17:51 INFO - PROCESS | 15876 | 17:17:51 INFO - PROCESS | 15876 | [#2] jquery.html Cycles:180 Average:24604.97 Median:2095.20 stddev:71101.91 (3393.6%) stddev-sans-first:71278.06 17:17:51 INFO - PROCESS | 15876 | Values: 359.7 362.9 364.5 365.8 366.3 14058.3 14097.8 16221.2 17742.5 18911.3 10986.5 11263.8 16157.2 16297.4 16389.1 4828.0 4967.9 4969.7 4972.9 4973.0 3806.9 3869.4 4927.0 6519.6 6682.1 6478.8 6615.8 6616.4 6691.1 6694.7 6579.4 6631.7 6634.8 6636.3 6640.0 5942.9 6112.4 6125.1 6316.7 6322.6 21017.4 21116.6 21428.7 21503.1 22318.3 2129.1 2148.7 2183.8 2205.6 2217.2 13694.9 13878.7 13947.1 14046.9 14360.6 1940.2 1949.7 2018.7 2034.2 2085.9 66163.3 66464.3 68991.3 69203.3 69535.0 15565.0 15579.9 15624.6 15629.9 15681.6 23775.8 23829.4 23841.9 24118.8 24130.9 8932.7 8944.7 8947.3 8956.8 8998.1 7536.6 7569.6 7597.4 7606.5 7681.2 7034.7 7625.6 7870.3 7950.6 7999.1 2569.7 2945.2 3008.4 3076.5 3086.6 383.5 410.2 426.2 465.5 749.5 9253.7 10124.1 10368.9 10756.1 11101.7 444.2 463.9 469.2 471.4 495.1 5983.8 6038.0 6073.8 6080.3 6105.5 126166.0 126602.0 511052.4 559779.0 564937.0 75631.6 78015.6 78433.0 78621.6 79744.6 499.3 503.4 504.1 504.3 504.3 9654.3 10086.2 10401.3 10452.9 10453.2 31483.7 33323.2 33639.8 33760.3 34353.7 44034.0 44963.0 45017.8 45407.0 47142.8 9240.0 9442.5 9623.1 9810.7 9825.3 16675.4 16908.6 16920.0 17104.2 17273.6 12603.2 13495.3 13499.8 13851.4 13924.3 11062.5 13519.9 13865.7 13988.9 14719.4 12691.6 12786.9 13214.4 13228.7 13229.2 9045.3 9062.4 9225.7 9245.8 9297.0 12357.9 12378.8 13113.2 13168.3 13363.2 17:17:51 INFO - PROCESS | 15876 | 17:17:51 INFO - PROCESS | 15876 | [#3] mootools.html Cycles:180 Average:5379.19 Median:6121.18 stddev:2819.88 (46.1%) stddev-sans-first:2810.55 17:17:51 INFO - PROCESS | 15876 | Values: 1231.6 1450.5 1462.3 1608.8 1793.5 6871.6 7405.7 7482.0 7502.2 7507.9 7330.5 7553.9 7555.8 7556.8 7558.4 2198.7 2230.2 2230.3 2232.5 2234.7 2211.1 2236.5 2308.5 2313.6 2325.3 2302.8 2308.3 2316.2 2318.5 2340.4 2262.7 2277.2 2304.2 2304.8 2304.9 2280.0 2307.8 2308.1 2309.5 2310.5 7595.9 7668.5 7685.0 7692.2 7707.2 4633.0 4715.8 4736.1 4742.2 4745.5 2928.2 2954.3 3023.7 3033.6 3041.6 1069.6 1070.7 1116.4 1116.7 1149.4 10546.8 10689.7 10697.7 10760.6 10800.1 4204.2 4222.8 4292.7 4317.5 4324.0 9329.1 9364.7 9388.1 9393.3 9411.3 4807.5 4812.6 4812.7 4814.0 4824.0 3758.2 3805.8 4086.2 4375.9 4380.7 3630.1 3630.7 3670.9 3679.2 3679.8 1145.8 1152.7 1153.6 1156.2 1167.7 1300.0 1305.0 1324.1 1337.6 1337.7 6991.8 7060.9 7173.5 7175.5 7182.7 481.9 486.8 495.9 496.1 496.3 5770.7 5833.9 5834.7 5834.8 5842.6 8911.3 9505.5 9627.6 9638.9 9651.6 9522.6 9541.6 9542.8 9543.6 9553.8 7222.9 7332.0 7344.8 7386.4 7419.7 7029.8 7102.0 7112.8 7118.6 7127.3 8135.3 8245.4 8484.7 8496.0 8517.7 8491.9 8545.8 8695.4 8695.7 8706.4 6142.3 6257.6 6261.3 6828.9 6926.4 6863.3 7093.8 7201.4 7218.6 7223.4 6623.5 6707.7 6818.5 6840.5 6942.3 6622.1 6660.8 6750.8 6753.5 6763.7 6648.4 6674.3 6682.0 6698.7 6785.3 6134.5 6156.1 6185.9 6195.9 6205.2 6107.8 6141.7 6146.0 6148.4 6169.9 17:17:51 INFO - PROCESS | 15876 | 17:17:51 INFO - PROCESS | 15876 | [#4] prototype.html Cycles:180 Average:5277.26 Median:5966.30 stddev:1574.88 (26.4%) stddev-sans-first:1535.11 17:17:51 INFO - PROCESS | 15876 | Values: 341.7 350.0 351.1 354.2 356.4 5784.6 5899.4 5904.5 5943.9 5950.0 5674.5 5841.7 5887.1 5894.3 5895.5 4541.0 4550.1 4553.2 4553.4 4569.6 4428.1 4486.9 4504.8 4566.0 4596.7 4504.2 4516.0 4520.9 4530.9 4560.7 4544.1 4556.7 4567.1 4573.1 4584.2 4000.8 4024.7 4030.2 4036.3 4039.9 5499.3 5608.6 5621.0 5655.7 5677.5 5281.1 5283.2 5285.7 5296.2 5296.3 6063.1 6316.9 6317.8 6320.9 6325.5 4305.2 4318.5 4377.3 4385.4 4386.5 6418.0 6574.0 6576.3 6580.4 6580.9 4527.0 4530.8 4531.3 4532.4 4538.3 4500.0 4590.1 4591.8 4593.1 4614.4 5236.2 5241.8 5245.7 5280.6 5289.6 6302.1 6338.6 6342.4 6345.1 6350.7 1601.8 1619.8 1619.9 1620.0 1622.6 1085.4 1090.0 1093.3 1111.5 1116.9 5982.6 5984.2 5988.2 5994.1 6000.9 6513.5 6524.0 6527.6 6528.0 6534.2 5868.8 5997.4 6000.8 6005.0 6006.4 3510.1 3541.1 3546.9 3548.3 3552.0 6736.8 6742.9 6745.5 6749.9 6755.3 6676.0 6685.1 6685.2 6695.2 6696.9 6563.2 6798.0 6812.9 6817.9 6828.4 6305.7 6448.9 6546.8 6548.5 6552.3 6358.8 6409.8 6454.6 6457.9 6466.4 6698.3 6731.2 6765.5 6775.4 6782.1 4577.5 4601.5 4639.7 4651.2 4659.3 6460.7 6473.4 6475.9 6478.1 6482.3 6261.6 6261.6 6263.5 6269.1 6274.4 6189.6 6300.0 6301.3 6302.3 6308.9 6197.8 6200.4 6200.9 6206.9 6215.8 6309.8 6319.0 6331.5 6333.6 6337.0 6026.7 6177.1 6180.0 6180.4 6189.9 17:17:51 INFO - PROCESS | 15876 | 17:17:51 INFO - PROCESS | 15876 | [#5] yui.html Cycles:180 Average:13629.16 Median:43575.57 stddev:15500.57 (35.6%) stddev-sans-first:15513.56 17:17:51 INFO - PROCESS | 15876 | Values: 682.8 694.8 739.4 741.2 743.6 12503.5 12587.0 12882.9 13066.0 13076.6 13034.1 13113.7 13137.9 13150.1 13178.7 677.9 683.1 804.8 808.1 813.2 801.1 808.5 814.7 818.0 818.1 863.9 871.5 872.0 872.0 872.5 707.8 716.5 838.5 857.5 858.6 627.2 628.9 628.9 629.0 629.6 13002.2 13169.5 13177.3 13200.0 13218.9 11534.7 11967.2 12105.4 12208.1 12345.7 10716.3 10760.8 10858.5 10959.7 11069.6 3560.5 3563.9 3582.8 3608.5 3609.6 44850.3 45714.3 45761.3 45795.5 45876.5 9670.4 10160.9 10187.9 10235.5 10237.3 18188.3 18333.9 18440.3 18473.0 18506.9 7109.9 7326.5 7427.7 7603.8 7648.9 3989.7 4017.8 4041.2 4108.9 4111.8 3125.1 3175.4 3177.7 3183.7 3185.2 540.7 558.1 572.3 576.8 577.2 496.7 543.9 579.8 600.2 630.9 8352.8 8634.8 8902.3 8981.5 9193.9 538.0 667.6 680.7 692.8 726.3 3359.1 3555.7 3782.8 3917.3 3975.7 53199.7 53585.7 54481.7 57069.7 57312.7 46155.0 46255.0 46578.8 46855.0 47085.5 48733.3 49499.8 49586.5 50241.7 50379.7 8585.3 8825.9 8931.1 8982.1 9174.9 35157.8 35198.0 35884.0 36224.0 36879.4 42850.0 42943.8 43044.4 44106.8 44183.8 11094.9 11524.7 11558.8 11640.4 11806.6 12186.1 12393.3 12411.6 12576.4 12578.0 10892.8 11140.2 11152.2 11471.3 11513.6 11129.6 11549.1 11661.9 11668.5 11957.0 11025.6 11058.6 11261.1 11312.0 11625.0 9777.6 10278.4 10423.0 10744.6 10767.6 9043.2 9111.9 9368.6 9535.4 9841.3 17:17:51 INFO - PROCESS | 15876 | -------- Summary: end -------- 17:17:51 INFO - PROCESS | 15876 | 17:17:51 INFO - TEST-INFO | 15876: exit 0 17:17:51 INFO - TEST-OK | dromaeo_css | took 1112745ms 17:17:51 INFO - TEST-START | kraken 17:17:51 INFO - operating with platform_type : linux_ 17:17:51 INFO - Initialising browser for kraken test... 17:17:51 INFO - TEST-INFO | started process 16068 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHEWs6E/profile http://localhost:40358/getInfo.html) 17:17:55 INFO - PROCESS | 16068 | __metrics Screen width/height:1600/1200 17:17:55 INFO - PROCESS | 16068 | colorDepth:24 17:17:55 INFO - PROCESS | 16068 | Browser inner width/height: 1024/697 17:17:55 INFO - PROCESS | 16068 | __metrics 17:17:55 INFO - PROCESS | 16068 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:17:55 INFO - PROCESS | 16068 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:17:56 INFO - TEST-INFO | 16068: exit 0 17:17:56 INFO - Browser initialized. 17:17:56 INFO - Running cycle 1/1 for kraken test... 17:17:56 INFO - TEST-INFO | started process 16150 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHEWs6E/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:18:08 INFO - PROCESS | 16150 | RSS: Main: 150704128 17:18:08 INFO - PROCESS | 16150 | 17:18:11 INFO - PROCESS | 16150 | Cycle 1(1): loaded http://localhost:40358/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40358/tests/kraken/driver.html?testName=audio-beat-detection) 17:18:11 INFO - PROCESS | 16150 | RSS: Main: 186638336 17:18:11 INFO - PROCESS | 16150 | 17:18:14 INFO - PROCESS | 16150 | Cycle 1(1): loaded http://localhost:40358/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40358/tests/kraken/driver.html?testName=audio-dft) 17:18:15 INFO - PROCESS | 16150 | RSS: Main: 177086464 17:18:15 INFO - PROCESS | 16150 | 17:18:17 INFO - PROCESS | 16150 | Cycle 1(1): loaded http://localhost:40358/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40358/tests/kraken/driver.html?testName=audio-fft) 17:18:18 INFO - PROCESS | 16150 | RSS: Main: 160866304 17:18:18 INFO - PROCESS | 16150 | 17:18:20 INFO - PROCESS | 16150 | Cycle 1(1): loaded http://localhost:40358/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40358/tests/kraken/driver.html?testName=audio-oscillator) 17:18:21 INFO - PROCESS | 16150 | RSS: Main: 163205120 17:18:21 INFO - PROCESS | 16150 | 17:18:23 INFO - PROCESS | 16150 | Cycle 1(1): loaded http://localhost:40358/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40358/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:18:23 INFO - PROCESS | 16150 | RSS: Main: 164360192 17:18:23 INFO - PROCESS | 16150 | 17:18:26 INFO - PROCESS | 16150 | Cycle 1(1): loaded http://localhost:40358/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40358/tests/kraken/driver.html?testName=imaging-darkroom) 17:18:27 INFO - PROCESS | 16150 | RSS: Main: 164995072 17:18:27 INFO - PROCESS | 16150 | 17:18:30 INFO - PROCESS | 16150 | Cycle 1(1): loaded http://localhost:40358/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40358/tests/kraken/driver.html?testName=imaging-desaturate) 17:18:31 INFO - PROCESS | 16150 | RSS: Main: 166498304 17:18:31 INFO - PROCESS | 16150 | 17:18:34 INFO - PROCESS | 16150 | Cycle 1(1): loaded http://localhost:40358/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40358/tests/kraken/driver.html?testName=json-parse-financial) 17:18:34 INFO - PROCESS | 16150 | RSS: Main: 166363136 17:18:34 INFO - PROCESS | 16150 | 17:18:36 INFO - PROCESS | 16150 | Cycle 1(1): loaded http://localhost:40358/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40358/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:18:36 INFO - PROCESS | 16150 | RSS: Main: 176422912 17:18:36 INFO - PROCESS | 16150 | 17:18:38 INFO - PROCESS | 16150 | Cycle 1(1): loaded http://localhost:40358/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40358/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:18:39 INFO - PROCESS | 16150 | RSS: Main: 174391296 17:18:39 INFO - PROCESS | 16150 | 17:18:41 INFO - PROCESS | 16150 | Cycle 1(1): loaded http://localhost:40358/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40358/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:18:41 INFO - PROCESS | 16150 | RSS: Main: 182255616 17:18:41 INFO - PROCESS | 16150 | 17:18:44 INFO - PROCESS | 16150 | Cycle 1(1): loaded http://localhost:40358/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40358/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:18:44 INFO - PROCESS | 16150 | RSS: Main: 189714432 17:18:44 INFO - PROCESS | 16150 | 17:18:47 INFO - PROCESS | 16150 | Cycle 1(1): loaded http://localhost:40358/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40358/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:18:47 INFO - PROCESS | 16150 | RSS: Main: 188358656 17:18:47 INFO - PROCESS | 16150 | 17:18:49 INFO - PROCESS | 16150 | Cycle 1(1): loaded http://localhost:40358/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40358/tests/kraken/driver.html?testName=ai-astar) 17:18:49 INFO - PROCESS | 16150 | RSS: Main: 245080064 17:18:49 INFO - PROCESS | 16150 | 17:18:49 INFO - PROCESS | 16150 | __start_tp_report 17:18:49 INFO - PROCESS | 16150 | _x_x_mozilla_page_load 17:18:49 INFO - PROCESS | 16150 | _x_x_mozilla_page_load_details 17:18:49 INFO - PROCESS | 16150 | |i|pagename|runs| 17:18:49 INFO - PROCESS | 16150 | |0;ai-astar;109;111;107;112;110;111;100;110;111;117 17:18:49 INFO - PROCESS | 16150 | |1;audio-beat-detection;152;135;149;163;128;153;152;130;177;127 17:18:49 INFO - PROCESS | 16150 | |2;audio-dft;160;161;160;161;163;161;162;165;161;161 17:18:49 INFO - PROCESS | 16150 | |3;audio-fft;73;71;86;92;71;71;73;102;88;71 17:18:49 INFO - PROCESS | 16150 | |4;audio-oscillator;96;96;145;95;97;96;138;95;96;141 17:18:49 INFO - PROCESS | 16150 | |5;imaging-gaussian-blur;109;109;109;108;109;109;109;109;110;108 17:18:49 INFO - PROCESS | 16150 | |6;imaging-darkroom;145;146;145;146;144;146;146;145;145;145 17:18:49 INFO - PROCESS | 16150 | |7;imaging-desaturate;96;95;95;96;96;96;96;95;96;96 17:18:49 INFO - PROCESS | 16150 | |8;json-parse-financial;58;57;56;56;57;57;57;67;55;55 17:18:49 INFO - PROCESS | 16150 | |9;json-stringify-tinderbox;67;68;67;68;69;67;67;67;67;75 17:18:49 INFO - PROCESS | 16150 | |10;stanford-crypto-aes;84;85;86;86;92;85;84;86;86;85 17:18:49 INFO - PROCESS | 16150 | |11;stanford-crypto-ccm;118;120;117;115;125;117;122;117;123;120 17:18:49 INFO - PROCESS | 16150 | |12;stanford-crypto-pbkdf2;143;146;154;152;156;144;166;153;155;163 17:18:49 INFO - PROCESS | 16150 | |13;stanford-crypto-sha256-iterative;70;69;69;67;70;68;68;69;69;67 17:18:49 INFO - PROCESS | 16150 | __end_tp_report 17:18:49 INFO - PROCESS | 16150 | __start_cc_report 17:18:49 INFO - PROCESS | 16150 | _x_x_mozilla_cycle_collect,927 17:18:49 INFO - PROCESS | 16150 | __end_cc_report 17:18:49 INFO - PROCESS | 16150 | __startTimestamp1451956729841__endTimestamp 17:18:49 INFO - PROCESS | 16150 | 17:18:49 INFO - PROCESS | 16150 | ------- Summary: start ------- 17:18:49 INFO - PROCESS | 16150 | Number of tests: 14 17:18:49 INFO - PROCESS | 16150 | 17:18:49 INFO - PROCESS | 16150 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:4.29 (3.9%) stddev-sans-first:4.54 17:18:49 INFO - PROCESS | 16150 | Values: 109.0 111.0 107.0 112.0 110.0 111.0 100.0 110.0 111.0 117.0 17:18:49 INFO - PROCESS | 16150 | 17:18:49 INFO - PROCESS | 16150 | [#1] audio-beat-detection Cycles:10 Average:146.60 Median:152.00 stddev:16.46 (10.8%) stddev-sans-first:17.34 17:18:49 INFO - PROCESS | 16150 | Values: 152.0 135.0 149.0 163.0 128.0 153.0 152.0 130.0 177.0 127.0 17:18:49 INFO - PROCESS | 16150 | 17:18:49 INFO - PROCESS | 16150 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.00 stddev:1.51 (0.9%) stddev-sans-first:1.50 17:18:49 INFO - PROCESS | 16150 | Values: 160.0 161.0 160.0 161.0 163.0 161.0 162.0 165.0 161.0 161.0 17:18:49 INFO - PROCESS | 16150 | 17:18:49 INFO - PROCESS | 16150 | [#3] audio-fft Cycles:10 Average:79.80 Median:73.00 stddev:11.30 (15.5%) stddev-sans-first:11.72 17:18:49 INFO - PROCESS | 16150 | Values: 73.0 71.0 86.0 92.0 71.0 71.0 73.0 102.0 88.0 71.0 17:18:49 INFO - PROCESS | 16150 | 17:18:49 INFO - PROCESS | 16150 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:96.00 stddev:22.04 (23.0%) stddev-sans-first:22.83 17:18:49 INFO - PROCESS | 16150 | Values: 96.0 96.0 145.0 95.0 97.0 96.0 138.0 95.0 96.0 141.0 17:18:49 INFO - PROCESS | 16150 | 17:18:49 INFO - PROCESS | 16150 | [#5] imaging-gaussian-blur Cycles:10 Average:108.90 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 17:18:49 INFO - PROCESS | 16150 | Values: 109.0 109.0 109.0 108.0 109.0 109.0 109.0 109.0 110.0 108.0 17:18:49 INFO - PROCESS | 16150 | 17:18:49 INFO - PROCESS | 16150 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 17:18:49 INFO - PROCESS | 16150 | Values: 145.0 146.0 145.0 146.0 144.0 146.0 146.0 145.0 145.0 145.0 17:18:49 INFO - PROCESS | 16150 | 17:18:49 INFO - PROCESS | 16150 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 17:18:49 INFO - PROCESS | 16150 | Values: 96.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 17:18:49 INFO - PROCESS | 16150 | 17:18:49 INFO - PROCESS | 16150 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:57.00 stddev:3.47 (6.1%) stddev-sans-first:3.68 17:18:49 INFO - PROCESS | 16150 | Values: 58.0 57.0 56.0 56.0 57.0 57.0 57.0 67.0 55.0 55.0 17:18:49 INFO - PROCESS | 16150 | 17:18:49 INFO - PROCESS | 16150 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:67.50 stddev:2.49 (3.7%) stddev-sans-first:2.60 17:18:49 INFO - PROCESS | 16150 | Values: 67.0 68.0 67.0 68.0 69.0 67.0 67.0 67.0 67.0 75.0 17:18:49 INFO - PROCESS | 16150 | 17:18:49 INFO - PROCESS | 16150 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.00 stddev:2.28 (2.7%) stddev-sans-first:2.32 17:18:49 INFO - PROCESS | 16150 | Values: 84.0 85.0 86.0 86.0 92.0 85.0 84.0 86.0 86.0 85.0 17:18:49 INFO - PROCESS | 16150 | 17:18:49 INFO - PROCESS | 16150 | [#11] stanford-crypto-ccm Cycles:10 Average:119.40 Median:120.00 stddev:3.17 (2.6%) stddev-sans-first:3.32 17:18:49 INFO - PROCESS | 16150 | Values: 118.0 120.0 117.0 115.0 125.0 117.0 122.0 117.0 123.0 120.0 17:18:49 INFO - PROCESS | 16150 | 17:18:49 INFO - PROCESS | 16150 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.20 Median:154.50 stddev:7.55 (4.9%) stddev-sans-first:7.05 17:18:49 INFO - PROCESS | 16150 | Values: 143.0 146.0 154.0 152.0 156.0 144.0 166.0 153.0 155.0 163.0 17:18:49 INFO - PROCESS | 16150 | 17:18:49 INFO - PROCESS | 16150 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.07 (1.6%) stddev-sans-first:1.01 17:18:49 INFO - PROCESS | 16150 | Values: 70.0 69.0 69.0 67.0 70.0 68.0 68.0 69.0 69.0 67.0 17:18:49 INFO - PROCESS | 16150 | -------- Summary: end -------- 17:18:49 INFO - PROCESS | 16150 | 17:18:50 INFO - TEST-INFO | 16150: exit 0 17:18:50 INFO - TEST-OK | kraken | took 58761ms 17:18:50 INFO - TEST-START | v8_7 17:18:50 INFO - operating with platform_type : linux_ 17:18:50 INFO - Initialising browser for v8_7 test... 17:18:50 INFO - TEST-INFO | started process 16400 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFchNXc/profile http://localhost:40358/getInfo.html) 17:18:54 INFO - PROCESS | 16400 | __metrics Screen width/height:1600/1200 17:18:54 INFO - PROCESS | 16400 | colorDepth:24 17:18:54 INFO - PROCESS | 16400 | Browser inner width/height: 1024/697 17:18:54 INFO - PROCESS | 16400 | __metrics 17:18:54 INFO - PROCESS | 16400 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:18:54 INFO - PROCESS | 16400 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:18:55 INFO - TEST-INFO | 16400: exit 0 17:18:55 INFO - Browser initialized. 17:18:55 INFO - Running cycle 1/1 for v8_7 test... 17:18:55 INFO - TEST-INFO | started process 16484 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFchNXc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:19:07 INFO - PROCESS | 16484 | RSS: Main: 150745088 17:19:07 INFO - PROCESS | 16484 | 17:19:29 INFO - PROCESS | 16484 | Cycle 1(1): loaded http://localhost:40358/tests/v8_7/run.html (next: http://localhost:40358/tests/v8_7/run.html) 17:19:29 INFO - PROCESS | 16484 | RSS: Main: 537595904 17:19:29 INFO - PROCESS | 16484 | 17:19:29 INFO - PROCESS | 16484 | __start_tp_report 17:19:29 INFO - PROCESS | 16484 | _x_x_mozilla_page_load 17:19:29 INFO - PROCESS | 16484 | _x_x_mozilla_page_load_details 17:19:29 INFO - PROCESS | 16484 | |i|pagename|runs| 17:19:29 INFO - PROCESS | 16484 | |0;Richards;167.1402306535183 17:19:29 INFO - PROCESS | 16484 | |1;DeltaBlue;192.12295869356387 17:19:29 INFO - PROCESS | 16484 | |2;Encrypt;279.9552071668533 17:19:29 INFO - PROCESS | 16484 | |3;Decrypt;5284.210526315789 17:19:29 INFO - PROCESS | 16484 | |4;RayTrace;1960.7843137254902 17:19:29 INFO - PROCESS | 16484 | |5;Earley;809.215844785772 17:19:29 INFO - PROCESS | 16484 | |6;Boyer;12444.444444444445 17:19:29 INFO - PROCESS | 16484 | |7;RegExp;26394.736842105263 17:19:29 INFO - PROCESS | 16484 | |8;Splay;601.6847172081829 17:19:29 INFO - PROCESS | 16484 | |9;NavierStokes;4835.748792270531 17:19:29 INFO - PROCESS | 16484 | __end_tp_report 17:19:29 INFO - PROCESS | 16484 | __startTimestamp1451956769421__endTimestamp 17:19:29 INFO - PROCESS | 16484 | 17:19:29 INFO - PROCESS | 16484 | ------- Summary: start ------- 17:19:29 INFO - PROCESS | 16484 | Number of tests: 10 17:19:29 INFO - PROCESS | 16484 | 17:19:29 INFO - PROCESS | 16484 | [#0] Richards Cycles:1 Average:167.14 Median:167.14 stddev:0.00 (0.0%) 17:19:29 INFO - PROCESS | 16484 | Values: 167.1 17:19:29 INFO - PROCESS | 16484 | 17:19:29 INFO - PROCESS | 16484 | [#1] DeltaBlue Cycles:1 Average:192.12 Median:192.12 stddev:0.00 (0.0%) 17:19:29 INFO - PROCESS | 16484 | Values: 192.1 17:19:29 INFO - PROCESS | 16484 | 17:19:29 INFO - PROCESS | 16484 | [#2] Encrypt Cycles:1 Average:279.96 Median:279.96 stddev:0.00 (0.0%) 17:19:29 INFO - PROCESS | 16484 | Values: 280.0 17:19:29 INFO - PROCESS | 16484 | 17:19:29 INFO - PROCESS | 16484 | [#3] Decrypt Cycles:1 Average:5284.21 Median:5284.21 stddev:0.00 (0.0%) 17:19:29 INFO - PROCESS | 16484 | Values: 5284.2 17:19:29 INFO - PROCESS | 16484 | 17:19:29 INFO - PROCESS | 16484 | [#4] RayTrace Cycles:1 Average:1960.78 Median:1960.78 stddev:0.00 (0.0%) 17:19:29 INFO - PROCESS | 16484 | Values: 1960.8 17:19:29 INFO - PROCESS | 16484 | 17:19:29 INFO - PROCESS | 16484 | [#5] Earley Cycles:1 Average:809.22 Median:809.22 stddev:0.00 (0.0%) 17:19:29 INFO - PROCESS | 16484 | Values: 809.2 17:19:29 INFO - PROCESS | 16484 | 17:19:29 INFO - PROCESS | 16484 | [#6] Boyer Cycles:1 Average:12444.44 Median:12444.44 stddev:0.00 (0.0%) 17:19:29 INFO - PROCESS | 16484 | Values: 12444.4 17:19:29 INFO - PROCESS | 16484 | 17:19:29 INFO - PROCESS | 16484 | [#7] RegExp Cycles:1 Average:26394.74 Median:26394.74 stddev:0.00 (0.0%) 17:19:29 INFO - PROCESS | 16484 | Values: 26394.7 17:19:29 INFO - PROCESS | 16484 | 17:19:29 INFO - PROCESS | 16484 | [#8] Splay Cycles:1 Average:601.68 Median:601.68 stddev:0.00 (0.0%) 17:19:29 INFO - PROCESS | 16484 | Values: 601.7 17:19:29 INFO - PROCESS | 16484 | 17:19:29 INFO - PROCESS | 16484 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 17:19:29 INFO - PROCESS | 16484 | Values: 4835.7 17:19:29 INFO - PROCESS | 16484 | -------- Summary: end -------- 17:19:29 INFO - PROCESS | 16484 | 17:19:30 INFO - TEST-INFO | 16484: exit 0 17:19:30 INFO - TEST-OK | v8_7 | took 39583ms 17:19:30 INFO - SUITE-END | took 1211s 17:19:30 INFO - Completed test suite (00:20:11) 17:19:30 INFO - Working with test: dromaeo_css 17:19:30 INFO - Generating results file: dromaeo_css 17:19:30 INFO - Working with test: kraken 17:19:30 INFO - Generating results file: kraken 17:19:30 INFO - javascript benchmark 17:19:30 INFO - Working with test: v8_7 17:19:30 INFO - Generating results file: v8_7 17:19:30 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:19:30 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 17:19:30 INFO - process_Request line: dromaeo_css 6841.72 graph.html#tests=[[72,64,35]] 17:19:30 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:19:30 INFO - process_Request line: kraken 1509.90 graph.html#tests=[[232,64,35]] 17:19:30 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:19:30 INFO - process_Request line: v8_7 19664.16 graph.html#tests=[[230,64,35]] 17:19:30 INFO - RETURN: dromaeo_css: 6841.72 17:19:30 INFO - RETURN: kraken: 1509.90 17:19:30 INFO - RETURN: v8_7: 19664.16 17:19:30 INFO - javascript benchmark 17:19:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3099.5040793473045, 3129.499280115182, 3162.952555711663, 3177.2851108500577, 3205.599300087489, 5179.8446046618565, 5259.86850328742, 5266.499682530163, 5271.551918086962, 5307.150855863063, 5260.526552610264, 5270.5520030797425, 5354.651947623402, 5376.542993845518, 5393.757280922358, 4798.376211092553, 4856.125897338477, 4865.124277630025, 4871.7076975381415, 4924.532169443897, 4870.561649451549, 5003.39959204896, 5036.924446133311, 5043.84868453947, 5091.109055915219, 4753.738544380058, 4842.055799119174, 4967.006598680242, 4975.90048199034, 5023.874403139914, 4791.089692958327, 4862.683925544864, 4885.2916327132725, 4887.022595480918, 4895.167821470359, 4771.594414474774, 4805.159097158018, 4806.543378379049, 4817.445993710698, 4818.662693611449, 5093.745312734385, 5164.9741751291, 5185.481451854785, 5196.610254230948, 5225.503577160163, 5744.0, 5770.596058275923, 5772.480476757112, 5776.162456443834, 5777.162311464856, 5779.739911703983, 5810.389909059572, 5814.302283725938, 5814.767409303623, 5825.854353641193, 5198.116320225533, 5291.947080529222, 5304.098303288373, 5311.707856067915, 5382.730863456812, 5795.478406943395, 5801.477866991991, 5807.8548036299435, 5825.679587622637, 5838.065909454467, 5611.635243709227, 5612.438756124355, 5612.747426365823, 5617.185508101303, 5661.235733176051, 5644.096944488862, 5652.293463317085, 5690.487856092972, 5695.145728140812, 5748.540116790647, 5525.944740552623, 5528.695921724263, 5528.86177845549, 5538.501534861882, 5598.776048957996, 5475.945240547543, 5501.972490137604, 5513.3108361454815, 5516.668999860021, 5535.889282214333, 4325.15659446405, 4354.0, 4372.6939114261695, 4416.24923762961, 4443.178012067778, 3885.475460812754, 3912.882613521599, 3927.293087244266, 3949.0324870406935, 3981.343078392033, 5254.448282930313, 5264.92102618461, 5265.473452654704, 5269.104252277122, 5308.469153084738, 5554.50009499147, 5669.54643628517, 5670.432956704379, 5715.885682286331, 5716.256886604798, 5266.2890509781455, 5348.117560602457, 5358.410574836765, 5358.946410535845, 5371.811986580451, 4903.166461701519, 4920.5571498565305, 4922.237053256751, 4922.655414121049, 4965.106280869478, 5737.799177028784, 5878.735456904449, 5935.554833387427, 5940.227770389908, 5954.940450595525, 5626.803061892978, 5678.943210567842, 5684.71576421169, 5686.061799803151, 5733.8566535836935, 5900.262467191601, 5904.114382842608, 5913.852153696192, 5920.703964801829, 5921.792737254175, 5524.723763811874, 5637.774489020393, 5643.0, 5655.151727240782, 5661.745221464962, 5697.0, 5706.90136909754, 5714.714264286686, 5738.626989245686, 5816.534677225727, 5582.665040097607, 5603.8879222416135, 5605.411431799603, 5605.971970140124, 5612.074007788669, 5428.592855535771, 5588.552915766648, 5592.916106258491, 5601.747921343468, 5606.6636001840025, 5534.1145416733125, 5536.141898005815, 5543.223948647274, 5548.029094908295, 5557.472040156179, 5636.464535869086, 5640.661560306395, 5651.15232715096, 5668.37647858727, 5720.427957204246, 5378.058839702958, 5476.534494567847, 5489.313835770528, 5544.972275138599, 5551.139573366135], "unit": "score", "name": "dojo.html", "value": 5254.2482034029645}, {"lowerIsBetter": false, "replicates": [539.8677324055607, 548.3474665148473, 565.5051829649057, 570.2159530645363, 574.1674571870788, 28000.85999570002, 28436.28909277269, 28479.572806407894, 35094.0, 35512.0, 38159.0, 38718.41922371159, 38764.61235387645, 38797.41803872944, 38810.611893881054, 8309.916900831005, 8540.530270835101, 8541.786455338635, 8543.188397102265, 8548.572571371407, 7469.813254668622, 7598.620068996555, 9877.407355558653, 9894.40633561985, 9932.553035113437, 10124.240681948846, 10157.390556566592, 10219.693409197736, 10221.89778102217, 10222.182225421948, 7557.319841214317, 7726.918231447546, 10025.749356266115, 10091.091801737879, 10117.08946194846, 10087.34432261908, 10249.436281004542, 10250.179985601135, 10253.384796912209, 10254.0, 35591.28817423637, 35986.460203096976, 36009.45985810215, 36022.819885900666, 36049.45925811115, 3152.2592190835135, 3191.0745883693703, 3438.673326034023, 3842.846286148551, 4015.036391266104, 28736.281592960135, 29464.26339341512, 29960.250993725112, 30324.0, 31165.37669246625, 3859.9333157761334, 3898.8440462381473, 3906.3978093104306, 3950.328444164499, 4058.208649313385, 258578.0, 258630.9999999981, 259210.0, 259604.0, 260526.0, 55790.442095578524, 57282.713586432634, 57285.71357143188, 57309.71345143248, 57318.426815731305, 50736.74631626818, 52045.0, 57263.427365726646, 60223.0, 60357.698211508665, 14643.48747793822, 14706.852931470763, 14748.926255368655, 14803.111813291236, 14916.328765205591, 10535.525901334306, 10622.628208012837, 10647.680569582924, 10658.467076646137, 10696.94651526753, 18191.727124093148, 18226.817731822513, 18252.087395630166, 18260.178291976892, 18290.63418731618, 7522.097348318237, 7876.133625301212, 8007.319377852831, 8008.079070906921, 8079.515229086273, 922.8846394200725, 949.9810003800023, 966.970990870261, 993.1657407777357, 1041.068243921686, 28015.439691206062, 28306.15081547557, 28660.856695716804, 28751.712482875322, 28823.71176288252, 832.2759199496477, 854.9102344253764, 955.3360414511986, 961.8701475300885, 998.7652901568125, 12689.048321375934, 12859.16415432994, 12908.35458227085, 12977.610671679864, 13022.2837743925, 330444.0, 334833.0, 334986.0, 335786.0, 336101.0, 49135.77160571014, 49378.75310623424, 49425.25862112071, 49443.75278123586, 49508.0, 1303.478608556585, 1317.1504379675057, 1318.2354234544134, 1321.8744219299151, 1325.9867401326055, 21412.464688382915, 25282.241532753313, 25635.487290254463, 26166.476670466865, 26200.475990479703, 41714.165716686104, 42283.0, 42290.154196916505, 42293.15413691771, 42317.36523952205, 194319.0, 194579.0, 195185.0, 196047.0, 196163.0, 28290.717092829633, 30270.0, 30877.228069298446, 30922.226944326572, 31110.844445777628, 36966.63033369632, 36979.260414792094, 37060.62939370572, 37220.44169337408, 38043.42934855924, 32201.51697724489, 32217.0, 33185.66814331826, 33788.83105584457, 34921.82539087288, 27071.1878643641, 28727.0, 29050.41899162047, 29935.70064299416, 34340.111293879076, 31194.37611247717, 31682.683173167974, 31730.365392692478, 32218.35563288768, 32231.194220144684, 28680.71319286864, 31128.22179445532, 31453.842730787113, 31727.84136079305, 31760.841195793873, 23543.41141471477, 23724.0, 23949.0, 24150.87924560366, 24207.0], "unit": "score", "name": "ext.html", "value": 17472.446094314033}, {"lowerIsBetter": false, "replicates": [359.74098648972745, 362.93467175908324, 364.50245415008504, 365.77322060322587, 366.3113346907814, 14058.297085145727, 14097.78853317201, 16221.188940552984, 17742.467725968225, 18911.338103166374, 10986.450677466135, 11263.831042534348, 16157.192140392992, 16297.429589964353, 16389.098599577017, 4827.951720482794, 4967.925481117786, 4969.652124351279, 4972.900541989158, 4972.950270497303, 3806.9428958565504, 3869.361555343365, 4927.0, 6519.576227545194, 6682.097916781246, 6478.773242936498, 6615.768448104317, 6616.437602803743, 6691.096701945224, 6694.665266736668, 6579.374959378852, 6631.668416579176, 6634.767783127591, 6636.270010298863, 6640.0, 5942.940570594325, 6112.449879510866, 6125.111858780497, 6316.715747791361, 6322.58903171297, 21017.369478915658, 21116.5776684467, 21428.714277143266, 21503.139874405006, 22318.330450086523, 2129.095134567818, 2148.6807695552257, 2183.7816218378034, 2205.63607004844, 2217.168561789329, 13694.863051369459, 13878.722425551432, 13947.093438926437, 14046.929765351108, 14360.640983975483, 1940.1754254441805, 1949.6685563454246, 2018.7072874433125, 2034.206659402834, 2085.9165633374646, 66163.3383666162, 66464.3353566463, 68991.31008689899, 69203.30796692069, 69535.00347460006, 15565.0, 15579.922100389425, 15624.609384765245, 15629.921850390903, 15681.607959800867, 23775.7622423777, 23829.404264893168, 23841.880790595937, 24118.758812412, 24130.87934560351, 8932.687355942511, 8944.731658050268, 8947.284217262604, 8956.776080597907, 8998.055204203596, 7536.623168841536, 7569.583672898044, 7597.392208623297, 7606.467547271638, 7681.193474685189, 7034.718611255595, 7625.565317873005, 7870.29167374939, 7950.562719050507, 7999.080105787909, 2569.717331093578, 2945.2337910049064, 3008.3983203359417, 3076.461619216628, 3086.6450358208645, 383.4593223554774, 410.24514892597165, 426.2051274373272, 465.46006632306364, 749.5465243527697, 9253.67612133572, 10124.088832005154, 10368.896311036793, 10756.139508839275, 11101.72245693848, 444.19822220890956, 463.9443266808005, 469.2000139761698, 471.36130543114274, 495.1434019146824, 5983.790567330209, 6038.0, 6073.787417440457, 6080.331163572004, 6105.45050945417, 126166.0, 126602.0, 511052.4447377739, 559779.0, 564937.0, 75631.62184189154, 78015.60992195003, 78433.0391740211, 78621.60689196517, 79744.60127699324, 499.3234167702783, 503.3582182717065, 504.0976651793249, 504.26125725811863, 504.32672382369947, 9654.27592930519, 10086.193104551765, 10401.27191096616, 10452.947735261276, 10453.163746900382, 31483.685163148075, 33323.16692082717, 33639.83180084182, 33760.3247935035, 34353.65646343504, 44034.0, 44963.0, 45017.774911126544, 45407.0, 47142.764286178346, 9239.953800230956, 9442.48066356357, 9623.133917947418, 9810.705678829647, 9825.263105267277, 16675.39332286154, 16908.57728556796, 16920.0, 17104.230309636347, 17273.56816079608, 12603.18079324841, 13495.325233738078, 13499.797503037658, 13851.376688049264, 13924.303784810516, 11062.502187401748, 13519.864801351861, 13865.653358666113, 13988.860111398755, 14719.411223551366, 12691.555795547112, 12786.936065319614, 13214.405351759002, 13228.735425291632, 13229.206247625174, 9045.276377889884, 9062.410943288665, 9225.677101301422, 9245.815083698422, 9297.0, 12357.876421235673, 12378.81431778506, 13113.213207207598, 13168.341582920624, 13363.198208107544], "unit": "score", "name": "jquery.html", "value": 8602.419521162456}, {"lowerIsBetter": false, "replicates": [1231.6489800406887, 1450.4995776457122, 1462.3492545817112, 1608.7747715319858, 1793.4888556761325, 6871.622060786654, 7405.740799072034, 7482.027336446268, 7502.17476077631, 7507.887381689279, 7330.486865919388, 7553.8866916996285, 7555.773326800191, 7556.773296801091, 7558.433117516181, 2198.714167158267, 2230.163688616769, 2230.2751605728204, 2232.497688020199, 2234.72065991751, 2211.0934516848097, 2236.541508990653, 2308.4690521180055, 2313.571989181998, 2325.290786310183, 2302.804261637763, 2308.319045881469, 2316.1661801751357, 2318.4783423729696, 2340.356401989458, 2262.694536237603, 2277.1688333758143, 2304.2396009316885, 2304.758000409958, 2304.9423764405856, 2279.985406494111, 2307.7576854430213, 2308.1229132929548, 2309.549637820626, 2310.549442858643, 7595.924040759577, 7668.501547399401, 7685.0, 7692.230776922319, 7707.229277072304, 4633.027064316498, 4715.7642117893965, 4736.123817093814, 4742.217534106868, 4745.525447455261, 2928.209383466452, 2954.290970167166, 3023.712747289004, 3033.5752994580776, 3041.6197975253094, 1069.5775168808354, 1070.6734445993968, 1116.4083035990857, 1116.7040734205443, 1149.367847683779, 10546.789064218749, 10689.679309620724, 10697.679069627924, 10760.623378181726, 10800.135989120772, 4204.180184863983, 4222.767747773902, 4292.7424354538825, 4317.546657600969, 4324.048709283952, 9329.11373419524, 9364.719058428258, 9388.061193880694, 9393.342466027449, 9411.341206115507, 4807.471178170398, 4812.5668689817385, 4812.663113582015, 4814.037192561432, 4824.0, 3758.229562939591, 3805.809709514513, 4086.244044851712, 4375.890602734893, 4380.7152535085115, 3630.128769095398, 3630.673239408466, 3670.8531658733887, 3679.2089700714473, 3679.79761113136, 1145.8166693329194, 1152.6945359479744, 1153.5789436855655, 1156.2311063143084, 1167.6963989362828, 1300.0444673165405, 1304.9934750326377, 1324.0797645636383, 1337.5786627212397, 1337.652210425277, 6991.755288564876, 7060.92939070613, 7173.461990350745, 7175.497715159889, 7182.7486037989465, 481.8891654919388, 486.7566216891554, 495.86859482237236, 496.11443573221624, 496.26304937168277, 5770.711464426762, 5833.854153646108, 5834.67909264986, 5834.766609335664, 5842.59101862874, 8911.287097032222, 9505.477198754135, 9627.56675949584, 9638.855417168748, 9651.613935442503, 9522.571484283224, 9541.61833526665, 9542.761430964281, 9543.618255269712, 9553.808923821623, 7222.855542889218, 7332.0, 7344.816379590553, 7386.372158366599, 7419.740309089156, 7029.753958611424, 7101.964490177723, 7112.822179445555, 7118.60847653384, 7127.2516385778745, 8135.267825895698, 8245.381596380175, 8484.660613575636, 8496.0, 8517.701880434155, 8491.91508084936, 8545.786355340917, 8695.434796738191, 8695.652173912973, 8706.390552661253, 6142.293636231891, 6257.5932564383165, 6261.3112557617715, 6828.897566536407, 6926.44588432914, 6863.313668633096, 7093.751718689821, 7201.387882030086, 7218.566885986857, 7223.3747406833045, 6623.536352455282, 6707.664616769044, 6818.522703410912, 6840.521163518506, 6942.340477654615, 6622.139121914313, 6660.766873159416, 6750.797476075725, 6753.527253092237, 6763.661816909036, 6648.434883034996, 6674.265830758515, 6681.966590167018, 6698.66506674674, 6785.2536221016635, 6134.539909506716, 6156.138140660221, 6185.876282474415, 6195.938040619536, 6205.193324867739, 6107.816765497042, 6141.723622437091, 6145.9692701536205, 6148.385161483816, 6169.876602468015], "unit": "score", "name": "mootools.html", "value": 4363.244309637604}, {"lowerIsBetter": false, "replicates": [341.67711512620576, 349.98775042873507, 351.1327022255029, 354.20834435037705, 356.36211181984265, 5784.56615753818, 5899.3805650406675, 5904.527637788978, 5943.910841337378, 5950.047992321235, 5674.517665998395, 5841.707914604263, 5887.116932460133, 5894.322152952412, 5895.498882594974, 4541.0, 4550.089982003596, 4553.248713962209, 4553.408056952591, 4569.588737013668, 4428.092241090569, 4486.932696009562, 4504.797284122206, 4565.977170114144, 4596.701214421052, 4504.1892459357305, 4515.954840451603, 4520.864374068783, 4530.8867278317975, 4560.749158796265, 4544.113897789933, 4556.6582506312, 4567.13224487348, 4573.085382923396, 4584.243599806061, 4000.7999600020175, 4024.7383920045104, 4030.2141082488924, 4036.2936486114813, 4039.939400908989, 5499.285092937933, 5608.579356548275, 5621.0, 5655.745491452894, 5677.545796336283, 5281.102212623825, 5283.207518872162, 5285.709285989269, 5296.232046353257, 5296.285001524783, 6063.120847477136, 6316.873662526769, 6317.778877739257, 6320.936790632127, 6325.462335701471, 4305.160493703729, 4318.460192475941, 4377.255866502702, 4385.429894113745, 4386.539413361615, 6417.967910160466, 6573.967130164367, 6576.276609572943, 6580.407763301326, 6580.901286480706, 4527.004059106991, 4530.818767249339, 4531.252343363374, 4532.410786597788, 4538.29656403258, 4499.977500112478, 4590.127875703605, 4591.770411479412, 4593.127305811885, 4614.446266448048, 5236.188390799432, 5241.842744717665, 5245.737713114329, 5280.6039547034125, 5289.576833853283, 6302.054691796267, 6338.556301058881, 6342.365763423621, 6345.111684364193, 6350.745970161234, 1601.75973603958, 1619.8299178586078, 1619.9109049002182, 1619.9551289418496, 1622.6105734623604, 1085.4138765066934, 1090.0, 1093.3002878157986, 1111.483160330434, 1116.9385683787307, 5982.551308651781, 5984.192134061933, 5988.221531200916, 5994.07091900756, 6000.939990600038, 6513.478921686348, 6523.967380163069, 6527.5757075789925, 6528.0, 6534.183227096613, 5868.823935281948, 5997.430244126801, 6000.849978750479, 6005.0, 6006.429389208106, 3510.087377281925, 3541.061618671054, 3546.946795798065, 3548.2903419315726, 3551.964480355215, 6736.831579210461, 6742.898856517156, 6745.460363170934, 6749.93250067493, 6755.324467553303, 6676.031975363642, 6685.130932978779, 6685.197776266782, 6695.230048544382, 6696.8995465068065, 6563.212414510289, 6798.014287928321, 6812.863742725217, 6817.897731534031, 6828.419584335387, 6305.747770089145, 6448.9032664511005, 6546.803595892131, 6548.476121910331, 6552.312007239171, 6358.841028974312, 6409.775657851953, 6454.612723236621, 6457.903131453126, 6466.418022378009, 6698.330166983263, 6731.225909020525, 6765.5264131512295, 6775.356341147583, 6782.084418603426, 4577.473590536998, 4601.516840731675, 4639.698419602715, 4651.162790697707, 4659.301104834167, 6460.709268083042, 6473.449756770538, 6475.8990971535895, 6478.125453063776, 6482.254540727877, 6261.624302541862, 6261.624302541862, 6263.498920086291, 6269.122322874892, 6274.372562743689, 6189.6286222826775, 6299.96850015747, 6301.275353334425, 6302.306746257999, 6308.936910630835, 6197.783077592443, 6200.410960958701, 6200.906986395117, 6206.906896396467, 6215.782447614311, 6309.779157729457, 6319.0, 6331.493480521639, 6333.588316759396, 6337.049442583465, 6026.728797204224, 6177.073438984188, 6180.0, 6180.381961803963, 6189.938100618936], "unit": "score", "name": "prototype.html", "value": 4772.706484984975}, {"lowerIsBetter": false, "replicates": [682.8019874236471, 694.84366017646, 739.3900032473209, 741.1661880384565, 743.561298833688, 12503.499860005611, 12587.0, 12882.935585322071, 13066.0, 13076.60770176895, 13034.087613867034, 13113.73772524549, 13137.868621313784, 13150.079494435393, 13178.670533236675, 677.8779819632464, 683.0778449093733, 804.8269622031262, 808.1070417188995, 813.1583810755869, 801.0907619851481, 808.4623725222749, 814.722994181978, 817.9591020448954, 818.0837462042521, 863.9049704532497, 871.4640496094888, 871.9738407847775, 872.0102683454294, 872.5331947408138, 707.8018154916632, 716.5485743981285, 838.534613289624, 857.5155037403847, 858.5578427110044, 627.2285089340137, 628.8616504369031, 628.9025201093838, 628.9748410063592, 629.5876201088295, 13002.219866808022, 13169.539066132735, 13177.341132943315, 13200.0, 13218.933905330412, 11534.711632209179, 11967.1622986391, 12105.394730263451, 12208.084393670422, 12345.69135771604, 10716.303440276357, 10760.838587421194, 10858.457077146111, 10959.726006849813, 11069.612563560317, 3560.537130173087, 3563.8574457021687, 3582.7850328980085, 3608.4767708682357, 3609.62098979606, 44850.32724509102, 45714.31428528575, 45761.31358029632, 45795.54204457946, 45876.54123458756, 9670.419774813534, 10160.949195254125, 10187.949060254652, 10235.539400726986, 10237.283390162765, 18188.272469101088, 18333.90833045853, 18440.26238950427, 18473.0, 18506.907465462587, 7109.938117945738, 7326.487145899736, 7427.740029098955, 7603.771886843404, 7648.885266721004, 3989.7007724420782, 4017.799110044486, 4041.1715598302276, 4108.938365924513, 4111.773852438085, 3125.1405863387295, 3175.380800743879, 3177.6504584495688, 3183.7293830024246, 3185.1718553176343, 540.7215284128677, 558.126531977454, 572.2532095615262, 576.8471355090904, 577.2466930655451, 496.6597880451902, 543.9428859969726, 579.7622974580486, 600.2341409210939, 630.9463695585927, 8352.791180220544, 8634.784130396665, 8902.287816974627, 8981.46111233315, 9193.908060919439, 537.965032272901, 667.5927684112785, 680.7175022365761, 692.7679227458757, 726.3027493606091, 3359.10983589349, 3555.6622120898473, 3782.829772660182, 3917.2557214129224, 3975.662068724133, 53199.73400132974, 53585.73207133939, 54481.727591362585, 57069.714651427304, 57312.71343643338, 46155.0, 46255.0, 46578.767106164254, 46855.0, 47085.52914470811, 48733.26900096501, 49499.752501237264, 49586.50413495891, 50241.748791255806, 50379.74810125999, 8585.313174945864, 8825.91174088251, 8931.106889311017, 8982.056884027083, 9174.862377064215, 35157.82421087878, 35198.0, 35884.0, 36224.0, 36879.44680829736, 42850.0, 42943.7852810734, 43044.35433468563, 44106.77946610247, 44183.77908110439, 11094.889051109709, 11524.711882203012, 11558.768824623628, 11640.417979100841, 11806.645800625995, 12186.086043546593, 12393.318367489876, 12411.565595204125, 12576.371181440709, 12578.0, 10892.836607450736, 11140.164487663296, 11152.16358773079, 11471.311721296748, 11513.597024104116, 11129.63776508649, 11549.076073914235, 11661.941690291495, 11668.533258669897, 11957.0, 11025.61410350634, 11058.557657693602, 11261.099112070851, 11312.0, 11625.0, 9777.608895644094, 10278.383297002203, 10423.0, 10744.570217191538, 10767.6231331903, 9043.18611324984, 9111.908880911371, 9368.578413971523, 9535.38020028696, 9841.26190535727], "unit": "score", "name": "yui.html", "value": 6235.85067921964}], "name": "dromaeo_css", "value": 6841.72103742265}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 107.0, 112.0, 110.0, 111.0, 100.0, 110.0, 111.0, 117.0], "unit": "score", "name": "ai-astar", "value": 109.8}, {"lowerIsBetter": true, "replicates": [152.0, 135.0, 149.0, 163.0, 128.0, 153.0, 152.0, 130.0, 177.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 146.6}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 160.0, 161.0, 163.0, 161.0, 162.0, 165.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 86.0, 92.0, 71.0, 71.0, 73.0, 102.0, 88.0, 71.0], "unit": "score", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 145.0, 95.0, 97.0, 96.0, 138.0, 95.0, 96.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 108.0, 109.0, 109.0, 109.0, 109.0, 110.0, 108.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.9}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 146.0, 144.0, 146.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 56.0, 56.0, 57.0, 57.0, 57.0, 67.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 69.0, 67.0, 67.0, 67.0, 67.0, 75.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 86.0, 86.0, 92.0, 85.0, 84.0, 86.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [118.0, 120.0, 117.0, 115.0, 125.0, 117.0, 122.0, 117.0, 123.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.4}, {"lowerIsBetter": true, "replicates": [143.0, 146.0, 154.0, 152.0, 156.0, 144.0, 166.0, 153.0, 155.0, 163.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.2}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 67.0, 70.0, 68.0, 68.0, 69.0, 69.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1509.9000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.1402306535183], "unit": "score", "name": "Richards", "value": 211.21186599999996}, {"lowerIsBetter": false, "replicates": [192.12295869356387], "unit": "score", "name": "DeltaBlue", "value": 344.1441900000001}, {"lowerIsBetter": false, "replicates": [279.9552071668533], "unit": "score", "name": "Encrypt", "value": 950.7985320000004}, {"lowerIsBetter": false, "replicates": [5284.210526315789], "unit": "score", "name": "Decrypt", "value": 50.37289840637447}, {"lowerIsBetter": false, "replicates": [1960.7843137254902], "unit": "score", "name": "RayTrace", "value": 377.39439}, {"lowerIsBetter": false, "replicates": [809.215844785772], "unit": "score", "name": "Earley", "value": 823.5911398601397}, {"lowerIsBetter": false, "replicates": [12444.444444444445], "unit": "score", "name": "Boyer", "value": 53.555062500000005}, {"lowerIsBetter": false, "replicates": [26394.736842105263], "unit": "score", "name": "RegExp", "value": 34.51388833499503}, {"lowerIsBetter": false, "replicates": [601.6847172081829], "unit": "score", "name": "Splay", "value": 135.43804200000002}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19664.16405155504}]} 17:19:30 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19664.16"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1509.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6841.72"}}} 17:19:30 INFO - Return code: 0 17:19:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:19:30 INFO - # TBPL SUCCESS # 17:19:30 INFO - Running post-action listener: _resource_record_post_action 17:19:30 INFO - Running post-run listener: _resource_record_post_run 17:19:31 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 562204672; Read time: 0; Write time: 664672 17:19:31 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 258920448; Read time: 0; Write time: 385460 17:19:31 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 303284224; Read time: 0; Write time: 279212 17:19:31 INFO - Running post-run listener: _upload_blobber_files 17:19:31 INFO - Blob upload gear active. 17:19:31 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:19:31 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:19:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:19:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:19:32 INFO - (blobuploader) - INFO - Open directory for files ... 17:19:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:19:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:19:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:19:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:19:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:19:33 INFO - (blobuploader) - INFO - Done attempting. 17:19:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:19:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:19:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:19:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:19:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:19:34 INFO - (blobuploader) - INFO - Done attempting. 17:19:34 INFO - (blobuploader) - INFO - Iteration through files over. 17:19:34 INFO - Return code: 0 17:19:34 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:19:34 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:19:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51d626228672bf6b15b46b780b55386b7e01853fbe243e50b808eae3ae9ca6b0fc4914e6ad57de622fa830a3b5befa5e7bd5f5592873583ba08d2e3441d6414f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c860a92f158aacb4cc365dd015c048716654ac7722a1ca60e6d54971b2c7b6433505728c01be7fc1d42ce84023447c8d9d2b5ccffbe92059e35b67dfc2cbd08"} 17:19:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:19:34 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:19:34 INFO - Contents: 17:19:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51d626228672bf6b15b46b780b55386b7e01853fbe243e50b808eae3ae9ca6b0fc4914e6ad57de622fa830a3b5befa5e7bd5f5592873583ba08d2e3441d6414f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c860a92f158aacb4cc365dd015c048716654ac7722a1ca60e6d54971b2c7b6433505728c01be7fc1d42ce84023447c8d9d2b5ccffbe92059e35b67dfc2cbd08"} 17:19:34 INFO - Copying logs to upload dir... 17:19:34 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1267.717750 ========= master_lag: 0.25 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-01-04 17:19:34.302102) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 17:19:34.309536) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/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-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1451955126.892664-789759957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51d626228672bf6b15b46b780b55386b7e01853fbe243e50b808eae3ae9ca6b0fc4914e6ad57de622fa830a3b5befa5e7bd5f5592873583ba08d2e3441d6414f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c860a92f158aacb4cc365dd015c048716654ac7722a1ca60e6d54971b2c7b6433505728c01be7fc1d42ce84023447c8d9d2b5ccffbe92059e35b67dfc2cbd08"} build_url:https://queue.taskcluster.net/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009691 build_url: 'https://queue.taskcluster.net/v1/task/Dy2rdrjxTVqPZaa93RQf9A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51d626228672bf6b15b46b780b55386b7e01853fbe243e50b808eae3ae9ca6b0fc4914e6ad57de622fa830a3b5befa5e7bd5f5592873583ba08d2e3441d6414f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c860a92f158aacb4cc365dd015c048716654ac7722a1ca60e6d54971b2c7b6433505728c01be7fc1d42ce84023447c8d9d2b5ccffbe92059e35b67dfc2cbd08"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 17:19:34.338147) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 17:19:34.338558) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1451955126.892664-789759957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004584 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 17:19:34.392791) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 17:19:34.393166) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 17:19:34.393511) ========= ========= Total master_lag: 0.45 =========