builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-049 starttime: 1452834115.76 results: success (0) buildid: 20160114193043 builduid: 18c5842b65a44ba88e1ba11134f0bd43 revision: 9a358be6fa798f24deecac1b502742b2c37cd6bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 21:01:55.762713) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 21:01:55.763298) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 21:01:55.763862) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1452833208.302399-2044520815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006336 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 21:01:55.789419) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 21:01:55.789752) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 21:01:55.805452) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 21:01:55.805781) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1452833208.302399-2044520815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004638 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 21:01:55.863829) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 21:01:55.864166) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 21:01:55.864615) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 21:01:55.864952) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1452833208.302399-2044520815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-14 21:01:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.9M=0s 2016-01-14 21:01:56 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160699 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 21:01:56.038774) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 21:01:56.039140) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1452833208.302399-2044520815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018170 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 21:01:56.089604) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 21:01:56.090031) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9a358be6fa798f24deecac1b502742b2c37cd6bd --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 9a358be6fa798f24deecac1b502742b2c37cd6bd --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1452833208.302399-2044520815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-14 21:01:56,418 truncating revision to first 12 chars 2016-01-14 21:01:56,418 Setting DEBUG logging. 2016-01-14 21:01:56,418 attempt 1/10 2016-01-14 21:01:56,418 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9a358be6fa79?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-14 21:01:56,695 unpacking tar archive at: mozilla-central-9a358be6fa79/testing/mozharness/ program finished with exit code 0 elapsedTime=0.614569 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 21:01:56.718313) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 21:01:56.718673) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 21:01:56.727769) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 21:01:56.728192) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 21:01:56.728755) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-01-14 21:01:56.729093) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1452833208.302399-2044520815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:01:57 INFO - MultiFileLogger online at 20160114 21:01:57 in /builds/slave/test-pgo 21:01:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:01:57 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:01:57 INFO - {'append_to_log': False, 21:01:57 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:01:57 INFO - 'blob_upload_branch': 'Firefox', 21:01:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:01:57 INFO - 'branch': 'Firefox', 21:01:57 INFO - 'buildbot_json_path': 'buildprops.json', 21:01:57 INFO - 'config_files': ('talos/linux_config.py',), 21:01:57 INFO - 'default_actions': ('clobber', 21:01:57 INFO - 'read-buildbot-config', 21:01:57 INFO - 'download-and-extract', 21:01:57 INFO - 'populate-webroot', 21:01:57 INFO - 'create-virtualenv', 21:01:57 INFO - 'install', 21:01:57 INFO - 'run-tests'), 21:01:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:01:57 INFO - 'download_minidump_stackwalk': True, 21:01:57 INFO - 'download_symbols': 'ondemand', 21:01:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:01:57 INFO - 'tooltool.py': '/tools/tooltool.py', 21:01:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:01:57 INFO - '/tools/misc-python/virtualenv.py')}, 21:01:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:01:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:01:57 INFO - 'installer_path': 'installer.exe', 21:01:57 INFO - 'log_level': 'info', 21:01:57 INFO - 'log_name': 'talos', 21:01:57 INFO - 'log_to_console': True, 21:01:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:01:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:01:57 INFO - 'opt_config_files': (), 21:01:57 INFO - 'pip_index': False, 21:01:57 INFO - 'sps_profile': False, 21:01:57 INFO - 'sps_profile_interval': 0, 21:01:57 INFO - 'suite': 'dromaeojs-e10s', 21:01:57 INFO - 'system_bits': '32', 21:01:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:01:57 INFO - 'title': 'talos-linux64-ix-049', 21:01:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:01:57 INFO - 'use_talos_json': True, 21:01:57 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:01:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:01:57 INFO - 'work_dir': 'build'} 21:01:57 INFO - ##### 21:01:57 INFO - ##### Running clobber step. 21:01:57 INFO - ##### 21:01:57 INFO - Running pre-action listener: _resource_record_pre_action 21:01:57 INFO - Running main action method: clobber 21:01:57 INFO - rmtree: /builds/slave/test-pgo/build 21:01:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:01:57 INFO - Running post-action listener: _resource_record_post_action 21:01:57 INFO - ##### 21:01:57 INFO - ##### Running read-buildbot-config step. 21:01:57 INFO - ##### 21:01:57 INFO - Running pre-action listener: _resource_record_pre_action 21:01:57 INFO - Running main action method: read_buildbot_config 21:01:57 INFO - Using buildbot properties: 21:01:57 INFO - { 21:01:57 INFO - "project": "", 21:01:57 INFO - "product": "firefox", 21:01:57 INFO - "script_repo_revision": "production", 21:01:57 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 21:01:57 INFO - "repository": "", 21:01:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 21:01:57 INFO - "buildid": "20160114193043", 21:01:57 INFO - "pgo_build": "True", 21:01:57 INFO - "basedir": "/builds/slave/test-pgo", 21:01:57 INFO - "buildnumber": 620, 21:01:57 INFO - "slavename": "talos-linux64-ix-049", 21:01:57 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:01:57 INFO - "platform": "ubuntu64_hw", 21:01:57 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 21:01:57 INFO - "branch": "mozilla-central", 21:01:57 INFO - "repo_path": "mozilla-central", 21:01:57 INFO - "revision": "9a358be6fa798f24deecac1b502742b2c37cd6bd", 21:01:57 INFO - "stage_platform": "linux64-pgo", 21:01:57 INFO - "builduid": "18c5842b65a44ba88e1ba11134f0bd43", 21:01:57 INFO - "slavebuilddir": "test" 21:01:57 INFO - } 21:01:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/IpknuwviQ9CPIDevMtHWnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 21:01:57 INFO - Running post-action listener: _resource_record_post_action 21:01:57 INFO - ##### 21:01:57 INFO - ##### Running download-and-extract step. 21:01:57 INFO - ##### 21:01:57 INFO - Running pre-action listener: _resource_record_pre_action 21:01:57 INFO - Running main action method: download_and_extract 21:01:57 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:01:57 INFO - https://queue.taskcluster.net/v1/task/IpknuwviQ9CPIDevMtHWnw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:01:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpknuwviQ9CPIDevMtHWnw/artifacts/public/build/test_packages.json 21:01:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpknuwviQ9CPIDevMtHWnw/artifacts/public/build/test_packages.json 21:01:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpknuwviQ9CPIDevMtHWnw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:01:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpknuwviQ9CPIDevMtHWnw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:01:58 INFO - Downloaded 1448 bytes. 21:01:58 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:01:58 INFO - Using the following test package requirements: 21:01:58 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:01:58 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:01:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:01:58 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:01:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:01:58 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:01:58 INFO - u'jsshell-linux-x86_64.zip'], 21:01:58 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:01:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:01:58 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:01:58 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:01:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:01:58 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:01:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:01:58 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:01:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:01:58 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:01:58 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:01:58 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:01:58 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:01:58 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')]} 21:01:58 INFO - https://queue.taskcluster.net/v1/task/IpknuwviQ9CPIDevMtHWnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:01:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpknuwviQ9CPIDevMtHWnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:01:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpknuwviQ9CPIDevMtHWnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:01:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpknuwviQ9CPIDevMtHWnw/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 21:01:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpknuwviQ9CPIDevMtHWnw/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 21:02:01 INFO - Downloaded 24030757 bytes. 21:02:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:02:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 21:02:02 INFO - Return code: 0 21:02:02 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 21:02: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')]} 21:02:02 INFO - https://queue.taskcluster.net/v1/task/IpknuwviQ9CPIDevMtHWnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:02:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpknuwviQ9CPIDevMtHWnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:02:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpknuwviQ9CPIDevMtHWnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:02:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpknuwviQ9CPIDevMtHWnw/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 21:02:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpknuwviQ9CPIDevMtHWnw/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 21:02:12 INFO - Downloaded 24030757 bytes. 21:02:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:02:12 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 21:02:14 INFO - Return code: 0 21:02: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')]} 21:02:14 INFO - https://queue.taskcluster.net/v1/task/IpknuwviQ9CPIDevMtHWnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:02:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpknuwviQ9CPIDevMtHWnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:02:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpknuwviQ9CPIDevMtHWnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:02:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpknuwviQ9CPIDevMtHWnw/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 21:02:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpknuwviQ9CPIDevMtHWnw/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 21:02:16 INFO - Downloaded 11132144 bytes. 21:02:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:02:16 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 21:02:16 INFO - Return code: 0 21:02:16 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')]} 21:02:16 INFO - https://queue.taskcluster.net/v1/task/IpknuwviQ9CPIDevMtHWnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:02:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpknuwviQ9CPIDevMtHWnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:02:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpknuwviQ9CPIDevMtHWnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:02:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpknuwviQ9CPIDevMtHWnw/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 21:02:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IpknuwviQ9CPIDevMtHWnw/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 21:02:19 INFO - Downloaded 55864290 bytes. 21:02:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IpknuwviQ9CPIDevMtHWnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:02:19 INFO - mkdir: /builds/slave/test-pgo/properties 21:02:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:02:19 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:02:19 INFO - Contents: 21:02:19 INFO - build_url:https://queue.taskcluster.net/v1/task/IpknuwviQ9CPIDevMtHWnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:02:19 INFO - Running post-action listener: _resource_record_post_action 21:02:19 INFO - Running post-action listener: set_extra_try_arguments 21:02:19 INFO - ##### 21:02:19 INFO - ##### Running populate-webroot step. 21:02:19 INFO - ##### 21:02:19 INFO - Running pre-action listener: _resource_record_pre_action 21:02:19 INFO - Running main action method: populate_webroot 21:02:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:02:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:02:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:02:19 INFO - '--tppagecycles', 21:02:19 INFO - '7'], 21:02:19 INFO - 'tests': ['tsvgm']}}, 21:02:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:02:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:02:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:02:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:02:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:02:19 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:02:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:02:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:19 INFO - 'talos_options': ['--e10s'], 21:02:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:02:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:19 INFO - 'tests': ['damp', 'tps']}, 21:02:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:19 INFO - 'talos_options': ['--e10s'], 21:02:19 INFO - 'tests': ['damp', 'tps']}, 21:02:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:02:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:02:19 INFO - 'other': {'tests': ['a11yr', 21:02:19 INFO - 'ts_paint', 21:02:19 INFO - 'tpaint', 21:02:19 INFO - 'sessionrestore', 21:02:19 INFO - 'sessionrestore_no_auto_restore']}, 21:02:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:02:19 INFO - 'tests': ['a11yr', 21:02:19 INFO - 'ts_paint', 21:02:19 INFO - 'tpaint', 21:02:19 INFO - 'sessionrestore', 21:02:19 INFO - 'sessionrestore_no_auto_restore']}, 21:02:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:02:19 INFO - 'tests': ['a11yr', 21:02:19 INFO - 'ts_paint', 21:02:19 INFO - 'tpaint', 21:02:19 INFO - 'sessionrestore', 21:02:19 INFO - 'sessionrestore_no_auto_restore']}, 21:02:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:02:19 INFO - 'tests': ['a11yr', 21:02:19 INFO - 'ts_paint', 21:02:19 INFO - 'tpaint', 21:02:19 INFO - 'sessionrestore', 21:02:19 INFO - 'sessionrestore_no_auto_restore']}, 21:02:19 INFO - 'other_l64': {'tests': ['a11yr', 21:02:19 INFO - 'ts_paint', 21:02:19 INFO - 'tpaint', 21:02:19 INFO - 'sessionrestore', 21:02:19 INFO - 'sessionrestore_no_auto_restore']}, 21:02:19 INFO - 'other_nol64': {'tests': ['a11yr', 21:02:19 INFO - 'ts_paint', 21:02:19 INFO - 'tpaint', 21:02:19 INFO - 'sessionrestore', 21:02:19 INFO - 'sessionrestore_no_auto_restore']}, 21:02:19 INFO - 'svgr': {'tests': ['tsvgx', 21:02:19 INFO - 'tsvgr_opacity', 21:02:19 INFO - 'tart', 21:02:19 INFO - 'tscrollx', 21:02:19 INFO - 'cart']}, 21:02:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:02:19 INFO - 'tests': ['tsvgx', 21:02:19 INFO - 'tsvgr_opacity', 21:02:19 INFO - 'tart', 21:02:19 INFO - 'tscrollx', 21:02:19 INFO - 'cart']}, 21:02:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:19 INFO - 'tests': ['tp5o']}, 21:02:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:19 INFO - 'talos_options': ['--e10s'], 21:02:19 INFO - 'tests': ['tp5o']}, 21:02:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:19 INFO - 'talos_options': ['--xperf_path', 21:02:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:02:19 INFO - 'tests': ['tp5n']}, 21:02:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:19 INFO - 'talos_options': ['--e10s', 21:02:19 INFO - '--xperf_path', 21:02:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:02:19 INFO - 'tests': ['tp5n']}}, 21:02:19 INFO - 'talos.zip': {'path': '', 21:02:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:02:19 INFO - Running post-action listener: _resource_record_post_action 21:02:19 INFO - ##### 21:02:19 INFO - ##### Running create-virtualenv step. 21:02:19 INFO - ##### 21:02:19 INFO - Running pre-action listener: _resource_record_pre_action 21:02:19 INFO - Running main action method: create_virtualenv 21:02:19 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:02:19 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 21:02:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:02:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:02:19 INFO - Using real prefix '/usr' 21:02:19 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:02:20 INFO - Installing distribute.............................................................................................................................................................................................done. 21:02:22 INFO - Installing pip.................done. 21:02:22 INFO - Return code: 0 21:02:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:02:22 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')]} 21:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:22 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')]} 21:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:22 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 0x7f3bf5e17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449840>, '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 0x13b66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b6b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452833208.302399-2044520815', '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 21:02:22 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 21:02:22 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 21:02:22 INFO - Using env: {'DISPLAY': ':0', 21:02:22 INFO - 'HOME': '/home/cltbld', 21:02:22 INFO - 'LANG': 'en_US.UTF-8', 21:02:22 INFO - 'LANGUAGE': 'en_US:en', 21:02:22 INFO - 'LOGNAME': 'cltbld', 21:02:22 INFO - 'MAIL': '/var/mail/cltbld', 21:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:22 INFO - 'MOZ_NO_REMOTE': '1', 21:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:22 INFO - 'NO_EM_RESTART': '1', 21:02:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:02:22 INFO - 'PWD': '/builds/slave/test-pgo', 21:02:22 INFO - 'SHELL': '/bin/bash', 21:02:22 INFO - 'SHLVL': '1', 21:02:22 INFO - 'TERM': 'linux', 21:02:22 INFO - 'TMOUT': '86400', 21:02:22 INFO - 'USER': 'cltbld', 21:02:22 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452833208.302399-2044520815', 21:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:22 INFO - '_': '/tools/buildbot/bin/python'} 21:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:22 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 21:02:22 INFO - Cleaning up... 21:02:22 INFO - Return code: 0 21:02:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:02:22 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')]} 21:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:22 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')]} 21:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:22 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 0x7f3bf5e17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449840>, '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 0x13b66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b6b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452833208.302399-2044520815', '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 21:02:22 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 21:02:22 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 21:02:22 INFO - Using env: {'DISPLAY': ':0', 21:02:22 INFO - 'HOME': '/home/cltbld', 21:02:22 INFO - 'LANG': 'en_US.UTF-8', 21:02:22 INFO - 'LANGUAGE': 'en_US:en', 21:02:22 INFO - 'LOGNAME': 'cltbld', 21:02:22 INFO - 'MAIL': '/var/mail/cltbld', 21:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:22 INFO - 'MOZ_NO_REMOTE': '1', 21:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:22 INFO - 'NO_EM_RESTART': '1', 21:02:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:02:22 INFO - 'PWD': '/builds/slave/test-pgo', 21:02:22 INFO - 'SHELL': '/bin/bash', 21:02:22 INFO - 'SHLVL': '1', 21:02:22 INFO - 'TERM': 'linux', 21:02:22 INFO - 'TMOUT': '86400', 21:02:22 INFO - 'USER': 'cltbld', 21:02:22 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452833208.302399-2044520815', 21:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:22 INFO - '_': '/tools/buildbot/bin/python'} 21:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:22 INFO - Downloading/unpacking psutil>=0.7.1 21:02:22 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 21:02:22 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 21:02:22 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 21:02:22 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 21:02:22 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 21:02:22 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 21:02:24 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:02:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:02:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:02:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:02:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:02:24 INFO - Installing collected packages: psutil 21:02:24 INFO - Running setup.py install for psutil 21:02:24 INFO - building 'psutil._psutil_linux' extension 21:02:24 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 21:02:24 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 21:02:24 INFO - building 'psutil._psutil_posix' extension 21:02:24 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 21:02:24 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 21:02:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:02:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:02:24 INFO - Successfully installed psutil 21:02:24 INFO - Cleaning up... 21:02:24 INFO - Return code: 0 21:02:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:02:24 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')]} 21:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:24 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')]} 21:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:24 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 0x7f3bf5e17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449840>, '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 0x13b66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b6b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452833208.302399-2044520815', '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 21:02:24 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 21:02:24 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 21:02:24 INFO - Using env: {'DISPLAY': ':0', 21:02:24 INFO - 'HOME': '/home/cltbld', 21:02:24 INFO - 'LANG': 'en_US.UTF-8', 21:02:24 INFO - 'LANGUAGE': 'en_US:en', 21:02:24 INFO - 'LOGNAME': 'cltbld', 21:02:24 INFO - 'MAIL': '/var/mail/cltbld', 21:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:24 INFO - 'MOZ_NO_REMOTE': '1', 21:02:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:24 INFO - 'NO_EM_RESTART': '1', 21:02:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:02:24 INFO - 'PWD': '/builds/slave/test-pgo', 21:02:24 INFO - 'SHELL': '/bin/bash', 21:02:24 INFO - 'SHLVL': '1', 21:02:24 INFO - 'TERM': 'linux', 21:02:24 INFO - 'TMOUT': '86400', 21:02:24 INFO - 'USER': 'cltbld', 21:02:24 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452833208.302399-2044520815', 21:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:24 INFO - '_': '/tools/buildbot/bin/python'} 21:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:02:25 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 21:02:25 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 21:02:25 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 21:02:25 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 21:02:25 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 21:02:25 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 21:02:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:02:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:02:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:02:26 INFO - Installing collected packages: mozsystemmonitor 21:02:26 INFO - Running setup.py install for mozsystemmonitor 21:02:26 INFO - Successfully installed mozsystemmonitor 21:02:26 INFO - Cleaning up... 21:02:27 INFO - Return code: 0 21:02:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:27 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 0x7f3bf5e17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449840>, '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 0x13b66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b6b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452833208.302399-2044520815', '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 21:02:27 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 21:02:27 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 21:02:27 INFO - Using env: {'DISPLAY': ':0', 21:02:27 INFO - 'HOME': '/home/cltbld', 21:02:27 INFO - 'LANG': 'en_US.UTF-8', 21:02:27 INFO - 'LANGUAGE': 'en_US:en', 21:02:27 INFO - 'LOGNAME': 'cltbld', 21:02:27 INFO - 'MAIL': '/var/mail/cltbld', 21:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:27 INFO - 'MOZ_NO_REMOTE': '1', 21:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:27 INFO - 'NO_EM_RESTART': '1', 21:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:02:27 INFO - 'PWD': '/builds/slave/test-pgo', 21:02:27 INFO - 'SHELL': '/bin/bash', 21:02:27 INFO - 'SHLVL': '1', 21:02:27 INFO - 'TERM': 'linux', 21:02:27 INFO - 'TMOUT': '86400', 21:02:27 INFO - 'USER': 'cltbld', 21:02:27 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452833208.302399-2044520815', 21:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:27 INFO - '_': '/tools/buildbot/bin/python'} 21:02:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:27 INFO - Downloading/unpacking blobuploader==1.2.4 21:02:27 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 21:02:27 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 21:02:27 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 21:02:27 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 21:02:27 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 21:02:27 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 21:02:28 INFO - Downloading blobuploader-1.2.4.tar.gz 21:02:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:02:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:02:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:02:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:02:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:29 INFO - Downloading docopt-0.6.1.tar.gz 21:02:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:02:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:02:29 INFO - Installing collected packages: blobuploader, requests, docopt 21:02:29 INFO - Running setup.py install for blobuploader 21:02:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:02:29 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:02:29 INFO - Running setup.py install for requests 21:02:30 INFO - Running setup.py install for docopt 21:02:30 INFO - Successfully installed blobuploader requests docopt 21:02:30 INFO - Cleaning up... 21:02:30 INFO - Return code: 0 21:02:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:30 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 0x7f3bf5e17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449840>, '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 0x13b66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b6b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452833208.302399-2044520815', '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 21:02:30 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 21:02:30 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 21:02:30 INFO - Using env: {'DISPLAY': ':0', 21:02:30 INFO - 'HOME': '/home/cltbld', 21:02:30 INFO - 'LANG': 'en_US.UTF-8', 21:02:30 INFO - 'LANGUAGE': 'en_US:en', 21:02:30 INFO - 'LOGNAME': 'cltbld', 21:02:30 INFO - 'MAIL': '/var/mail/cltbld', 21:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:30 INFO - 'MOZ_NO_REMOTE': '1', 21:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:30 INFO - 'NO_EM_RESTART': '1', 21:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:02:30 INFO - 'PWD': '/builds/slave/test-pgo', 21:02:30 INFO - 'SHELL': '/bin/bash', 21:02:30 INFO - 'SHLVL': '1', 21:02:30 INFO - 'TERM': 'linux', 21:02:30 INFO - 'TMOUT': '86400', 21:02:30 INFO - 'USER': 'cltbld', 21:02:30 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452833208.302399-2044520815', 21:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:30 INFO - '_': '/tools/buildbot/bin/python'} 21:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:02:30 INFO - Running setup.py (path:/tmp/pip-hNCfUJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:02:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:02:30 INFO - Running setup.py (path:/tmp/pip-LMcTZx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:02:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:02:30 INFO - Running setup.py (path:/tmp/pip-C9OtJg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:02:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:02:30 INFO - Running setup.py (path:/tmp/pip-FgWYi1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:02:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:02:30 INFO - Running setup.py (path:/tmp/pip-FU74se-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:02:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:02:30 INFO - Running setup.py (path:/tmp/pip-V23anr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:02:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:02:30 INFO - Running setup.py (path:/tmp/pip-yZCoNQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:02:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:02:30 INFO - Running setup.py (path:/tmp/pip-S_h_zj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:02:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:02:31 INFO - Running setup.py (path:/tmp/pip-NDgm9t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:02:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:02:31 INFO - Running setup.py (path:/tmp/pip-c0vxmi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:02:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:02:31 INFO - Running setup.py (path:/tmp/pip-paKVwU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:02:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:02:31 INFO - Running setup.py (path:/tmp/pip-CpcJOE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:02:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:02:31 INFO - Running setup.py (path:/tmp/pip-jq9cX0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:02:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:02:31 INFO - Running setup.py (path:/tmp/pip-UotF9H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:02:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:02:31 INFO - Running setup.py (path:/tmp/pip-nrFhhy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:02:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:02:31 INFO - Running setup.py (path:/tmp/pip-IUR0jE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:02:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:02:31 INFO - Running setup.py (path:/tmp/pip-joKdJO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:02:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:02:31 INFO - Running setup.py install for manifestparser 21:02:31 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:02:31 INFO - Running setup.py install for mozcrash 21:02:31 INFO - Running setup.py install for mozdebug 21:02:31 INFO - Running setup.py install for mozdevice 21:02:32 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:02:32 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:02:32 INFO - Running setup.py install for mozfile 21:02:32 INFO - Running setup.py install for mozhttpd 21:02:32 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:02:32 INFO - Running setup.py install for mozinfo 21:02:32 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:02:32 INFO - Running setup.py install for mozInstall 21:02:32 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:02:32 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:02:32 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:02:32 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:02:32 INFO - Running setup.py install for mozleak 21:02:32 INFO - Running setup.py install for mozlog 21:02:32 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:02:32 INFO - Running setup.py install for moznetwork 21:02:32 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:02:32 INFO - Running setup.py install for mozprocess 21:02:32 INFO - Running setup.py install for mozprofile 21:02:33 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:02:33 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:02:33 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:02:33 INFO - Running setup.py install for mozrunner 21:02:33 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:02:33 INFO - Running setup.py install for mozscreenshot 21:02:33 INFO - Running setup.py install for moztest 21:02:33 INFO - Running setup.py install for mozversion 21:02:33 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:02:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:02:33 INFO - Cleaning up... 21:02:33 INFO - Return code: 0 21:02:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:02:33 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')]} 21:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:33 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')]} 21:02:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:33 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 0x7f3bf5e17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449840>, '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 0x13b66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b6b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452833208.302399-2044520815', '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 21:02:33 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 21:02:33 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 21:02:33 INFO - Using env: {'DISPLAY': ':0', 21:02:33 INFO - 'HOME': '/home/cltbld', 21:02:33 INFO - 'LANG': 'en_US.UTF-8', 21:02:33 INFO - 'LANGUAGE': 'en_US:en', 21:02:33 INFO - 'LOGNAME': 'cltbld', 21:02:33 INFO - 'MAIL': '/var/mail/cltbld', 21:02:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:33 INFO - 'MOZ_NO_REMOTE': '1', 21:02:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:33 INFO - 'NO_EM_RESTART': '1', 21:02:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:02:33 INFO - 'PWD': '/builds/slave/test-pgo', 21:02:33 INFO - 'SHELL': '/bin/bash', 21:02:33 INFO - 'SHLVL': '1', 21:02:33 INFO - 'TERM': 'linux', 21:02:33 INFO - 'TMOUT': '86400', 21:02:33 INFO - 'USER': 'cltbld', 21:02:33 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452833208.302399-2044520815', 21:02:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:33 INFO - '_': '/tools/buildbot/bin/python'} 21:02:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:02:33 INFO - Running setup.py (path:/tmp/pip-0aJkCo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:02:33 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)) 21:02:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:02:33 INFO - Running setup.py (path:/tmp/pip-AlxFnw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:02:33 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)) 21:02:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:02:33 INFO - Running setup.py (path:/tmp/pip-KeLSd9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:02:33 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)) 21:02:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:02:33 INFO - Running setup.py (path:/tmp/pip-rRLkcd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 21:02:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:02:34 INFO - Running setup.py (path:/tmp/pip-EhGPAf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:02:34 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)) 21:02:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:02:34 INFO - Running setup.py (path:/tmp/pip-D827AP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:02:34 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)) 21:02:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:02:34 INFO - Running setup.py (path:/tmp/pip-xMesV4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:02:34 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)) 21:02:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:02:34 INFO - Running setup.py (path:/tmp/pip-GbdyHY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:02:34 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)) 21:02:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:02:34 INFO - Running setup.py (path:/tmp/pip-MZRE0R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:02:34 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)) 21:02:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:02:34 INFO - Running setup.py (path:/tmp/pip-NQ4oPW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:02:34 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)) 21:02:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:02:34 INFO - Running setup.py (path:/tmp/pip-W3UhrT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:02:34 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)) 21:02:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:02:34 INFO - Running setup.py (path:/tmp/pip-jIjwaw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:02:34 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)) 21:02:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:02:34 INFO - Running setup.py (path:/tmp/pip-uo6Rzu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:02:34 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)) 21:02:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:02:34 INFO - Running setup.py (path:/tmp/pip-J4h9Sb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:02:34 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)) 21:02:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:02:34 INFO - Running setup.py (path:/tmp/pip-x2eVOt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:02:34 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)) 21:02:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:02:34 INFO - Running setup.py (path:/tmp/pip-Gi7hZ_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:02:34 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)) 21:02:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:02:34 INFO - Running setup.py (path:/tmp/pip-CGjoks-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:02:34 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)) 21:02:34 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)) 21:02:34 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)) 21:02:34 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)) 21:02:34 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:02:34 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:02:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:02:34 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 21:02:34 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 21:02:34 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 21:02:34 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 21:02:34 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 21:02:34 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 21:02:36 INFO - Downloading blessings-1.5.1.tar.gz 21:02:36 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 21:02:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:02:36 INFO - Installing collected packages: blessings 21:02:36 INFO - Running setup.py install for blessings 21:02:36 INFO - Successfully installed blessings 21:02:36 INFO - Cleaning up... 21:02:36 INFO - Return code: 0 21:02:36 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:02:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:02:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:02:37 INFO - Reading from file tmpfile_stdout 21:02:37 INFO - Current package versions: 21:02:37 INFO - argparse == 1.2.1 21:02:37 INFO - blessings == 1.5.1 21:02:37 INFO - blobuploader == 1.2.4 21:02:37 INFO - docopt == 0.6.1 21:02:37 INFO - manifestparser == 1.1 21:02:37 INFO - mozInstall == 1.12 21:02:37 INFO - mozcrash == 0.16 21:02:37 INFO - mozdebug == 0.1 21:02:37 INFO - mozdevice == 0.48 21:02:37 INFO - mozfile == 1.2 21:02:37 INFO - mozhttpd == 0.7 21:02:37 INFO - mozinfo == 0.9 21:02:37 INFO - mozleak == 0.1 21:02:37 INFO - mozlog == 3.1 21:02:37 INFO - moznetwork == 0.27 21:02:37 INFO - mozprocess == 0.22 21:02:37 INFO - mozprofile == 0.28 21:02:37 INFO - mozrunner == 6.11 21:02:37 INFO - mozscreenshot == 0.1 21:02:37 INFO - mozsystemmonitor == 0.0 21:02:37 INFO - moztest == 0.7 21:02:37 INFO - mozversion == 1.4 21:02:37 INFO - psutil == 3.1.1 21:02:37 INFO - requests == 1.2.3 21:02:37 INFO - wsgiref == 0.1.2 21:02:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:37 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 0x7f3bf5e17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449840>, '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 0x13b66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b6b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452833208.302399-2044520815', '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 21:02:37 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 21:02:37 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 21:02:37 INFO - Using env: {'DISPLAY': ':0', 21:02:37 INFO - 'HOME': '/home/cltbld', 21:02:37 INFO - 'LANG': 'en_US.UTF-8', 21:02:37 INFO - 'LANGUAGE': 'en_US:en', 21:02:37 INFO - 'LOGNAME': 'cltbld', 21:02:37 INFO - 'MAIL': '/var/mail/cltbld', 21:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:37 INFO - 'MOZ_NO_REMOTE': '1', 21:02:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:37 INFO - 'NO_EM_RESTART': '1', 21:02:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:02:37 INFO - 'PWD': '/builds/slave/test-pgo', 21:02:37 INFO - 'SHELL': '/bin/bash', 21:02:37 INFO - 'SHLVL': '1', 21:02:37 INFO - 'TERM': 'linux', 21:02:37 INFO - 'TMOUT': '86400', 21:02:37 INFO - 'USER': 'cltbld', 21:02:37 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452833208.302399-2044520815', 21:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:37 INFO - '_': '/tools/buildbot/bin/python'} 21:02:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:37 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)) 21:02:37 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)) 21:02:37 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)) 21:02:37 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)) 21:02:37 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)) 21:02:37 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)) 21:02:37 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)) 21:02:37 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)) 21:02:37 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)) 21:02:37 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)) 21:02:37 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)) 21:02:37 INFO - Cleaning up... 21:02:37 INFO - Return code: 0 21:02:37 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 21:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:37 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 0x7f3bf5e17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449840>, '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 0x13b66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b6b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452833208.302399-2044520815', '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 21:02:37 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 21:02:37 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 21:02:37 INFO - Using env: {'DISPLAY': ':0', 21:02:37 INFO - 'HOME': '/home/cltbld', 21:02:37 INFO - 'LANG': 'en_US.UTF-8', 21:02:37 INFO - 'LANGUAGE': 'en_US:en', 21:02:37 INFO - 'LOGNAME': 'cltbld', 21:02:37 INFO - 'MAIL': '/var/mail/cltbld', 21:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:37 INFO - 'MOZ_NO_REMOTE': '1', 21:02:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:37 INFO - 'NO_EM_RESTART': '1', 21:02:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:02:37 INFO - 'PWD': '/builds/slave/test-pgo', 21:02:37 INFO - 'SHELL': '/bin/bash', 21:02:37 INFO - 'SHLVL': '1', 21:02:37 INFO - 'TERM': 'linux', 21:02:37 INFO - 'TMOUT': '86400', 21:02:37 INFO - 'USER': 'cltbld', 21:02:37 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452833208.302399-2044520815', 21:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:37 INFO - '_': '/tools/buildbot/bin/python'} 21:02:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:37 INFO - Downloading/unpacking jsonschema 21:02:37 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 21:02:37 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 21:02:37 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 21:02:37 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 21:02:37 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 21:02:37 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 21:02:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:02:39 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 21:02:39 INFO - Downloading/unpacking functools32 (from jsonschema) 21:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:39 INFO - Downloading functools32-3.2.3-2.tar.gz 21:02:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 21:02:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 21:02:39 INFO - warning: no files found matching '*.txt' 21:02:39 INFO - no previously-included directories found matching 'build' 21:02:39 INFO - no previously-included directories found matching 'dist' 21:02:39 INFO - no previously-included directories found matching '.git*' 21:02:39 INFO - Installing collected packages: jsonschema, functools32 21:02:39 INFO - Running setup.py install for functools32 21:02:39 INFO - warning: no files found matching '*.txt' 21:02:39 INFO - no previously-included directories found matching 'build' 21:02:39 INFO - no previously-included directories found matching 'dist' 21:02:39 INFO - no previously-included directories found matching '.git*' 21:02:39 INFO - Successfully installed jsonschema functools32 21:02:39 INFO - Cleaning up... 21:02:39 INFO - Return code: 0 21:02:39 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 21:02: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')]} 21:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02: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')]} 21:02:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:39 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 0x7f3bf5e17f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1449840>, '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 0x13b66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b6b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452833208.302399-2044520815', '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 21:02:39 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 21:02:39 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 21:02:39 INFO - Using env: {'DISPLAY': ':0', 21:02:39 INFO - 'HOME': '/home/cltbld', 21:02:39 INFO - 'LANG': 'en_US.UTF-8', 21:02:39 INFO - 'LANGUAGE': 'en_US:en', 21:02:39 INFO - 'LOGNAME': 'cltbld', 21:02:39 INFO - 'MAIL': '/var/mail/cltbld', 21:02:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:39 INFO - 'MOZ_NO_REMOTE': '1', 21:02:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:39 INFO - 'NO_EM_RESTART': '1', 21:02:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:02:39 INFO - 'PWD': '/builds/slave/test-pgo', 21:02:39 INFO - 'SHELL': '/bin/bash', 21:02:39 INFO - 'SHLVL': '1', 21:02:39 INFO - 'TERM': 'linux', 21:02:39 INFO - 'TMOUT': '86400', 21:02:39 INFO - 'USER': 'cltbld', 21:02:39 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452833208.302399-2044520815', 21:02:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:39 INFO - '_': '/tools/buildbot/bin/python'} 21:02:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:39 INFO - Downloading/unpacking flake8 21:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:02:41 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 21:02:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:02:41 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 21:02:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:42 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 21:02:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 21:02:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 21:02:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:02:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:02:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:02:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:02:42 INFO - no previously-included directories found matching 'docs/_build' 21:02:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:02:42 INFO - Running setup.py install for pep8 21:02:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:02:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:02:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:02:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:02:42 INFO - no previously-included directories found matching 'docs/_build' 21:02:42 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 21:02:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:02:42 INFO - Cleaning up... 21:02:42 INFO - Return code: 0 21:02:42 INFO - Running post-action listener: _resource_record_post_action 21:02:42 INFO - Running post-action listener: _start_resource_monitoring 21:02:42 INFO - Starting resource monitoring. 21:02:42 INFO - ##### 21:02:42 INFO - ##### Running install step. 21:02:42 INFO - ##### 21:02:42 INFO - Running pre-action listener: _resource_record_pre_action 21:02:42 INFO - Running main action method: install 21:02:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:02:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:02:42 INFO - Reading from file tmpfile_stdout 21:02:42 INFO - Detecting whether we're running mozinstall >=1.0... 21:02:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:02:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:02:42 INFO - Reading from file tmpfile_stdout 21:02:42 INFO - Output received: 21:02:42 INFO - Usage: mozinstall [options] installer 21:02:42 INFO - Options: 21:02:42 INFO - -h, --help show this help message and exit 21:02:42 INFO - -d DEST, --destination=DEST 21:02:42 INFO - Directory to install application into. [default: 21:02:42 INFO - "/builds/slave/test-pgo"] 21:02:42 INFO - --app=APP Application being installed. [default: firefox] 21:02:42 INFO - mkdir: /builds/slave/test-pgo/build/application 21:02:42 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'] 21:02:42 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 21:02:58 INFO - Reading from file tmpfile_stdout 21:02:58 INFO - Output received: 21:02:58 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:02:58 INFO - Running post-action listener: _resource_record_post_action 21:02:58 INFO - ##### 21:02:58 INFO - ##### Running run-tests step. 21:02:58 INFO - ##### 21:02:58 INFO - Running pre-action listener: _resource_record_pre_action 21:02:58 INFO - Running main action method: run_tests 21:02:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:02:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:02:58 INFO - Python 2.7.3 21:02:58 INFO - Return code: 0 21:02:58 INFO - grabbing minidump binary from tooltool 21:02:58 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')]} 21:02:58 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 0x1449840>, '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 0x13b66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13b6b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:02:58 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 21:02:58 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 21:02:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:02:58 INFO - Return code: 0 21:02:58 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:02:58 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:02:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:02:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:02:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:02:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 21:02:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 21:02:59 INFO - Return code: 0 21:02:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IpknuwviQ9CPIDevMtHWnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 21:02:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IpknuwviQ9CPIDevMtHWnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:02:59 INFO - Using env: {'DISPLAY': ':0', 21:02:59 INFO - 'HOME': '/home/cltbld', 21:02:59 INFO - 'LANG': 'en_US.UTF-8', 21:02:59 INFO - 'LANGUAGE': 'en_US:en', 21:02:59 INFO - 'LOGNAME': 'cltbld', 21:02:59 INFO - 'MAIL': '/var/mail/cltbld', 21:02:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:02:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:59 INFO - 'MOZ_NO_REMOTE': '1', 21:02:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:59 INFO - 'NO_EM_RESTART': '1', 21:02:59 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:02:59 INFO - 'PWD': '/builds/slave/test-pgo', 21:02:59 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:02:59 INFO - 'SHELL': '/bin/bash', 21:02:59 INFO - 'SHLVL': '1', 21:02:59 INFO - 'TERM': 'linux', 21:02:59 INFO - 'TMOUT': '86400', 21:02:59 INFO - 'USER': 'cltbld', 21:02:59 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452833208.302399-2044520815', 21:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:59 INFO - '_': '/tools/buildbot/bin/python'} 21:02:59 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IpknuwviQ9CPIDevMtHWnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:03:00 INFO - mozversion application_buildid: 20160114193043 21:03:00 INFO - mozversion application_changeset: 9a358be6fa798f24deecac1b502742b2c37cd6bd 21:03:00 INFO - mozversion application_display_name: Nightly 21:03:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:03:00 INFO - mozversion application_name: Firefox 21:03:00 INFO - mozversion application_remotingname: firefox 21:03:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:03:00 INFO - mozversion application_vendor: Mozilla 21:03:00 INFO - mozversion application_version: 46.0a1 21:03:00 INFO - mozversion platform_buildid: 20160114193043 21:03:00 INFO - mozversion platform_changeset: 9a358be6fa798f24deecac1b502742b2c37cd6bd 21:03:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:03:00 INFO - mozversion platform_version: 46.0a1 21:03:00 INFO - using testdate: 1452834180 21:03:00 INFO - actual date: 1452834180 21:03:00 INFO - starting webserver on 'localhost:35870' 21:03:00 INFO - SUITE-START | Running 3 tests 21:03:00 INFO - TEST-START | dromaeo_css 21:03:00 INFO - operating with platform_type : linux_ 21:03:00 INFO - Initialising browser for dromaeo_css test... 21:03:00 INFO - TEST-INFO | started process 12208 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBWJyik/profile http://localhost:35870/getInfo.html) 21:03:03 INFO - PROCESS | 12208 | 21:03:03 INFO - PROCESS | 12208 | (process:12290): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:03:04 INFO - PROCESS | 12208 | __metrics Screen width/height:1600/1200 21:03:04 INFO - PROCESS | 12208 | colorDepth:24 21:03:04 INFO - PROCESS | 12208 | Browser inner width/height: 1024/697 21:03:04 INFO - PROCESS | 12208 | __metrics 21:03:04 INFO - PROCESS | 12208 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:03:05 INFO - TEST-INFO | 12208: exit 0 21:03:05 INFO - Browser initialized. 21:03:05 INFO - Running cycle 1/1 for dromaeo_css test... 21:03:05 INFO - TEST-INFO | started process 12339 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBWJyik/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:03:06 INFO - PROCESS | 12339 | 21:03:06 INFO - PROCESS | 12339 | (process:12397): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:03:17 INFO - PROCESS | 12339 | RSS: Main: 150589440 21:03:17 INFO - PROCESS | 12339 | 21:04:06 INFO - PROCESS | 12339 | 1452834246774 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] 21:06:15 INFO - PROCESS | 12339 | Cycle 1(1): loaded http://localhost:35870/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35870/tests/dromaeo/cssquery-ext.html) 21:06:16 INFO - PROCESS | 12339 | RSS: Main: 157118464 21:06:16 INFO - PROCESS | 12339 | 21:09:18 INFO - PROCESS | 12339 | Cycle 1(1): loaded http://localhost:35870/tests/dromaeo/cssquery-ext.html (next: http://localhost:35870/tests/dromaeo/cssquery-jquery.html) 21:09:19 INFO - PROCESS | 12339 | RSS: Main: 151666688 21:09:19 INFO - PROCESS | 12339 | 21:12:20 INFO - PROCESS | 12339 | Cycle 1(1): loaded http://localhost:35870/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35870/tests/dromaeo/cssquery-mootools.html) 21:12:21 INFO - PROCESS | 12339 | RSS: Main: 151154688 21:12:21 INFO - PROCESS | 12339 | 21:15:23 INFO - PROCESS | 12339 | Cycle 1(1): loaded http://localhost:35870/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35870/tests/dromaeo/cssquery-prototype.html) 21:15:23 INFO - PROCESS | 12339 | RSS: Main: 150761472 21:15:23 INFO - PROCESS | 12339 | 21:18:26 INFO - PROCESS | 12339 | Cycle 1(1): loaded http://localhost:35870/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35870/tests/dromaeo/cssquery-yui.html) 21:18:26 INFO - PROCESS | 12339 | RSS: Main: 150040576 21:18:26 INFO - PROCESS | 12339 | 21:21:29 INFO - PROCESS | 12339 | Cycle 1(1): loaded http://localhost:35870/tests/dromaeo/cssquery-yui.html (next: http://localhost:35870/tests/dromaeo/cssquery-dojo.html) 21:21:29 INFO - PROCESS | 12339 | RSS: Main: 152375296 21:21:29 INFO - PROCESS | 12339 | 21:21:29 INFO - PROCESS | 12339 | __start_tp_report 21:21:29 INFO - PROCESS | 12339 | _x_x_mozilla_page_load 21:21:29 INFO - PROCESS | 12339 | _x_x_mozilla_page_load_details 21:21:29 INFO - PROCESS | 12339 | |i|pagename|runs| 21:21:29 INFO - PROCESS | 12339 | |0;dojo.html;3154.842257887105;3167.1607024138607;3179.968200317996;3204.8237346945925;3218.967810321896;5039.773210205541;5101.9744901275535;5108.4636113208135;5108.514691104344;5145.665531740434;5047.924281135786;5152.252923326116;5168.3539557555305;5169.844904652857;5187.299714538536;4434.290513517838;4683.274092515657;4831.637627177958;4845.53967373099;4891.1195984722735;4625.907481850361;4755.144074066667;4804.783784729696;4822.252550854606;4828.324034635154;4617.030423611029;4672.556107169813;4709.670323077386;4767.928481072787;4781.497942716;4703;4704.247320428715;4704.9059018819435;4740.407449068866;4741.502142275046;4649.604783593399;4694.530546945312;4722.338872557844;4747.976260118678;4762.833300834454;4970.627202959792;4975.90048199034;4994.700317980896;5079.771410286546;5086.491350864921;5519.530839878616;5521.917171242435;5528.917066244009;5532.5573954083575;5538.695371754552;5541.639793413456;5549.861253468695;5552.666839989613;5556.138798486241;5567.8608034799045;5157.226416037587;5194.298769666085;5198.844034678966;5203.739813009334;5232.39827419844;5627.930693168285;5640.379558248589;5640.589852536866;5646.6894320811925;5648.322201335866;5376.059189641797;5452.91820622691;5472.616916815864;5502.669839809624;5550.306211723535;5318.25544423781;5377.865553361197;5382.085045542267;5386.976474469838;5394.190871369247;5329.25390445338;5360.624756267024;5401.2168235606405;5554.91667624986;5612.1581762735095;5540.722963851791;5541.861453463615;5549.778008879681;5565.332160140809;5574.832755017356;4319.8488052918;4332.956670433256;4346.2828633275785;4365.083332500147;4381.40850985113;3809.809509524568;3821.7133714971487;3849.364854798983;3858.82635281413;3859.7877116758846;5116.641835071584;5139.460356662571;5141;5144.099782538041;5150.716710580879;5388.191771234347;5437.265969094201;5487.204355368529;5494.423085576037;5495.34055913285;5108.744562771846;5130.333056702605;5150.0472412603785;5155.097857874857;5204.9219261711105;4718.4809670936165;4727.290906364073;4739.289106634033;4746.477887432379;4790.305405716152;5612.214289999403;5701.116326969326;5771.989901767174;5806.68063256525;5809.7095145242565;5562.554995600423;5576.191452239484;5593.384727679871;5628.605997580294;5667.716614169358;5762.049261871744;5788.53691704671;5792.9283082629845;5797.362290148165;5800.970995144998;5156.793728250978;5263.23683065961;5455.1271796512365;5522.696251706195;5541.778328866801;5467.972660136674;5542.140968149944;5560.471755183251;5576.525995290446;5604.887902242014;5405.567554595545;5422.593305502182;5429.945700542944;5437.864053398696;5485.204645326485;5346.572274217975;5410.83767486976;5435.673859568438;5435.972820135874;5508.476694713996;5267.051930652519;5315.548178404879;5315.920261196163;5320.946790532045;5367.114426119802;5387.084195686664;5435.83692489226;5457.181422786613;5465.59008074388;5523.8895222094525;5222.634415591024;5299.655522391032;5302.231176479466;5388.057090009311;5396.892062158657 21:21:29 INFO - PROCESS | 12339 | |1;ext.html;539.6195682044157;547.4908335248219;555.4834004375929;558.2686680448612;564.7204633706316;35273.29453410934;35871.10322241945;35956.460653090195;35981.280374392496;36037.81981090091;40360.59639403605;40780;40852.59147408525;40885.79557102218;40992;8425.578721063937;8628.568571571428;8629.870551941694;8634.827303453958;8645.827083458327;8247.917520824805;8270.966129233846;8347.83304333913;8523.872141917876;8544.401891867572;8499.61751721174;8547.401681882271;8563.700270490534;8587.055423903366;8594.570271486433;8540.103289154642;8589.098144694779;8595.914040859574;8597.5701214939;8598.484090954562;8341;8446.61990210442;8453.788655283606;8453.95773021131;8463.95768021162;39464;39885.20229595392;39885.20229595392;39970.40044399336;40057.39913901294;2633.394319306551;2806.2282872210103;3031.2118849099393;3096.47359948807;3202.4876019836715;26584.601230981552;26732.33169170767;27017.86491067552;27102.45795084107;27253;3233.0785726067957;3240.416724989501;3272.8199949002797;3363.091965169415;3473.826308684581;179789;180082;180390;180504;182488.99999999866;52455.213171802454;53117.7344113277;54670.17994730082;57283.14075288874;59297.145685530304;57334.7133264331;57486;57566.7121664389;57668.9815856443;57723.42276577181;16392.590185245463;16624.418145364853;16658;16670.083145427117;16688.74966875498;12638.873611263954;12807.61577152687;12842.550510732079;12843.743125137446;12917.095803293867;19179.560993162962;19381.51546211356;19430.417087487396;19450.319238826574;19479.318223862098;7481.177070522347;7608.505447145918;7673.693052277847;7707.807304817312;7758.3017528422715;912.5026860361119;976.3360914578155;1099.0163803395915;1114.6321713834416;1120.0983208517223;27504.17487475379;27547.173584792487;27948.72051279461;28232.29419264535;28277.293067673472;1024.5491983527224;1057.6932689520106;1118.725912151528;1122.5790328626765;1124.0670243697712;14610.342534585969;14789.408423663148;15137.243137843285;15470.922645386701;15693.136877471848;311984;312985;313524;313724;317044;51303;51756.22365664518;51886.740566296925;52083.479165207864;52228;1350.0684527675871;1371.2800779590796;1378.0835744230176;1383.5641772841523;1385.3558095485648;27691.169264922086;28775.712242877304;28885;29206.200187763145;29465.263368415963;44702.3294650574;45005;45117;45122.323165151895;45226.32160517661;290152;291686;293003;293714;293922;30584.235394115327;31037.8448107758;31167.844160779052;31956.36087278288;32006.19984500313;37623.2475350486;37772.62227377691;38396.42405363978;38414;38972;32044.359112818078;32314.35371292608;33086.83456582798;33383.83308083444;33697.66302336945;34526.309473810885;35097.122571935906;35706.821465892506;35999.820000899825;36556.81721591375;34048.48927266044;34310;34920.47619285662;34955.126121847155;35000.29999399947;26484.735152648227;27365.589516156877;28562.85718571394;32109.678903210668;33431.66568334286;23429.531409371375;23698.170564030177;24953.500929980935;26549.867250664396;26739.197824065308 21:21:29 INFO - PROCESS | 12339 | |2;jquery.html;350.8771929824561;353.44509120680544;355.03430668581467;355.66567426618974;360.2093404976077;15788.999999999985;16682.66634667306;16914.407995720154;17563.56091097723;18382.81617183826;11600.825987610193;11605.651830445078;11633.011194048495;12498.812517812241;16698;4949.2328689053165;5025.597952163818;5530.889382212354;5555.111182210847;5570.164475328713;4481.126180394825;5450.29146210992;5487.6433031853;5504.091824848895;5521.696306703129;5461.863453413676;5478.506934375905;5483.150111732688;5501.614886957915;5508.256385387961;4953.281774142747;5046.924296135561;5063.18988961768;5474.069408200596;5484;4905.068037072981;4907.312976183337;4911.8772030699165;4913.754312284407;4928.778204980785;16935.915320423443;19510.219591216333;19997;20168.79831201684;20176.69734953977;1935.090507461491;1961.5880665060354;1993.4219076467807;2092.1213090501874;2132.0618927671776;9693.709188724279;9703.854442183372;9786.510674466248;9812.116909478109;9850;1759.8504127149208;1771.477414162825;1804.404546499665;1810.1039985207406;1817.9909100454413;36378;46044.769776150904;57736.71131644357;58014.70992645052;59120.40879591192;9959.302848800515;10167.23745719074;10304.330218535772;10312.639057633098;10367.688969330931;12364.1963272387;12903.290319032356;12903.741925161632;12990.090693651542;13307.667308317175;7212;7381.224971378036;7682.116556595951;7702.191269916578;7738.342240909473;7464.813379665443;7483.064616922885;7495.962520187473;7504.549727016287;7514.248575142551;4343.847965321199;4395.055063161436;4412.602865742098;4431.290993441034;4441.533638967927;1824.1882362348626;1851.4639134121455;1857.721341798741;1888.282452668005;1891.9621607567772;862.2498426368974;866.5450638414757;905.5879574793453;940.9952950235205;956.8803899512561;15769.763453548207;16135.112568808829;16310.021398715877;16401.1799410029;16511.09188994617;807.1524898856178;855.1363123245567;909.4043401571981;929.4980710416299;957.6935380678116;9310;10066.245031622657;10215.284930054824;10220.846687299547;10227.181825453947;391352;396399;402591;403658;517697;68966.31033689699;72570.27429725636;74148.62925685337;75013;75832.62083689656;1139.943002849854;1141.4406940599213;1154.255505199142;1171.0982543441503;1176.5411489519095;14865.182414967281;15145.697086058437;15265.6183595411;15401;15585.844141558438;27027.459450811268;27198.864005679847;27953.580696289977;30673.693263067085;31109.68890311068;37415.06462338354;38421.807890960365;38678;39216.803915980236;39558.40662390124;7104.11198600175;7431.70273189088;7535.924640753522;7546.132194797449;7561.470697051153;9590.657307977028;11021.44892755375;11199.440027998731;11458.541658333574;11643.359615220905;9133.178013978773;9755.463449510346;9880.160186384237;9925.205983521157;9991.600335986479;3167.0815463515323;5480.72596370172;7780.210551573056;10093.444860532742;10183.18534517222;3269.182704323919;3273;9182.31132665066;9759.901621151486;10030.64892728751;7371.152317483344;7424.703011879465;7512.774616761506;7544.773656790305;7622.885656715042;9259.657349684392;10066.29535932507;10097.040781125781;10243.641472548425;10358.689239322832 21:21:29 INFO - PROCESS | 12339 | |3;mootools.html;1449.942002319907;1483.3695679336279;1616.9595760105997;1754.8859324143937;1757.4903278049367;7685.577293248869;7736.96131519343;7853.214678532158;7921.12867584566;7956.880646790296;7844.607769611511;7867.291943725064;7946.7615971520945;7948.364130869531;7971.083325417579;2271.057511132878;2284.7715228477186;2287.3481057898503;2292.33522278539;2292.919747808827;2316.0388438797877;2331.428799944016;2331.708536432946;2347.389678683546;2348.283773449097;2004.1382205651637;2047.7030830529638;2295.231097582312;2311.3297143828268;2322.6632138340015;2273.454370950968;2316.884155792212;2325.6046472099783;2326.0579465316405;2329.9068037278576;2252.2454977582365;2257.288953979508;2258.7176602924633;2262.9094836206696;2285.1544928376443;7652.846943061108;7665.425093118039;7701.460897737161;7712.6529306181355;7723.497972631761;4640.419947506562;4757.833475828329;4766.118268120409;4819.108464933998;4838.491958344358;2831.943361132766;2850.8717107729994;3004.519276915683;3026.273694313371;3032.802867813585;888.076400543434;919.0946917286467;921.9170274675245;950.1543626172712;954.0745476887478;10690.51892664832;10860.239783215178;10860.239783215178;10865.3480791152;10902.182336324728;4191.203671302504;4196.958030419718;4257.233697934402;4291.914161716748;4293.463317085364;8826.382153249338;8841.955790221007;8877.091425343582;8878.73363799087;8885.733427997171;4802.087603355351;4816.95183048172;4832.347633069561;4833.564979151823;4834.564889159992;4404.097160082176;4409.801558929856;4412.338149277634;4447.577480139382;4460.28635418338;3364.6971772540587;3393.6776006279365;3415.9146021349666;3417.333619944137;3435.089701229176;1070.357785328812;1083.7290677330668;1085.7502774361783;1097.226455348977;1098.5331234225582;960.4045491795132;969.6412327438752;1023.0690072034413;1051.2378525569054;1172.5075468303332;6905.723771049102;6951.131108611424;6966.233714291424;7036.472264580177;7049.330313620198;1085.853409789684;1086.1748295102293;1113;1127;1139.789139009286;5381.4349493303425;5396.352437707422;5415.810446634349;5422.1053526168525;5426.267453893753;9327.906720932839;9346.57940392684;9609.759756006155;9842.950785246172;9848.310618256797;9524.666636667684;9612.663556775618;9628.951855240679;9683.41899486033;9689.27330450219;7381.557106573623;7390;7560.659770310239;7580.9620951894885;7584.582847943416;6946.6179360135675;6989.965050174716;6990.231074581894;6992.475564332593;7027.648617569203;8319.542425166674;8403.579821009047;8485.406021578678;8614.18165274298;8691.304695624209;8827.534114513339;8951.239144672776;8963.820723585623;9033.277337813091;9120.863187052068;6725.361090696376;6838.589684618939;6858.3827455529245;6865.931340686729;6867.965660171667;7523.059617547807;7543.283388078124;7575.545467271982;7623.9326494289735;7639.618019099134;6974.860502790018;7064.258252883374;7173.1392232932385;7315.195328513752;7316.378107860679;6717.697703603252;6764;6801.319868013357;6832.658367081725;6845.794626161223;6743.629100399525;6822.283660215804;6824.215215250111;6839.6580170990255;6839.658017099225;6027.065804800263;6081.817545473643;6088.665123418255;6108.02271636536;6129.908051379322;6180.969095154495;6235.095911092775;6249.1563638908165;6272;6280.0893870389455 21:21:29 INFO - PROCESS | 12339 | |4;prototype.html;316.33411668437935;335.2992246205431;341.0433733377874;342.5461263825432;347.423277359583;6252.499800015999;6253.46845518131;6277.937220627787;6282.780102696406;6413.358664133584;6203.286622038467;6216.813495595139;6238.688065596724;6239.532035097374;6278.0269058296035;4767.952320476786;4771.165046116933;4773.474917759044;4773.546513081261;4786.83246086387;4765.26138448541;4770.6422018348585;4772.80908763649;4790.59279961202;4793.664443488957;4650.697704649187;4712.222483290253;4713;4726;4730.621550275987;4690.038542098896;4694.295855621667;4702.553257440538;4703.741294228816;4737.170995075848;4111.8560850370095;4127.711060225785;4133.2973394522705;4138.193052354792;4139.151473947833;5928.140419639171;5997.520198384119;6012.819615411545;6017.548683848729;6031.849203769897;5390.272313237702;5514.200440936042;5515.889682206333;5526.530244929186;5545.667259964415;6605.273419923805;6620.510385163348;6620.6358650274215;6621.073049773036;6641.0370496277765;4538.568835960578;4553.066621342617;4566.611837993774;4568.565986231302;4576.107659006495;6729.798106056826;6762.087118239024;6803.829904252384;6832.863342733167;6864.5881247124835;4614.607758340511;4633.814647414066;4633.837815676435;4638.257878739386;4642.814287428465;4693.718376897329;4697.436307643036;4699.036697477009;4699.95300047002;4712.646551508582;5419.620626556182;5448.711541152726;5455.454454554592;5455.645383050169;5455.945440545624;6388.361163883575;6600.966995165089;6611.107500487373;6627.469802415795;6644.833879152963;1619.902805831654;1640.196303811124;1654.454030170041;1664.9750253746204;1671.4901954903871;1071.3678929431674;1086.6905379018265;1103.6854496468468;1115.6931843743037;1126.1553834624033;6236.563440559117;6244.594101383486;6248.937510624926;6251.74993000284;6262.279837818709;6734.595924244561;6774.9661251694415;6778.3221677831825;6781;6785.117934668461;6102.298235702862;6204.627722336674;6248.187735594343;6249.531285153632;6251.468625166912;3659.469376940329;3674.2284120334493;3688.944665830015;3690.9077273068388;3695.8542851716056;7045.260247674023;7046.4715146363205;7048.823779405556;7053.717851285891;7069.646517674096;6719.294474080249;6863.862722745617;6884.105066341343;6886;6892.448604111659;7043.718251269892;7052.224255331909;7053.259407762111;7053.612051337226;7054.6472676365975;6736.494762892705;6743.9325606743305;6747.426468750211;6749.0888730020815;6793.218779840382;6559.147310849559;6652.168478940132;6654.434373078343;6661.067450556829;6690.565113267622;7002.0547226125855;7047.47143964215;7059.364657180879;7071.398931090709;7072.151341838807;4598.517155698737;4606.124836281096;4607.055553611434;4614.215583350771;4643.071385722937;6654;6690.933090669226;6733.124693789776;6764.8985265222045;6931.584104953719;6701.262861085374;6723.865522689616;6730.158730158731;6738.797836064926;6739.663016849236;6653.833654158685;6680.331966803281;6686.5653732507235;6697.0958920547055;6701;6447;6529.857274976765;6569.343065693392;6593.80218593443;6596.472282217315;6632.1709786276715;6656.534042617164;6659.633720145439;6660.134182556237;6661.566998145105;6549.443297319591;6569.770058048137;6570.47436205112;6570.638614876228;6581.769638062645 21:21:29 INFO - PROCESS | 12339 | |5;yui.html;717.9641017949104;745.817274767682;800.3797057280607;846.2341580869315;846.7925358287221;13557.389917453713;13721.313934303294;13890.097143685653;13895.444182232712;13905.096168749049;12482.126251162423;12599.181053231534;12626.431810568523;12662.556810511634;12896.742065158714;795.6379847169538;812.4962523235573;818.0755746007004;818.3862103422433;820.0118856777568;800.6237068577759;803.9316658084069;808.1675873849944;809.2514424157631;811.2050190813006;852.4160949749411;856.6958729650978;857.8498762716531;861.1431625532604;861.4874149880811;850.7873031742096;851.9563534670042;852.2798235491031;852.3436953545797;852.9977276699884;625.4871005775266;629.0375725140542;629.276332217953;629.3486241739823;631.9810405687791;14113.153210807282;14164.504242351572;14175.078619889675;14184.432622695183;14197.290135493287;12356.62930112089;12388;12626.17929834567;12674.049446291472;12713.93643031788;9923.106920377128;10059.597616095347;10108.494575271281;10201.38791672502;10566.841497377545;3394.592648882125;3543.1850674345046;3547.024568243728;3578.141246100943;3584.1039740064984;48036.51963480355;48126.75936620295;48739.26891096636;49508.25737613939;49520.25719614208;9541.952290238505;9608.471534065693;9627.711168664951;9665.130138287588;9676.080772326617;17427.39004134849;17432.5641858952;17550.82449175492;17810.19854106568;17859.821401786077;7291.270872912666;7583.810404739926;7590.620468976639;7601.581912994839;7748.147703752583;3955.624215699504;3955.960440395617;3983.581723918947;3986.720929534905;4025.1748391579654;3009.5636132761065;3069.4628440022907;3080.614923134608;3081.352915887644;3083.629964404286;558.3021223470662;579.5450571301592;586.5454272938507;590.2179612014013;593.9673317967553;479.38399157082983;498.22277247494026;564.8164346587375;568.4599630351183;613.6594190224469;7102.325279098477;7307.926920730831;7421.693952306133;7680.692772289158;7724.0731112266885;622.0855342646303;625.5996162456032;625.918630578022;637.2957881540831;664.2095905871997;4027.1140349123148;4107.4880976765035;4112.321466957978;4220.430241917364;4352.455943007124;53528;54261.72869135708;54705;54832;55062.449375506534;48320.75839620779;48955.510444895095;49025.754871225414;49138.754306228955;49307;43863.78068109639;44105.33841992437;44164;44412.3338149928;44936.77531612321;8065.395095367753;8250.917490825255;8339.874901876598;8425.368097392842;8473.788155296166;33638.49542256917;33989.32021359608;34314.656853431145;34593.82703086468;34752.826235868655;42014.159716806105;42089;42337.57662423336;42388.78805605952;42402.575974239866;10429.895701042893;10684.89315106839;11220.214584978972;11258.605948791754;11277.703064147729;11013.229073965065;11728.882711172779;11752.471138798946;11752.764944700886;11820.70448238801;9824.21406287481;9861.260405469475;10643.840342394715;10966.945165274123;11068.5572577096;9712;9758.170555502578;9972.60109595608;10059.409080323549;10480.056794888496;10726.892731072589;10962.123030157409;10993.725156870822;11142.888571114185;11221.27061741017;8803.955980220058;8819.426737262058;8928.15182557656;8983.640654373752;9704.223662106873;9571.28215383835;10029.14752246038;10042;10045.196384289386;10085.445300508543 21:21:29 INFO - PROCESS | 12339 | __end_tp_report 21:21:29 INFO - PROCESS | 12339 | __start_cc_report 21:21:29 INFO - PROCESS | 12339 | _x_x_mozilla_cycle_collect,325 21:21:29 INFO - PROCESS | 12339 | __end_cc_report 21:21:29 INFO - PROCESS | 12339 | __startTimestamp1452835289569__endTimestamp 21:21:29 INFO - PROCESS | 12339 | 21:21:29 INFO - PROCESS | 12339 | ------- Summary: start ------- 21:21:29 INFO - PROCESS | 12339 | Number of tests: 6 21:21:29 INFO - PROCESS | 12339 | 21:21:29 INFO - PROCESS | 12339 | [#0] dojo.html Cycles:165 Average:5138.84 Median:5315.92 stddev:550.39 (10.4%) stddev-sans-first:529.61 21:21:29 INFO - PROCESS | 12339 | Values: 3154.8 3167.2 3180.0 3204.8 3219.0 5039.8 5102.0 5108.5 5108.5 5145.7 5047.9 5152.3 5168.4 5169.8 5187.3 4434.3 4683.3 4831.6 4845.5 4891.1 4625.9 4755.1 4804.8 4822.3 4828.3 4617.0 4672.6 4709.7 4767.9 4781.5 4703.0 4704.2 4704.9 4740.4 4741.5 4649.6 4694.5 4722.3 4748.0 4762.8 4970.6 4975.9 4994.7 5079.8 5086.5 5519.5 5521.9 5528.9 5532.6 5538.7 5541.6 5549.9 5552.7 5556.1 5567.9 5157.2 5194.3 5198.8 5203.7 5232.4 5627.9 5640.4 5640.6 5646.7 5648.3 5376.1 5452.9 5472.6 5502.7 5550.3 5318.3 5377.9 5382.1 5387.0 5394.2 5329.3 5360.6 5401.2 5554.9 5612.2 5540.7 5541.9 5549.8 5565.3 5574.8 4319.8 4333.0 4346.3 4365.1 4381.4 3809.8 3821.7 3849.4 3858.8 3859.8 5116.6 5139.5 5141.0 5144.1 5150.7 5388.2 5437.3 5487.2 5494.4 5495.3 5108.7 5130.3 5150.0 5155.1 5204.9 4718.5 4727.3 4739.3 4746.5 4790.3 5612.2 5701.1 5772.0 5806.7 5809.7 5562.6 5576.2 5593.4 5628.6 5667.7 5762.0 5788.5 5792.9 5797.4 5801.0 5156.8 5263.2 5455.1 5522.7 5541.8 5468.0 5542.1 5560.5 5576.5 5604.9 5405.6 5422.6 5429.9 5437.9 5485.2 5346.6 5410.8 5435.7 5436.0 5508.5 5267.1 5315.5 5315.9 5320.9 5367.1 5387.1 5435.8 5457.2 5465.6 5523.9 5222.6 5299.7 5302.2 5388.1 5396.9 21:21:29 INFO - PROCESS | 12339 | 21:21:29 INFO - PROCESS | 12339 | [#1] ext.html Cycles:180 Average:43020.95 Median:18530.38 stddev:70321.97 (379.5%) stddev-sans-first:70446.91 21:21:29 INFO - PROCESS | 12339 | Values: 539.6 547.5 555.5 558.3 564.7 35273.3 35871.1 35956.5 35981.3 36037.8 40360.6 40780.0 40852.6 40885.8 40992.0 8425.6 8628.6 8629.9 8634.8 8645.8 8247.9 8271.0 8347.8 8523.9 8544.4 8499.6 8547.4 8563.7 8587.1 8594.6 8540.1 8589.1 8595.9 8597.6 8598.5 8341.0 8446.6 8453.8 8454.0 8464.0 39464.0 39885.2 39885.2 39970.4 40057.4 2633.4 2806.2 3031.2 3096.5 3202.5 26584.6 26732.3 27017.9 27102.5 27253.0 3233.1 3240.4 3272.8 3363.1 3473.8 179789.0 180082.0 180390.0 180504.0 182489.0 52455.2 53117.7 54670.2 57283.1 59297.1 57334.7 57486.0 57566.7 57669.0 57723.4 16392.6 16624.4 16658.0 16670.1 16688.7 12638.9 12807.6 12842.6 12843.7 12917.1 19179.6 19381.5 19430.4 19450.3 19479.3 7481.2 7608.5 7673.7 7707.8 7758.3 912.5 976.3 1099.0 1114.6 1120.1 27504.2 27547.2 27948.7 28232.3 28277.3 1024.5 1057.7 1118.7 1122.6 1124.1 14610.3 14789.4 15137.2 15470.9 15693.1 311984.0 312985.0 313524.0 313724.0 317044.0 51303.0 51756.2 51886.7 52083.5 52228.0 1350.1 1371.3 1378.1 1383.6 1385.4 27691.2 28775.7 28885.0 29206.2 29465.3 44702.3 45005.0 45117.0 45122.3 45226.3 290152.0 291686.0 293003.0 293714.0 293922.0 30584.2 31037.8 31167.8 31956.4 32006.2 37623.2 37772.6 38396.4 38414.0 38972.0 32044.4 32314.4 33086.8 33383.8 33697.7 34526.3 35097.1 35706.8 35999.8 36556.8 34048.5 34310.0 34920.5 34955.1 35000.3 26484.7 27365.6 28562.9 32109.7 33431.7 23429.5 23698.2 24953.5 26549.9 26739.2 21:21:29 INFO - PROCESS | 12339 | 21:21:29 INFO - PROCESS | 12339 | [#2] jquery.html Cycles:180 Average:23691.84 Median:403124.50 stddev:69620.58 (17.3%) stddev-sans-first:69793.83 21:21:29 INFO - PROCESS | 12339 | Values: 350.9 353.4 355.0 355.7 360.2 15789.0 16682.7 16914.4 17563.6 18382.8 11600.8 11605.7 11633.0 12498.8 16698.0 4949.2 5025.6 5530.9 5555.1 5570.2 4481.1 5450.3 5487.6 5504.1 5521.7 5461.9 5478.5 5483.2 5501.6 5508.3 4953.3 5046.9 5063.2 5474.1 5484.0 4905.1 4907.3 4911.9 4913.8 4928.8 16935.9 19510.2 19997.0 20168.8 20176.7 1935.1 1961.6 1993.4 2092.1 2132.1 9693.7 9703.9 9786.5 9812.1 9850.0 1759.9 1771.5 1804.4 1810.1 1818.0 36378.0 46044.8 57736.7 58014.7 59120.4 9959.3 10167.2 10304.3 10312.6 10367.7 12364.2 12903.3 12903.7 12990.1 13307.7 7212.0 7381.2 7682.1 7702.2 7738.3 7464.8 7483.1 7496.0 7504.5 7514.2 4343.8 4395.1 4412.6 4431.3 4441.5 1824.2 1851.5 1857.7 1888.3 1892.0 862.2 866.5 905.6 941.0 956.9 15769.8 16135.1 16310.0 16401.2 16511.1 807.2 855.1 909.4 929.5 957.7 9310.0 10066.2 10215.3 10220.8 10227.2 391352.0 396399.0 402591.0 403658.0 517697.0 68966.3 72570.3 74148.6 75013.0 75832.6 1139.9 1141.4 1154.3 1171.1 1176.5 14865.2 15145.7 15265.6 15401.0 15585.8 27027.5 27198.9 27953.6 30673.7 31109.7 37415.1 38421.8 38678.0 39216.8 39558.4 7104.1 7431.7 7535.9 7546.1 7561.5 9590.7 11021.4 11199.4 11458.5 11643.4 9133.2 9755.5 9880.2 9925.2 9991.6 3167.1 5480.7 7780.2 10093.4 10183.2 3269.2 3273.0 9182.3 9759.9 10030.6 7371.2 7424.7 7512.8 7544.8 7622.9 9259.7 10066.3 10097.0 10243.6 10358.7 21:21:29 INFO - PROCESS | 12339 | 21:21:29 INFO - PROCESS | 12339 | [#3] mootools.html Cycles:180 Average:5444.99 Median:6260.58 stddev:2864.14 (45.7%) stddev-sans-first:2856.44 21:21:29 INFO - PROCESS | 12339 | Values: 1449.9 1483.4 1617.0 1754.9 1757.5 7685.6 7737.0 7853.2 7921.1 7956.9 7844.6 7867.3 7946.8 7948.4 7971.1 2271.1 2284.8 2287.3 2292.3 2292.9 2316.0 2331.4 2331.7 2347.4 2348.3 2004.1 2047.7 2295.2 2311.3 2322.7 2273.5 2316.9 2325.6 2326.1 2329.9 2252.2 2257.3 2258.7 2262.9 2285.2 7652.8 7665.4 7701.5 7712.7 7723.5 4640.4 4757.8 4766.1 4819.1 4838.5 2831.9 2850.9 3004.5 3026.3 3032.8 888.1 919.1 921.9 950.2 954.1 10690.5 10860.2 10860.2 10865.3 10902.2 4191.2 4197.0 4257.2 4291.9 4293.5 8826.4 8842.0 8877.1 8878.7 8885.7 4802.1 4817.0 4832.3 4833.6 4834.6 4404.1 4409.8 4412.3 4447.6 4460.3 3364.7 3393.7 3415.9 3417.3 3435.1 1070.4 1083.7 1085.8 1097.2 1098.5 960.4 969.6 1023.1 1051.2 1172.5 6905.7 6951.1 6966.2 7036.5 7049.3 1085.9 1086.2 1113.0 1127.0 1139.8 5381.4 5396.4 5415.8 5422.1 5426.3 9327.9 9346.6 9609.8 9843.0 9848.3 9524.7 9612.7 9629.0 9683.4 9689.3 7381.6 7390.0 7560.7 7581.0 7584.6 6946.6 6990.0 6990.2 6992.5 7027.6 8319.5 8403.6 8485.4 8614.2 8691.3 8827.5 8951.2 8963.8 9033.3 9120.9 6725.4 6838.6 6858.4 6865.9 6868.0 7523.1 7543.3 7575.5 7623.9 7639.6 6974.9 7064.3 7173.1 7315.2 7316.4 6717.7 6764.0 6801.3 6832.7 6845.8 6743.6 6822.3 6824.2 6839.7 6839.7 6027.1 6081.8 6088.7 6108.0 6129.9 6181.0 6235.1 6249.2 6272.0 6280.1 21:21:29 INFO - PROCESS | 12339 | 21:21:29 INFO - PROCESS | 12339 | [#4] prototype.html Cycles:180 Average:5511.36 Median:6250.50 stddev:1668.03 (26.7%) stddev-sans-first:1626.49 21:21:29 INFO - PROCESS | 12339 | Values: 316.3 335.3 341.0 342.5 347.4 6252.5 6253.5 6277.9 6282.8 6413.4 6203.3 6216.8 6238.7 6239.5 6278.0 4768.0 4771.2 4773.5 4773.5 4786.8 4765.3 4770.6 4772.8 4790.6 4793.7 4650.7 4712.2 4713.0 4726.0 4730.6 4690.0 4694.3 4702.6 4703.7 4737.2 4111.9 4127.7 4133.3 4138.2 4139.2 5928.1 5997.5 6012.8 6017.5 6031.8 5390.3 5514.2 5515.9 5526.5 5545.7 6605.3 6620.5 6620.6 6621.1 6641.0 4538.6 4553.1 4566.6 4568.6 4576.1 6729.8 6762.1 6803.8 6832.9 6864.6 4614.6 4633.8 4633.8 4638.3 4642.8 4693.7 4697.4 4699.0 4700.0 4712.6 5419.6 5448.7 5455.5 5455.6 5455.9 6388.4 6601.0 6611.1 6627.5 6644.8 1619.9 1640.2 1654.5 1665.0 1671.5 1071.4 1086.7 1103.7 1115.7 1126.2 6236.6 6244.6 6248.9 6251.7 6262.3 6734.6 6775.0 6778.3 6781.0 6785.1 6102.3 6204.6 6248.2 6249.5 6251.5 3659.5 3674.2 3688.9 3690.9 3695.9 7045.3 7046.5 7048.8 7053.7 7069.6 6719.3 6863.9 6884.1 6886.0 6892.4 7043.7 7052.2 7053.3 7053.6 7054.6 6736.5 6743.9 6747.4 6749.1 6793.2 6559.1 6652.2 6654.4 6661.1 6690.6 7002.1 7047.5 7059.4 7071.4 7072.2 4598.5 4606.1 4607.1 4614.2 4643.1 6654.0 6690.9 6733.1 6764.9 6931.6 6701.3 6723.9 6730.2 6738.8 6739.7 6653.8 6680.3 6686.6 6697.1 6701.0 6447.0 6529.9 6569.3 6593.8 6596.5 6632.2 6656.5 6659.6 6660.1 6661.6 6549.4 6569.8 6570.5 6570.6 6581.8 21:21:29 INFO - PROCESS | 12339 | 21:21:29 INFO - PROCESS | 12339 | [#5] yui.html Cycles:180 Average:13367.62 Median:48223.76 stddev:15370.17 (31.9%) stddev-sans-first:15383.93 21:21:29 INFO - PROCESS | 12339 | Values: 718.0 745.8 800.4 846.2 846.8 13557.4 13721.3 13890.1 13895.4 13905.1 12482.1 12599.2 12626.4 12662.6 12896.7 795.6 812.5 818.1 818.4 820.0 800.6 803.9 808.2 809.3 811.2 852.4 856.7 857.8 861.1 861.5 850.8 852.0 852.3 852.3 853.0 625.5 629.0 629.3 629.3 632.0 14113.2 14164.5 14175.1 14184.4 14197.3 12356.6 12388.0 12626.2 12674.0 12713.9 9923.1 10059.6 10108.5 10201.4 10566.8 3394.6 3543.2 3547.0 3578.1 3584.1 48036.5 48126.8 48739.3 49508.3 49520.3 9542.0 9608.5 9627.7 9665.1 9676.1 17427.4 17432.6 17550.8 17810.2 17859.8 7291.3 7583.8 7590.6 7601.6 7748.1 3955.6 3956.0 3983.6 3986.7 4025.2 3009.6 3069.5 3080.6 3081.4 3083.6 558.3 579.5 586.5 590.2 594.0 479.4 498.2 564.8 568.5 613.7 7102.3 7307.9 7421.7 7680.7 7724.1 622.1 625.6 625.9 637.3 664.2 4027.1 4107.5 4112.3 4220.4 4352.5 53528.0 54261.7 54705.0 54832.0 55062.4 48320.8 48955.5 49025.8 49138.8 49307.0 43863.8 44105.3 44164.0 44412.3 44936.8 8065.4 8250.9 8339.9 8425.4 8473.8 33638.5 33989.3 34314.7 34593.8 34752.8 42014.2 42089.0 42337.6 42388.8 42402.6 10429.9 10684.9 11220.2 11258.6 11277.7 11013.2 11728.9 11752.5 11752.8 11820.7 9824.2 9861.3 10643.8 10966.9 11068.6 9712.0 9758.2 9972.6 10059.4 10480.1 10726.9 10962.1 10993.7 11142.9 11221.3 8804.0 8819.4 8928.2 8983.6 9704.2 9571.3 10029.1 10042.0 10045.2 10085.4 21:21:29 INFO - PROCESS | 12339 | -------- Summary: end -------- 21:21:29 INFO - PROCESS | 12339 | 21:21:30 INFO - TEST-INFO | 12339: exit 0 21:21:30 INFO - TEST-OK | dromaeo_css | took 1110091ms 21:21:30 INFO - TEST-START | kraken 21:21:30 INFO - operating with platform_type : linux_ 21:21:30 INFO - Initialising browser for kraken test... 21:21:30 INFO - TEST-INFO | started process 12577 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpc_MWoA/profile http://localhost:35870/getInfo.html) 21:21:33 INFO - PROCESS | 12577 | 21:21:33 INFO - PROCESS | 12577 | (process:12647): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:21:34 INFO - PROCESS | 12577 | __metrics Screen width/height:1600/1200 21:21:34 INFO - PROCESS | 12577 | colorDepth:24 21:21:34 INFO - PROCESS | 12577 | Browser inner width/height: 1024/697 21:21:34 INFO - PROCESS | 12577 | __metrics 21:21:34 INFO - PROCESS | 12577 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:21:35 INFO - TEST-INFO | 12577: exit 0 21:21:35 INFO - Browser initialized. 21:21:35 INFO - Running cycle 1/1 for kraken test... 21:21:35 INFO - TEST-INFO | started process 12696 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpc_MWoA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:21:36 INFO - PROCESS | 12696 | 21:21:36 INFO - PROCESS | 12696 | (process:12757): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:21:46 INFO - PROCESS | 12696 | RSS: Main: 150482944 21:21:46 INFO - PROCESS | 12696 | 21:21:49 INFO - PROCESS | 12696 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35870/tests/kraken/driver.html?testName=audio-beat-detection) 21:21:50 INFO - PROCESS | 12696 | RSS: Main: 150659072 21:21:50 INFO - PROCESS | 12696 | 21:21:52 INFO - PROCESS | 12696 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35870/tests/kraken/driver.html?testName=audio-dft) 21:21:53 INFO - PROCESS | 12696 | RSS: Main: 152645632 21:21:53 INFO - PROCESS | 12696 | 21:21:56 INFO - PROCESS | 12696 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35870/tests/kraken/driver.html?testName=audio-fft) 21:21:56 INFO - PROCESS | 12696 | RSS: Main: 148316160 21:21:56 INFO - PROCESS | 12696 | 21:21:58 INFO - PROCESS | 12696 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35870/tests/kraken/driver.html?testName=audio-oscillator) 21:21:59 INFO - PROCESS | 12696 | RSS: Main: 148090880 21:21:59 INFO - PROCESS | 12696 | 21:22:01 INFO - PROCESS | 12696 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35870/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:22:02 INFO - PROCESS | 12696 | RSS: Main: 148660224 21:22:02 INFO - PROCESS | 12696 | 21:22:05 INFO - PROCESS | 12696 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35870/tests/kraken/driver.html?testName=imaging-darkroom) 21:22:05 INFO - PROCESS | 12696 | RSS: Main: 148189184 21:22:05 INFO - PROCESS | 12696 | 21:22:09 INFO - PROCESS | 12696 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35870/tests/kraken/driver.html?testName=imaging-desaturate) 21:22:09 INFO - PROCESS | 12696 | RSS: Main: 148582400 21:22:09 INFO - PROCESS | 12696 | 21:22:12 INFO - PROCESS | 12696 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35870/tests/kraken/driver.html?testName=json-parse-financial) 21:22:13 INFO - PROCESS | 12696 | RSS: Main: 148979712 21:22:13 INFO - PROCESS | 12696 | 21:22:14 INFO - PROCESS | 12696 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35870/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:22:15 INFO - PROCESS | 12696 | RSS: Main: 148738048 21:22:15 INFO - PROCESS | 12696 | 21:22:17 INFO - PROCESS | 12696 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35870/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:22:17 INFO - PROCESS | 12696 | RSS: Main: 149155840 21:22:17 INFO - PROCESS | 12696 | 21:22:19 INFO - PROCESS | 12696 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35870/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:22:20 INFO - PROCESS | 12696 | RSS: Main: 149536768 21:22:20 INFO - PROCESS | 12696 | 21:22:22 INFO - PROCESS | 12696 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35870/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:22:23 INFO - PROCESS | 12696 | RSS: Main: 150011904 21:22:23 INFO - PROCESS | 12696 | 21:22:26 INFO - PROCESS | 12696 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35870/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:22:26 INFO - PROCESS | 12696 | RSS: Main: 149041152 21:22:26 INFO - PROCESS | 12696 | 21:22:28 INFO - PROCESS | 12696 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35870/tests/kraken/driver.html?testName=ai-astar) 21:22:28 INFO - PROCESS | 12696 | RSS: Main: 150065152 21:22:28 INFO - PROCESS | 12696 | 21:22:28 INFO - PROCESS | 12696 | __start_tp_report 21:22:28 INFO - PROCESS | 12696 | _x_x_mozilla_page_load 21:22:28 INFO - PROCESS | 12696 | _x_x_mozilla_page_load_details 21:22:28 INFO - PROCESS | 12696 | |i|pagename|runs| 21:22:28 INFO - PROCESS | 12696 | |0;ai-astar;110;105;110;110;111;123;111;110;112;112 21:22:28 INFO - PROCESS | 12696 | |1;audio-beat-detection;160;127;148;166;130;148;155;127;166;127 21:22:28 INFO - PROCESS | 12696 | |2;audio-dft;160;164;165;163;162;162;163;165;169;163 21:22:28 INFO - PROCESS | 12696 | |3;audio-fft;72;72;71;74;73;73;160;72;75;75 21:22:28 INFO - PROCESS | 12696 | |4;audio-oscillator;97;98;141;96;97;97;136;97;97;139 21:22:28 INFO - PROCESS | 12696 | |5;imaging-gaussian-blur;110;110;111;109;110;110;109;111;110;110 21:22:28 INFO - PROCESS | 12696 | |6;imaging-darkroom;148;146;146;149;147;146;147;148;147;147 21:22:28 INFO - PROCESS | 12696 | |7;imaging-desaturate;97;97;97;96;96;97;96;96;96;96 21:22:28 INFO - PROCESS | 12696 | |8;json-parse-financial;58;59;60;57;58;59;64;58;57;59 21:22:28 INFO - PROCESS | 12696 | |9;json-stringify-tinderbox;66;70;68;68;67;68;67;68;67;68 21:22:28 INFO - PROCESS | 12696 | |10;stanford-crypto-aes;84;83;82;86;83;83;90;84;83;84 21:22:28 INFO - PROCESS | 12696 | |11;stanford-crypto-ccm;118;118;120;117;121;119;118;124;133;125 21:22:28 INFO - PROCESS | 12696 | |12;stanford-crypto-pbkdf2;139;150;147;147;152;149;149;150;150;151 21:22:28 INFO - PROCESS | 12696 | |13;stanford-crypto-sha256-iterative;73;69;70;69;71;70;69;70;68;74 21:22:28 INFO - PROCESS | 12696 | __end_tp_report 21:22:28 INFO - PROCESS | 12696 | __start_cc_report 21:22:28 INFO - PROCESS | 12696 | _x_x_mozilla_cycle_collect,744 21:22:28 INFO - PROCESS | 12696 | __end_cc_report 21:22:28 INFO - PROCESS | 12696 | __startTimestamp1452835348568__endTimestamp 21:22:28 INFO - PROCESS | 12696 | 21:22:28 INFO - PROCESS | 12696 | ------- Summary: start ------- 21:22:28 INFO - PROCESS | 12696 | Number of tests: 14 21:22:28 INFO - PROCESS | 12696 | 21:22:28 INFO - PROCESS | 12696 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.00 stddev:4.53 (4.1%) stddev-sans-first:4.77 21:22:28 INFO - PROCESS | 12696 | Values: 110.0 105.0 110.0 110.0 111.0 123.0 111.0 110.0 112.0 112.0 21:22:28 INFO - PROCESS | 12696 | 21:22:28 INFO - PROCESS | 12696 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:151.50 stddev:16.40 (10.8%) stddev-sans-first:16.52 21:22:28 INFO - PROCESS | 12696 | Values: 160.0 127.0 148.0 166.0 130.0 148.0 155.0 127.0 166.0 127.0 21:22:28 INFO - PROCESS | 12696 | 21:22:28 INFO - PROCESS | 12696 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:2.41 (1.5%) stddev-sans-first:2.18 21:22:28 INFO - PROCESS | 12696 | Values: 160.0 164.0 165.0 163.0 162.0 162.0 163.0 165.0 169.0 163.0 21:22:28 INFO - PROCESS | 12696 | 21:22:28 INFO - PROCESS | 12696 | [#3] audio-fft Cycles:10 Average:81.70 Median:73.00 stddev:27.54 (37.7%) stddev-sans-first:28.99 21:22:28 INFO - PROCESS | 12696 | Values: 72.0 72.0 71.0 74.0 73.0 73.0 160.0 72.0 75.0 75.0 21:22:28 INFO - PROCESS | 12696 | 21:22:28 INFO - PROCESS | 12696 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:97.00 stddev:20.17 (20.8%) stddev-sans-first:20.88 21:22:28 INFO - PROCESS | 12696 | Values: 97.0 98.0 141.0 96.0 97.0 97.0 136.0 97.0 97.0 139.0 21:22:28 INFO - PROCESS | 12696 | 21:22:28 INFO - PROCESS | 12696 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 21:22:28 INFO - PROCESS | 12696 | Values: 110.0 110.0 111.0 109.0 110.0 110.0 109.0 111.0 110.0 110.0 21:22:28 INFO - PROCESS | 12696 | 21:22:28 INFO - PROCESS | 12696 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:1.00 21:22:28 INFO - PROCESS | 12696 | Values: 148.0 146.0 146.0 149.0 147.0 146.0 147.0 148.0 147.0 147.0 21:22:28 INFO - PROCESS | 12696 | 21:22:28 INFO - PROCESS | 12696 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 21:22:28 INFO - PROCESS | 12696 | Values: 97.0 97.0 97.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 21:22:28 INFO - PROCESS | 12696 | 21:22:28 INFO - PROCESS | 12696 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:59.00 stddev:2.02 (3.4%) stddev-sans-first:2.12 21:22:28 INFO - PROCESS | 12696 | Values: 58.0 59.0 60.0 57.0 58.0 59.0 64.0 58.0 57.0 59.0 21:22:28 INFO - PROCESS | 12696 | 21:22:28 INFO - PROCESS | 12696 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:1.06 (1.6%) stddev-sans-first:0.93 21:22:28 INFO - PROCESS | 12696 | Values: 66.0 70.0 68.0 68.0 67.0 68.0 67.0 68.0 67.0 68.0 21:22:28 INFO - PROCESS | 12696 | 21:22:28 INFO - PROCESS | 12696 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:2.30 (2.7%) stddev-sans-first:2.44 21:22:28 INFO - PROCESS | 12696 | Values: 84.0 83.0 82.0 86.0 83.0 83.0 90.0 84.0 83.0 84.0 21:22:28 INFO - PROCESS | 12696 | 21:22:28 INFO - PROCESS | 12696 | [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:120.50 stddev:4.90 (4.1%) stddev-sans-first:5.05 21:22:28 INFO - PROCESS | 12696 | Values: 118.0 118.0 120.0 117.0 121.0 119.0 118.0 124.0 133.0 125.0 21:22:28 INFO - PROCESS | 12696 | 21:22:28 INFO - PROCESS | 12696 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.40 Median:150.00 stddev:3.66 (2.4%) stddev-sans-first:1.67 21:22:28 INFO - PROCESS | 12696 | Values: 139.0 150.0 147.0 147.0 152.0 149.0 149.0 150.0 150.0 151.0 21:22:28 INFO - PROCESS | 12696 | 21:22:28 INFO - PROCESS | 12696 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.00 stddev:1.89 (2.7%) stddev-sans-first:1.73 21:22:28 INFO - PROCESS | 12696 | Values: 73.0 69.0 70.0 69.0 71.0 70.0 69.0 70.0 68.0 74.0 21:22:28 INFO - PROCESS | 12696 | -------- Summary: end -------- 21:22:28 INFO - PROCESS | 12696 | 21:22:29 INFO - TEST-INFO | 12696: exit 0 21:22:29 INFO - TEST-OK | kraken | took 59288ms 21:22:29 INFO - TEST-START | v8_7 21:22:29 INFO - operating with platform_type : linux_ 21:22:29 INFO - Initialising browser for v8_7 test... 21:22:29 INFO - TEST-INFO | started process 12985 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7J4vLu/profile http://localhost:35870/getInfo.html) 21:22:32 INFO - PROCESS | 12985 | 21:22:32 INFO - PROCESS | 12985 | (process:13058): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:22:33 INFO - PROCESS | 12985 | __metrics Screen width/height:1600/1200 21:22:33 INFO - PROCESS | 12985 | colorDepth:24 21:22:33 INFO - PROCESS | 12985 | Browser inner width/height: 1024/697 21:22:33 INFO - PROCESS | 12985 | __metrics 21:22:33 INFO - PROCESS | 12985 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:22:34 INFO - TEST-INFO | 12985: exit 0 21:22:34 INFO - Browser initialized. 21:22:34 INFO - Running cycle 1/1 for v8_7 test... 21:22:34 INFO - TEST-INFO | started process 13107 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7J4vLu/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:22:36 INFO - PROCESS | 13107 | 21:22:36 INFO - PROCESS | 13107 | (process:13164): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:22:46 INFO - PROCESS | 13107 | RSS: Main: 151175168 21:22:46 INFO - PROCESS | 13107 | 21:23:08 INFO - PROCESS | 13107 | Cycle 1(1): loaded http://localhost:35870/tests/v8_7/run.html (next: http://localhost:35870/tests/v8_7/run.html) 21:23:09 INFO - PROCESS | 13107 | RSS: Main: 145485824 21:23:09 INFO - PROCESS | 13107 | 21:23:09 INFO - PROCESS | 13107 | __start_tp_report 21:23:09 INFO - PROCESS | 13107 | _x_x_mozilla_page_load 21:23:09 INFO - PROCESS | 13107 | _x_x_mozilla_page_load_details 21:23:09 INFO - PROCESS | 13107 | |i|pagename|runs| 21:23:09 INFO - PROCESS | 13107 | |0;Richards;166.41704110500916 21:23:09 INFO - PROCESS | 13107 | |1;DeltaBlue;190.29495718363464 21:23:09 INFO - PROCESS | 13107 | |2;Encrypt;279.72027972027973 21:23:09 INFO - PROCESS | 13107 | |3;Decrypt;5229.166666666667 21:23:09 INFO - PROCESS | 13107 | |4;RayTrace;1078.7486515641856 21:23:09 INFO - PROCESS | 13107 | |5;Earley;713.2667617689016 21:23:09 INFO - PROCESS | 13107 | |6;Boyer;12500 21:23:09 INFO - PROCESS | 13107 | |7;RegExp;41612.244897959186 21:23:09 INFO - PROCESS | 13107 | |8;Splay;595.8333333333334 21:23:09 INFO - PROCESS | 13107 | |9;NavierStokes;4845.410628019324 21:23:09 INFO - PROCESS | 13107 | __end_tp_report 21:23:09 INFO - PROCESS | 13107 | __startTimestamp1452835389224__endTimestamp 21:23:09 INFO - PROCESS | 13107 | 21:23:09 INFO - PROCESS | 13107 | ------- Summary: start ------- 21:23:09 INFO - PROCESS | 13107 | Number of tests: 10 21:23:09 INFO - PROCESS | 13107 | 21:23:09 INFO - PROCESS | 13107 | [#0] Richards Cycles:1 Average:166.42 Median:166.42 stddev:0.00 (0.0%) 21:23:09 INFO - PROCESS | 13107 | Values: 166.4 21:23:09 INFO - PROCESS | 13107 | 21:23:09 INFO - PROCESS | 13107 | [#1] DeltaBlue Cycles:1 Average:190.29 Median:190.29 stddev:0.00 (0.0%) 21:23:09 INFO - PROCESS | 13107 | Values: 190.3 21:23:09 INFO - PROCESS | 13107 | 21:23:09 INFO - PROCESS | 13107 | [#2] Encrypt Cycles:1 Average:279.72 Median:279.72 stddev:0.00 (0.0%) 21:23:09 INFO - PROCESS | 13107 | Values: 279.7 21:23:09 INFO - PROCESS | 13107 | 21:23:09 INFO - PROCESS | 13107 | [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 21:23:09 INFO - PROCESS | 13107 | Values: 5229.2 21:23:09 INFO - PROCESS | 13107 | 21:23:09 INFO - PROCESS | 13107 | [#4] RayTrace Cycles:1 Average:1078.75 Median:1078.75 stddev:0.00 (0.0%) 21:23:09 INFO - PROCESS | 13107 | Values: 1078.7 21:23:09 INFO - PROCESS | 13107 | 21:23:09 INFO - PROCESS | 13107 | [#5] Earley Cycles:1 Average:713.27 Median:713.27 stddev:0.00 (0.0%) 21:23:09 INFO - PROCESS | 13107 | Values: 713.3 21:23:09 INFO - PROCESS | 13107 | 21:23:09 INFO - PROCESS | 13107 | [#6] Boyer Cycles:1 Average:12500.00 Median:12500.00 stddev:0.00 (0.0%) 21:23:09 INFO - PROCESS | 13107 | Values: 12500.0 21:23:09 INFO - PROCESS | 13107 | 21:23:09 INFO - PROCESS | 13107 | [#7] RegExp Cycles:1 Average:41612.24 Median:41612.24 stddev:0.00 (0.0%) 21:23:09 INFO - PROCESS | 13107 | Values: 41612.2 21:23:09 INFO - PROCESS | 13107 | 21:23:09 INFO - PROCESS | 13107 | [#8] Splay Cycles:1 Average:595.83 Median:595.83 stddev:0.00 (0.0%) 21:23:09 INFO - PROCESS | 13107 | Values: 595.8 21:23:09 INFO - PROCESS | 13107 | 21:23:09 INFO - PROCESS | 13107 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 21:23:09 INFO - PROCESS | 13107 | Values: 4845.4 21:23:09 INFO - PROCESS | 13107 | -------- Summary: end -------- 21:23:09 INFO - PROCESS | 13107 | 21:23:10 INFO - TEST-INFO | 13107: exit 0 21:23:10 INFO - TEST-OK | v8_7 | took 40570ms 21:23:10 INFO - SUITE-END | took 1209s 21:23:10 INFO - Completed test suite (00:20:10) 21:23:10 INFO - Working with test: dromaeo_css 21:23:10 INFO - Generating results file: dromaeo_css 21:23:10 INFO - Working with test: kraken 21:23:10 INFO - Generating results file: kraken 21:23:10 INFO - javascript benchmark 21:23:10 INFO - Working with test: v8_7 21:23:10 INFO - Generating results file: v8_7 21:23:10 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:23:10 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 21:23:10 INFO - process_Request line: dromaeo_css 6773.73 graph.html#tests=[[72,1,43]] 21:23:10 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:23:10 INFO - process_Request line: kraken 1515.90 graph.html#tests=[[232,1,43]] 21:23:10 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:23:10 INFO - process_Request line: v8_7 20289.69 graph.html#tests=[[230,1,43]] 21:23:10 INFO - RETURN: dromaeo_css: 6773.73 21:23:10 INFO - RETURN: kraken: 1515.90 21:23:10 INFO - RETURN: v8_7: 20289.69 21:23:10 INFO - javascript benchmark 21:23:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3154.842257887105, 3167.1607024138607, 3179.968200317996, 3204.8237346945925, 3218.967810321896, 5039.773210205541, 5101.9744901275535, 5108.4636113208135, 5108.514691104344, 5145.665531740434, 5047.924281135786, 5152.252923326116, 5168.3539557555305, 5169.844904652857, 5187.299714538536, 4434.290513517838, 4683.274092515657, 4831.637627177958, 4845.53967373099, 4891.1195984722735, 4625.907481850361, 4755.144074066667, 4804.783784729696, 4822.252550854606, 4828.324034635154, 4617.030423611029, 4672.556107169813, 4709.670323077386, 4767.928481072787, 4781.497942716, 4703.0, 4704.247320428715, 4704.9059018819435, 4740.407449068866, 4741.502142275046, 4649.604783593399, 4694.530546945312, 4722.338872557844, 4747.976260118678, 4762.833300834454, 4970.627202959792, 4975.90048199034, 4994.700317980896, 5079.771410286546, 5086.491350864921, 5519.530839878616, 5521.917171242435, 5528.917066244009, 5532.5573954083575, 5538.695371754552, 5541.639793413456, 5549.861253468695, 5552.666839989613, 5556.138798486241, 5567.8608034799045, 5157.226416037587, 5194.298769666085, 5198.844034678966, 5203.739813009334, 5232.39827419844, 5627.930693168285, 5640.379558248589, 5640.589852536866, 5646.6894320811925, 5648.322201335866, 5376.059189641797, 5452.91820622691, 5472.616916815864, 5502.669839809624, 5550.306211723535, 5318.25544423781, 5377.865553361197, 5382.085045542267, 5386.976474469838, 5394.190871369247, 5329.25390445338, 5360.624756267024, 5401.2168235606405, 5554.91667624986, 5612.1581762735095, 5540.722963851791, 5541.861453463615, 5549.778008879681, 5565.332160140809, 5574.832755017356, 4319.8488052918, 4332.956670433256, 4346.2828633275785, 4365.083332500147, 4381.40850985113, 3809.809509524568, 3821.7133714971487, 3849.364854798983, 3858.82635281413, 3859.7877116758846, 5116.641835071584, 5139.460356662571, 5141.0, 5144.099782538041, 5150.716710580879, 5388.191771234347, 5437.265969094201, 5487.204355368529, 5494.423085576037, 5495.34055913285, 5108.744562771846, 5130.333056702605, 5150.0472412603785, 5155.097857874857, 5204.9219261711105, 4718.4809670936165, 4727.290906364073, 4739.289106634033, 4746.477887432379, 4790.305405716152, 5612.214289999403, 5701.116326969326, 5771.989901767174, 5806.68063256525, 5809.7095145242565, 5562.554995600423, 5576.191452239484, 5593.384727679871, 5628.605997580294, 5667.716614169358, 5762.049261871744, 5788.53691704671, 5792.9283082629845, 5797.362290148165, 5800.970995144998, 5156.793728250978, 5263.23683065961, 5455.1271796512365, 5522.696251706195, 5541.778328866801, 5467.972660136674, 5542.140968149944, 5560.471755183251, 5576.525995290446, 5604.887902242014, 5405.567554595545, 5422.593305502182, 5429.945700542944, 5437.864053398696, 5485.204645326485, 5346.572274217975, 5410.83767486976, 5435.673859568438, 5435.972820135874, 5508.476694713996, 5267.051930652519, 5315.548178404879, 5315.920261196163, 5320.946790532045, 5367.114426119802, 5387.084195686664, 5435.83692489226, 5457.181422786613, 5465.59008074388, 5523.8895222094525, 5222.634415591024, 5299.655522391032, 5302.231176479466, 5388.057090009311, 5396.892062158657], "unit": "score", "name": "dojo.html", "value": 5104.979223502198}, {"lowerIsBetter": false, "replicates": [539.6195682044157, 547.4908335248219, 555.4834004375929, 558.2686680448612, 564.7204633706316, 35273.29453410934, 35871.10322241945, 35956.460653090195, 35981.280374392496, 36037.81981090091, 40360.59639403605, 40780.0, 40852.59147408525, 40885.79557102218, 40992.0, 8425.578721063937, 8628.568571571428, 8629.870551941694, 8634.827303453958, 8645.827083458327, 8247.917520824805, 8270.966129233846, 8347.83304333913, 8523.872141917876, 8544.401891867572, 8499.61751721174, 8547.401681882271, 8563.700270490534, 8587.055423903366, 8594.570271486433, 8540.103289154642, 8589.098144694779, 8595.914040859574, 8597.5701214939, 8598.484090954562, 8341.0, 8446.61990210442, 8453.788655283606, 8453.95773021131, 8463.95768021162, 39464.0, 39885.20229595392, 39885.20229595392, 39970.40044399336, 40057.39913901294, 2633.394319306551, 2806.2282872210103, 3031.2118849099393, 3096.47359948807, 3202.4876019836715, 26584.601230981552, 26732.33169170767, 27017.86491067552, 27102.45795084107, 27253.0, 3233.0785726067957, 3240.416724989501, 3272.8199949002797, 3363.091965169415, 3473.826308684581, 179789.0, 180082.0, 180390.0, 180504.0, 182488.99999999866, 52455.213171802454, 53117.7344113277, 54670.17994730082, 57283.14075288874, 59297.145685530304, 57334.7133264331, 57486.0, 57566.7121664389, 57668.9815856443, 57723.42276577181, 16392.590185245463, 16624.418145364853, 16658.0, 16670.083145427117, 16688.74966875498, 12638.873611263954, 12807.61577152687, 12842.550510732079, 12843.743125137446, 12917.095803293867, 19179.560993162962, 19381.51546211356, 19430.417087487396, 19450.319238826574, 19479.318223862098, 7481.177070522347, 7608.505447145918, 7673.693052277847, 7707.807304817312, 7758.3017528422715, 912.5026860361119, 976.3360914578155, 1099.0163803395915, 1114.6321713834416, 1120.0983208517223, 27504.17487475379, 27547.173584792487, 27948.72051279461, 28232.29419264535, 28277.293067673472, 1024.5491983527224, 1057.6932689520106, 1118.725912151528, 1122.5790328626765, 1124.0670243697712, 14610.342534585969, 14789.408423663148, 15137.243137843285, 15470.922645386701, 15693.136877471848, 311984.0, 312985.0, 313524.0, 313724.0, 317044.0, 51303.0, 51756.22365664518, 51886.740566296925, 52083.479165207864, 52228.0, 1350.0684527675871, 1371.2800779590796, 1378.0835744230176, 1383.5641772841523, 1385.3558095485648, 27691.169264922086, 28775.712242877304, 28885.0, 29206.200187763145, 29465.263368415963, 44702.3294650574, 45005.0, 45117.0, 45122.323165151895, 45226.32160517661, 290152.0, 291686.0, 293003.0, 293714.0, 293922.0, 30584.235394115327, 31037.8448107758, 31167.844160779052, 31956.36087278288, 32006.19984500313, 37623.2475350486, 37772.62227377691, 38396.42405363978, 38414.0, 38972.0, 32044.359112818078, 32314.35371292608, 33086.83456582798, 33383.83308083444, 33697.66302336945, 34526.309473810885, 35097.122571935906, 35706.821465892506, 35999.820000899825, 36556.81721591375, 34048.48927266044, 34310.0, 34920.47619285662, 34955.126121847155, 35000.29999399947, 26484.735152648227, 27365.589516156877, 28562.85718571394, 32109.678903210668, 33431.66568334286, 23429.531409371375, 23698.170564030177, 24953.500929980935, 26549.867250664396, 26739.197824065308], "unit": "score", "name": "ext.html", "value": 17791.33917613447}, {"lowerIsBetter": false, "replicates": [350.8771929824561, 353.44509120680544, 355.03430668581467, 355.66567426618974, 360.2093404976077, 15788.999999999985, 16682.66634667306, 16914.407995720154, 17563.56091097723, 18382.81617183826, 11600.825987610193, 11605.651830445078, 11633.011194048495, 12498.812517812241, 16698.0, 4949.2328689053165, 5025.597952163818, 5530.889382212354, 5555.111182210847, 5570.164475328713, 4481.126180394825, 5450.29146210992, 5487.6433031853, 5504.091824848895, 5521.696306703129, 5461.863453413676, 5478.506934375905, 5483.150111732688, 5501.614886957915, 5508.256385387961, 4953.281774142747, 5046.924296135561, 5063.18988961768, 5474.069408200596, 5484.0, 4905.068037072981, 4907.312976183337, 4911.8772030699165, 4913.754312284407, 4928.778204980785, 16935.915320423443, 19510.219591216333, 19997.0, 20168.79831201684, 20176.69734953977, 1935.090507461491, 1961.5880665060354, 1993.4219076467807, 2092.1213090501874, 2132.0618927671776, 9693.709188724279, 9703.854442183372, 9786.510674466248, 9812.116909478109, 9850.0, 1759.8504127149208, 1771.477414162825, 1804.404546499665, 1810.1039985207406, 1817.9909100454413, 36378.0, 46044.769776150904, 57736.71131644357, 58014.70992645052, 59120.40879591192, 9959.302848800515, 10167.23745719074, 10304.330218535772, 10312.639057633098, 10367.688969330931, 12364.1963272387, 12903.290319032356, 12903.741925161632, 12990.090693651542, 13307.667308317175, 7212.0, 7381.224971378036, 7682.116556595951, 7702.191269916578, 7738.342240909473, 7464.813379665443, 7483.064616922885, 7495.962520187473, 7504.549727016287, 7514.248575142551, 4343.847965321199, 4395.055063161436, 4412.602865742098, 4431.290993441034, 4441.533638967927, 1824.1882362348626, 1851.4639134121455, 1857.721341798741, 1888.282452668005, 1891.9621607567772, 862.2498426368974, 866.5450638414757, 905.5879574793453, 940.9952950235205, 956.8803899512561, 15769.763453548207, 16135.112568808829, 16310.021398715877, 16401.1799410029, 16511.09188994617, 807.1524898856178, 855.1363123245567, 909.4043401571981, 929.4980710416299, 957.6935380678116, 9310.0, 10066.245031622657, 10215.284930054824, 10220.846687299547, 10227.181825453947, 391352.0, 396399.0, 402591.0, 403658.0, 517697.0, 68966.31033689699, 72570.27429725636, 74148.62925685337, 75013.0, 75832.62083689656, 1139.943002849854, 1141.4406940599213, 1154.255505199142, 1171.0982543441503, 1176.5411489519095, 14865.182414967281, 15145.697086058437, 15265.6183595411, 15401.0, 15585.844141558438, 27027.459450811268, 27198.864005679847, 27953.580696289977, 30673.693263067085, 31109.68890311068, 37415.06462338354, 38421.807890960365, 38678.0, 39216.803915980236, 39558.40662390124, 7104.11198600175, 7431.70273189088, 7535.924640753522, 7546.132194797449, 7561.470697051153, 9590.657307977028, 11021.44892755375, 11199.440027998731, 11458.541658333574, 11643.359615220905, 9133.178013978773, 9755.463449510346, 9880.160186384237, 9925.205983521157, 9991.600335986479, 3167.0815463515323, 5480.72596370172, 7780.210551573056, 10093.444860532742, 10183.18534517222, 3269.182704323919, 3273.0, 9182.31132665066, 9759.901621151486, 10030.64892728751, 7371.152317483344, 7424.703011879465, 7512.774616761506, 7544.773656790305, 7622.885656715042, 9259.657349684392, 10066.29535932507, 10097.040781125781, 10243.641472548425, 10358.689239322832], "unit": "score", "name": "jquery.html", "value": 7851.281724097047}, {"lowerIsBetter": false, "replicates": [1449.942002319907, 1483.3695679336279, 1616.9595760105997, 1754.8859324143937, 1757.4903278049367, 7685.577293248869, 7736.96131519343, 7853.214678532158, 7921.12867584566, 7956.880646790296, 7844.607769611511, 7867.291943725064, 7946.7615971520945, 7948.364130869531, 7971.083325417579, 2271.057511132878, 2284.7715228477186, 2287.3481057898503, 2292.33522278539, 2292.919747808827, 2316.0388438797877, 2331.428799944016, 2331.708536432946, 2347.389678683546, 2348.283773449097, 2004.1382205651637, 2047.7030830529638, 2295.231097582312, 2311.3297143828268, 2322.6632138340015, 2273.454370950968, 2316.884155792212, 2325.6046472099783, 2326.0579465316405, 2329.9068037278576, 2252.2454977582365, 2257.288953979508, 2258.7176602924633, 2262.9094836206696, 2285.1544928376443, 7652.846943061108, 7665.425093118039, 7701.460897737161, 7712.6529306181355, 7723.497972631761, 4640.419947506562, 4757.833475828329, 4766.118268120409, 4819.108464933998, 4838.491958344358, 2831.943361132766, 2850.8717107729994, 3004.519276915683, 3026.273694313371, 3032.802867813585, 888.076400543434, 919.0946917286467, 921.9170274675245, 950.1543626172712, 954.0745476887478, 10690.51892664832, 10860.239783215178, 10860.239783215178, 10865.3480791152, 10902.182336324728, 4191.203671302504, 4196.958030419718, 4257.233697934402, 4291.914161716748, 4293.463317085364, 8826.382153249338, 8841.955790221007, 8877.091425343582, 8878.73363799087, 8885.733427997171, 4802.087603355351, 4816.95183048172, 4832.347633069561, 4833.564979151823, 4834.564889159992, 4404.097160082176, 4409.801558929856, 4412.338149277634, 4447.577480139382, 4460.28635418338, 3364.6971772540587, 3393.6776006279365, 3415.9146021349666, 3417.333619944137, 3435.089701229176, 1070.357785328812, 1083.7290677330668, 1085.7502774361783, 1097.226455348977, 1098.5331234225582, 960.4045491795132, 969.6412327438752, 1023.0690072034413, 1051.2378525569054, 1172.5075468303332, 6905.723771049102, 6951.131108611424, 6966.233714291424, 7036.472264580177, 7049.330313620198, 1085.853409789684, 1086.1748295102293, 1113.0, 1127.0, 1139.789139009286, 5381.4349493303425, 5396.352437707422, 5415.810446634349, 5422.1053526168525, 5426.267453893753, 9327.906720932839, 9346.57940392684, 9609.759756006155, 9842.950785246172, 9848.310618256797, 9524.666636667684, 9612.663556775618, 9628.951855240679, 9683.41899486033, 9689.27330450219, 7381.557106573623, 7390.0, 7560.659770310239, 7580.9620951894885, 7584.582847943416, 6946.6179360135675, 6989.965050174716, 6990.231074581894, 6992.475564332593, 7027.648617569203, 8319.542425166674, 8403.579821009047, 8485.406021578678, 8614.18165274298, 8691.304695624209, 8827.534114513339, 8951.239144672776, 8963.820723585623, 9033.277337813091, 9120.863187052068, 6725.361090696376, 6838.589684618939, 6858.3827455529245, 6865.931340686729, 6867.965660171667, 7523.059617547807, 7543.283388078124, 7575.545467271982, 7623.9326494289735, 7639.618019099134, 6974.860502790018, 7064.258252883374, 7173.1392232932385, 7315.195328513752, 7316.378107860679, 6717.697703603252, 6764.0, 6801.319868013357, 6832.658367081725, 6845.794626161223, 6743.629100399525, 6822.283660215804, 6824.215215250111, 6839.6580170990255, 6839.658017099225, 6027.065804800263, 6081.817545473643, 6088.665123418255, 6108.02271636536, 6129.908051379322, 6180.969095154495, 6235.095911092775, 6249.1563638908165, 6272.0, 6280.0893870389455], "unit": "score", "name": "mootools.html", "value": 4443.601312703547}, {"lowerIsBetter": false, "replicates": [316.33411668437935, 335.2992246205431, 341.0433733377874, 342.5461263825432, 347.423277359583, 6252.499800015999, 6253.46845518131, 6277.937220627787, 6282.780102696406, 6413.358664133584, 6203.286622038467, 6216.813495595139, 6238.688065596724, 6239.532035097374, 6278.0269058296035, 4767.952320476786, 4771.165046116933, 4773.474917759044, 4773.546513081261, 4786.83246086387, 4765.26138448541, 4770.6422018348585, 4772.80908763649, 4790.59279961202, 4793.664443488957, 4650.697704649187, 4712.222483290253, 4713.0, 4726.0, 4730.621550275987, 4690.038542098896, 4694.295855621667, 4702.553257440538, 4703.741294228816, 4737.170995075848, 4111.8560850370095, 4127.711060225785, 4133.2973394522705, 4138.193052354792, 4139.151473947833, 5928.140419639171, 5997.520198384119, 6012.819615411545, 6017.548683848729, 6031.849203769897, 5390.272313237702, 5514.200440936042, 5515.889682206333, 5526.530244929186, 5545.667259964415, 6605.273419923805, 6620.510385163348, 6620.6358650274215, 6621.073049773036, 6641.0370496277765, 4538.568835960578, 4553.066621342617, 4566.611837993774, 4568.565986231302, 4576.107659006495, 6729.798106056826, 6762.087118239024, 6803.829904252384, 6832.863342733167, 6864.5881247124835, 4614.607758340511, 4633.814647414066, 4633.837815676435, 4638.257878739386, 4642.814287428465, 4693.718376897329, 4697.436307643036, 4699.036697477009, 4699.95300047002, 4712.646551508582, 5419.620626556182, 5448.711541152726, 5455.454454554592, 5455.645383050169, 5455.945440545624, 6388.361163883575, 6600.966995165089, 6611.107500487373, 6627.469802415795, 6644.833879152963, 1619.902805831654, 1640.196303811124, 1654.454030170041, 1664.9750253746204, 1671.4901954903871, 1071.3678929431674, 1086.6905379018265, 1103.6854496468468, 1115.6931843743037, 1126.1553834624033, 6236.563440559117, 6244.594101383486, 6248.937510624926, 6251.74993000284, 6262.279837818709, 6734.595924244561, 6774.9661251694415, 6778.3221677831825, 6781.0, 6785.117934668461, 6102.298235702862, 6204.627722336674, 6248.187735594343, 6249.531285153632, 6251.468625166912, 3659.469376940329, 3674.2284120334493, 3688.944665830015, 3690.9077273068388, 3695.8542851716056, 7045.260247674023, 7046.4715146363205, 7048.823779405556, 7053.717851285891, 7069.646517674096, 6719.294474080249, 6863.862722745617, 6884.105066341343, 6886.0, 6892.448604111659, 7043.718251269892, 7052.224255331909, 7053.259407762111, 7053.612051337226, 7054.6472676365975, 6736.494762892705, 6743.9325606743305, 6747.426468750211, 6749.0888730020815, 6793.218779840382, 6559.147310849559, 6652.168478940132, 6654.434373078343, 6661.067450556829, 6690.565113267622, 7002.0547226125855, 7047.47143964215, 7059.364657180879, 7071.398931090709, 7072.151341838807, 4598.517155698737, 4606.124836281096, 4607.055553611434, 4614.215583350771, 4643.071385722937, 6654.0, 6690.933090669226, 6733.124693789776, 6764.8985265222045, 6931.584104953719, 6701.262861085374, 6723.865522689616, 6730.158730158731, 6738.797836064926, 6739.663016849236, 6653.833654158685, 6680.331966803281, 6686.5653732507235, 6697.0958920547055, 6701.0, 6447.0, 6529.857274976765, 6569.343065693392, 6593.80218593443, 6596.472282217315, 6632.1709786276715, 6656.534042617164, 6659.633720145439, 6660.134182556237, 6661.566998145105, 6549.443297319591, 6569.770058048137, 6570.47436205112, 6570.638614876228, 6581.769638062645], "unit": "score", "name": "prototype.html", "value": 4962.383283688233}, {"lowerIsBetter": false, "replicates": [717.9641017949104, 745.817274767682, 800.3797057280607, 846.2341580869315, 846.7925358287221, 13557.389917453713, 13721.313934303294, 13890.097143685653, 13895.444182232712, 13905.096168749049, 12482.126251162423, 12599.181053231534, 12626.431810568523, 12662.556810511634, 12896.742065158714, 795.6379847169538, 812.4962523235573, 818.0755746007004, 818.3862103422433, 820.0118856777568, 800.6237068577759, 803.9316658084069, 808.1675873849944, 809.2514424157631, 811.2050190813006, 852.4160949749411, 856.6958729650978, 857.8498762716531, 861.1431625532604, 861.4874149880811, 850.7873031742096, 851.9563534670042, 852.2798235491031, 852.3436953545797, 852.9977276699884, 625.4871005775266, 629.0375725140542, 629.276332217953, 629.3486241739823, 631.9810405687791, 14113.153210807282, 14164.504242351572, 14175.078619889675, 14184.432622695183, 14197.290135493287, 12356.62930112089, 12388.0, 12626.17929834567, 12674.049446291472, 12713.93643031788, 9923.106920377128, 10059.597616095347, 10108.494575271281, 10201.38791672502, 10566.841497377545, 3394.592648882125, 3543.1850674345046, 3547.024568243728, 3578.141246100943, 3584.1039740064984, 48036.51963480355, 48126.75936620295, 48739.26891096636, 49508.25737613939, 49520.25719614208, 9541.952290238505, 9608.471534065693, 9627.711168664951, 9665.130138287588, 9676.080772326617, 17427.39004134849, 17432.5641858952, 17550.82449175492, 17810.19854106568, 17859.821401786077, 7291.270872912666, 7583.810404739926, 7590.620468976639, 7601.581912994839, 7748.147703752583, 3955.624215699504, 3955.960440395617, 3983.581723918947, 3986.720929534905, 4025.1748391579654, 3009.5636132761065, 3069.4628440022907, 3080.614923134608, 3081.352915887644, 3083.629964404286, 558.3021223470662, 579.5450571301592, 586.5454272938507, 590.2179612014013, 593.9673317967553, 479.38399157082983, 498.22277247494026, 564.8164346587375, 568.4599630351183, 613.6594190224469, 7102.325279098477, 7307.926920730831, 7421.693952306133, 7680.692772289158, 7724.0731112266885, 622.0855342646303, 625.5996162456032, 625.918630578022, 637.2957881540831, 664.2095905871997, 4027.1140349123148, 4107.4880976765035, 4112.321466957978, 4220.430241917364, 4352.455943007124, 53528.0, 54261.72869135708, 54705.0, 54832.0, 55062.449375506534, 48320.75839620779, 48955.510444895095, 49025.754871225414, 49138.754306228955, 49307.0, 43863.78068109639, 44105.33841992437, 44164.0, 44412.3338149928, 44936.77531612321, 8065.395095367753, 8250.917490825255, 8339.874901876598, 8425.368097392842, 8473.788155296166, 33638.49542256917, 33989.32021359608, 34314.656853431145, 34593.82703086468, 34752.826235868655, 42014.159716806105, 42089.0, 42337.57662423336, 42388.78805605952, 42402.575974239866, 10429.895701042893, 10684.89315106839, 11220.214584978972, 11258.605948791754, 11277.703064147729, 11013.229073965065, 11728.882711172779, 11752.471138798946, 11752.764944700886, 11820.70448238801, 9824.21406287481, 9861.260405469475, 10643.840342394715, 10966.945165274123, 11068.5572577096, 9712.0, 9758.170555502578, 9972.60109595608, 10059.409080323549, 10480.056794888496, 10726.892731072589, 10962.123030157409, 10993.725156870822, 11142.888571114185, 11221.27061741017, 8803.955980220058, 8819.426737262058, 8928.15182557656, 8983.640654373752, 9704.223662106873, 9571.28215383835, 10029.14752246038, 10042.0, 10045.196384289386, 10085.445300508543], "unit": "score", "name": "yui.html", "value": 6142.780136017346}], "name": "dromaeo_css", "value": 6773.735993486222}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 105.0, 110.0, 110.0, 111.0, 123.0, 111.0, 110.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [160.0, 127.0, 148.0, 166.0, 130.0, 148.0, 155.0, 127.0, 166.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.4}, {"lowerIsBetter": true, "replicates": [160.0, 164.0, 165.0, 163.0, 162.0, 162.0, 163.0, 165.0, 169.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.6}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 71.0, 74.0, 73.0, 73.0, 160.0, 72.0, 75.0, 75.0], "unit": "score", "name": "audio-fft", "value": 81.7}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 141.0, 96.0, 97.0, 97.0, 136.0, 97.0, 97.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 111.0, 109.0, 110.0, 110.0, 109.0, 111.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 146.0, 149.0, 147.0, 146.0, 147.0, 148.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 60.0, 57.0, 58.0, 59.0, 64.0, 58.0, 57.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 58.9}, {"lowerIsBetter": true, "replicates": [66.0, 70.0, 68.0, 68.0, 67.0, 68.0, 67.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 82.0, 86.0, 83.0, 83.0, 90.0, 84.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 120.0, 117.0, 121.0, 119.0, 118.0, 124.0, 133.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.3}, {"lowerIsBetter": true, "replicates": [139.0, 150.0, 147.0, 147.0, 152.0, 149.0, 149.0, 150.0, 150.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.4}, {"lowerIsBetter": true, "replicates": [73.0, 69.0, 70.0, 69.0, 71.0, 70.0, 69.0, 70.0, 68.0, 74.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.3}], "name": "kraken", "value": 1515.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.41704110500916], "unit": "score", "name": "Richards", "value": 212.1297179999999}, {"lowerIsBetter": false, "replicates": [190.29495718363464], "unit": "score", "name": "DeltaBlue", "value": 347.4500900000001}, {"lowerIsBetter": false, "replicates": [279.72027972027973], "unit": "score", "name": "Encrypt", "value": 951.5970750000004}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [1078.7486515641856], "unit": "score", "name": "RayTrace", "value": 685.9698030000003}, {"lowerIsBetter": false, "replicates": [713.2667617689016], "unit": "score", "name": "Earley", "value": 934.3811260000003}, {"lowerIsBetter": false, "replicates": [12500.0], "unit": "score", "name": "Boyer", "value": 53.31704}, {"lowerIsBetter": false, "replicates": [41612.244897959186], "unit": "score", "name": "RegExp", "value": 21.892233938205006}, {"lowerIsBetter": false, "replicates": [595.8333333333334], "unit": "score", "name": "Splay", "value": 136.76811188811192}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 20289.687554538385}]} 21:23:10 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20289.69"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1515.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6773.73"}}} 21:23:10 INFO - Return code: 0 21:23:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 21:23:10 INFO - # TBPL SUCCESS # 21:23:10 INFO - Running post-action listener: _resource_record_post_action 21:23:10 INFO - Running post-run listener: _resource_record_post_run 21:23:11 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 554586112; Read time: 0; Write time: 525560 21:23:11 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 239357952; Read time: 0; Write time: 306216 21:23:11 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 315228160; Read time: 0; Write time: 219344 21:23:11 INFO - Running post-run listener: _upload_blobber_files 21:23:11 INFO - Blob upload gear active. 21:23:11 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 21:23:11 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 21:23:11 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 21:23:11 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 21:23:12 INFO - (blobuploader) - INFO - Open directory for files ... 21:23:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:23:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:23:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:23:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:23:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:23:12 INFO - (blobuploader) - INFO - Done attempting. 21:23:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:23:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:23:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:23:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:23:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:23:13 INFO - (blobuploader) - INFO - Done attempting. 21:23:13 INFO - (blobuploader) - INFO - Iteration through files over. 21:23:13 INFO - Return code: 0 21:23:13 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 21:23:13 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 21:23:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42a7eb52afba11e4e8395afb98499c027039e2dddaa987f2ed31c1d849eeea4d5afaf3701a3c9743e4beb1d255012a099a6494b54c5265145036ac81865e1b5d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42ea7dd38fe70d34781b97e4b189a664a10a130287ffdd3938c2cb32b476a11959116847ffa569fc7e454d3f9b7284d12de90ffee0cb55b56389f64ee7d27c11"} 21:23:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 21:23:13 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 21:23:13 INFO - Contents: 21:23:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42a7eb52afba11e4e8395afb98499c027039e2dddaa987f2ed31c1d849eeea4d5afaf3701a3c9743e4beb1d255012a099a6494b54c5265145036ac81865e1b5d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42ea7dd38fe70d34781b97e4b189a664a10a130287ffdd3938c2cb32b476a11959116847ffa569fc7e454d3f9b7284d12de90ffee0cb55b56389f64ee7d27c11"} 21:23:13 INFO - Copying logs to upload dir... 21:23:13 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1276.590803 ========= master_lag: -0.18 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-01-14 21:23:13.137309) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 21:23:13.140553) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1452833208.302399-2044520815 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/Firefox/sha512/42a7eb52afba11e4e8395afb98499c027039e2dddaa987f2ed31c1d849eeea4d5afaf3701a3c9743e4beb1d255012a099a6494b54c5265145036ac81865e1b5d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42ea7dd38fe70d34781b97e4b189a664a10a130287ffdd3938c2cb32b476a11959116847ffa569fc7e454d3f9b7284d12de90ffee0cb55b56389f64ee7d27c11"} build_url:https://queue.taskcluster.net/v1/task/IpknuwviQ9CPIDevMtHWnw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011381 build_url: 'https://queue.taskcluster.net/v1/task/IpknuwviQ9CPIDevMtHWnw/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/Firefox/sha512/42a7eb52afba11e4e8395afb98499c027039e2dddaa987f2ed31c1d849eeea4d5afaf3701a3c9743e4beb1d255012a099a6494b54c5265145036ac81865e1b5d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42ea7dd38fe70d34781b97e4b189a664a10a130287ffdd3938c2cb32b476a11959116847ffa569fc7e454d3f9b7284d12de90ffee0cb55b56389f64ee7d27c11"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 21:23:13.165042) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 21:23:13.165390) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1452833208.302399-2044520815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004564 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 21:23:13.250265) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 21:23:13.250591) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 21:23:13.250887) ========= ========= Total master_lag: 0.04 =========