builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-049 starttime: 1452052545.37 results: success (0) buildid: 20160105173012 builduid: dc8be0bedd774e85a49d128dc97e9a95 revision: 42b90df5e0e790b353b3c0dcd14bad80412e02de ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 19:55:45.374548) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 19:55:45.375263) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 19:55:45.375749) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1452052544.748469-648334921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006241 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 19:55:45.400228) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 19:55:45.400564) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 19:55:45.422156) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 19:55:45.422590) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1452052544.748469-648334921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.031418 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 19:55:45.470917) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 19:55:45.471234) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 19:55:45.471600) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 19:55:45.471868) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1452052544.748469-648334921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-05 19:55:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.1M=0s 2016-01-05 19:55:45 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098143 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 19:55:45.583180) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 19:55:45.583547) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1452052544.748469-648334921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.077394 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 19:55:45.672579) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-05 19:55:45.672942) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 42b90df5e0e790b353b3c0dcd14bad80412e02de --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 42b90df5e0e790b353b3c0dcd14bad80412e02de --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=8c719f637fb0c43bc4e5671e000001d0-1452052544.748469-648334921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-05 19:55:45,830 truncating revision to first 12 chars 2016-01-05 19:55:45,830 Setting DEBUG logging. 2016-01-05 19:55:45,830 attempt 1/10 2016-01-05 19:55:45,830 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/42b90df5e0e7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-05 19:55:46,766 unpacking tar archive at: fx-team-42b90df5e0e7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.203970 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-05 19:55:46.889804) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 19:55:46.890133) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 19:55:46.898763) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 19:55:46.899071) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 19:55:46.899494) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-01-05 19:55:46.899799) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=8c719f637fb0c43bc4e5671e000001d0-1452052544.748469-648334921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:55:47 INFO - MultiFileLogger online at 20160105 19:55:47 in /builds/slave/test-pgo 19:55:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:55:47 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:55:47 INFO - {'append_to_log': False, 19:55:47 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:55:47 INFO - 'blob_upload_branch': 'Fx-Team', 19:55:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:55:47 INFO - 'branch': 'Fx-Team', 19:55:47 INFO - 'buildbot_json_path': 'buildprops.json', 19:55:47 INFO - 'config_files': ('talos/linux_config.py',), 19:55:47 INFO - 'default_actions': ('clobber', 19:55:47 INFO - 'read-buildbot-config', 19:55:47 INFO - 'download-and-extract', 19:55:47 INFO - 'populate-webroot', 19:55:47 INFO - 'create-virtualenv', 19:55:47 INFO - 'install', 19:55:47 INFO - 'run-tests'), 19:55:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:55:47 INFO - 'download_minidump_stackwalk': True, 19:55:47 INFO - 'download_symbols': 'ondemand', 19:55:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:55:47 INFO - 'tooltool.py': '/tools/tooltool.py', 19:55:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:55:47 INFO - '/tools/misc-python/virtualenv.py')}, 19:55:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:55:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:55:47 INFO - 'installer_path': 'installer.exe', 19:55:47 INFO - 'log_level': 'info', 19:55:47 INFO - 'log_name': 'talos', 19:55:47 INFO - 'log_to_console': True, 19:55:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:55:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:55:47 INFO - 'opt_config_files': (), 19:55:47 INFO - 'pip_index': False, 19:55:47 INFO - 'sps_profile': False, 19:55:47 INFO - 'sps_profile_interval': 0, 19:55:47 INFO - 'suite': 'dromaeojs-e10s', 19:55:47 INFO - 'system_bits': '32', 19:55:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:55:47 INFO - 'title': 'talos-linux64-ix-049', 19:55:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:55:47 INFO - 'use_talos_json': True, 19:55:47 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:55:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:55:47 INFO - 'work_dir': 'build'} 19:55:47 INFO - ##### 19:55:47 INFO - ##### Running clobber step. 19:55:47 INFO - ##### 19:55:47 INFO - Running pre-action listener: _resource_record_pre_action 19:55:47 INFO - Running main action method: clobber 19:55:47 INFO - rmtree: /builds/slave/test-pgo/build 19:55:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:55:48 INFO - Running post-action listener: _resource_record_post_action 19:55:48 INFO - ##### 19:55:48 INFO - ##### Running read-buildbot-config step. 19:55:48 INFO - ##### 19:55:48 INFO - Running pre-action listener: _resource_record_pre_action 19:55:48 INFO - Running main action method: read_buildbot_config 19:55:48 INFO - Using buildbot properties: 19:55:48 INFO - { 19:55:48 INFO - "project": "", 19:55:48 INFO - "product": "firefox", 19:55:48 INFO - "script_repo_revision": "production", 19:55:48 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:55:48 INFO - "repository": "", 19:55:48 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 19:55:48 INFO - "buildid": "20160105173012", 19:55:48 INFO - "pgo_build": "True", 19:55:48 INFO - "basedir": "/builds/slave/test-pgo", 19:55:48 INFO - "buildnumber": 180, 19:55:48 INFO - "slavename": "talos-linux64-ix-049", 19:55:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:55:48 INFO - "platform": "ubuntu64_hw", 19:55:48 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:55:48 INFO - "branch": "fx-team", 19:55:48 INFO - "repo_path": "integration/fx-team", 19:55:48 INFO - "revision": "42b90df5e0e790b353b3c0dcd14bad80412e02de", 19:55:48 INFO - "stage_platform": "linux64-pgo", 19:55:48 INFO - "builduid": "dc8be0bedd774e85a49d128dc97e9a95", 19:55:48 INFO - "slavebuilddir": "test" 19:55:48 INFO - } 19:55:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:55:48 INFO - Running post-action listener: _resource_record_post_action 19:55:48 INFO - ##### 19:55:48 INFO - ##### Running download-and-extract step. 19:55:48 INFO - ##### 19:55:48 INFO - Running pre-action listener: _resource_record_pre_action 19:55:48 INFO - Running main action method: download_and_extract 19:55:48 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:48 INFO - https://queue.taskcluster.net/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:55:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/test_packages.json 19:55:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/test_packages.json 19:55:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:55:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:55:48 INFO - Downloaded 1302 bytes. 19:55:48 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:55:48 INFO - Using the following test package requirements: 19:55:48 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:55:48 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:55:48 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:48 INFO - u'jsshell-linux-x86_64.zip'], 19:55:48 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:55:48 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:55:48 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:55:48 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:55:48 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:55:48 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:55:48 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:55:48 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:48 INFO - https://queue.taskcluster.net/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:55:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:55:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:55:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/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 19:55:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/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 19:55:49 INFO - Downloaded 24055319 bytes. 19:55:49 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 19:55:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:55:49 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 19:55:51 INFO - Return code: 0 19:55:51 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:51 INFO - https://queue.taskcluster.net/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:55:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:55:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:55:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/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 19:55:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/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 19:55:52 INFO - Downloaded 24055319 bytes. 19:55:52 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 19:55:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:55:52 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 19:55:53 INFO - Return code: 0 19:55:53 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')]} 19:55:53 INFO - https://queue.taskcluster.net/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:55:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:55:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:55:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/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 19:55:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/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 19:55:54 INFO - Downloaded 11132285 bytes. 19:55:54 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 19:55:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:55:54 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 19:55:54 INFO - Return code: 0 19:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:54 INFO - https://queue.taskcluster.net/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:55:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:55:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:55:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/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 19:55:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/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 19:55:57 INFO - Downloaded 55049010 bytes. 19:55:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:55:57 INFO - mkdir: /builds/slave/test-pgo/properties 19:55:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:55:57 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:55:57 INFO - Contents: 19:55:57 INFO - build_url:https://queue.taskcluster.net/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:55:57 INFO - Running post-action listener: _resource_record_post_action 19:55:57 INFO - Running post-action listener: set_extra_try_arguments 19:55:57 INFO - ##### 19:55:57 INFO - ##### Running populate-webroot step. 19:55:57 INFO - ##### 19:55:57 INFO - Running pre-action listener: _resource_record_pre_action 19:55:57 INFO - Running main action method: populate_webroot 19:55:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:55:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:55:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:55:57 INFO - '--tppagecycles', 19:55:57 INFO - '7'], 19:55:57 INFO - 'tests': ['tsvgm']}}, 19:55:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:55:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:55:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:55:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:55:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:55:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:55:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:55:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:57 INFO - 'talos_options': ['--e10s'], 19:55:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:55:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:57 INFO - 'tests': ['damp', 'tps']}, 19:55:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:57 INFO - 'talos_options': ['--e10s'], 19:55:57 INFO - 'tests': ['damp', 'tps']}, 19:55:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:55:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:55:57 INFO - 'other': {'tests': ['a11yr', 19:55:57 INFO - 'ts_paint', 19:55:57 INFO - 'tpaint', 19:55:57 INFO - 'sessionrestore', 19:55:57 INFO - 'sessionrestore_no_auto_restore']}, 19:55:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:55:57 INFO - 'tests': ['a11yr', 19:55:57 INFO - 'ts_paint', 19:55:57 INFO - 'tpaint', 19:55:57 INFO - 'sessionrestore', 19:55:57 INFO - 'sessionrestore_no_auto_restore']}, 19:55:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:55:57 INFO - 'tests': ['a11yr', 19:55:57 INFO - 'ts_paint', 19:55:57 INFO - 'tpaint', 19:55:57 INFO - 'sessionrestore', 19:55:57 INFO - 'sessionrestore_no_auto_restore']}, 19:55:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:55:57 INFO - 'tests': ['a11yr', 19:55:57 INFO - 'ts_paint', 19:55:57 INFO - 'tpaint', 19:55:57 INFO - 'sessionrestore', 19:55:57 INFO - 'sessionrestore_no_auto_restore']}, 19:55:57 INFO - 'other_l64': {'tests': ['a11yr', 19:55:57 INFO - 'ts_paint', 19:55:57 INFO - 'tpaint', 19:55:57 INFO - 'sessionrestore', 19:55:57 INFO - 'sessionrestore_no_auto_restore']}, 19:55:57 INFO - 'other_nol64': {'tests': ['a11yr', 19:55:57 INFO - 'ts_paint', 19:55:57 INFO - 'tpaint', 19:55:57 INFO - 'sessionrestore', 19:55:57 INFO - 'sessionrestore_no_auto_restore']}, 19:55:57 INFO - 'svgr': {'tests': ['tsvgx', 19:55:57 INFO - 'tsvgr_opacity', 19:55:57 INFO - 'tart', 19:55:57 INFO - 'tscrollx', 19:55:57 INFO - 'cart']}, 19:55:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:55:57 INFO - 'tests': ['tsvgx', 19:55:57 INFO - 'tsvgr_opacity', 19:55:57 INFO - 'tart', 19:55:57 INFO - 'tscrollx', 19:55:57 INFO - 'cart']}, 19:55:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:57 INFO - 'tests': ['tp5o']}, 19:55:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:57 INFO - 'talos_options': ['--e10s'], 19:55:57 INFO - 'tests': ['tp5o']}, 19:55:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:57 INFO - 'talos_options': ['--xperf_path', 19:55:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:55:57 INFO - 'tests': ['tp5n']}, 19:55:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:57 INFO - 'talos_options': ['--e10s', 19:55:57 INFO - '--xperf_path', 19:55:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:55:57 INFO - 'tests': ['tp5n']}}, 19:55:57 INFO - 'talos.zip': {'path': '', 19:55:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:55:57 INFO - Running post-action listener: _resource_record_post_action 19:55:57 INFO - ##### 19:55:57 INFO - ##### Running create-virtualenv step. 19:55:57 INFO - ##### 19:55:57 INFO - Running pre-action listener: _resource_record_pre_action 19:55:57 INFO - Running main action method: create_virtualenv 19:55:57 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:55:57 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 19:55:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:55:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:55:57 INFO - Using real prefix '/usr' 19:55:57 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:55:57 INFO - Installing distribute.............................................................................................................................................................................................done. 19:55:59 INFO - Installing pip.................done. 19:55:59 INFO - Return code: 0 19:55:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:55: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')]} 19:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55: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')]} 19:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd07da0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1040630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1840>, '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 0x103e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103eb60>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452052544.748469-648334921', '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 19:55: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 19:55: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 pip>=1.5 19:55:59 INFO - Using env: {'DISPLAY': ':0', 19:55:59 INFO - 'HOME': '/home/cltbld', 19:55:59 INFO - 'LANG': 'en_US.UTF-8', 19:55:59 INFO - 'LANGUAGE': 'en_US:en', 19:55:59 INFO - 'LOGNAME': 'cltbld', 19:55:59 INFO - 'MAIL': '/var/mail/cltbld', 19:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:59 INFO - 'MOZ_NO_REMOTE': '1', 19:55:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:59 INFO - 'NO_EM_RESTART': '1', 19:55:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:55:59 INFO - 'PWD': '/builds/slave/test-pgo', 19:55:59 INFO - 'SHELL': '/bin/bash', 19:55:59 INFO - 'SHLVL': '1', 19:55:59 INFO - 'TERM': 'linux', 19:55:59 INFO - 'TMOUT': '86400', 19:55:59 INFO - 'USER': 'cltbld', 19:55:59 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452052544.748469-648334921', 19:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:59 INFO - '_': '/tools/buildbot/bin/python'} 19:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:00 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 19:56:00 INFO - Cleaning up... 19:56:00 INFO - Return code: 0 19:56:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:56:00 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')]} 19:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:00 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')]} 19:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:00 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 0x7fd07da0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1040630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1840>, '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 0x103e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103eb60>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452052544.748469-648334921', '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 19:56:00 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 19:56:00 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 19:56:00 INFO - Using env: {'DISPLAY': ':0', 19:56:00 INFO - 'HOME': '/home/cltbld', 19:56:00 INFO - 'LANG': 'en_US.UTF-8', 19:56:00 INFO - 'LANGUAGE': 'en_US:en', 19:56:00 INFO - 'LOGNAME': 'cltbld', 19:56:00 INFO - 'MAIL': '/var/mail/cltbld', 19:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:00 INFO - 'MOZ_NO_REMOTE': '1', 19:56:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:00 INFO - 'NO_EM_RESTART': '1', 19:56:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:00 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:00 INFO - 'SHELL': '/bin/bash', 19:56:00 INFO - 'SHLVL': '1', 19:56:00 INFO - 'TERM': 'linux', 19:56:00 INFO - 'TMOUT': '86400', 19:56:00 INFO - 'USER': 'cltbld', 19:56:00 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452052544.748469-648334921', 19:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:00 INFO - '_': '/tools/buildbot/bin/python'} 19:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:00 INFO - Downloading/unpacking psutil>=0.7.1 19:56: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 19:56: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 19:56: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 19:56: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 19:56: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 19:56: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 19:56:01 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:56:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:56:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:56:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:56:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:56:02 INFO - Installing collected packages: psutil 19:56:02 INFO - Running setup.py install for psutil 19:56:02 INFO - building 'psutil._psutil_linux' extension 19:56:02 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 19:56:02 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 19:56:02 INFO - building 'psutil._psutil_posix' extension 19:56:02 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 19:56:02 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 19:56:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:56:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:56:02 INFO - Successfully installed psutil 19:56:02 INFO - Cleaning up... 19:56:02 INFO - Return code: 0 19:56:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:02 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 0x7fd07da0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1040630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1840>, '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 0x103e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103eb60>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452052544.748469-648334921', '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 19:56:02 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 19:56:02 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 19:56:02 INFO - Using env: {'DISPLAY': ':0', 19:56:02 INFO - 'HOME': '/home/cltbld', 19:56:02 INFO - 'LANG': 'en_US.UTF-8', 19:56:02 INFO - 'LANGUAGE': 'en_US:en', 19:56:02 INFO - 'LOGNAME': 'cltbld', 19:56:02 INFO - 'MAIL': '/var/mail/cltbld', 19:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:02 INFO - 'MOZ_NO_REMOTE': '1', 19:56:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:02 INFO - 'NO_EM_RESTART': '1', 19:56:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:02 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:02 INFO - 'SHELL': '/bin/bash', 19:56:02 INFO - 'SHLVL': '1', 19:56:02 INFO - 'TERM': 'linux', 19:56:02 INFO - 'TMOUT': '86400', 19:56:02 INFO - 'USER': 'cltbld', 19:56:02 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452052544.748469-648334921', 19:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:02 INFO - '_': '/tools/buildbot/bin/python'} 19:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:56:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:56:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:56:04 INFO - Installing collected packages: mozsystemmonitor 19:56:04 INFO - Running setup.py install for mozsystemmonitor 19:56:04 INFO - Successfully installed mozsystemmonitor 19:56:04 INFO - Cleaning up... 19:56:04 INFO - Return code: 0 19:56:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:56:04 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')]} 19:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:04 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')]} 19:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:04 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 0x7fd07da0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1040630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1840>, '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 0x103e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103eb60>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452052544.748469-648334921', '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 19:56:04 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 19:56:04 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 19:56:04 INFO - Using env: {'DISPLAY': ':0', 19:56:04 INFO - 'HOME': '/home/cltbld', 19:56:04 INFO - 'LANG': 'en_US.UTF-8', 19:56:04 INFO - 'LANGUAGE': 'en_US:en', 19:56:04 INFO - 'LOGNAME': 'cltbld', 19:56:04 INFO - 'MAIL': '/var/mail/cltbld', 19:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:04 INFO - 'MOZ_NO_REMOTE': '1', 19:56:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:04 INFO - 'NO_EM_RESTART': '1', 19:56:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:04 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:04 INFO - 'SHELL': '/bin/bash', 19:56:04 INFO - 'SHLVL': '1', 19:56:04 INFO - 'TERM': 'linux', 19:56:04 INFO - 'TMOUT': '86400', 19:56:04 INFO - 'USER': 'cltbld', 19:56:04 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452052544.748469-648334921', 19:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:04 INFO - '_': '/tools/buildbot/bin/python'} 19:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:04 INFO - Downloading/unpacking blobuploader==1.2.4 19:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:06 INFO - Downloading blobuploader-1.2.4.tar.gz 19:56:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:56:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:56:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:56:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:56:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:07 INFO - Downloading docopt-0.6.1.tar.gz 19:56:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:56:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:56:07 INFO - Installing collected packages: blobuploader, requests, docopt 19:56:07 INFO - Running setup.py install for blobuploader 19:56:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:56:07 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:56:07 INFO - Running setup.py install for requests 19:56:07 INFO - Running setup.py install for docopt 19:56:07 INFO - Successfully installed blobuploader requests docopt 19:56:07 INFO - Cleaning up... 19:56:07 INFO - Return code: 0 19:56:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:56:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:07 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 0x7fd07da0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1040630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1840>, '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 0x103e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103eb60>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452052544.748469-648334921', '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 19:56:07 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 19:56:07 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 19:56:07 INFO - Using env: {'DISPLAY': ':0', 19:56:07 INFO - 'HOME': '/home/cltbld', 19:56:07 INFO - 'LANG': 'en_US.UTF-8', 19:56:07 INFO - 'LANGUAGE': 'en_US:en', 19:56:07 INFO - 'LOGNAME': 'cltbld', 19:56:07 INFO - 'MAIL': '/var/mail/cltbld', 19:56:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:07 INFO - 'MOZ_NO_REMOTE': '1', 19:56:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:07 INFO - 'NO_EM_RESTART': '1', 19:56:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:07 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:07 INFO - 'SHELL': '/bin/bash', 19:56:07 INFO - 'SHLVL': '1', 19:56:07 INFO - 'TERM': 'linux', 19:56:07 INFO - 'TMOUT': '86400', 19:56:07 INFO - 'USER': 'cltbld', 19:56:07 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452052544.748469-648334921', 19:56:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:07 INFO - '_': '/tools/buildbot/bin/python'} 19:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:56:08 INFO - Running setup.py (path:/tmp/pip-TBKcyU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:56:08 INFO - Running setup.py (path:/tmp/pip-PIGOuC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:56:08 INFO - Running setup.py (path:/tmp/pip-4wL_hK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:56:08 INFO - Running setup.py (path:/tmp/pip-xLFdoE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:56:08 INFO - Running setup.py (path:/tmp/pip-Jprbkw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:56:08 INFO - Running setup.py (path:/tmp/pip-NPA53f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:56:08 INFO - Running setup.py (path:/tmp/pip-KF3k46-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:56:08 INFO - Running setup.py (path:/tmp/pip-h3LxnF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:56:08 INFO - Running setup.py (path:/tmp/pip-_BUlz6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:56:08 INFO - Running setup.py (path:/tmp/pip-N9SsNb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:56:08 INFO - Running setup.py (path:/tmp/pip-gMr8h1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:56:08 INFO - Running setup.py (path:/tmp/pip-w1dsPB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:56:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:56:09 INFO - Running setup.py (path:/tmp/pip-f1b9Gd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:56:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:56:09 INFO - Running setup.py (path:/tmp/pip-lkdEEx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:56:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:56:09 INFO - Running setup.py (path:/tmp/pip-uIF7lj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:56:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:56:09 INFO - Running setup.py (path:/tmp/pip-5xzduM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:56:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:56:09 INFO - Running setup.py (path:/tmp/pip-pwA7pE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:56:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:56:09 INFO - Running setup.py install for manifestparser 19:56:09 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:56:09 INFO - Running setup.py install for mozcrash 19:56:09 INFO - Running setup.py install for mozdebug 19:56:09 INFO - Running setup.py install for mozdevice 19:56:09 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:56:09 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:56:09 INFO - Running setup.py install for mozfile 19:56:09 INFO - Running setup.py install for mozhttpd 19:56:09 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:56:09 INFO - Running setup.py install for mozinfo 19:56:10 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:56:10 INFO - Running setup.py install for mozInstall 19:56:10 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:56:10 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:56:10 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:56:10 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:56:10 INFO - Running setup.py install for mozleak 19:56:10 INFO - Running setup.py install for mozlog 19:56:10 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:56:10 INFO - Running setup.py install for moznetwork 19:56:10 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:56:10 INFO - Running setup.py install for mozprocess 19:56:10 INFO - Running setup.py install for mozprofile 19:56:10 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:56:10 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:56:10 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:56:10 INFO - Running setup.py install for mozrunner 19:56:10 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:56:10 INFO - Running setup.py install for mozscreenshot 19:56:10 INFO - Running setup.py install for moztest 19:56:11 INFO - Running setup.py install for mozversion 19:56:11 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:56:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:56:11 INFO - Cleaning up... 19:56:11 INFO - Return code: 0 19:56:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:56:11 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')]} 19:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:11 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')]} 19:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:11 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 0x7fd07da0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1040630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1840>, '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 0x103e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103eb60>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452052544.748469-648334921', '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 19:56:11 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 19:56:11 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 19:56:11 INFO - Using env: {'DISPLAY': ':0', 19:56:11 INFO - 'HOME': '/home/cltbld', 19:56:11 INFO - 'LANG': 'en_US.UTF-8', 19:56:11 INFO - 'LANGUAGE': 'en_US:en', 19:56:11 INFO - 'LOGNAME': 'cltbld', 19:56:11 INFO - 'MAIL': '/var/mail/cltbld', 19:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:11 INFO - 'MOZ_NO_REMOTE': '1', 19:56:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:11 INFO - 'NO_EM_RESTART': '1', 19:56:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:11 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:11 INFO - 'SHELL': '/bin/bash', 19:56:11 INFO - 'SHLVL': '1', 19:56:11 INFO - 'TERM': 'linux', 19:56:11 INFO - 'TMOUT': '86400', 19:56:11 INFO - 'USER': 'cltbld', 19:56:11 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452052544.748469-648334921', 19:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:11 INFO - '_': '/tools/buildbot/bin/python'} 19:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:56:11 INFO - Running setup.py (path:/tmp/pip-H20x90-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:56:11 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)) 19:56:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:56:11 INFO - Running setup.py (path:/tmp/pip-1IQP7G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:56:11 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)) 19:56:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:56:11 INFO - Running setup.py (path:/tmp/pip-_EHp45-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:56:11 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)) 19:56:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:56:11 INFO - Running setup.py (path:/tmp/pip-bfYLdB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:56:11 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)) 19:56:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:56:11 INFO - Running setup.py (path:/tmp/pip-h6Xn4M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:56:11 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)) 19:56:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:56:11 INFO - Running setup.py (path:/tmp/pip-1exx3Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:56:11 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)) 19:56:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:56:11 INFO - Running setup.py (path:/tmp/pip-Ulog0e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:56:11 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)) 19:56:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:56:11 INFO - Running setup.py (path:/tmp/pip-OuEH2i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:56:11 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)) 19:56:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:56:11 INFO - Running setup.py (path:/tmp/pip-uWi0C7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:56:12 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)) 19:56:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:56:12 INFO - Running setup.py (path:/tmp/pip-Pmo5XG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:56:12 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)) 19:56:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:56:12 INFO - Running setup.py (path:/tmp/pip-IwzP8l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:56:12 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)) 19:56:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:56:12 INFO - Running setup.py (path:/tmp/pip-2FCBpc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:56:12 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)) 19:56:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:56:12 INFO - Running setup.py (path:/tmp/pip-3w2MyQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:56:12 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)) 19:56:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:56:12 INFO - Running setup.py (path:/tmp/pip-w6W6zL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:56:12 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)) 19:56:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:56:12 INFO - Running setup.py (path:/tmp/pip-k6K906-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:56:12 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)) 19:56:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:56:12 INFO - Running setup.py (path:/tmp/pip-E1gKMv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:56:12 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)) 19:56:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:56:12 INFO - Running setup.py (path:/tmp/pip-vIZ7ME-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:56:12 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)) 19:56:12 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)) 19:56:12 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)) 19:56:12 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)) 19:56:12 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)) 19:56:12 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)) 19:56:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:14 INFO - Downloading blessings-1.5.1.tar.gz 19:56:14 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 19:56:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:56:14 INFO - Installing collected packages: blessings 19:56:14 INFO - Running setup.py install for blessings 19:56:14 INFO - Successfully installed blessings 19:56:14 INFO - Cleaning up... 19:56:14 INFO - Return code: 0 19:56:14 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:56:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:56:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:56:14 INFO - Reading from file tmpfile_stdout 19:56:14 INFO - Current package versions: 19:56:14 INFO - argparse == 1.2.1 19:56:14 INFO - blessings == 1.5.1 19:56:14 INFO - blobuploader == 1.2.4 19:56:14 INFO - docopt == 0.6.1 19:56:14 INFO - manifestparser == 1.1 19:56:14 INFO - mozInstall == 1.12 19:56:14 INFO - mozcrash == 0.16 19:56:14 INFO - mozdebug == 0.1 19:56:14 INFO - mozdevice == 0.47 19:56:14 INFO - mozfile == 1.2 19:56:14 INFO - mozhttpd == 0.7 19:56:14 INFO - mozinfo == 0.9 19:56:14 INFO - mozleak == 0.1 19:56:14 INFO - mozlog == 3.1 19:56:14 INFO - moznetwork == 0.27 19:56:14 INFO - mozprocess == 0.22 19:56:14 INFO - mozprofile == 0.28 19:56:14 INFO - mozrunner == 6.11 19:56:14 INFO - mozscreenshot == 0.1 19:56:14 INFO - mozsystemmonitor == 0.0 19:56:14 INFO - moztest == 0.7 19:56:14 INFO - mozversion == 1.4 19:56:14 INFO - psutil == 3.1.1 19:56:14 INFO - requests == 1.2.3 19:56:14 INFO - wsgiref == 0.1.2 19:56:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:14 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 0x7fd07da0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1040630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1840>, '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 0x103e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103eb60>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452052544.748469-648334921', '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 19:56:14 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 19:56:14 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 19:56:14 INFO - Using env: {'DISPLAY': ':0', 19:56:14 INFO - 'HOME': '/home/cltbld', 19:56:14 INFO - 'LANG': 'en_US.UTF-8', 19:56:14 INFO - 'LANGUAGE': 'en_US:en', 19:56:14 INFO - 'LOGNAME': 'cltbld', 19:56:14 INFO - 'MAIL': '/var/mail/cltbld', 19:56:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:14 INFO - 'MOZ_NO_REMOTE': '1', 19:56:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:14 INFO - 'NO_EM_RESTART': '1', 19:56:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:14 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:14 INFO - 'SHELL': '/bin/bash', 19:56:14 INFO - 'SHLVL': '1', 19:56:14 INFO - 'TERM': 'linux', 19:56:14 INFO - 'TMOUT': '86400', 19:56:14 INFO - 'USER': 'cltbld', 19:56:14 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452052544.748469-648334921', 19:56:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:14 INFO - '_': '/tools/buildbot/bin/python'} 19:56:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:14 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)) 19:56:14 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)) 19:56:14 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)) 19:56:14 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)) 19:56:14 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)) 19:56:14 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)) 19:56:14 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)) 19:56:14 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)) 19:56:14 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)) 19:56:14 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)) 19:56:14 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)) 19:56:14 INFO - Cleaning up... 19:56:14 INFO - Return code: 0 19:56:14 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:15 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 0x7fd07da0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1040630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1840>, '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 0x103e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103eb60>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452052544.748469-648334921', '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 19:56:15 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 19:56:15 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 19:56:15 INFO - Using env: {'DISPLAY': ':0', 19:56:15 INFO - 'HOME': '/home/cltbld', 19:56:15 INFO - 'LANG': 'en_US.UTF-8', 19:56:15 INFO - 'LANGUAGE': 'en_US:en', 19:56:15 INFO - 'LOGNAME': 'cltbld', 19:56:15 INFO - 'MAIL': '/var/mail/cltbld', 19:56:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:15 INFO - 'MOZ_NO_REMOTE': '1', 19:56:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:15 INFO - 'NO_EM_RESTART': '1', 19:56:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:15 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:15 INFO - 'SHELL': '/bin/bash', 19:56:15 INFO - 'SHLVL': '1', 19:56:15 INFO - 'TERM': 'linux', 19:56:15 INFO - 'TMOUT': '86400', 19:56:15 INFO - 'USER': 'cltbld', 19:56:15 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452052544.748469-648334921', 19:56:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:15 INFO - '_': '/tools/buildbot/bin/python'} 19:56:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:15 INFO - Downloading/unpacking jsonschema 19:56:15 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 19:56:15 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 19:56:15 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 19:56:15 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 19:56:15 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 19:56:15 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 19:56:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:56:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 19:56:16 INFO - Downloading/unpacking functools32 (from jsonschema) 19:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:17 INFO - Downloading functools32-3.2.3-2.tar.gz 19:56:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:56:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:56:17 INFO - warning: no files found matching '*.txt' 19:56:17 INFO - no previously-included directories found matching 'build' 19:56:17 INFO - no previously-included directories found matching 'dist' 19:56:17 INFO - no previously-included directories found matching '.git*' 19:56:17 INFO - Installing collected packages: jsonschema, functools32 19:56:17 INFO - Running setup.py install for functools32 19:56:17 INFO - warning: no files found matching '*.txt' 19:56:17 INFO - no previously-included directories found matching 'build' 19:56:17 INFO - no previously-included directories found matching 'dist' 19:56:17 INFO - no previously-included directories found matching '.git*' 19:56:17 INFO - Successfully installed jsonschema functools32 19:56:17 INFO - Cleaning up... 19:56:17 INFO - Return code: 0 19:56:17 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:17 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 0x7fd07da0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1040630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1840>, '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 0x103e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103eb60>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452052544.748469-648334921', '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 19:56:17 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 19:56:17 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 19:56:17 INFO - Using env: {'DISPLAY': ':0', 19:56:17 INFO - 'HOME': '/home/cltbld', 19:56:17 INFO - 'LANG': 'en_US.UTF-8', 19:56:17 INFO - 'LANGUAGE': 'en_US:en', 19:56:17 INFO - 'LOGNAME': 'cltbld', 19:56:17 INFO - 'MAIL': '/var/mail/cltbld', 19:56:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:17 INFO - 'MOZ_NO_REMOTE': '1', 19:56:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:17 INFO - 'NO_EM_RESTART': '1', 19:56:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:17 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:17 INFO - 'SHELL': '/bin/bash', 19:56:17 INFO - 'SHLVL': '1', 19:56:17 INFO - 'TERM': 'linux', 19:56:17 INFO - 'TMOUT': '86400', 19:56:17 INFO - 'USER': 'cltbld', 19:56:17 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452052544.748469-648334921', 19:56:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:17 INFO - '_': '/tools/buildbot/bin/python'} 19:56:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:17 INFO - Downloading/unpacking flake8 19:56:17 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 19:56:17 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 19:56:17 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 19:56:17 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 19:56:17 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 19:56:17 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 19:56:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:56:19 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 19:56:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:56:19 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 19:56:19 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 19:56:19 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 19:56:19 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 19:56:19 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 19:56:19 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 19:56:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:56:19 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 19:56:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:56:19 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 19:56:19 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 19:56:19 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 19:56:19 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 19:56:19 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 19:56:19 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 19:56:19 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 19:56:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:56:19 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 19:56:19 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 19:56:19 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 19:56:19 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 19:56:19 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 19:56:19 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 19:56:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:56:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:56:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:56:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:56:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:56:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:56:19 INFO - no previously-included directories found matching 'docs/_build' 19:56:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:56:20 INFO - Running setup.py install for pep8 19:56:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:56:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:56:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:56:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:56:20 INFO - no previously-included directories found matching 'docs/_build' 19:56:20 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:56:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:56:20 INFO - Cleaning up... 19:56:20 INFO - Return code: 0 19:56:20 INFO - Running post-action listener: _resource_record_post_action 19:56:20 INFO - Running post-action listener: _start_resource_monitoring 19:56:20 INFO - Starting resource monitoring. 19:56:20 INFO - ##### 19:56:20 INFO - ##### Running install step. 19:56:20 INFO - ##### 19:56:20 INFO - Running pre-action listener: _resource_record_pre_action 19:56:20 INFO - Running main action method: install 19:56:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:56:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:56:20 INFO - Reading from file tmpfile_stdout 19:56:20 INFO - Detecting whether we're running mozinstall >=1.0... 19:56:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:56:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:56:20 INFO - Reading from file tmpfile_stdout 19:56:20 INFO - Output received: 19:56:20 INFO - Usage: mozinstall [options] installer 19:56:20 INFO - Options: 19:56:20 INFO - -h, --help show this help message and exit 19:56:20 INFO - -d DEST, --destination=DEST 19:56:20 INFO - Directory to install application into. [default: 19:56:20 INFO - "/builds/slave/test-pgo"] 19:56:20 INFO - --app=APP Application being installed. [default: firefox] 19:56:20 INFO - mkdir: /builds/slave/test-pgo/build/application 19:56:20 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'] 19:56:20 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 19:56:36 INFO - Reading from file tmpfile_stdout 19:56:36 INFO - Output received: 19:56:36 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:56:36 INFO - Running post-action listener: _resource_record_post_action 19:56:36 INFO - ##### 19:56:36 INFO - ##### Running run-tests step. 19:56:36 INFO - ##### 19:56:36 INFO - Running pre-action listener: _resource_record_pre_action 19:56:36 INFO - Running main action method: run_tests 19:56:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:56:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:56:36 INFO - Python 2.7.3 19:56:36 INFO - Return code: 0 19:56:36 INFO - grabbing minidump binary from tooltool 19:56:36 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')]} 19:56:36 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 0x10d1840>, '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 0x103e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103eb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:56:36 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 19:56:36 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 19:56:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:56:36 INFO - Return code: 0 19:56:36 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:56:36 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:56:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:56:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:56:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:56:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:56:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:56:37 INFO - Return code: 0 19:56:37 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 19:56:37 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:56:37 INFO - Using env: {'DISPLAY': ':0', 19:56:37 INFO - 'HOME': '/home/cltbld', 19:56:37 INFO - 'LANG': 'en_US.UTF-8', 19:56:37 INFO - 'LANGUAGE': 'en_US:en', 19:56:37 INFO - 'LOGNAME': 'cltbld', 19:56:37 INFO - 'MAIL': '/var/mail/cltbld', 19:56:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:56:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:37 INFO - 'MOZ_NO_REMOTE': '1', 19:56:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:56:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:37 INFO - 'NO_EM_RESTART': '1', 19:56:37 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:37 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:37 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:56:37 INFO - 'SHELL': '/bin/bash', 19:56:37 INFO - 'SHLVL': '1', 19:56:37 INFO - 'TERM': 'linux', 19:56:37 INFO - 'TMOUT': '86400', 19:56:37 INFO - 'USER': 'cltbld', 19:56:37 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452052544.748469-648334921', 19:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:37 INFO - '_': '/tools/buildbot/bin/python'} 19:56:37 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:56:37 INFO - mozversion application_buildid: 20160105173012 19:56:37 INFO - mozversion application_changeset: 42b90df5e0e790b353b3c0dcd14bad80412e02de 19:56:37 INFO - mozversion application_display_name: Nightly 19:56:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:56:37 INFO - mozversion application_name: Firefox 19:56:37 INFO - mozversion application_remotingname: firefox 19:56:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:56:37 INFO - mozversion application_vendor: Mozilla 19:56:37 INFO - mozversion application_version: 46.0a1 19:56:37 INFO - mozversion platform_buildid: 20160105173012 19:56:37 INFO - mozversion platform_changeset: 42b90df5e0e790b353b3c0dcd14bad80412e02de 19:56:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:56:37 INFO - mozversion platform_version: 46.0a1 19:56:37 INFO - using testdate: 1452052597 19:56:37 INFO - actual date: 1452052597 19:56:37 INFO - starting webserver on 'localhost:43227' 19:56:37 INFO - SUITE-START | Running 3 tests 19:56:37 INFO - TEST-START | dromaeo_css 19:56:37 INFO - operating with platform_type : linux_ 19:56:37 INFO - Initialising browser for dromaeo_css test... 19:56:37 INFO - TEST-INFO | started process 26807 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpINBJn8/profile http://localhost:43227/getInfo.html) 19:56:41 INFO - PROCESS | 26807 | __metrics Screen width/height:1600/1200 19:56:41 INFO - PROCESS | 26807 | colorDepth:24 19:56:41 INFO - PROCESS | 26807 | Browser inner width/height: 1024/697 19:56:41 INFO - PROCESS | 26807 | __metrics 19:56:41 INFO - PROCESS | 26807 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:56:42 INFO - TEST-INFO | 26807: exit 0 19:56:42 INFO - Browser initialized. 19:56:42 INFO - Running cycle 1/1 for dromaeo_css test... 19:56:42 INFO - TEST-INFO | started process 26942 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpINBJn8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:56:54 INFO - PROCESS | 26942 | RSS: Main: 150384640 19:56:54 INFO - PROCESS | 26942 | 19:57:44 INFO - PROCESS | 26942 | 1452052664237 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] 19:59:52 INFO - PROCESS | 26942 | Cycle 1(1): loaded http://localhost:43227/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43227/tests/dromaeo/cssquery-ext.html) 19:59:53 INFO - PROCESS | 26942 | RSS: Main: 158146560 19:59:53 INFO - PROCESS | 26942 | 20:02:55 INFO - PROCESS | 26942 | Cycle 1(1): loaded http://localhost:43227/tests/dromaeo/cssquery-ext.html (next: http://localhost:43227/tests/dromaeo/cssquery-jquery.html) 20:02:56 INFO - PROCESS | 26942 | RSS: Main: 153108480 20:02:56 INFO - PROCESS | 26942 | 20:05:58 INFO - PROCESS | 26942 | Cycle 1(1): loaded http://localhost:43227/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43227/tests/dromaeo/cssquery-mootools.html) 20:05:58 INFO - PROCESS | 26942 | RSS: Main: 155131904 20:05:58 INFO - PROCESS | 26942 | 20:09:00 INFO - PROCESS | 26942 | Cycle 1(1): loaded http://localhost:43227/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43227/tests/dromaeo/cssquery-prototype.html) 20:09:00 INFO - PROCESS | 26942 | RSS: Main: 152592384 20:09:00 INFO - PROCESS | 26942 | 20:12:03 INFO - PROCESS | 26942 | Cycle 1(1): loaded http://localhost:43227/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43227/tests/dromaeo/cssquery-yui.html) 20:12:03 INFO - PROCESS | 26942 | RSS: Main: 153419776 20:12:03 INFO - PROCESS | 26942 | 20:15:06 INFO - PROCESS | 26942 | Cycle 1(1): loaded http://localhost:43227/tests/dromaeo/cssquery-yui.html (next: http://localhost:43227/tests/dromaeo/cssquery-dojo.html) 20:15:06 INFO - PROCESS | 26942 | RSS: Main: 154939392 20:15:06 INFO - PROCESS | 26942 | 20:15:06 INFO - PROCESS | 26942 | __start_tp_report 20:15:06 INFO - PROCESS | 26942 | _x_x_mozilla_page_load 20:15:06 INFO - PROCESS | 26942 | _x_x_mozilla_page_load_details 20:15:06 INFO - PROCESS | 26942 | |i|pagename|runs| 20:15:06 INFO - PROCESS | 26942 | |0;dojo.html;3190.872365105396;3249.1227368610475;3249.7075263226307;3254.9023529294113;3291.967080329196;5215.765290561924;5242.659227150232;5274.5780337573;5290.629655924082;5348.46515348465;5248.6063545234065;5270.9458108378285;5295.947040529593;5310.76101575429;5319.494648008433;4799.256115302125;4814.398200224972;4847.757612119398;4911.140550403683;4957.355543779322;4606.907861842761;4885.291632713254;4894.388201474816;4905.533974272438;4998.825041123561;4812.783424745895;4826.34844296019;4905.583025442824;4913.631477639191;4930.506949305077;4893.681910675795;4894.241392584155;4901.852944411673;4922.237053256751;4936.407631084293;4755.35802666639;4902.7058376497525;4902.950970490285;4922.0402021605805;4928.975355123237;5101.336826212606;5114.769835357418;5145.588352931756;5147.510986456318;5163.509466600667;5721.227634269362;5728.140778883159;5736.541076713895;5739.483446489794;5743.569232307552;5706.457886500776;5757.8560535986935;5765.509931655773;5772.826815195551;5777.768889244425;5346.91979620306;5376.516113549799;5419.458054194549;5433.239346491494;5459.890802183934;5813.970930145322;5864.8533786654825;5877.617954832922;5879.617824841372;5894.528437724972;5575.776968921279;5671.546276297886;5684;5688.203651488795;5708.80019199326;5682.289713785777;5766.740496677576;5781;5784.971075144597;5822.7088645567555;5658.830235092953;5665.291838520185;5704.486596206361;5728.455796699307;5735.483806457439;5626.465485778845;5678.630888992285;5717.3996730342715;5759.712014399347;5772.6536407815665;4370.366296886998;4449.911001779947;4466.994926141657;4482.9775851121185;4523.977380113079;4005.559388467266;4005.819738111734;4013.5585085640555;4027.436158937751;4038.919221615551;5266;5350.5987050971335;5402.972985135049;5414.187871819258;5415.864603384868;5716.142578613159;5777.913331300034;5793.565482588822;5809.88380232393;5846.619969701956;5355.892882142335;5371.785128594891;5373.7581808818695;5390.757415916293;5399.622026458111;4789.640776941744;4886.731229782396;4893.755312234374;4936.8765780855765;4976.377952755905;5923.911141332884;5976.641401515923;5994.700264986734;6007;6045.879082418327;5709.058005429058;5722.62802917809;5752.511036561939;5755.079187330174;5755.3381361144;5859.150423188528;5878.617889837147;5926.436988486087;5974.671393073423;6071.119687645179;5576.944230557642;5590.021746194481;5604.327480702342;5605.607607467601;5616.494515493462;5659.717014149193;5676.659400435987;5688.886222275614;5690.77236910519;5711.257536520226;5568;5573.27547418833;5638.971805141112;5643.266375371176;5678.318601767649;5618.129189975561;5619.8876022480135;5648;5650.745716442852;5651.717414129195;5410.729463526729;5495.368032676293;5500.367457742411;5539.8892022158525;5544.63959842609;5523.364813046551;5542.722863856871;5719.799807006735;5721.370649228665;5761.049426844524;5564.165375193753;5569.582281328835;5585.2180694701965;5588.161775733673;5592.692401917933 20:15:06 INFO - PROCESS | 26942 | |1;ext.html;534.9438308977557;544.7167472914085;554.5397320224213;558.7709039293887;577.615885436185;34863.82568087159;35242.2951540969;35501.644983550155;35653.99999999997;35744.2851142977;36086.278274434495;36657;36682;36705;36711;8303.792405189874;8387.119352467995;8482.321414286873;8485.830283394329;8491.108433614474;8102.392320575951;8432.83134337313;8455.788605284855;8483.406161568693;8493.235608795207;8389.664413423456;8537.10360412157;8543.743687689348;8548.31613470924;8554.187352201561;8460.915390846105;8467.66129354825;8491.023532293773;8518.957405212996;8531.146885311482;8379.874301885477;8503.744887653318;8506.82986340276;8539;8545.27365173961;37361.439578406345;37412;37608.435873461916;37799.62200378016;37838.43242351367;2992.2818523554192;2993.043842752906;3048.192229059301;3065.3103051813387;3646.690031347312;28809.42381152365;28838;29566.26084347887;29660.110196694135;30088.398232035455;3342.398368293706;3371.7302615790677;3492.2491664292297;3535.4520049392386;3593.7843729376323;247656;248845;249902;250922;250992.74503627548;51405.742971285654;52796.73601631967;59699.70150149308;60869.39130608726;61467.07799383013;54187;54197;54200.45799542033;54204.457955419944;54319.45680543223;15230.847691523164;15277.923610381877;15406.768898466533;15489.690206195814;15504.379824806882;10675;10692.144628429707;10709.036186743231;10774.030337269684;10798.298110622783;19643.508912277022;20124.29564965219;20141.19435222604;20263.79736202619;20288.695669564968;7248.637568121573;7281.526700764433;7367.226441223702;7456.366208872307;7515.323620874038;934.621478301289;989.9356541824758;1017.1710056304089;1070.7376692710336;1084.219362059316;27797.72202277992;28740.281492962844;29003.12990610285;29134.7086529132;31468.37063258722;1059.0733108530037;1064.0423618743039;1089.596849165798;1109.2567979453786;1194.814803705427;13558.933466234737;13722.245276509688;13723.1079979801;13774.65563360904;13969.580912572435;297862;299389;299671;299922;300135;50895.23657145146;51191;51480.22779658308;51506.48493515092;51612.22581661278;1361.4009835672273;1365.3651052260745;1365.9726805463836;1366.221253885276;1376.9655758606116;26637.733622663527;26663.33341666474;30306.696933030387;30928.79349814601;31434.685653143177;45571.77214113908;46996.7650161747;47035;47118.29322560096;47156.52843471659;202430;202839;203521;204581;205131;28240.71759282381;28373.574396384483;29759.363235022283;30140.24649383783;31964.68035319617;40732;40848;41736.3739543901;42055.7897210512;42373.1525369497;34526;34660;35170.29659406849;35379.82310088433;36326.27347453089;32412.675873240965;32604.510932336507;32865.50701739523;35110.64889351176;36200.637993619726;32020.35959280848;32575.18562035968;32998;33280.500792488616;33327.83336083304;30046.69953300439;31778;32131.51802723008;32213.194670133435;32271;24146;24343.878280608482;24511.877440613396;24711.87644061768;24775.38061548476 20:15:06 INFO - PROCESS | 26942 | |2;jquery.html;351.5640605648994;351.8715668780894;354.5674277381594;355.1972542054955;355.39405313939733;16474.67050658986;16918.91540542297;17588.472345829647;17600.59195264379;18304.908475457636;11228.32630042198;12529.93735031326;16302.592435189126;16399;16438.7534186987;4719.57523822855;4985.850424487253;5023;5038.59691224703;5039.44566097729;4948.455669876311;5006.148954677696;5035.924461133086;5038.697678139323;5042.042012017723;4914.238293064563;5334.626576139672;5338.67967921924;5663.9433605664035;5912.645241285537;4989.376327959005;6064.848378790522;6091.573589848713;6099.329073801879;6134.202553668017;5096.261042148904;5383.623146379755;5440.619156659035;5443.319585051869;5448.536874365684;12391.566295179715;12543.435545400387;12621;14444.783328250085;15012.924935375362;1869.4485126887464;1920.5582715975404;1945.231633504772;1955.071341112974;1969.7143914132514;9386.389884657476;9538.570764315622;9581.808363832753;9674.6323070392;9737.07497787709;1743.7994630617513;1756.350150444331;1781.5546113471632;1842.8894266344062;1919.1459800388832;54985;57696.71151644257;57918.13122803161;58057.54856128588;58118.7094064527;9935.205183585296;10145.797084058277;10161.847572286422;10166.28835981489;10177.287589868638;13134.146280491737;13181.538646147339;13194.868051319556;13200.669983250496;13201.47194112244;7507.662155203029;7539.246075392527;7773.261540153676;7785.610719464004;7936.206379362017;7201.819954501075;7222.927770722225;7227.096612923385;7239.167495737952;7297.233790452032;4321.351797230441;4421.093675796454;4438.60052595268;4443.755593442327;4524.208263553931;1782.1980108951025;1836.8714190006838;1852.323901775869;1855.1744473709339;1861.3485280151838;424.60511724096887;427.7241179439244;431.492995730016;918.807050519385;1045.5608644369383;10422.426766527762;10991.945040274748;11068.612598559012;11124.666260012213;11127.666170014912;904.2043002158059;933.3186773655269;939.9671011514564;963.8265112279857;971.218169373661;9152.359334846496;9381.108794664497;9507.762305942406;9838.458884761407;10351.792964140675;464664;469195;470140;471252;480005;79467;80418;83089;83841.58079209564;84493;1129.4578602270956;1136.1251836086333;1136.7158210447387;1142.7543078238218;1143.0626885953604;15991.92004040019;16067.437639682556;16164.595885102966;16210.756838647665;16343.182840857671;35038;35096.82451587828;35218;35774.8211258942;36074.63925360818;46591.534084660074;46912;47223.52776472191;48287.75856120697;48666.75666621644;8714;9614.326997110134;9642.903570964201;9649.807003860024;9655.855162172433;17273.827261727223;17411.216495258;17749.467515974542;18156.909215454365;18383.63232735311;13701.314934253049;14691.118532887633;14723.926380368459;15064.246787660353;15287.77068343998;13848.792268115785;14001.229932353412;14005.229712365917;14592.343344549308;14748.778768318269;13549.525766598123;14443.566692999228;14512.419503219753;14759.188244646648;14948.925255373653;9233.399829011092;9407.153356197976;9444.622215111318;9544.284178686488;9575.473348965874;13037.15258508194;14108.153510789385;14119.364628591533;14255.144691318554;14432.061915975428 20:15:06 INFO - PROCESS | 26942 | |3;mootools.html;1463.1952426165608;1471.48498025691;1631.7552367144926;1758.6218962922985;1788.454521370982;7468.738594149206;7479.47643664943;7617.047869016373;7628.160902300742;7631.580263085528;7667.84664306715;7711.26742959418;7715.112762032368;7777.988861448004;7795.259450352221;2156.6872803443493;2199.9890000549976;2206.8013878750908;2212.048819007826;2215.2578886073184;2189.8357623178244;2211.4139752965475;2220.555888822242;2222.7110475638146;2223.84433089683;2160.351894431672;2176.9020394082227;2177.8693278403266;2227.922022729205;2278.9886050569726;2138.4012476506605;2165.53441010182;2168.4687251623295;2170.6201414752354;2179.400664817172;2191.9232826851144;2235.6311208650554;2237.3288013595857;2246.2587346175887;2248.6289762189217;7381.409487241008;7404.703811847519;7443.59060251686;7475.962620186864;7477.327040566375;4407.955920440819;4474.306482495186;4504.887377815581;4522.050369422425;4553.180427523044;2936.5154749466315;2957.0833041757123;3011.4278287125594;3038.3619439917643;3045.3756979819086;935.2564711054728;941.3316545252878;954.2842867849113;958.8945216026232;960.5783440508087;10127.493625318704;10322.071013608736;10335;10337.173026157889;10356;3857.3828187489867;3903.2974064668633;4007.8196481158416;4019.7789121598007;4033.757974521538;8292.626831792584;8389.203025712548;8423.663053477914;8440.78898027542;8466.872996905051;4507.2112380333965;4509.323601459807;4509.842155524607;4510.413646225969;4512.4133862597655;4162.959260184954;4175.665946724254;4177.770222637723;4191.958080419217;4204.558521355275;3177.428062948645;3185.5380969759253;3187.569678093474;3206.4228438881223;3207.4226639205167;940.5344354544408;943.9339246252696;956.9234461243223;961.5240455974198;961.6009356117133;1028.8816786069697;1034;1069.6470164845582;1177.6408195500283;1304.8173255744202;6885.862282754317;6944;6951.339622735832;6975.232724400312;6981.5461994970165;993.8857031441332;1007.4912169354576;1131.5134492168447;1136.6987748246722;1143.6168883424145;5694.658320500783;5730.054541000772;5748.02283611787;5761.510271626875;5762.394948530427;9021.50381728998;9110.817783644423;9187;9314.254859611216;9425.528723563795;9023.684171053981;9084.727458176265;9243.445393276425;9259.861102083474;9268.860967085498;6883.827904302332;6936.895946560806;6959.060526828814;6978.825529361705;7046.260142685047;6609.966950165219;6616.371444712745;6646.83382915431;6662.467002639874;6673.432758215412;7757.069151701832;7828.843423131391;8068.273855353046;8073.7577872663915;8148.511089334659;7994.200579941959;8341.83316333682;8608.397412181088;8626.956865215634;8656.091110433566;6681.33186681328;6688.398044176048;6719.664016799238;6886.51794374389;6895.827604309932;7308.707651694085;7310.195878453473;7310.96344518274;7360.926390736024;7392.519486233377;6770.93229067703;6819.420349270169;6834.419074378535;7050.153981522045;7123;6380.87238255223;6477.255115661571;6582.637954912526;6678.933210668026;6786.93213067863;6741.966290168518;6767.763128290486;6787.89818152738;6814.977753336841;6822.11312529368;6302.432781049728;6341.55609107358;6351.174347335002;6398.90401643985;6399.488040956619;6247.843803904939;6291.559590828598;6307.684615769102;6314.368563143649;6346.492280617447 20:15:06 INFO - PROCESS | 26942 | |4;prototype.html;334.585114458072;335.1320080990236;343.6065704768039;346.4577935530894;352.5945163062476;6200.658963756991;6234.875302493947;6284.183056202699;6310.085037669535;6411.807645770635;6220.6578638175;6231.626102433857;6260.686965651722;6266.467350275232;6269.090981807635;4715.481297057329;4717.528247175289;4724.102420540086;4733.242681171013;4741.075490279397;4731.455882573497;4740.146773580754;4743.976280118612;4751.501092385284;4752.453467851189;4522.841700540482;4636.188666983281;4642.837500687477;4670.369500117475;4670.673052886299;4568.497465278817;4593.540645935396;4607.884802879921;4613.400257966477;4643.4660014098135;4053.27041132596;4054.2499637567144;4054.817533210983;4062.878113656595;4064.410660454247;5812.099124635688;5818.709064546756;5825.0679891217205;5826;5827.766889324422;5283.63014588979;5404.972975135139;5424.077906755861;5455;5461.344638643388;6531.118299029617;6578.27638959714;6597;6601.405873471363;6602.547439563336;4471.731696098212;4473.060657261979;4481.596656300949;4483.215437298492;4486.237339652267;6779.254282028973;6845.794626161223;6915.308469153045;6922.826929326757;6927.445804335641;4605.700629459075;4612.262038073892;4617.960958784247;4647.117047760915;4648.721076735339;4671.672982891165;4678.742669153229;4689.695169813951;4691.671582989226;4703.764811759398;5432.592555558349;5449.155380915964;5450.400455949843;5464.808731694372;5478.424765399655;6526.575772574767;6669.032990216391;6669.233038200669;6670.366315200048;6673.466122710269;1649.9340026398809;1670.473800752759;1672.1137796967625;1674.4474323473225;1675.1875340459867;1058.8941105889503;1062.0706881478707;1070.7002039428971;1077.8922107789158;1097.665212110298;6211;6213.782517611862;6214.844628884314;6221.720022598994;6229.470495007885;6689.5986240825705;6690.063391125246;6695.029220762962;6724.697388617524;6740.898886516707;6120.357362476965;6137.294211165684;6166.383361663798;6194.163787888668;6242.843928901723;3698.4267438547067;3726.6459686329754;3744.494493243432;3748.475213470116;3748.5126933499014;7130.180029296594;7172.713091476283;7183.281671832775;7186.604736739425;7224.638768061681;6868.278830722802;7025.297470252934;7033.226345102034;7066.116735407971;7072.8939065914055;7147.6068816214565;7200;7211.495195336276;7234.457415693739;7235.746748863765;6800.93199068003;6826.112605361272;6829.93170068293;6837.042814006142;6843.555168914005;6703.899441508283;6758;6765.188177418741;6788.694508747217;6847.383735463832;7142.142942846684;7183.748568800067;7208.35124838767;7220.927790722236;7223.133224013152;4629.1436084324505;4631.861044168681;4634.46703629087;4645.512221216723;4646.443441447153;6759.391654751096;6896.482763792836;6905.413039891465;6920.273371295942;6928.168619765459;6653.833654158685;6677.966610167113;6691.46468282546;6692.364225398579;6716.429103526255;6656.30108838565;6671;6677.699503522256;6703.396694297537;6713.026611141259;6342.841428964312;6580.1116849226655;6604.339566043357;6608.5374023819795;6613.272540020497;6754.459643228628;6762.391384775394;6775;6780.440498685231;6782.186137663314;6513.3161018094315;6536.052272420377;6593.538452308292;6600.9339906602245;6604.0754294399785 20:15:06 INFO - PROCESS | 26942 | |5;yui.html;797.7606717984605;863.9136086391362;866.3026263857593;869.8651708985105;891.9999999999995;13621.114627549203;13839.238841863718;13853.722925541495;13867.23730194839;13876.236806975612;12805.231686098841;12867.356632168377;12885.935570322159;12908.354582270897;14100.647483812883;835.2816577743137;839.08539691736;843.439112989864;844.4426678392263;845.7040035987386;797.4378063465272;827.3918669777709;827.6647957577161;831.3017065664841;836.8786525953733;856.2165618459103;859.1580251353677;860.9526476043815;861.027039445429;861.9224269815716;854.8546747052985;856.498948115347;857.1642648417774;862.6937437209795;863.3481721300378;619.7737825693634;625.4496043481753;626.357983067355;632.424493710721;632.8576070384173;14007.08953917992;14051.789223161559;14096.224707641075;14108;14125.78811317831;11717.589884354007;11915.344656043913;12165.635030949086;12175.147739658227;12363.443645035995;9722.416655000652;9850.509998357244;10277.126444252248;10351.741206469898;10410.42742649154;3639.490471334015;3645.708343332527;3689.335919534483;3703.9444408333898;3794.7912864792424;43917;44265.55734442647;44267.77866110649;44281.11437771259;44443.555564444265;9669.854585297939;10111.349950604927;10268.58925642966;10282;10441;17984.37054703079;17992.460226193234;18062;18645.81354186441;18664.906675466806;7061.788146355618;7162.104736907887;7195.352418282275;7292.088488938883;7383.520071195462;4005.339119045383;4061.898452538651;4122.319817230184;4229.386738922901;4328.11273688893;2925.414917016605;2976.821390716564;2979.5828583997823;2985.1641540368296;2990.4617168909804;567.6310398241176;568.6048196503391;577.1804038265673;581.2937281203358;592.9614575052608;525.3669328459198;615.9876802464015;671.9899201511884;712.9786106416816;723.6309482164029;8107.351411887035;8163.755087347389;8295.087540370554;8355.874661880076;8377.6230069647;532.9014132385521;586.8298193523916;630.4231628060365;687.8314812870778;692.9965350173217;3408.795472271622;3594.370985077601;3693;3747.6814470769746;3765.0775559987433;50130.24804627933;50308.245376319384;51157.7442112787;55801.44198557962;57766.7111664439;48341;48799.756001219765;49356.50643493591;49500.25749613759;49946.00431965434;43312;43782.781086094365;44027.559724402345;44050;44874;7724.420668449777;7778.222177782177;7993.960030199812;8014.719484818003;8076.676932922617;34751;35371.64628353684;36656.45015324719;37018.44472332971;37612.99999999891;42968.78515607402;43495.130097398505;43647.56352436562;44683;45306.54693453155;10081.395116293046;10767.89232107669;10796.56813727442;10830.67507974762;10921.290116142425;10948.890511094787;11689.574203969229;11889.989350904923;11962.521499139937;12333.876661233631;9702.85445718329;10506.527206275583;10732.409717465302;10807.189460790314;11236.044936180517;10576.41829699374;10647.148228141885;10680.626178084041;11159.72100697489;11756.882431175578;9019.278457723236;9868.649662937149;9886.209103271865;10292.485375731034;10298.588056477656;8405.11329346561;8411.242988131098;8565.95717021411;8604.268637165911;8905.421147625384;8129.496043232021;8361.205685460114;8497.92151480814;8676.436031657922;8896.733098007071 20:15:06 INFO - PROCESS | 26942 | __end_tp_report 20:15:06 INFO - PROCESS | 26942 | __start_cc_report 20:15:06 INFO - PROCESS | 26942 | _x_x_mozilla_cycle_collect,309 20:15:06 INFO - PROCESS | 26942 | __end_cc_report 20:15:06 INFO - PROCESS | 26942 | __startTimestamp1452053706550__endTimestamp 20:15:06 INFO - PROCESS | 26942 | 20:15:06 INFO - PROCESS | 26942 | ------- Summary: start ------- 20:15:06 INFO - PROCESS | 26942 | Number of tests: 6 20:15:06 INFO - PROCESS | 26942 | 20:15:06 INFO - PROCESS | 26942 | [#0] dojo.html Cycles:165 Average:5327.30 Median:5564.17 stddev:582.59 (10.5%) stddev-sans-first:559.75 20:15:06 INFO - PROCESS | 26942 | Values: 3190.9 3249.1 3249.7 3254.9 3292.0 5215.8 5242.7 5274.6 5290.6 5348.5 5248.6 5270.9 5295.9 5310.8 5319.5 4799.3 4814.4 4847.8 4911.1 4957.4 4606.9 4885.3 4894.4 4905.5 4998.8 4812.8 4826.3 4905.6 4913.6 4930.5 4893.7 4894.2 4901.9 4922.2 4936.4 4755.4 4902.7 4903.0 4922.0 4929.0 5101.3 5114.8 5145.6 5147.5 5163.5 5721.2 5728.1 5736.5 5739.5 5743.6 5706.5 5757.9 5765.5 5772.8 5777.8 5346.9 5376.5 5419.5 5433.2 5459.9 5814.0 5864.9 5877.6 5879.6 5894.5 5575.8 5671.5 5684.0 5688.2 5708.8 5682.3 5766.7 5781.0 5785.0 5822.7 5658.8 5665.3 5704.5 5728.5 5735.5 5626.5 5678.6 5717.4 5759.7 5772.7 4370.4 4449.9 4467.0 4483.0 4524.0 4005.6 4005.8 4013.6 4027.4 4038.9 5266.0 5350.6 5403.0 5414.2 5415.9 5716.1 5777.9 5793.6 5809.9 5846.6 5355.9 5371.8 5373.8 5390.8 5399.6 4789.6 4886.7 4893.8 4936.9 4976.4 5923.9 5976.6 5994.7 6007.0 6045.9 5709.1 5722.6 5752.5 5755.1 5755.3 5859.2 5878.6 5926.4 5974.7 6071.1 5576.9 5590.0 5604.3 5605.6 5616.5 5659.7 5676.7 5688.9 5690.8 5711.3 5568.0 5573.3 5639.0 5643.3 5678.3 5618.1 5619.9 5648.0 5650.7 5651.7 5410.7 5495.4 5500.4 5539.9 5544.6 5523.4 5542.7 5719.8 5721.4 5761.0 5564.2 5569.6 5585.2 5588.2 5592.7 20:15:06 INFO - PROCESS | 26942 | 20:15:06 INFO - PROCESS | 26942 | [#1] ext.html Cycles:180 Average:41926.89 Median:3357.06 stddev:66199.78 (1972.0%) stddev-sans-first:66312.53 20:15:06 INFO - PROCESS | 26942 | Values: 534.9 544.7 554.5 558.8 577.6 34863.8 35242.3 35501.6 35654.0 35744.3 36086.3 36657.0 36682.0 36705.0 36711.0 8303.8 8387.1 8482.3 8485.8 8491.1 8102.4 8432.8 8455.8 8483.4 8493.2 8389.7 8537.1 8543.7 8548.3 8554.2 8460.9 8467.7 8491.0 8519.0 8531.1 8379.9 8503.7 8506.8 8539.0 8545.3 37361.4 37412.0 37608.4 37799.6 37838.4 2992.3 2993.0 3048.2 3065.3 3646.7 28809.4 28838.0 29566.3 29660.1 30088.4 3342.4 3371.7 3492.2 3535.5 3593.8 247656.0 248845.0 249902.0 250922.0 250992.7 51405.7 52796.7 59699.7 60869.4 61467.1 54187.0 54197.0 54200.5 54204.5 54319.5 15230.8 15277.9 15406.8 15489.7 15504.4 10675.0 10692.1 10709.0 10774.0 10798.3 19643.5 20124.3 20141.2 20263.8 20288.7 7248.6 7281.5 7367.2 7456.4 7515.3 934.6 989.9 1017.2 1070.7 1084.2 27797.7 28740.3 29003.1 29134.7 31468.4 1059.1 1064.0 1089.6 1109.3 1194.8 13558.9 13722.2 13723.1 13774.7 13969.6 297862.0 299389.0 299671.0 299922.0 300135.0 50895.2 51191.0 51480.2 51506.5 51612.2 1361.4 1365.4 1366.0 1366.2 1377.0 26637.7 26663.3 30306.7 30928.8 31434.7 45571.8 46996.8 47035.0 47118.3 47156.5 202430.0 202839.0 203521.0 204581.0 205131.0 28240.7 28373.6 29759.4 30140.2 31964.7 40732.0 40848.0 41736.4 42055.8 42373.2 34526.0 34660.0 35170.3 35379.8 36326.3 32412.7 32604.5 32865.5 35110.6 36200.6 32020.4 32575.2 32998.0 33280.5 33327.8 30046.7 31778.0 32131.5 32213.2 32271.0 24146.0 24343.9 24511.9 24711.9 24775.4 20:15:06 INFO - PROCESS | 26942 | 20:15:06 INFO - PROCESS | 26942 | [#2] jquery.html Cycles:180 Average:26593.87 Median:18249.62 stddev:77167.43 (422.8%) stddev-sans-first:77358.75 20:15:06 INFO - PROCESS | 26942 | Values: 351.6 351.9 354.6 355.2 355.4 16474.7 16918.9 17588.5 17600.6 18304.9 11228.3 12529.9 16302.6 16399.0 16438.8 4719.6 4985.9 5023.0 5038.6 5039.4 4948.5 5006.1 5035.9 5038.7 5042.0 4914.2 5334.6 5338.7 5663.9 5912.6 4989.4 6064.8 6091.6 6099.3 6134.2 5096.3 5383.6 5440.6 5443.3 5448.5 12391.6 12543.4 12621.0 14444.8 15012.9 1869.4 1920.6 1945.2 1955.1 1969.7 9386.4 9538.6 9581.8 9674.6 9737.1 1743.8 1756.4 1781.6 1842.9 1919.1 54985.0 57696.7 57918.1 58057.5 58118.7 9935.2 10145.8 10161.8 10166.3 10177.3 13134.1 13181.5 13194.9 13200.7 13201.5 7507.7 7539.2 7773.3 7785.6 7936.2 7201.8 7222.9 7227.1 7239.2 7297.2 4321.4 4421.1 4438.6 4443.8 4524.2 1782.2 1836.9 1852.3 1855.2 1861.3 424.6 427.7 431.5 918.8 1045.6 10422.4 10991.9 11068.6 11124.7 11127.7 904.2 933.3 940.0 963.8 971.2 9152.4 9381.1 9507.8 9838.5 10351.8 464664.0 469195.0 470140.0 471252.0 480005.0 79467.0 80418.0 83089.0 83841.6 84493.0 1129.5 1136.1 1136.7 1142.8 1143.1 15991.9 16067.4 16164.6 16210.8 16343.2 35038.0 35096.8 35218.0 35774.8 36074.6 46591.5 46912.0 47223.5 48287.8 48666.8 8714.0 9614.3 9642.9 9649.8 9655.9 17273.8 17411.2 17749.5 18156.9 18383.6 13701.3 14691.1 14723.9 15064.2 15287.8 13848.8 14001.2 14005.2 14592.3 14748.8 13549.5 14443.6 14512.4 14759.2 14948.9 9233.4 9407.2 9444.6 9544.3 9575.5 13037.2 14108.2 14119.4 14255.1 14432.1 20:15:06 INFO - PROCESS | 26942 | 20:15:06 INFO - PROCESS | 26942 | [#3] mootools.html Cycles:180 Average:5268.74 Median:6529.95 stddev:2740.01 (42.0%) stddev-sans-first:2732.76 20:15:06 INFO - PROCESS | 26942 | Values: 1463.2 1471.5 1631.8 1758.6 1788.5 7468.7 7479.5 7617.0 7628.2 7631.6 7667.8 7711.3 7715.1 7778.0 7795.3 2156.7 2200.0 2206.8 2212.0 2215.3 2189.8 2211.4 2220.6 2222.7 2223.8 2160.4 2176.9 2177.9 2227.9 2279.0 2138.4 2165.5 2168.5 2170.6 2179.4 2191.9 2235.6 2237.3 2246.3 2248.6 7381.4 7404.7 7443.6 7476.0 7477.3 4408.0 4474.3 4504.9 4522.1 4553.2 2936.5 2957.1 3011.4 3038.4 3045.4 935.3 941.3 954.3 958.9 960.6 10127.5 10322.1 10335.0 10337.2 10356.0 3857.4 3903.3 4007.8 4019.8 4033.8 8292.6 8389.2 8423.7 8440.8 8466.9 4507.2 4509.3 4509.8 4510.4 4512.4 4163.0 4175.7 4177.8 4192.0 4204.6 3177.4 3185.5 3187.6 3206.4 3207.4 940.5 943.9 956.9 961.5 961.6 1028.9 1034.0 1069.6 1177.6 1304.8 6885.9 6944.0 6951.3 6975.2 6981.5 993.9 1007.5 1131.5 1136.7 1143.6 5694.7 5730.1 5748.0 5761.5 5762.4 9021.5 9110.8 9187.0 9314.3 9425.5 9023.7 9084.7 9243.4 9259.9 9268.9 6883.8 6936.9 6959.1 6978.8 7046.3 6610.0 6616.4 6646.8 6662.5 6673.4 7757.1 7828.8 8068.3 8073.8 8148.5 7994.2 8341.8 8608.4 8627.0 8656.1 6681.3 6688.4 6719.7 6886.5 6895.8 7308.7 7310.2 7311.0 7360.9 7392.5 6770.9 6819.4 6834.4 7050.2 7123.0 6380.9 6477.3 6582.6 6678.9 6786.9 6742.0 6767.8 6787.9 6815.0 6822.1 6302.4 6341.6 6351.2 6398.9 6399.5 6247.8 6291.6 6307.7 6314.4 6346.5 20:15:06 INFO - PROCESS | 26942 | 20:15:06 INFO - PROCESS | 26942 | [#4] prototype.html Cycles:180 Average:5521.34 Median:6230.55 stddev:1696.28 (27.2%) stddev-sans-first:1655.76 20:15:06 INFO - PROCESS | 26942 | Values: 334.6 335.1 343.6 346.5 352.6 6200.7 6234.9 6284.2 6310.1 6411.8 6220.7 6231.6 6260.7 6266.5 6269.1 4715.5 4717.5 4724.1 4733.2 4741.1 4731.5 4740.1 4744.0 4751.5 4752.5 4522.8 4636.2 4642.8 4670.4 4670.7 4568.5 4593.5 4607.9 4613.4 4643.5 4053.3 4054.2 4054.8 4062.9 4064.4 5812.1 5818.7 5825.1 5826.0 5827.8 5283.6 5405.0 5424.1 5455.0 5461.3 6531.1 6578.3 6597.0 6601.4 6602.5 4471.7 4473.1 4481.6 4483.2 4486.2 6779.3 6845.8 6915.3 6922.8 6927.4 4605.7 4612.3 4618.0 4647.1 4648.7 4671.7 4678.7 4689.7 4691.7 4703.8 5432.6 5449.2 5450.4 5464.8 5478.4 6526.6 6669.0 6669.2 6670.4 6673.5 1649.9 1670.5 1672.1 1674.4 1675.2 1058.9 1062.1 1070.7 1077.9 1097.7 6211.0 6213.8 6214.8 6221.7 6229.5 6689.6 6690.1 6695.0 6724.7 6740.9 6120.4 6137.3 6166.4 6194.2 6242.8 3698.4 3726.6 3744.5 3748.5 3748.5 7130.2 7172.7 7183.3 7186.6 7224.6 6868.3 7025.3 7033.2 7066.1 7072.9 7147.6 7200.0 7211.5 7234.5 7235.7 6800.9 6826.1 6829.9 6837.0 6843.6 6703.9 6758.0 6765.2 6788.7 6847.4 7142.1 7183.7 7208.4 7220.9 7223.1 4629.1 4631.9 4634.5 4645.5 4646.4 6759.4 6896.5 6905.4 6920.3 6928.2 6653.8 6678.0 6691.5 6692.4 6716.4 6656.3 6671.0 6677.7 6703.4 6713.0 6342.8 6580.1 6604.3 6608.5 6613.3 6754.5 6762.4 6775.0 6780.4 6782.2 6513.3 6536.1 6593.5 6600.9 6604.1 20:15:06 INFO - PROCESS | 26942 | 20:15:06 INFO - PROCESS | 26942 | [#5] yui.html Cycles:180 Average:13275.89 Median:44778.50 stddev:15193.67 (33.9%) stddev-sans-first:15207.40 20:15:06 INFO - PROCESS | 26942 | Values: 797.8 863.9 866.3 869.9 892.0 13621.1 13839.2 13853.7 13867.2 13876.2 12805.2 12867.4 12885.9 12908.4 14100.6 835.3 839.1 843.4 844.4 845.7 797.4 827.4 827.7 831.3 836.9 856.2 859.2 861.0 861.0 861.9 854.9 856.5 857.2 862.7 863.3 619.8 625.4 626.4 632.4 632.9 14007.1 14051.8 14096.2 14108.0 14125.8 11717.6 11915.3 12165.6 12175.1 12363.4 9722.4 9850.5 10277.1 10351.7 10410.4 3639.5 3645.7 3689.3 3703.9 3794.8 43917.0 44265.6 44267.8 44281.1 44443.6 9669.9 10111.3 10268.6 10282.0 10441.0 17984.4 17992.5 18062.0 18645.8 18664.9 7061.8 7162.1 7195.4 7292.1 7383.5 4005.3 4061.9 4122.3 4229.4 4328.1 2925.4 2976.8 2979.6 2985.2 2990.5 567.6 568.6 577.2 581.3 593.0 525.4 616.0 672.0 713.0 723.6 8107.4 8163.8 8295.1 8355.9 8377.6 532.9 586.8 630.4 687.8 693.0 3408.8 3594.4 3693.0 3747.7 3765.1 50130.2 50308.2 51157.7 55801.4 57766.7 48341.0 48799.8 49356.5 49500.3 49946.0 43312.0 43782.8 44027.6 44050.0 44874.0 7724.4 7778.2 7994.0 8014.7 8076.7 34751.0 35371.6 36656.5 37018.4 37613.0 42968.8 43495.1 43647.6 44683.0 45306.5 10081.4 10767.9 10796.6 10830.7 10921.3 10948.9 11689.6 11890.0 11962.5 12333.9 9702.9 10506.5 10732.4 10807.2 11236.0 10576.4 10647.1 10680.6 11159.7 11756.9 9019.3 9868.6 9886.2 10292.5 10298.6 8405.1 8411.2 8566.0 8604.3 8905.4 8129.5 8361.2 8497.9 8676.4 8896.7 20:15:06 INFO - PROCESS | 26942 | -------- Summary: end -------- 20:15:06 INFO - PROCESS | 26942 | 20:15:07 INFO - TEST-INFO | 26942: exit 0 20:15:07 INFO - TEST-OK | dromaeo_css | took 1109672ms 20:15:07 INFO - TEST-START | kraken 20:15:07 INFO - operating with platform_type : linux_ 20:15:07 INFO - Initialising browser for kraken test... 20:15:07 INFO - TEST-INFO | started process 27183 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsw5VsB/profile http://localhost:43227/getInfo.html) 20:15:11 INFO - PROCESS | 27183 | __metrics Screen width/height:1600/1200 20:15:11 INFO - PROCESS | 27183 | colorDepth:24 20:15:11 INFO - PROCESS | 27183 | Browser inner width/height: 1024/697 20:15:11 INFO - PROCESS | 27183 | __metrics 20:15:11 INFO - PROCESS | 27183 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:15:12 INFO - TEST-INFO | 27183: exit 0 20:15:12 INFO - Browser initialized. 20:15:12 INFO - Running cycle 1/1 for kraken test... 20:15:12 INFO - TEST-INFO | started process 27303 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsw5VsB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:15:24 INFO - PROCESS | 27303 | RSS: Main: 150528000 20:15:24 INFO - PROCESS | 27303 | 20:15:26 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:43227/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43227/tests/kraken/driver.html?testName=audio-beat-detection) 20:15:27 INFO - PROCESS | 27303 | RSS: Main: 151756800 20:15:27 INFO - PROCESS | 27303 | 20:15:29 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:43227/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43227/tests/kraken/driver.html?testName=audio-dft) 20:15:30 INFO - PROCESS | 27303 | RSS: Main: 151748608 20:15:30 INFO - PROCESS | 27303 | 20:15:33 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:43227/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43227/tests/kraken/driver.html?testName=audio-fft) 20:15:33 INFO - PROCESS | 27303 | RSS: Main: 145104896 20:15:33 INFO - PROCESS | 27303 | 20:15:35 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:43227/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43227/tests/kraken/driver.html?testName=audio-oscillator) 20:15:36 INFO - PROCESS | 27303 | RSS: Main: 146776064 20:15:36 INFO - PROCESS | 27303 | 20:15:38 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:43227/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43227/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:15:39 INFO - PROCESS | 27303 | RSS: Main: 146640896 20:15:39 INFO - PROCESS | 27303 | 20:15:42 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:43227/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43227/tests/kraken/driver.html?testName=imaging-darkroom) 20:15:42 INFO - PROCESS | 27303 | RSS: Main: 147673088 20:15:42 INFO - PROCESS | 27303 | 20:15:46 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:43227/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43227/tests/kraken/driver.html?testName=imaging-desaturate) 20:15:46 INFO - PROCESS | 27303 | RSS: Main: 148930560 20:15:46 INFO - PROCESS | 27303 | 20:15:49 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:43227/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43227/tests/kraken/driver.html?testName=json-parse-financial) 20:15:50 INFO - PROCESS | 27303 | RSS: Main: 148877312 20:15:50 INFO - PROCESS | 27303 | 20:15:51 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:43227/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43227/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:15:52 INFO - PROCESS | 27303 | RSS: Main: 148578304 20:15:52 INFO - PROCESS | 27303 | 20:15:54 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:43227/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43227/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:15:54 INFO - PROCESS | 27303 | RSS: Main: 148418560 20:15:54 INFO - PROCESS | 27303 | 20:15:56 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:43227/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43227/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:15:57 INFO - PROCESS | 27303 | RSS: Main: 148762624 20:15:57 INFO - PROCESS | 27303 | 20:16:00 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:43227/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43227/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:16:00 INFO - PROCESS | 27303 | RSS: Main: 148766720 20:16:00 INFO - PROCESS | 27303 | 20:16:03 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:43227/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43227/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:16:03 INFO - PROCESS | 27303 | RSS: Main: 148512768 20:16:03 INFO - PROCESS | 27303 | 20:16:05 INFO - PROCESS | 27303 | Cycle 1(1): loaded http://localhost:43227/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43227/tests/kraken/driver.html?testName=ai-astar) 20:16:05 INFO - PROCESS | 27303 | RSS: Main: 149286912 20:16:05 INFO - PROCESS | 27303 | 20:16:05 INFO - PROCESS | 27303 | __start_tp_report 20:16:05 INFO - PROCESS | 27303 | _x_x_mozilla_page_load 20:16:05 INFO - PROCESS | 27303 | _x_x_mozilla_page_load_details 20:16:05 INFO - PROCESS | 27303 | |i|pagename|runs| 20:16:05 INFO - PROCESS | 27303 | |0;ai-astar;112;108;112;112;111;123;110;112;111;112 20:16:05 INFO - PROCESS | 27303 | |1;audio-beat-detection;152;126;154;164;130;161;144;126;168;127 20:16:05 INFO - PROCESS | 27303 | |2;audio-dft;164;163;162;166;162;161;163;165;166;172 20:16:05 INFO - PROCESS | 27303 | |3;audio-fft;72;73;75;73;72;144;73;76;74;75 20:16:05 INFO - PROCESS | 27303 | |4;audio-oscillator;97;97;152;97;98;96;137;97;96;142 20:16:05 INFO - PROCESS | 27303 | |5;imaging-gaussian-blur;109;109;111;110;109;110;109;110;109;110 20:16:05 INFO - PROCESS | 27303 | |6;imaging-darkroom;146;149;146;147;146;148;149;148;148;146 20:16:05 INFO - PROCESS | 27303 | |7;imaging-desaturate;97;96;97;96;96;96;96;97;97;96 20:16:05 INFO - PROCESS | 27303 | |8;json-parse-financial;63;61;61;62;62;60;60;61;59;60 20:16:05 INFO - PROCESS | 27303 | |9;json-stringify-tinderbox;67;68;67;67;67;67;67;68;68;68 20:16:05 INFO - PROCESS | 27303 | |10;stanford-crypto-aes;86;94;85;87;87;87;88;86;90;85 20:16:05 INFO - PROCESS | 27303 | |11;stanford-crypto-ccm;125;119;118;129;125;143;125;121;126;120 20:16:05 INFO - PROCESS | 27303 | |12;stanford-crypto-pbkdf2;151;160;161;160;161;147;158;159;162;148 20:16:05 INFO - PROCESS | 27303 | |13;stanford-crypto-sha256-iterative;69;70;70;71;69;69;69;73;71;69 20:16:05 INFO - PROCESS | 27303 | __end_tp_report 20:16:05 INFO - PROCESS | 27303 | __start_cc_report 20:16:05 INFO - PROCESS | 27303 | _x_x_mozilla_cycle_collect,716 20:16:05 INFO - PROCESS | 27303 | __end_cc_report 20:16:05 INFO - PROCESS | 27303 | __startTimestamp1452053765850__endTimestamp 20:16:05 INFO - PROCESS | 27303 | 20:16:05 INFO - PROCESS | 27303 | ------- Summary: start ------- 20:16:05 INFO - PROCESS | 27303 | Number of tests: 14 20:16:05 INFO - PROCESS | 27303 | 20:16:05 INFO - PROCESS | 27303 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:3.97 (3.5%) stddev-sans-first:4.21 20:16:05 INFO - PROCESS | 27303 | Values: 112.0 108.0 112.0 112.0 111.0 123.0 110.0 112.0 111.0 112.0 20:16:05 INFO - PROCESS | 27303 | 20:16:05 INFO - PROCESS | 27303 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:153.00 stddev:16.82 (11.0%) stddev-sans-first:17.66 20:16:05 INFO - PROCESS | 27303 | Values: 152.0 126.0 154.0 164.0 130.0 161.0 144.0 126.0 168.0 127.0 20:16:05 INFO - PROCESS | 27303 | 20:16:05 INFO - PROCESS | 27303 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.50 stddev:3.17 (1.9%) stddev-sans-first:3.36 20:16:05 INFO - PROCESS | 27303 | Values: 164.0 163.0 162.0 166.0 162.0 161.0 163.0 165.0 166.0 172.0 20:16:05 INFO - PROCESS | 27303 | 20:16:05 INFO - PROCESS | 27303 | [#3] audio-fft Cycles:10 Average:80.70 Median:73.50 stddev:22.28 (30.3%) stddev-sans-first:23.41 20:16:05 INFO - PROCESS | 27303 | Values: 72.0 73.0 75.0 73.0 72.0 144.0 73.0 76.0 74.0 75.0 20:16:05 INFO - PROCESS | 27303 | 20:16:05 INFO - PROCESS | 27303 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:97.00 stddev:22.90 (23.6%) stddev-sans-first:23.73 20:16:05 INFO - PROCESS | 27303 | Values: 97.0 97.0 152.0 97.0 98.0 96.0 137.0 97.0 96.0 142.0 20:16:05 INFO - PROCESS | 27303 | 20:16:05 INFO - PROCESS | 27303 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 20:16:05 INFO - PROCESS | 27303 | Values: 109.0 109.0 111.0 110.0 109.0 110.0 109.0 110.0 109.0 110.0 20:16:05 INFO - PROCESS | 27303 | 20:16:05 INFO - PROCESS | 27303 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:148.00 stddev:1.25 (0.8%) stddev-sans-first:1.24 20:16:05 INFO - PROCESS | 27303 | Values: 146.0 149.0 146.0 147.0 146.0 148.0 149.0 148.0 148.0 146.0 20:16:05 INFO - PROCESS | 27303 | 20:16:05 INFO - PROCESS | 27303 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 20:16:05 INFO - PROCESS | 27303 | Values: 97.0 96.0 97.0 96.0 96.0 96.0 96.0 97.0 97.0 96.0 20:16:05 INFO - PROCESS | 27303 | 20:16:05 INFO - PROCESS | 27303 | [#8] json-parse-financial Cycles:10 Average:60.90 Median:61.00 stddev:1.20 (2.0%) stddev-sans-first:1.00 20:16:05 INFO - PROCESS | 27303 | Values: 63.0 61.0 61.0 62.0 62.0 60.0 60.0 61.0 59.0 60.0 20:16:05 INFO - PROCESS | 27303 | 20:16:05 INFO - PROCESS | 27303 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 20:16:05 INFO - PROCESS | 27303 | Values: 67.0 68.0 67.0 67.0 67.0 67.0 67.0 68.0 68.0 68.0 20:16:05 INFO - PROCESS | 27303 | 20:16:05 INFO - PROCESS | 27303 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:87.00 stddev:2.72 (3.1%) stddev-sans-first:2.83 20:16:05 INFO - PROCESS | 27303 | Values: 86.0 94.0 85.0 87.0 87.0 87.0 88.0 86.0 90.0 85.0 20:16:05 INFO - PROCESS | 27303 | 20:16:05 INFO - PROCESS | 27303 | [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:125.00 stddev:7.20 (5.8%) stddev-sans-first:7.64 20:16:05 INFO - PROCESS | 27303 | Values: 125.0 119.0 118.0 129.0 125.0 143.0 125.0 121.0 126.0 120.0 20:16:05 INFO - PROCESS | 27303 | 20:16:05 INFO - PROCESS | 27303 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.70 Median:160.00 stddev:5.74 (3.6%) stddev-sans-first:5.70 20:16:05 INFO - PROCESS | 27303 | Values: 151.0 160.0 161.0 160.0 161.0 147.0 158.0 159.0 162.0 148.0 20:16:05 INFO - PROCESS | 27303 | 20:16:05 INFO - PROCESS | 27303 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:1.33 (1.9%) stddev-sans-first:1.36 20:16:05 INFO - PROCESS | 27303 | Values: 69.0 70.0 70.0 71.0 69.0 69.0 69.0 73.0 71.0 69.0 20:16:05 INFO - PROCESS | 27303 | -------- Summary: end -------- 20:16:05 INFO - PROCESS | 27303 | 20:16:06 INFO - TEST-INFO | 27303: exit 0 20:16:06 INFO - TEST-OK | kraken | took 59492ms 20:16:06 INFO - TEST-START | v8_7 20:16:06 INFO - operating with platform_type : linux_ 20:16:06 INFO - Initialising browser for v8_7 test... 20:16:06 INFO - TEST-INFO | started process 27589 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcQAShb/profile http://localhost:43227/getInfo.html) 20:16:11 INFO - PROCESS | 27589 | __metrics Screen width/height:1600/1200 20:16:11 INFO - PROCESS | 27589 | colorDepth:24 20:16:11 INFO - PROCESS | 27589 | Browser inner width/height: 1024/697 20:16:11 INFO - PROCESS | 27589 | __metrics 20:16:11 INFO - PROCESS | 27589 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:16:11 INFO - TEST-INFO | 27589: exit 0 20:16:11 INFO - Browser initialized. 20:16:11 INFO - Running cycle 1/1 for v8_7 test... 20:16:11 INFO - TEST-INFO | started process 27714 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcQAShb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:16:23 INFO - PROCESS | 27714 | RSS: Main: 150904832 20:16:23 INFO - PROCESS | 27714 | 20:16:45 INFO - PROCESS | 27714 | Cycle 1(1): loaded http://localhost:43227/tests/v8_7/run.html (next: http://localhost:43227/tests/v8_7/run.html) 20:16:45 INFO - PROCESS | 27714 | RSS: Main: 145965056 20:16:45 INFO - PROCESS | 27714 | 20:16:45 INFO - PROCESS | 27714 | __start_tp_report 20:16:45 INFO - PROCESS | 27714 | _x_x_mozilla_page_load 20:16:45 INFO - PROCESS | 27714 | _x_x_mozilla_page_load_details 20:16:45 INFO - PROCESS | 27714 | |i|pagename|runs| 20:16:45 INFO - PROCESS | 27714 | |0;Richards;165.56291390728478 20:16:45 INFO - PROCESS | 27714 | |1;DeltaBlue;188.78610534264678 20:16:45 INFO - PROCESS | 27714 | |2;Encrypt;279.6420581655481 20:16:45 INFO - PROCESS | 27714 | |3;Decrypt;5235.602094240838 20:16:45 INFO - PROCESS | 27714 | |4;RayTrace;1075.268817204301 20:16:45 INFO - PROCESS | 27714 | |5;Earley;704.7216349541931 20:16:45 INFO - PROCESS | 27714 | |6;Boyer;12268.292682926829 20:16:45 INFO - PROCESS | 27714 | |7;RegExp;25275 20:16:45 INFO - PROCESS | 27714 | |8;Splay;616.1429451632779 20:16:45 INFO - PROCESS | 27714 | |9;NavierStokes;4826.923076923077 20:16:45 INFO - PROCESS | 27714 | __end_tp_report 20:16:45 INFO - PROCESS | 27714 | __startTimestamp1452053805513__endTimestamp 20:16:45 INFO - PROCESS | 27714 | 20:16:45 INFO - PROCESS | 27714 | ------- Summary: start ------- 20:16:45 INFO - PROCESS | 27714 | Number of tests: 10 20:16:45 INFO - PROCESS | 27714 | 20:16:45 INFO - PROCESS | 27714 | [#0] Richards Cycles:1 Average:165.56 Median:165.56 stddev:0.00 (0.0%) 20:16:45 INFO - PROCESS | 27714 | Values: 165.6 20:16:45 INFO - PROCESS | 27714 | 20:16:45 INFO - PROCESS | 27714 | [#1] DeltaBlue Cycles:1 Average:188.79 Median:188.79 stddev:0.00 (0.0%) 20:16:45 INFO - PROCESS | 27714 | Values: 188.8 20:16:45 INFO - PROCESS | 27714 | 20:16:45 INFO - PROCESS | 27714 | [#2] Encrypt Cycles:1 Average:279.64 Median:279.64 stddev:0.00 (0.0%) 20:16:45 INFO - PROCESS | 27714 | Values: 279.6 20:16:45 INFO - PROCESS | 27714 | 20:16:45 INFO - PROCESS | 27714 | [#3] Decrypt Cycles:1 Average:5235.60 Median:5235.60 stddev:0.00 (0.0%) 20:16:45 INFO - PROCESS | 27714 | Values: 5235.6 20:16:45 INFO - PROCESS | 27714 | 20:16:45 INFO - PROCESS | 27714 | [#4] RayTrace Cycles:1 Average:1075.27 Median:1075.27 stddev:0.00 (0.0%) 20:16:45 INFO - PROCESS | 27714 | Values: 1075.3 20:16:45 INFO - PROCESS | 27714 | 20:16:45 INFO - PROCESS | 27714 | [#5] Earley Cycles:1 Average:704.72 Median:704.72 stddev:0.00 (0.0%) 20:16:45 INFO - PROCESS | 27714 | Values: 704.7 20:16:45 INFO - PROCESS | 27714 | 20:16:45 INFO - PROCESS | 27714 | [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 20:16:45 INFO - PROCESS | 27714 | Values: 12268.3 20:16:45 INFO - PROCESS | 27714 | 20:16:45 INFO - PROCESS | 27714 | [#7] RegExp Cycles:1 Average:25275.00 Median:25275.00 stddev:0.00 (0.0%) 20:16:45 INFO - PROCESS | 27714 | Values: 25275.0 20:16:45 INFO - PROCESS | 27714 | 20:16:45 INFO - PROCESS | 27714 | [#8] Splay Cycles:1 Average:616.14 Median:616.14 stddev:0.00 (0.0%) 20:16:45 INFO - PROCESS | 27714 | Values: 616.1 20:16:45 INFO - PROCESS | 27714 | 20:16:45 INFO - PROCESS | 27714 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 20:16:45 INFO - PROCESS | 27714 | Values: 4826.9 20:16:45 INFO - PROCESS | 27714 | -------- Summary: end -------- 20:16:45 INFO - PROCESS | 27714 | 20:16:46 INFO - TEST-INFO | 27714: exit 0 20:16:46 INFO - TEST-OK | v8_7 | took 39621ms 20:16:46 INFO - SUITE-END | took 1208s 20:16:46 INFO - Completed test suite (00:20:08) 20:16:46 INFO - Working with test: dromaeo_css 20:16:46 INFO - Generating results file: dromaeo_css 20:16:46 INFO - Working with test: kraken 20:16:46 INFO - Generating results file: kraken 20:16:46 INFO - javascript benchmark 20:16:46 INFO - Working with test: v8_7 20:16:46 INFO - Generating results file: v8_7 20:16:46 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:16:46 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 20:16:46 INFO - process_Request line: dromaeo_css 6864.68 graph.html#tests=[[72,64,43]] 20:16:46 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:16:46 INFO - process_Request line: kraken 1534.40 graph.html#tests=[[232,64,43]] 20:16:46 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:16:46 INFO - process_Request line: v8_7 21329.92 graph.html#tests=[[230,64,43]] 20:16:46 INFO - RETURN: dromaeo_css: 6864.68 20:16:46 INFO - RETURN: kraken: 1534.40 20:16:46 INFO - RETURN: v8_7: 21329.92 20:16:46 INFO - javascript benchmark 20:16:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3190.872365105396, 3249.1227368610475, 3249.7075263226307, 3254.9023529294113, 3291.967080329196, 5215.765290561924, 5242.659227150232, 5274.5780337573, 5290.629655924082, 5348.46515348465, 5248.6063545234065, 5270.9458108378285, 5295.947040529593, 5310.76101575429, 5319.494648008433, 4799.256115302125, 4814.398200224972, 4847.757612119398, 4911.140550403683, 4957.355543779322, 4606.907861842761, 4885.291632713254, 4894.388201474816, 4905.533974272438, 4998.825041123561, 4812.783424745895, 4826.34844296019, 4905.583025442824, 4913.631477639191, 4930.506949305077, 4893.681910675795, 4894.241392584155, 4901.852944411673, 4922.237053256751, 4936.407631084293, 4755.35802666639, 4902.7058376497525, 4902.950970490285, 4922.0402021605805, 4928.975355123237, 5101.336826212606, 5114.769835357418, 5145.588352931756, 5147.510986456318, 5163.509466600667, 5721.227634269362, 5728.140778883159, 5736.541076713895, 5739.483446489794, 5743.569232307552, 5706.457886500776, 5757.8560535986935, 5765.509931655773, 5772.826815195551, 5777.768889244425, 5346.91979620306, 5376.516113549799, 5419.458054194549, 5433.239346491494, 5459.890802183934, 5813.970930145322, 5864.8533786654825, 5877.617954832922, 5879.617824841372, 5894.528437724972, 5575.776968921279, 5671.546276297886, 5684.0, 5688.203651488795, 5708.80019199326, 5682.289713785777, 5766.740496677576, 5781.0, 5784.971075144597, 5822.7088645567555, 5658.830235092953, 5665.291838520185, 5704.486596206361, 5728.455796699307, 5735.483806457439, 5626.465485778845, 5678.630888992285, 5717.3996730342715, 5759.712014399347, 5772.6536407815665, 4370.366296886998, 4449.911001779947, 4466.994926141657, 4482.9775851121185, 4523.977380113079, 4005.559388467266, 4005.819738111734, 4013.5585085640555, 4027.436158937751, 4038.919221615551, 5266.0, 5350.5987050971335, 5402.972985135049, 5414.187871819258, 5415.864603384868, 5716.142578613159, 5777.913331300034, 5793.565482588822, 5809.88380232393, 5846.619969701956, 5355.892882142335, 5371.785128594891, 5373.7581808818695, 5390.757415916293, 5399.622026458111, 4789.640776941744, 4886.731229782396, 4893.755312234374, 4936.8765780855765, 4976.377952755905, 5923.911141332884, 5976.641401515923, 5994.700264986734, 6007.0, 6045.879082418327, 5709.058005429058, 5722.62802917809, 5752.511036561939, 5755.079187330174, 5755.3381361144, 5859.150423188528, 5878.617889837147, 5926.436988486087, 5974.671393073423, 6071.119687645179, 5576.944230557642, 5590.021746194481, 5604.327480702342, 5605.607607467601, 5616.494515493462, 5659.717014149193, 5676.659400435987, 5688.886222275614, 5690.77236910519, 5711.257536520226, 5568.0, 5573.27547418833, 5638.971805141112, 5643.266375371176, 5678.318601767649, 5618.129189975561, 5619.8876022480135, 5648.0, 5650.745716442852, 5651.717414129195, 5410.729463526729, 5495.368032676293, 5500.367457742411, 5539.8892022158525, 5544.63959842609, 5523.364813046551, 5542.722863856871, 5719.799807006735, 5721.370649228665, 5761.049426844524, 5564.165375193753, 5569.582281328835, 5585.2180694701965, 5588.161775733673, 5592.692401917933], "unit": "score", "name": "dojo.html", "value": 5290.429593553833}, {"lowerIsBetter": false, "replicates": [534.9438308977557, 544.7167472914085, 554.5397320224213, 558.7709039293887, 577.615885436185, 34863.82568087159, 35242.2951540969, 35501.644983550155, 35653.99999999997, 35744.2851142977, 36086.278274434495, 36657.0, 36682.0, 36705.0, 36711.0, 8303.792405189874, 8387.119352467995, 8482.321414286873, 8485.830283394329, 8491.108433614474, 8102.392320575951, 8432.83134337313, 8455.788605284855, 8483.406161568693, 8493.235608795207, 8389.664413423456, 8537.10360412157, 8543.743687689348, 8548.31613470924, 8554.187352201561, 8460.915390846105, 8467.66129354825, 8491.023532293773, 8518.957405212996, 8531.146885311482, 8379.874301885477, 8503.744887653318, 8506.82986340276, 8539.0, 8545.27365173961, 37361.439578406345, 37412.0, 37608.435873461916, 37799.62200378016, 37838.43242351367, 2992.2818523554192, 2993.043842752906, 3048.192229059301, 3065.3103051813387, 3646.690031347312, 28809.42381152365, 28838.0, 29566.26084347887, 29660.110196694135, 30088.398232035455, 3342.398368293706, 3371.7302615790677, 3492.2491664292297, 3535.4520049392386, 3593.7843729376323, 247656.0, 248845.0, 249902.0, 250922.0, 250992.74503627548, 51405.742971285654, 52796.73601631967, 59699.70150149308, 60869.39130608726, 61467.07799383013, 54187.0, 54197.0, 54200.45799542033, 54204.457955419944, 54319.45680543223, 15230.847691523164, 15277.923610381877, 15406.768898466533, 15489.690206195814, 15504.379824806882, 10675.0, 10692.144628429707, 10709.036186743231, 10774.030337269684, 10798.298110622783, 19643.508912277022, 20124.29564965219, 20141.19435222604, 20263.79736202619, 20288.695669564968, 7248.637568121573, 7281.526700764433, 7367.226441223702, 7456.366208872307, 7515.323620874038, 934.621478301289, 989.9356541824758, 1017.1710056304089, 1070.7376692710336, 1084.219362059316, 27797.72202277992, 28740.281492962844, 29003.12990610285, 29134.7086529132, 31468.37063258722, 1059.0733108530037, 1064.0423618743039, 1089.596849165798, 1109.2567979453786, 1194.814803705427, 13558.933466234737, 13722.245276509688, 13723.1079979801, 13774.65563360904, 13969.580912572435, 297862.0, 299389.0, 299671.0, 299922.0, 300135.0, 50895.23657145146, 51191.0, 51480.22779658308, 51506.48493515092, 51612.22581661278, 1361.4009835672273, 1365.3651052260745, 1365.9726805463836, 1366.221253885276, 1376.9655758606116, 26637.733622663527, 26663.33341666474, 30306.696933030387, 30928.79349814601, 31434.685653143177, 45571.77214113908, 46996.7650161747, 47035.0, 47118.29322560096, 47156.52843471659, 202430.0, 202839.0, 203521.0, 204581.0, 205131.0, 28240.71759282381, 28373.574396384483, 29759.363235022283, 30140.24649383783, 31964.68035319617, 40732.0, 40848.0, 41736.3739543901, 42055.7897210512, 42373.1525369497, 34526.0, 34660.0, 35170.29659406849, 35379.82310088433, 36326.27347453089, 32412.675873240965, 32604.510932336507, 32865.50701739523, 35110.64889351176, 36200.637993619726, 32020.35959280848, 32575.18562035968, 32998.0, 33280.500792488616, 33327.83336083304, 30046.69953300439, 31778.0, 32131.51802723008, 32213.194670133435, 32271.0, 24146.0, 24343.878280608482, 24511.877440613396, 24711.87644061768, 24775.38061548476], "unit": "score", "name": "ext.html", "value": 17613.96946796413}, {"lowerIsBetter": false, "replicates": [351.5640605648994, 351.8715668780894, 354.5674277381594, 355.1972542054955, 355.39405313939733, 16474.67050658986, 16918.91540542297, 17588.472345829647, 17600.59195264379, 18304.908475457636, 11228.32630042198, 12529.93735031326, 16302.592435189126, 16399.0, 16438.7534186987, 4719.57523822855, 4985.850424487253, 5023.0, 5038.59691224703, 5039.44566097729, 4948.455669876311, 5006.148954677696, 5035.924461133086, 5038.697678139323, 5042.042012017723, 4914.238293064563, 5334.626576139672, 5338.67967921924, 5663.9433605664035, 5912.645241285537, 4989.376327959005, 6064.848378790522, 6091.573589848713, 6099.329073801879, 6134.202553668017, 5096.261042148904, 5383.623146379755, 5440.619156659035, 5443.319585051869, 5448.536874365684, 12391.566295179715, 12543.435545400387, 12621.0, 14444.783328250085, 15012.924935375362, 1869.4485126887464, 1920.5582715975404, 1945.231633504772, 1955.071341112974, 1969.7143914132514, 9386.389884657476, 9538.570764315622, 9581.808363832753, 9674.6323070392, 9737.07497787709, 1743.7994630617513, 1756.350150444331, 1781.5546113471632, 1842.8894266344062, 1919.1459800388832, 54985.0, 57696.71151644257, 57918.13122803161, 58057.54856128588, 58118.7094064527, 9935.205183585296, 10145.797084058277, 10161.847572286422, 10166.28835981489, 10177.287589868638, 13134.146280491737, 13181.538646147339, 13194.868051319556, 13200.669983250496, 13201.47194112244, 7507.662155203029, 7539.246075392527, 7773.261540153676, 7785.610719464004, 7936.206379362017, 7201.819954501075, 7222.927770722225, 7227.096612923385, 7239.167495737952, 7297.233790452032, 4321.351797230441, 4421.093675796454, 4438.60052595268, 4443.755593442327, 4524.208263553931, 1782.1980108951025, 1836.8714190006838, 1852.323901775869, 1855.1744473709339, 1861.3485280151838, 424.60511724096887, 427.7241179439244, 431.492995730016, 918.807050519385, 1045.5608644369383, 10422.426766527762, 10991.945040274748, 11068.612598559012, 11124.666260012213, 11127.666170014912, 904.2043002158059, 933.3186773655269, 939.9671011514564, 963.8265112279857, 971.218169373661, 9152.359334846496, 9381.108794664497, 9507.762305942406, 9838.458884761407, 10351.792964140675, 464664.0, 469195.0, 470140.0, 471252.0, 480005.0, 79467.0, 80418.0, 83089.0, 83841.58079209564, 84493.0, 1129.4578602270956, 1136.1251836086333, 1136.7158210447387, 1142.7543078238218, 1143.0626885953604, 15991.92004040019, 16067.437639682556, 16164.595885102966, 16210.756838647665, 16343.182840857671, 35038.0, 35096.82451587828, 35218.0, 35774.8211258942, 36074.63925360818, 46591.534084660074, 46912.0, 47223.52776472191, 48287.75856120697, 48666.75666621644, 8714.0, 9614.326997110134, 9642.903570964201, 9649.807003860024, 9655.855162172433, 17273.827261727223, 17411.216495258, 17749.467515974542, 18156.909215454365, 18383.63232735311, 13701.314934253049, 14691.118532887633, 14723.926380368459, 15064.246787660353, 15287.77068343998, 13848.792268115785, 14001.229932353412, 14005.229712365917, 14592.343344549308, 14748.778768318269, 13549.525766598123, 14443.566692999228, 14512.419503219753, 14759.188244646648, 14948.925255373653, 9233.399829011092, 9407.153356197976, 9444.622215111318, 9544.284178686488, 9575.473348965874, 13037.15258508194, 14108.153510789385, 14119.364628591533, 14255.144691318554, 14432.061915975428], "unit": "score", "name": "jquery.html", "value": 8519.134033345303}, {"lowerIsBetter": false, "replicates": [1463.1952426165608, 1471.48498025691, 1631.7552367144926, 1758.6218962922985, 1788.454521370982, 7468.738594149206, 7479.47643664943, 7617.047869016373, 7628.160902300742, 7631.580263085528, 7667.84664306715, 7711.26742959418, 7715.112762032368, 7777.988861448004, 7795.259450352221, 2156.6872803443493, 2199.9890000549976, 2206.8013878750908, 2212.048819007826, 2215.2578886073184, 2189.8357623178244, 2211.4139752965475, 2220.555888822242, 2222.7110475638146, 2223.84433089683, 2160.351894431672, 2176.9020394082227, 2177.8693278403266, 2227.922022729205, 2278.9886050569726, 2138.4012476506605, 2165.53441010182, 2168.4687251623295, 2170.6201414752354, 2179.400664817172, 2191.9232826851144, 2235.6311208650554, 2237.3288013595857, 2246.2587346175887, 2248.6289762189217, 7381.409487241008, 7404.703811847519, 7443.59060251686, 7475.962620186864, 7477.327040566375, 4407.955920440819, 4474.306482495186, 4504.887377815581, 4522.050369422425, 4553.180427523044, 2936.5154749466315, 2957.0833041757123, 3011.4278287125594, 3038.3619439917643, 3045.3756979819086, 935.2564711054728, 941.3316545252878, 954.2842867849113, 958.8945216026232, 960.5783440508087, 10127.493625318704, 10322.071013608736, 10335.0, 10337.173026157889, 10356.0, 3857.3828187489867, 3903.2974064668633, 4007.8196481158416, 4019.7789121598007, 4033.757974521538, 8292.626831792584, 8389.203025712548, 8423.663053477914, 8440.78898027542, 8466.872996905051, 4507.2112380333965, 4509.323601459807, 4509.842155524607, 4510.413646225969, 4512.4133862597655, 4162.959260184954, 4175.665946724254, 4177.770222637723, 4191.958080419217, 4204.558521355275, 3177.428062948645, 3185.5380969759253, 3187.569678093474, 3206.4228438881223, 3207.4226639205167, 940.5344354544408, 943.9339246252696, 956.9234461243223, 961.5240455974198, 961.6009356117133, 1028.8816786069697, 1034.0, 1069.6470164845582, 1177.6408195500283, 1304.8173255744202, 6885.862282754317, 6944.0, 6951.339622735832, 6975.232724400312, 6981.5461994970165, 993.8857031441332, 1007.4912169354576, 1131.5134492168447, 1136.6987748246722, 1143.6168883424145, 5694.658320500783, 5730.054541000772, 5748.02283611787, 5761.510271626875, 5762.394948530427, 9021.50381728998, 9110.817783644423, 9187.0, 9314.254859611216, 9425.528723563795, 9023.684171053981, 9084.727458176265, 9243.445393276425, 9259.861102083474, 9268.860967085498, 6883.827904302332, 6936.895946560806, 6959.060526828814, 6978.825529361705, 7046.260142685047, 6609.966950165219, 6616.371444712745, 6646.83382915431, 6662.467002639874, 6673.432758215412, 7757.069151701832, 7828.843423131391, 8068.273855353046, 8073.7577872663915, 8148.511089334659, 7994.200579941959, 8341.83316333682, 8608.397412181088, 8626.956865215634, 8656.091110433566, 6681.33186681328, 6688.398044176048, 6719.664016799238, 6886.51794374389, 6895.827604309932, 7308.707651694085, 7310.195878453473, 7310.96344518274, 7360.926390736024, 7392.519486233377, 6770.93229067703, 6819.420349270169, 6834.419074378535, 7050.153981522045, 7123.0, 6380.87238255223, 6477.255115661571, 6582.637954912526, 6678.933210668026, 6786.93213067863, 6741.966290168518, 6767.763128290486, 6787.89818152738, 6814.977753336841, 6822.11312529368, 6302.432781049728, 6341.55609107358, 6351.174347335002, 6398.90401643985, 6399.488040956619, 6247.843803904939, 6291.559590828598, 6307.684615769102, 6314.368563143649, 6346.492280617447], "unit": "score", "name": "mootools.html", "value": 4315.402172211225}, {"lowerIsBetter": false, "replicates": [334.585114458072, 335.1320080990236, 343.6065704768039, 346.4577935530894, 352.5945163062476, 6200.658963756991, 6234.875302493947, 6284.183056202699, 6310.085037669535, 6411.807645770635, 6220.6578638175, 6231.626102433857, 6260.686965651722, 6266.467350275232, 6269.090981807635, 4715.481297057329, 4717.528247175289, 4724.102420540086, 4733.242681171013, 4741.075490279397, 4731.455882573497, 4740.146773580754, 4743.976280118612, 4751.501092385284, 4752.453467851189, 4522.841700540482, 4636.188666983281, 4642.837500687477, 4670.369500117475, 4670.673052886299, 4568.497465278817, 4593.540645935396, 4607.884802879921, 4613.400257966477, 4643.4660014098135, 4053.27041132596, 4054.2499637567144, 4054.817533210983, 4062.878113656595, 4064.410660454247, 5812.099124635688, 5818.709064546756, 5825.0679891217205, 5826.0, 5827.766889324422, 5283.63014588979, 5404.972975135139, 5424.077906755861, 5455.0, 5461.344638643388, 6531.118299029617, 6578.27638959714, 6597.0, 6601.405873471363, 6602.547439563336, 4471.731696098212, 4473.060657261979, 4481.596656300949, 4483.215437298492, 4486.237339652267, 6779.254282028973, 6845.794626161223, 6915.308469153045, 6922.826929326757, 6927.445804335641, 4605.700629459075, 4612.262038073892, 4617.960958784247, 4647.117047760915, 4648.721076735339, 4671.672982891165, 4678.742669153229, 4689.695169813951, 4691.671582989226, 4703.764811759398, 5432.592555558349, 5449.155380915964, 5450.400455949843, 5464.808731694372, 5478.424765399655, 6526.575772574767, 6669.032990216391, 6669.233038200669, 6670.366315200048, 6673.466122710269, 1649.9340026398809, 1670.473800752759, 1672.1137796967625, 1674.4474323473225, 1675.1875340459867, 1058.8941105889503, 1062.0706881478707, 1070.7002039428971, 1077.8922107789158, 1097.665212110298, 6211.0, 6213.782517611862, 6214.844628884314, 6221.720022598994, 6229.470495007885, 6689.5986240825705, 6690.063391125246, 6695.029220762962, 6724.697388617524, 6740.898886516707, 6120.357362476965, 6137.294211165684, 6166.383361663798, 6194.163787888668, 6242.843928901723, 3698.4267438547067, 3726.6459686329754, 3744.494493243432, 3748.475213470116, 3748.5126933499014, 7130.180029296594, 7172.713091476283, 7183.281671832775, 7186.604736739425, 7224.638768061681, 6868.278830722802, 7025.297470252934, 7033.226345102034, 7066.116735407971, 7072.8939065914055, 7147.6068816214565, 7200.0, 7211.495195336276, 7234.457415693739, 7235.746748863765, 6800.93199068003, 6826.112605361272, 6829.93170068293, 6837.042814006142, 6843.555168914005, 6703.899441508283, 6758.0, 6765.188177418741, 6788.694508747217, 6847.383735463832, 7142.142942846684, 7183.748568800067, 7208.35124838767, 7220.927790722236, 7223.133224013152, 4629.1436084324505, 4631.861044168681, 4634.46703629087, 4645.512221216723, 4646.443441447153, 6759.391654751096, 6896.482763792836, 6905.413039891465, 6920.273371295942, 6928.168619765459, 6653.833654158685, 6677.966610167113, 6691.46468282546, 6692.364225398579, 6716.429103526255, 6656.30108838565, 6671.0, 6677.699503522256, 6703.396694297537, 6713.026611141259, 6342.841428964312, 6580.1116849226655, 6604.339566043357, 6608.5374023819795, 6613.272540020497, 6754.459643228628, 6762.391384775394, 6775.0, 6780.440498685231, 6782.186137663314, 6513.3161018094315, 6536.052272420377, 6593.538452308292, 6600.9339906602245, 6604.0754294399785], "unit": "score", "name": "prototype.html", "value": 4965.442485028407}, {"lowerIsBetter": false, "replicates": [797.7606717984605, 863.9136086391362, 866.3026263857593, 869.8651708985105, 891.9999999999995, 13621.114627549203, 13839.238841863718, 13853.722925541495, 13867.23730194839, 13876.236806975612, 12805.231686098841, 12867.356632168377, 12885.935570322159, 12908.354582270897, 14100.647483812883, 835.2816577743137, 839.08539691736, 843.439112989864, 844.4426678392263, 845.7040035987386, 797.4378063465272, 827.3918669777709, 827.6647957577161, 831.3017065664841, 836.8786525953733, 856.2165618459103, 859.1580251353677, 860.9526476043815, 861.027039445429, 861.9224269815716, 854.8546747052985, 856.498948115347, 857.1642648417774, 862.6937437209795, 863.3481721300378, 619.7737825693634, 625.4496043481753, 626.357983067355, 632.424493710721, 632.8576070384173, 14007.08953917992, 14051.789223161559, 14096.224707641075, 14108.0, 14125.78811317831, 11717.589884354007, 11915.344656043913, 12165.635030949086, 12175.147739658227, 12363.443645035995, 9722.416655000652, 9850.509998357244, 10277.126444252248, 10351.741206469898, 10410.42742649154, 3639.490471334015, 3645.708343332527, 3689.335919534483, 3703.9444408333898, 3794.7912864792424, 43917.0, 44265.55734442647, 44267.77866110649, 44281.11437771259, 44443.555564444265, 9669.854585297939, 10111.349950604927, 10268.58925642966, 10282.0, 10441.0, 17984.37054703079, 17992.460226193234, 18062.0, 18645.81354186441, 18664.906675466806, 7061.788146355618, 7162.104736907887, 7195.352418282275, 7292.088488938883, 7383.520071195462, 4005.339119045383, 4061.898452538651, 4122.319817230184, 4229.386738922901, 4328.11273688893, 2925.414917016605, 2976.821390716564, 2979.5828583997823, 2985.1641540368296, 2990.4617168909804, 567.6310398241176, 568.6048196503391, 577.1804038265673, 581.2937281203358, 592.9614575052608, 525.3669328459198, 615.9876802464015, 671.9899201511884, 712.9786106416816, 723.6309482164029, 8107.351411887035, 8163.755087347389, 8295.087540370554, 8355.874661880076, 8377.6230069647, 532.9014132385521, 586.8298193523916, 630.4231628060365, 687.8314812870778, 692.9965350173217, 3408.795472271622, 3594.370985077601, 3693.0, 3747.6814470769746, 3765.0775559987433, 50130.24804627933, 50308.245376319384, 51157.7442112787, 55801.44198557962, 57766.7111664439, 48341.0, 48799.756001219765, 49356.50643493591, 49500.25749613759, 49946.00431965434, 43312.0, 43782.781086094365, 44027.559724402345, 44050.0, 44874.0, 7724.420668449777, 7778.222177782177, 7993.960030199812, 8014.719484818003, 8076.676932922617, 34751.0, 35371.64628353684, 36656.45015324719, 37018.44472332971, 37612.99999999891, 42968.78515607402, 43495.130097398505, 43647.56352436562, 44683.0, 45306.54693453155, 10081.395116293046, 10767.89232107669, 10796.56813727442, 10830.67507974762, 10921.290116142425, 10948.890511094787, 11689.574203969229, 11889.989350904923, 11962.521499139937, 12333.876661233631, 9702.85445718329, 10506.527206275583, 10732.409717465302, 10807.189460790314, 11236.044936180517, 10576.41829699374, 10647.148228141885, 10680.626178084041, 11159.72100697489, 11756.882431175578, 9019.278457723236, 9868.649662937149, 9886.209103271865, 10292.485375731034, 10298.588056477656, 8405.11329346561, 8411.242988131098, 8565.95717021411, 8604.268637165911, 8905.421147625384, 8129.496043232021, 8361.205685460114, 8497.92151480814, 8676.436031657922, 8896.733098007071], "unit": "score", "name": "yui.html", "value": 6151.259688968751}], "name": "dromaeo_css", "value": 6864.685188197501}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 112.0, 112.0, 111.0, 123.0, 110.0, 112.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [152.0, 126.0, 154.0, 164.0, 130.0, 161.0, 144.0, 126.0, 168.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.2}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 162.0, 166.0, 162.0, 161.0, 163.0, 165.0, 166.0, 172.0], "unit": "score", "name": "audio-dft", "value": 164.4}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 75.0, 73.0, 72.0, 144.0, 73.0, 76.0, 74.0, 75.0], "unit": "score", "name": "audio-fft", "value": 80.7}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 152.0, 97.0, 98.0, 96.0, 137.0, 97.0, 96.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 110.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 111.0, 110.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 149.0, 146.0, 147.0, 146.0, 148.0, 149.0, 148.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [63.0, 61.0, 61.0, 62.0, 62.0, 60.0, 60.0, 61.0, 59.0, 60.0], "unit": "score", "name": "json-parse-financial", "value": 60.9}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [86.0, 94.0, 85.0, 87.0, 87.0, 87.0, 88.0, 86.0, 90.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.5}, {"lowerIsBetter": true, "replicates": [125.0, 119.0, 118.0, 129.0, 125.0, 143.0, 125.0, 121.0, 126.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.1}, {"lowerIsBetter": true, "replicates": [151.0, 160.0, 161.0, 160.0, 161.0, 147.0, 158.0, 159.0, 162.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 156.7}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 71.0, 69.0, 69.0, 69.0, 73.0, 71.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1534.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.56291390728478], "unit": "score", "name": "Richards", "value": 213.2240799999999}, {"lowerIsBetter": false, "replicates": [188.78610534264678], "unit": "score", "name": "DeltaBlue", "value": 350.22704600000003}, {"lowerIsBetter": false, "replicates": [279.6420581655481], "unit": "score", "name": "Encrypt", "value": 951.8632560000003}, {"lowerIsBetter": false, "replicates": [5235.602094240838], "unit": "score", "name": "Decrypt", "value": 50.84057100000005}, {"lowerIsBetter": false, "replicates": [1075.268817204301], "unit": "score", "name": "RayTrace", "value": 688.1897699999998}, {"lowerIsBetter": false, "replicates": [704.7216349541931], "unit": "score", "name": "Earley", "value": 945.7109970000002}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [25275.0], "unit": "score", "name": "RegExp", "value": 36.042927794263136}, {"lowerIsBetter": false, "replicates": [616.1429451632779], "unit": "score", "name": "Splay", "value": 132.25989299999998}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 21329.9184507442}]} 20:16:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21329.92"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1534.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6864.68"}}} 20:16:46 INFO - Return code: 0 20:16:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:16:46 INFO - # TBPL SUCCESS # 20:16:46 INFO - Running post-action listener: _resource_record_post_action 20:16:46 INFO - Running post-run listener: _resource_record_post_run 20:16:47 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 8192; Write bytes: 559550464; Read time: 12; Write time: 549192 20:16:47 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 238059520; Read time: 0; Write time: 332792 20:16:47 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 8192; Write bytes: 320626688; Read time: 12; Write time: 216344 20:16:47 INFO - Running post-run listener: _upload_blobber_files 20:16:47 INFO - Blob upload gear active. 20:16:47 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:16:47 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 20:16:47 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'] 20:16:47 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 20:16:48 INFO - (blobuploader) - INFO - Open directory for files ... 20:16:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:16:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:16:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:16:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:16:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:16:49 INFO - (blobuploader) - INFO - Done attempting. 20:16:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:16:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:16:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:16:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:16:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:16:49 INFO - (blobuploader) - INFO - Done attempting. 20:16:49 INFO - (blobuploader) - INFO - Iteration through files over. 20:16:49 INFO - Return code: 0 20:16:49 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:16:49 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:16:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57bb87a0f6c4d7011873f64498804fc905b2f2728fd34b9a9d1ddd365e73508b098607f9146524698090106510d1b35e4c2493f5d40eade6a3910d0e89efadff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f8e46b8c00b9432486bf15da769c0e7f5cd0f7ba9eaead13e8fdfa789bb938eb287dce2af72acac7fee48041b94cb8e8cbfc254176dbdc73cdab71b609ed886c"} 20:16:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:16:49 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:16:49 INFO - Contents: 20:16:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57bb87a0f6c4d7011873f64498804fc905b2f2728fd34b9a9d1ddd365e73508b098607f9146524698090106510d1b35e4c2493f5d40eade6a3910d0e89efadff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f8e46b8c00b9432486bf15da769c0e7f5cd0f7ba9eaead13e8fdfa789bb938eb287dce2af72acac7fee48041b94cb8e8cbfc254176dbdc73cdab71b609ed886c"} 20:16:49 INFO - Copying logs to upload dir... 20:16:49 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1262.898204 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-01-05 20:16:49.826908) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 20:16:49.831127) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1452052544.748469-648334921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57bb87a0f6c4d7011873f64498804fc905b2f2728fd34b9a9d1ddd365e73508b098607f9146524698090106510d1b35e4c2493f5d40eade6a3910d0e89efadff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f8e46b8c00b9432486bf15da769c0e7f5cd0f7ba9eaead13e8fdfa789bb938eb287dce2af72acac7fee48041b94cb8e8cbfc254176dbdc73cdab71b609ed886c"} build_url:https://queue.taskcluster.net/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011473 build_url: 'https://queue.taskcluster.net/v1/task/GXqFjeL8SaGvJwZjLAwbRQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57bb87a0f6c4d7011873f64498804fc905b2f2728fd34b9a9d1ddd365e73508b098607f9146524698090106510d1b35e4c2493f5d40eade6a3910d0e89efadff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f8e46b8c00b9432486bf15da769c0e7f5cd0f7ba9eaead13e8fdfa789bb938eb287dce2af72acac7fee48041b94cb8e8cbfc254176dbdc73cdab71b609ed886c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 20:16:49.863111) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 20:16:49.863728) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1452052544.748469-648334921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004562 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 20:16:49.948095) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 20:16:49.948655) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 20:16:49.949880) ========= ========= Total master_lag: 0.20 =========