builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-039 starttime: 1451361390.09 results: success (0) buildid: 20151228173003 builduid: efba87556bbe47baa47c10d9b93e8f2e revision: 36634a31d101cab18c462d46fca07a14fdd519a1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-28 19:56:30.088223) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-28 19:56:30.088686) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-28 19:56:30.088972) ========= 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=6e558709db315bacd2260379000001b6-1451356216.117616-944872298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006319 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-28 19:56:30.112006) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-28 19:56:30.112323) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-28 19:56:30.125349) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 19:56:30.125665) ========= 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=6e558709db315bacd2260379000001b6-1451356216.117616-944872298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004641 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 19:56:30.175338) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-28 19:56:30.175728) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-28 19:56:30.176116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 19:56:30.176517) ========= 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=6e558709db315bacd2260379000001b6-1451356216.117616-944872298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-28 19:56:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.5M=0s 2015-12-28 19:56:31 (42.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156069 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 19:56:30.345018) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 19:56:30.345328) ========= 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=6e558709db315bacd2260379000001b6-1451356216.117616-944872298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019475 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 19:56:30.394811) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 19:56:30.395128) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 36634a31d101cab18c462d46fca07a14fdd519a1 --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 36634a31d101cab18c462d46fca07a14fdd519a1 --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=6e558709db315bacd2260379000001b6-1451356216.117616-944872298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-28 19:56:31,580 truncating revision to first 12 chars 2015-12-28 19:56:31,580 Setting DEBUG logging. 2015-12-28 19:56:31,580 attempt 1/10 2015-12-28 19:56:31,580 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/36634a31d101?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-28 19:56:31,810 unpacking tar archive at: fx-team-36634a31d101/testing/mozharness/ program finished with exit code 0 elapsedTime=0.508304 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 19:56:30.915779) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-28 19:56:30.916058) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-28 19:56:30.924975) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-28 19:56:30.925240) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-28 19:56:30.926001) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-28 19:56:30.926292) ========= /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=6e558709db315bacd2260379000001b6-1451356216.117616-944872298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:56:32 INFO - MultiFileLogger online at 20151228 19:56:32 in /builds/slave/test-pgo 19:56:32 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:56:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:56:32 INFO - {'append_to_log': False, 19:56:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:56:32 INFO - 'blob_upload_branch': 'Fx-Team', 19:56:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:56:32 INFO - 'branch': 'Fx-Team', 19:56:32 INFO - 'buildbot_json_path': 'buildprops.json', 19:56:32 INFO - 'config_files': ('talos/linux_config.py',), 19:56:32 INFO - 'default_actions': ('clobber', 19:56:32 INFO - 'read-buildbot-config', 19:56:32 INFO - 'download-and-extract', 19:56:32 INFO - 'populate-webroot', 19:56:32 INFO - 'create-virtualenv', 19:56:32 INFO - 'install', 19:56:32 INFO - 'run-tests'), 19:56:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:56:32 INFO - 'download_minidump_stackwalk': True, 19:56:32 INFO - 'download_symbols': 'ondemand', 19:56:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:56:32 INFO - 'tooltool.py': '/tools/tooltool.py', 19:56:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:56:32 INFO - '/tools/misc-python/virtualenv.py')}, 19:56:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:56:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:56:32 INFO - 'installer_path': 'installer.exe', 19:56:32 INFO - 'log_level': 'info', 19:56:32 INFO - 'log_name': 'talos', 19:56:32 INFO - 'log_to_console': True, 19:56:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:56:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:56:32 INFO - 'opt_config_files': (), 19:56:32 INFO - 'pip_index': False, 19:56:32 INFO - 'sps_profile': False, 19:56:32 INFO - 'sps_profile_interval': 0, 19:56:32 INFO - 'suite': 'dromaeojs-e10s', 19:56:32 INFO - 'system_bits': '32', 19:56:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:56:32 INFO - 'title': 'talos-linux64-ix-039', 19:56:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:56:32 INFO - 'use_talos_json': True, 19:56:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:56:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:56:32 INFO - 'work_dir': 'build'} 19:56:32 INFO - ##### 19:56:32 INFO - ##### Running clobber step. 19:56:32 INFO - ##### 19:56:32 INFO - Running pre-action listener: _resource_record_pre_action 19:56:32 INFO - Running main action method: clobber 19:56:32 INFO - rmtree: /builds/slave/test-pgo/build 19:56:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:56:32 INFO - Running post-action listener: _resource_record_post_action 19:56:32 INFO - ##### 19:56:32 INFO - ##### Running read-buildbot-config step. 19:56:32 INFO - ##### 19:56:32 INFO - Running pre-action listener: _resource_record_pre_action 19:56:32 INFO - Running main action method: read_buildbot_config 19:56:32 INFO - Using buildbot properties: 19:56:32 INFO - { 19:56:32 INFO - "project": "", 19:56:32 INFO - "product": "firefox", 19:56:32 INFO - "script_repo_revision": "production", 19:56:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:56:32 INFO - "repository": "", 19:56:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 19:56:32 INFO - "buildid": "20151228173003", 19:56:32 INFO - "pgo_build": "True", 19:56:32 INFO - "basedir": "/builds/slave/test-pgo", 19:56:32 INFO - "buildnumber": 160, 19:56:32 INFO - "slavename": "talos-linux64-ix-039", 19:56:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:56:32 INFO - "platform": "ubuntu64_hw", 19:56:32 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:56:32 INFO - "branch": "fx-team", 19:56:32 INFO - "repo_path": "integration/fx-team", 19:56:32 INFO - "revision": "36634a31d101cab18c462d46fca07a14fdd519a1", 19:56:32 INFO - "stage_platform": "linux64-pgo", 19:56:32 INFO - "builduid": "efba87556bbe47baa47c10d9b93e8f2e", 19:56:32 INFO - "slavebuilddir": "test" 19:56:32 INFO - } 19:56:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/99lCyuv0Q_ONHqSmxLFp6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:56:32 INFO - Running post-action listener: _resource_record_post_action 19:56:32 INFO - ##### 19:56:32 INFO - ##### Running download-and-extract step. 19:56:32 INFO - ##### 19:56:32 INFO - Running pre-action listener: _resource_record_pre_action 19:56:32 INFO - Running main action method: download_and_extract 19:56:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:56:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:32 INFO - https://queue.taskcluster.net/v1/task/99lCyuv0Q_ONHqSmxLFp6A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:56:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/99lCyuv0Q_ONHqSmxLFp6A/artifacts/public/build/test_packages.json 19:56:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/99lCyuv0Q_ONHqSmxLFp6A/artifacts/public/build/test_packages.json 19:56:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/99lCyuv0Q_ONHqSmxLFp6A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:56:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/99lCyuv0Q_ONHqSmxLFp6A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:56:39 INFO - Downloaded 1302 bytes. 19:56:39 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:56:39 INFO - Using the following test package requirements: 19:56:39 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:56:39 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:56:39 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:39 INFO - u'jsshell-linux-x86_64.zip'], 19:56:39 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:56:39 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:56:39 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:56:39 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:56:39 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:56:39 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:56:39 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:56:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:39 INFO - https://queue.taskcluster.net/v1/task/99lCyuv0Q_ONHqSmxLFp6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:56:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/99lCyuv0Q_ONHqSmxLFp6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:56:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/99lCyuv0Q_ONHqSmxLFp6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:56:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/99lCyuv0Q_ONHqSmxLFp6A/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:56:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/99lCyuv0Q_ONHqSmxLFp6A/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:56:50 INFO - Downloaded 23191759 bytes. 19:56:50 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:56:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:56:50 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:56:51 INFO - Return code: 0 19:56: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:56: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:56:51 INFO - https://queue.taskcluster.net/v1/task/99lCyuv0Q_ONHqSmxLFp6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:56:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/99lCyuv0Q_ONHqSmxLFp6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:56:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/99lCyuv0Q_ONHqSmxLFp6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:56:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/99lCyuv0Q_ONHqSmxLFp6A/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:56:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/99lCyuv0Q_ONHqSmxLFp6A/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:56:53 INFO - Downloaded 23191759 bytes. 19:56:53 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:56:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:56:53 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:56:54 INFO - Return code: 0 19:56: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:56:54 INFO - https://queue.taskcluster.net/v1/task/99lCyuv0Q_ONHqSmxLFp6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:56:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/99lCyuv0Q_ONHqSmxLFp6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:56:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/99lCyuv0Q_ONHqSmxLFp6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:56:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/99lCyuv0Q_ONHqSmxLFp6A/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:56:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/99lCyuv0Q_ONHqSmxLFp6A/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:56:55 INFO - Downloaded 11132270 bytes. 19:56:55 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:56:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:56:55 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:56:55 INFO - Return code: 0 19:56:55 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:55 INFO - https://queue.taskcluster.net/v1/task/99lCyuv0Q_ONHqSmxLFp6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:56:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/99lCyuv0Q_ONHqSmxLFp6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:56:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/99lCyuv0Q_ONHqSmxLFp6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:56:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/99lCyuv0Q_ONHqSmxLFp6A/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:56:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/99lCyuv0Q_ONHqSmxLFp6A/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:56:57 INFO - Downloaded 54881949 bytes. 19:56:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/99lCyuv0Q_ONHqSmxLFp6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:56:57 INFO - mkdir: /builds/slave/test-pgo/properties 19:56:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:56:57 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:56:57 INFO - Contents: 19:56:57 INFO - build_url:https://queue.taskcluster.net/v1/task/99lCyuv0Q_ONHqSmxLFp6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:56:57 INFO - Running post-action listener: _resource_record_post_action 19:56:57 INFO - Running post-action listener: set_extra_try_arguments 19:56:57 INFO - ##### 19:56:57 INFO - ##### Running populate-webroot step. 19:56:57 INFO - ##### 19:56:57 INFO - Running pre-action listener: _resource_record_pre_action 19:56:57 INFO - Running main action method: populate_webroot 19:56:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:56:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:56:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:56:57 INFO - '--tppagecycles', 19:56:57 INFO - '7'], 19:56:57 INFO - 'tests': ['tsvgm']}}, 19:56:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:56:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:56:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:56:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:56:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:56:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:56:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:56:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:57 INFO - 'talos_options': ['--e10s'], 19:56:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:56:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:57 INFO - 'tests': ['damp', 'tps']}, 19:56:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:57 INFO - 'talos_options': ['--e10s'], 19:56:57 INFO - 'tests': ['damp', 'tps']}, 19:56:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:56:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:56:57 INFO - 'other': {'tests': ['a11yr', 19:56:57 INFO - 'ts_paint', 19:56:57 INFO - 'tpaint', 19:56:57 INFO - 'sessionrestore', 19:56:57 INFO - 'sessionrestore_no_auto_restore']}, 19:56:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:56:57 INFO - 'tests': ['a11yr', 19:56:57 INFO - 'ts_paint', 19:56:57 INFO - 'tpaint', 19:56:57 INFO - 'sessionrestore', 19:56:57 INFO - 'sessionrestore_no_auto_restore']}, 19:56:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:56:57 INFO - 'tests': ['a11yr', 19:56:57 INFO - 'ts_paint', 19:56:57 INFO - 'tpaint', 19:56:57 INFO - 'sessionrestore', 19:56:57 INFO - 'sessionrestore_no_auto_restore']}, 19:56:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:56:57 INFO - 'tests': ['a11yr', 19:56:57 INFO - 'ts_paint', 19:56:57 INFO - 'tpaint', 19:56:57 INFO - 'sessionrestore', 19:56:57 INFO - 'sessionrestore_no_auto_restore']}, 19:56:57 INFO - 'other_l64': {'tests': ['a11yr', 19:56:57 INFO - 'ts_paint', 19:56:57 INFO - 'tpaint', 19:56:57 INFO - 'sessionrestore', 19:56:57 INFO - 'sessionrestore_no_auto_restore']}, 19:56:57 INFO - 'other_nol64': {'tests': ['a11yr', 19:56:57 INFO - 'ts_paint', 19:56:57 INFO - 'tpaint', 19:56:57 INFO - 'sessionrestore', 19:56:57 INFO - 'sessionrestore_no_auto_restore']}, 19:56:57 INFO - 'svgr': {'tests': ['tsvgx', 19:56:57 INFO - 'tsvgr_opacity', 19:56:57 INFO - 'tart', 19:56:57 INFO - 'tscrollx', 19:56:57 INFO - 'cart']}, 19:56:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:56:57 INFO - 'tests': ['tsvgx', 19:56:57 INFO - 'tsvgr_opacity', 19:56:57 INFO - 'tart', 19:56:57 INFO - 'tscrollx', 19:56:57 INFO - 'cart']}, 19:56:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:57 INFO - 'tests': ['tp5o']}, 19:56:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:57 INFO - 'talos_options': ['--e10s'], 19:56:57 INFO - 'tests': ['tp5o']}, 19:56:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:57 INFO - 'talos_options': ['--xperf_path', 19:56:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:56:57 INFO - 'tests': ['tp5n']}, 19:56:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:57 INFO - 'talos_options': ['--e10s', 19:56:57 INFO - '--xperf_path', 19:56:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:56:57 INFO - 'tests': ['tp5n']}}, 19:56:57 INFO - 'talos.zip': {'path': '', 19:56:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:56:57 INFO - Running post-action listener: _resource_record_post_action 19:56:57 INFO - ##### 19:56:57 INFO - ##### Running create-virtualenv step. 19:56:57 INFO - ##### 19:56:57 INFO - Running pre-action listener: _resource_record_pre_action 19:56:57 INFO - Running main action method: create_virtualenv 19:56:57 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:56: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:56:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:56:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:56:57 INFO - Using real prefix '/usr' 19:56:57 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:56:57 INFO - Installing distribute.............................................................................................................................................................................................done. 19:56:59 INFO - Installing pip.................done. 19:56:59 INFO - Return code: 0 19:56:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:56: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:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56: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:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56: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 0x7f6c5f282f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1769630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fa840>, '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 0x17676b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1767b60>, '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': '6e558709db315bacd2260379000001b6-1451356216.117616-944872298', '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: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:56: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:56:59 INFO - Using env: {'DISPLAY': ':0', 19:56:59 INFO - 'HOME': '/home/cltbld', 19:56:59 INFO - 'LANG': 'en_US.UTF-8', 19:56:59 INFO - 'LANGUAGE': 'en_US:en', 19:56:59 INFO - 'LOGNAME': 'cltbld', 19:56:59 INFO - 'MAIL': '/var/mail/cltbld', 19:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:59 INFO - 'MOZ_NO_REMOTE': '1', 19:56:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:59 INFO - 'NO_EM_RESTART': '1', 19:56:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:59 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:59 INFO - 'SHELL': '/bin/bash', 19:56:59 INFO - 'SHLVL': '1', 19:56:59 INFO - 'TERM': 'linux', 19:56:59 INFO - 'TMOUT': '86400', 19:56:59 INFO - 'USER': 'cltbld', 19:56:59 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1451356216.117616-944872298', 19:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:59 INFO - '_': '/tools/buildbot/bin/python'} 19:56:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:59 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:59 INFO - Cleaning up... 19:56:59 INFO - Return code: 0 19:56:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:56: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:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56: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:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56: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', '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 0x7f6c5f282f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1769630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fa840>, '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 0x17676b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1767b60>, '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': '6e558709db315bacd2260379000001b6-1451356216.117616-944872298', '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: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 19:56: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 psutil>=0.7.1 19:56:59 INFO - Using env: {'DISPLAY': ':0', 19:56:59 INFO - 'HOME': '/home/cltbld', 19:56:59 INFO - 'LANG': 'en_US.UTF-8', 19:56:59 INFO - 'LANGUAGE': 'en_US:en', 19:56:59 INFO - 'LOGNAME': 'cltbld', 19:56:59 INFO - 'MAIL': '/var/mail/cltbld', 19:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:59 INFO - 'MOZ_NO_REMOTE': '1', 19:56:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:59 INFO - 'NO_EM_RESTART': '1', 19:56:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:59 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:59 INFO - 'SHELL': '/bin/bash', 19:56:59 INFO - 'SHLVL': '1', 19:56:59 INFO - 'TERM': 'linux', 19:56:59 INFO - 'TMOUT': '86400', 19:56:59 INFO - 'USER': 'cltbld', 19:56:59 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1451356216.117616-944872298', 19:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:59 INFO - '_': '/tools/buildbot/bin/python'} 19:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:00 INFO - Downloading/unpacking psutil>=0.7.1 19:57: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:57: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:57: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:57: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:57: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:57: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:57:01 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:57: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:57:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:57:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:57:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:57:01 INFO - Installing collected packages: psutil 19:57:01 INFO - Running setup.py install for psutil 19:57:01 INFO - building 'psutil._psutil_linux' extension 19:57:01 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:57: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:57:02 INFO - building 'psutil._psutil_posix' extension 19:57: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:57: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:57:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:57:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:57:02 INFO - Successfully installed psutil 19:57:02 INFO - Cleaning up... 19:57:02 INFO - Return code: 0 19:57:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:57: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:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57: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:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57: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 0x7f6c5f282f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1769630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fa840>, '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 0x17676b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1767b60>, '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': '6e558709db315bacd2260379000001b6-1451356216.117616-944872298', '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:57: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:57: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:57:02 INFO - Using env: {'DISPLAY': ':0', 19:57:02 INFO - 'HOME': '/home/cltbld', 19:57:02 INFO - 'LANG': 'en_US.UTF-8', 19:57:02 INFO - 'LANGUAGE': 'en_US:en', 19:57:02 INFO - 'LOGNAME': 'cltbld', 19:57:02 INFO - 'MAIL': '/var/mail/cltbld', 19:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:02 INFO - 'MOZ_NO_REMOTE': '1', 19:57:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:02 INFO - 'NO_EM_RESTART': '1', 19:57:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:57:02 INFO - 'PWD': '/builds/slave/test-pgo', 19:57:02 INFO - 'SHELL': '/bin/bash', 19:57:02 INFO - 'SHLVL': '1', 19:57:02 INFO - 'TERM': 'linux', 19:57:02 INFO - 'TMOUT': '86400', 19:57:02 INFO - 'USER': 'cltbld', 19:57:02 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1451356216.117616-944872298', 19:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:02 INFO - '_': '/tools/buildbot/bin/python'} 19:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:57: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:57: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:57: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:57: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:57: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:57: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:57:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:57:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:57:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:57: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:57:04 INFO - Installing collected packages: mozsystemmonitor 19:57:04 INFO - Running setup.py install for mozsystemmonitor 19:57:04 INFO - Successfully installed mozsystemmonitor 19:57:04 INFO - Cleaning up... 19:57:04 INFO - Return code: 0 19:57:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:57: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:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57: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:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57: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 0x7f6c5f282f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1769630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fa840>, '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 0x17676b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1767b60>, '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': '6e558709db315bacd2260379000001b6-1451356216.117616-944872298', '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:57: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:57: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:57:04 INFO - Using env: {'DISPLAY': ':0', 19:57:04 INFO - 'HOME': '/home/cltbld', 19:57:04 INFO - 'LANG': 'en_US.UTF-8', 19:57:04 INFO - 'LANGUAGE': 'en_US:en', 19:57:04 INFO - 'LOGNAME': 'cltbld', 19:57:04 INFO - 'MAIL': '/var/mail/cltbld', 19:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:04 INFO - 'MOZ_NO_REMOTE': '1', 19:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:04 INFO - 'NO_EM_RESTART': '1', 19:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:57:04 INFO - 'PWD': '/builds/slave/test-pgo', 19:57:04 INFO - 'SHELL': '/bin/bash', 19:57:04 INFO - 'SHLVL': '1', 19:57:04 INFO - 'TERM': 'linux', 19:57:04 INFO - 'TMOUT': '86400', 19:57:04 INFO - 'USER': 'cltbld', 19:57:04 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1451356216.117616-944872298', 19:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:04 INFO - '_': '/tools/buildbot/bin/python'} 19:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:04 INFO - Downloading/unpacking blobuploader==1.2.4 19:57: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:57: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:57: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:57: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:57: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:57: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:57:06 INFO - Downloading blobuploader-1.2.4.tar.gz 19:57: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:57:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:57:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:57: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:57: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:57: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:57: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:57: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:57: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:57: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:57:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:57:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:57: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:57: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:57: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:57: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:57: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:57: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:57:07 INFO - Downloading docopt-0.6.1.tar.gz 19:57: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:57:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:57:07 INFO - Installing collected packages: blobuploader, requests, docopt 19:57:07 INFO - Running setup.py install for blobuploader 19:57:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:57:07 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:57:07 INFO - Running setup.py install for requests 19:57:07 INFO - Running setup.py install for docopt 19:57:07 INFO - Successfully installed blobuploader requests docopt 19:57:07 INFO - Cleaning up... 19:57:07 INFO - Return code: 0 19:57:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:57: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:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57: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:57:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57: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 0x7f6c5f282f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1769630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fa840>, '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 0x17676b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1767b60>, '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': '6e558709db315bacd2260379000001b6-1451356216.117616-944872298', '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:57: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:57: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:57:07 INFO - Using env: {'DISPLAY': ':0', 19:57:07 INFO - 'HOME': '/home/cltbld', 19:57:07 INFO - 'LANG': 'en_US.UTF-8', 19:57:07 INFO - 'LANGUAGE': 'en_US:en', 19:57:07 INFO - 'LOGNAME': 'cltbld', 19:57:07 INFO - 'MAIL': '/var/mail/cltbld', 19:57:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:07 INFO - 'MOZ_NO_REMOTE': '1', 19:57:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:07 INFO - 'NO_EM_RESTART': '1', 19:57:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:57:07 INFO - 'PWD': '/builds/slave/test-pgo', 19:57:07 INFO - 'SHELL': '/bin/bash', 19:57:07 INFO - 'SHLVL': '1', 19:57:07 INFO - 'TERM': 'linux', 19:57:07 INFO - 'TMOUT': '86400', 19:57:07 INFO - 'USER': 'cltbld', 19:57:07 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1451356216.117616-944872298', 19:57:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:07 INFO - '_': '/tools/buildbot/bin/python'} 19:57:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:57:07 INFO - Running setup.py (path:/tmp/pip-loVoN1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:57:08 INFO - Running setup.py (path:/tmp/pip-tWzeNJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:57:08 INFO - Running setup.py (path:/tmp/pip-YKZGI7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:57:08 INFO - Running setup.py (path:/tmp/pip-lBMPis-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:57:08 INFO - Running setup.py (path:/tmp/pip-GHe3l1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:57:08 INFO - Running setup.py (path:/tmp/pip-sVKhLL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:57:08 INFO - Running setup.py (path:/tmp/pip-l56BJD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:57:08 INFO - Running setup.py (path:/tmp/pip-OathkL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:57:08 INFO - Running setup.py (path:/tmp/pip-5lG8o4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:57:08 INFO - Running setup.py (path:/tmp/pip-malZMB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:57:08 INFO - Running setup.py (path:/tmp/pip-to2Wrs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:57:08 INFO - Running setup.py (path:/tmp/pip-538shi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:57:08 INFO - Running setup.py (path:/tmp/pip-GjmCbP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:57:08 INFO - Running setup.py (path:/tmp/pip-NlHs1G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:57:09 INFO - Running setup.py (path:/tmp/pip-EFQ2qq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:57:09 INFO - Running setup.py (path:/tmp/pip-hbObyf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:57:09 INFO - Running setup.py (path:/tmp/pip-TZ2xfE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:57:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:57:09 INFO - Running setup.py install for manifestparser 19:57:09 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:57:09 INFO - Running setup.py install for mozcrash 19:57:09 INFO - Running setup.py install for mozdebug 19:57:09 INFO - Running setup.py install for mozdevice 19:57:09 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:57:09 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:57:09 INFO - Running setup.py install for mozfile 19:57:09 INFO - Running setup.py install for mozhttpd 19:57:09 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:57:09 INFO - Running setup.py install for mozinfo 19:57:09 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:57:09 INFO - Running setup.py install for mozInstall 19:57:10 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:57:10 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:57:10 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:57:10 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:57:10 INFO - Running setup.py install for mozleak 19:57:10 INFO - Running setup.py install for mozlog 19:57:10 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:57:10 INFO - Running setup.py install for moznetwork 19:57:10 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:57:10 INFO - Running setup.py install for mozprocess 19:57:10 INFO - Running setup.py install for mozprofile 19:57:10 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:57:10 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:57:10 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:57:10 INFO - Running setup.py install for mozrunner 19:57:10 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:57:10 INFO - Running setup.py install for mozscreenshot 19:57:10 INFO - Running setup.py install for moztest 19:57:10 INFO - Running setup.py install for mozversion 19:57:10 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:57:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:57:11 INFO - Cleaning up... 19:57:11 INFO - Return code: 0 19:57:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:57: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:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57: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:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57: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 0x7f6c5f282f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1769630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fa840>, '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 0x17676b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1767b60>, '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': '6e558709db315bacd2260379000001b6-1451356216.117616-944872298', '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:57: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:57: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:57:11 INFO - Using env: {'DISPLAY': ':0', 19:57:11 INFO - 'HOME': '/home/cltbld', 19:57:11 INFO - 'LANG': 'en_US.UTF-8', 19:57:11 INFO - 'LANGUAGE': 'en_US:en', 19:57:11 INFO - 'LOGNAME': 'cltbld', 19:57:11 INFO - 'MAIL': '/var/mail/cltbld', 19:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:11 INFO - 'MOZ_NO_REMOTE': '1', 19:57:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:11 INFO - 'NO_EM_RESTART': '1', 19:57:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:57:11 INFO - 'PWD': '/builds/slave/test-pgo', 19:57:11 INFO - 'SHELL': '/bin/bash', 19:57:11 INFO - 'SHLVL': '1', 19:57:11 INFO - 'TERM': 'linux', 19:57:11 INFO - 'TMOUT': '86400', 19:57:11 INFO - 'USER': 'cltbld', 19:57:11 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1451356216.117616-944872298', 19:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:11 INFO - '_': '/tools/buildbot/bin/python'} 19:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:57:11 INFO - Running setup.py (path:/tmp/pip-jeuXwV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:57: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:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:57:11 INFO - Running setup.py (path:/tmp/pip-euzMEM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:57: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:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:57:11 INFO - Running setup.py (path:/tmp/pip-ROEVtO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:57: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:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:57:11 INFO - Running setup.py (path:/tmp/pip-TTpFrV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:57: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:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:57:11 INFO - Running setup.py (path:/tmp/pip-NeVbwJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:57: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:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:57:11 INFO - Running setup.py (path:/tmp/pip-r3qrwB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:57: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:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:57:11 INFO - Running setup.py (path:/tmp/pip-XbwJiu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:57: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:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:57:11 INFO - Running setup.py (path:/tmp/pip-Zdm76b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:57: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:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:57:11 INFO - Running setup.py (path:/tmp/pip-2uirI5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:57:11 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:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:57:11 INFO - Running setup.py (path:/tmp/pip-sCXmnF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:57:11 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:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:57:11 INFO - Running setup.py (path:/tmp/pip-vNdshX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:57: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:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:57:12 INFO - Running setup.py (path:/tmp/pip-sQw9bE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:57: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:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:57:12 INFO - Running setup.py (path:/tmp/pip-oZwUqu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:57: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:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:57:12 INFO - Running setup.py (path:/tmp/pip-FTY9tT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:57: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:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:57:12 INFO - Running setup.py (path:/tmp/pip-GUv8Z1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:57: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:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:57:12 INFO - Running setup.py (path:/tmp/pip-S1kAif-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:57: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:57:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:57:12 INFO - Running setup.py (path:/tmp/pip-WGR6gn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:57: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:57: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:57: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:57: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:57: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:57: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:57: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:57: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:57: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:57: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:57: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:57: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:57: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:57:14 INFO - Downloading blessings-1.5.1.tar.gz 19:57: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:57:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:57:14 INFO - Installing collected packages: blessings 19:57:14 INFO - Running setup.py install for blessings 19:57:14 INFO - Successfully installed blessings 19:57:14 INFO - Cleaning up... 19:57:14 INFO - Return code: 0 19:57:14 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:57:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:57:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:57:14 INFO - Reading from file tmpfile_stdout 19:57:14 INFO - Current package versions: 19:57:14 INFO - argparse == 1.2.1 19:57:14 INFO - blessings == 1.5.1 19:57:14 INFO - blobuploader == 1.2.4 19:57:14 INFO - docopt == 0.6.1 19:57:14 INFO - manifestparser == 1.1 19:57:14 INFO - mozInstall == 1.12 19:57:14 INFO - mozcrash == 0.16 19:57:14 INFO - mozdebug == 0.1 19:57:14 INFO - mozdevice == 0.47 19:57:14 INFO - mozfile == 1.2 19:57:14 INFO - mozhttpd == 0.7 19:57:14 INFO - mozinfo == 0.9 19:57:14 INFO - mozleak == 0.1 19:57:14 INFO - mozlog == 3.1 19:57:14 INFO - moznetwork == 0.27 19:57:14 INFO - mozprocess == 0.22 19:57:14 INFO - mozprofile == 0.28 19:57:14 INFO - mozrunner == 6.11 19:57:14 INFO - mozscreenshot == 0.1 19:57:14 INFO - mozsystemmonitor == 0.0 19:57:14 INFO - moztest == 0.7 19:57:14 INFO - mozversion == 1.4 19:57:14 INFO - psutil == 3.1.1 19:57:14 INFO - requests == 1.2.3 19:57:14 INFO - wsgiref == 0.1.2 19:57:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:57: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:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57: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:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57: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 0x7f6c5f282f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1769630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fa840>, '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 0x17676b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1767b60>, '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': '6e558709db315bacd2260379000001b6-1451356216.117616-944872298', '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:57: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:57: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:57:14 INFO - Using env: {'DISPLAY': ':0', 19:57:14 INFO - 'HOME': '/home/cltbld', 19:57:14 INFO - 'LANG': 'en_US.UTF-8', 19:57:14 INFO - 'LANGUAGE': 'en_US:en', 19:57:14 INFO - 'LOGNAME': 'cltbld', 19:57:14 INFO - 'MAIL': '/var/mail/cltbld', 19:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:14 INFO - 'MOZ_NO_REMOTE': '1', 19:57:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:14 INFO - 'NO_EM_RESTART': '1', 19:57:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:57:14 INFO - 'PWD': '/builds/slave/test-pgo', 19:57:14 INFO - 'SHELL': '/bin/bash', 19:57:14 INFO - 'SHLVL': '1', 19:57:14 INFO - 'TERM': 'linux', 19:57:14 INFO - 'TMOUT': '86400', 19:57:14 INFO - 'USER': 'cltbld', 19:57:14 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1451356216.117616-944872298', 19:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:14 INFO - '_': '/tools/buildbot/bin/python'} 19:57:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57: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:57: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:57: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:57: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:57: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:57: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:57: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:57: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:57: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:57: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:57: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:57:14 INFO - Cleaning up... 19:57:14 INFO - Return code: 0 19:57:14 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:57: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:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57: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:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57: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', '--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 0x7f6c5f282f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1769630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fa840>, '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 0x17676b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1767b60>, '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': '6e558709db315bacd2260379000001b6-1451356216.117616-944872298', '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:57:14 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:57:14 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:57:14 INFO - Using env: {'DISPLAY': ':0', 19:57:14 INFO - 'HOME': '/home/cltbld', 19:57:14 INFO - 'LANG': 'en_US.UTF-8', 19:57:14 INFO - 'LANGUAGE': 'en_US:en', 19:57:14 INFO - 'LOGNAME': 'cltbld', 19:57:14 INFO - 'MAIL': '/var/mail/cltbld', 19:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:14 INFO - 'MOZ_NO_REMOTE': '1', 19:57:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:14 INFO - 'NO_EM_RESTART': '1', 19:57:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:57:14 INFO - 'PWD': '/builds/slave/test-pgo', 19:57:14 INFO - 'SHELL': '/bin/bash', 19:57:14 INFO - 'SHLVL': '1', 19:57:14 INFO - 'TERM': 'linux', 19:57:14 INFO - 'TMOUT': '86400', 19:57:14 INFO - 'USER': 'cltbld', 19:57:14 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1451356216.117616-944872298', 19:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:14 INFO - '_': '/tools/buildbot/bin/python'} 19:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:15 INFO - Downloading/unpacking jsonschema 19:57: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:57: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:57: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:57: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:57: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:57: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:57:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:57: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:57:16 INFO - Downloading/unpacking functools32 (from jsonschema) 19:57: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:57: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:57: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:57: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:57: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:57: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:57:16 INFO - Downloading functools32-3.2.3-2.tar.gz 19:57:16 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:57:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:57:16 INFO - warning: no files found matching '*.txt' 19:57:16 INFO - no previously-included directories found matching 'build' 19:57:16 INFO - no previously-included directories found matching 'dist' 19:57:16 INFO - no previously-included directories found matching '.git*' 19:57:17 INFO - Installing collected packages: jsonschema, functools32 19:57:17 INFO - Running setup.py install for functools32 19:57:17 INFO - warning: no files found matching '*.txt' 19:57:17 INFO - no previously-included directories found matching 'build' 19:57:17 INFO - no previously-included directories found matching 'dist' 19:57:17 INFO - no previously-included directories found matching '.git*' 19:57:17 INFO - Successfully installed jsonschema functools32 19:57:17 INFO - Cleaning up... 19:57:17 INFO - Return code: 0 19:57:17 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:57: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:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57: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:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57: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 0x7f6c5f282f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1769630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fa840>, '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 0x17676b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1767b60>, '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': '6e558709db315bacd2260379000001b6-1451356216.117616-944872298', '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:57: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:57: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:57:17 INFO - Using env: {'DISPLAY': ':0', 19:57:17 INFO - 'HOME': '/home/cltbld', 19:57:17 INFO - 'LANG': 'en_US.UTF-8', 19:57:17 INFO - 'LANGUAGE': 'en_US:en', 19:57:17 INFO - 'LOGNAME': 'cltbld', 19:57:17 INFO - 'MAIL': '/var/mail/cltbld', 19:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:17 INFO - 'MOZ_NO_REMOTE': '1', 19:57:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:17 INFO - 'NO_EM_RESTART': '1', 19:57:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:57:17 INFO - 'PWD': '/builds/slave/test-pgo', 19:57:17 INFO - 'SHELL': '/bin/bash', 19:57:17 INFO - 'SHLVL': '1', 19:57:17 INFO - 'TERM': 'linux', 19:57:17 INFO - 'TMOUT': '86400', 19:57:17 INFO - 'USER': 'cltbld', 19:57:17 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1451356216.117616-944872298', 19:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:17 INFO - '_': '/tools/buildbot/bin/python'} 19:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:17 INFO - Downloading/unpacking flake8 19:57: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:57: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:57: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:57: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:57: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:57: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:57:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:57: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:57:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:57: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:57: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:57: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:57: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:57: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:57: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:57:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:57: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:57:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:57: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:57: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:57: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:57: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:57: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:57: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:57: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:57:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:57: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:57: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:57: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:57: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:57: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:57: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:57: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:57:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:57:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:57:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:57:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:57:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:57:19 INFO - no previously-included directories found matching 'docs/_build' 19:57:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:57:19 INFO - Running setup.py install for pep8 19:57:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:57:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:57:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:57:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:57:19 INFO - no previously-included directories found matching 'docs/_build' 19:57:19 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:57:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:57:19 INFO - Cleaning up... 19:57:20 INFO - Return code: 0 19:57:20 INFO - Running post-action listener: _resource_record_post_action 19:57:20 INFO - Running post-action listener: _start_resource_monitoring 19:57:20 INFO - Starting resource monitoring. 19:57:20 INFO - ##### 19:57:20 INFO - ##### Running install step. 19:57:20 INFO - ##### 19:57:20 INFO - Running pre-action listener: _resource_record_pre_action 19:57:20 INFO - Running main action method: install 19:57:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:57:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:57:20 INFO - Reading from file tmpfile_stdout 19:57:20 INFO - Detecting whether we're running mozinstall >=1.0... 19:57:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:57:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:57:20 INFO - Reading from file tmpfile_stdout 19:57:20 INFO - Output received: 19:57:20 INFO - Usage: mozinstall [options] installer 19:57:20 INFO - Options: 19:57:20 INFO - -h, --help show this help message and exit 19:57:20 INFO - -d DEST, --destination=DEST 19:57:20 INFO - Directory to install application into. [default: 19:57:20 INFO - "/builds/slave/test-pgo"] 19:57:20 INFO - --app=APP Application being installed. [default: firefox] 19:57:20 INFO - mkdir: /builds/slave/test-pgo/build/application 19:57: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:57: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:57:36 INFO - Reading from file tmpfile_stdout 19:57:36 INFO - Output received: 19:57:36 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:57:36 INFO - Running post-action listener: _resource_record_post_action 19:57:36 INFO - ##### 19:57:36 INFO - ##### Running run-tests step. 19:57:36 INFO - ##### 19:57:36 INFO - Running pre-action listener: _resource_record_pre_action 19:57:36 INFO - Running main action method: run_tests 19:57:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:57:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:57:36 INFO - Python 2.7.3 19:57:36 INFO - Return code: 0 19:57:36 INFO - grabbing minidump binary from tooltool 19:57: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:57: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 0x17fa840>, '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 0x17676b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1767b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:57: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:57: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:57:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:57:36 INFO - Return code: 0 19:57:36 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:57:36 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:57:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:57:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:57:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:57:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:57:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:57:37 INFO - Return code: 0 19:57: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/99lCyuv0Q_ONHqSmxLFp6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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:57: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/99lCyuv0Q_ONHqSmxLFp6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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:57:37 INFO - Using env: {'DISPLAY': ':0', 19:57:37 INFO - 'HOME': '/home/cltbld', 19:57:37 INFO - 'LANG': 'en_US.UTF-8', 19:57:37 INFO - 'LANGUAGE': 'en_US:en', 19:57:37 INFO - 'LOGNAME': 'cltbld', 19:57:37 INFO - 'MAIL': '/var/mail/cltbld', 19:57:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:57:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:37 INFO - 'MOZ_NO_REMOTE': '1', 19:57:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:57:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:37 INFO - 'NO_EM_RESTART': '1', 19:57: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:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:57:37 INFO - 'PWD': '/builds/slave/test-pgo', 19:57:37 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:57:37 INFO - 'SHELL': '/bin/bash', 19:57:37 INFO - 'SHLVL': '1', 19:57:37 INFO - 'TERM': 'linux', 19:57:37 INFO - 'TMOUT': '86400', 19:57:37 INFO - 'USER': 'cltbld', 19:57:37 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1451356216.117616-944872298', 19:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:37 INFO - '_': '/tools/buildbot/bin/python'} 19:57: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/99lCyuv0Q_ONHqSmxLFp6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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:57:37 INFO - mozversion application_buildid: 20151228173003 19:57:37 INFO - mozversion application_changeset: 36634a31d101cab18c462d46fca07a14fdd519a1 19:57:37 INFO - mozversion application_display_name: Nightly 19:57:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:57:37 INFO - mozversion application_name: Firefox 19:57:37 INFO - mozversion application_remotingname: firefox 19:57:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:57:37 INFO - mozversion application_vendor: Mozilla 19:57:37 INFO - mozversion application_version: 46.0a1 19:57:37 INFO - mozversion platform_buildid: 20151228173003 19:57:37 INFO - mozversion platform_changeset: 36634a31d101cab18c462d46fca07a14fdd519a1 19:57:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:57:37 INFO - mozversion platform_version: 46.0a1 19:57:37 INFO - using testdate: 1451361457 19:57:37 INFO - actual date: 1451361457 19:57:37 INFO - starting webserver on 'localhost:51866' 19:57:37 INFO - SUITE-START | Running 3 tests 19:57:37 INFO - TEST-START | dromaeo_css 19:57:37 INFO - operating with platform_type : linux_ 19:57:37 INFO - Initialising browser for dromaeo_css test... 19:57:37 INFO - TEST-INFO | started process 8153 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvRUauI/profile http://localhost:51866/getInfo.html) 19:57:42 INFO - PROCESS | 8153 | __metrics Screen width/height:1600/1200 19:57:42 INFO - PROCESS | 8153 | colorDepth:24 19:57:42 INFO - PROCESS | 8153 | Browser inner width/height: 1024/697 19:57:42 INFO - PROCESS | 8153 | __metrics 19:57:42 INFO - PROCESS | 8153 | 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:57:43 INFO - TEST-INFO | 8153: exit 0 19:57:43 INFO - Browser initialized. 19:57:43 INFO - Running cycle 1/1 for dromaeo_css test... 19:57:43 INFO - TEST-INFO | started process 8287 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvRUauI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:57:55 INFO - PROCESS | 8287 | RSS: Main: 149278720 19:57:55 INFO - PROCESS | 8287 | 19:58:44 INFO - PROCESS | 8287 | 1451361524661 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] 20:00:53 INFO - PROCESS | 8287 | Cycle 1(1): loaded http://localhost:51866/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51866/tests/dromaeo/cssquery-ext.html) 20:00:54 INFO - PROCESS | 8287 | RSS: Main: 157093888 20:00:54 INFO - PROCESS | 8287 | 20:03:57 INFO - PROCESS | 8287 | Cycle 1(1): loaded http://localhost:51866/tests/dromaeo/cssquery-ext.html (next: http://localhost:51866/tests/dromaeo/cssquery-jquery.html) 20:03:57 INFO - PROCESS | 8287 | RSS: Main: 155123712 20:03:57 INFO - PROCESS | 8287 | 20:06:59 INFO - PROCESS | 8287 | Cycle 1(1): loaded http://localhost:51866/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51866/tests/dromaeo/cssquery-mootools.html) 20:06:59 INFO - PROCESS | 8287 | RSS: Main: 154505216 20:06:59 INFO - PROCESS | 8287 | 20:10:01 INFO - PROCESS | 8287 | Cycle 1(1): loaded http://localhost:51866/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51866/tests/dromaeo/cssquery-prototype.html) 20:10:02 INFO - PROCESS | 8287 | RSS: Main: 152268800 20:10:02 INFO - PROCESS | 8287 | 20:13:04 INFO - PROCESS | 8287 | Cycle 1(1): loaded http://localhost:51866/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51866/tests/dromaeo/cssquery-yui.html) 20:13:05 INFO - PROCESS | 8287 | RSS: Main: 152494080 20:13:05 INFO - PROCESS | 8287 | 20:16:07 INFO - PROCESS | 8287 | Cycle 1(1): loaded http://localhost:51866/tests/dromaeo/cssquery-yui.html (next: http://localhost:51866/tests/dromaeo/cssquery-dojo.html) 20:16:07 INFO - PROCESS | 8287 | RSS: Main: 154206208 20:16:07 INFO - PROCESS | 8287 | 20:16:07 INFO - PROCESS | 8287 | __start_tp_report 20:16:07 INFO - PROCESS | 8287 | _x_x_mozilla_page_load 20:16:07 INFO - PROCESS | 8287 | _x_x_mozilla_page_load_details 20:16:07 INFO - PROCESS | 8287 | |i|pagename|runs| 20:16:07 INFO - PROCESS | 8287 | |0;dojo.html;3202.4075546023973;3209.4383482890494;3244.0267919624116;3250.9674903250975;3281.2125089978413;5228.79084836606;5367.275417818598;5409.756560954756;5414.512693857552;5425.321834770653;5316.548093412055;5360.544353729938;5360.597955153359;5376.489233522819;5383.542398896088;4872.805087796484;4949.529794669518;4957.677750946177;5023.648344615878;5030.270610761438;4952.405711314647;5016.623753218505;5021.271915572258;5024.82413115541;5069.467705890884;4517.864464066083;4805.591524720403;4817.831375901862;4827.420709514846;4849.490803465638;4795.808167673289;4835.153848076572;4835.951640483585;4853.344798452199;4860.027994401134;4821.300911367867;4832.975835120802;4834.903301933977;4861.73260470674;4868.586170175539;5134.691918484903;5140.948590514085;5182.611304152204;5189.42916279209;5214.921776173361;5759.366469688331;5766.279215098113;5769.07694768835;5770.538356931435;5797.4782269595935;5651.519620832234;5818.4763371296785;5833.095870140135;5859.209006784072;5860.413958604148;5411.134218525057;5413.756380962866;5424.538914192299;5448.83653490396;5472.863178420532;5861.560382971209;5911.881762364728;5922.318933322636;5927.525797936155;5935.821925342247;5657.886842263131;5717.914231286534;5723.54211663066;5790.392008839095;5794.1308803679785;5780.797672081457;5786.103154011135;5854.882902342015;5859.355470898197;5860.531157507389;5773.134029895549;5774.711264436762;5783.161441590946;5786.189933409326;5827.650340979555;5711.942880571224;5774.3070831499645;5778.335491418541;5782.10377391505;5795.507381872504;4328.329108988112;4432.423784907941;4451.732896026248;4484.1255955088445;4532.909341813145;4026.1142548639255;4031.858884939013;4034.576369481162;4035.7174997749876;4070.633642972147;5479.506844384025;5495.258140151029;5504.779808807683;5518.696471694096;5541.058020136506;5753.4821866031425;5772.94227057724;5853.795117170878;5859.472647461749;5874.618149820248;5412.458754124556;5464.699441530754;5467.343918729698;5470.343558772973;5475.561955043587;4977.800887964513;5048.188617593767;5052;5075.137226671474;5097.439281679012;5901.380355062656;5958.612690175125;6015.969920150459;6018.037114061729;6029.517638588903;5855.795047173328;5869.06095024794;5873.295204575478;5876.735546900485;5882.058870580687;5834.241548598655;5937.376575459687;5981.521478281814;6050.757969681164;6067.180930574493;5695.373508914099;5748;5753.597248192586;5760.279965004374;5807.593468457337;5842.883142337045;5866.149408335682;5880.911786323294;5890.911636325544;5907.940920590739;5576.498115169492;5626.662400255997;5673.205751194753;5739.942600573941;5747.942520574741;5734.254546908875;5753.798617048383;5759.481646651821;5760.395158508296;5805.129230615442;5640.323161220515;5648;5654.688992105309;5655.349634791887;5657.632253903483;5563.221149039218;5605.859853503695;5691.516221121251;5718.656880587178;5726;5683.7442315095095;5689.573282003949;5691.288588926384;5698.715064246854;5740.569457290803 20:16:07 INFO - PROCESS | 8287 | |1;ext.html;600.4505877122433;600.4715850051954;600.8678090820018;605.627539063476;609.3327806052371;38076;38884.41673374898;38905.22189556207;38957.80521097391;38977.415338769904;42849.7857510712;43494.56505434945;43539.3469097963;43807.34288985668;43811;8633.611487483078;8741.868871966926;8759.51822649754;8770.780730481758;8774.429662071945;8561.657533698644;8674.956625216897;8700.782480437976;8715.128487151298;8717.084706105863;8675.913240867574;8676.349273804459;8761.649534018632;8763.298936085097;8765.561721913911;8543.615537300868;8567.785805354853;8578.528180950045;8600.35497337696;8652;8560.61477233526;8596.2263396294;8619.310455163572;8638.65445382184;8680.131986801332;38873.222535549416;39615.60384396148;39617.60382396168;39660.20679586421;39720.20559588792;3296.538484612156;3355.5302257683943;3361.5629968104236;3366.6633336666137;3495.0912762681887;29672.519606190683;29867.40265194684;30091.247718806986;30128.09615711532;30501.389972200654;3793.407333326719;3813.733038687293;3815.313243616148;3854.2291541691775;4001.099752555681;195386;195628;196971.99999999857;197207;197582;41336.1732765349;41442.58557414387;58542;58745.70627146837;58886;40167;40594.391084133764;40634.18731625351;40644;40802.38796418056;14718.779218311734;15027.398904043934;15043.097414155185;15085.24573771329;15090;12088.879111208951;12128.211666241843;12140.453679584263;12141.817872731915;12148.696282593006;14229.28853557318;14264.85735142656;14301.28493575317;14350.784738228935;14367.425302987764;5789.797357092481;5927.911081333784;6026.45761881424;6038.939610603926;6064.787732429344;904.556767184075;923.2337160157053;958.4536814016084;1086.918481113904;1122.3490375582144;28323.433531329258;28898;29026.12921612355;29251.707482925325;29350.412991740046;953.1374106433689;1052.2686732720686;1098.4288170151476;1113.2263077161458;1125.6960620632383;16451.91774041122;17233.827661723473;17329.306827727003;17387.913060434617;17516.5620859477;379973;383260;384420;384562;384758;55326;55479.44520554823;55645.165322520195;55743.72128139334;56025.15962260569;1291.5027714330051;1325.5029363988504;1326.6683329167709;1339.163023110556;1355.5391167003265;29309;30427.54358684577;31107;31700.841495792374;32337.191570210933;49987.75006124946;50560.74719626379;50609.49390506195;50722.2391664118;50770.74614626903;301007;303438;306133;306237;306255;41101.383479248434;43465;43952.34071488866;44398;44693.776531118434;39850.800745996086;40075.79962100171;40128.39807402833;40924;40989.59010409858;33897.49153762646;34112.31775364429;34290.657093428745;34795.65204347924;39859;35989.460158098176;36598.8170059148;39066;40104.19791604093;40533.79733101316;33666.663333366356;33949.83025084859;34161;34200.65799341975;35981.28037439289;30909.49988753111;31841.363172736877;32972.34055318928;33051.504227437086;33166.502502462;31926.840365798023;33375.33249334951;34534.48198276978;34644.82677586697;34884.30231395409 20:16:07 INFO - PROCESS | 8287 | |2;jquery.html;349.7202238209433;351.4096318185448;352.652637152405;354.7711725936771;357.1090130125337;14207.57377278682;15103.622409439757;16382.42661506846;17387.304507819674;18068.09659517022;11102.722431939206;11507.654770356881;16328.34686612537;16469.67060658789;16504.75242871358;4911.189653707134;5471.316085489314;5473.781048758045;5474.042042642542;5474.507294343508;5405.945940540583;5411.783528658869;5452.318460192476;5457.072297709379;5457.563394928416;5003.649744517885;5149.40781810091;5289.259503669489;5412.296401467804;5427.48438898304;5080.060188865072;5120.846374608767;5136.64043516954;5149.922751158736;5153.433122356557;4925.21196608541;5359.785608575652;5371.650842695212;5380.408155102936;5380.838574842761;19478.12348444309;19625.705614415794;20002.39992800218;20082.598348033105;20101.195952161896;1965.4791480257743;2007.1569940624827;2059.1351632314463;2112.313498113104;2222.244436891465;11986.401647683582;13152.342382880817;13172.6706832329;13208.075434719574;13313;1651.3229575873834;1811.5923917118675;1815.8638102142393;1827.9268829246946;1928.267258441783;52645.73677131628;52935.73532132353;53431.732841335936;53531.464685353036;56656.43343566594;8935.776605584782;9461.52692365379;10008.999100090079;10027.749306267402;10094.545745441326;12775.488980440865;12912.548060818015;12930.935345323402;12931.418086186144;12936.547220847226;7619.276168763959;7650;7656.349210317186;7676.040494938133;7689.6539655714505;7474.70101195957;7519.248075192437;7602.087749469988;7625.618719064136;7650.464467487333;4404.11917616478;4435.2016637005645;4473.798679059385;4491.797869095899;4498.05540836428;1695.3303445139102;1723.2159367487764;1779.2082523277277;1834.3671433355737;1855.3228071753713;390.54111419082466;400.54738145894953;401.5783427401217;409.1836785612662;904.1184844776291;10133.695989120339;10144.087032166994;10144.644937427302;10253.897461025443;10457.163426925828;411.04432195146404;413.8365345688436;433.0386541877028;440.6915159388377;444.7198265092971;5602.411746766612;5664;5699.686517241592;5702.54379649627;5757.884842303214;376254;381196;382793;384785;441118;83314.58342708247;83383.5830820842;86258;86500.56749716337;86606;1139.1684070628487;1159.368144361325;1162.2968104296947;1163.9709007274887;1168.2990205876577;15706.136162510715;15798.60503487422;15935.12356820386;16044;16285.918570407071;32333.35333293368;32335.676643233266;33809.83095084509;34736.47895281624;35591;36931.446028310136;37347.43978840374;37353.81323093367;37881;38362.23275534529;9167.587458564247;9391.872975243015;9455.243580513405;9524.14282714559;9831.606735730491;16894.746578801572;16897.408590699266;17160.313587456363;17615.119244038004;17646;2792.7905407094145;13745.532701871733;14669.633259168606;14779.556613301618;15043.849561504683;13838.584842454742;13888.652783680489;14379.928100359431;14417.92791036038;14574.85425145735;12510.311932843417;14903.627409314853;15159.924200379368;15219.923900380427;15321.463748769185;9096.681616143404;9263.953680231556;9268.443893366419;9337.159655631025;9806.85289720669;14373.496927607484;14419.423223071379;14736;14906.776398353817;15238.542843714706 20:16:07 INFO - PROCESS | 8287 | |3;mootools.html;1464.253230852265;1465.7508223601988;1644.8355164483553;1772.5480002599336;1791.3103455169755;6552.868942621145;6635.933640663592;7183.89224161638;7350.779476615703;7385.409167266619;6928.549644273119;7148.678309476073;7318.853622927551;7420.183779784219;7431.145418276899;2195.2316689158824;2210.149092599345;2214.357836227492;2215.5679642469727;2220.911163553464;2216.822654187661;2227.5767604155158;2313.363824948144;2314.2478694424294;2316.131450705985;2202.658587918867;2223.766504517019;2224.354937068248;2224.92212772553;2267.3424706835;2194.9780502195094;2198.483356411242;2215.4129155773735;2223.132978138527;2228.9665655015187;2225.321277010511;2263.0834512022657;2270.545890821842;2271.4775601611555;2273.4089136824377;7338.4496162788;7386.667599957961;7443.739469118609;7454.664540095709;7469.701211951516;4391.67062470316;4460.977695111536;4468.374427580141;4469.843555475575;4473.642108631334;2860.127661063375;2933.398653276073;2935.853207339646;2936.192547049557;2963.5554666799935;903.5075883643365;911.4349103555771;935.1023017902821;935.1396715022196;937.6062053937362;10246.129079028291;10382.896171038268;10396.84404733922;10414.635487757967;10417.114545263661;3971.0270983609203;3981.1440540283397;4003.7597744134864;4008.6993475489453;4102.077032667686;9072.954635226914;9077.863832042525;9083.318751093695;9087.273018158663;9088.409253398508;4532.977335113369;4549.203889319356;4550.47669518003;4560.817567297271;4563.612092972135;4009.3985902114914;4066.3493840985893;4126.690498212586;4214.431051808028;4219.957800421957;3379.425497665403;3408.6761757632985;3416.7095796857047;3422.6235114137426;3432.8798492053156;1033.6278939581744;1034.8447732839984;1037.180627304421;1042.0673497219946;1045.7333379988206;1297.863724308953;1299.4477347127433;1315.83552055993;1335.5859683498147;1339.4709089909431;6864.176298844171;6909.309069093151;7027.367536921702;7070.8939365909555;7082.5396349237135;440.58364845220956;446.5712915601059;447.98432054877924;449.99325010124875;452.116112999086;5537.058700021006;5551.7779288828;5554.72226388679;5597.132444471114;5605.299337582802;8241.50550966944;8300.252977232078;8541.871871921927;8597.484150950962;8620.310375169971;8457.915420845837;8521;8533.871991920127;8535.189157030196;8587.527685977331;6912.516123871281;6933.2720064393525;6991.19601245853;6997.895031574531;7040.683169257396;6736.6968486417245;6736.7642132525125;6742.157230346207;6748.257691654012;6751.729930802713;7450.180480147071;7545;7746.690132394867;7817.452778305464;7847.293743563107;7677.577733224726;7789.766307010798;7871.803204919923;7874.409419293462;7940;5699.5725320600295;5745.91381129275;6036.305824830025;6270.9372906270355;6316;6986.056882320821;6995.79012629622;7031.753888613874;7044.189918159477;7056.082709247765;6515.478761699147;6586.37429444202;6648.667566621746;6658.3674550917585;6711.731530738716;6580.309067547839;6584.8024559263295;6614.503912206507;6675.098861653809;6703.162104736908;6633.270340262664;6653.73385064592;6659;6670.165704431321;6684.131062961978;5784.797532086357;5867.911981320369;5873.94126058751;5890.617109887844;6155.446009858955;6067.908981365194;6113.02191649334;6133.417325354084;6139.109829074849;6142.293636231711 20:16:07 INFO - PROCESS | 8287 | |4;prototype.html;329.4136437141887;339.4890689512284;340.4501729706523;340.9727221822254;345.75451429485065;6260.6869656517165;6273.5922165059355;6281.685915704214;6313.6211827290335;6400.583962042464;6259.843503912404;6280.968595157029;6319.494440444765;6319.526035547329;6334.208223972004;4754.833580824672;4758.238681810911;4763.095011947737;4763.404574428197;4790.640701947351;4758.262469317261;4758.547937945889;4767.880802979918;4774.708140092757;4775.164346239411;4642.396488456496;4721.622270218374;4723.976380118094;4736.59738922192;4739.052189562084;4713.316569097496;4717.080169366975;4739.691920025204;4748.311494833264;4756.8572942811425;4095.5904409558807;4096.836126554934;4096.9795151024055;4102.712810103294;4110.650594699454;5965.105234214859;6013.579049466539;6024.307204671475;6030.33666296707;6036.8188954331445;5421.322334708161;5560.499555040065;5565.332160140809;5570.637908535932;5571.1086226203615;6671.099401580773;6713.060171575935;6720.798376048726;6733.158355205599;6748.730050797963;4524.5701658342405;4558.202314594966;4562.338460923181;4566.315052742082;4579.839705610321;6750.797476075725;6920.204176519664;6965.686544105527;7002.334778196063;7005.579665220052;4580.0152967112235;4584.541545845389;4603.148417542765;4603.286490593963;4616.169089563844;4676.181668208118;4677.9942312403;4683.086798074342;4685.226937555333;4687.929681054787;5477.342718873681;5478.041342765;5480.534154596824;5480.835574932758;5483.588730845203;6577.704003319862;6649.867002659919;6663.833404164935;6718.529702920847;6739.865202696017;1618.0210972361788;1638.6313079557003;1639.6392793585392;1640.6062544989118;1665.0758828849862;1087.8912108789216;1100.510272928539;1104.0394856474918;1114.3091283404342;1125.808612535871;6186.072089186658;6267.62394256346;6300.590461620071;6306.779262725874;6326.746930122836;6820.829479263058;6869.519133660696;6881.13985751781;6886.586804791728;6890.724371025103;6171.259448866164;6303.2751233607805;6310.337414571496;6312.652804095727;6335.588186767845;3715.368387374153;3741.1769410729594;3743.6630703236838;3744.700423966076;3747;7101.396381307543;7118.216996130422;7121.928780712126;7134;7137.10786151731;6902.309769023058;6975.755848545378;6978.860422791618;7017.403520700797;7021.297870212938;7156.785296441115;7160.427165826722;7223;7237.384822290059;7261.346478816826;6965.930340696731;6968.721251149897;6984.825379365557;6993.335633114846;7005.964970175117;6741.932580674131;6822.795316140524;6854.931450685629;6896.689648965708;6912.55068420551;7143.607101609461;7229.963850180716;7233.819154521179;7237.963810180915;7255.310745479171;4640.976795116003;4646.256598944153;4659.697119687209;4686.367340409001;4697.13103075932;6840.965795170992;6974.337437943387;6984.3364880336285;6996.790096297119;7050.5769653820935;6790.72837086511;6807.285235050248;6808.421284190899;6822.215445223665;6826.863462730618;6777.254502004677;6813.625250611264;6815.386615204656;6819.69311380999;6829.590224586541;6516.413522782972;6639.668016599054;6664.366885145903;6680.331966803281;6681.365270299314;6773.661316934035;6808.319168083152;6817.284185160487;6822.897656535057;6831.555948863308;6637.535372523877;6644.800655980328;6645.302243264581;6656.5340426169705;6658.667066646745 20:16:07 INFO - PROCESS | 8287 | |5;yui.html;771.4060173666273;777.7472321495513;824.7278398128615;865.5974971638187;866.2420382165607;13069.542566010192;13098.738025239489;13148.737025259488;13216.207027578352;13244.801327980076;11756.7648647027;12096.213746106498;12219.083568732336;12686.555970541032;12766.106372553924;823.1932705948175;827.6275675945818;832.0389949608212;836.636063312458;853.4964371021097;834.1408349400127;838.0488145954325;839.5550358310105;843.6541018182546;845.3533047218882;877.6884206106804;884.7434244069212;885.3625389719424;887.928965682747;888.9377743557953;874.2263097158997;876.1545108969843;877.8419884420802;880.1858281089966;881.858902575588;645.5706954875003;645.8191706322237;651.9511036672269;652.2596852572317;652.9640869752162;13626.863731362659;13664.93167534156;13683.726325473435;13699.657508562266;13703.177809331472;12152.57465988695;12191.451384687622;12279.877201228051;12356.691082722913;12702.936485317514;10719.808276527321;10839.83740243897;10964.805372466111;10981.12151027916;11108.944455277753;3464.2378676691087;3498.3702933471964;3511.262634846685;3533.9116522086897;3555.8933232003083;45373.09253814938;45979.54020459786;46109.30836037462;46193;46205.53794462046;8669.739907802776;8802.955985220033;8850.911490885137;8868.822623547492;8955.955220223857;17580;17607.559811004572;17621.383251586132;17630.73553896667;17637.823621763873;7025;7138.643067846587;7141.285871412817;7169.426445884316;7419.443541734391;4218.957810421918;4236.110416812442;4241.936370954438;4262.70161088727;4389.561043895649;2924.1081470151807;2937.2656835791054;2951.5720220567896;2959.5856580078807;2962.70372962702;519.2782032974169;536.0832975611747;536.9919451208235;537.9858965849402;554.500949145764;609.5452614524391;612.5681394616785;627.4102343796816;652.7650045983443;693.5284006875272;8094.595270236465;8168.428210025241;8288.378371622153;8413.411061225777;8632.438891472035;585.7803323753592;599.8320470268332;605.8909396308707;606.848287928018;633.8954072577973;3797.4493698413576;3974.6224108709625;4064.5935406459707;4114.753114813121;4128.277551428488;52316;53034.73482632562;53358.733206333716;53552;55875;48431.757841210565;51689.224661630105;52192.739036305335;53569.57217113186;53747.73126134423;47676.761616192394;48090.27864582034;48143.75928120337;48314.75842620764;48742;8422.536760477988;8477.321814254721;8487.830243395221;8502.829943400973;8996.775080623036;35810.28379432449;36320.27359452849;36385;37233.25533489369;37375.439368410036;47096.29355559601;47226.527734722215;48296;48406.27390589214;48547.5145248543;10546.630867919586;10570.10154136907;10631.096356809758;10944.1791865612;11241.325520468798;10887.401192934465;11432.199746017699;11486.770264594494;11540.94229528847;11713.238639488405;9918.30571859963;10067.597296108073;10099.848502272325;10213.182945364502;10267.332623379756;10245.436500992517;10301.639442619473;10414.375137491776;10631.627893023708;10842.674719758419;11309.264897781617;11374.601888933848;11572.158555340844;11604.88395116038;12148.574799881962;8960.68637597681;9256.53717314145;9446.197073248575;9565.594139529932;9616.423014619146;8642.913570864212;8887.244584210415;9240.306976976619;9444.52777361143;9504.857427138737 20:16:07 INFO - PROCESS | 8287 | __end_tp_report 20:16:07 INFO - PROCESS | 8287 | __start_cc_report 20:16:07 INFO - PROCESS | 8287 | _x_x_mozilla_cycle_collect,305 20:16:07 INFO - PROCESS | 8287 | __end_cc_report 20:16:07 INFO - PROCESS | 8287 | __startTimestamp1451362567618__endTimestamp 20:16:07 INFO - PROCESS | 8287 | 20:16:07 INFO - PROCESS | 8287 | ------- Summary: start ------- 20:16:07 INFO - PROCESS | 8287 | Number of tests: 6 20:16:07 INFO - PROCESS | 8287 | 20:16:07 INFO - PROCESS | 8287 | [#0] dojo.html Cycles:165 Average:5389.27 Median:5654.69 stddev:606.51 (10.7%) stddev-sans-first:583.60 20:16:07 INFO - PROCESS | 8287 | Values: 3202.4 3209.4 3244.0 3251.0 3281.2 5228.8 5367.3 5409.8 5414.5 5425.3 5316.5 5360.5 5360.6 5376.5 5383.5 4872.8 4949.5 4957.7 5023.6 5030.3 4952.4 5016.6 5021.3 5024.8 5069.5 4517.9 4805.6 4817.8 4827.4 4849.5 4795.8 4835.2 4836.0 4853.3 4860.0 4821.3 4833.0 4834.9 4861.7 4868.6 5134.7 5140.9 5182.6 5189.4 5214.9 5759.4 5766.3 5769.1 5770.5 5797.5 5651.5 5818.5 5833.1 5859.2 5860.4 5411.1 5413.8 5424.5 5448.8 5472.9 5861.6 5911.9 5922.3 5927.5 5935.8 5657.9 5717.9 5723.5 5790.4 5794.1 5780.8 5786.1 5854.9 5859.4 5860.5 5773.1 5774.7 5783.2 5786.2 5827.7 5711.9 5774.3 5778.3 5782.1 5795.5 4328.3 4432.4 4451.7 4484.1 4532.9 4026.1 4031.9 4034.6 4035.7 4070.6 5479.5 5495.3 5504.8 5518.7 5541.1 5753.5 5772.9 5853.8 5859.5 5874.6 5412.5 5464.7 5467.3 5470.3 5475.6 4977.8 5048.2 5052.0 5075.1 5097.4 5901.4 5958.6 6016.0 6018.0 6029.5 5855.8 5869.1 5873.3 5876.7 5882.1 5834.2 5937.4 5981.5 6050.8 6067.2 5695.4 5748.0 5753.6 5760.3 5807.6 5842.9 5866.1 5880.9 5890.9 5907.9 5576.5 5626.7 5673.2 5739.9 5747.9 5734.3 5753.8 5759.5 5760.4 5805.1 5640.3 5648.0 5654.7 5655.3 5657.6 5563.2 5605.9 5691.5 5718.7 5726.0 5683.7 5689.6 5691.3 5698.7 5740.6 20:16:07 INFO - PROCESS | 8287 | 20:16:07 INFO - PROCESS | 8287 | [#1] ext.html Cycles:180 Average:46456.26 Median:194306.11 stddev:80048.93 (41.2%) stddev-sans-first:80199.45 20:16:07 INFO - PROCESS | 8287 | Values: 600.5 600.5 600.9 605.6 609.3 38076.0 38884.4 38905.2 38957.8 38977.4 42849.8 43494.6 43539.3 43807.3 43811.0 8633.6 8741.9 8759.5 8770.8 8774.4 8561.7 8675.0 8700.8 8715.1 8717.1 8675.9 8676.3 8761.6 8763.3 8765.6 8543.6 8567.8 8578.5 8600.4 8652.0 8560.6 8596.2 8619.3 8638.7 8680.1 38873.2 39615.6 39617.6 39660.2 39720.2 3296.5 3355.5 3361.6 3366.7 3495.1 29672.5 29867.4 30091.2 30128.1 30501.4 3793.4 3813.7 3815.3 3854.2 4001.1 195386.0 195628.0 196972.0 197207.0 197582.0 41336.2 41442.6 58542.0 58745.7 58886.0 40167.0 40594.4 40634.2 40644.0 40802.4 14718.8 15027.4 15043.1 15085.2 15090.0 12088.9 12128.2 12140.5 12141.8 12148.7 14229.3 14264.9 14301.3 14350.8 14367.4 5789.8 5927.9 6026.5 6038.9 6064.8 904.6 923.2 958.5 1086.9 1122.3 28323.4 28898.0 29026.1 29251.7 29350.4 953.1 1052.3 1098.4 1113.2 1125.7 16451.9 17233.8 17329.3 17387.9 17516.6 379973.0 383260.0 384420.0 384562.0 384758.0 55326.0 55479.4 55645.2 55743.7 56025.2 1291.5 1325.5 1326.7 1339.2 1355.5 29309.0 30427.5 31107.0 31700.8 32337.2 49987.8 50560.7 50609.5 50722.2 50770.7 301007.0 303438.0 306133.0 306237.0 306255.0 41101.4 43465.0 43952.3 44398.0 44693.8 39850.8 40075.8 40128.4 40924.0 40989.6 33897.5 34112.3 34290.7 34795.7 39859.0 35989.5 36598.8 39066.0 40104.2 40533.8 33666.7 33949.8 34161.0 34200.7 35981.3 30909.5 31841.4 32972.3 33051.5 33166.5 31926.8 33375.3 34534.5 34644.8 34884.3 20:16:07 INFO - PROCESS | 8287 | 20:16:07 INFO - PROCESS | 8287 | [#2] jquery.html Cycles:180 Average:24101.08 Median:17972.89 stddev:64790.29 (360.5%) stddev-sans-first:64947.50 20:16:07 INFO - PROCESS | 8287 | Values: 349.7 351.4 352.7 354.8 357.1 14207.6 15103.6 16382.4 17387.3 18068.1 11102.7 11507.7 16328.3 16469.7 16504.8 4911.2 5471.3 5473.8 5474.0 5474.5 5405.9 5411.8 5452.3 5457.1 5457.6 5003.6 5149.4 5289.3 5412.3 5427.5 5080.1 5120.8 5136.6 5149.9 5153.4 4925.2 5359.8 5371.7 5380.4 5380.8 19478.1 19625.7 20002.4 20082.6 20101.2 1965.5 2007.2 2059.1 2112.3 2222.2 11986.4 13152.3 13172.7 13208.1 13313.0 1651.3 1811.6 1815.9 1827.9 1928.3 52645.7 52935.7 53431.7 53531.5 56656.4 8935.8 9461.5 10009.0 10027.7 10094.5 12775.5 12912.5 12930.9 12931.4 12936.5 7619.3 7650.0 7656.3 7676.0 7689.7 7474.7 7519.2 7602.1 7625.6 7650.5 4404.1 4435.2 4473.8 4491.8 4498.1 1695.3 1723.2 1779.2 1834.4 1855.3 390.5 400.5 401.6 409.2 904.1 10133.7 10144.1 10144.6 10253.9 10457.2 411.0 413.8 433.0 440.7 444.7 5602.4 5664.0 5699.7 5702.5 5757.9 376254.0 381196.0 382793.0 384785.0 441118.0 83314.6 83383.6 86258.0 86500.6 86606.0 1139.2 1159.4 1162.3 1164.0 1168.3 15706.1 15798.6 15935.1 16044.0 16285.9 32333.4 32335.7 33809.8 34736.5 35591.0 36931.4 37347.4 37353.8 37881.0 38362.2 9167.6 9391.9 9455.2 9524.1 9831.6 16894.7 16897.4 17160.3 17615.1 17646.0 2792.8 13745.5 14669.6 14779.6 15043.8 13838.6 13888.7 14379.9 14417.9 14574.9 12510.3 14903.6 15159.9 15219.9 15321.5 9096.7 9264.0 9268.4 9337.2 9806.9 14373.5 14419.4 14736.0 14906.8 15238.5 20:16:07 INFO - PROCESS | 8287 | 20:16:07 INFO - PROCESS | 8287 | [#3] mootools.html Cycles:180 Average:5137.13 Median:5963.46 stddev:2650.35 (44.4%) stddev-sans-first:2643.40 20:16:07 INFO - PROCESS | 8287 | Values: 1464.3 1465.8 1644.8 1772.5 1791.3 6552.9 6635.9 7183.9 7350.8 7385.4 6928.5 7148.7 7318.9 7420.2 7431.1 2195.2 2210.1 2214.4 2215.6 2220.9 2216.8 2227.6 2313.4 2314.2 2316.1 2202.7 2223.8 2224.4 2224.9 2267.3 2195.0 2198.5 2215.4 2223.1 2229.0 2225.3 2263.1 2270.5 2271.5 2273.4 7338.4 7386.7 7443.7 7454.7 7469.7 4391.7 4461.0 4468.4 4469.8 4473.6 2860.1 2933.4 2935.9 2936.2 2963.6 903.5 911.4 935.1 935.1 937.6 10246.1 10382.9 10396.8 10414.6 10417.1 3971.0 3981.1 4003.8 4008.7 4102.1 9073.0 9077.9 9083.3 9087.3 9088.4 4533.0 4549.2 4550.5 4560.8 4563.6 4009.4 4066.3 4126.7 4214.4 4220.0 3379.4 3408.7 3416.7 3422.6 3432.9 1033.6 1034.8 1037.2 1042.1 1045.7 1297.9 1299.4 1315.8 1335.6 1339.5 6864.2 6909.3 7027.4 7070.9 7082.5 440.6 446.6 448.0 450.0 452.1 5537.1 5551.8 5554.7 5597.1 5605.3 8241.5 8300.3 8541.9 8597.5 8620.3 8457.9 8521.0 8533.9 8535.2 8587.5 6912.5 6933.3 6991.2 6997.9 7040.7 6736.7 6736.8 6742.2 6748.3 6751.7 7450.2 7545.0 7746.7 7817.5 7847.3 7677.6 7789.8 7871.8 7874.4 7940.0 5699.6 5745.9 6036.3 6270.9 6316.0 6986.1 6995.8 7031.8 7044.2 7056.1 6515.5 6586.4 6648.7 6658.4 6711.7 6580.3 6584.8 6614.5 6675.1 6703.2 6633.3 6653.7 6659.0 6670.2 6684.1 5784.8 5867.9 5873.9 5890.6 6155.4 6067.9 6113.0 6133.4 6139.1 6142.3 20:16:07 INFO - PROCESS | 8287 | 20:16:07 INFO - PROCESS | 8287 | [#4] prototype.html Cycles:180 Average:5579.08 Median:6308.56 stddev:1714.65 (27.2%) stddev-sans-first:1673.57 20:16:07 INFO - PROCESS | 8287 | Values: 329.4 339.5 340.5 341.0 345.8 6260.7 6273.6 6281.7 6313.6 6400.6 6259.8 6281.0 6319.5 6319.5 6334.2 4754.8 4758.2 4763.1 4763.4 4790.6 4758.3 4758.5 4767.9 4774.7 4775.2 4642.4 4721.6 4724.0 4736.6 4739.1 4713.3 4717.1 4739.7 4748.3 4756.9 4095.6 4096.8 4097.0 4102.7 4110.7 5965.1 6013.6 6024.3 6030.3 6036.8 5421.3 5560.5 5565.3 5570.6 5571.1 6671.1 6713.1 6720.8 6733.2 6748.7 4524.6 4558.2 4562.3 4566.3 4579.8 6750.8 6920.2 6965.7 7002.3 7005.6 4580.0 4584.5 4603.1 4603.3 4616.2 4676.2 4678.0 4683.1 4685.2 4687.9 5477.3 5478.0 5480.5 5480.8 5483.6 6577.7 6649.9 6663.8 6718.5 6739.9 1618.0 1638.6 1639.6 1640.6 1665.1 1087.9 1100.5 1104.0 1114.3 1125.8 6186.1 6267.6 6300.6 6306.8 6326.7 6820.8 6869.5 6881.1 6886.6 6890.7 6171.3 6303.3 6310.3 6312.7 6335.6 3715.4 3741.2 3743.7 3744.7 3747.0 7101.4 7118.2 7121.9 7134.0 7137.1 6902.3 6975.8 6978.9 7017.4 7021.3 7156.8 7160.4 7223.0 7237.4 7261.3 6965.9 6968.7 6984.8 6993.3 7006.0 6741.9 6822.8 6854.9 6896.7 6912.6 7143.6 7230.0 7233.8 7238.0 7255.3 4641.0 4646.3 4659.7 4686.4 4697.1 6841.0 6974.3 6984.3 6996.8 7050.6 6790.7 6807.3 6808.4 6822.2 6826.9 6777.3 6813.6 6815.4 6819.7 6829.6 6516.4 6639.7 6664.4 6680.3 6681.4 6773.7 6808.3 6817.3 6822.9 6831.6 6637.5 6644.8 6645.3 6656.5 6658.7 20:16:07 INFO - PROCESS | 8287 | 20:16:07 INFO - PROCESS | 8287 | [#5] yui.html Cycles:180 Average:13653.50 Median:48360.52 stddev:15971.52 (33.0%) stddev-sans-first:15987.03 20:16:07 INFO - PROCESS | 8287 | Values: 771.4 777.7 824.7 865.6 866.2 13069.5 13098.7 13148.7 13216.2 13244.8 11756.8 12096.2 12219.1 12686.6 12766.1 823.2 827.6 832.0 836.6 853.5 834.1 838.0 839.6 843.7 845.4 877.7 884.7 885.4 887.9 888.9 874.2 876.2 877.8 880.2 881.9 645.6 645.8 652.0 652.3 653.0 13626.9 13664.9 13683.7 13699.7 13703.2 12152.6 12191.5 12279.9 12356.7 12702.9 10719.8 10839.8 10964.8 10981.1 11108.9 3464.2 3498.4 3511.3 3533.9 3555.9 45373.1 45979.5 46109.3 46193.0 46205.5 8669.7 8803.0 8850.9 8868.8 8956.0 17580.0 17607.6 17621.4 17630.7 17637.8 7025.0 7138.6 7141.3 7169.4 7419.4 4219.0 4236.1 4241.9 4262.7 4389.6 2924.1 2937.3 2951.6 2959.6 2962.7 519.3 536.1 537.0 538.0 554.5 609.5 612.6 627.4 652.8 693.5 8094.6 8168.4 8288.4 8413.4 8632.4 585.8 599.8 605.9 606.8 633.9 3797.4 3974.6 4064.6 4114.8 4128.3 52316.0 53034.7 53358.7 53552.0 55875.0 48431.8 51689.2 52192.7 53569.6 53747.7 47676.8 48090.3 48143.8 48314.8 48742.0 8422.5 8477.3 8487.8 8502.8 8996.8 35810.3 36320.3 36385.0 37233.3 37375.4 47096.3 47226.5 48296.0 48406.3 48547.5 10546.6 10570.1 10631.1 10944.2 11241.3 10887.4 11432.2 11486.8 11540.9 11713.2 9918.3 10067.6 10099.8 10213.2 10267.3 10245.4 10301.6 10414.4 10631.6 10842.7 11309.3 11374.6 11572.2 11604.9 12148.6 8960.7 9256.5 9446.2 9565.6 9616.4 8642.9 8887.2 9240.3 9444.5 9504.9 20:16:07 INFO - PROCESS | 8287 | -------- Summary: end -------- 20:16:07 INFO - PROCESS | 8287 | 20:16:08 INFO - TEST-INFO | 8287: exit 0 20:16:08 INFO - TEST-OK | dromaeo_css | took 1110959ms 20:16:08 INFO - TEST-START | kraken 20:16:08 INFO - operating with platform_type : linux_ 20:16:08 INFO - Initialising browser for kraken test... 20:16:08 INFO - TEST-INFO | started process 8528 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLPhLZD/profile http://localhost:51866/getInfo.html) 20:16:12 INFO - PROCESS | 8528 | __metrics Screen width/height:1600/1200 20:16:12 INFO - PROCESS | 8528 | colorDepth:24 20:16:12 INFO - PROCESS | 8528 | Browser inner width/height: 1024/697 20:16:12 INFO - PROCESS | 8528 | __metrics 20:16:12 INFO - PROCESS | 8528 | 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:13 INFO - TEST-INFO | 8528: exit 0 20:16:13 INFO - Browser initialized. 20:16:13 INFO - Running cycle 1/1 for kraken test... 20:16:13 INFO - TEST-INFO | started process 8650 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLPhLZD/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:16:25 INFO - PROCESS | 8650 | RSS: Main: 149348352 20:16:25 INFO - PROCESS | 8650 | 20:16:28 INFO - PROCESS | 8650 | Cycle 1(1): loaded http://localhost:51866/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51866/tests/kraken/driver.html?testName=audio-beat-detection) 20:16:28 INFO - PROCESS | 8650 | RSS: Main: 150626304 20:16:28 INFO - PROCESS | 8650 | 20:16:31 INFO - PROCESS | 8650 | Cycle 1(1): loaded http://localhost:51866/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51866/tests/kraken/driver.html?testName=audio-dft) 20:16:31 INFO - PROCESS | 8650 | RSS: Main: 149524480 20:16:31 INFO - PROCESS | 8650 | 20:16:34 INFO - PROCESS | 8650 | Cycle 1(1): loaded http://localhost:51866/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51866/tests/kraken/driver.html?testName=audio-fft) 20:16:35 INFO - PROCESS | 8650 | RSS: Main: 145899520 20:16:35 INFO - PROCESS | 8650 | 20:16:37 INFO - PROCESS | 8650 | Cycle 1(1): loaded http://localhost:51866/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51866/tests/kraken/driver.html?testName=audio-oscillator) 20:16:38 INFO - PROCESS | 8650 | RSS: Main: 145391616 20:16:38 INFO - PROCESS | 8650 | 20:16:40 INFO - PROCESS | 8650 | Cycle 1(1): loaded http://localhost:51866/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51866/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:16:40 INFO - PROCESS | 8650 | RSS: Main: 146104320 20:16:40 INFO - PROCESS | 8650 | 20:16:43 INFO - PROCESS | 8650 | Cycle 1(1): loaded http://localhost:51866/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51866/tests/kraken/driver.html?testName=imaging-darkroom) 20:16:44 INFO - PROCESS | 8650 | RSS: Main: 146595840 20:16:44 INFO - PROCESS | 8650 | 20:16:47 INFO - PROCESS | 8650 | Cycle 1(1): loaded http://localhost:51866/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51866/tests/kraken/driver.html?testName=imaging-desaturate) 20:16:48 INFO - PROCESS | 8650 | RSS: Main: 148004864 20:16:48 INFO - PROCESS | 8650 | 20:16:51 INFO - PROCESS | 8650 | Cycle 1(1): loaded http://localhost:51866/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51866/tests/kraken/driver.html?testName=json-parse-financial) 20:16:51 INFO - PROCESS | 8650 | RSS: Main: 148221952 20:16:51 INFO - PROCESS | 8650 | 20:16:53 INFO - PROCESS | 8650 | Cycle 1(1): loaded http://localhost:51866/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51866/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:16:54 INFO - PROCESS | 8650 | RSS: Main: 147517440 20:16:54 INFO - PROCESS | 8650 | 20:16:55 INFO - PROCESS | 8650 | Cycle 1(1): loaded http://localhost:51866/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51866/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:16:56 INFO - PROCESS | 8650 | RSS: Main: 148496384 20:16:56 INFO - PROCESS | 8650 | 20:16:58 INFO - PROCESS | 8650 | Cycle 1(1): loaded http://localhost:51866/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51866/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:16:59 INFO - PROCESS | 8650 | RSS: Main: 148639744 20:16:59 INFO - PROCESS | 8650 | 20:17:01 INFO - PROCESS | 8650 | Cycle 1(1): loaded http://localhost:51866/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51866/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:17:02 INFO - PROCESS | 8650 | RSS: Main: 149147648 20:17:02 INFO - PROCESS | 8650 | 20:17:04 INFO - PROCESS | 8650 | Cycle 1(1): loaded http://localhost:51866/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51866/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:17:05 INFO - PROCESS | 8650 | RSS: Main: 148320256 20:17:05 INFO - PROCESS | 8650 | 20:17:07 INFO - PROCESS | 8650 | Cycle 1(1): loaded http://localhost:51866/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51866/tests/kraken/driver.html?testName=ai-astar) 20:17:07 INFO - PROCESS | 8650 | RSS: Main: 148275200 20:17:07 INFO - PROCESS | 8650 | 20:17:07 INFO - PROCESS | 8650 | __start_tp_report 20:17:07 INFO - PROCESS | 8650 | _x_x_mozilla_page_load 20:17:07 INFO - PROCESS | 8650 | _x_x_mozilla_page_load_details 20:17:07 INFO - PROCESS | 8650 | |i|pagename|runs| 20:17:07 INFO - PROCESS | 8650 | |0;ai-astar;112;107;112;120;111;125;110;110;111;113 20:17:07 INFO - PROCESS | 8650 | |1;audio-beat-detection;161;132;150;165;126;150;152;131;171;126 20:17:07 INFO - PROCESS | 8650 | |2;audio-dft;162;165;163;164;162;162;163;168;171;168 20:17:07 INFO - PROCESS | 8650 | |3;audio-fft;72;71;73;74;75;75;71;129;74;71 20:17:07 INFO - PROCESS | 8650 | |4;audio-oscillator;97;96;142;96;97;97;147;97;96;138 20:17:07 INFO - PROCESS | 8650 | |5;imaging-gaussian-blur;111;112;109;110;110;110;109;110;109;109 20:17:07 INFO - PROCESS | 8650 | |6;imaging-darkroom;148;146;147;145;147;148;146;147;146;147 20:17:07 INFO - PROCESS | 8650 | |7;imaging-desaturate;97;97;96;96;97;96;96;97;96;96 20:17:07 INFO - PROCESS | 8650 | |8;json-parse-financial;61;64;64;62;70;60;59;61;63;58 20:17:07 INFO - PROCESS | 8650 | |9;json-stringify-tinderbox;68;69;68;68;69;70;70;69;69;68 20:17:07 INFO - PROCESS | 8650 | |10;stanford-crypto-aes;93;87;86;87;86;87;86;86;92;91 20:17:07 INFO - PROCESS | 8650 | |11;stanford-crypto-ccm;128;126;125;126;120;126;128;127;123;126 20:17:07 INFO - PROCESS | 8650 | |12;stanford-crypto-pbkdf2;145;151;152;150;141;147;150;154;151;138 20:17:07 INFO - PROCESS | 8650 | |13;stanford-crypto-sha256-iterative;68;69;69;70;70;73;68;68;68;68 20:17:07 INFO - PROCESS | 8650 | __end_tp_report 20:17:07 INFO - PROCESS | 8650 | __start_cc_report 20:17:07 INFO - PROCESS | 8650 | _x_x_mozilla_cycle_collect,738 20:17:07 INFO - PROCESS | 8650 | __end_cc_report 20:17:07 INFO - PROCESS | 8650 | __startTimestamp1451362627402__endTimestamp 20:17:07 INFO - PROCESS | 8650 | 20:17:07 INFO - PROCESS | 8650 | ------- Summary: start ------- 20:17:07 INFO - PROCESS | 8650 | Number of tests: 14 20:17:07 INFO - PROCESS | 8650 | 20:17:07 INFO - PROCESS | 8650 | [#0] ai-astar Cycles:10 Average:113.10 Median:112.00 stddev:5.34 (4.8%) stddev-sans-first:5.65 20:17:07 INFO - PROCESS | 8650 | Values: 112.0 107.0 112.0 120.0 111.0 125.0 110.0 110.0 111.0 113.0 20:17:07 INFO - PROCESS | 8650 | 20:17:07 INFO - PROCESS | 8650 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:151.00 stddev:16.66 (11.0%) stddev-sans-first:16.81 20:17:07 INFO - PROCESS | 8650 | Values: 161.0 132.0 150.0 165.0 126.0 150.0 152.0 131.0 171.0 126.0 20:17:07 INFO - PROCESS | 8650 | 20:17:07 INFO - PROCESS | 8650 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.50 stddev:3.16 (1.9%) stddev-sans-first:3.18 20:17:07 INFO - PROCESS | 8650 | Values: 162.0 165.0 163.0 164.0 162.0 162.0 163.0 168.0 171.0 168.0 20:17:07 INFO - PROCESS | 8650 | 20:17:07 INFO - PROCESS | 8650 | [#3] audio-fft Cycles:10 Average:78.50 Median:73.50 stddev:17.82 (24.2%) stddev-sans-first:18.74 20:17:07 INFO - PROCESS | 8650 | Values: 72.0 71.0 73.0 74.0 75.0 75.0 71.0 129.0 74.0 71.0 20:17:07 INFO - PROCESS | 8650 | 20:17:07 INFO - PROCESS | 8650 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:96.50 stddev:22.21 (23.0%) stddev-sans-first:23.03 20:17:07 INFO - PROCESS | 8650 | Values: 97.0 96.0 142.0 96.0 97.0 97.0 147.0 97.0 96.0 138.0 20:17:07 INFO - PROCESS | 8650 | 20:17:07 INFO - PROCESS | 8650 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.99 (0.9%) stddev-sans-first:0.97 20:17:07 INFO - PROCESS | 8650 | Values: 111.0 112.0 109.0 110.0 110.0 110.0 109.0 110.0 109.0 109.0 20:17:07 INFO - PROCESS | 8650 | 20:17:07 INFO - PROCESS | 8650 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.95 (0.6%) stddev-sans-first:0.88 20:17:07 INFO - PROCESS | 8650 | Values: 148.0 146.0 147.0 145.0 147.0 148.0 146.0 147.0 146.0 147.0 20:17:07 INFO - PROCESS | 8650 | 20:17:07 INFO - PROCESS | 8650 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 20:17:07 INFO - PROCESS | 8650 | Values: 97.0 97.0 96.0 96.0 97.0 96.0 96.0 97.0 96.0 96.0 20:17:07 INFO - PROCESS | 8650 | 20:17:07 INFO - PROCESS | 8650 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:62.50 stddev:3.39 (5.4%) stddev-sans-first:3.57 20:17:07 INFO - PROCESS | 8650 | Values: 61.0 64.0 64.0 62.0 70.0 60.0 59.0 61.0 63.0 58.0 20:17:07 INFO - PROCESS | 8650 | 20:17:07 INFO - PROCESS | 8650 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.79 (1.1%) stddev-sans-first:0.78 20:17:07 INFO - PROCESS | 8650 | Values: 68.0 69.0 68.0 68.0 69.0 70.0 70.0 69.0 69.0 68.0 20:17:07 INFO - PROCESS | 8650 | 20:17:07 INFO - PROCESS | 8650 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:87.00 stddev:2.77 (3.2%) stddev-sans-first:2.30 20:17:07 INFO - PROCESS | 8650 | Values: 93.0 87.0 86.0 87.0 86.0 87.0 86.0 86.0 92.0 91.0 20:17:07 INFO - PROCESS | 8650 | 20:17:07 INFO - PROCESS | 8650 | [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:126.00 stddev:2.42 (1.9%) stddev-sans-first:2.39 20:17:07 INFO - PROCESS | 8650 | Values: 128.0 126.0 125.0 126.0 120.0 126.0 128.0 127.0 123.0 126.0 20:17:07 INFO - PROCESS | 8650 | 20:17:07 INFO - PROCESS | 8650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:150.50 stddev:5.13 (3.4%) stddev-sans-first:5.33 20:17:07 INFO - PROCESS | 8650 | Values: 145.0 151.0 152.0 150.0 141.0 147.0 150.0 154.0 151.0 138.0 20:17:07 INFO - PROCESS | 8650 | 20:17:07 INFO - PROCESS | 8650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:1.60 (2.3%) stddev-sans-first:1.64 20:17:07 INFO - PROCESS | 8650 | Values: 68.0 69.0 69.0 70.0 70.0 73.0 68.0 68.0 68.0 68.0 20:17:07 INFO - PROCESS | 8650 | -------- Summary: end -------- 20:17:07 INFO - PROCESS | 8650 | 20:17:08 INFO - TEST-INFO | 8650: exit 0 20:17:08 INFO - TEST-OK | kraken | took 60011ms 20:17:08 INFO - TEST-START | v8_7 20:17:08 INFO - operating with platform_type : linux_ 20:17:08 INFO - Initialising browser for v8_7 test... 20:17:08 INFO - TEST-INFO | started process 8940 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUuvSd6/profile http://localhost:51866/getInfo.html) 20:17:12 INFO - PROCESS | 8940 | __metrics Screen width/height:1600/1200 20:17:12 INFO - PROCESS | 8940 | colorDepth:24 20:17:12 INFO - PROCESS | 8940 | Browser inner width/height: 1024/697 20:17:12 INFO - PROCESS | 8940 | __metrics 20:17:13 INFO - PROCESS | 8940 | 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:17:13 INFO - TEST-INFO | 8940: exit 0 20:17:13 INFO - Browser initialized. 20:17:13 INFO - Running cycle 1/1 for v8_7 test... 20:17:13 INFO - TEST-INFO | started process 9060 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUuvSd6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:17:25 INFO - PROCESS | 9060 | RSS: Main: 149196800 20:17:25 INFO - PROCESS | 9060 | 20:17:47 INFO - PROCESS | 9060 | Cycle 1(1): loaded http://localhost:51866/tests/v8_7/run.html (next: http://localhost:51866/tests/v8_7/run.html) 20:17:47 INFO - PROCESS | 9060 | RSS: Main: 145936384 20:17:47 INFO - PROCESS | 9060 | 20:17:47 INFO - PROCESS | 9060 | __start_tp_report 20:17:47 INFO - PROCESS | 9060 | _x_x_mozilla_page_load 20:17:47 INFO - PROCESS | 9060 | _x_x_mozilla_page_load_details 20:17:47 INFO - PROCESS | 9060 | |i|pagename|runs| 20:17:47 INFO - PROCESS | 9060 | |0;Richards;166.38935108153078 20:17:47 INFO - PROCESS | 9060 | |1;DeltaBlue;190.98548510313216 20:17:47 INFO - PROCESS | 9060 | |2;Encrypt;280.42624789680315 20:17:47 INFO - PROCESS | 9060 | |3;Decrypt;5202.072538860104 20:17:47 INFO - PROCESS | 9060 | |4;RayTrace;1075.268817204301 20:17:47 INFO - PROCESS | 9060 | |5;Earley;709.4259390503189 20:17:47 INFO - PROCESS | 9060 | |6;Boyer;12395.061728395061 20:17:47 INFO - PROCESS | 9060 | |7;RegExp;25475 20:17:47 INFO - PROCESS | 9060 | |8;Splay;588.6150234741784 20:17:47 INFO - PROCESS | 9060 | |9;NavierStokes;4845.410628019324 20:17:47 INFO - PROCESS | 9060 | __end_tp_report 20:17:47 INFO - PROCESS | 9060 | __startTimestamp1451362667419__endTimestamp 20:17:47 INFO - PROCESS | 9060 | 20:17:47 INFO - PROCESS | 9060 | ------- Summary: start ------- 20:17:47 INFO - PROCESS | 9060 | Number of tests: 10 20:17:47 INFO - PROCESS | 9060 | 20:17:47 INFO - PROCESS | 9060 | [#0] Richards Cycles:1 Average:166.39 Median:166.39 stddev:0.00 (0.0%) 20:17:47 INFO - PROCESS | 9060 | Values: 166.4 20:17:47 INFO - PROCESS | 9060 | 20:17:47 INFO - PROCESS | 9060 | [#1] DeltaBlue Cycles:1 Average:190.99 Median:190.99 stddev:0.00 (0.0%) 20:17:47 INFO - PROCESS | 9060 | Values: 191.0 20:17:47 INFO - PROCESS | 9060 | 20:17:47 INFO - PROCESS | 9060 | [#2] Encrypt Cycles:1 Average:280.43 Median:280.43 stddev:0.00 (0.0%) 20:17:47 INFO - PROCESS | 9060 | Values: 280.4 20:17:47 INFO - PROCESS | 9060 | 20:17:47 INFO - PROCESS | 9060 | [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 20:17:47 INFO - PROCESS | 9060 | Values: 5202.1 20:17:47 INFO - PROCESS | 9060 | 20:17:47 INFO - PROCESS | 9060 | [#4] RayTrace Cycles:1 Average:1075.27 Median:1075.27 stddev:0.00 (0.0%) 20:17:47 INFO - PROCESS | 9060 | Values: 1075.3 20:17:47 INFO - PROCESS | 9060 | 20:17:47 INFO - PROCESS | 9060 | [#5] Earley Cycles:1 Average:709.43 Median:709.43 stddev:0.00 (0.0%) 20:17:47 INFO - PROCESS | 9060 | Values: 709.4 20:17:47 INFO - PROCESS | 9060 | 20:17:47 INFO - PROCESS | 9060 | [#6] Boyer Cycles:1 Average:12395.06 Median:12395.06 stddev:0.00 (0.0%) 20:17:47 INFO - PROCESS | 9060 | Values: 12395.1 20:17:47 INFO - PROCESS | 9060 | 20:17:47 INFO - PROCESS | 9060 | [#7] RegExp Cycles:1 Average:25475.00 Median:25475.00 stddev:0.00 (0.0%) 20:17:47 INFO - PROCESS | 9060 | Values: 25475.0 20:17:47 INFO - PROCESS | 9060 | 20:17:47 INFO - PROCESS | 9060 | [#8] Splay Cycles:1 Average:588.62 Median:588.62 stddev:0.00 (0.0%) 20:17:47 INFO - PROCESS | 9060 | Values: 588.6 20:17:47 INFO - PROCESS | 9060 | 20:17:47 INFO - PROCESS | 9060 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 20:17:47 INFO - PROCESS | 9060 | Values: 4845.4 20:17:47 INFO - PROCESS | 9060 | -------- Summary: end -------- 20:17:47 INFO - PROCESS | 9060 | 20:17:48 INFO - TEST-INFO | 9060: exit 0 20:17:48 INFO - TEST-OK | v8_7 | took 39960ms 20:17:48 INFO - SUITE-END | took 1210s 20:17:48 INFO - Completed test suite (00:20:11) 20:17:48 INFO - Working with test: dromaeo_css 20:17:48 INFO - Generating results file: dromaeo_css 20:17:48 INFO - Working with test: kraken 20:17:48 INFO - Generating results file: kraken 20:17:48 INFO - javascript benchmark 20:17:48 INFO - Working with test: v8_7 20:17:48 INFO - Generating results file: v8_7 20:17:48 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:17:48 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 20:17:48 INFO - process_Request line: dromaeo_css 6856.51 graph.html#tests=[[72,64,43]] 20:17:48 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:17:48 INFO - process_Request line: kraken 1527.70 graph.html#tests=[[232,64,43]] 20:17:48 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:17:48 INFO - process_Request line: v8_7 21338.82 graph.html#tests=[[230,64,43]] 20:17:48 INFO - RETURN: dromaeo_css: 6856.51 20:17:48 INFO - RETURN: kraken: 1527.70 20:17:48 INFO - RETURN: v8_7: 21338.82 20:17:48 INFO - javascript benchmark 20:17:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3202.4075546023973, 3209.4383482890494, 3244.0267919624116, 3250.9674903250975, 3281.2125089978413, 5228.79084836606, 5367.275417818598, 5409.756560954756, 5414.512693857552, 5425.321834770653, 5316.548093412055, 5360.544353729938, 5360.597955153359, 5376.489233522819, 5383.542398896088, 4872.805087796484, 4949.529794669518, 4957.677750946177, 5023.648344615878, 5030.270610761438, 4952.405711314647, 5016.623753218505, 5021.271915572258, 5024.82413115541, 5069.467705890884, 4517.864464066083, 4805.591524720403, 4817.831375901862, 4827.420709514846, 4849.490803465638, 4795.808167673289, 4835.153848076572, 4835.951640483585, 4853.344798452199, 4860.027994401134, 4821.300911367867, 4832.975835120802, 4834.903301933977, 4861.73260470674, 4868.586170175539, 5134.691918484903, 5140.948590514085, 5182.611304152204, 5189.42916279209, 5214.921776173361, 5759.366469688331, 5766.279215098113, 5769.07694768835, 5770.538356931435, 5797.4782269595935, 5651.519620832234, 5818.4763371296785, 5833.095870140135, 5859.209006784072, 5860.413958604148, 5411.134218525057, 5413.756380962866, 5424.538914192299, 5448.83653490396, 5472.863178420532, 5861.560382971209, 5911.881762364728, 5922.318933322636, 5927.525797936155, 5935.821925342247, 5657.886842263131, 5717.914231286534, 5723.54211663066, 5790.392008839095, 5794.1308803679785, 5780.797672081457, 5786.103154011135, 5854.882902342015, 5859.355470898197, 5860.531157507389, 5773.134029895549, 5774.711264436762, 5783.161441590946, 5786.189933409326, 5827.650340979555, 5711.942880571224, 5774.3070831499645, 5778.335491418541, 5782.10377391505, 5795.507381872504, 4328.329108988112, 4432.423784907941, 4451.732896026248, 4484.1255955088445, 4532.909341813145, 4026.1142548639255, 4031.858884939013, 4034.576369481162, 4035.7174997749876, 4070.633642972147, 5479.506844384025, 5495.258140151029, 5504.779808807683, 5518.696471694096, 5541.058020136506, 5753.4821866031425, 5772.94227057724, 5853.795117170878, 5859.472647461749, 5874.618149820248, 5412.458754124556, 5464.699441530754, 5467.343918729698, 5470.343558772973, 5475.561955043587, 4977.800887964513, 5048.188617593767, 5052.0, 5075.137226671474, 5097.439281679012, 5901.380355062656, 5958.612690175125, 6015.969920150459, 6018.037114061729, 6029.517638588903, 5855.795047173328, 5869.06095024794, 5873.295204575478, 5876.735546900485, 5882.058870580687, 5834.241548598655, 5937.376575459687, 5981.521478281814, 6050.757969681164, 6067.180930574493, 5695.373508914099, 5748.0, 5753.597248192586, 5760.279965004374, 5807.593468457337, 5842.883142337045, 5866.149408335682, 5880.911786323294, 5890.911636325544, 5907.940920590739, 5576.498115169492, 5626.662400255997, 5673.205751194753, 5739.942600573941, 5747.942520574741, 5734.254546908875, 5753.798617048383, 5759.481646651821, 5760.395158508296, 5805.129230615442, 5640.323161220515, 5648.0, 5654.688992105309, 5655.349634791887, 5657.632253903483, 5563.221149039218, 5605.859853503695, 5691.516221121251, 5718.656880587178, 5726.0, 5683.7442315095095, 5689.573282003949, 5691.288588926384, 5698.715064246854, 5740.569457290803], "unit": "score", "name": "dojo.html", "value": 5349.496552652825}, {"lowerIsBetter": false, "replicates": [600.4505877122433, 600.4715850051954, 600.8678090820018, 605.627539063476, 609.3327806052371, 38076.0, 38884.41673374898, 38905.22189556207, 38957.80521097391, 38977.415338769904, 42849.7857510712, 43494.56505434945, 43539.3469097963, 43807.34288985668, 43811.0, 8633.611487483078, 8741.868871966926, 8759.51822649754, 8770.780730481758, 8774.429662071945, 8561.657533698644, 8674.956625216897, 8700.782480437976, 8715.128487151298, 8717.084706105863, 8675.913240867574, 8676.349273804459, 8761.649534018632, 8763.298936085097, 8765.561721913911, 8543.615537300868, 8567.785805354853, 8578.528180950045, 8600.35497337696, 8652.0, 8560.61477233526, 8596.2263396294, 8619.310455163572, 8638.65445382184, 8680.131986801332, 38873.222535549416, 39615.60384396148, 39617.60382396168, 39660.20679586421, 39720.20559588792, 3296.538484612156, 3355.5302257683943, 3361.5629968104236, 3366.6633336666137, 3495.0912762681887, 29672.519606190683, 29867.40265194684, 30091.247718806986, 30128.09615711532, 30501.389972200654, 3793.407333326719, 3813.733038687293, 3815.313243616148, 3854.2291541691775, 4001.099752555681, 195386.0, 195628.0, 196971.99999999857, 197207.0, 197582.0, 41336.1732765349, 41442.58557414387, 58542.0, 58745.70627146837, 58886.0, 40167.0, 40594.391084133764, 40634.18731625351, 40644.0, 40802.38796418056, 14718.779218311734, 15027.398904043934, 15043.097414155185, 15085.24573771329, 15090.0, 12088.879111208951, 12128.211666241843, 12140.453679584263, 12141.817872731915, 12148.696282593006, 14229.28853557318, 14264.85735142656, 14301.28493575317, 14350.784738228935, 14367.425302987764, 5789.797357092481, 5927.911081333784, 6026.45761881424, 6038.939610603926, 6064.787732429344, 904.556767184075, 923.2337160157053, 958.4536814016084, 1086.918481113904, 1122.3490375582144, 28323.433531329258, 28898.0, 29026.12921612355, 29251.707482925325, 29350.412991740046, 953.1374106433689, 1052.2686732720686, 1098.4288170151476, 1113.2263077161458, 1125.6960620632383, 16451.91774041122, 17233.827661723473, 17329.306827727003, 17387.913060434617, 17516.5620859477, 379973.0, 383260.0, 384420.0, 384562.0, 384758.0, 55326.0, 55479.44520554823, 55645.165322520195, 55743.72128139334, 56025.15962260569, 1291.5027714330051, 1325.5029363988504, 1326.6683329167709, 1339.163023110556, 1355.5391167003265, 29309.0, 30427.54358684577, 31107.0, 31700.841495792374, 32337.191570210933, 49987.75006124946, 50560.74719626379, 50609.49390506195, 50722.2391664118, 50770.74614626903, 301007.0, 303438.0, 306133.0, 306237.0, 306255.0, 41101.383479248434, 43465.0, 43952.34071488866, 44398.0, 44693.776531118434, 39850.800745996086, 40075.79962100171, 40128.39807402833, 40924.0, 40989.59010409858, 33897.49153762646, 34112.31775364429, 34290.657093428745, 34795.65204347924, 39859.0, 35989.460158098176, 36598.8170059148, 39066.0, 40104.19791604093, 40533.79733101316, 33666.663333366356, 33949.83025084859, 34161.0, 34200.65799341975, 35981.28037439289, 30909.49988753111, 31841.363172736877, 32972.34055318928, 33051.504227437086, 33166.502502462, 31926.840365798023, 33375.33249334951, 34534.48198276978, 34644.82677586697, 34884.30231395409], "unit": "score", "name": "ext.html", "value": 18368.451859593566}, {"lowerIsBetter": false, "replicates": [349.7202238209433, 351.4096318185448, 352.652637152405, 354.7711725936771, 357.1090130125337, 14207.57377278682, 15103.622409439757, 16382.42661506846, 17387.304507819674, 18068.09659517022, 11102.722431939206, 11507.654770356881, 16328.34686612537, 16469.67060658789, 16504.75242871358, 4911.189653707134, 5471.316085489314, 5473.781048758045, 5474.042042642542, 5474.507294343508, 5405.945940540583, 5411.783528658869, 5452.318460192476, 5457.072297709379, 5457.563394928416, 5003.649744517885, 5149.40781810091, 5289.259503669489, 5412.296401467804, 5427.48438898304, 5080.060188865072, 5120.846374608767, 5136.64043516954, 5149.922751158736, 5153.433122356557, 4925.21196608541, 5359.785608575652, 5371.650842695212, 5380.408155102936, 5380.838574842761, 19478.12348444309, 19625.705614415794, 20002.39992800218, 20082.598348033105, 20101.195952161896, 1965.4791480257743, 2007.1569940624827, 2059.1351632314463, 2112.313498113104, 2222.244436891465, 11986.401647683582, 13152.342382880817, 13172.6706832329, 13208.075434719574, 13313.0, 1651.3229575873834, 1811.5923917118675, 1815.8638102142393, 1827.9268829246946, 1928.267258441783, 52645.73677131628, 52935.73532132353, 53431.732841335936, 53531.464685353036, 56656.43343566594, 8935.776605584782, 9461.52692365379, 10008.999100090079, 10027.749306267402, 10094.545745441326, 12775.488980440865, 12912.548060818015, 12930.935345323402, 12931.418086186144, 12936.547220847226, 7619.276168763959, 7650.0, 7656.349210317186, 7676.040494938133, 7689.6539655714505, 7474.70101195957, 7519.248075192437, 7602.087749469988, 7625.618719064136, 7650.464467487333, 4404.11917616478, 4435.2016637005645, 4473.798679059385, 4491.797869095899, 4498.05540836428, 1695.3303445139102, 1723.2159367487764, 1779.2082523277277, 1834.3671433355737, 1855.3228071753713, 390.54111419082466, 400.54738145894953, 401.5783427401217, 409.1836785612662, 904.1184844776291, 10133.695989120339, 10144.087032166994, 10144.644937427302, 10253.897461025443, 10457.163426925828, 411.04432195146404, 413.8365345688436, 433.0386541877028, 440.6915159388377, 444.7198265092971, 5602.411746766612, 5664.0, 5699.686517241592, 5702.54379649627, 5757.884842303214, 376254.0, 381196.0, 382793.0, 384785.0, 441118.0, 83314.58342708247, 83383.5830820842, 86258.0, 86500.56749716337, 86606.0, 1139.1684070628487, 1159.368144361325, 1162.2968104296947, 1163.9709007274887, 1168.2990205876577, 15706.136162510715, 15798.60503487422, 15935.12356820386, 16044.0, 16285.918570407071, 32333.35333293368, 32335.676643233266, 33809.83095084509, 34736.47895281624, 35591.0, 36931.446028310136, 37347.43978840374, 37353.81323093367, 37881.0, 38362.23275534529, 9167.587458564247, 9391.872975243015, 9455.243580513405, 9524.14282714559, 9831.606735730491, 16894.746578801572, 16897.408590699266, 17160.313587456363, 17615.119244038004, 17646.0, 2792.7905407094145, 13745.532701871733, 14669.633259168606, 14779.556613301618, 15043.849561504683, 13838.584842454742, 13888.652783680489, 14379.928100359431, 14417.92791036038, 14574.85425145735, 12510.311932843417, 14903.627409314853, 15159.924200379368, 15219.923900380427, 15321.463748769185, 9096.681616143404, 9263.953680231556, 9268.443893366419, 9337.159655631025, 9806.85289720669, 14373.496927607484, 14419.423223071379, 14736.0, 14906.776398353817, 15238.542843714706], "unit": "score", "name": "jquery.html", "value": 8129.539428519698}, {"lowerIsBetter": false, "replicates": [1464.253230852265, 1465.7508223601988, 1644.8355164483553, 1772.5480002599336, 1791.3103455169755, 6552.868942621145, 6635.933640663592, 7183.89224161638, 7350.779476615703, 7385.409167266619, 6928.549644273119, 7148.678309476073, 7318.853622927551, 7420.183779784219, 7431.145418276899, 2195.2316689158824, 2210.149092599345, 2214.357836227492, 2215.5679642469727, 2220.911163553464, 2216.822654187661, 2227.5767604155158, 2313.363824948144, 2314.2478694424294, 2316.131450705985, 2202.658587918867, 2223.766504517019, 2224.354937068248, 2224.92212772553, 2267.3424706835, 2194.9780502195094, 2198.483356411242, 2215.4129155773735, 2223.132978138527, 2228.9665655015187, 2225.321277010511, 2263.0834512022657, 2270.545890821842, 2271.4775601611555, 2273.4089136824377, 7338.4496162788, 7386.667599957961, 7443.739469118609, 7454.664540095709, 7469.701211951516, 4391.67062470316, 4460.977695111536, 4468.374427580141, 4469.843555475575, 4473.642108631334, 2860.127661063375, 2933.398653276073, 2935.853207339646, 2936.192547049557, 2963.5554666799935, 903.5075883643365, 911.4349103555771, 935.1023017902821, 935.1396715022196, 937.6062053937362, 10246.129079028291, 10382.896171038268, 10396.84404733922, 10414.635487757967, 10417.114545263661, 3971.0270983609203, 3981.1440540283397, 4003.7597744134864, 4008.6993475489453, 4102.077032667686, 9072.954635226914, 9077.863832042525, 9083.318751093695, 9087.273018158663, 9088.409253398508, 4532.977335113369, 4549.203889319356, 4550.47669518003, 4560.817567297271, 4563.612092972135, 4009.3985902114914, 4066.3493840985893, 4126.690498212586, 4214.431051808028, 4219.957800421957, 3379.425497665403, 3408.6761757632985, 3416.7095796857047, 3422.6235114137426, 3432.8798492053156, 1033.6278939581744, 1034.8447732839984, 1037.180627304421, 1042.0673497219946, 1045.7333379988206, 1297.863724308953, 1299.4477347127433, 1315.83552055993, 1335.5859683498147, 1339.4709089909431, 6864.176298844171, 6909.309069093151, 7027.367536921702, 7070.8939365909555, 7082.5396349237135, 440.58364845220956, 446.5712915601059, 447.98432054877924, 449.99325010124875, 452.116112999086, 5537.058700021006, 5551.7779288828, 5554.72226388679, 5597.132444471114, 5605.299337582802, 8241.50550966944, 8300.252977232078, 8541.871871921927, 8597.484150950962, 8620.310375169971, 8457.915420845837, 8521.0, 8533.871991920127, 8535.189157030196, 8587.527685977331, 6912.516123871281, 6933.2720064393525, 6991.19601245853, 6997.895031574531, 7040.683169257396, 6736.6968486417245, 6736.7642132525125, 6742.157230346207, 6748.257691654012, 6751.729930802713, 7450.180480147071, 7545.0, 7746.690132394867, 7817.452778305464, 7847.293743563107, 7677.577733224726, 7789.766307010798, 7871.803204919923, 7874.409419293462, 7940.0, 5699.5725320600295, 5745.91381129275, 6036.305824830025, 6270.9372906270355, 6316.0, 6986.056882320821, 6995.79012629622, 7031.753888613874, 7044.189918159477, 7056.082709247765, 6515.478761699147, 6586.37429444202, 6648.667566621746, 6658.3674550917585, 6711.731530738716, 6580.309067547839, 6584.8024559263295, 6614.503912206507, 6675.098861653809, 6703.162104736908, 6633.270340262664, 6653.73385064592, 6659.0, 6670.165704431321, 6684.131062961978, 5784.797532086357, 5867.911981320369, 5873.94126058751, 5890.617109887844, 6155.446009858955, 6067.908981365194, 6113.02191649334, 6133.417325354084, 6139.109829074849, 6142.293636231711], "unit": "score", "name": "mootools.html", "value": 4174.657089325633}, {"lowerIsBetter": false, "replicates": [329.4136437141887, 339.4890689512284, 340.4501729706523, 340.9727221822254, 345.75451429485065, 6260.6869656517165, 6273.5922165059355, 6281.685915704214, 6313.6211827290335, 6400.583962042464, 6259.843503912404, 6280.968595157029, 6319.494440444765, 6319.526035547329, 6334.208223972004, 4754.833580824672, 4758.238681810911, 4763.095011947737, 4763.404574428197, 4790.640701947351, 4758.262469317261, 4758.547937945889, 4767.880802979918, 4774.708140092757, 4775.164346239411, 4642.396488456496, 4721.622270218374, 4723.976380118094, 4736.59738922192, 4739.052189562084, 4713.316569097496, 4717.080169366975, 4739.691920025204, 4748.311494833264, 4756.8572942811425, 4095.5904409558807, 4096.836126554934, 4096.9795151024055, 4102.712810103294, 4110.650594699454, 5965.105234214859, 6013.579049466539, 6024.307204671475, 6030.33666296707, 6036.8188954331445, 5421.322334708161, 5560.499555040065, 5565.332160140809, 5570.637908535932, 5571.1086226203615, 6671.099401580773, 6713.060171575935, 6720.798376048726, 6733.158355205599, 6748.730050797963, 4524.5701658342405, 4558.202314594966, 4562.338460923181, 4566.315052742082, 4579.839705610321, 6750.797476075725, 6920.204176519664, 6965.686544105527, 7002.334778196063, 7005.579665220052, 4580.0152967112235, 4584.541545845389, 4603.148417542765, 4603.286490593963, 4616.169089563844, 4676.181668208118, 4677.9942312403, 4683.086798074342, 4685.226937555333, 4687.929681054787, 5477.342718873681, 5478.041342765, 5480.534154596824, 5480.835574932758, 5483.588730845203, 6577.704003319862, 6649.867002659919, 6663.833404164935, 6718.529702920847, 6739.865202696017, 1618.0210972361788, 1638.6313079557003, 1639.6392793585392, 1640.6062544989118, 1665.0758828849862, 1087.8912108789216, 1100.510272928539, 1104.0394856474918, 1114.3091283404342, 1125.808612535871, 6186.072089186658, 6267.62394256346, 6300.590461620071, 6306.779262725874, 6326.746930122836, 6820.829479263058, 6869.519133660696, 6881.13985751781, 6886.586804791728, 6890.724371025103, 6171.259448866164, 6303.2751233607805, 6310.337414571496, 6312.652804095727, 6335.588186767845, 3715.368387374153, 3741.1769410729594, 3743.6630703236838, 3744.700423966076, 3747.0, 7101.396381307543, 7118.216996130422, 7121.928780712126, 7134.0, 7137.10786151731, 6902.309769023058, 6975.755848545378, 6978.860422791618, 7017.403520700797, 7021.297870212938, 7156.785296441115, 7160.427165826722, 7223.0, 7237.384822290059, 7261.346478816826, 6965.930340696731, 6968.721251149897, 6984.825379365557, 6993.335633114846, 7005.964970175117, 6741.932580674131, 6822.795316140524, 6854.931450685629, 6896.689648965708, 6912.55068420551, 7143.607101609461, 7229.963850180716, 7233.819154521179, 7237.963810180915, 7255.310745479171, 4640.976795116003, 4646.256598944153, 4659.697119687209, 4686.367340409001, 4697.13103075932, 6840.965795170992, 6974.337437943387, 6984.3364880336285, 6996.790096297119, 7050.5769653820935, 6790.72837086511, 6807.285235050248, 6808.421284190899, 6822.215445223665, 6826.863462730618, 6777.254502004677, 6813.625250611264, 6815.386615204656, 6819.69311380999, 6829.590224586541, 6516.413522782972, 6639.668016599054, 6664.366885145903, 6680.331966803281, 6681.365270299314, 6773.661316934035, 6808.319168083152, 6817.284185160487, 6822.897656535057, 6831.555948863308, 6637.535372523877, 6644.800655980328, 6645.302243264581, 6656.5340426169705, 6658.667066646745], "unit": "score", "name": "prototype.html", "value": 5014.244851394059}, {"lowerIsBetter": false, "replicates": [771.4060173666273, 777.7472321495513, 824.7278398128615, 865.5974971638187, 866.2420382165607, 13069.542566010192, 13098.738025239489, 13148.737025259488, 13216.207027578352, 13244.801327980076, 11756.7648647027, 12096.213746106498, 12219.083568732336, 12686.555970541032, 12766.106372553924, 823.1932705948175, 827.6275675945818, 832.0389949608212, 836.636063312458, 853.4964371021097, 834.1408349400127, 838.0488145954325, 839.5550358310105, 843.6541018182546, 845.3533047218882, 877.6884206106804, 884.7434244069212, 885.3625389719424, 887.928965682747, 888.9377743557953, 874.2263097158997, 876.1545108969843, 877.8419884420802, 880.1858281089966, 881.858902575588, 645.5706954875003, 645.8191706322237, 651.9511036672269, 652.2596852572317, 652.9640869752162, 13626.863731362659, 13664.93167534156, 13683.726325473435, 13699.657508562266, 13703.177809331472, 12152.57465988695, 12191.451384687622, 12279.877201228051, 12356.691082722913, 12702.936485317514, 10719.808276527321, 10839.83740243897, 10964.805372466111, 10981.12151027916, 11108.944455277753, 3464.2378676691087, 3498.3702933471964, 3511.262634846685, 3533.9116522086897, 3555.8933232003083, 45373.09253814938, 45979.54020459786, 46109.30836037462, 46193.0, 46205.53794462046, 8669.739907802776, 8802.955985220033, 8850.911490885137, 8868.822623547492, 8955.955220223857, 17580.0, 17607.559811004572, 17621.383251586132, 17630.73553896667, 17637.823621763873, 7025.0, 7138.643067846587, 7141.285871412817, 7169.426445884316, 7419.443541734391, 4218.957810421918, 4236.110416812442, 4241.936370954438, 4262.70161088727, 4389.561043895649, 2924.1081470151807, 2937.2656835791054, 2951.5720220567896, 2959.5856580078807, 2962.70372962702, 519.2782032974169, 536.0832975611747, 536.9919451208235, 537.9858965849402, 554.500949145764, 609.5452614524391, 612.5681394616785, 627.4102343796816, 652.7650045983443, 693.5284006875272, 8094.595270236465, 8168.428210025241, 8288.378371622153, 8413.411061225777, 8632.438891472035, 585.7803323753592, 599.8320470268332, 605.8909396308707, 606.848287928018, 633.8954072577973, 3797.4493698413576, 3974.6224108709625, 4064.5935406459707, 4114.753114813121, 4128.277551428488, 52316.0, 53034.73482632562, 53358.733206333716, 53552.0, 55875.0, 48431.757841210565, 51689.224661630105, 52192.739036305335, 53569.57217113186, 53747.73126134423, 47676.761616192394, 48090.27864582034, 48143.75928120337, 48314.75842620764, 48742.0, 8422.536760477988, 8477.321814254721, 8487.830243395221, 8502.829943400973, 8996.775080623036, 35810.28379432449, 36320.27359452849, 36385.0, 37233.25533489369, 37375.439368410036, 47096.29355559601, 47226.527734722215, 48296.0, 48406.27390589214, 48547.5145248543, 10546.630867919586, 10570.10154136907, 10631.096356809758, 10944.1791865612, 11241.325520468798, 10887.401192934465, 11432.199746017699, 11486.770264594494, 11540.94229528847, 11713.238639488405, 9918.30571859963, 10067.597296108073, 10099.848502272325, 10213.182945364502, 10267.332623379756, 10245.436500992517, 10301.639442619473, 10414.375137491776, 10631.627893023708, 10842.674719758419, 11309.264897781617, 11374.601888933848, 11572.158555340844, 11604.88395116038, 12148.574799881962, 8960.68637597681, 9256.53717314145, 9446.197073248575, 9565.594139529932, 9616.423014619146, 8642.913570864212, 8887.244584210415, 9240.306976976619, 9444.52777361143, 9504.857427138737], "unit": "score", "name": "yui.html", "value": 6212.989019753853}], "name": "dromaeo_css", "value": 6856.505782463926}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 112.0, 120.0, 111.0, 125.0, 110.0, 110.0, 111.0, 113.0], "unit": "score", "name": "ai-astar", "value": 113.1}, {"lowerIsBetter": true, "replicates": [161.0, 132.0, 150.0, 165.0, 126.0, 150.0, 152.0, 131.0, 171.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 146.4}, {"lowerIsBetter": true, "replicates": [162.0, 165.0, 163.0, 164.0, 162.0, 162.0, 163.0, 168.0, 171.0, 168.0], "unit": "score", "name": "audio-dft", "value": 164.8}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 73.0, 74.0, 75.0, 75.0, 71.0, 129.0, 74.0, 71.0], "unit": "score", "name": "audio-fft", "value": 78.5}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 142.0, 96.0, 97.0, 97.0, 147.0, 97.0, 96.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 110.3}, {"lowerIsBetter": true, "replicates": [111.0, 112.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 145.0, 147.0, 148.0, 146.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [61.0, 64.0, 64.0, 62.0, 70.0, 60.0, 59.0, 61.0, 63.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 62.2}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 69.0, 70.0, 70.0, 69.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [93.0, 87.0, 86.0, 87.0, 86.0, 87.0, 86.0, 86.0, 92.0, 91.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.1}, {"lowerIsBetter": true, "replicates": [128.0, 126.0, 125.0, 126.0, 120.0, 126.0, 128.0, 127.0, 123.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.5}, {"lowerIsBetter": true, "replicates": [145.0, 151.0, 152.0, 150.0, 141.0, 147.0, 150.0, 154.0, 151.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 70.0, 70.0, 73.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.1}], "name": "kraken", "value": 1527.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.38935108153078], "unit": "score", "name": "Richards", "value": 212.16501999999997}, {"lowerIsBetter": false, "replicates": [190.98548510313216], "unit": "score", "name": "DeltaBlue", "value": 346.19384800000006}, {"lowerIsBetter": false, "replicates": [280.42624789680315], "unit": "score", "name": "Encrypt", "value": 949.2014460000001}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1075.268817204301], "unit": "score", "name": "RayTrace", "value": 688.1897699999998}, {"lowerIsBetter": false, "replicates": [709.4259390503189], "unit": "score", "name": "Earley", "value": 939.439853146853}, {"lowerIsBetter": false, "replicates": [12395.061728395061], "unit": "score", "name": "Boyer", "value": 53.768429282868496}, {"lowerIsBetter": false, "replicates": [25475.0], "unit": "score", "name": "RegExp", "value": 35.759960745829254}, {"lowerIsBetter": false, "replicates": [588.6150234741784], "unit": "score", "name": "Splay", "value": 138.44532801595213}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21338.816932367718}]} 20:17:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21338.82"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1527.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6856.51"}}} 20:17:48 INFO - Return code: 0 20:17:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:17:48 INFO - # TBPL SUCCESS # 20:17:48 INFO - Running post-action listener: _resource_record_post_action 20:17:48 INFO - Running post-run listener: _resource_record_post_run 20:17:49 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 8192; Write bytes: 555479040; Read time: 372; Write time: 724420 20:17:49 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235118592; Read time: 0; Write time: 369516 20:17:49 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 8192; Write bytes: 320065536; Read time: 372; Write time: 354876 20:17:49 INFO - Running post-run listener: _upload_blobber_files 20:17:49 INFO - Blob upload gear active. 20:17:49 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:17:49 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:17:49 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:17:49 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:17:50 INFO - (blobuploader) - INFO - Open directory for files ... 20:17:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:17:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:17:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:17:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:17:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:17:51 INFO - (blobuploader) - INFO - Done attempting. 20:17:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:17:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:17:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:17:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:17:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:17:51 INFO - (blobuploader) - INFO - Done attempting. 20:17:51 INFO - (blobuploader) - INFO - Iteration through files over. 20:17:51 INFO - Return code: 0 20:17:51 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:17:51 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:17:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00a24d5f2b8fe71486bca25aab66aff4bc9a03824e093afdf9245bd29f888407f82503ca6c05cbfed4e405af73c3332b946eeb50498507d9fd1a9c42be3a849b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4f8cd2164859cb29069d446b6520e90e811b040f7d8788be442b877b8ff58df24876daf4b5886c68ff007d757be77c5a7bf3b43e5f94e4edaa4d68c54435061"} 20:17:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:17:51 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:17:51 INFO - Contents: 20:17:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00a24d5f2b8fe71486bca25aab66aff4bc9a03824e093afdf9245bd29f888407f82503ca6c05cbfed4e405af73c3332b946eeb50498507d9fd1a9c42be3a849b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4f8cd2164859cb29069d446b6520e90e811b040f7d8788be442b877b8ff58df24876daf4b5886c68ff007d757be77c5a7bf3b43e5f94e4edaa4d68c54435061"} 20:17:51 INFO - Copying logs to upload dir... 20:17:51 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1279.900182 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-28 20:17:50.837555) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-28 20:17:50.840793) ========= 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=6e558709db315bacd2260379000001b6-1451356216.117616-944872298 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/00a24d5f2b8fe71486bca25aab66aff4bc9a03824e093afdf9245bd29f888407f82503ca6c05cbfed4e405af73c3332b946eeb50498507d9fd1a9c42be3a849b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4f8cd2164859cb29069d446b6520e90e811b040f7d8788be442b877b8ff58df24876daf4b5886c68ff007d757be77c5a7bf3b43e5f94e4edaa4d68c54435061"} build_url:https://queue.taskcluster.net/v1/task/99lCyuv0Q_ONHqSmxLFp6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011360 build_url: 'https://queue.taskcluster.net/v1/task/99lCyuv0Q_ONHqSmxLFp6A/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/00a24d5f2b8fe71486bca25aab66aff4bc9a03824e093afdf9245bd29f888407f82503ca6c05cbfed4e405af73c3332b946eeb50498507d9fd1a9c42be3a849b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4f8cd2164859cb29069d446b6520e90e811b040f7d8788be442b877b8ff58df24876daf4b5886c68ff007d757be77c5a7bf3b43e5f94e4edaa4d68c54435061"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-28 20:17:50.865599) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 20:17:50.865916) ========= 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=6e558709db315bacd2260379000001b6-1451356216.117616-944872298 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004567 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 20:17:50.948281) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-28 20:17:50.948671) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-28 20:17:50.948969) ========= ========= Total master_lag: 0.22 =========