builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1451803829.12 results: success (0) buildid: 20160102203756 builduid: aa207f8b1e7e4ea5975e581c687778e6 revision: d7a0ad85d9fb77916f9d77d62697b852f3dc63e6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-02 22:50:29.124848) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-02 22:50:29.125370) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-02 22:50:29.125656) ========= 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=7d909545e45784438f4e8e36000001b3-1451801359.481941-1110124823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006416 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.27 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-02 22:50:29.402823) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-02 22:50:29.403299) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-02 22:50:29.435064) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 22:50:29.435508) ========= 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=7d909545e45784438f4e8e36000001b3-1451801359.481941-1110124823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004597 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 22:50:29.488367) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-02 22:50:29.488811) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-02 22:50:29.489387) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 22:50:29.489827) ========= 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=7d909545e45784438f4e8e36000001b3-1451801359.481941-1110124823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-02 22:50:29-- 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% 224M=0s 2016-01-02 22:50:30 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170503 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 22:50:29.676803) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 22:50:29.677149) ========= 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=7d909545e45784438f4e8e36000001b3-1451801359.481941-1110124823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021033 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 22:50:29.728996) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 22:50:29.729402) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev d7a0ad85d9fb77916f9d77d62697b852f3dc63e6 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev d7a0ad85d9fb77916f9d77d62697b852f3dc63e6 --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=7d909545e45784438f4e8e36000001b3-1451801359.481941-1110124823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-02 22:50:30,249 truncating revision to first 12 chars 2016-01-02 22:50:30,249 Setting DEBUG logging. 2016-01-02 22:50:30,249 attempt 1/10 2016-01-02 22:50:30,249 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/d7a0ad85d9fb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-02 22:50:30,477 unpacking tar archive at: b2g-inbound-d7a0ad85d9fb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.492102 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 22:50:30.247816) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-02 22:50:30.248175) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-02 22:50:30.258440) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-02 22:50:30.258840) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-02 22:50:30.259292) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-02 22:50:30.259601) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] 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=7d909545e45784438f4e8e36000001b3-1451801359.481941-1110124823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:50:30 INFO - MultiFileLogger online at 20160102 22:50:30 in /builds/slave/test-pgo 22:50:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 22:50:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:50:30 INFO - {'append_to_log': False, 22:50:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:50:30 INFO - 'blob_upload_branch': 'B2G-Inbound', 22:50:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:50:30 INFO - 'branch': 'B2G-Inbound', 22:50:30 INFO - 'buildbot_json_path': 'buildprops.json', 22:50:30 INFO - 'config_files': ('talos/linux_config.py',), 22:50:30 INFO - 'default_actions': ('clobber', 22:50:30 INFO - 'read-buildbot-config', 22:50:30 INFO - 'download-and-extract', 22:50:30 INFO - 'populate-webroot', 22:50:30 INFO - 'create-virtualenv', 22:50:30 INFO - 'install', 22:50:30 INFO - 'run-tests'), 22:50:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:50:30 INFO - 'download_minidump_stackwalk': True, 22:50:30 INFO - 'download_symbols': 'ondemand', 22:50:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:50:30 INFO - 'tooltool.py': '/tools/tooltool.py', 22:50:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:50:30 INFO - '/tools/misc-python/virtualenv.py')}, 22:50:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:50:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:50:30 INFO - 'installer_path': 'installer.exe', 22:50:30 INFO - 'log_level': 'info', 22:50:30 INFO - 'log_name': 'talos', 22:50:30 INFO - 'log_to_console': True, 22:50:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:50:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:50:30 INFO - 'opt_config_files': (), 22:50:30 INFO - 'pip_index': False, 22:50:30 INFO - 'sps_profile': False, 22:50:30 INFO - 'sps_profile_interval': 0, 22:50:30 INFO - 'suite': 'dromaeojs', 22:50:30 INFO - 'system_bits': '32', 22:50:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:50:30 INFO - 'title': 'talos-linux64-ix-008', 22:50:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:50:30 INFO - 'use_talos_json': True, 22:50:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:50:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:50:30 INFO - 'work_dir': 'build'} 22:50:30 INFO - ##### 22:50:30 INFO - ##### Running clobber step. 22:50:30 INFO - ##### 22:50:30 INFO - Running pre-action listener: _resource_record_pre_action 22:50:30 INFO - Running main action method: clobber 22:50:30 INFO - rmtree: /builds/slave/test-pgo/build 22:50:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:50:31 INFO - Running post-action listener: _resource_record_post_action 22:50:31 INFO - ##### 22:50:31 INFO - ##### Running read-buildbot-config step. 22:50:31 INFO - ##### 22:50:31 INFO - Running pre-action listener: _resource_record_pre_action 22:50:31 INFO - Running main action method: read_buildbot_config 22:50:31 INFO - Using buildbot properties: 22:50:31 INFO - { 22:50:31 INFO - "project": "", 22:50:31 INFO - "product": "firefox", 22:50:31 INFO - "script_repo_revision": "production", 22:50:31 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 22:50:31 INFO - "repository": "", 22:50:31 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 22:50:31 INFO - "buildid": "20160102203756", 22:50:31 INFO - "pgo_build": "True", 22:50:31 INFO - "basedir": "/builds/slave/test-pgo", 22:50:31 INFO - "buildnumber": 175, 22:50:31 INFO - "slavename": "talos-linux64-ix-008", 22:50:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:50:31 INFO - "platform": "ubuntu64_hw", 22:50:31 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 22:50:31 INFO - "branch": "b2g-inbound", 22:50:31 INFO - "repo_path": "integration/b2g-inbound", 22:50:31 INFO - "revision": "d7a0ad85d9fb77916f9d77d62697b852f3dc63e6", 22:50:31 INFO - "stage_platform": "linux64-pgo", 22:50:31 INFO - "builduid": "aa207f8b1e7e4ea5975e581c687778e6", 22:50:31 INFO - "slavebuilddir": "test" 22:50:31 INFO - } 22:50:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:50:31 INFO - Running post-action listener: _resource_record_post_action 22:50:31 INFO - ##### 22:50:31 INFO - ##### Running download-and-extract step. 22:50:31 INFO - ##### 22:50:31 INFO - Running pre-action listener: _resource_record_pre_action 22:50:31 INFO - Running main action method: download_and_extract 22:50:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:50:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:31 INFO - https://queue.taskcluster.net/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:50:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/artifacts/public/build/test_packages.json 22:50:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/artifacts/public/build/test_packages.json 22:50:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:50:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:50:36 INFO - Downloaded 1302 bytes. 22:50:36 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:50:36 INFO - Using the following test package requirements: 22:50:36 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:50:36 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:50:36 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:36 INFO - u'jsshell-linux-x86_64.zip'], 22:50:36 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:50:36 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:50:36 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:50:36 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:50:36 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:50:36 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:50:36 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:50:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:50:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:36 INFO - https://queue.taskcluster.net/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:50:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:50:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:50:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/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 22:50:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/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 22:50:39 INFO - Downloaded 23197959 bytes. 22:50:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 22:50:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:50:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:50:40 INFO - Return code: 0 22:50:40 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 22:50:40 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')]} 22:50:40 INFO - https://queue.taskcluster.net/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:50:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:50:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:50:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/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 22:50:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/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 22:50:41 INFO - Downloaded 23197959 bytes. 22:50:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 22:50:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:50:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:50:42 INFO - Return code: 0 22:50:42 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')]} 22:50:42 INFO - https://queue.taskcluster.net/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:50:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:50:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:50:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/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 22:50:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/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 22:50:43 INFO - Downloaded 11132285 bytes. 22:50:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 22:50:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:50:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 22:50:43 INFO - Return code: 0 22:50:43 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')]} 22:50:43 INFO - https://queue.taskcluster.net/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:50:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:50:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:50:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/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 22:50:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/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 22:50:45 INFO - Downloaded 54976791 bytes. 22:50:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:50:45 INFO - mkdir: /builds/slave/test-pgo/properties 22:50:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:50:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:50:45 INFO - Contents: 22:50:45 INFO - build_url:https://queue.taskcluster.net/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:50:45 INFO - Running post-action listener: _resource_record_post_action 22:50:45 INFO - Running post-action listener: set_extra_try_arguments 22:50:45 INFO - ##### 22:50:45 INFO - ##### Running populate-webroot step. 22:50:45 INFO - ##### 22:50:45 INFO - Running pre-action listener: _resource_record_pre_action 22:50:45 INFO - Running main action method: populate_webroot 22:50:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:50:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:50:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:50:45 INFO - '--tppagecycles', 22:50:45 INFO - '7'], 22:50:45 INFO - 'tests': ['tsvgm']}}, 22:50:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:50:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:50:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:50:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:50:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:50:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:50:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:50:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:50:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:50:45 INFO - 'talos_options': ['--e10s'], 22:50:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:50:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:50:45 INFO - 'tests': ['damp', 'tps']}, 22:50:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:50:45 INFO - 'talos_options': ['--e10s'], 22:50:45 INFO - 'tests': ['damp', 'tps']}, 22:50:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:50:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:50:45 INFO - 'other': {'tests': ['a11yr', 22:50:45 INFO - 'ts_paint', 22:50:45 INFO - 'tpaint', 22:50:45 INFO - 'sessionrestore', 22:50:45 INFO - 'sessionrestore_no_auto_restore']}, 22:50:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:50:45 INFO - 'tests': ['a11yr', 22:50:45 INFO - 'ts_paint', 22:50:45 INFO - 'tpaint', 22:50:45 INFO - 'sessionrestore', 22:50:45 INFO - 'sessionrestore_no_auto_restore']}, 22:50:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:50:45 INFO - 'tests': ['a11yr', 22:50:45 INFO - 'ts_paint', 22:50:45 INFO - 'tpaint', 22:50:45 INFO - 'sessionrestore', 22:50:45 INFO - 'sessionrestore_no_auto_restore']}, 22:50:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:50:45 INFO - 'tests': ['a11yr', 22:50:45 INFO - 'ts_paint', 22:50:45 INFO - 'tpaint', 22:50:45 INFO - 'sessionrestore', 22:50:45 INFO - 'sessionrestore_no_auto_restore']}, 22:50:45 INFO - 'other_l64': {'tests': ['a11yr', 22:50:45 INFO - 'ts_paint', 22:50:45 INFO - 'tpaint', 22:50:45 INFO - 'sessionrestore', 22:50:45 INFO - 'sessionrestore_no_auto_restore']}, 22:50:45 INFO - 'other_nol64': {'tests': ['a11yr', 22:50:45 INFO - 'ts_paint', 22:50:45 INFO - 'tpaint', 22:50:45 INFO - 'sessionrestore', 22:50:45 INFO - 'sessionrestore_no_auto_restore']}, 22:50:45 INFO - 'svgr': {'tests': ['tsvgx', 22:50:45 INFO - 'tsvgr_opacity', 22:50:45 INFO - 'tart', 22:50:45 INFO - 'tscrollx', 22:50:45 INFO - 'cart']}, 22:50:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:50:45 INFO - 'tests': ['tsvgx', 22:50:45 INFO - 'tsvgr_opacity', 22:50:45 INFO - 'tart', 22:50:45 INFO - 'tscrollx', 22:50:45 INFO - 'cart']}, 22:50:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:50:45 INFO - 'tests': ['tp5o']}, 22:50:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:50:45 INFO - 'talos_options': ['--e10s'], 22:50:45 INFO - 'tests': ['tp5o']}, 22:50:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:50:45 INFO - 'talos_options': ['--xperf_path', 22:50:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:50:45 INFO - 'tests': ['tp5n']}, 22:50:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:50:45 INFO - 'talos_options': ['--e10s', 22:50:45 INFO - '--xperf_path', 22:50:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:50:45 INFO - 'tests': ['tp5n']}}, 22:50:45 INFO - 'talos.zip': {'path': '', 22:50:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:50:45 INFO - Running post-action listener: _resource_record_post_action 22:50:45 INFO - ##### 22:50:45 INFO - ##### Running create-virtualenv step. 22:50:45 INFO - ##### 22:50:45 INFO - Running pre-action listener: _resource_record_pre_action 22:50:45 INFO - Running main action method: create_virtualenv 22:50:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:50:45 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 22:50:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:50:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:50:45 INFO - Using real prefix '/usr' 22:50:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:50:45 INFO - Installing distribute.............................................................................................................................................................................................done. 22:50:47 INFO - Installing pip.................done. 22:50:47 INFO - Return code: 0 22:50:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:50:47 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')]} 22:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:50:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:47 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')]} 22:50:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:50:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:47 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 0x7f4bbaa21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137840>, '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 0x20a46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a4b60>, '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': '7d909545e45784438f4e8e36000001b3-1451801359.481941-1110124823', '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 22:50:47 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 22:50:47 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 22:50:47 INFO - Using env: {'DISPLAY': ':0', 22:50:47 INFO - 'HOME': '/home/cltbld', 22:50:47 INFO - 'LANG': 'en_US.UTF-8', 22:50:47 INFO - 'LANGUAGE': 'en_US:en', 22:50:47 INFO - 'LOGNAME': 'cltbld', 22:50:47 INFO - 'MAIL': '/var/mail/cltbld', 22:50:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:50:47 INFO - 'MOZ_NO_REMOTE': '1', 22:50:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:50:47 INFO - 'NO_EM_RESTART': '1', 22:50:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:50:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:50:47 INFO - 'PWD': '/builds/slave/test-pgo', 22:50:47 INFO - 'SHELL': '/bin/bash', 22:50:47 INFO - 'SHLVL': '1', 22:50:47 INFO - 'TERM': 'linux', 22:50:47 INFO - 'TMOUT': '86400', 22:50:47 INFO - 'USER': 'cltbld', 22:50:47 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1451801359.481941-1110124823', 22:50:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:50:47 INFO - '_': '/tools/buildbot/bin/python'} 22:50:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:50:48 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 22:50:48 INFO - Cleaning up... 22:50:48 INFO - Return code: 0 22:50:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:50:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:50:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:48 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 0x7f4bbaa21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137840>, '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 0x20a46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a4b60>, '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': '7d909545e45784438f4e8e36000001b3-1451801359.481941-1110124823', '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 22:50:48 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 22:50:48 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 22:50:48 INFO - Using env: {'DISPLAY': ':0', 22:50:48 INFO - 'HOME': '/home/cltbld', 22:50:48 INFO - 'LANG': 'en_US.UTF-8', 22:50:48 INFO - 'LANGUAGE': 'en_US:en', 22:50:48 INFO - 'LOGNAME': 'cltbld', 22:50:48 INFO - 'MAIL': '/var/mail/cltbld', 22:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:50:48 INFO - 'MOZ_NO_REMOTE': '1', 22:50:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:50:48 INFO - 'NO_EM_RESTART': '1', 22:50:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:50:48 INFO - 'PWD': '/builds/slave/test-pgo', 22:50:48 INFO - 'SHELL': '/bin/bash', 22:50:48 INFO - 'SHLVL': '1', 22:50:48 INFO - 'TERM': 'linux', 22:50:48 INFO - 'TMOUT': '86400', 22:50:48 INFO - 'USER': 'cltbld', 22:50:48 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1451801359.481941-1110124823', 22:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:50:48 INFO - '_': '/tools/buildbot/bin/python'} 22:50:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:50:48 INFO - Downloading/unpacking psutil>=0.7.1 22:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:50 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:50:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:50:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:50:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:50:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:50:50 INFO - Installing collected packages: psutil 22:50:50 INFO - Running setup.py install for psutil 22:50:50 INFO - building 'psutil._psutil_linux' extension 22:50:50 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 22:50:50 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 22:50:50 INFO - building 'psutil._psutil_posix' extension 22:50:50 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 22:50:50 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 22:50:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:50:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:50:50 INFO - Successfully installed psutil 22:50:50 INFO - Cleaning up... 22:50:50 INFO - Return code: 0 22:50:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:50:50 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')]} 22:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:50:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:50 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')]} 22:50:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:50:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:50 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 0x7f4bbaa21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137840>, '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 0x20a46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a4b60>, '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': '7d909545e45784438f4e8e36000001b3-1451801359.481941-1110124823', '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 22:50:50 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 22:50:50 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 22:50:50 INFO - Using env: {'DISPLAY': ':0', 22:50:50 INFO - 'HOME': '/home/cltbld', 22:50:50 INFO - 'LANG': 'en_US.UTF-8', 22:50:50 INFO - 'LANGUAGE': 'en_US:en', 22:50:50 INFO - 'LOGNAME': 'cltbld', 22:50:50 INFO - 'MAIL': '/var/mail/cltbld', 22:50:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:50:50 INFO - 'MOZ_NO_REMOTE': '1', 22:50:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:50:50 INFO - 'NO_EM_RESTART': '1', 22:50:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:50:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:50:50 INFO - 'PWD': '/builds/slave/test-pgo', 22:50:50 INFO - 'SHELL': '/bin/bash', 22:50:50 INFO - 'SHLVL': '1', 22:50:50 INFO - 'TERM': 'linux', 22:50:50 INFO - 'TMOUT': '86400', 22:50:50 INFO - 'USER': 'cltbld', 22:50:50 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1451801359.481941-1110124823', 22:50:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:50:50 INFO - '_': '/tools/buildbot/bin/python'} 22:50:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:50:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:50:50 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 22:50:50 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 22:50:50 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 22:50:50 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 22:50:50 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 22:50:50 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 22:50:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:50:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:50:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:50:52 INFO - Installing collected packages: mozsystemmonitor 22:50:52 INFO - Running setup.py install for mozsystemmonitor 22:50:52 INFO - Successfully installed mozsystemmonitor 22:50:52 INFO - Cleaning up... 22:50:52 INFO - Return code: 0 22:50:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f4bbaa21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137840>, '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 0x20a46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a4b60>, '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': '7d909545e45784438f4e8e36000001b3-1451801359.481941-1110124823', '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 22:50:52 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 22:50:52 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 22:50:52 INFO - Using env: {'DISPLAY': ':0', 22:50:52 INFO - 'HOME': '/home/cltbld', 22:50:52 INFO - 'LANG': 'en_US.UTF-8', 22:50:52 INFO - 'LANGUAGE': 'en_US:en', 22:50:52 INFO - 'LOGNAME': 'cltbld', 22:50:52 INFO - 'MAIL': '/var/mail/cltbld', 22:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:50:52 INFO - 'MOZ_NO_REMOTE': '1', 22:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:50:52 INFO - 'NO_EM_RESTART': '1', 22:50:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:50:52 INFO - 'PWD': '/builds/slave/test-pgo', 22:50:52 INFO - 'SHELL': '/bin/bash', 22:50:52 INFO - 'SHLVL': '1', 22:50:52 INFO - 'TERM': 'linux', 22:50:52 INFO - 'TMOUT': '86400', 22:50:52 INFO - 'USER': 'cltbld', 22:50:52 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1451801359.481941-1110124823', 22:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:50:52 INFO - '_': '/tools/buildbot/bin/python'} 22:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:50:52 INFO - Downloading/unpacking blobuploader==1.2.4 22:50:52 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 22:50:52 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 22:50:52 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 22:50:52 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 22:50:52 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 22:50:52 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 22:50:54 INFO - Downloading blobuploader-1.2.4.tar.gz 22:50:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:50:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:50:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:50:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:50:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:50:55 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 22:50:55 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 22:50:55 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 22:50:55 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 22:50:55 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 22:50:55 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 22:50:55 INFO - Downloading docopt-0.6.1.tar.gz 22:50:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:50:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:50:55 INFO - Installing collected packages: blobuploader, requests, docopt 22:50:55 INFO - Running setup.py install for blobuploader 22:50:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:50:55 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:50:55 INFO - Running setup.py install for requests 22:50:55 INFO - Running setup.py install for docopt 22:50:55 INFO - Successfully installed blobuploader requests docopt 22:50:55 INFO - Cleaning up... 22:50:55 INFO - Return code: 0 22:50:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:50:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:50:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:55 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 0x7f4bbaa21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137840>, '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 0x20a46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a4b60>, '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': '7d909545e45784438f4e8e36000001b3-1451801359.481941-1110124823', '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 22:50:55 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 22:50:55 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 22:50:55 INFO - Using env: {'DISPLAY': ':0', 22:50:55 INFO - 'HOME': '/home/cltbld', 22:50:55 INFO - 'LANG': 'en_US.UTF-8', 22:50:55 INFO - 'LANGUAGE': 'en_US:en', 22:50:55 INFO - 'LOGNAME': 'cltbld', 22:50:55 INFO - 'MAIL': '/var/mail/cltbld', 22:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:50:55 INFO - 'MOZ_NO_REMOTE': '1', 22:50:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:50:55 INFO - 'NO_EM_RESTART': '1', 22:50:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:50:55 INFO - 'PWD': '/builds/slave/test-pgo', 22:50:55 INFO - 'SHELL': '/bin/bash', 22:50:55 INFO - 'SHLVL': '1', 22:50:55 INFO - 'TERM': 'linux', 22:50:55 INFO - 'TMOUT': '86400', 22:50:55 INFO - 'USER': 'cltbld', 22:50:55 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1451801359.481941-1110124823', 22:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:50:55 INFO - '_': '/tools/buildbot/bin/python'} 22:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:50:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:50:56 INFO - Running setup.py (path:/tmp/pip-1vGJxA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:50:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:50:56 INFO - Running setup.py (path:/tmp/pip-0aR_09-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:50:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:50:56 INFO - Running setup.py (path:/tmp/pip-Cgg9i1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:50:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:50:56 INFO - Running setup.py (path:/tmp/pip-TSkqK6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:50:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:50:56 INFO - Running setup.py (path:/tmp/pip-Z0uyXM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:50:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:50:56 INFO - Running setup.py (path:/tmp/pip-nkmA5j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:50:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:50:56 INFO - Running setup.py (path:/tmp/pip-FeHVCo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:50:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:50:56 INFO - Running setup.py (path:/tmp/pip-Nx_ZeI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:50:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:50:56 INFO - Running setup.py (path:/tmp/pip-aSqCS2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:50:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:50:56 INFO - Running setup.py (path:/tmp/pip-o9HGXT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:50:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:50:56 INFO - Running setup.py (path:/tmp/pip-e64Yes-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:50:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:50:56 INFO - Running setup.py (path:/tmp/pip-hrxYo5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:50:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:50:57 INFO - Running setup.py (path:/tmp/pip-0i3DCL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:50:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:50:57 INFO - Running setup.py (path:/tmp/pip-z4x8XD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:50:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:50:57 INFO - Running setup.py (path:/tmp/pip-Z4J6YI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:50:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:50:57 INFO - Running setup.py (path:/tmp/pip-q_ZHOs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:50:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:50:57 INFO - Running setup.py (path:/tmp/pip-VooNI0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:50:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:50:57 INFO - Running setup.py install for manifestparser 22:50:57 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:50:57 INFO - Running setup.py install for mozcrash 22:50:57 INFO - Running setup.py install for mozdebug 22:50:57 INFO - Running setup.py install for mozdevice 22:50:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:50:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:50:57 INFO - Running setup.py install for mozfile 22:50:57 INFO - Running setup.py install for mozhttpd 22:50:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:50:57 INFO - Running setup.py install for mozinfo 22:50:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:50:58 INFO - Running setup.py install for mozInstall 22:50:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:50:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:50:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:50:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:50:58 INFO - Running setup.py install for mozleak 22:50:58 INFO - Running setup.py install for mozlog 22:50:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:50:58 INFO - Running setup.py install for moznetwork 22:50:58 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:50:58 INFO - Running setup.py install for mozprocess 22:50:58 INFO - Running setup.py install for mozprofile 22:50:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:50:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:50:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:50:58 INFO - Running setup.py install for mozrunner 22:50:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:50:58 INFO - Running setup.py install for mozscreenshot 22:50:58 INFO - Running setup.py install for moztest 22:50:59 INFO - Running setup.py install for mozversion 22:50:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:50:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:50:59 INFO - Cleaning up... 22:50:59 INFO - Return code: 0 22:50:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:50:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:50:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f4bbaa21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137840>, '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 0x20a46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a4b60>, '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': '7d909545e45784438f4e8e36000001b3-1451801359.481941-1110124823', '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 22:50:59 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 22:50:59 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 22:50:59 INFO - Using env: {'DISPLAY': ':0', 22:50:59 INFO - 'HOME': '/home/cltbld', 22:50:59 INFO - 'LANG': 'en_US.UTF-8', 22:50:59 INFO - 'LANGUAGE': 'en_US:en', 22:50:59 INFO - 'LOGNAME': 'cltbld', 22:50:59 INFO - 'MAIL': '/var/mail/cltbld', 22:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:50:59 INFO - 'MOZ_NO_REMOTE': '1', 22:50:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:50:59 INFO - 'NO_EM_RESTART': '1', 22:50:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:50:59 INFO - 'PWD': '/builds/slave/test-pgo', 22:50:59 INFO - 'SHELL': '/bin/bash', 22:50:59 INFO - 'SHLVL': '1', 22:50:59 INFO - 'TERM': 'linux', 22:50:59 INFO - 'TMOUT': '86400', 22:50:59 INFO - 'USER': 'cltbld', 22:50:59 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1451801359.481941-1110124823', 22:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:50:59 INFO - '_': '/tools/buildbot/bin/python'} 22:50:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:50:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:50:59 INFO - Running setup.py (path:/tmp/pip-2c6uCG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:50:59 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)) 22:50:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:50:59 INFO - Running setup.py (path:/tmp/pip-vP7Hg7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:50:59 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)) 22:50:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:50:59 INFO - Running setup.py (path:/tmp/pip-dev7Hz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:50:59 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)) 22:50:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:50:59 INFO - Running setup.py (path:/tmp/pip-dgFap_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:50:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:50:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:50:59 INFO - Running setup.py (path:/tmp/pip-awEa7o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:50:59 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)) 22:50:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:50:59 INFO - Running setup.py (path:/tmp/pip-SHgD3v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:50:59 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)) 22:50:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:50:59 INFO - Running setup.py (path:/tmp/pip-wZBjmk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:50:59 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)) 22:50:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:50:59 INFO - Running setup.py (path:/tmp/pip-lE7til-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:50:59 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)) 22:50:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:50:59 INFO - Running setup.py (path:/tmp/pip-cOI6nL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:50:59 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)) 22:50:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:51:00 INFO - Running setup.py (path:/tmp/pip-9WEFDb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:51:00 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)) 22:51:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:51:00 INFO - Running setup.py (path:/tmp/pip-s_Z5nu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:51:00 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)) 22:51:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:51:00 INFO - Running setup.py (path:/tmp/pip-g0jnoW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:51:00 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)) 22:51:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:51:00 INFO - Running setup.py (path:/tmp/pip-0cjBIG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:51:00 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)) 22:51:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:51:00 INFO - Running setup.py (path:/tmp/pip-B7WiQi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:51:00 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)) 22:51:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:51:00 INFO - Running setup.py (path:/tmp/pip-OtXZ2b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:51:00 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)) 22:51:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:51:00 INFO - Running setup.py (path:/tmp/pip-VFcb_Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:51:00 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)) 22:51:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:51:00 INFO - Running setup.py (path:/tmp/pip-bQheGm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:51:00 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)) 22:51:00 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)) 22:51:00 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)) 22:51:00 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)) 22:51:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:51:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:51:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:02 INFO - Downloading blessings-1.5.1.tar.gz 22:51:02 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 22:51:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:51:02 INFO - Installing collected packages: blessings 22:51:02 INFO - Running setup.py install for blessings 22:51:02 INFO - Successfully installed blessings 22:51:02 INFO - Cleaning up... 22:51:02 INFO - Return code: 0 22:51:02 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:51:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:51:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:51:02 INFO - Reading from file tmpfile_stdout 22:51:02 INFO - Current package versions: 22:51:02 INFO - argparse == 1.2.1 22:51:02 INFO - blessings == 1.5.1 22:51:02 INFO - blobuploader == 1.2.4 22:51:02 INFO - docopt == 0.6.1 22:51:02 INFO - manifestparser == 1.1 22:51:02 INFO - mozInstall == 1.12 22:51:02 INFO - mozcrash == 0.16 22:51:02 INFO - mozdebug == 0.1 22:51:02 INFO - mozdevice == 0.47 22:51:02 INFO - mozfile == 1.2 22:51:02 INFO - mozhttpd == 0.7 22:51:02 INFO - mozinfo == 0.9 22:51:02 INFO - mozleak == 0.1 22:51:02 INFO - mozlog == 3.1 22:51:02 INFO - moznetwork == 0.27 22:51:02 INFO - mozprocess == 0.22 22:51:02 INFO - mozprofile == 0.28 22:51:02 INFO - mozrunner == 6.11 22:51:02 INFO - mozscreenshot == 0.1 22:51:02 INFO - mozsystemmonitor == 0.0 22:51:02 INFO - moztest == 0.7 22:51:02 INFO - mozversion == 1.4 22:51:02 INFO - psutil == 3.1.1 22:51:02 INFO - requests == 1.2.3 22:51:02 INFO - wsgiref == 0.1.2 22:51:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:51: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')]} 22:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51: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')]} 22:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f4bbaa21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137840>, '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 0x20a46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a4b60>, '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': '7d909545e45784438f4e8e36000001b3-1451801359.481941-1110124823', '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 22:51:02 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 22:51:02 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 22:51:02 INFO - Using env: {'DISPLAY': ':0', 22:51:02 INFO - 'HOME': '/home/cltbld', 22:51:02 INFO - 'LANG': 'en_US.UTF-8', 22:51:02 INFO - 'LANGUAGE': 'en_US:en', 22:51:02 INFO - 'LOGNAME': 'cltbld', 22:51:02 INFO - 'MAIL': '/var/mail/cltbld', 22:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:02 INFO - 'MOZ_NO_REMOTE': '1', 22:51:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:02 INFO - 'NO_EM_RESTART': '1', 22:51:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:02 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:02 INFO - 'SHELL': '/bin/bash', 22:51:02 INFO - 'SHLVL': '1', 22:51:02 INFO - 'TERM': 'linux', 22:51:02 INFO - 'TMOUT': '86400', 22:51:02 INFO - 'USER': 'cltbld', 22:51:02 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1451801359.481941-1110124823', 22:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:02 INFO - '_': '/tools/buildbot/bin/python'} 22:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:02 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)) 22:51:02 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)) 22:51:02 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)) 22:51:02 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)) 22:51:02 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)) 22:51:02 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)) 22:51:02 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)) 22:51:02 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)) 22:51:02 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)) 22:51:02 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)) 22:51:02 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)) 22:51:02 INFO - Cleaning up... 22:51:02 INFO - Return code: 0 22:51:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:51: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')]} 22:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51: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')]} 22:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4bbaa21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137840>, '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 0x20a46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a4b60>, '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': '7d909545e45784438f4e8e36000001b3-1451801359.481941-1110124823', '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 22:51:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:51:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:51:02 INFO - Using env: {'DISPLAY': ':0', 22:51:02 INFO - 'HOME': '/home/cltbld', 22:51:02 INFO - 'LANG': 'en_US.UTF-8', 22:51:02 INFO - 'LANGUAGE': 'en_US:en', 22:51:02 INFO - 'LOGNAME': 'cltbld', 22:51:02 INFO - 'MAIL': '/var/mail/cltbld', 22:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:02 INFO - 'MOZ_NO_REMOTE': '1', 22:51:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:02 INFO - 'NO_EM_RESTART': '1', 22:51:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:02 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:02 INFO - 'SHELL': '/bin/bash', 22:51:02 INFO - 'SHLVL': '1', 22:51:02 INFO - 'TERM': 'linux', 22:51:02 INFO - 'TMOUT': '86400', 22:51:02 INFO - 'USER': 'cltbld', 22:51:02 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1451801359.481941-1110124823', 22:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:02 INFO - '_': '/tools/buildbot/bin/python'} 22:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:03 INFO - Downloading/unpacking jsonschema 22:51:03 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 22:51:03 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 22:51:03 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 22:51:03 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 22:51:03 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 22:51:03 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 22:51:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:51:04 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 22:51:04 INFO - Downloading/unpacking functools32 (from jsonschema) 22:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:05 INFO - Downloading functools32-3.2.3-2.tar.gz 22:51:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:51:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:51:05 INFO - warning: no files found matching '*.txt' 22:51:05 INFO - no previously-included directories found matching 'build' 22:51:05 INFO - no previously-included directories found matching 'dist' 22:51:05 INFO - no previously-included directories found matching '.git*' 22:51:05 INFO - Installing collected packages: jsonschema, functools32 22:51:05 INFO - Running setup.py install for functools32 22:51:05 INFO - warning: no files found matching '*.txt' 22:51:05 INFO - no previously-included directories found matching 'build' 22:51:05 INFO - no previously-included directories found matching 'dist' 22:51:05 INFO - no previously-included directories found matching '.git*' 22:51:05 INFO - Successfully installed jsonschema functools32 22:51:05 INFO - Cleaning up... 22:51:05 INFO - Return code: 0 22:51:05 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:51:05 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')]} 22:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:05 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')]} 22:51:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:05 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 0x7f4bbaa21f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137840>, '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 0x20a46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a4b60>, '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': '7d909545e45784438f4e8e36000001b3-1451801359.481941-1110124823', '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 22:51:05 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 22:51:05 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 22:51:05 INFO - Using env: {'DISPLAY': ':0', 22:51:05 INFO - 'HOME': '/home/cltbld', 22:51:05 INFO - 'LANG': 'en_US.UTF-8', 22:51:05 INFO - 'LANGUAGE': 'en_US:en', 22:51:05 INFO - 'LOGNAME': 'cltbld', 22:51:05 INFO - 'MAIL': '/var/mail/cltbld', 22:51:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:05 INFO - 'MOZ_NO_REMOTE': '1', 22:51:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:05 INFO - 'NO_EM_RESTART': '1', 22:51:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:05 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:05 INFO - 'SHELL': '/bin/bash', 22:51:05 INFO - 'SHLVL': '1', 22:51:05 INFO - 'TERM': 'linux', 22:51:05 INFO - 'TMOUT': '86400', 22:51:05 INFO - 'USER': 'cltbld', 22:51:05 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1451801359.481941-1110124823', 22:51:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:05 INFO - '_': '/tools/buildbot/bin/python'} 22:51:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:05 INFO - Downloading/unpacking flake8 22:51:05 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 22:51:05 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 22:51:05 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 22:51:05 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 22:51:05 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 22:51:05 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 22:51:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:51:07 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 22:51:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:51:07 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 22:51:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:07 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 22:51:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:51:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:51:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:51:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:51:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:51:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:51:07 INFO - no previously-included directories found matching 'docs/_build' 22:51:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:51:08 INFO - Running setup.py install for pep8 22:51:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:51:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:51:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:51:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:51:08 INFO - no previously-included directories found matching 'docs/_build' 22:51:08 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:51:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:51:08 INFO - Cleaning up... 22:51:08 INFO - Return code: 0 22:51:08 INFO - Running post-action listener: _resource_record_post_action 22:51:08 INFO - Running post-action listener: _start_resource_monitoring 22:51:08 INFO - Starting resource monitoring. 22:51:08 INFO - ##### 22:51:08 INFO - ##### Running install step. 22:51:08 INFO - ##### 22:51:08 INFO - Running pre-action listener: _resource_record_pre_action 22:51:08 INFO - Running main action method: install 22:51:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:51:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:51:08 INFO - Reading from file tmpfile_stdout 22:51:08 INFO - Detecting whether we're running mozinstall >=1.0... 22:51:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:51:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:51:08 INFO - Reading from file tmpfile_stdout 22:51:08 INFO - Output received: 22:51:08 INFO - Usage: mozinstall [options] installer 22:51:08 INFO - Options: 22:51:08 INFO - -h, --help show this help message and exit 22:51:08 INFO - -d DEST, --destination=DEST 22:51:08 INFO - Directory to install application into. [default: 22:51:08 INFO - "/builds/slave/test-pgo"] 22:51:08 INFO - --app=APP Application being installed. [default: firefox] 22:51:08 INFO - mkdir: /builds/slave/test-pgo/build/application 22:51:08 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'] 22:51:08 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 22:51:24 INFO - Reading from file tmpfile_stdout 22:51:24 INFO - Output received: 22:51:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:51:24 INFO - Running post-action listener: _resource_record_post_action 22:51:24 INFO - ##### 22:51:24 INFO - ##### Running run-tests step. 22:51:24 INFO - ##### 22:51:24 INFO - Running pre-action listener: _resource_record_pre_action 22:51:24 INFO - Running main action method: run_tests 22:51:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:51:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:51:24 INFO - Python 2.7.3 22:51:24 INFO - Return code: 0 22:51:24 INFO - grabbing minidump binary from tooltool 22:51: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')]} 22:51:24 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 0x2137840>, '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 0x20a46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a4b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:51:24 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 22:51:24 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 22:51:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:51:24 INFO - Return code: 0 22:51:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:51:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:51:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:51:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:51:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:51:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:51:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:51:25 INFO - Return code: 0 22:51:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 22:51:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 22:51:25 INFO - Using env: {'DISPLAY': ':0', 22:51:25 INFO - 'HOME': '/home/cltbld', 22:51:25 INFO - 'LANG': 'en_US.UTF-8', 22:51:25 INFO - 'LANGUAGE': 'en_US:en', 22:51:25 INFO - 'LOGNAME': 'cltbld', 22:51:25 INFO - 'MAIL': '/var/mail/cltbld', 22:51:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:51:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:25 INFO - 'MOZ_NO_REMOTE': '1', 22:51:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:51:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:25 INFO - 'NO_EM_RESTART': '1', 22:51:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:25 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:51:25 INFO - 'SHELL': '/bin/bash', 22:51:25 INFO - 'SHLVL': '1', 22:51:25 INFO - 'TERM': 'linux', 22:51:25 INFO - 'TMOUT': '86400', 22:51:25 INFO - 'USER': 'cltbld', 22:51:25 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1451801359.481941-1110124823', 22:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:25 INFO - '_': '/tools/buildbot/bin/python'} 22:51:25 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:51:25 INFO - mozversion application_buildid: 20160102203756 22:51:25 INFO - mozversion application_changeset: d7a0ad85d9fb77916f9d77d62697b852f3dc63e6 22:51:25 INFO - mozversion application_display_name: Nightly 22:51:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:51:25 INFO - mozversion application_name: Firefox 22:51:25 INFO - mozversion application_remotingname: firefox 22:51:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 22:51:25 INFO - mozversion application_vendor: Mozilla 22:51:25 INFO - mozversion application_version: 46.0a1 22:51:25 INFO - mozversion platform_buildid: 20160102203756 22:51:25 INFO - mozversion platform_changeset: d7a0ad85d9fb77916f9d77d62697b852f3dc63e6 22:51:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 22:51:25 INFO - mozversion platform_version: 46.0a1 22:51:25 INFO - using testdate: 1451803885 22:51:25 INFO - actual date: 1451803885 22:51:25 INFO - starting webserver on 'localhost:35094' 22:51:25 INFO - SUITE-START | Running 3 tests 22:51:25 INFO - TEST-START | dromaeo_css 22:51:25 INFO - operating with platform_type : linux_ 22:51:25 INFO - Initialising browser for dromaeo_css test... 22:51:25 INFO - TEST-INFO | started process 15816 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpknD6S0/profile http://localhost:35094/getInfo.html) 22:51:30 INFO - PROCESS | 15816 | __metrics Screen width/height:1600/1200 22:51:30 INFO - PROCESS | 15816 | colorDepth:24 22:51:30 INFO - PROCESS | 15816 | Browser inner width/height: 1024/697 22:51:30 INFO - PROCESS | 15816 | __metrics 22:51:30 INFO - PROCESS | 15816 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:51:30 INFO - PROCESS | 15816 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:51:30 INFO - TEST-INFO | 15816: exit 0 22:51:30 INFO - Browser initialized. 22:51:30 INFO - Running cycle 1/1 for dromaeo_css test... 22:51:30 INFO - TEST-INFO | started process 15909 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpknD6S0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:51:42 INFO - PROCESS | 15909 | RSS: Main: 150097920 22:51:42 INFO - PROCESS | 15909 | 22:52:34 INFO - PROCESS | 15909 | 1451803954446 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] 22:54:42 INFO - PROCESS | 15909 | Cycle 1(1): loaded http://localhost:35094/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35094/tests/dromaeo/cssquery-ext.html) 22:54:44 INFO - PROCESS | 15909 | RSS: Main: 335138816 22:54:44 INFO - PROCESS | 15909 | 22:57:47 INFO - PROCESS | 15909 | Cycle 1(1): loaded http://localhost:35094/tests/dromaeo/cssquery-ext.html (next: http://localhost:35094/tests/dromaeo/cssquery-jquery.html) 22:57:47 INFO - PROCESS | 15909 | RSS: Main: 229335040 22:57:47 INFO - PROCESS | 15909 | 23:00:49 INFO - PROCESS | 15909 | Cycle 1(1): loaded http://localhost:35094/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35094/tests/dromaeo/cssquery-mootools.html) 23:00:50 INFO - PROCESS | 15909 | RSS: Main: 232775680 23:00:50 INFO - PROCESS | 15909 | 23:03:52 INFO - PROCESS | 15909 | Cycle 1(1): loaded http://localhost:35094/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35094/tests/dromaeo/cssquery-prototype.html) 23:03:52 INFO - PROCESS | 15909 | RSS: Main: 217440256 23:03:52 INFO - PROCESS | 15909 | 23:06:55 INFO - PROCESS | 15909 | Cycle 1(1): loaded http://localhost:35094/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35094/tests/dromaeo/cssquery-yui.html) 23:06:55 INFO - PROCESS | 15909 | RSS: Main: 221245440 23:06:55 INFO - PROCESS | 15909 | 23:09:58 INFO - PROCESS | 15909 | Cycle 1(1): loaded http://localhost:35094/tests/dromaeo/cssquery-yui.html (next: http://localhost:35094/tests/dromaeo/cssquery-dojo.html) 23:09:58 INFO - PROCESS | 15909 | RSS: Main: 243408896 23:09:58 INFO - PROCESS | 15909 | 23:09:58 INFO - PROCESS | 15909 | __start_tp_report 23:09:58 INFO - PROCESS | 15909 | _x_x_mozilla_page_load 23:09:58 INFO - PROCESS | 15909 | _x_x_mozilla_page_load_details 23:09:58 INFO - PROCESS | 15909 | |i|pagename|runs| 23:09:58 INFO - PROCESS | 15909 | |0;dojo.html;3102.084884958937;3172.1435212492643;3218.1471909943853;3224.6614105518906;3248.821314827685;5010.549050585447;5147.433782283946;5185.2740616313695;5211.944080079401;5240.528352448279;5122.206058060997;5159.458256883029;5231.816886408977;5238.633295669305;5250.894982100365;4697.741624210667;4726.810927562893;4754.524547545244;4773.737444440554;4779.593734532569;4851.514848515138;4869.147899117658;4872.123017856802;4920.901581968358;4946.1838796598695;4600.585947264745;4675.859724208279;4715.622750179995;4799.328094066834;4803.495632958524;4803.975980120112;4811.085893680224;4838.927416088762;4841.588464980446;4857.975710121462;4769.928451073237;4791.904161916777;4804.111239420718;4816.397950256218;4863.586595139417;4977.15388383972;5059.87350316245;5061.5950723942;5118.846434606968;5182.533571978503;5643.576731745095;5653.971730141323;5661.2923384576925;5663.66018038919;5663.915041274384;5680.147977803321;5687.289088863892;5687.374388817227;5690.658560486384;5694.715264236813;5149.253358263069;5251.632385733038;5254.369475662945;5260.28986086881;5354.41101478837;5620;5621.0444224481935;5624.3250809903075;5631.662100273997;5670.688112153871;5428.647137936022;5428.9185662215095;5429.294191755047;5430.456954304538;5453.345598528202;5380.811671591554;5440.91838622421;5486.91769623456;5523;5629.437056294338;5582.162675598693;5599.496045355938;5604.719764011783;5609.719514024282;5611.270534830446;5583.525400341016;5583.860403489864;5583.972080139573;5591.3569939456665;5597.944020559824;4194.559571245037;4267.487901451846;4323.870283891489;4377.212101821703;4381.890452738643;3880.6701430378735;3884.1454879926373;3898.2983063048355;3924.9018774530296;3929.174873276587;5186.299849520266;5193.740312984336;5201.973990130025;5206;5211.270422140903;5383.67697938125;5482.780688772485;5485.232067510552;5497.505224529731;5552.056150454432;5216.686998780086;5224.320838290998;5226.869328266824;5229.921551176735;5270.683758974474;4737.076270127292;4739.431268247763;4789.856304310876;4789.976050119797;4797.088553174885;5516.7517461714315;5726.169705392695;5727.627704199213;5729.0260655688635;5790.247267855152;5587.106063029895;5657.066584013592;5657.5473962082115;5662.150677398423;5699.686517241592;5654.886902261849;5691.943080569141;5694.345150307768;5697.316322041382;5709.600327977002;5338.866528336823;5416.83749487516;5448.591355648263;5449.918251226156;5451.018816613047;5516.613837031369;5543.25166102571;5543.556515478671;5580.21876937221;5580.35825880029;5405.432429594994;5435.211894275229;5443.537299329443;5443.836684899459;5446.373667028342;5429.484199001088;5511.696856672921;5537.2524709163745;5541.556675466034;5555.50000499957;5340.0921843287515;5386.5152136307925;5391.245225668331;5394.271773310553;5394.379646340564;5470.964405414326;5499.890002200013;5510.448955104457;5517.2551705519245;5552.472515111058;5225.608079394136;5313.973430132824;5322.946770532245;5347.358317001985;5442.156465747816 23:09:58 INFO - PROCESS | 15909 | |1;ext.html;524.7481209019668;528.9867753306168;535.1998761851033;552.7871769368792;553.0404747762633;28257.717422825765;28781.999999999975;28786.56820147697;34738.82630586844;35808.283834323294;37968.81015594925;38335.80832095843;38466;38473.80763096188;38499.23001539968;8311.168883111686;8553.700620478285;8566.057733649324;8569.785755356135;8573.399862009663;7605.961970190141;7751.18612545683;10017.599296028151;10175.59297628094;10176.745581360488;9918.851217231711;9956.402615843037;10015.198784097254;10024.899751002506;10025.849612255786;7581.6209189540305;7756.108047574545;9883.209343252522;9982.951790062012;9993.750156246115;9935.453550054744;10209;10210.438425886574;10220.591176352937;10235.334703244265;35395.29209415797;35912.82043589791;36014;36016.819915900254;36093.63906360929;3392.219789448416;3404.6425125361975;3490.877819276313;3678.1724112074835;3882.2235552889533;27500.58749118765;27702.5844612331;28629.427411451863;29491;29895.252618684706;3851.5185601799776;3943.507061617298;3978.085040440686;4032.6370626643447;4069.348904175318;264528;264653;265281.9999999981;265471;267050.64170828834;48554.27168592474;50005.74997125064;54110.18834717404;54516.45483545193;54639;55313;55326;55548;55589.722051389486;55617;12549.309787961749;12651.620451386472;12668.113232073667;12787.680307992374;12794.42425090873;9492.240620750323;9540.61837526505;9632.036796320452;9669.274804389699;9774.609015639437;18267.451976440727;18459.815401845808;18510.81489185118;18535.629287414176;18584.628307434046;6989.7553585624255;7110.786676399716;7124.290170359077;7153.883429667663;7192.748253811092;918.2837386838277;1001.5993602558889;1016.7356487313352;1036.4765793274348;1098.9120870330514;27836.16491505258;27922.581161282596;28260.85869570639;28386.290342741595;28420.573691394646;1031.3605564550028;1106.3748981825242;1121.1199208621192;1138.0497284767312;1150.775598758251;14660.853391466162;14685.926570367079;14706;14923.552293431214;14958.252087395804;307838;310975;311968;312215;312919;50464.74767626138;50637.49362506402;50814.74592627013;50935.23597146046;51011.7449412758;1301.4989229146847;1306.8431788185478;1322.768515509782;1327.3429652322163;1331.5006872422841;21344.573108538054;27547.86226068857;27596.586051209648;28191.15426537207;28227.15318540447;40933.38599921063;41292.587074130075;41488.585114148475;41529.37705934353;41643.16713665771;237709;238339;239426;239716;240409;27570.862145689945;28091.859540702164;28960.275993100342;31087;31597.368052638358;38863;39587.20825583414;39595.406068908414;39912.40131397973;40064.198716024934;33943.66056339405;34154;34352;34765.47851782175;35637.82181089078;28217.99161723661;32169.195770104998;32635.34729305353;35063.82468087643;38776.80611596924;34308;34683.82658086693;34922.12694682552;34977.30045399129;34998;30849.845750772;31432.68567314389;31488.685113148575;31580;31953.520697190026;23429.648555272026;23930.64104038406;24210.336862945413;24270;24280 23:09:58 INFO - PROCESS | 15909 | |2;jquery.html;339.5874013074114;342.36320443974205;342.91598558353206;346.587560802645;346.5927535146201;14094.577162685111;14508.709825803478;16086.276117574707;16728.91635541822;18742.250309987583;14891.925540372311;15134.848651513481;15139.31873065712;15142.924285378558;15163.696726065473;5181.792728290873;5188.143956247215;5361.463853614647;5364.114921038044;5371.946280537184;3953.525576930758;4098.262312783698;5313.362396512424;5880.7059647017695;6057.3336932937345;5962.731677074542;5969.5821292509545;5978.252718410199;5995.580309378345;6002.519798416116;5696.174054762057;5833.7374818133285;5856.619319744203;5858.355580886099;5865.941340586583;5090.77091530882;5114.974425127888;5116.718580478072;5123.538881500683;5143.588512918957;20206.19175232989;20405.183792648277;20925.790742092537;20970.37088887336;21843.235486758047;2190.9890450547646;2219.323106452531;2225.221172589581;2269.188871921644;2423.7333893271725;13779.862201377959;13792.172469651752;14189.077709948924;14446;14718.116912985255;1952.707093935921;1995.521074942018;2015.3349394699715;2026.6554685703466;2047.5290683142812;66341.336586634;70016.6499167506;70459.64770176167;71042.64478677625;71300;15399;15443.459478918185;15470.381184752483;15473.303701333467;15508.612284692974;24114.276571702878;24243.393915151908;24258.725072115038;24386.756132438804;24465.87767061153;7959.084705258853;7962.920370796333;7976.401769867283;7999.200079991954;8113.959430202929;6410.391012853772;6419.967900160563;6434.64609446485;6460.418562329413;6465;7541.962290188624;7551.320381165721;7673.079230492377;7684.46208765381;7757.650905709256;2574.253466494733;2955.733983941456;2978.717021882918;3010.71398217169;3020.7432368248506;829.531314807132;929.6374413978418;955.6846240740539;962.2542529539663;1017.7201269650906;16002.359905603646;16226.837731622532;16461.917690411472;16824.495265142064;16826.158692065346;931.6459745296744;932.5616960028775;944.2964991081689;1021.8620486234412;1030.5723124903081;8899.866502002475;9427.670031549;9640.951795240979;10010.749731256778;10198.898011019943;358125.20937395666;358520;547192.8482503094;547320;555230;77002.61498692582;81317;81472.59263703643;84623;84941;1069.2408390043001;1098.368438148068;1101.8567586213742;1103.713034610991;1124.3197865291381;12569.43437545331;14718.411263549766;14931.10413375201;15198;15245.542633721006;31727.206819828767;31881.20296992501;32091.197720057186;32525.67474325321;33410;38141;39105;39474.40788388119;41401.585984139776;41767.58232417759;9095;9213.262938964732;9221.077892210726;9325.766855828659;9451.716448506555;10689.251752377259;13325.533606323732;13459.394327255493;17807.643847122727;18573.72139417883;14947.25263736787;15689.607759806097;16002.759958600864;16069.67860642804;16114.355425782838;9162.35863489576;9240.815183696153;14903.627409314853;15593.610159746097;15839;9956.103950644478;10120.291579589359;10273.921238269873;10334.501497283003;10395.792084158425;14151.787723184367;14657.926710366806;14723.411063557338;14870.033447825857;14872.479463218735;14720.411183552966;15054.096754194783;15356;15435.305411256744;15832.050076994956 23:09:58 INFO - PROCESS | 15909 | |3;mootools.html;1279.2068917271292;1445.934932928018;1461.8245810502742;1592.7371983622702;1768.964620707586;6758.357955994185;7509.136449308331;7640.35057020154;7648.732294369698;7652.92347076529;7424.9976253205805;7549.886751698715;7601.049868766404;7618.809529761758;7628.199039100884;1963.9018049097488;2016.6672499037716;2182.8253739700867;2216.8004879560835;2236.6197746383073;2263.7170353705787;2269.3305474884946;2270.137347807839;2270.9545809083893;2271.0802125139344;2186.486175748698;2262.468319944812;2263.151318255654;2263.287064574662;2264.1056782570877;2193.5174261662487;2203;2227.0201111510883;2228.665700144975;2231.6987206727044;2209.3924170852983;2226.4100013496436;2252.1892118837204;2254.5040091179912;2287.062304455182;7656;7732.072151341818;7732.961335193344;7749.9225007749765;7764.844703105963;4441.200583894898;4505.707129036602;4544.159330523864;4550.317452382136;4553.430821147356;2983.254186453387;3025.5764193012997;3074.584931034304;3075.969240307613;3079.9538006929915;983.6409710455704;990.6928852055886;1007.6674697349857;1033.6382266206842;1040.6149724601871;10394.22043346752;10394.79210415795;10425.478726063666;10425.9478702606;10429.217808664305;4094.733842300241;4124.237016152021;4195.223883581547;4207.347861081537;4232.111256636079;8775.07861674515;8778.473291602524;8779.078196789245;8784.78038049054;8791.428557143892;4531.478879928784;4533.569310915458;4537.115262523776;4555.840545580955;4571.314302854598;4152.709310348307;4183.895402614898;4187.330027195634;4190.769507677046;4191.308434108399;3331.916702082419;3378.290558982592;3554.182538016271;3671.155634204148;3734.2718169957143;1179.33367647279;1193.570314686712;1195.9820602690966;1196.946137423818;1198.7482628647908;1088.3306766338803;1088.8149014667526;1090.7491277006175;1227.8833510816457;1328.3291937571464;7107.076080109656;7144.678489467987;7197.172325182566;7215;7217.783466496014;1090.9509072091776;1096.0683419093707;1115.7043383503378;1116.1963386361806;1117.675873996532;5488.7530061147345;5570.359408667974;5576;5581.079121944915;5585.664860108325;8837.469751814911;9158.496282704515;9187.26501879848;9283.25733941283;9300.767480813034;8962.596683149273;9032.096790320915;9116.81766364669;9138.725838224864;9172.633094676139;6945.617991010543;6997.510174287751;7238.638068096574;7284.562926224444;7300.7079716811795;6939.410150137295;6953.096097507494;6979.336962988508;6990.196127445409;7002.299770022957;8134.471259368122;8247.298979586561;8256.752297431087;8272.503649781032;8411.537365444714;8305.543195124326;8380.287675547646;8527.317814574695;8556.700515481929;8561.657533698832;6795.116634837439;6941.028256044056;6952.756653517103;6957;6958.826029349307;6606;6711.261761206361;7048.189458212166;7193.496455248292;7244.673989670372;6440.13058237132;6440.484761218998;6485.189351331083;6496.7726129585235;6684.4652427804685;6677.332266773284;6765.763198288037;6781.457483401217;6860.588364698134;6898.068760717239;6819.045333653392;6833.043373927555;6845.075914751644;6849.794506164823;6856.314368563104;6240.7503699851495;6253.249610046823;6310.495160387066;6337.176167098248;6366.586171898812;6353.237611486651;6370.8088757337355;6378.075179099097;6395;6424.9036264455135 23:09:58 INFO - PROCESS | 15909 | |4;prototype.html;326.960764708235;331.54782054600844;333.2934179539377;338.2119661189428;340.22089415239105;5859.589828711992;5892.14563888237;5916.970415147929;5927.911081333784;5934.080217566278;5575.080111781551;5614.635048721831;5700.857478563028;5738.626989245696;5793.884122317561;4435.203742484299;4463.218936686083;4465.955340446602;4488.1696886076015;4489.1919454498175;4284.9143017139795;4487.528809475007;4490.685652004361;4509.887252818689;4512.638988880898;4318.309070548713;4324.481062272532;4372.300431930892;4374;4380.430544029272;4356.106998065389;4395.780210989454;4425;4429.357743127229;4430.873180873199;3873.3802591585213;3886.378179491268;3889.086064774776;3891.299566078105;3893.8831835044994;5465.824956732608;5523.309586301712;5526.171074338841;5531.419200983879;5536.390996990328;5110;5171.095058364771;5171.22431635254;5172.5344718975475;5175.430702622709;6128.479079278267;6140.539459540552;6142.140100385949;6143.846403839895;6148.047052706837;4308.095299987007;4308.67684923632;4309.482862056542;4310.224159651261;4315.676324275661;6208.689565521706;6422.7109780059545;6462.15991921052;6465.612063276171;6473.996530537727;4364.018095928391;4384.101259241847;4392.824287028483;4397.868063958086;4399.186150562156;4454.26504626733;4454.443194600675;4455.732656040648;4456.286994080996;4460.77696115193;5154.407243167008;5154.664946778447;5156.974215128976;5162.199859021857;5162.92255616166;6057.545684073624;6226.719797609118;6228.096925945803;6229.937700622936;6233.158523599347;1557.8831587630973;1572.2374648295568;1573.1347758732652;1575.0628376116192;1575.3619783987504;1013.9442330671884;1045.7594753206804;1052.1950707708609;1054.0618849224197;1067.0929709746808;5912.645241285537;5921.2006379138265;5923.585349025527;5927.73325200367;5946.345901950782;6422.967885160544;6427.100205971168;6433.453156481658;6434.774782882577;6442.9355706443275;5714.285714285715;5822.796202132905;5856.0630299151935;5983.611065280743;5996.790112346047;3470.6182319944787;3487.2676737885326;3489.1277180704824;3498.4577390504514;3501.282237141431;6749.730010799612;6756.223034351015;6761.932380676229;6766.120404347404;6768.898466523006;6386.616802991743;6590.670466476657;6637.933620663828;6651.135352404156;6654.26803051664;6774.798190588079;6779.62712050832;6789.694463749143;6791.456683465311;6794.864102717918;6497;6498.285188629342;6503.02454631809;6508.446782023581;6517;6278.183836101278;6398.776042838478;6401.519886008661;6404.615723056631;6408.29508754046;6747.460203183831;6755.493337999768;6759.188897332351;6771.187457504934;6771.52599318043;4364.825406983812;4401.0977749560625;4404.1411924674385;4406.5593440655675;4409.382686423967;6407.615543067431;6506.772262970773;6513.381228783258;6540;6547.574407663486;6334.081558174131;6337.2395312562785;6341.587796793194;6347.746090156342;6348.206474190726;6345.777897773556;6346.143270658402;6346.238451385863;6348.047792831112;6357.078223657636;6078.7264573093435;6205.6586887721605;6208.534359922934;6222.751089956351;6227.9377206227355;6355.52333574993;6360.96819515918;6368.395002474757;6370.6814659267775;6371.108044873628;6175.752969881154;6196.442320191204;6197.287311959002;6199.3490683477585;6218.968905155445 23:09:58 INFO - PROCESS | 15909 | |5;yui.html;834.9916500834994;859.3511898516621;860.4321148042286;873.8121303919658;883.3463237204467;13458.596242112728;13464.12483188592;13618.319084045808;13637.113587616797;13750.31248437578;12010.819837702442;12676.302803345836;12794.552190673328;12795.872041279585;14020.929895350535;817.5871185051541;825.63671984327;829.7261903571837;830.4519017448486;831.4595512916623;807.5154907055748;809.4131754478016;810.1938571121713;811.2090711556244;811.679386642276;851.2296371783515;856.8029353248756;860.6600392844823;861.2421069458899;861.8577934640776;854;854.8845905802731;855.6449073634434;857.7255278310943;859.239572977919;628.833359159823;629.0344321466573;629.2417636747708;629.3046183966696;629.612788135298;13361.13152645075;13532.661683457894;13579.117357371839;13595.116317439335;13634.522791702242;12107.939460302641;12326.753464930742;12426.316552589604;12511.186772859826;12674.239545627292;10532.368057916472;10622.312243696522;10856.457177141112;10886.23796334257;11151.163662725328;3594.532710747586;3636.472711456824;3642.0894776305922;3643.0710168907026;3756.887293381203;41526.792366037975;41891.790541047405;45342;45377.54622453766;45879.77060114678;9290.628374865066;9945.104940555384;9984.60061597528;10310.639127630497;10327.32872363294;17803.643927121644;17831.73252401215;17948.282068717366;17951.640967180585;17958.461246162376;7527.698892044366;7654.349380302737;7680.078390593165;7685.154632990367;7735.419843511759;4235.915281694349;4321.913561728811;4324.502682191525;4358.3244597087505;4415.315626077963;3051.725344718986;3096.349766549005;3101.085179871943;3101.5887771064113;3105.1305634421947;545.2638937434432;550.1884720037992;560.9158626206101;569.6794069795693;578.2482772395869;578.4302462074853;625.1092193624158;625.8842114208886;708.727140051084;737.5722081192895;8490.278326342206;8520.786980325418;9005.189532941935;9009.549522523848;9122;598.1058317814808;611.9785807496717;646.5668002438377;654.6105067484839;660.1451120798578;3910.276598829226;4210.115875666144;4261.211675839918;4296.849610263688;4403.647708183337;47661.995490473695;48090.759546202746;48306.27540586894;48485.5151448488;48939;49111.50888491141;50933;51579.74210129;51920.22119668208;52243;39624.207515850096;40317.59682403197;47388.052238955715;47772.28341574879;51492.99999999925;8789.604467798836;8935.463872167691;8964.103589640983;9002.099790020946;9045.954770226106;33365.66343365644;34699;35329.29341413209;36054.45918311175;37319.81340093282;39097.804510977265;39828.40257396199;40299.79850100731;40790;45838;11292.943535282271;11437.771244575228;11922.880771192524;12158.939205303917;12597.11820172579;11848.676668494312;11947.761044778881;12056.457459414523;12086;12126.575569855013;11482.655520334069;11642.41787910618;11727.589534366256;11823.231489953125;11843.170978031456;11403;11438.370889601152;11571.247868888495;11885.28688278706;12050.216735912138;11160.10719142483;11219.7756044877;11220.719482013015;11355.829662554903;11936.10479214045;9622.422654640744;9764.462954537568;9903;9928.354656947275;10000.2999790014;10020.64927727526;10068.993100689873;10095.466586694598;10134.861867694672;10382.636607718996 23:09:58 INFO - PROCESS | 15909 | __end_tp_report 23:09:58 INFO - PROCESS | 15909 | __start_cc_report 23:09:58 INFO - PROCESS | 15909 | _x_x_mozilla_cycle_collect,1530 23:09:58 INFO - PROCESS | 15909 | __end_cc_report 23:09:58 INFO - PROCESS | 15909 | __startTimestamp1451804998657__endTimestamp 23:09:58 INFO - PROCESS | 15909 | 23:09:58 INFO - PROCESS | 15909 | ------- Summary: start ------- 23:09:58 INFO - PROCESS | 15909 | Number of tests: 6 23:09:58 INFO - PROCESS | 15909 | 23:09:58 INFO - PROCESS | 15909 | [#0] dojo.html Cycles:165 Average:5183.70 Median:5383.68 stddev:549.94 (10.2%) stddev-sans-first:526.82 23:09:58 INFO - PROCESS | 15909 | Values: 3102.1 3172.1 3218.1 3224.7 3248.8 5010.5 5147.4 5185.3 5211.9 5240.5 5122.2 5159.5 5231.8 5238.6 5250.9 4697.7 4726.8 4754.5 4773.7 4779.6 4851.5 4869.1 4872.1 4920.9 4946.2 4600.6 4675.9 4715.6 4799.3 4803.5 4804.0 4811.1 4838.9 4841.6 4858.0 4769.9 4791.9 4804.1 4816.4 4863.6 4977.2 5059.9 5061.6 5118.8 5182.5 5643.6 5654.0 5661.3 5663.7 5663.9 5680.1 5687.3 5687.4 5690.7 5694.7 5149.3 5251.6 5254.4 5260.3 5354.4 5620.0 5621.0 5624.3 5631.7 5670.7 5428.6 5428.9 5429.3 5430.5 5453.3 5380.8 5440.9 5486.9 5523.0 5629.4 5582.2 5599.5 5604.7 5609.7 5611.3 5583.5 5583.9 5584.0 5591.4 5597.9 4194.6 4267.5 4323.9 4377.2 4381.9 3880.7 3884.1 3898.3 3924.9 3929.2 5186.3 5193.7 5202.0 5206.0 5211.3 5383.7 5482.8 5485.2 5497.5 5552.1 5216.7 5224.3 5226.9 5229.9 5270.7 4737.1 4739.4 4789.9 4790.0 4797.1 5516.8 5726.2 5727.6 5729.0 5790.2 5587.1 5657.1 5657.5 5662.2 5699.7 5654.9 5691.9 5694.3 5697.3 5709.6 5338.9 5416.8 5448.6 5449.9 5451.0 5516.6 5543.3 5543.6 5580.2 5580.4 5405.4 5435.2 5443.5 5443.8 5446.4 5429.5 5511.7 5537.3 5541.6 5555.5 5340.1 5386.5 5391.2 5394.3 5394.4 5471.0 5499.9 5510.4 5517.3 5552.5 5225.6 5314.0 5322.9 5347.4 5442.2 23:09:58 INFO - PROCESS | 15909 | 23:09:58 INFO - PROCESS | 15909 | [#1] ext.html Cycles:180 Average:43136.86 Median:18667.94 stddev:71405.59 (382.5%) stddev-sans-first:71534.22 23:09:58 INFO - PROCESS | 15909 | Values: 524.7 529.0 535.2 552.8 553.0 28257.7 28782.0 28786.6 34738.8 35808.3 37968.8 38335.8 38466.0 38473.8 38499.2 8311.2 8553.7 8566.1 8569.8 8573.4 7606.0 7751.2 10017.6 10175.6 10176.7 9918.9 9956.4 10015.2 10024.9 10025.8 7581.6 7756.1 9883.2 9983.0 9993.8 9935.5 10209.0 10210.4 10220.6 10235.3 35395.3 35912.8 36014.0 36016.8 36093.6 3392.2 3404.6 3490.9 3678.2 3882.2 27500.6 27702.6 28629.4 29491.0 29895.3 3851.5 3943.5 3978.1 4032.6 4069.3 264528.0 264653.0 265282.0 265471.0 267050.6 48554.3 50005.7 54110.2 54516.5 54639.0 55313.0 55326.0 55548.0 55589.7 55617.0 12549.3 12651.6 12668.1 12787.7 12794.4 9492.2 9540.6 9632.0 9669.3 9774.6 18267.5 18459.8 18510.8 18535.6 18584.6 6989.8 7110.8 7124.3 7153.9 7192.7 918.3 1001.6 1016.7 1036.5 1098.9 27836.2 27922.6 28260.9 28386.3 28420.6 1031.4 1106.4 1121.1 1138.0 1150.8 14660.9 14685.9 14706.0 14923.6 14958.3 307838.0 310975.0 311968.0 312215.0 312919.0 50464.7 50637.5 50814.7 50935.2 51011.7 1301.5 1306.8 1322.8 1327.3 1331.5 21344.6 27547.9 27596.6 28191.2 28227.2 40933.4 41292.6 41488.6 41529.4 41643.2 237709.0 238339.0 239426.0 239716.0 240409.0 27570.9 28091.9 28960.3 31087.0 31597.4 38863.0 39587.2 39595.4 39912.4 40064.2 33943.7 34154.0 34352.0 34765.5 35637.8 28218.0 32169.2 32635.3 35063.8 38776.8 34308.0 34683.8 34922.1 34977.3 34998.0 30849.8 31432.7 31488.7 31580.0 31953.5 23429.6 23930.6 24210.3 24270.0 24280.0 23:09:58 INFO - PROCESS | 15909 | 23:09:58 INFO - PROCESS | 15909 | [#2] jquery.html Cycles:180 Average:27684.62 Median:3015.73 stddev:79032.51 (2620.7%) stddev-sans-first:79227.55 23:09:58 INFO - PROCESS | 15909 | Values: 339.6 342.4 342.9 346.6 346.6 14094.6 14508.7 16086.3 16728.9 18742.3 14891.9 15134.8 15139.3 15142.9 15163.7 5181.8 5188.1 5361.5 5364.1 5371.9 3953.5 4098.3 5313.4 5880.7 6057.3 5962.7 5969.6 5978.3 5995.6 6002.5 5696.2 5833.7 5856.6 5858.4 5865.9 5090.8 5115.0 5116.7 5123.5 5143.6 20206.2 20405.2 20925.8 20970.4 21843.2 2191.0 2219.3 2225.2 2269.2 2423.7 13779.9 13792.2 14189.1 14446.0 14718.1 1952.7 1995.5 2015.3 2026.7 2047.5 66341.3 70016.6 70459.6 71042.6 71300.0 15399.0 15443.5 15470.4 15473.3 15508.6 24114.3 24243.4 24258.7 24386.8 24465.9 7959.1 7962.9 7976.4 7999.2 8114.0 6410.4 6420.0 6434.6 6460.4 6465.0 7542.0 7551.3 7673.1 7684.5 7757.7 2574.3 2955.7 2978.7 3010.7 3020.7 829.5 929.6 955.7 962.3 1017.7 16002.4 16226.8 16461.9 16824.5 16826.2 931.6 932.6 944.3 1021.9 1030.6 8899.9 9427.7 9641.0 10010.7 10198.9 358125.2 358520.0 547192.8 547320.0 555230.0 77002.6 81317.0 81472.6 84623.0 84941.0 1069.2 1098.4 1101.9 1103.7 1124.3 12569.4 14718.4 14931.1 15198.0 15245.5 31727.2 31881.2 32091.2 32525.7 33410.0 38141.0 39105.0 39474.4 41401.6 41767.6 9095.0 9213.3 9221.1 9325.8 9451.7 10689.3 13325.5 13459.4 17807.6 18573.7 14947.3 15689.6 16002.8 16069.7 16114.4 9162.4 9240.8 14903.6 15593.6 15839.0 9956.1 10120.3 10273.9 10334.5 10395.8 14151.8 14657.9 14723.4 14870.0 14872.5 14720.4 15054.1 15356.0 15435.3 15832.1 23:09:58 INFO - PROCESS | 15909 | 23:09:58 INFO - PROCESS | 15909 | [#3] mootools.html Cycles:180 Average:5321.20 Median:6323.84 stddev:2742.79 (43.4%) stddev-sans-first:2733.66 23:09:58 INFO - PROCESS | 15909 | Values: 1279.2 1445.9 1461.8 1592.7 1769.0 6758.4 7509.1 7640.4 7648.7 7652.9 7425.0 7549.9 7601.0 7618.8 7628.2 1963.9 2016.7 2182.8 2216.8 2236.6 2263.7 2269.3 2270.1 2271.0 2271.1 2186.5 2262.5 2263.2 2263.3 2264.1 2193.5 2203.0 2227.0 2228.7 2231.7 2209.4 2226.4 2252.2 2254.5 2287.1 7656.0 7732.1 7733.0 7749.9 7764.8 4441.2 4505.7 4544.2 4550.3 4553.4 2983.3 3025.6 3074.6 3076.0 3080.0 983.6 990.7 1007.7 1033.6 1040.6 10394.2 10394.8 10425.5 10425.9 10429.2 4094.7 4124.2 4195.2 4207.3 4232.1 8775.1 8778.5 8779.1 8784.8 8791.4 4531.5 4533.6 4537.1 4555.8 4571.3 4152.7 4183.9 4187.3 4190.8 4191.3 3331.9 3378.3 3554.2 3671.2 3734.3 1179.3 1193.6 1196.0 1196.9 1198.7 1088.3 1088.8 1090.7 1227.9 1328.3 7107.1 7144.7 7197.2 7215.0 7217.8 1091.0 1096.1 1115.7 1116.2 1117.7 5488.8 5570.4 5576.0 5581.1 5585.7 8837.5 9158.5 9187.3 9283.3 9300.8 8962.6 9032.1 9116.8 9138.7 9172.6 6945.6 6997.5 7238.6 7284.6 7300.7 6939.4 6953.1 6979.3 6990.2 7002.3 8134.5 8247.3 8256.8 8272.5 8411.5 8305.5 8380.3 8527.3 8556.7 8561.7 6795.1 6941.0 6952.8 6957.0 6958.8 6606.0 6711.3 7048.2 7193.5 7244.7 6440.1 6440.5 6485.2 6496.8 6684.5 6677.3 6765.8 6781.5 6860.6 6898.1 6819.0 6833.0 6845.1 6849.8 6856.3 6240.8 6253.2 6310.5 6337.2 6366.6 6353.2 6370.8 6378.1 6395.0 6424.9 23:09:58 INFO - PROCESS | 15909 | 23:09:58 INFO - PROCESS | 15909 | [#4] prototype.html Cycles:180 Average:5213.53 Median:5914.81 stddev:1590.85 (26.9%) stddev-sans-first:1552.46 23:09:58 INFO - PROCESS | 15909 | Values: 327.0 331.5 333.3 338.2 340.2 5859.6 5892.1 5917.0 5927.9 5934.1 5575.1 5614.6 5700.9 5738.6 5793.9 4435.2 4463.2 4466.0 4488.2 4489.2 4284.9 4487.5 4490.7 4509.9 4512.6 4318.3 4324.5 4372.3 4374.0 4380.4 4356.1 4395.8 4425.0 4429.4 4430.9 3873.4 3886.4 3889.1 3891.3 3893.9 5465.8 5523.3 5526.2 5531.4 5536.4 5110.0 5171.1 5171.2 5172.5 5175.4 6128.5 6140.5 6142.1 6143.8 6148.0 4308.1 4308.7 4309.5 4310.2 4315.7 6208.7 6422.7 6462.2 6465.6 6474.0 4364.0 4384.1 4392.8 4397.9 4399.2 4454.3 4454.4 4455.7 4456.3 4460.8 5154.4 5154.7 5157.0 5162.2 5162.9 6057.5 6226.7 6228.1 6229.9 6233.2 1557.9 1572.2 1573.1 1575.1 1575.4 1013.9 1045.8 1052.2 1054.1 1067.1 5912.6 5921.2 5923.6 5927.7 5946.3 6423.0 6427.1 6433.5 6434.8 6442.9 5714.3 5822.8 5856.1 5983.6 5996.8 3470.6 3487.3 3489.1 3498.5 3501.3 6749.7 6756.2 6761.9 6766.1 6768.9 6386.6 6590.7 6637.9 6651.1 6654.3 6774.8 6779.6 6789.7 6791.5 6794.9 6497.0 6498.3 6503.0 6508.4 6517.0 6278.2 6398.8 6401.5 6404.6 6408.3 6747.5 6755.5 6759.2 6771.2 6771.5 4364.8 4401.1 4404.1 4406.6 4409.4 6407.6 6506.8 6513.4 6540.0 6547.6 6334.1 6337.2 6341.6 6347.7 6348.2 6345.8 6346.1 6346.2 6348.0 6357.1 6078.7 6205.7 6208.5 6222.8 6227.9 6355.5 6361.0 6368.4 6370.7 6371.1 6175.8 6196.4 6197.3 6199.3 6219.0 23:09:58 INFO - PROCESS | 15909 | 23:09:58 INFO - PROCESS | 15909 | [#5] yui.html Cycles:180 Average:13400.78 Median:4309.38 stddev:14805.67 (343.6%) stddev-sans-first:14817.13 23:09:58 INFO - PROCESS | 15909 | Values: 835.0 859.4 860.4 873.8 883.3 13458.6 13464.1 13618.3 13637.1 13750.3 12010.8 12676.3 12794.6 12795.9 14020.9 817.6 825.6 829.7 830.5 831.5 807.5 809.4 810.2 811.2 811.7 851.2 856.8 860.7 861.2 861.9 854.0 854.9 855.6 857.7 859.2 628.8 629.0 629.2 629.3 629.6 13361.1 13532.7 13579.1 13595.1 13634.5 12107.9 12326.8 12426.3 12511.2 12674.2 10532.4 10622.3 10856.5 10886.2 11151.2 3594.5 3636.5 3642.1 3643.1 3756.9 41526.8 41891.8 45342.0 45377.5 45879.8 9290.6 9945.1 9984.6 10310.6 10327.3 17803.6 17831.7 17948.3 17951.6 17958.5 7527.7 7654.3 7680.1 7685.2 7735.4 4235.9 4321.9 4324.5 4358.3 4415.3 3051.7 3096.3 3101.1 3101.6 3105.1 545.3 550.2 560.9 569.7 578.2 578.4 625.1 625.9 708.7 737.6 8490.3 8520.8 9005.2 9009.5 9122.0 598.1 612.0 646.6 654.6 660.1 3910.3 4210.1 4261.2 4296.8 4403.6 47662.0 48090.8 48306.3 48485.5 48939.0 49111.5 50933.0 51579.7 51920.2 52243.0 39624.2 40317.6 47388.1 47772.3 51493.0 8789.6 8935.5 8964.1 9002.1 9046.0 33365.7 34699.0 35329.3 36054.5 37319.8 39097.8 39828.4 40299.8 40790.0 45838.0 11292.9 11437.8 11922.9 12158.9 12597.1 11848.7 11947.8 12056.5 12086.0 12126.6 11482.7 11642.4 11727.6 11823.2 11843.2 11403.0 11438.4 11571.2 11885.3 12050.2 11160.1 11219.8 11220.7 11355.8 11936.1 9622.4 9764.5 9903.0 9928.4 10000.3 10020.6 10069.0 10095.5 10134.9 10382.6 23:09:58 INFO - PROCESS | 15909 | -------- Summary: end -------- 23:09:58 INFO - PROCESS | 15909 | 23:09:59 INFO - TEST-INFO | 15909: exit 0 23:09:59 INFO - TEST-OK | dromaeo_css | took 1113714ms 23:09:59 INFO - TEST-START | kraken 23:09:59 INFO - operating with platform_type : linux_ 23:09:59 INFO - Initialising browser for kraken test... 23:09:59 INFO - TEST-INFO | started process 16104 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcDwg0R/profile http://localhost:35094/getInfo.html) 23:10:03 INFO - PROCESS | 16104 | __metrics Screen width/height:1600/1200 23:10:03 INFO - PROCESS | 16104 | colorDepth:24 23:10:03 INFO - PROCESS | 16104 | Browser inner width/height: 1024/697 23:10:03 INFO - PROCESS | 16104 | __metrics 23:10:03 INFO - PROCESS | 16104 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:10:03 INFO - PROCESS | 16104 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:10:04 INFO - TEST-INFO | 16104: exit 0 23:10:04 INFO - Browser initialized. 23:10:04 INFO - Running cycle 1/1 for kraken test... 23:10:04 INFO - TEST-INFO | started process 16186 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcDwg0R/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:10:16 INFO - PROCESS | 16186 | RSS: Main: 150011904 23:10:16 INFO - PROCESS | 16186 | 23:10:18 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:35094/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35094/tests/kraken/driver.html?testName=audio-beat-detection) 23:10:19 INFO - PROCESS | 16186 | RSS: Main: 186011648 23:10:19 INFO - PROCESS | 16186 | 23:10:21 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:35094/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35094/tests/kraken/driver.html?testName=audio-dft) 23:10:22 INFO - PROCESS | 16186 | RSS: Main: 175759360 23:10:22 INFO - PROCESS | 16186 | 23:10:25 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:35094/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35094/tests/kraken/driver.html?testName=audio-fft) 23:10:25 INFO - PROCESS | 16186 | RSS: Main: 160104448 23:10:25 INFO - PROCESS | 16186 | 23:10:27 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:35094/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35094/tests/kraken/driver.html?testName=audio-oscillator) 23:10:28 INFO - PROCESS | 16186 | RSS: Main: 162000896 23:10:28 INFO - PROCESS | 16186 | 23:10:30 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:35094/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35094/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:10:31 INFO - PROCESS | 16186 | RSS: Main: 163217408 23:10:31 INFO - PROCESS | 16186 | 23:10:34 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:35094/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35094/tests/kraken/driver.html?testName=imaging-darkroom) 23:10:34 INFO - PROCESS | 16186 | RSS: Main: 165212160 23:10:34 INFO - PROCESS | 16186 | 23:10:37 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:35094/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35094/tests/kraken/driver.html?testName=imaging-desaturate) 23:10:38 INFO - PROCESS | 16186 | RSS: Main: 165015552 23:10:38 INFO - PROCESS | 16186 | 23:10:41 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:35094/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35094/tests/kraken/driver.html?testName=json-parse-financial) 23:10:41 INFO - PROCESS | 16186 | RSS: Main: 164188160 23:10:41 INFO - PROCESS | 16186 | 23:10:43 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:35094/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35094/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:10:43 INFO - PROCESS | 16186 | RSS: Main: 172888064 23:10:43 INFO - PROCESS | 16186 | 23:10:45 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:35094/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35094/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:10:46 INFO - PROCESS | 16186 | RSS: Main: 171393024 23:10:46 INFO - PROCESS | 16186 | 23:10:48 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:35094/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35094/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:10:49 INFO - PROCESS | 16186 | RSS: Main: 185384960 23:10:49 INFO - PROCESS | 16186 | 23:10:51 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:35094/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35094/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:10:52 INFO - PROCESS | 16186 | RSS: Main: 191934464 23:10:52 INFO - PROCESS | 16186 | 23:10:54 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:35094/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35094/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:10:55 INFO - PROCESS | 16186 | RSS: Main: 188051456 23:10:55 INFO - PROCESS | 16186 | 23:10:56 INFO - PROCESS | 16186 | Cycle 1(1): loaded http://localhost:35094/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35094/tests/kraken/driver.html?testName=ai-astar) 23:10:57 INFO - PROCESS | 16186 | RSS: Main: 246784000 23:10:57 INFO - PROCESS | 16186 | 23:10:57 INFO - PROCESS | 16186 | __start_tp_report 23:10:57 INFO - PROCESS | 16186 | _x_x_mozilla_page_load 23:10:57 INFO - PROCESS | 16186 | _x_x_mozilla_page_load_details 23:10:57 INFO - PROCESS | 16186 | |i|pagename|runs| 23:10:57 INFO - PROCESS | 16186 | |0;ai-astar;108;111;106;110;111;110;101;109;110;110 23:10:57 INFO - PROCESS | 16186 | |1;audio-beat-detection;146;126;146;161;128;166;156;127;167;131 23:10:57 INFO - PROCESS | 16186 | |2;audio-dft;162;159;163;160;161;160;164;162;161;160 23:10:57 INFO - PROCESS | 16186 | |3;audio-fft;72;73;81;98;71;72;71;112;98;73 23:10:57 INFO - PROCESS | 16186 | |4;audio-oscillator;96;96;139;97;96;96;151;96;96;154 23:10:57 INFO - PROCESS | 16186 | |5;imaging-gaussian-blur;109;109;109;109;109;109;110;109;110;109 23:10:57 INFO - PROCESS | 16186 | |6;imaging-darkroom;147;145;145;145;145;145;145;146;145;145 23:10:57 INFO - PROCESS | 16186 | |7;imaging-desaturate;96;96;96;95;96;96;96;95;96;96 23:10:57 INFO - PROCESS | 16186 | |8;json-parse-financial;57;58;57;57;56;63;57;58;56;55 23:10:57 INFO - PROCESS | 16186 | |9;json-stringify-tinderbox;67;68;67;68;68;68;68;68;68;69 23:10:57 INFO - PROCESS | 16186 | |10;stanford-crypto-aes;89;89;91;90;96;94;89;89;90;96 23:10:57 INFO - PROCESS | 16186 | |11;stanford-crypto-ccm;132;132;118;116;128;115;131;117;128;119 23:10:57 INFO - PROCESS | 16186 | |12;stanford-crypto-pbkdf2;143;156;151;150;150;140;151;141;151;141 23:10:57 INFO - PROCESS | 16186 | |13;stanford-crypto-sha256-iterative;75;68;70;67;68;70;67;68;68;72 23:10:57 INFO - PROCESS | 16186 | __end_tp_report 23:10:57 INFO - PROCESS | 16186 | __start_cc_report 23:10:57 INFO - PROCESS | 16186 | _x_x_mozilla_cycle_collect,919 23:10:57 INFO - PROCESS | 16186 | __end_cc_report 23:10:57 INFO - PROCESS | 16186 | __startTimestamp1451805057152__endTimestamp 23:10:57 INFO - PROCESS | 16186 | 23:10:57 INFO - PROCESS | 16186 | ------- Summary: start ------- 23:10:57 INFO - PROCESS | 16186 | Number of tests: 14 23:10:57 INFO - PROCESS | 16186 | 23:10:57 INFO - PROCESS | 16186 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:3.06 (2.8%) stddev-sans-first:3.24 23:10:57 INFO - PROCESS | 16186 | Values: 108.0 111.0 106.0 110.0 111.0 110.0 101.0 109.0 110.0 110.0 23:10:57 INFO - PROCESS | 16186 | 23:10:57 INFO - PROCESS | 16186 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:151.00 stddev:16.57 (11.0%) stddev-sans-first:17.58 23:10:57 INFO - PROCESS | 16186 | Values: 146.0 126.0 146.0 161.0 128.0 166.0 156.0 127.0 167.0 131.0 23:10:57 INFO - PROCESS | 16186 | 23:10:57 INFO - PROCESS | 16186 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.55 (1.0%) stddev-sans-first:1.62 23:10:57 INFO - PROCESS | 16186 | Values: 162.0 159.0 163.0 160.0 161.0 160.0 164.0 162.0 161.0 160.0 23:10:57 INFO - PROCESS | 16186 | 23:10:57 INFO - PROCESS | 16186 | [#3] audio-fft Cycles:10 Average:82.10 Median:73.00 stddev:14.97 (20.5%) stddev-sans-first:15.43 23:10:57 INFO - PROCESS | 16186 | Values: 72.0 73.0 81.0 98.0 71.0 72.0 71.0 112.0 98.0 73.0 23:10:57 INFO - PROCESS | 16186 | 23:10:57 INFO - PROCESS | 16186 | [#4] audio-oscillator Cycles:10 Average:111.70 Median:96.00 stddev:25.33 (26.4%) stddev-sans-first:26.22 23:10:57 INFO - PROCESS | 16186 | Values: 96.0 96.0 139.0 97.0 96.0 96.0 151.0 96.0 96.0 154.0 23:10:57 INFO - PROCESS | 16186 | 23:10:57 INFO - PROCESS | 16186 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:10:57 INFO - PROCESS | 16186 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 110.0 109.0 23:10:57 INFO - PROCESS | 16186 | 23:10:57 INFO - PROCESS | 16186 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.33 23:10:57 INFO - PROCESS | 16186 | Values: 147.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 23:10:57 INFO - PROCESS | 16186 | 23:10:57 INFO - PROCESS | 16186 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:10:57 INFO - PROCESS | 16186 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 23:10:57 INFO - PROCESS | 16186 | 23:10:57 INFO - PROCESS | 16186 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.00 stddev:2.17 (3.8%) stddev-sans-first:2.30 23:10:57 INFO - PROCESS | 16186 | Values: 57.0 58.0 57.0 57.0 56.0 63.0 57.0 58.0 56.0 55.0 23:10:57 INFO - PROCESS | 16186 | 23:10:57 INFO - PROCESS | 16186 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 23:10:57 INFO - PROCESS | 16186 | Values: 67.0 68.0 67.0 68.0 68.0 68.0 68.0 68.0 68.0 69.0 23:10:57 INFO - PROCESS | 16186 | 23:10:57 INFO - PROCESS | 16186 | [#10] stanford-crypto-aes Cycles:10 Average:91.30 Median:90.50 stddev:2.91 (3.2%) stddev-sans-first:2.96 23:10:57 INFO - PROCESS | 16186 | Values: 89.0 89.0 91.0 90.0 96.0 94.0 89.0 89.0 90.0 96.0 23:10:57 INFO - PROCESS | 16186 | 23:10:57 INFO - PROCESS | 16186 | [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:128.00 stddev:7.17 (5.6%) stddev-sans-first:6.93 23:10:57 INFO - PROCESS | 16186 | Values: 132.0 132.0 118.0 116.0 128.0 115.0 131.0 117.0 128.0 119.0 23:10:57 INFO - PROCESS | 16186 | 23:10:57 INFO - PROCESS | 16186 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.40 Median:150.50 stddev:5.60 (3.7%) stddev-sans-first:5.71 23:10:57 INFO - PROCESS | 16186 | Values: 143.0 156.0 151.0 150.0 150.0 140.0 151.0 141.0 151.0 141.0 23:10:57 INFO - PROCESS | 16186 | 23:10:57 INFO - PROCESS | 16186 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:2.54 (3.7%) stddev-sans-first:1.66 23:10:57 INFO - PROCESS | 16186 | Values: 75.0 68.0 70.0 67.0 68.0 70.0 67.0 68.0 68.0 72.0 23:10:57 INFO - PROCESS | 16186 | -------- Summary: end -------- 23:10:57 INFO - PROCESS | 16186 | 23:10:57 INFO - TEST-INFO | 16186: exit 0 23:10:58 INFO - TEST-OK | kraken | took 58606ms 23:10:58 INFO - TEST-START | v8_7 23:10:58 INFO - operating with platform_type : linux_ 23:10:58 INFO - Initialising browser for v8_7 test... 23:10:58 INFO - TEST-INFO | started process 16435 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmV3Ppn/profile http://localhost:35094/getInfo.html) 23:11:01 INFO - PROCESS | 16435 | __metrics Screen width/height:1600/1200 23:11:01 INFO - PROCESS | 16435 | colorDepth:24 23:11:01 INFO - PROCESS | 16435 | Browser inner width/height: 1024/697 23:11:01 INFO - PROCESS | 16435 | __metrics 23:11:01 INFO - PROCESS | 16435 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:11:01 INFO - PROCESS | 16435 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:11:02 INFO - TEST-INFO | 16435: exit 0 23:11:02 INFO - Browser initialized. 23:11:02 INFO - Running cycle 1/1 for v8_7 test... 23:11:02 INFO - TEST-INFO | started process 16516 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmV3Ppn/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:11:14 INFO - PROCESS | 16516 | RSS: Main: 149569536 23:11:14 INFO - PROCESS | 16516 | 23:11:36 INFO - PROCESS | 16516 | Cycle 1(1): loaded http://localhost:35094/tests/v8_7/run.html (next: http://localhost:35094/tests/v8_7/run.html) 23:11:36 INFO - PROCESS | 16516 | RSS: Main: 620396544 23:11:36 INFO - PROCESS | 16516 | 23:11:36 INFO - PROCESS | 16516 | __start_tp_report 23:11:36 INFO - PROCESS | 16516 | _x_x_mozilla_page_load 23:11:36 INFO - PROCESS | 16516 | _x_x_mozilla_page_load_details 23:11:36 INFO - PROCESS | 16516 | |i|pagename|runs| 23:11:36 INFO - PROCESS | 16516 | |0;Richards;166.41704110500916 23:11:36 INFO - PROCESS | 16516 | |1;DeltaBlue;191.05846388995033 23:11:36 INFO - PROCESS | 16516 | |2;Encrypt;281.0567734682406 23:11:36 INFO - PROCESS | 16516 | |3;Decrypt;5218.75 23:11:36 INFO - PROCESS | 16516 | |4;RayTrace;1122.334455667789 23:11:36 INFO - PROCESS | 16516 | |5;Earley;786.1635220125786 23:11:36 INFO - PROCESS | 16516 | |6;Boyer;12550 23:11:36 INFO - PROCESS | 16516 | |7;RegExp;25794.871794871793 23:11:36 INFO - PROCESS | 16516 | |8;Splay;636.1323155216285 23:11:36 INFO - PROCESS | 16516 | |9;NavierStokes;4835.748792270531 23:11:36 INFO - PROCESS | 16516 | __end_tp_report 23:11:36 INFO - PROCESS | 16516 | __startTimestamp1451805096258__endTimestamp 23:11:36 INFO - PROCESS | 16516 | 23:11:36 INFO - PROCESS | 16516 | ------- Summary: start ------- 23:11:36 INFO - PROCESS | 16516 | Number of tests: 10 23:11:36 INFO - PROCESS | 16516 | 23:11:36 INFO - PROCESS | 16516 | [#0] Richards Cycles:1 Average:166.42 Median:166.42 stddev:0.00 (0.0%) 23:11:36 INFO - PROCESS | 16516 | Values: 166.4 23:11:36 INFO - PROCESS | 16516 | 23:11:36 INFO - PROCESS | 16516 | [#1] DeltaBlue Cycles:1 Average:191.06 Median:191.06 stddev:0.00 (0.0%) 23:11:36 INFO - PROCESS | 16516 | Values: 191.1 23:11:36 INFO - PROCESS | 16516 | 23:11:36 INFO - PROCESS | 16516 | [#2] Encrypt Cycles:1 Average:281.06 Median:281.06 stddev:0.00 (0.0%) 23:11:36 INFO - PROCESS | 16516 | Values: 281.1 23:11:36 INFO - PROCESS | 16516 | 23:11:36 INFO - PROCESS | 16516 | [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 23:11:36 INFO - PROCESS | 16516 | Values: 5218.8 23:11:36 INFO - PROCESS | 16516 | 23:11:36 INFO - PROCESS | 16516 | [#4] RayTrace Cycles:1 Average:1122.33 Median:1122.33 stddev:0.00 (0.0%) 23:11:36 INFO - PROCESS | 16516 | Values: 1122.3 23:11:36 INFO - PROCESS | 16516 | 23:11:36 INFO - PROCESS | 16516 | [#5] Earley Cycles:1 Average:786.16 Median:786.16 stddev:0.00 (0.0%) 23:11:36 INFO - PROCESS | 16516 | Values: 786.2 23:11:36 INFO - PROCESS | 16516 | 23:11:36 INFO - PROCESS | 16516 | [#6] Boyer Cycles:1 Average:12550.00 Median:12550.00 stddev:0.00 (0.0%) 23:11:36 INFO - PROCESS | 16516 | Values: 12550.0 23:11:36 INFO - PROCESS | 16516 | 23:11:36 INFO - PROCESS | 16516 | [#7] RegExp Cycles:1 Average:25794.87 Median:25794.87 stddev:0.00 (0.0%) 23:11:36 INFO - PROCESS | 16516 | Values: 25794.9 23:11:36 INFO - PROCESS | 16516 | 23:11:36 INFO - PROCESS | 16516 | [#8] Splay Cycles:1 Average:636.13 Median:636.13 stddev:0.00 (0.0%) 23:11:36 INFO - PROCESS | 16516 | Values: 636.1 23:11:36 INFO - PROCESS | 16516 | 23:11:36 INFO - PROCESS | 16516 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 23:11:36 INFO - PROCESS | 16516 | Values: 4835.7 23:11:36 INFO - PROCESS | 16516 | -------- Summary: end -------- 23:11:36 INFO - PROCESS | 16516 | 23:11:37 INFO - TEST-INFO | 16516: exit 0 23:11:37 INFO - TEST-OK | v8_7 | took 39047ms 23:11:37 INFO - SUITE-END | took 1211s 23:11:37 INFO - Completed test suite (00:20:11) 23:11:37 INFO - Working with test: dromaeo_css 23:11:37 INFO - Generating results file: dromaeo_css 23:11:37 INFO - Working with test: kraken 23:11:37 INFO - Generating results file: kraken 23:11:37 INFO - javascript benchmark 23:11:37 INFO - Working with test: v8_7 23:11:37 INFO - Generating results file: v8_7 23:11:37 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:11:37 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 23:11:37 INFO - process_Request line: dromaeo_css 6940.69 graph.html#tests=[[72,201,35]] 23:11:37 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:11:37 INFO - process_Request line: kraken 1516.20 graph.html#tests=[[232,201,35]] 23:11:37 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:11:37 INFO - process_Request line: v8_7 20808.03 graph.html#tests=[[230,201,35]] 23:11:37 INFO - RETURN: dromaeo_css: 6940.69 23:11:37 INFO - RETURN: kraken: 1516.20 23:11:37 INFO - RETURN: v8_7: 20808.03 23:11:37 INFO - javascript benchmark 23:11:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3102.084884958937, 3172.1435212492643, 3218.1471909943853, 3224.6614105518906, 3248.821314827685, 5010.549050585447, 5147.433782283946, 5185.2740616313695, 5211.944080079401, 5240.528352448279, 5122.206058060997, 5159.458256883029, 5231.816886408977, 5238.633295669305, 5250.894982100365, 4697.741624210667, 4726.810927562893, 4754.524547545244, 4773.737444440554, 4779.593734532569, 4851.514848515138, 4869.147899117658, 4872.123017856802, 4920.901581968358, 4946.1838796598695, 4600.585947264745, 4675.859724208279, 4715.622750179995, 4799.328094066834, 4803.495632958524, 4803.975980120112, 4811.085893680224, 4838.927416088762, 4841.588464980446, 4857.975710121462, 4769.928451073237, 4791.904161916777, 4804.111239420718, 4816.397950256218, 4863.586595139417, 4977.15388383972, 5059.87350316245, 5061.5950723942, 5118.846434606968, 5182.533571978503, 5643.576731745095, 5653.971730141323, 5661.2923384576925, 5663.66018038919, 5663.915041274384, 5680.147977803321, 5687.289088863892, 5687.374388817227, 5690.658560486384, 5694.715264236813, 5149.253358263069, 5251.632385733038, 5254.369475662945, 5260.28986086881, 5354.41101478837, 5620.0, 5621.0444224481935, 5624.3250809903075, 5631.662100273997, 5670.688112153871, 5428.647137936022, 5428.9185662215095, 5429.294191755047, 5430.456954304538, 5453.345598528202, 5380.811671591554, 5440.91838622421, 5486.91769623456, 5523.0, 5629.437056294338, 5582.162675598693, 5599.496045355938, 5604.719764011783, 5609.719514024282, 5611.270534830446, 5583.525400341016, 5583.860403489864, 5583.972080139573, 5591.3569939456665, 5597.944020559824, 4194.559571245037, 4267.487901451846, 4323.870283891489, 4377.212101821703, 4381.890452738643, 3880.6701430378735, 3884.1454879926373, 3898.2983063048355, 3924.9018774530296, 3929.174873276587, 5186.299849520266, 5193.740312984336, 5201.973990130025, 5206.0, 5211.270422140903, 5383.67697938125, 5482.780688772485, 5485.232067510552, 5497.505224529731, 5552.056150454432, 5216.686998780086, 5224.320838290998, 5226.869328266824, 5229.921551176735, 5270.683758974474, 4737.076270127292, 4739.431268247763, 4789.856304310876, 4789.976050119797, 4797.088553174885, 5516.7517461714315, 5726.169705392695, 5727.627704199213, 5729.0260655688635, 5790.247267855152, 5587.106063029895, 5657.066584013592, 5657.5473962082115, 5662.150677398423, 5699.686517241592, 5654.886902261849, 5691.943080569141, 5694.345150307768, 5697.316322041382, 5709.600327977002, 5338.866528336823, 5416.83749487516, 5448.591355648263, 5449.918251226156, 5451.018816613047, 5516.613837031369, 5543.25166102571, 5543.556515478671, 5580.21876937221, 5580.35825880029, 5405.432429594994, 5435.211894275229, 5443.537299329443, 5443.836684899459, 5446.373667028342, 5429.484199001088, 5511.696856672921, 5537.2524709163745, 5541.556675466034, 5555.50000499957, 5340.0921843287515, 5386.5152136307925, 5391.245225668331, 5394.271773310553, 5394.379646340564, 5470.964405414326, 5499.890002200013, 5510.448955104457, 5517.2551705519245, 5552.472515111058, 5225.608079394136, 5313.973430132824, 5322.946770532245, 5347.358317001985, 5442.156465747816], "unit": "score", "name": "dojo.html", "value": 5149.782422475374}, {"lowerIsBetter": false, "replicates": [524.7481209019668, 528.9867753306168, 535.1998761851033, 552.7871769368792, 553.0404747762633, 28257.717422825765, 28781.999999999975, 28786.56820147697, 34738.82630586844, 35808.283834323294, 37968.81015594925, 38335.80832095843, 38466.0, 38473.80763096188, 38499.23001539968, 8311.168883111686, 8553.700620478285, 8566.057733649324, 8569.785755356135, 8573.399862009663, 7605.961970190141, 7751.18612545683, 10017.599296028151, 10175.59297628094, 10176.745581360488, 9918.851217231711, 9956.402615843037, 10015.198784097254, 10024.899751002506, 10025.849612255786, 7581.6209189540305, 7756.108047574545, 9883.209343252522, 9982.951790062012, 9993.750156246115, 9935.453550054744, 10209.0, 10210.438425886574, 10220.591176352937, 10235.334703244265, 35395.29209415797, 35912.82043589791, 36014.0, 36016.819915900254, 36093.63906360929, 3392.219789448416, 3404.6425125361975, 3490.877819276313, 3678.1724112074835, 3882.2235552889533, 27500.58749118765, 27702.5844612331, 28629.427411451863, 29491.0, 29895.252618684706, 3851.5185601799776, 3943.507061617298, 3978.085040440686, 4032.6370626643447, 4069.348904175318, 264528.0, 264653.0, 265281.9999999981, 265471.0, 267050.64170828834, 48554.27168592474, 50005.74997125064, 54110.18834717404, 54516.45483545193, 54639.0, 55313.0, 55326.0, 55548.0, 55589.722051389486, 55617.0, 12549.309787961749, 12651.620451386472, 12668.113232073667, 12787.680307992374, 12794.42425090873, 9492.240620750323, 9540.61837526505, 9632.036796320452, 9669.274804389699, 9774.609015639437, 18267.451976440727, 18459.815401845808, 18510.81489185118, 18535.629287414176, 18584.628307434046, 6989.7553585624255, 7110.786676399716, 7124.290170359077, 7153.883429667663, 7192.748253811092, 918.2837386838277, 1001.5993602558889, 1016.7356487313352, 1036.4765793274348, 1098.9120870330514, 27836.16491505258, 27922.581161282596, 28260.85869570639, 28386.290342741595, 28420.573691394646, 1031.3605564550028, 1106.3748981825242, 1121.1199208621192, 1138.0497284767312, 1150.775598758251, 14660.853391466162, 14685.926570367079, 14706.0, 14923.552293431214, 14958.252087395804, 307838.0, 310975.0, 311968.0, 312215.0, 312919.0, 50464.74767626138, 50637.49362506402, 50814.74592627013, 50935.23597146046, 51011.7449412758, 1301.4989229146847, 1306.8431788185478, 1322.768515509782, 1327.3429652322163, 1331.5006872422841, 21344.573108538054, 27547.86226068857, 27596.586051209648, 28191.15426537207, 28227.15318540447, 40933.38599921063, 41292.587074130075, 41488.585114148475, 41529.37705934353, 41643.16713665771, 237709.0, 238339.0, 239426.0, 239716.0, 240409.0, 27570.862145689945, 28091.859540702164, 28960.275993100342, 31087.0, 31597.368052638358, 38863.0, 39587.20825583414, 39595.406068908414, 39912.40131397973, 40064.198716024934, 33943.66056339405, 34154.0, 34352.0, 34765.47851782175, 35637.82181089078, 28217.99161723661, 32169.195770104998, 32635.34729305353, 35063.82468087643, 38776.80611596924, 34308.0, 34683.82658086693, 34922.12694682552, 34977.30045399129, 34998.0, 30849.845750772, 31432.68567314389, 31488.685113148575, 31580.0, 31953.520697190026, 23429.648555272026, 23930.64104038406, 24210.336862945413, 24270.0, 24280.0], "unit": "score", "name": "ext.html", "value": 17648.033055006035}, {"lowerIsBetter": false, "replicates": [339.5874013074114, 342.36320443974205, 342.91598558353206, 346.587560802645, 346.5927535146201, 14094.577162685111, 14508.709825803478, 16086.276117574707, 16728.91635541822, 18742.250309987583, 14891.925540372311, 15134.848651513481, 15139.31873065712, 15142.924285378558, 15163.696726065473, 5181.792728290873, 5188.143956247215, 5361.463853614647, 5364.114921038044, 5371.946280537184, 3953.525576930758, 4098.262312783698, 5313.362396512424, 5880.7059647017695, 6057.3336932937345, 5962.731677074542, 5969.5821292509545, 5978.252718410199, 5995.580309378345, 6002.519798416116, 5696.174054762057, 5833.7374818133285, 5856.619319744203, 5858.355580886099, 5865.941340586583, 5090.77091530882, 5114.974425127888, 5116.718580478072, 5123.538881500683, 5143.588512918957, 20206.19175232989, 20405.183792648277, 20925.790742092537, 20970.37088887336, 21843.235486758047, 2190.9890450547646, 2219.323106452531, 2225.221172589581, 2269.188871921644, 2423.7333893271725, 13779.862201377959, 13792.172469651752, 14189.077709948924, 14446.0, 14718.116912985255, 1952.707093935921, 1995.521074942018, 2015.3349394699715, 2026.6554685703466, 2047.5290683142812, 66341.336586634, 70016.6499167506, 70459.64770176167, 71042.64478677625, 71300.0, 15399.0, 15443.459478918185, 15470.381184752483, 15473.303701333467, 15508.612284692974, 24114.276571702878, 24243.393915151908, 24258.725072115038, 24386.756132438804, 24465.87767061153, 7959.084705258853, 7962.920370796333, 7976.401769867283, 7999.200079991954, 8113.959430202929, 6410.391012853772, 6419.967900160563, 6434.64609446485, 6460.418562329413, 6465.0, 7541.962290188624, 7551.320381165721, 7673.079230492377, 7684.46208765381, 7757.650905709256, 2574.253466494733, 2955.733983941456, 2978.717021882918, 3010.71398217169, 3020.7432368248506, 829.531314807132, 929.6374413978418, 955.6846240740539, 962.2542529539663, 1017.7201269650906, 16002.359905603646, 16226.837731622532, 16461.917690411472, 16824.495265142064, 16826.158692065346, 931.6459745296744, 932.5616960028775, 944.2964991081689, 1021.8620486234412, 1030.5723124903081, 8899.866502002475, 9427.670031549, 9640.951795240979, 10010.749731256778, 10198.898011019943, 358125.20937395666, 358520.0, 547192.8482503094, 547320.0, 555230.0, 77002.61498692582, 81317.0, 81472.59263703643, 84623.0, 84941.0, 1069.2408390043001, 1098.368438148068, 1101.8567586213742, 1103.713034610991, 1124.3197865291381, 12569.43437545331, 14718.411263549766, 14931.10413375201, 15198.0, 15245.542633721006, 31727.206819828767, 31881.20296992501, 32091.197720057186, 32525.67474325321, 33410.0, 38141.0, 39105.0, 39474.40788388119, 41401.585984139776, 41767.58232417759, 9095.0, 9213.262938964732, 9221.077892210726, 9325.766855828659, 9451.716448506555, 10689.251752377259, 13325.533606323732, 13459.394327255493, 17807.643847122727, 18573.72139417883, 14947.25263736787, 15689.607759806097, 16002.759958600864, 16069.67860642804, 16114.355425782838, 9162.35863489576, 9240.815183696153, 14903.627409314853, 15593.610159746097, 15839.0, 9956.103950644478, 10120.291579589359, 10273.921238269873, 10334.501497283003, 10395.792084158425, 14151.787723184367, 14657.926710366806, 14723.411063557338, 14870.033447825857, 14872.479463218735, 14720.411183552966, 15054.096754194783, 15356.0, 15435.305411256744, 15832.050076994956], "unit": "score", "name": "jquery.html", "value": 9427.077997997558}, {"lowerIsBetter": false, "replicates": [1279.2068917271292, 1445.934932928018, 1461.8245810502742, 1592.7371983622702, 1768.964620707586, 6758.357955994185, 7509.136449308331, 7640.35057020154, 7648.732294369698, 7652.92347076529, 7424.9976253205805, 7549.886751698715, 7601.049868766404, 7618.809529761758, 7628.199039100884, 1963.9018049097488, 2016.6672499037716, 2182.8253739700867, 2216.8004879560835, 2236.6197746383073, 2263.7170353705787, 2269.3305474884946, 2270.137347807839, 2270.9545809083893, 2271.0802125139344, 2186.486175748698, 2262.468319944812, 2263.151318255654, 2263.287064574662, 2264.1056782570877, 2193.5174261662487, 2203.0, 2227.0201111510883, 2228.665700144975, 2231.6987206727044, 2209.3924170852983, 2226.4100013496436, 2252.1892118837204, 2254.5040091179912, 2287.062304455182, 7656.0, 7732.072151341818, 7732.961335193344, 7749.9225007749765, 7764.844703105963, 4441.200583894898, 4505.707129036602, 4544.159330523864, 4550.317452382136, 4553.430821147356, 2983.254186453387, 3025.5764193012997, 3074.584931034304, 3075.969240307613, 3079.9538006929915, 983.6409710455704, 990.6928852055886, 1007.6674697349857, 1033.6382266206842, 1040.6149724601871, 10394.22043346752, 10394.79210415795, 10425.478726063666, 10425.9478702606, 10429.217808664305, 4094.733842300241, 4124.237016152021, 4195.223883581547, 4207.347861081537, 4232.111256636079, 8775.07861674515, 8778.473291602524, 8779.078196789245, 8784.78038049054, 8791.428557143892, 4531.478879928784, 4533.569310915458, 4537.115262523776, 4555.840545580955, 4571.314302854598, 4152.709310348307, 4183.895402614898, 4187.330027195634, 4190.769507677046, 4191.308434108399, 3331.916702082419, 3378.290558982592, 3554.182538016271, 3671.155634204148, 3734.2718169957143, 1179.33367647279, 1193.570314686712, 1195.9820602690966, 1196.946137423818, 1198.7482628647908, 1088.3306766338803, 1088.8149014667526, 1090.7491277006175, 1227.8833510816457, 1328.3291937571464, 7107.076080109656, 7144.678489467987, 7197.172325182566, 7215.0, 7217.783466496014, 1090.9509072091776, 1096.0683419093707, 1115.7043383503378, 1116.1963386361806, 1117.675873996532, 5488.7530061147345, 5570.359408667974, 5576.0, 5581.079121944915, 5585.664860108325, 8837.469751814911, 9158.496282704515, 9187.26501879848, 9283.25733941283, 9300.767480813034, 8962.596683149273, 9032.096790320915, 9116.81766364669, 9138.725838224864, 9172.633094676139, 6945.617991010543, 6997.510174287751, 7238.638068096574, 7284.562926224444, 7300.7079716811795, 6939.410150137295, 6953.096097507494, 6979.336962988508, 6990.196127445409, 7002.299770022957, 8134.471259368122, 8247.298979586561, 8256.752297431087, 8272.503649781032, 8411.537365444714, 8305.543195124326, 8380.287675547646, 8527.317814574695, 8556.700515481929, 8561.657533698832, 6795.116634837439, 6941.028256044056, 6952.756653517103, 6957.0, 6958.826029349307, 6606.0, 6711.261761206361, 7048.189458212166, 7193.496455248292, 7244.673989670372, 6440.13058237132, 6440.484761218998, 6485.189351331083, 6496.7726129585235, 6684.4652427804685, 6677.332266773284, 6765.763198288037, 6781.457483401217, 6860.588364698134, 6898.068760717239, 6819.045333653392, 6833.043373927555, 6845.075914751644, 6849.794506164823, 6856.314368563104, 6240.7503699851495, 6253.249610046823, 6310.495160387066, 6337.176167098248, 6366.586171898812, 6353.237611486651, 6370.8088757337355, 6378.075179099097, 6395.0, 6424.9036264455135], "unit": "score", "name": "mootools.html", "value": 4388.0956672778475}, {"lowerIsBetter": false, "replicates": [326.960764708235, 331.54782054600844, 333.2934179539377, 338.2119661189428, 340.22089415239105, 5859.589828711992, 5892.14563888237, 5916.970415147929, 5927.911081333784, 5934.080217566278, 5575.080111781551, 5614.635048721831, 5700.857478563028, 5738.626989245696, 5793.884122317561, 4435.203742484299, 4463.218936686083, 4465.955340446602, 4488.1696886076015, 4489.1919454498175, 4284.9143017139795, 4487.528809475007, 4490.685652004361, 4509.887252818689, 4512.638988880898, 4318.309070548713, 4324.481062272532, 4372.300431930892, 4374.0, 4380.430544029272, 4356.106998065389, 4395.780210989454, 4425.0, 4429.357743127229, 4430.873180873199, 3873.3802591585213, 3886.378179491268, 3889.086064774776, 3891.299566078105, 3893.8831835044994, 5465.824956732608, 5523.309586301712, 5526.171074338841, 5531.419200983879, 5536.390996990328, 5110.0, 5171.095058364771, 5171.22431635254, 5172.5344718975475, 5175.430702622709, 6128.479079278267, 6140.539459540552, 6142.140100385949, 6143.846403839895, 6148.047052706837, 4308.095299987007, 4308.67684923632, 4309.482862056542, 4310.224159651261, 4315.676324275661, 6208.689565521706, 6422.7109780059545, 6462.15991921052, 6465.612063276171, 6473.996530537727, 4364.018095928391, 4384.101259241847, 4392.824287028483, 4397.868063958086, 4399.186150562156, 4454.26504626733, 4454.443194600675, 4455.732656040648, 4456.286994080996, 4460.77696115193, 5154.407243167008, 5154.664946778447, 5156.974215128976, 5162.199859021857, 5162.92255616166, 6057.545684073624, 6226.719797609118, 6228.096925945803, 6229.937700622936, 6233.158523599347, 1557.8831587630973, 1572.2374648295568, 1573.1347758732652, 1575.0628376116192, 1575.3619783987504, 1013.9442330671884, 1045.7594753206804, 1052.1950707708609, 1054.0618849224197, 1067.0929709746808, 5912.645241285537, 5921.2006379138265, 5923.585349025527, 5927.73325200367, 5946.345901950782, 6422.967885160544, 6427.100205971168, 6433.453156481658, 6434.774782882577, 6442.9355706443275, 5714.285714285715, 5822.796202132905, 5856.0630299151935, 5983.611065280743, 5996.790112346047, 3470.6182319944787, 3487.2676737885326, 3489.1277180704824, 3498.4577390504514, 3501.282237141431, 6749.730010799612, 6756.223034351015, 6761.932380676229, 6766.120404347404, 6768.898466523006, 6386.616802991743, 6590.670466476657, 6637.933620663828, 6651.135352404156, 6654.26803051664, 6774.798190588079, 6779.62712050832, 6789.694463749143, 6791.456683465311, 6794.864102717918, 6497.0, 6498.285188629342, 6503.02454631809, 6508.446782023581, 6517.0, 6278.183836101278, 6398.776042838478, 6401.519886008661, 6404.615723056631, 6408.29508754046, 6747.460203183831, 6755.493337999768, 6759.188897332351, 6771.187457504934, 6771.52599318043, 4364.825406983812, 4401.0977749560625, 4404.1411924674385, 4406.5593440655675, 4409.382686423967, 6407.615543067431, 6506.772262970773, 6513.381228783258, 6540.0, 6547.574407663486, 6334.081558174131, 6337.2395312562785, 6341.587796793194, 6347.746090156342, 6348.206474190726, 6345.777897773556, 6346.143270658402, 6346.238451385863, 6348.047792831112, 6357.078223657636, 6078.7264573093435, 6205.6586887721605, 6208.534359922934, 6222.751089956351, 6227.9377206227355, 6355.52333574993, 6360.96819515918, 6368.395002474757, 6370.6814659267775, 6371.108044873628, 6175.752969881154, 6196.442320191204, 6197.287311959002, 6199.3490683477585, 6218.968905155445], "unit": "score", "name": "prototype.html", "value": 4697.758433435236}, {"lowerIsBetter": false, "replicates": [834.9916500834994, 859.3511898516621, 860.4321148042286, 873.8121303919658, 883.3463237204467, 13458.596242112728, 13464.12483188592, 13618.319084045808, 13637.113587616797, 13750.31248437578, 12010.819837702442, 12676.302803345836, 12794.552190673328, 12795.872041279585, 14020.929895350535, 817.5871185051541, 825.63671984327, 829.7261903571837, 830.4519017448486, 831.4595512916623, 807.5154907055748, 809.4131754478016, 810.1938571121713, 811.2090711556244, 811.679386642276, 851.2296371783515, 856.8029353248756, 860.6600392844823, 861.2421069458899, 861.8577934640776, 854.0, 854.8845905802731, 855.6449073634434, 857.7255278310943, 859.239572977919, 628.833359159823, 629.0344321466573, 629.2417636747708, 629.3046183966696, 629.612788135298, 13361.13152645075, 13532.661683457894, 13579.117357371839, 13595.116317439335, 13634.522791702242, 12107.939460302641, 12326.753464930742, 12426.316552589604, 12511.186772859826, 12674.239545627292, 10532.368057916472, 10622.312243696522, 10856.457177141112, 10886.23796334257, 11151.163662725328, 3594.532710747586, 3636.472711456824, 3642.0894776305922, 3643.0710168907026, 3756.887293381203, 41526.792366037975, 41891.790541047405, 45342.0, 45377.54622453766, 45879.77060114678, 9290.628374865066, 9945.104940555384, 9984.60061597528, 10310.639127630497, 10327.32872363294, 17803.643927121644, 17831.73252401215, 17948.282068717366, 17951.640967180585, 17958.461246162376, 7527.698892044366, 7654.349380302737, 7680.078390593165, 7685.154632990367, 7735.419843511759, 4235.915281694349, 4321.913561728811, 4324.502682191525, 4358.3244597087505, 4415.315626077963, 3051.725344718986, 3096.349766549005, 3101.085179871943, 3101.5887771064113, 3105.1305634421947, 545.2638937434432, 550.1884720037992, 560.9158626206101, 569.6794069795693, 578.2482772395869, 578.4302462074853, 625.1092193624158, 625.8842114208886, 708.727140051084, 737.5722081192895, 8490.278326342206, 8520.786980325418, 9005.189532941935, 9009.549522523848, 9122.0, 598.1058317814808, 611.9785807496717, 646.5668002438377, 654.6105067484839, 660.1451120798578, 3910.276598829226, 4210.115875666144, 4261.211675839918, 4296.849610263688, 4403.647708183337, 47661.995490473695, 48090.759546202746, 48306.27540586894, 48485.5151448488, 48939.0, 49111.50888491141, 50933.0, 51579.74210129, 51920.22119668208, 52243.0, 39624.207515850096, 40317.59682403197, 47388.052238955715, 47772.28341574879, 51492.99999999925, 8789.604467798836, 8935.463872167691, 8964.103589640983, 9002.099790020946, 9045.954770226106, 33365.66343365644, 34699.0, 35329.29341413209, 36054.45918311175, 37319.81340093282, 39097.804510977265, 39828.40257396199, 40299.79850100731, 40790.0, 45838.0, 11292.943535282271, 11437.771244575228, 11922.880771192524, 12158.939205303917, 12597.11820172579, 11848.676668494312, 11947.761044778881, 12056.457459414523, 12086.0, 12126.575569855013, 11482.655520334069, 11642.41787910618, 11727.589534366256, 11823.231489953125, 11843.170978031456, 11403.0, 11438.370889601152, 11571.247868888495, 11885.28688278706, 12050.216735912138, 11160.10719142483, 11219.7756044877, 11220.719482013015, 11355.829662554903, 11936.10479214045, 9622.422654640744, 9764.462954537568, 9903.0, 9928.354656947275, 10000.2999790014, 10020.64927727526, 10068.993100689873, 10095.466586694598, 10134.861867694672, 10382.636607718996], "unit": "score", "name": "yui.html", "value": 6329.168532081179}], "name": "dromaeo_css", "value": 6940.688495262771}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 106.0, 110.0, 111.0, 110.0, 101.0, 109.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [146.0, 126.0, 146.0, 161.0, 128.0, 166.0, 156.0, 127.0, 167.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 145.4}, {"lowerIsBetter": true, "replicates": [162.0, 159.0, 163.0, 160.0, 161.0, 160.0, 164.0, 162.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 81.0, 98.0, 71.0, 72.0, 71.0, 112.0, 98.0, 73.0], "unit": "score", "name": "audio-fft", "value": 82.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 139.0, 97.0, 96.0, 96.0, 151.0, 96.0, 96.0, 154.0], "unit": "score", "name": "audio-oscillator", "value": 111.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 57.0, 57.0, 56.0, 63.0, 57.0, 58.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [89.0, 89.0, 91.0, 90.0, 96.0, 94.0, 89.0, 89.0, 90.0, 96.0], "unit": "score", "name": "stanford-crypto-aes", "value": 91.3}, {"lowerIsBetter": true, "replicates": [132.0, 132.0, 118.0, 116.0, 128.0, 115.0, 131.0, 117.0, 128.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.6}, {"lowerIsBetter": true, "replicates": [143.0, 156.0, 151.0, 150.0, 150.0, 140.0, 151.0, 141.0, 151.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.4}, {"lowerIsBetter": true, "replicates": [75.0, 68.0, 70.0, 67.0, 68.0, 70.0, 67.0, 68.0, 68.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1516.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.41704110500916], "unit": "score", "name": "Richards", "value": 212.1297179999999}, {"lowerIsBetter": false, "replicates": [191.05846388995033], "unit": "score", "name": "DeltaBlue", "value": 346.061612}, {"lowerIsBetter": false, "replicates": [281.0567734682406], "unit": "score", "name": "Encrypt", "value": 947.0719979999998}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1122.334455667789], "unit": "score", "name": "RayTrace", "value": 659.3301990000002}, {"lowerIsBetter": false, "replicates": [786.1635220125786], "unit": "score", "name": "Earley", "value": 847.7409359999999}, {"lowerIsBetter": false, "replicates": [12550.0], "unit": "score", "name": "Boyer", "value": 53.10462151394425}, {"lowerIsBetter": false, "replicates": [25794.871794871793], "unit": "score", "name": "RegExp", "value": 35.31651590457257}, {"lowerIsBetter": false, "replicates": [636.1323155216285], "unit": "score", "name": "Splay", "value": 128.10385200000002}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20808.033945806274}]} 23:11:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20808.03"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1516.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6940.69"}}} 23:11:37 INFO - Return code: 0 23:11:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:11:37 INFO - # TBPL SUCCESS # 23:11:37 INFO - Running post-action listener: _resource_record_post_action 23:11:37 INFO - Running post-run listener: _resource_record_post_run 23:11:38 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 77824; Write bytes: 554913792; Read time: 44; Write time: 652460 23:11:38 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 246374400; Read time: 0; Write time: 317440 23:11:38 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 77824; Write bytes: 308252672; Read time: 44; Write time: 334992 23:11:38 INFO - Running post-run listener: _upload_blobber_files 23:11:38 INFO - Blob upload gear active. 23:11:38 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:11:38 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 23:11:38 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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:11:38 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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:11:39 INFO - (blobuploader) - INFO - Open directory for files ... 23:11:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:11:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:11:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:11:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:11:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:11:40 INFO - (blobuploader) - INFO - Done attempting. 23:11:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:11:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:11:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:11:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:11:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:11:41 INFO - (blobuploader) - INFO - Done attempting. 23:11:41 INFO - (blobuploader) - INFO - Iteration through files over. 23:11:41 INFO - Return code: 0 23:11:41 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:11:41 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:11:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/1193786e66b6f6972cc45beeda04ef5896b3b705e1fc0e5f25b43755c2505aa3bf32ca70ed12d517d88d2de0e6337c206bdd1448da03e71b5679645d2761d8f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/c70dbc520febfd2a0d0a7a7ca829db4598f94256bed4c707df8219fd0073eb2f8e5bf77ae59fc7a2c7184f09b4f2a064cf624de5fdaca9c0cb64ea50d1c73136"} 23:11:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:11:41 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:11:41 INFO - Contents: 23:11:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/1193786e66b6f6972cc45beeda04ef5896b3b705e1fc0e5f25b43755c2505aa3bf32ca70ed12d517d88d2de0e6337c206bdd1448da03e71b5679645d2761d8f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/c70dbc520febfd2a0d0a7a7ca829db4598f94256bed4c707df8219fd0073eb2f8e5bf77ae59fc7a2c7184f09b4f2a064cf624de5fdaca9c0cb64ea50d1c73136"} 23:11:41 INFO - Copying logs to upload dir... 23:11:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1270.449275 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-02 23:11:40.721311) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-02 23:11:40.724774) ========= 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=7d909545e45784438f4e8e36000001b3-1451801359.481941-1110124823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/1193786e66b6f6972cc45beeda04ef5896b3b705e1fc0e5f25b43755c2505aa3bf32ca70ed12d517d88d2de0e6337c206bdd1448da03e71b5679645d2761d8f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/c70dbc520febfd2a0d0a7a7ca829db4598f94256bed4c707df8219fd0073eb2f8e5bf77ae59fc7a2c7184f09b4f2a064cf624de5fdaca9c0cb64ea50d1c73136"} build_url:https://queue.taskcluster.net/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011530 build_url: 'https://queue.taskcluster.net/v1/task/DjuRZLz0TgWiwrZz3xKfNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/1193786e66b6f6972cc45beeda04ef5896b3b705e1fc0e5f25b43755c2505aa3bf32ca70ed12d517d88d2de0e6337c206bdd1448da03e71b5679645d2761d8f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/c70dbc520febfd2a0d0a7a7ca829db4598f94256bed4c707df8219fd0073eb2f8e5bf77ae59fc7a2c7184f09b4f2a064cf624de5fdaca9c0cb64ea50d1c73136"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-02 23:11:40.749813) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 23:11:40.750147) ========= 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=7d909545e45784438f4e8e36000001b3-1451801359.481941-1110124823 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004567 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-02 23:11:40.836032) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-02 23:11:40.836429) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-02 23:11:40.837149) ========= ========= Total master_lag: 0.50 =========