builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1450766844.82 results: success (0) buildid: 20151221203241 builduid: 7a868b5b4f864b73bff11462f35970b3 revision: b96e844b0289c5363b5988214d6343b05a7996e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 22:47:24.822645) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 22:47:24.823163) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 22:47:24.823486) ========= 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=a9e534cca236dfa67d42a089000001c1-1450763974.273791-935948795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006352 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 22:47:24.867197) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 22:47:24.867511) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 22:47:24.897827) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 22:47:24.898117) ========= 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=a9e534cca236dfa67d42a089000001c1-1450763974.273791-935948795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024401 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 22:47:24.950208) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 22:47:24.950505) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 22:47:24.950927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 22:47:24.951266) ========= 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=a9e534cca236dfa67d42a089000001c1-1450763974.273791-935948795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 22:47:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2015-12-21 22:47:25 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179749 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 22:47:25.147635) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 22:47:25.147908) ========= 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=a9e534cca236dfa67d42a089000001c1-1450763974.273791-935948795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.154635 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 22:47:25.312264) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 22:47:25.312645) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b96e844b0289c5363b5988214d6343b05a7996e8 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b96e844b0289c5363b5988214d6343b05a7996e8 --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=a9e534cca236dfa67d42a089000001c1-1450763974.273791-935948795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 22:47:25,461 truncating revision to first 12 chars 2015-12-21 22:47:25,461 Setting DEBUG logging. 2015-12-21 22:47:25,461 attempt 1/10 2015-12-21 22:47:25,461 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b96e844b0289?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-21 22:47:25,714 unpacking tar archive at: fx-team-b96e844b0289/testing/mozharness/ program finished with exit code 0 elapsedTime=0.529520 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 22:47:25.858359) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 22:47:25.858725) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 22:47:25.873361) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 22:47:25.873629) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 22:47:25.874037) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-21 22:47:25.874312) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a9e534cca236dfa67d42a089000001c1-1450763974.273791-935948795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:47:26 INFO - MultiFileLogger online at 20151221 22:47:26 in /builds/slave/test-pgo 22:47:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:47:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:47:26 INFO - {'append_to_log': False, 22:47:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:47:26 INFO - 'blob_upload_branch': 'Fx-Team', 22:47:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:47:26 INFO - 'branch': 'Fx-Team', 22:47:26 INFO - 'buildbot_json_path': 'buildprops.json', 22:47:26 INFO - 'config_files': ('talos/linux_config.py',), 22:47:26 INFO - 'default_actions': ('clobber', 22:47:26 INFO - 'read-buildbot-config', 22:47:26 INFO - 'download-and-extract', 22:47:26 INFO - 'populate-webroot', 22:47:26 INFO - 'create-virtualenv', 22:47:26 INFO - 'install', 22:47:26 INFO - 'run-tests'), 22:47:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:47:26 INFO - 'download_minidump_stackwalk': True, 22:47:26 INFO - 'download_symbols': 'ondemand', 22:47:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:47:26 INFO - 'tooltool.py': '/tools/tooltool.py', 22:47:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:47:26 INFO - '/tools/misc-python/virtualenv.py')}, 22:47:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:47:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:47:26 INFO - 'installer_path': 'installer.exe', 22:47:26 INFO - 'log_level': 'info', 22:47:26 INFO - 'log_name': 'talos', 22:47:26 INFO - 'log_to_console': True, 22:47:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:47:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:47:26 INFO - 'opt_config_files': (), 22:47:26 INFO - 'pip_index': False, 22:47:26 INFO - 'sps_profile': False, 22:47:26 INFO - 'sps_profile_interval': 0, 22:47:26 INFO - 'suite': 'dromaeojs', 22:47:26 INFO - 'system_bits': '64', 22:47:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:47:26 INFO - 'title': 'talos-linux64-ix-031', 22:47:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:47:26 INFO - 'use_talos_json': True, 22:47:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:47:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:47:26 INFO - 'work_dir': 'build'} 22:47:26 INFO - ##### 22:47:26 INFO - ##### Running clobber step. 22:47:26 INFO - ##### 22:47:26 INFO - Running pre-action listener: _resource_record_pre_action 22:47:26 INFO - Running main action method: clobber 22:47:26 INFO - rmtree: /builds/slave/test-pgo/build 22:47:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:47:27 INFO - Running post-action listener: _resource_record_post_action 22:47:27 INFO - ##### 22:47:27 INFO - ##### Running read-buildbot-config step. 22:47:27 INFO - ##### 22:47:27 INFO - Running pre-action listener: _resource_record_pre_action 22:47:27 INFO - Running main action method: read_buildbot_config 22:47:27 INFO - Using buildbot properties: 22:47:27 INFO - { 22:47:27 INFO - "project": "", 22:47:27 INFO - "product": "firefox", 22:47:27 INFO - "script_repo_revision": "production", 22:47:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:47:27 INFO - "repository": "", 22:47:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 22:47:27 INFO - "buildid": "20151221203241", 22:47:27 INFO - "pgo_build": "True", 22:47:27 INFO - "basedir": "/builds/slave/test-pgo", 22:47:27 INFO - "buildnumber": 845, 22:47:27 INFO - "slavename": "talos-linux64-ix-031", 22:47:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:47:27 INFO - "platform": "ubuntu64_hw", 22:47:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:47:27 INFO - "branch": "fx-team", 22:47:27 INFO - "repo_path": "integration/fx-team", 22:47:27 INFO - "revision": "b96e844b0289c5363b5988214d6343b05a7996e8", 22:47:27 INFO - "stage_platform": "linux64-pgo", 22:47:27 INFO - "builduid": "7a868b5b4f864b73bff11462f35970b3", 22:47:27 INFO - "slavebuilddir": "test" 22:47:27 INFO - } 22:47:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/XX-D3zUJQECVFWyjmqiRgQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:47:27 INFO - Running post-action listener: _resource_record_post_action 22:47:27 INFO - ##### 22:47:27 INFO - ##### Running download-and-extract step. 22:47:27 INFO - ##### 22:47:27 INFO - Running pre-action listener: _resource_record_pre_action 22:47:27 INFO - Running main action method: download_and_extract 22:47:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:27 INFO - https://queue.taskcluster.net/v1/task/XX-D3zUJQECVFWyjmqiRgQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:47:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XX-D3zUJQECVFWyjmqiRgQ/artifacts/public/build/test_packages.json 22:47:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XX-D3zUJQECVFWyjmqiRgQ/artifacts/public/build/test_packages.json 22:47:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XX-D3zUJQECVFWyjmqiRgQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:47:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XX-D3zUJQECVFWyjmqiRgQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:47:30 INFO - Downloaded 1302 bytes. 22:47:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:47:30 INFO - Using the following test package requirements: 22:47:30 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:47:30 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:47:30 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:30 INFO - u'jsshell-linux-x86_64.zip'], 22:47:30 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:47:30 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:47:30 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:47:30 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:47:30 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:47:30 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:47:30 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:47:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:30 INFO - https://queue.taskcluster.net/v1/task/XX-D3zUJQECVFWyjmqiRgQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:47:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XX-D3zUJQECVFWyjmqiRgQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:47:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XX-D3zUJQECVFWyjmqiRgQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:47:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XX-D3zUJQECVFWyjmqiRgQ/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:47:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XX-D3zUJQECVFWyjmqiRgQ/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:47:31 INFO - Downloaded 23175746 bytes. 22:47:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 22:47:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:47:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:47:32 INFO - Return code: 0 22:47:32 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:47:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:32 INFO - https://queue.taskcluster.net/v1/task/XX-D3zUJQECVFWyjmqiRgQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:47:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XX-D3zUJQECVFWyjmqiRgQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:47:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XX-D3zUJQECVFWyjmqiRgQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:47:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XX-D3zUJQECVFWyjmqiRgQ/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:47:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XX-D3zUJQECVFWyjmqiRgQ/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:47:40 INFO - Downloaded 23175746 bytes. 22:47:40 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:47:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:47:40 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:47:41 INFO - Return code: 0 22:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:41 INFO - https://queue.taskcluster.net/v1/task/XX-D3zUJQECVFWyjmqiRgQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:47:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XX-D3zUJQECVFWyjmqiRgQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:47:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XX-D3zUJQECVFWyjmqiRgQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:47:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XX-D3zUJQECVFWyjmqiRgQ/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:47:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XX-D3zUJQECVFWyjmqiRgQ/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:47:43 INFO - Downloaded 11132277 bytes. 22:47: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:47:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:47: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:47:43 INFO - Return code: 0 22:47: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:47:43 INFO - https://queue.taskcluster.net/v1/task/XX-D3zUJQECVFWyjmqiRgQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:47:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XX-D3zUJQECVFWyjmqiRgQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:47:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XX-D3zUJQECVFWyjmqiRgQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:47:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XX-D3zUJQECVFWyjmqiRgQ/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:47:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XX-D3zUJQECVFWyjmqiRgQ/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:47:44 INFO - Downloaded 54877061 bytes. 22:47:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XX-D3zUJQECVFWyjmqiRgQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:47:44 INFO - mkdir: /builds/slave/test-pgo/properties 22:47:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:47:44 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:47:44 INFO - Contents: 22:47:44 INFO - build_url:https://queue.taskcluster.net/v1/task/XX-D3zUJQECVFWyjmqiRgQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:47:44 INFO - Running post-action listener: _resource_record_post_action 22:47:44 INFO - Running post-action listener: set_extra_try_arguments 22:47:44 INFO - ##### 22:47:44 INFO - ##### Running populate-webroot step. 22:47:44 INFO - ##### 22:47:44 INFO - Running pre-action listener: _resource_record_pre_action 22:47:44 INFO - Running main action method: populate_webroot 22:47:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:47:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:47:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:47:44 INFO - '--tppagecycles', 22:47:44 INFO - '7'], 22:47:44 INFO - 'tests': ['tsvgm']}}, 22:47:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:47:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:47:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:47:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:47:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:47:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:47:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:47:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:44 INFO - 'talos_options': ['--e10s'], 22:47:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:47:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:44 INFO - 'tests': ['damp', 'tps']}, 22:47:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:44 INFO - 'talos_options': ['--e10s'], 22:47:44 INFO - 'tests': ['damp', 'tps']}, 22:47:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:47:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:47:44 INFO - 'other': {'tests': ['a11yr', 22:47:44 INFO - 'ts_paint', 22:47:44 INFO - 'tpaint', 22:47:44 INFO - 'sessionrestore', 22:47:44 INFO - 'sessionrestore_no_auto_restore']}, 22:47:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:47:44 INFO - 'tests': ['a11yr', 22:47:44 INFO - 'ts_paint', 22:47:44 INFO - 'tpaint', 22:47:44 INFO - 'sessionrestore', 22:47:44 INFO - 'sessionrestore_no_auto_restore']}, 22:47:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:47:44 INFO - 'tests': ['a11yr', 22:47:44 INFO - 'ts_paint', 22:47:44 INFO - 'tpaint', 22:47:44 INFO - 'sessionrestore', 22:47:44 INFO - 'sessionrestore_no_auto_restore']}, 22:47:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:47:44 INFO - 'tests': ['a11yr', 22:47:44 INFO - 'ts_paint', 22:47:44 INFO - 'tpaint', 22:47:44 INFO - 'sessionrestore', 22:47:44 INFO - 'sessionrestore_no_auto_restore']}, 22:47:44 INFO - 'other_l64': {'tests': ['a11yr', 22:47:44 INFO - 'ts_paint', 22:47:44 INFO - 'tpaint', 22:47:44 INFO - 'sessionrestore', 22:47:44 INFO - 'sessionrestore_no_auto_restore']}, 22:47:44 INFO - 'other_nol64': {'tests': ['a11yr', 22:47:44 INFO - 'ts_paint', 22:47:44 INFO - 'tpaint', 22:47:44 INFO - 'sessionrestore', 22:47:44 INFO - 'sessionrestore_no_auto_restore']}, 22:47:44 INFO - 'svgr': {'tests': ['tsvgx', 22:47:44 INFO - 'tsvgr_opacity', 22:47:44 INFO - 'tart', 22:47:44 INFO - 'tscrollx', 22:47:44 INFO - 'cart']}, 22:47:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:47:44 INFO - 'tests': ['tsvgx', 22:47:44 INFO - 'tsvgr_opacity', 22:47:44 INFO - 'tart', 22:47:44 INFO - 'tscrollx', 22:47:44 INFO - 'cart']}, 22:47:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:44 INFO - 'tests': ['tp5o']}, 22:47:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:44 INFO - 'talos_options': ['--e10s'], 22:47:44 INFO - 'tests': ['tp5o']}, 22:47:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:44 INFO - 'talos_options': ['--xperf_path', 22:47:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:47:44 INFO - 'tests': ['tp5n']}, 22:47:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:44 INFO - 'talos_options': ['--e10s', 22:47:44 INFO - '--xperf_path', 22:47:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:47:44 INFO - 'tests': ['tp5n']}}, 22:47:44 INFO - 'talos.zip': {'path': '', 22:47:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:47:44 INFO - Running post-action listener: _resource_record_post_action 22:47:44 INFO - ##### 22:47:44 INFO - ##### Running create-virtualenv step. 22:47:44 INFO - ##### 22:47:44 INFO - Running pre-action listener: _resource_record_pre_action 22:47:44 INFO - Running main action method: create_virtualenv 22:47:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:47:44 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:47:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:47:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:47:44 INFO - Using real prefix '/usr' 22:47:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:47:45 INFO - Installing distribute.............................................................................................................................................................................................done. 22:47:47 INFO - Installing pip.................done. 22:47:47 INFO - Return code: 0 22:47:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:47: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:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47: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:47:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47: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 0x7ff971d46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2249630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22da840>, '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 0x22476b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2247b60>, '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': 'a9e534cca236dfa67d42a089000001c1-1450763974.273791-935948795', '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:47: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:47: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:47:47 INFO - Using env: {'DISPLAY': ':0', 22:47:47 INFO - 'HOME': '/home/cltbld', 22:47:47 INFO - 'LANG': 'en_US.UTF-8', 22:47:47 INFO - 'LANGUAGE': 'en_US:en', 22:47:47 INFO - 'LOGNAME': 'cltbld', 22:47:47 INFO - 'MAIL': '/var/mail/cltbld', 22:47:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:47 INFO - 'MOZ_NO_REMOTE': '1', 22:47:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:47 INFO - 'NO_EM_RESTART': '1', 22:47:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:47:47 INFO - 'PWD': '/builds/slave/test-pgo', 22:47:47 INFO - 'SHELL': '/bin/bash', 22:47:47 INFO - 'SHLVL': '1', 22:47:47 INFO - 'TERM': 'linux', 22:47:47 INFO - 'TMOUT': '86400', 22:47:47 INFO - 'USER': 'cltbld', 22:47:47 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450763974.273791-935948795', 22:47:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:47 INFO - '_': '/tools/buildbot/bin/python'} 22:47:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:47 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:47:47 INFO - Cleaning up... 22:47:47 INFO - Return code: 0 22:47:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:47: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:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47: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:47:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47: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', '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 0x7ff971d46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2249630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22da840>, '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 0x22476b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2247b60>, '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': 'a9e534cca236dfa67d42a089000001c1-1450763974.273791-935948795', '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:47: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:47: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 psutil>=0.7.1 22:47:47 INFO - Using env: {'DISPLAY': ':0', 22:47:47 INFO - 'HOME': '/home/cltbld', 22:47:47 INFO - 'LANG': 'en_US.UTF-8', 22:47:47 INFO - 'LANGUAGE': 'en_US:en', 22:47:47 INFO - 'LOGNAME': 'cltbld', 22:47:47 INFO - 'MAIL': '/var/mail/cltbld', 22:47:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:47 INFO - 'MOZ_NO_REMOTE': '1', 22:47:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:47 INFO - 'NO_EM_RESTART': '1', 22:47:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:47:47 INFO - 'PWD': '/builds/slave/test-pgo', 22:47:47 INFO - 'SHELL': '/bin/bash', 22:47:47 INFO - 'SHLVL': '1', 22:47:47 INFO - 'TERM': 'linux', 22:47:47 INFO - 'TMOUT': '86400', 22:47:47 INFO - 'USER': 'cltbld', 22:47:47 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450763974.273791-935948795', 22:47:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:47 INFO - '_': '/tools/buildbot/bin/python'} 22:47:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:47 INFO - Downloading/unpacking psutil>=0.7.1 22:47:47 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:47:47 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:47:47 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:47:47 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:47:47 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:47:47 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:47:49 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:47:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:47:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:47:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:47:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:47:49 INFO - Installing collected packages: psutil 22:47:49 INFO - Running setup.py install for psutil 22:47:49 INFO - building 'psutil._psutil_linux' extension 22:47:49 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:47:49 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:47:49 INFO - building 'psutil._psutil_posix' extension 22:47:49 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:47:49 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:47:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:47:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:47:49 INFO - Successfully installed psutil 22:47:49 INFO - Cleaning up... 22:47:49 INFO - Return code: 0 22:47:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:49 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 0x7ff971d46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2249630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22da840>, '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 0x22476b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2247b60>, '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': 'a9e534cca236dfa67d42a089000001c1-1450763974.273791-935948795', '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:47:49 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:47:49 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:47:49 INFO - Using env: {'DISPLAY': ':0', 22:47:49 INFO - 'HOME': '/home/cltbld', 22:47:49 INFO - 'LANG': 'en_US.UTF-8', 22:47:49 INFO - 'LANGUAGE': 'en_US:en', 22:47:49 INFO - 'LOGNAME': 'cltbld', 22:47:49 INFO - 'MAIL': '/var/mail/cltbld', 22:47:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:49 INFO - 'MOZ_NO_REMOTE': '1', 22:47:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:49 INFO - 'NO_EM_RESTART': '1', 22:47:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:47:49 INFO - 'PWD': '/builds/slave/test-pgo', 22:47:49 INFO - 'SHELL': '/bin/bash', 22:47:49 INFO - 'SHLVL': '1', 22:47:49 INFO - 'TERM': 'linux', 22:47:49 INFO - 'TMOUT': '86400', 22:47:49 INFO - 'USER': 'cltbld', 22:47:49 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450763974.273791-935948795', 22:47:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:49 INFO - '_': '/tools/buildbot/bin/python'} 22:47:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:47: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:47: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:47: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:47: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:47: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:47: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:47:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:47:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:47:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:47:51 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:47:51 INFO - Installing collected packages: mozsystemmonitor 22:47:51 INFO - Running setup.py install for mozsystemmonitor 22:47:51 INFO - Successfully installed mozsystemmonitor 22:47:51 INFO - Cleaning up... 22:47:52 INFO - Return code: 0 22:47:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:47: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:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47: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:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47: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 0x7ff971d46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2249630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22da840>, '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 0x22476b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2247b60>, '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': 'a9e534cca236dfa67d42a089000001c1-1450763974.273791-935948795', '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:47: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:47: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:47:52 INFO - Using env: {'DISPLAY': ':0', 22:47:52 INFO - 'HOME': '/home/cltbld', 22:47:52 INFO - 'LANG': 'en_US.UTF-8', 22:47:52 INFO - 'LANGUAGE': 'en_US:en', 22:47:52 INFO - 'LOGNAME': 'cltbld', 22:47:52 INFO - 'MAIL': '/var/mail/cltbld', 22:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:52 INFO - 'MOZ_NO_REMOTE': '1', 22:47:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:52 INFO - 'NO_EM_RESTART': '1', 22:47:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:47:52 INFO - 'PWD': '/builds/slave/test-pgo', 22:47:52 INFO - 'SHELL': '/bin/bash', 22:47:52 INFO - 'SHLVL': '1', 22:47:52 INFO - 'TERM': 'linux', 22:47:52 INFO - 'TMOUT': '86400', 22:47:52 INFO - 'USER': 'cltbld', 22:47:52 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450763974.273791-935948795', 22:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:52 INFO - '_': '/tools/buildbot/bin/python'} 22:47:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:52 INFO - Downloading/unpacking blobuploader==1.2.4 22:47: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:47: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:47: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:47: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:47: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:47: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:47:54 INFO - Downloading blobuploader-1.2.4.tar.gz 22:47: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:47:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:47:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:47: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:47: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:47: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:47: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:47: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:47: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:47: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:47:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:47:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:47: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:47: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:47: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:47: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:47: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:47: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:47:54 INFO - Downloading docopt-0.6.1.tar.gz 22:47:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:47:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:47:55 INFO - Installing collected packages: blobuploader, requests, docopt 22:47:55 INFO - Running setup.py install for blobuploader 22:47:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:47:55 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:47:55 INFO - Running setup.py install for requests 22:47:55 INFO - Running setup.py install for docopt 22:47:55 INFO - Successfully installed blobuploader requests docopt 22:47:55 INFO - Cleaning up... 22:47:55 INFO - Return code: 0 22:47:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:47: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:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47: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:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47: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 0x7ff971d46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2249630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22da840>, '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 0x22476b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2247b60>, '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': 'a9e534cca236dfa67d42a089000001c1-1450763974.273791-935948795', '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:47: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:47: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:47:55 INFO - Using env: {'DISPLAY': ':0', 22:47:55 INFO - 'HOME': '/home/cltbld', 22:47:55 INFO - 'LANG': 'en_US.UTF-8', 22:47:55 INFO - 'LANGUAGE': 'en_US:en', 22:47:55 INFO - 'LOGNAME': 'cltbld', 22:47:55 INFO - 'MAIL': '/var/mail/cltbld', 22:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:55 INFO - 'MOZ_NO_REMOTE': '1', 22:47:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:55 INFO - 'NO_EM_RESTART': '1', 22:47:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:47:55 INFO - 'PWD': '/builds/slave/test-pgo', 22:47:55 INFO - 'SHELL': '/bin/bash', 22:47:55 INFO - 'SHLVL': '1', 22:47:55 INFO - 'TERM': 'linux', 22:47:55 INFO - 'TMOUT': '86400', 22:47:55 INFO - 'USER': 'cltbld', 22:47:55 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450763974.273791-935948795', 22:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:55 INFO - '_': '/tools/buildbot/bin/python'} 22:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:47:55 INFO - Running setup.py (path:/tmp/pip-AgYDbz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:47:55 INFO - Running setup.py (path:/tmp/pip-5ngPYp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:47:56 INFO - Running setup.py (path:/tmp/pip-TzPme0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:47:56 INFO - Running setup.py (path:/tmp/pip-7Vop6p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:47:56 INFO - Running setup.py (path:/tmp/pip-9K8hgx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:47:56 INFO - Running setup.py (path:/tmp/pip-2dKnFz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:47:56 INFO - Running setup.py (path:/tmp/pip-gDF99_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:47:56 INFO - Running setup.py (path:/tmp/pip-bna7su-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:47:56 INFO - Running setup.py (path:/tmp/pip-2GK75Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:47:56 INFO - Running setup.py (path:/tmp/pip-MGx1zn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:47:56 INFO - Running setup.py (path:/tmp/pip-wJfnhd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:47:56 INFO - Running setup.py (path:/tmp/pip-qpiT1e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:47:56 INFO - Running setup.py (path:/tmp/pip-43O5Nn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:47:56 INFO - Running setup.py (path:/tmp/pip-_TVYtN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:47:56 INFO - Running setup.py (path:/tmp/pip-w0JVAh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:47:56 INFO - Running setup.py (path:/tmp/pip-rlRX5X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:47:57 INFO - Running setup.py (path:/tmp/pip-tEGWWH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:47:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:47:57 INFO - Running setup.py install for manifestparser 22:47:57 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:47:57 INFO - Running setup.py install for mozcrash 22:47:57 INFO - Running setup.py install for mozdebug 22:47:57 INFO - Running setup.py install for mozdevice 22:47:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:47:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:47:57 INFO - Running setup.py install for mozfile 22:47:57 INFO - Running setup.py install for mozhttpd 22:47:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:47:57 INFO - Running setup.py install for mozinfo 22:47:57 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:47:57 INFO - Running setup.py install for mozInstall 22:47:57 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:47:57 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:47:57 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:47:57 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:47:57 INFO - Running setup.py install for mozleak 22:47:57 INFO - Running setup.py install for mozlog 22:47:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:47:58 INFO - Running setup.py install for moznetwork 22:47:58 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:47:58 INFO - Running setup.py install for mozprocess 22:47:58 INFO - Running setup.py install for mozprofile 22:47:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:47:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:47:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:47:58 INFO - Running setup.py install for mozrunner 22:47:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:47:58 INFO - Running setup.py install for mozscreenshot 22:47:58 INFO - Running setup.py install for moztest 22:47:58 INFO - Running setup.py install for mozversion 22:47:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:47:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:47:58 INFO - Cleaning up... 22:47:58 INFO - Return code: 0 22:47:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:58 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 0x7ff971d46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2249630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22da840>, '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 0x22476b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2247b60>, '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': 'a9e534cca236dfa67d42a089000001c1-1450763974.273791-935948795', '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:47:58 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:47:58 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:47:58 INFO - Using env: {'DISPLAY': ':0', 22:47:58 INFO - 'HOME': '/home/cltbld', 22:47:58 INFO - 'LANG': 'en_US.UTF-8', 22:47:58 INFO - 'LANGUAGE': 'en_US:en', 22:47:58 INFO - 'LOGNAME': 'cltbld', 22:47:58 INFO - 'MAIL': '/var/mail/cltbld', 22:47:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:58 INFO - 'MOZ_NO_REMOTE': '1', 22:47:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:58 INFO - 'NO_EM_RESTART': '1', 22:47:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:47:58 INFO - 'PWD': '/builds/slave/test-pgo', 22:47:58 INFO - 'SHELL': '/bin/bash', 22:47:58 INFO - 'SHLVL': '1', 22:47:58 INFO - 'TERM': 'linux', 22:47:58 INFO - 'TMOUT': '86400', 22:47:58 INFO - 'USER': 'cltbld', 22:47:58 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450763974.273791-935948795', 22:47:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:58 INFO - '_': '/tools/buildbot/bin/python'} 22:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:47:59 INFO - Running setup.py (path:/tmp/pip-xfj5Vq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:47: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:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:47:59 INFO - Running setup.py (path:/tmp/pip-rZ8JW6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:47: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:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:47:59 INFO - Running setup.py (path:/tmp/pip-Ih8DEc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:47: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:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:47:59 INFO - Running setup.py (path:/tmp/pip-pJjMYE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:47: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:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:47:59 INFO - Running setup.py (path:/tmp/pip-nPR37k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:47: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:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:47:59 INFO - Running setup.py (path:/tmp/pip-ALcDCu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:47: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:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:47:59 INFO - Running setup.py (path:/tmp/pip-91owps-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:47: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:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:47:59 INFO - Running setup.py (path:/tmp/pip-LqlMWw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:47: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:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:47:59 INFO - Running setup.py (path:/tmp/pip-mPdxPq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:47: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:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:47:59 INFO - Running setup.py (path:/tmp/pip-41l_PU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:47:59 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:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:47:59 INFO - Running setup.py (path:/tmp/pip-FneZHC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:47:59 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:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:47:59 INFO - Running setup.py (path:/tmp/pip-TWZGB8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:47:59 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:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:47:59 INFO - Running setup.py (path:/tmp/pip-49J4aQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:48: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:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:48:00 INFO - Running setup.py (path:/tmp/pip-3FgpLA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:48: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:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:48:00 INFO - Running setup.py (path:/tmp/pip-rumyfv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:48: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:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:48:00 INFO - Running setup.py (path:/tmp/pip-vGpbwI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:48: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:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:48:00 INFO - Running setup.py (path:/tmp/pip-BqK4ir-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:48: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:48: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:48: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:48: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:48: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:48: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:48: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:48: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:48: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:48: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:48: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:48: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:48: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:48:01 INFO - Downloading blessings-1.5.1.tar.gz 22:48:01 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:48:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:48:02 INFO - Installing collected packages: blessings 22:48:02 INFO - Running setup.py install for blessings 22:48:02 INFO - Successfully installed blessings 22:48:02 INFO - Cleaning up... 22:48:02 INFO - Return code: 0 22:48:02 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:48:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:48:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:48:02 INFO - Reading from file tmpfile_stdout 22:48:02 INFO - Current package versions: 22:48:02 INFO - argparse == 1.2.1 22:48:02 INFO - blessings == 1.5.1 22:48:02 INFO - blobuploader == 1.2.4 22:48:02 INFO - docopt == 0.6.1 22:48:02 INFO - manifestparser == 1.1 22:48:02 INFO - mozInstall == 1.12 22:48:02 INFO - mozcrash == 0.16 22:48:02 INFO - mozdebug == 0.1 22:48:02 INFO - mozdevice == 0.47 22:48:02 INFO - mozfile == 1.2 22:48:02 INFO - mozhttpd == 0.7 22:48:02 INFO - mozinfo == 0.9 22:48:02 INFO - mozleak == 0.1 22:48:02 INFO - mozlog == 3.1 22:48:02 INFO - moznetwork == 0.27 22:48:02 INFO - mozprocess == 0.22 22:48:02 INFO - mozprofile == 0.28 22:48:02 INFO - mozrunner == 6.11 22:48:02 INFO - mozscreenshot == 0.1 22:48:02 INFO - mozsystemmonitor == 0.0 22:48:02 INFO - moztest == 0.7 22:48:02 INFO - mozversion == 1.4 22:48:02 INFO - psutil == 3.1.1 22:48:02 INFO - requests == 1.2.3 22:48:02 INFO - wsgiref == 0.1.2 22:48:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:48: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:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48: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:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48: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 0x7ff971d46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2249630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22da840>, '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 0x22476b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2247b60>, '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': 'a9e534cca236dfa67d42a089000001c1-1450763974.273791-935948795', '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:48: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:48: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:48:02 INFO - Using env: {'DISPLAY': ':0', 22:48:02 INFO - 'HOME': '/home/cltbld', 22:48:02 INFO - 'LANG': 'en_US.UTF-8', 22:48:02 INFO - 'LANGUAGE': 'en_US:en', 22:48:02 INFO - 'LOGNAME': 'cltbld', 22:48:02 INFO - 'MAIL': '/var/mail/cltbld', 22:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:02 INFO - 'MOZ_NO_REMOTE': '1', 22:48:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:02 INFO - 'NO_EM_RESTART': '1', 22:48:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:48:02 INFO - 'PWD': '/builds/slave/test-pgo', 22:48:02 INFO - 'SHELL': '/bin/bash', 22:48:02 INFO - 'SHLVL': '1', 22:48:02 INFO - 'TERM': 'linux', 22:48:02 INFO - 'TMOUT': '86400', 22:48:02 INFO - 'USER': 'cltbld', 22:48:02 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450763974.273791-935948795', 22:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:02 INFO - '_': '/tools/buildbot/bin/python'} 22:48:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48: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:48: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:48: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:48: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:48: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:48: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:48: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:48: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:48: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:48: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:48: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:48:02 INFO - Cleaning up... 22:48:02 INFO - Return code: 0 22:48:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:48: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:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48: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:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48: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 0x7ff971d46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2249630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22da840>, '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 0x22476b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2247b60>, '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': 'a9e534cca236dfa67d42a089000001c1-1450763974.273791-935948795', '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:48: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:48: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:48:02 INFO - Using env: {'DISPLAY': ':0', 22:48:02 INFO - 'HOME': '/home/cltbld', 22:48:02 INFO - 'LANG': 'en_US.UTF-8', 22:48:02 INFO - 'LANGUAGE': 'en_US:en', 22:48:02 INFO - 'LOGNAME': 'cltbld', 22:48:02 INFO - 'MAIL': '/var/mail/cltbld', 22:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:02 INFO - 'MOZ_NO_REMOTE': '1', 22:48:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:02 INFO - 'NO_EM_RESTART': '1', 22:48:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:48:02 INFO - 'PWD': '/builds/slave/test-pgo', 22:48:02 INFO - 'SHELL': '/bin/bash', 22:48:02 INFO - 'SHLVL': '1', 22:48:02 INFO - 'TERM': 'linux', 22:48:02 INFO - 'TMOUT': '86400', 22:48:02 INFO - 'USER': 'cltbld', 22:48:02 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450763974.273791-935948795', 22:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:02 INFO - '_': '/tools/buildbot/bin/python'} 22:48:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:02 INFO - Downloading/unpacking jsonschema 22:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:48: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:48:04 INFO - Downloading/unpacking functools32 (from jsonschema) 22:48: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:48: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:48: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:48: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:48: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:48: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:48:04 INFO - Downloading functools32-3.2.3-2.tar.gz 22:48:04 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:48:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:48:04 INFO - warning: no files found matching '*.txt' 22:48:04 INFO - no previously-included directories found matching 'build' 22:48:04 INFO - no previously-included directories found matching 'dist' 22:48:04 INFO - no previously-included directories found matching '.git*' 22:48:04 INFO - Installing collected packages: jsonschema, functools32 22:48:04 INFO - Running setup.py install for functools32 22:48:04 INFO - warning: no files found matching '*.txt' 22:48:04 INFO - no previously-included directories found matching 'build' 22:48:04 INFO - no previously-included directories found matching 'dist' 22:48:04 INFO - no previously-included directories found matching '.git*' 22:48:04 INFO - Successfully installed jsonschema functools32 22:48:04 INFO - Cleaning up... 22:48:05 INFO - Return code: 0 22:48:05 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:48: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:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48: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:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48: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 0x7ff971d46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2249630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22da840>, '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 0x22476b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2247b60>, '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': 'a9e534cca236dfa67d42a089000001c1-1450763974.273791-935948795', '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:48: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:48: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:48:05 INFO - Using env: {'DISPLAY': ':0', 22:48:05 INFO - 'HOME': '/home/cltbld', 22:48:05 INFO - 'LANG': 'en_US.UTF-8', 22:48:05 INFO - 'LANGUAGE': 'en_US:en', 22:48:05 INFO - 'LOGNAME': 'cltbld', 22:48:05 INFO - 'MAIL': '/var/mail/cltbld', 22:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:05 INFO - 'MOZ_NO_REMOTE': '1', 22:48:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:05 INFO - 'NO_EM_RESTART': '1', 22:48:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:48:05 INFO - 'PWD': '/builds/slave/test-pgo', 22:48:05 INFO - 'SHELL': '/bin/bash', 22:48:05 INFO - 'SHLVL': '1', 22:48:05 INFO - 'TERM': 'linux', 22:48:05 INFO - 'TMOUT': '86400', 22:48:05 INFO - 'USER': 'cltbld', 22:48:05 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450763974.273791-935948795', 22:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:05 INFO - '_': '/tools/buildbot/bin/python'} 22:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:05 INFO - Downloading/unpacking flake8 22:48: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:48: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:48: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:48: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:48: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:48: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:48:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:48:06 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:48:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:48: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:48:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:48: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:48: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:48: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:48: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:48: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:48: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:48: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:48:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:48: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:48: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:48: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:48: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:48: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:48: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:48: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:48:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:48:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:48:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:48:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:48:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:48:07 INFO - no previously-included directories found matching 'docs/_build' 22:48:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:48:07 INFO - Running setup.py install for pep8 22:48:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:48:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:48:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:48:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:48:07 INFO - no previously-included directories found matching 'docs/_build' 22:48:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:48:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:48:07 INFO - Cleaning up... 22:48:07 INFO - Return code: 0 22:48:07 INFO - Running post-action listener: _resource_record_post_action 22:48:07 INFO - Running post-action listener: _start_resource_monitoring 22:48:07 INFO - Starting resource monitoring. 22:48:07 INFO - ##### 22:48:07 INFO - ##### Running install step. 22:48:07 INFO - ##### 22:48:07 INFO - Running pre-action listener: _resource_record_pre_action 22:48:07 INFO - Running main action method: install 22:48:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:48:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:48:08 INFO - Reading from file tmpfile_stdout 22:48:08 INFO - Detecting whether we're running mozinstall >=1.0... 22:48:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:48:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:48:08 INFO - Reading from file tmpfile_stdout 22:48:08 INFO - Output received: 22:48:08 INFO - Usage: mozinstall [options] installer 22:48:08 INFO - Options: 22:48:08 INFO - -h, --help show this help message and exit 22:48:08 INFO - -d DEST, --destination=DEST 22:48:08 INFO - Directory to install application into. [default: 22:48:08 INFO - "/builds/slave/test-pgo"] 22:48:08 INFO - --app=APP Application being installed. [default: firefox] 22:48:08 INFO - mkdir: /builds/slave/test-pgo/build/application 22:48: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:48: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:48:23 INFO - Reading from file tmpfile_stdout 22:48:23 INFO - Output received: 22:48:23 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:48:23 INFO - Running post-action listener: _resource_record_post_action 22:48:23 INFO - ##### 22:48:23 INFO - ##### Running run-tests step. 22:48:23 INFO - ##### 22:48:23 INFO - Running pre-action listener: _resource_record_pre_action 22:48:23 INFO - Running main action method: run_tests 22:48:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:48:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:48:23 INFO - Python 2.7.3 22:48:23 INFO - Return code: 0 22:48:23 INFO - grabbing minidump binary from tooltool 22:48:23 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:48:23 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 0x22da840>, '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 0x22476b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2247b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:48:23 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:48:23 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:48:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:48:24 INFO - Return code: 0 22:48:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:48:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:48:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:48:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:48:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:48:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:48:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:48:24 INFO - Return code: 0 22:48:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XX-D3zUJQECVFWyjmqiRgQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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:48:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XX-D3zUJQECVFWyjmqiRgQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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:48:24 INFO - Using env: {'DISPLAY': ':0', 22:48:24 INFO - 'HOME': '/home/cltbld', 22:48:24 INFO - 'LANG': 'en_US.UTF-8', 22:48:24 INFO - 'LANGUAGE': 'en_US:en', 22:48:24 INFO - 'LOGNAME': 'cltbld', 22:48:24 INFO - 'MAIL': '/var/mail/cltbld', 22:48:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:48:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:48:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:24 INFO - 'MOZ_NO_REMOTE': '1', 22:48:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:48:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:24 INFO - 'NO_EM_RESTART': '1', 22:48:24 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:48:24 INFO - 'PWD': '/builds/slave/test-pgo', 22:48:24 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:48:24 INFO - 'SHELL': '/bin/bash', 22:48:24 INFO - 'SHLVL': '1', 22:48:24 INFO - 'TERM': 'linux', 22:48:24 INFO - 'TMOUT': '86400', 22:48:24 INFO - 'USER': 'cltbld', 22:48:24 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1450763974.273791-935948795', 22:48:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:24 INFO - '_': '/tools/buildbot/bin/python'} 22:48:24 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XX-D3zUJQECVFWyjmqiRgQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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:48:25 INFO - mozversion application_buildid: 20151221203241 22:48:25 INFO - mozversion application_changeset: b96e844b0289c5363b5988214d6343b05a7996e8 22:48:25 INFO - mozversion application_display_name: Nightly 22:48:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:48:25 INFO - mozversion application_name: Firefox 22:48:25 INFO - mozversion application_remotingname: firefox 22:48:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:48:25 INFO - mozversion application_vendor: Mozilla 22:48:25 INFO - mozversion application_version: 46.0a1 22:48:25 INFO - mozversion platform_buildid: 20151221203241 22:48:25 INFO - mozversion platform_changeset: b96e844b0289c5363b5988214d6343b05a7996e8 22:48:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:48:25 INFO - mozversion platform_version: 46.0a1 22:48:25 INFO - using testdate: 1450766905 22:48:25 INFO - actual date: 1450766905 22:48:25 INFO - starting webserver on 'localhost:37345' 22:48:25 INFO - SUITE-START | Running 3 tests 22:48:25 INFO - TEST-START | dromaeo_css 22:48:25 INFO - operating with platform_type : linux_ 22:48:25 INFO - Initialising browser for dromaeo_css test... 22:48:25 INFO - TEST-INFO | started process 6860 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWgE_6_/profile http://localhost:37345/getInfo.html) 22:48:29 INFO - PROCESS | 6860 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 22:48:29 INFO - PROCESS | 6860 | __metrics Screen width/height:1600/1200 22:48:29 INFO - PROCESS | 6860 | colorDepth:24 22:48:29 INFO - PROCESS | 6860 | Browser inner width/height: 1024/697 22:48:29 INFO - PROCESS | 6860 | __metrics 22:48:29 INFO - PROCESS | 6860 | 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:48:29 INFO - PROCESS | 6860 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:48:29 ERROR - PROCESS | 6860 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 22:48:30 INFO - TEST-INFO | 6860: exit 0 22:48:30 INFO - Browser initialized. 22:48:30 INFO - Running cycle 1/1 for dromaeo_css test... 22:48:30 INFO - TEST-INFO | started process 6953 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWgE_6_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:48:42 INFO - PROCESS | 6953 | RSS: Main: 149901312 22:48:42 INFO - PROCESS | 6953 | 22:49:33 INFO - PROCESS | 6953 | 1450766973076 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:51:42 INFO - PROCESS | 6953 | Cycle 1(1): loaded http://localhost:37345/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37345/tests/dromaeo/cssquery-ext.html) 22:51:43 INFO - PROCESS | 6953 | RSS: Main: 246493184 22:51:43 INFO - PROCESS | 6953 | 22:54:46 INFO - PROCESS | 6953 | Cycle 1(1): loaded http://localhost:37345/tests/dromaeo/cssquery-ext.html (next: http://localhost:37345/tests/dromaeo/cssquery-jquery.html) 22:54:46 INFO - PROCESS | 6953 | RSS: Main: 232329216 22:54:46 INFO - PROCESS | 6953 | 22:57:48 INFO - PROCESS | 6953 | Cycle 1(1): loaded http://localhost:37345/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37345/tests/dromaeo/cssquery-mootools.html) 22:57:49 INFO - PROCESS | 6953 | RSS: Main: 221204480 22:57:49 INFO - PROCESS | 6953 | 23:00:50 INFO - PROCESS | 6953 | Cycle 1(1): loaded http://localhost:37345/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37345/tests/dromaeo/cssquery-prototype.html) 23:00:51 INFO - PROCESS | 6953 | RSS: Main: 209383424 23:00:51 INFO - PROCESS | 6953 | 23:03:54 INFO - PROCESS | 6953 | Cycle 1(1): loaded http://localhost:37345/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37345/tests/dromaeo/cssquery-yui.html) 23:03:54 INFO - PROCESS | 6953 | RSS: Main: 216571904 23:03:54 INFO - PROCESS | 6953 | 23:06:57 INFO - PROCESS | 6953 | Cycle 1(1): loaded http://localhost:37345/tests/dromaeo/cssquery-yui.html (next: http://localhost:37345/tests/dromaeo/cssquery-dojo.html) 23:06:57 INFO - PROCESS | 6953 | RSS: Main: 261971968 23:06:57 INFO - PROCESS | 6953 | 23:06:57 INFO - PROCESS | 6953 | __start_tp_report 23:06:57 INFO - PROCESS | 6953 | _x_x_mozilla_page_load 23:06:57 INFO - PROCESS | 6953 | _x_x_mozilla_page_load_details 23:06:57 INFO - PROCESS | 6953 | |i|pagename|runs| 23:06:57 INFO - PROCESS | 6953 | |0;dojo.html;3172.8572214250357;3228.660990595989;3263.118957881372;3272.5582046423724;3293.4565796643546;5252.054630166568;5379.919301210475;5448.945510544893;5481.397046324906;5482.5613950883935;5181.378234611851;5229.686218826873;5295.126304159809;5337.7598008089635;5350;4857.805687772485;4860.902781944376;4876.317315575822;4932.950670493303;4982.676126051813;4635.675502714811;4958.231474121517;5025.899482010358;5036.949630503703;5058.721770302632;4834.758262086917;4906.705597664151;4956.653034287601;4979.327790748257;4990.925136122961;4928.778204980785;4932.901341973176;4933.062718083588;4938.3580134582635;4951.257311403282;4893.681910675795;4920.409550853885;4927.088488629615;4928.926066109011;4952.281919121707;5096.133657278272;5196.844094677166;5209.53114219722;5304.469553044664;5306.628536002481;5819.272590926134;5824.621399609012;5846.093855452412;5847.7953271635715;5922.615030023077;5872.882542349129;5876.9118463223085;5879.67661778602;5881.941180588182;5882.117682347639;5259.815906443295;5495.972520137374;5498.560115190775;5501.174823776466;5502.779888804443;5797.652140871562;5816.069428891357;5835.183074369592;5850.707464626752;5855.3266374367495;5746.42535746422;5750.741216645261;5751.626144300607;5752.309722833287;5795.072788353843;5773.624714393551;5820.126980952807;5837.29952405714;5841.065429531254;5845.766169353264;5714.514266287329;5787.71061446926;5791.768329266866;5922.200502932049;5933.821985340447;5701.486866182064;5773.711314434261;5777;5777.422257774273;5823.068309070529;4516.435445569304;4526.728396296233;4527.637788976874;4531.161735079021;4570.977145114253;3955.4066889966734;3964.5638979712785;4044.130511939947;4085.673146148301;4106.055607210358;5492.945070549244;5507.118860982224;5508.586855985817;5512.6692398456225;5552.222688823568;5830.679312637845;5857.70711464425;5872.941270587325;5876.059830427197;5878.970605146947;5220.034293655686;5286.207068939613;5397.217403476474;5438.401775804658;5491.395946445888;4995.150824359867;5000.499950004971;5013.1227035268685;5049.5707864831165;5114.335136432314;5828.5337173026055;5830.62100963436;5837.241158649434;5846.444587764156;5854.356020837705;5656.688882111359;5801.071828507418;5807.912881306699;5850.644359483775;5896.086106653475;5773.364929857797;5844.26946631671;5942.7920022799;5947.226860508106;5977.9402205977385;5879.853003674943;5889.440503152194;5890.970545147246;5896.64620122794;5901.085331773582;5741.8564535886935;5846.824595262149;5930.851728706817;5955.434233747787;5958.344582096052;5583.385827559046;5592.328920529562;5630.408807075362;5634.774609015593;5640.605157638925;5648.85877853057;5649.858753531194;5652.915206271827;5657.321121465286;5658.066419040812;5351.3043304370185;5510;5546.4453554644215;5548.0845660465575;5557.277553918127;5634.32388113429;5673.801416950387;5711.514521265739;5712.65724056558;5768.855778605568;5547.861303467445;5549.445055494418;5558.194061860927;5559.388467268678;5668.659880407189 23:06:57 INFO - PROCESS | 6953 | |1;ext.html;561.6405500479693;574.3194314737037;579.0879365000123;595.1073389915127;597.982060538184;37930;38450.615493845056;38738.612613873855;38850.222995540105;38971.805140974255;41558;42313.15373692532;42402.36396454056;42406;42454.36318455218;7599.164091949881;7748.961255193716;7756;8597.742067737961;8785.64857405703;10350.844737328945;10603.893961060368;10622;10625.946870265676;10626.415547144903;10249.282550221487;10347.689569312932;10355.637552685657;10356.896431035706;10362.378257304548;7870.055593328809;8094.797630059236;10238.078572928473;10245.846312305284;10482.58069677212;10031.949840250825;10109.797804043877;10229;10248.590056397736;10249.743756406075;39334.80332598319;39669.60330396717;39691.20617587661;39729.60270397317;39748.60251397478;3335.8999230023137;3357.3285342931513;3446.4141096013486;3742.401215805458;3791.450239715226;30172.8491357544;30279.394412111633;30616.69383306183;30687.386252275053;31416;3491.2668339648703;3519.788812671248;3521.4893840393;3612.8077734347603;3688.428293614494;263125;263905;263926;264702;264854;55093.173602396;55935;56177;56186.719066405225;56802.43197568054;66918.33081669218;67765.88458211915;67815;67957;68188.6590567054;15917.283722232527;16035.679286414206;16073;16086.43697470583;16105.355785768437;11948.103892208119;12016;12024.939875300568;12027.819582706266;12041.638750837488;19152.59630491412;19292.807071929383;19389.80610193908;19456.416307510513;19503.122359493856;7151.32062454066;7288.125424948934;7411.629418529052;7417.258274172539;7481.064866891638;898.4115404410122;938.8732521109563;1021.3922715983978;1026.1790567546082;1049.679847646475;25220.621690674656;26328.47343053128;26415.867920660272;26705.732942670715;26866.462670746474;1016.4054028393473;1024.9180065594735;1048.2505008918508;1105.8396532502902;1197.874223206568;13272.73454530904;13374.46502139923;13428.462861485626;13463.663408414868;13473.730525389437;303819;304092;305226;307263;307348;48790.26814597784;49078;49150;49157.75421122871;49165.50834491681;1208.9274643521417;1220.0605533738972;1223.565634199864;1226.9815952760716;1325.436689406998;24288;25152.37119072038;26946.86526567433;30064.3987120252;30323.241918952204;44964;45284.54715452935;45361.54638453573;45415.54584454245;45708.77145614251;241267;242860;243317;243345;298346;25643.230703078938;30601.693983060773;30987.070387888398;31395.215119622193;31440;36003.81998089993;36565;36776.63223367839;37186.25627487381;37261;28520.714792851806;31023.224419389695;31657.20856978594;31721.682783171873;32095.679043210203;33526;34300.656993429744;34447.4832877512;34539.48190777191;34620.480692789126;32854;33317.50023749597;33546;33572.66427335793;33651;29622.55566166466;30426.391472170875;30627.23431914131;30839.38321233518;30912.53631195489;23781.52436951286;24247.636285456087;25023;25024.62463063019;26906.59640105439 23:06:57 INFO - PROCESS | 6953 | |2;jquery.html;338.9000244927746;346.7174252983818;348.96510348965097;350.4340490108475;352.5487376158518;16739.33042678293;17446.738298925527;17674.734878976793;18140.546486337847;18153.7276940846;16430.424935127274;16634.75047874283;16717.164141792924;16782.328706851742;16792.32830686774;5303.814366497164;5327.387350454689;5427;5478.780848766045;5484.040292948738;5387.19192121181;5440.891182176354;5445.673259604417;5447.4824891635235;5453.64551304164;3906.726529142961;4235.788210589458;5378.951104534617;5396.865078373033;5882;5826;5863.618864773819;5884.499817515538;5884.970575147118;5887.941120588804;5000.67495612784;5041.924371134436;5072.239164125411;5075.111855425323;5183.740812959337;16085.758713619305;17209.913950430167;19274.71087933682;19572.412827615193;20246.898765506077;2031.8886766496116;2167.436466518701;2200.3179014505554;2244.371575958734;2268.194790849258;13134.60596182116;13219.801702974368;13250.138740981805;13426;13732.176069435865;1742.634046850163;1758.5427788774882;1774.8136445673276;1856.062688342392;1856.7679040119986;54121.72939135318;57536.42463575352;57603.71198144025;61444.38555614431;64704.67647661779;9974.900250997542;10089.445080520494;10105.595776169019;10131.290809643402;10137.34107283039;13085.411156497981;13132.146410483288;13139.54011609589;13157.934210329078;13186.142900711424;7487.513311634726;7539.660715267826;7617.124030736425;7695.538267703956;7762.107357653829;7628.86391810294;7677.808054798563;7680.500767450098;7717.344025757873;7739.883901741478;4046.676265898721;4168.145530166309;4315.784210789448;4354.586314300136;4359.564043595615;1617.5632579203784;1653.0494965394946;1684.6630673865277;1730.2214003698386;1761.6388640328703;877.1184959116048;906.5557876640398;933.9439633622004;956.7799406136488;976.6825781621002;13974.231417271943;16350.75473867893;16854.41009564659;16982.23579938906;17251.482455526355;870.5864714260675;885.822835432916;925.3661242049218;969.060011788564;982.8132654795565;9100.180983711498;9323.813523729488;9338.766530836647;9387.436753794795;9404.38871473352;517990;526220;554208;554973;563088;71062;78951;81325;82098;82314.17685823185;1149.166854030821;1154.3420250457327;1163.4764356039984;1173.0674114079327;1176.7352345722315;14749.926250368679;15389.692206156038;15455.149966751937;15625.687486249984;15773.526794196192;33497;34721.65278347184;34814.303713926085;35271.470927936614;36589.81705091458;43142.78428607837;44604;45329.0934181308;46949.295760562934;47322.76338618285;8599.484030958163;8890.95554522249;8958.68644597436;8972.955135224282;8976;10459.581616735246;11634.6509604712;16995.83004169992;17185.74221386705;17470.912645436692;13890.791638125234;14092.084014539023;14210.78683819723;14540.127592344494;14668.55994320172;13663.316834158451;13823.79264311016;14168.43326266979;14352.354144063333;14415.135091894519;14615.342309596306;14617.342219600356;15149.697006059596;15572.221388930282;15626.921865390601;9356.970733219205;9514.857277140987;9599.376040557341;9633.470159141314;9707.854382184132;9646.469444180637;9745.707628771148;11244.718882028015;14809.407623694931;15151.696966060837 23:06:57 INFO - PROCESS | 6953 | |3;mootools.html;1305.9347032648366;1688.907110108944;1758.4988278340675;1761.8678599105067;1810.1130446081424;6774.187097548295;7701.614919254036;7740.071191457019;7771.766846994585;7814.179511151333;7640.2741739534795;7788.844223115534;7799.493032952854;7817.374610031198;7819.960900195505;2036.389083275019;2073.8237249833783;2205.0848897707433;2205.6691496275607;2236.206146817881;2217.8225741940687;2233.486298151426;2239.2162743039967;2239.697640818485;2243.181238847825;2172.2397160993605;2243.6858839762444;2245.1244014834147;2248.6402175651897;2251.133313674239;2234.20685656592;2263.2531264682616;2269.8297627677907;2296.2422400607925;2297.310806757983;2282.3723476044056;2294.025039358266;2299.54009198161;2318.258157389636;2323.2913961241816;7733.6133193340675;7809.219078092202;7810.414218933603;7819.296263336327;7825.491343062739;4608;4706.647001474903;4714.481407045222;4719.10337035962;4724.149653062447;3001.5797788309656;3009.1724775686644;3039.316153865385;3052.4658184817567;3125.749940004817;948.5636607160715;951.2722767083187;971.7619183300137;973.2408721197477;1015.5531566110961;10699.946500267526;10716.249862509627;10753.51609177589;10768.24622276441;10777.353358798418;4140.648044916155;4167.124903770182;4222.176675548239;4226.809793559236;4239.342901850218;9155.816883662423;9176.44941303524;9193.908060919306;9202.217811486098;9220.170184683277;4655.138799322136;4680.976595117071;4684.063187362541;4712.858614241578;4720.929186062212;4295.892602684958;4298.398224248608;4300.80646370914;4304.5910638489295;4312.116016216668;3399.184195792992;3453.637368076366;3567.8572857085946;3596.2987217492337;3684.042149041215;1119.7256672115384;1133.3369978562469;1136.965891023254;1138.1009002887793;1146.3378101752492;1027.1525991057258;1039.2880876599554;1042.0569384706853;1182.7043239190202;1358.7554240236852;7047.119110111236;7128.536645118051;7144.9285507145305;7190.352868241779;7255.600941948138;1087.9292845964987;1092.0881064311388;1099.983500247497;1102.2835157147917;1108.1633366808007;5788.594798364158;5858.619189752652;5863.442972917566;5863.560232982458;5869.383714709979;9101.40840845343;9222.584983675752;9388.483633400092;9528.666496672584;9544.0455954404;9315.673951411669;9349.90650093504;9430;9447;9456.8581471278;7325.523840950428;7346.412287017026;7400.074990626172;7407.8888816667795;7424.554526728413;6991.056207411934;7018.719251229893;7026.473014524034;7052.0832291801735;7057.400120989773;8151.429399942184;8351.874721879298;8442.240198382175;8544.102869198645;8588.355873309401;8571.185737354941;8581.699640512552;8689.391742577958;8704;8714.69498567547;6828.351306625863;7002.404795592432;7010.439164866696;7018.6490675465;7039.225685174524;6784.08414863987;6966.686499107451;7108.182559005573;7321.487495875238;7386.298301661333;6924.203716572659;6924.961255811669;7062.611556364449;7073.115860517435;7139.464540159405;6983.930160698328;7000.299970002959;7062.364387204971;7095.538789978635;7160.319769621878;7023.578585284899;7066.893996589953;7106.395956343768;7124.821879453055;7147.070880785673;6286.245650521967;6308.243010838729;6336.017917222838;6337.144485494399;6370.617762934239;6585.539012269095;6609.570377925419;6617.536772425884;6618.2719900811835;6625.933740662532 23:06:57 INFO - PROCESS | 6953 | |4;prototype.html;333.3898964894243;333.4498078171019;334.4732047025933;340.4773672412846;340.4824666506908;5846.736896839642;5962.34414214436;5964.105384192373;6002.249718785158;6043.335233124364;5742.770289188438;5931.584789064767;5932.288125424944;5934.139549765281;5952.3750006249265;4576.244919588264;4580.244259697146;4584.656150788687;4589.380433641449;4593.081383723252;4410.735355878642;4481.350204220403;4485.327200919855;4534.97732511337;4572.9314060289125;4480.417545719052;4580.450345958489;4609.193391156534;4611.4696809866955;4624.190766615846;4574.977125114387;4577.130345234412;4594.908101837945;4601.976990115028;4604.884877878063;4027.556968733437;4029.4560234368278;4039.151778126597;4057.2494088593703;4065.57311482296;5548.472895074961;5636.408177141382;5664.6601203927485;5676.148577713335;5705.62913410627;5257.947420525784;5273.947260527384;5273.947260527422;5281.656692315026;5281.947180528184;6061.818145455643;6300.747970081191;6302.968485157545;6315.684215789192;6316.115743795872;4231.386448964914;4317.546657600969;4372.846950356722;4374.912501749947;4411.845585404495;6464.967675161641;6508.926027205505;6521.184851893513;6525.3474652535315;6534.248561415403;4499.820007199741;4504.774761261924;4507.549245075466;4508.932366014513;4509.233430316854;4474.843380481668;4565.56627120423;4570.063137056895;4571;4586.72479651222;5267.473252674778;5273.499017593323;5277.366715994029;5277.894442111136;5284.39229488606;6350.745970161234;6353.872922541524;6354.52341074412;6356.872862542816;6358.872822543616;1604.9598760031092;1623.6996155710995;1623.951281461558;1625.0168647968046;1625.9512614363668;1042.3224903812581;1053.136428128927;1053.8682664666917;1057.7408534908843;1086.625114335553;6012.579119461683;6024.367441418675;6025.698715064229;6066.636001839904;6099.20710307666;6526.086347911296;6536.640484773383;6538.313477084933;6539.574927629689;6551.312112228243;5960.225170727777;6074.665893375906;6083.178770865965;6088.726007329681;6090.543209259324;3530.2586456843837;3549.6627820357025;3550.55618047744;3553.058439513531;3553.431450967833;6617.735290588419;6618.371254730793;6625.17185351831;6629.933700662931;6633.369829866155;6664.266930637626;6677.332266773284;6677.866442671217;6685.331466853276;6690.565113267622;6430.292667806538;6596.241432235259;6607.9669601651685;6608.603483790892;6610.471162307004;6356.396142366468;6496.902546461902;6503.772367967098;6508.219013718384;6521.152250207443;6398.456131228898;6505.967470162619;6516.348365163446;6544.770933017321;6560.507961902781;6629.668516574248;6662.700178492077;6664.7000884959325;6666.100076489612;6675.132232809898;4406.823727050882;4451.221036318696;4454.977725111354;4459.710118842265;4462.709923854939;6448.355164483514;6465.838354040999;6506.869862602816;6515.413612774873;6528.445082167879;6329.335419780857;6334.271558770801;6347.365263473615;6351.2060992375955;6353.777617783356;6213.1922850029205;6327.303996560283;6330.177076979963;6332.3034466207755;6342.048692695948;6194.38056194377;6217.720202590804;6223.782167624111;6225.968870155621;6226.782062627786;6363.331850155667;6364.872702546016;6370.458511026614;6371.490280777434;6377.840553986188;6057.273127224761;6192.876142477216;6195.19462469876;6201.689915504297;6204.751809927552 23:06:57 INFO - PROCESS | 6953 | |5;yui.html;734.9485536012479;796.303234669664;798.4450806689349;808.6644042722271;824.4146655874331;13742.175469471838;13864.237466939314;13866.584002479916;13893;13946.511872084478;14695.559133225994;14807.703845923075;14807.777883331759;14810.407583696666;14816.111033338007;817.8446095241915;835.8202986357932;835.9038710548274;836.6778790165799;837.5519097282955;689.396777819408;701.5124488480508;836.1554829622095;852.2585350744861;852.47146769003;854.6965827131372;877.1184959116111;887.3167660901103;888.8133491966695;890.2477406591453;713.9464540159457;729.4456213277947;856.5160684213431;871.7341210930664;882.629295695806;520.1443625236465;635.7012204264034;645.3224114679615;646.5635695905245;646.7186773753432;13378.264195469343;13446.394912228972;13476.595702128952;13485.730285394335;13500.729985400336;11435.771284574263;11755;11883.465244063951;12741.260628964817;12824.80762788559;10452.790944181073;10478.685639430829;10484.108850747696;10545.683629491128;10647.57409703611;3518.1732292911147;3571.589267234275;3575.213453040327;3594.7663401878795;3613.765105268149;47670.5232947673;47785.52214477846;47882.28176577354;47907.76046119747;47914;9660.806783864284;9806.460644664468;9846.507674616241;9889.159421449114;10092.192624590016;17543;17623.383181588582;17627.735583966252;17637.50081243083;17678.381256655954;7428.702851885864;7533.623318834037;7537.660805263777;7602.543847369176;7678.500897441649;4183.414321994923;4223.53181870348;4304.053108316165;4402.603765661106;4452.0873220989615;3131.3424180921807;3140.309131991004;3157.6526582076413;3160;3164.9683503165134;533.0165844017858;542.8588566972616;551.892380985712;556.3824155187739;556.966582005081;512.2469969145351;576.7087620751494;578.6007654718231;587.7443312159224;598.5092224376057;6972.860542789116;7346.375558077516;7509.436792240604;7529.849403012018;7557.244275572399;471.1096028506126;519.8388499565147;520.5133200457584;589.0927970924813;601.6720887116531;3734.066483379155;3747.4004159334377;3770.5852356240794;3800.5059342285326;3824.8661296855034;51198.488015120114;51775.22337164945;52408;61298;61488.07767883485;42976.35535466971;43449.13101737948;43527;43629.56370436255;49917.25124123141;44001.339979900324;44299.778501107285;44725.55274447279;45794.313085303744;45910.31134532985;8266.628001739817;8438.240558349778;8544.615492302986;8653.956730216309;8929.598168082583;35225.29549409049;35821.82089089538;36006.45990310095;36145;36414.8179259102;41467.1706565873;41481.58518414777;43578;45122.323165153204;45484.31773523334;10253.538590763284;10360.896391035993;10764.838527422251;10819.080378167944;10954.890451095705;11515.942420287845;11693.889080537336;12321.322327271728;12461.688457788629;12632.936835315764;10653.573857045942;10810.29733067348;10947.83578246311;11208.327500350006;11839.348835814113;10924.836127457935;11130.387828669178;11214.271072380268;11402.429878506207;11470.598529051444;10584.259101863103;10744.30162039465;10807.837882431613;10821.404822734825;10939.195032819496;9534.809303814023;9620.904386862301;9747.512624368896;9853.359531630422;10140.29017968735;8880.378373513791;8911.777205569913;9536.952315238379;9696.660616878375;9823 23:06:57 INFO - PROCESS | 6953 | __end_tp_report 23:06:57 INFO - PROCESS | 6953 | __start_cc_report 23:06:57 INFO - PROCESS | 6953 | _x_x_mozilla_cycle_collect,843 23:06:57 INFO - PROCESS | 6953 | __end_cc_report 23:06:57 INFO - PROCESS | 6953 | __startTimestamp1450768017484__endTimestamp 23:06:57 INFO - PROCESS | 6953 | 23:06:57 INFO - PROCESS | 6953 | ------- Summary: start ------- 23:06:57 INFO - PROCESS | 6953 | Number of tests: 6 23:06:57 INFO - PROCESS | 6953 | 23:06:57 INFO - PROCESS | 6953 | [#0] dojo.html Cycles:165 Average:5385.00 Median:5558.19 stddev:591.40 (10.6%) stddev-sans-first:567.18 23:06:57 INFO - PROCESS | 6953 | Values: 3172.9 3228.7 3263.1 3272.6 3293.5 5252.1 5379.9 5448.9 5481.4 5482.6 5181.4 5229.7 5295.1 5337.8 5350.0 4857.8 4860.9 4876.3 4933.0 4982.7 4635.7 4958.2 5025.9 5036.9 5058.7 4834.8 4906.7 4956.7 4979.3 4990.9 4928.8 4932.9 4933.1 4938.4 4951.3 4893.7 4920.4 4927.1 4928.9 4952.3 5096.1 5196.8 5209.5 5304.5 5306.6 5819.3 5824.6 5846.1 5847.8 5922.6 5872.9 5876.9 5879.7 5881.9 5882.1 5259.8 5496.0 5498.6 5501.2 5502.8 5797.7 5816.1 5835.2 5850.7 5855.3 5746.4 5750.7 5751.6 5752.3 5795.1 5773.6 5820.1 5837.3 5841.1 5845.8 5714.5 5787.7 5791.8 5922.2 5933.8 5701.5 5773.7 5777.0 5777.4 5823.1 4516.4 4526.7 4527.6 4531.2 4571.0 3955.4 3964.6 4044.1 4085.7 4106.1 5492.9 5507.1 5508.6 5512.7 5552.2 5830.7 5857.7 5872.9 5876.1 5879.0 5220.0 5286.2 5397.2 5438.4 5491.4 4995.2 5000.5 5013.1 5049.6 5114.3 5828.5 5830.6 5837.2 5846.4 5854.4 5656.7 5801.1 5807.9 5850.6 5896.1 5773.4 5844.3 5942.8 5947.2 5977.9 5879.9 5889.4 5891.0 5896.6 5901.1 5741.9 5846.8 5930.9 5955.4 5958.3 5583.4 5592.3 5630.4 5634.8 5640.6 5648.9 5649.9 5652.9 5657.3 5658.1 5351.3 5510.0 5546.4 5548.1 5557.3 5634.3 5673.8 5711.5 5712.7 5768.9 5547.9 5549.4 5558.2 5559.4 5668.7 23:06:57 INFO - PROCESS | 6953 | 23:06:57 INFO - PROCESS | 6953 | [#1] ext.html Cycles:180 Average:44307.11 Median:169093.69 stddev:71957.65 (42.6%) stddev-sans-first:72084.55 23:06:57 INFO - PROCESS | 6953 | Values: 561.6 574.3 579.1 595.1 598.0 37930.0 38450.6 38738.6 38850.2 38971.8 41558.0 42313.2 42402.4 42406.0 42454.4 7599.2 7749.0 7756.0 8597.7 8785.6 10350.8 10603.9 10622.0 10625.9 10626.4 10249.3 10347.7 10355.6 10356.9 10362.4 7870.1 8094.8 10238.1 10245.8 10482.6 10031.9 10109.8 10229.0 10248.6 10249.7 39334.8 39669.6 39691.2 39729.6 39748.6 3335.9 3357.3 3446.4 3742.4 3791.5 30172.8 30279.4 30616.7 30687.4 31416.0 3491.3 3519.8 3521.5 3612.8 3688.4 263125.0 263905.0 263926.0 264702.0 264854.0 55093.2 55935.0 56177.0 56186.7 56802.4 66918.3 67765.9 67815.0 67957.0 68188.7 15917.3 16035.7 16073.0 16086.4 16105.4 11948.1 12016.0 12024.9 12027.8 12041.6 19152.6 19292.8 19389.8 19456.4 19503.1 7151.3 7288.1 7411.6 7417.3 7481.1 898.4 938.9 1021.4 1026.2 1049.7 25220.6 26328.5 26415.9 26705.7 26866.5 1016.4 1024.9 1048.3 1105.8 1197.9 13272.7 13374.5 13428.5 13463.7 13473.7 303819.0 304092.0 305226.0 307263.0 307348.0 48790.3 49078.0 49150.0 49157.8 49165.5 1208.9 1220.1 1223.6 1227.0 1325.4 24288.0 25152.4 26946.9 30064.4 30323.2 44964.0 45284.5 45361.5 45415.5 45708.8 241267.0 242860.0 243317.0 243345.0 298346.0 25643.2 30601.7 30987.1 31395.2 31440.0 36003.8 36565.0 36776.6 37186.3 37261.0 28520.7 31023.2 31657.2 31721.7 32095.7 33526.0 34300.7 34447.5 34539.5 34620.5 32854.0 33317.5 33546.0 33572.7 33651.0 29622.6 30426.4 30627.2 30839.4 30912.5 23781.5 24247.6 25023.0 25024.6 26906.6 23:06:57 INFO - PROCESS | 6953 | 23:06:57 INFO - PROCESS | 6953 | [#2] jquery.html Cycles:180 Average:28790.59 Median:35930.64 stddev:88780.91 (247.1%) stddev-sans-first:89004.26 23:06:57 INFO - PROCESS | 6953 | Values: 338.9 346.7 349.0 350.4 352.5 16739.3 17446.7 17674.7 18140.5 18153.7 16430.4 16634.8 16717.2 16782.3 16792.3 5303.8 5327.4 5427.0 5478.8 5484.0 5387.2 5440.9 5445.7 5447.5 5453.6 3906.7 4235.8 5379.0 5396.9 5882.0 5826.0 5863.6 5884.5 5885.0 5887.9 5000.7 5041.9 5072.2 5075.1 5183.7 16085.8 17209.9 19274.7 19572.4 20246.9 2031.9 2167.4 2200.3 2244.4 2268.2 13134.6 13219.8 13250.1 13426.0 13732.2 1742.6 1758.5 1774.8 1856.1 1856.8 54121.7 57536.4 57603.7 61444.4 64704.7 9974.9 10089.4 10105.6 10131.3 10137.3 13085.4 13132.1 13139.5 13157.9 13186.1 7487.5 7539.7 7617.1 7695.5 7762.1 7628.9 7677.8 7680.5 7717.3 7739.9 4046.7 4168.1 4315.8 4354.6 4359.6 1617.6 1653.0 1684.7 1730.2 1761.6 877.1 906.6 933.9 956.8 976.7 13974.2 16350.8 16854.4 16982.2 17251.5 870.6 885.8 925.4 969.1 982.8 9100.2 9323.8 9338.8 9387.4 9404.4 517990.0 526220.0 554208.0 554973.0 563088.0 71062.0 78951.0 81325.0 82098.0 82314.2 1149.2 1154.3 1163.5 1173.1 1176.7 14749.9 15389.7 15455.1 15625.7 15773.5 33497.0 34721.7 34814.3 35271.5 36589.8 43142.8 44604.0 45329.1 46949.3 47322.8 8599.5 8891.0 8958.7 8973.0 8976.0 10459.6 11634.7 16995.8 17185.7 17470.9 13890.8 14092.1 14210.8 14540.1 14668.6 13663.3 13823.8 14168.4 14352.4 14415.1 14615.3 14617.3 15149.7 15572.2 15626.9 9357.0 9514.9 9599.4 9633.5 9707.9 9646.5 9745.7 11244.7 14809.4 15151.7 23:06:57 INFO - PROCESS | 6953 | 23:06:57 INFO - PROCESS | 6953 | [#3] mootools.html Cycles:180 Average:5449.47 Median:6478.08 stddev:2834.24 (43.8%) stddev-sans-first:2825.08 23:06:57 INFO - PROCESS | 6953 | Values: 1305.9 1688.9 1758.5 1761.9 1810.1 6774.2 7701.6 7740.1 7771.8 7814.2 7640.3 7788.8 7799.5 7817.4 7820.0 2036.4 2073.8 2205.1 2205.7 2236.2 2217.8 2233.5 2239.2 2239.7 2243.2 2172.2 2243.7 2245.1 2248.6 2251.1 2234.2 2263.3 2269.8 2296.2 2297.3 2282.4 2294.0 2299.5 2318.3 2323.3 7733.6 7809.2 7810.4 7819.3 7825.5 4608.0 4706.6 4714.5 4719.1 4724.1 3001.6 3009.2 3039.3 3052.5 3125.7 948.6 951.3 971.8 973.2 1015.6 10699.9 10716.2 10753.5 10768.2 10777.4 4140.6 4167.1 4222.2 4226.8 4239.3 9155.8 9176.4 9193.9 9202.2 9220.2 4655.1 4681.0 4684.1 4712.9 4720.9 4295.9 4298.4 4300.8 4304.6 4312.1 3399.2 3453.6 3567.9 3596.3 3684.0 1119.7 1133.3 1137.0 1138.1 1146.3 1027.2 1039.3 1042.1 1182.7 1358.8 7047.1 7128.5 7144.9 7190.4 7255.6 1087.9 1092.1 1100.0 1102.3 1108.2 5788.6 5858.6 5863.4 5863.6 5869.4 9101.4 9222.6 9388.5 9528.7 9544.0 9315.7 9349.9 9430.0 9447.0 9456.9 7325.5 7346.4 7400.1 7407.9 7424.6 6991.1 7018.7 7026.5 7052.1 7057.4 8151.4 8351.9 8442.2 8544.1 8588.4 8571.2 8581.7 8689.4 8704.0 8714.7 6828.4 7002.4 7010.4 7018.6 7039.2 6784.1 6966.7 7108.2 7321.5 7386.3 6924.2 6925.0 7062.6 7073.1 7139.5 6983.9 7000.3 7062.4 7095.5 7160.3 7023.6 7066.9 7106.4 7124.8 7147.1 6286.2 6308.2 6336.0 6337.1 6370.6 6585.5 6609.6 6617.5 6618.3 6625.9 23:06:57 INFO - PROCESS | 6953 | 23:06:57 INFO - PROCESS | 6953 | [#4] prototype.html Cycles:180 Average:5276.57 Median:6018.47 stddev:1578.30 (26.2%) stddev-sans-first:1538.50 23:06:57 INFO - PROCESS | 6953 | Values: 333.4 333.4 334.5 340.5 340.5 5846.7 5962.3 5964.1 6002.2 6043.3 5742.8 5931.6 5932.3 5934.1 5952.4 4576.2 4580.2 4584.7 4589.4 4593.1 4410.7 4481.4 4485.3 4535.0 4572.9 4480.4 4580.5 4609.2 4611.5 4624.2 4575.0 4577.1 4594.9 4602.0 4604.9 4027.6 4029.5 4039.2 4057.2 4065.6 5548.5 5636.4 5664.7 5676.1 5705.6 5257.9 5273.9 5273.9 5281.7 5281.9 6061.8 6300.7 6303.0 6315.7 6316.1 4231.4 4317.5 4372.8 4374.9 4411.8 6465.0 6508.9 6521.2 6525.3 6534.2 4499.8 4504.8 4507.5 4508.9 4509.2 4474.8 4565.6 4570.1 4571.0 4586.7 5267.5 5273.5 5277.4 5277.9 5284.4 6350.7 6353.9 6354.5 6356.9 6358.9 1605.0 1623.7 1624.0 1625.0 1626.0 1042.3 1053.1 1053.9 1057.7 1086.6 6012.6 6024.4 6025.7 6066.6 6099.2 6526.1 6536.6 6538.3 6539.6 6551.3 5960.2 6074.7 6083.2 6088.7 6090.5 3530.3 3549.7 3550.6 3553.1 3553.4 6617.7 6618.4 6625.2 6629.9 6633.4 6664.3 6677.3 6677.9 6685.3 6690.6 6430.3 6596.2 6608.0 6608.6 6610.5 6356.4 6496.9 6503.8 6508.2 6521.2 6398.5 6506.0 6516.3 6544.8 6560.5 6629.7 6662.7 6664.7 6666.1 6675.1 4406.8 4451.2 4455.0 4459.7 4462.7 6448.4 6465.8 6506.9 6515.4 6528.4 6329.3 6334.3 6347.4 6351.2 6353.8 6213.2 6327.3 6330.2 6332.3 6342.0 6194.4 6217.7 6223.8 6226.0 6226.8 6363.3 6364.9 6370.5 6371.5 6377.8 6057.3 6192.9 6195.2 6201.7 6204.8 23:06:57 INFO - PROCESS | 6953 | 23:06:57 INFO - PROCESS | 6953 | [#5] yui.html Cycles:180 Average:13455.69 Median:24588.82 stddev:15322.45 (62.3%) stddev-sans-first:15335.66 23:06:57 INFO - PROCESS | 6953 | Values: 734.9 796.3 798.4 808.7 824.4 13742.2 13864.2 13866.6 13893.0 13946.5 14695.6 14807.7 14807.8 14810.4 14816.1 817.8 835.8 835.9 836.7 837.6 689.4 701.5 836.2 852.3 852.5 854.7 877.1 887.3 888.8 890.2 713.9 729.4 856.5 871.7 882.6 520.1 635.7 645.3 646.6 646.7 13378.3 13446.4 13476.6 13485.7 13500.7 11435.8 11755.0 11883.5 12741.3 12824.8 10452.8 10478.7 10484.1 10545.7 10647.6 3518.2 3571.6 3575.2 3594.8 3613.8 47670.5 47785.5 47882.3 47907.8 47914.0 9660.8 9806.5 9846.5 9889.2 10092.2 17543.0 17623.4 17627.7 17637.5 17678.4 7428.7 7533.6 7537.7 7602.5 7678.5 4183.4 4223.5 4304.1 4402.6 4452.1 3131.3 3140.3 3157.7 3160.0 3165.0 533.0 542.9 551.9 556.4 557.0 512.2 576.7 578.6 587.7 598.5 6972.9 7346.4 7509.4 7529.8 7557.2 471.1 519.8 520.5 589.1 601.7 3734.1 3747.4 3770.6 3800.5 3824.9 51198.5 51775.2 52408.0 61298.0 61488.1 42976.4 43449.1 43527.0 43629.6 49917.3 44001.3 44299.8 44725.6 45794.3 45910.3 8266.6 8438.2 8544.6 8654.0 8929.6 35225.3 35821.8 36006.5 36145.0 36414.8 41467.2 41481.6 43578.0 45122.3 45484.3 10253.5 10360.9 10764.8 10819.1 10954.9 11515.9 11693.9 12321.3 12461.7 12632.9 10653.6 10810.3 10947.8 11208.3 11839.3 10924.8 11130.4 11214.3 11402.4 11470.6 10584.3 10744.3 10807.8 10821.4 10939.2 9534.8 9620.9 9747.5 9853.4 10140.3 8880.4 8911.8 9537.0 9696.7 9823.0 23:06:57 INFO - PROCESS | 6953 | -------- Summary: end -------- 23:06:57 INFO - PROCESS | 6953 | 23:06:58 INFO - TEST-INFO | 6953: exit 0 23:06:58 INFO - TEST-OK | dromaeo_css | took 1113042ms 23:06:58 INFO - TEST-START | kraken 23:06:58 INFO - operating with platform_type : linux_ 23:06:58 INFO - Initialising browser for kraken test... 23:06:58 INFO - TEST-INFO | started process 7143 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpD7hZ_x/profile http://localhost:37345/getInfo.html) 23:07:01 INFO - PROCESS | 7143 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 23:07:01 INFO - PROCESS | 7143 | __metrics Screen width/height:1600/1200 23:07:01 INFO - PROCESS | 7143 | colorDepth:24 23:07:01 INFO - PROCESS | 7143 | Browser inner width/height: 1024/697 23:07:01 INFO - PROCESS | 7143 | __metrics 23:07:01 INFO - PROCESS | 7143 | 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:07:01 INFO - PROCESS | 7143 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:07:03 INFO - TEST-INFO | 7143: exit 0 23:07:03 INFO - Browser initialized. 23:07:03 INFO - Running cycle 1/1 for kraken test... 23:07:03 INFO - TEST-INFO | started process 7224 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpD7hZ_x/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:07:14 INFO - PROCESS | 7224 | RSS: Main: 149884928 23:07:14 INFO - PROCESS | 7224 | 23:07:17 INFO - PROCESS | 7224 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37345/tests/kraken/driver.html?testName=audio-beat-detection) 23:07:17 INFO - PROCESS | 7224 | RSS: Main: 186195968 23:07:17 INFO - PROCESS | 7224 | 23:07:20 INFO - PROCESS | 7224 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37345/tests/kraken/driver.html?testName=audio-dft) 23:07:21 INFO - PROCESS | 7224 | RSS: Main: 177930240 23:07:21 INFO - PROCESS | 7224 | 23:07:24 INFO - PROCESS | 7224 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37345/tests/kraken/driver.html?testName=audio-fft) 23:07:24 INFO - PROCESS | 7224 | RSS: Main: 160911360 23:07:24 INFO - PROCESS | 7224 | 23:07:26 INFO - PROCESS | 7224 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37345/tests/kraken/driver.html?testName=audio-oscillator) 23:07:27 INFO - PROCESS | 7224 | RSS: Main: 162295808 23:07:27 INFO - PROCESS | 7224 | 23:07:29 INFO - PROCESS | 7224 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37345/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:07:30 INFO - PROCESS | 7224 | RSS: Main: 163409920 23:07:30 INFO - PROCESS | 7224 | 23:07:32 INFO - PROCESS | 7224 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37345/tests/kraken/driver.html?testName=imaging-darkroom) 23:07:33 INFO - PROCESS | 7224 | RSS: Main: 164552704 23:07:33 INFO - PROCESS | 7224 | 23:07:36 INFO - PROCESS | 7224 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37345/tests/kraken/driver.html?testName=imaging-desaturate) 23:07:37 INFO - PROCESS | 7224 | RSS: Main: 166363136 23:07:37 INFO - PROCESS | 7224 | 23:07:40 INFO - PROCESS | 7224 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37345/tests/kraken/driver.html?testName=json-parse-financial) 23:07:40 INFO - PROCESS | 7224 | RSS: Main: 166985728 23:07:40 INFO - PROCESS | 7224 | 23:07:42 INFO - PROCESS | 7224 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37345/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:07:42 INFO - PROCESS | 7224 | RSS: Main: 175828992 23:07:42 INFO - PROCESS | 7224 | 23:07:44 INFO - PROCESS | 7224 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37345/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:07:45 INFO - PROCESS | 7224 | RSS: Main: 174448640 23:07:45 INFO - PROCESS | 7224 | 23:07:47 INFO - PROCESS | 7224 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37345/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:07:47 INFO - PROCESS | 7224 | RSS: Main: 186994688 23:07:47 INFO - PROCESS | 7224 | 23:07:50 INFO - PROCESS | 7224 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37345/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:07:50 INFO - PROCESS | 7224 | RSS: Main: 192643072 23:07:50 INFO - PROCESS | 7224 | 23:07:53 INFO - PROCESS | 7224 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37345/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:07:54 INFO - PROCESS | 7224 | RSS: Main: 191012864 23:07:54 INFO - PROCESS | 7224 | 23:07:55 INFO - PROCESS | 7224 | Cycle 1(1): loaded http://localhost:37345/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37345/tests/kraken/driver.html?testName=ai-astar) 23:07:56 INFO - PROCESS | 7224 | RSS: Main: 248020992 23:07:56 INFO - PROCESS | 7224 | 23:07:56 INFO - PROCESS | 7224 | __start_tp_report 23:07:56 INFO - PROCESS | 7224 | _x_x_mozilla_page_load 23:07:56 INFO - PROCESS | 7224 | _x_x_mozilla_page_load_details 23:07:56 INFO - PROCESS | 7224 | |i|pagename|runs| 23:07:56 INFO - PROCESS | 7224 | |0;ai-astar;109;112;106;112;110;112;101;110;111;117 23:07:56 INFO - PROCESS | 7224 | |1;audio-beat-detection;150;131;154;167;126;149;157;126;171;126 23:07:56 INFO - PROCESS | 7224 | |2;audio-dft;161;161;158;159;163;160;159;161;165;170 23:07:56 INFO - PROCESS | 7224 | |3;audio-fft;71;71;87;91;73;72;71;110;97;73 23:07:56 INFO - PROCESS | 7224 | |4;audio-oscillator;94;94;145;93;92;94;135;93;93;133 23:07:56 INFO - PROCESS | 7224 | |5;imaging-gaussian-blur;111;109;109;111;109;109;109;109;110;109 23:07:56 INFO - PROCESS | 7224 | |6;imaging-darkroom;146;146;145;146;146;146;145;145;146;146 23:07:56 INFO - PROCESS | 7224 | |7;imaging-desaturate;96;96;95;96;95;96;96;95;97;96 23:07:56 INFO - PROCESS | 7224 | |8;json-parse-financial;60;57;58;56;57;57;58;66;55;55 23:07:56 INFO - PROCESS | 7224 | |9;json-stringify-tinderbox;68;67;68;67;67;67;68;68;67;67 23:07:56 INFO - PROCESS | 7224 | |10;stanford-crypto-aes;91;84;93;85;84;83;85;87;86;87 23:07:56 INFO - PROCESS | 7224 | |11;stanford-crypto-ccm;133;125;115;117;113;127;119;122;115;121 23:07:56 INFO - PROCESS | 7224 | |12;stanford-crypto-pbkdf2;143;152;151;158;155;146;164;143;151;147 23:07:56 INFO - PROCESS | 7224 | |13;stanford-crypto-sha256-iterative;68;68;68;69;66;69;68;69;68;67 23:07:56 INFO - PROCESS | 7224 | __end_tp_report 23:07:56 INFO - PROCESS | 7224 | __start_cc_report 23:07:56 INFO - PROCESS | 7224 | _x_x_mozilla_cycle_collect,932 23:07:56 INFO - PROCESS | 7224 | __end_cc_report 23:07:56 INFO - PROCESS | 7224 | __startTimestamp1450768076115__endTimestamp 23:07:56 INFO - PROCESS | 7224 | 23:07:56 INFO - PROCESS | 7224 | ------- Summary: start ------- 23:07:56 INFO - PROCESS | 7224 | Number of tests: 14 23:07:56 INFO - PROCESS | 7224 | 23:07:56 INFO - PROCESS | 7224 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.50 stddev:4.22 (3.8%) stddev-sans-first:4.46 23:07:56 INFO - PROCESS | 7224 | Values: 109.0 112.0 106.0 112.0 110.0 112.0 101.0 110.0 111.0 117.0 23:07:56 INFO - PROCESS | 7224 | 23:07:56 INFO - PROCESS | 7224 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:152.00 stddev:17.32 (11.4%) stddev-sans-first:18.30 23:07:56 INFO - PROCESS | 7224 | Values: 150.0 131.0 154.0 167.0 126.0 149.0 157.0 126.0 171.0 126.0 23:07:56 INFO - PROCESS | 7224 | 23:07:56 INFO - PROCESS | 7224 | [#2] audio-dft Cycles:10 Average:161.70 Median:161.00 stddev:3.56 (2.2%) stddev-sans-first:3.77 23:07:56 INFO - PROCESS | 7224 | Values: 161.0 161.0 158.0 159.0 163.0 160.0 159.0 161.0 165.0 170.0 23:07:56 INFO - PROCESS | 7224 | 23:07:56 INFO - PROCESS | 7224 | [#3] audio-fft Cycles:10 Average:81.60 Median:73.00 stddev:13.90 (19.0%) stddev-sans-first:14.20 23:07:56 INFO - PROCESS | 7224 | Values: 71.0 71.0 87.0 91.0 73.0 72.0 71.0 110.0 97.0 73.0 23:07:56 INFO - PROCESS | 7224 | 23:07:56 INFO - PROCESS | 7224 | [#4] audio-oscillator Cycles:10 Average:106.60 Median:93.00 stddev:21.66 (23.3%) stddev-sans-first:22.49 23:07:56 INFO - PROCESS | 7224 | Values: 94.0 94.0 145.0 93.0 92.0 94.0 135.0 93.0 93.0 133.0 23:07:56 INFO - PROCESS | 7224 | 23:07:56 INFO - PROCESS | 7224 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:109.00 stddev:0.85 (0.8%) stddev-sans-first:0.71 23:07:56 INFO - PROCESS | 7224 | Values: 111.0 109.0 109.0 111.0 109.0 109.0 109.0 109.0 110.0 109.0 23:07:56 INFO - PROCESS | 7224 | 23:07:56 INFO - PROCESS | 7224 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 23:07:56 INFO - PROCESS | 7224 | Values: 146.0 146.0 145.0 146.0 146.0 146.0 145.0 145.0 146.0 146.0 23:07:56 INFO - PROCESS | 7224 | 23:07:56 INFO - PROCESS | 7224 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 23:07:56 INFO - PROCESS | 7224 | Values: 96.0 96.0 95.0 96.0 95.0 96.0 96.0 95.0 97.0 96.0 23:07:56 INFO - PROCESS | 7224 | 23:07:56 INFO - PROCESS | 7224 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:57.50 stddev:3.21 (5.6%) stddev-sans-first:3.32 23:07:56 INFO - PROCESS | 7224 | Values: 60.0 57.0 58.0 56.0 57.0 57.0 58.0 66.0 55.0 55.0 23:07:56 INFO - PROCESS | 7224 | 23:07:56 INFO - PROCESS | 7224 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 23:07:56 INFO - PROCESS | 7224 | Values: 68.0 67.0 68.0 67.0 67.0 67.0 68.0 68.0 67.0 67.0 23:07:56 INFO - PROCESS | 7224 | 23:07:56 INFO - PROCESS | 7224 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.50 stddev:3.21 (3.7%) stddev-sans-first:2.96 23:07:56 INFO - PROCESS | 7224 | Values: 91.0 84.0 93.0 85.0 84.0 83.0 85.0 87.0 86.0 87.0 23:07:56 INFO - PROCESS | 7224 | 23:07:56 INFO - PROCESS | 7224 | [#11] stanford-crypto-ccm Cycles:10 Average:120.70 Median:121.50 stddev:6.25 (5.1%) stddev-sans-first:4.80 23:07:56 INFO - PROCESS | 7224 | Values: 133.0 125.0 115.0 117.0 113.0 127.0 119.0 122.0 115.0 121.0 23:07:56 INFO - PROCESS | 7224 | 23:07:56 INFO - PROCESS | 7224 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.00 Median:151.50 stddev:6.70 (4.4%) stddev-sans-first:6.45 23:07:56 INFO - PROCESS | 7224 | Values: 143.0 152.0 151.0 158.0 155.0 146.0 164.0 143.0 151.0 147.0 23:07:56 INFO - PROCESS | 7224 | 23:07:56 INFO - PROCESS | 7224 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:0.94 (1.4%) stddev-sans-first:1.00 23:07:56 INFO - PROCESS | 7224 | Values: 68.0 68.0 68.0 69.0 66.0 69.0 68.0 69.0 68.0 67.0 23:07:56 INFO - PROCESS | 7224 | -------- Summary: end -------- 23:07:56 INFO - PROCESS | 7224 | 23:07:56 INFO - TEST-INFO | 7224: exit 0 23:07:57 INFO - TEST-OK | kraken | took 58846ms 23:07:57 INFO - TEST-START | v8_7 23:07:57 INFO - operating with platform_type : linux_ 23:07:57 INFO - Initialising browser for v8_7 test... 23:07:57 INFO - TEST-INFO | started process 7473 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMHQNPF/profile http://localhost:37345/getInfo.html) 23:08:00 INFO - PROCESS | 7473 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 23:08:00 INFO - PROCESS | 7473 | __metrics Screen width/height:1600/1200 23:08:00 INFO - PROCESS | 7473 | colorDepth:24 23:08:00 INFO - PROCESS | 7473 | Browser inner width/height: 1024/697 23:08:00 INFO - PROCESS | 7473 | __metrics 23:08:01 INFO - PROCESS | 7473 | 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:08:01 INFO - PROCESS | 7473 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:08:01 ERROR - PROCESS | 7473 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 23:08:01 INFO - TEST-INFO | 7473: exit 0 23:08:01 INFO - Browser initialized. 23:08:01 INFO - Running cycle 1/1 for v8_7 test... 23:08:01 INFO - TEST-INFO | started process 7558 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMHQNPF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:08:13 INFO - PROCESS | 7558 | RSS: Main: 149991424 23:08:13 INFO - PROCESS | 7558 | 23:08:35 INFO - PROCESS | 7558 | Cycle 1(1): loaded http://localhost:37345/tests/v8_7/run.html (next: http://localhost:37345/tests/v8_7/run.html) 23:08:35 INFO - PROCESS | 7558 | RSS: Main: 587018240 23:08:35 INFO - PROCESS | 7558 | 23:08:35 INFO - PROCESS | 7558 | __start_tp_report 23:08:35 INFO - PROCESS | 7558 | _x_x_mozilla_page_load 23:08:35 INFO - PROCESS | 7558 | _x_x_mozilla_page_load_details 23:08:35 INFO - PROCESS | 7558 | |i|pagename|runs| 23:08:35 INFO - PROCESS | 7558 | |0;Richards;165.59032952475576 23:08:35 INFO - PROCESS | 7558 | |1;DeltaBlue;189.14318138831095 23:08:35 INFO - PROCESS | 7558 | |2;Encrypt;280.0336040324839 23:08:35 INFO - PROCESS | 7558 | |3;Decrypt;5196.891191709845 23:08:35 INFO - PROCESS | 7558 | |4;RayTrace;2032.520325203252 23:08:35 INFO - PROCESS | 7558 | |5;Earley;783.6990595611285 23:08:35 INFO - PROCESS | 7558 | |6;Boyer;11964.285714285714 23:08:35 INFO - PROCESS | 7558 | |7;RegExp;25974.358974358973 23:08:35 INFO - PROCESS | 7558 | |8;Splay;663.1299734748011 23:08:35 INFO - PROCESS | 7558 | |9;NavierStokes;4840.579710144928 23:08:35 INFO - PROCESS | 7558 | __end_tp_report 23:08:35 INFO - PROCESS | 7558 | __startTimestamp1450768115355__endTimestamp 23:08:35 INFO - PROCESS | 7558 | 23:08:35 INFO - PROCESS | 7558 | ------- Summary: start ------- 23:08:35 INFO - PROCESS | 7558 | Number of tests: 10 23:08:35 INFO - PROCESS | 7558 | 23:08:35 INFO - PROCESS | 7558 | [#0] Richards Cycles:1 Average:165.59 Median:165.59 stddev:0.00 (0.0%) 23:08:35 INFO - PROCESS | 7558 | Values: 165.6 23:08:35 INFO - PROCESS | 7558 | 23:08:35 INFO - PROCESS | 7558 | [#1] DeltaBlue Cycles:1 Average:189.14 Median:189.14 stddev:0.00 (0.0%) 23:08:35 INFO - PROCESS | 7558 | Values: 189.1 23:08:35 INFO - PROCESS | 7558 | 23:08:35 INFO - PROCESS | 7558 | [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 23:08:35 INFO - PROCESS | 7558 | Values: 280.0 23:08:35 INFO - PROCESS | 7558 | 23:08:35 INFO - PROCESS | 7558 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 23:08:35 INFO - PROCESS | 7558 | Values: 5196.9 23:08:35 INFO - PROCESS | 7558 | 23:08:35 INFO - PROCESS | 7558 | [#4] RayTrace Cycles:1 Average:2032.52 Median:2032.52 stddev:0.00 (0.0%) 23:08:35 INFO - PROCESS | 7558 | Values: 2032.5 23:08:35 INFO - PROCESS | 7558 | 23:08:35 INFO - PROCESS | 7558 | [#5] Earley Cycles:1 Average:783.70 Median:783.70 stddev:0.00 (0.0%) 23:08:35 INFO - PROCESS | 7558 | Values: 783.7 23:08:35 INFO - PROCESS | 7558 | 23:08:35 INFO - PROCESS | 7558 | [#6] Boyer Cycles:1 Average:11964.29 Median:11964.29 stddev:0.00 (0.0%) 23:08:35 INFO - PROCESS | 7558 | Values: 11964.3 23:08:35 INFO - PROCESS | 7558 | 23:08:35 INFO - PROCESS | 7558 | [#7] RegExp Cycles:1 Average:25974.36 Median:25974.36 stddev:0.00 (0.0%) 23:08:35 INFO - PROCESS | 7558 | Values: 25974.4 23:08:35 INFO - PROCESS | 7558 | 23:08:35 INFO - PROCESS | 7558 | [#8] Splay Cycles:1 Average:663.13 Median:663.13 stddev:0.00 (0.0%) 23:08:35 INFO - PROCESS | 7558 | Values: 663.1 23:08:35 INFO - PROCESS | 7558 | 23:08:35 INFO - PROCESS | 7558 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 23:08:35 INFO - PROCESS | 7558 | Values: 4840.6 23:08:35 INFO - PROCESS | 7558 | -------- Summary: end -------- 23:08:35 INFO - PROCESS | 7558 | 23:08:36 INFO - TEST-INFO | 7558: exit 0 23:08:36 INFO - TEST-OK | v8_7 | took 39179ms 23:08:36 INFO - SUITE-END | took 1211s 23:08:36 INFO - Completed test suite (00:20:11) 23:08:36 INFO - Working with test: dromaeo_css 23:08:36 INFO - Generating results file: dromaeo_css 23:08:36 INFO - Working with test: kraken 23:08:36 INFO - Generating results file: kraken 23:08:36 INFO - javascript benchmark 23:08:36 INFO - Working with test: v8_7 23:08:36 INFO - Generating results file: v8_7 23:08:36 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:08:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 23:08:36 INFO - process_Request line: dromaeo_css 6947.30 graph.html#tests=[[72,64,35]] 23:08:36 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:08:36 INFO - process_Request line: kraken 1508.10 graph.html#tests=[[232,64,35]] 23:08:36 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:08:36 INFO - process_Request line: v8_7 19652.01 graph.html#tests=[[230,64,35]] 23:08:36 INFO - RETURN: dromaeo_css: 6947.30 23:08:36 INFO - RETURN: kraken: 1508.10 23:08:36 INFO - RETURN: v8_7: 19652.01 23:08:36 INFO - javascript benchmark 23:08:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3172.8572214250357, 3228.660990595989, 3263.118957881372, 3272.5582046423724, 3293.4565796643546, 5252.054630166568, 5379.919301210475, 5448.945510544893, 5481.397046324906, 5482.5613950883935, 5181.378234611851, 5229.686218826873, 5295.126304159809, 5337.7598008089635, 5350.0, 4857.805687772485, 4860.902781944376, 4876.317315575822, 4932.950670493303, 4982.676126051813, 4635.675502714811, 4958.231474121517, 5025.899482010358, 5036.949630503703, 5058.721770302632, 4834.758262086917, 4906.705597664151, 4956.653034287601, 4979.327790748257, 4990.925136122961, 4928.778204980785, 4932.901341973176, 4933.062718083588, 4938.3580134582635, 4951.257311403282, 4893.681910675795, 4920.409550853885, 4927.088488629615, 4928.926066109011, 4952.281919121707, 5096.133657278272, 5196.844094677166, 5209.53114219722, 5304.469553044664, 5306.628536002481, 5819.272590926134, 5824.621399609012, 5846.093855452412, 5847.7953271635715, 5922.615030023077, 5872.882542349129, 5876.9118463223085, 5879.67661778602, 5881.941180588182, 5882.117682347639, 5259.815906443295, 5495.972520137374, 5498.560115190775, 5501.174823776466, 5502.779888804443, 5797.652140871562, 5816.069428891357, 5835.183074369592, 5850.707464626752, 5855.3266374367495, 5746.42535746422, 5750.741216645261, 5751.626144300607, 5752.309722833287, 5795.072788353843, 5773.624714393551, 5820.126980952807, 5837.29952405714, 5841.065429531254, 5845.766169353264, 5714.514266287329, 5787.71061446926, 5791.768329266866, 5922.200502932049, 5933.821985340447, 5701.486866182064, 5773.711314434261, 5777.0, 5777.422257774273, 5823.068309070529, 4516.435445569304, 4526.728396296233, 4527.637788976874, 4531.161735079021, 4570.977145114253, 3955.4066889966734, 3964.5638979712785, 4044.130511939947, 4085.673146148301, 4106.055607210358, 5492.945070549244, 5507.118860982224, 5508.586855985817, 5512.6692398456225, 5552.222688823568, 5830.679312637845, 5857.70711464425, 5872.941270587325, 5876.059830427197, 5878.970605146947, 5220.034293655686, 5286.207068939613, 5397.217403476474, 5438.401775804658, 5491.395946445888, 4995.150824359867, 5000.499950004971, 5013.1227035268685, 5049.5707864831165, 5114.335136432314, 5828.5337173026055, 5830.62100963436, 5837.241158649434, 5846.444587764156, 5854.356020837705, 5656.688882111359, 5801.071828507418, 5807.912881306699, 5850.644359483775, 5896.086106653475, 5773.364929857797, 5844.26946631671, 5942.7920022799, 5947.226860508106, 5977.9402205977385, 5879.853003674943, 5889.440503152194, 5890.970545147246, 5896.64620122794, 5901.085331773582, 5741.8564535886935, 5846.824595262149, 5930.851728706817, 5955.434233747787, 5958.344582096052, 5583.385827559046, 5592.328920529562, 5630.408807075362, 5634.774609015593, 5640.605157638925, 5648.85877853057, 5649.858753531194, 5652.915206271827, 5657.321121465286, 5658.066419040812, 5351.3043304370185, 5510.0, 5546.4453554644215, 5548.0845660465575, 5557.277553918127, 5634.32388113429, 5673.801416950387, 5711.514521265739, 5712.65724056558, 5768.855778605568, 5547.861303467445, 5549.445055494418, 5558.194061860927, 5559.388467268678, 5668.659880407189], "unit": "score", "name": "dojo.html", "value": 5347.219924805687}, {"lowerIsBetter": false, "replicates": [561.6405500479693, 574.3194314737037, 579.0879365000123, 595.1073389915127, 597.982060538184, 37930.0, 38450.615493845056, 38738.612613873855, 38850.222995540105, 38971.805140974255, 41558.0, 42313.15373692532, 42402.36396454056, 42406.0, 42454.36318455218, 7599.164091949881, 7748.961255193716, 7756.0, 8597.742067737961, 8785.64857405703, 10350.844737328945, 10603.893961060368, 10622.0, 10625.946870265676, 10626.415547144903, 10249.282550221487, 10347.689569312932, 10355.637552685657, 10356.896431035706, 10362.378257304548, 7870.055593328809, 8094.797630059236, 10238.078572928473, 10245.846312305284, 10482.58069677212, 10031.949840250825, 10109.797804043877, 10229.0, 10248.590056397736, 10249.743756406075, 39334.80332598319, 39669.60330396717, 39691.20617587661, 39729.60270397317, 39748.60251397478, 3335.8999230023137, 3357.3285342931513, 3446.4141096013486, 3742.401215805458, 3791.450239715226, 30172.8491357544, 30279.394412111633, 30616.69383306183, 30687.386252275053, 31416.0, 3491.2668339648703, 3519.788812671248, 3521.4893840393, 3612.8077734347603, 3688.428293614494, 263125.0, 263905.0, 263926.0, 264702.0, 264854.0, 55093.173602396, 55935.0, 56177.0, 56186.719066405225, 56802.43197568054, 66918.33081669218, 67765.88458211915, 67815.0, 67957.0, 68188.6590567054, 15917.283722232527, 16035.679286414206, 16073.0, 16086.43697470583, 16105.355785768437, 11948.103892208119, 12016.0, 12024.939875300568, 12027.819582706266, 12041.638750837488, 19152.59630491412, 19292.807071929383, 19389.80610193908, 19456.416307510513, 19503.122359493856, 7151.32062454066, 7288.125424948934, 7411.629418529052, 7417.258274172539, 7481.064866891638, 898.4115404410122, 938.8732521109563, 1021.3922715983978, 1026.1790567546082, 1049.679847646475, 25220.621690674656, 26328.47343053128, 26415.867920660272, 26705.732942670715, 26866.462670746474, 1016.4054028393473, 1024.9180065594735, 1048.2505008918508, 1105.8396532502902, 1197.874223206568, 13272.73454530904, 13374.46502139923, 13428.462861485626, 13463.663408414868, 13473.730525389437, 303819.0, 304092.0, 305226.0, 307263.0, 307348.0, 48790.26814597784, 49078.0, 49150.0, 49157.75421122871, 49165.50834491681, 1208.9274643521417, 1220.0605533738972, 1223.565634199864, 1226.9815952760716, 1325.436689406998, 24288.0, 25152.37119072038, 26946.86526567433, 30064.3987120252, 30323.241918952204, 44964.0, 45284.54715452935, 45361.54638453573, 45415.54584454245, 45708.77145614251, 241267.0, 242860.0, 243317.0, 243345.0, 298346.0, 25643.230703078938, 30601.693983060773, 30987.070387888398, 31395.215119622193, 31440.0, 36003.81998089993, 36565.0, 36776.63223367839, 37186.25627487381, 37261.0, 28520.714792851806, 31023.224419389695, 31657.20856978594, 31721.682783171873, 32095.679043210203, 33526.0, 34300.656993429744, 34447.4832877512, 34539.48190777191, 34620.480692789126, 32854.0, 33317.50023749597, 33546.0, 33572.66427335793, 33651.0, 29622.55566166466, 30426.391472170875, 30627.23431914131, 30839.38321233518, 30912.53631195489, 23781.52436951286, 24247.636285456087, 25023.0, 25024.62463063019, 26906.59640105439], "unit": "score", "name": "ext.html", "value": 18180.891609518556}, {"lowerIsBetter": false, "replicates": [338.9000244927746, 346.7174252983818, 348.96510348965097, 350.4340490108475, 352.5487376158518, 16739.33042678293, 17446.738298925527, 17674.734878976793, 18140.546486337847, 18153.7276940846, 16430.424935127274, 16634.75047874283, 16717.164141792924, 16782.328706851742, 16792.32830686774, 5303.814366497164, 5327.387350454689, 5427.0, 5478.780848766045, 5484.040292948738, 5387.19192121181, 5440.891182176354, 5445.673259604417, 5447.4824891635235, 5453.64551304164, 3906.726529142961, 4235.788210589458, 5378.951104534617, 5396.865078373033, 5882.0, 5826.0, 5863.618864773819, 5884.499817515538, 5884.970575147118, 5887.941120588804, 5000.67495612784, 5041.924371134436, 5072.239164125411, 5075.111855425323, 5183.740812959337, 16085.758713619305, 17209.913950430167, 19274.71087933682, 19572.412827615193, 20246.898765506077, 2031.8886766496116, 2167.436466518701, 2200.3179014505554, 2244.371575958734, 2268.194790849258, 13134.60596182116, 13219.801702974368, 13250.138740981805, 13426.0, 13732.176069435865, 1742.634046850163, 1758.5427788774882, 1774.8136445673276, 1856.062688342392, 1856.7679040119986, 54121.72939135318, 57536.42463575352, 57603.71198144025, 61444.38555614431, 64704.67647661779, 9974.900250997542, 10089.445080520494, 10105.595776169019, 10131.290809643402, 10137.34107283039, 13085.411156497981, 13132.146410483288, 13139.54011609589, 13157.934210329078, 13186.142900711424, 7487.513311634726, 7539.660715267826, 7617.124030736425, 7695.538267703956, 7762.107357653829, 7628.86391810294, 7677.808054798563, 7680.500767450098, 7717.344025757873, 7739.883901741478, 4046.676265898721, 4168.145530166309, 4315.784210789448, 4354.586314300136, 4359.564043595615, 1617.5632579203784, 1653.0494965394946, 1684.6630673865277, 1730.2214003698386, 1761.6388640328703, 877.1184959116048, 906.5557876640398, 933.9439633622004, 956.7799406136488, 976.6825781621002, 13974.231417271943, 16350.75473867893, 16854.41009564659, 16982.23579938906, 17251.482455526355, 870.5864714260675, 885.822835432916, 925.3661242049218, 969.060011788564, 982.8132654795565, 9100.180983711498, 9323.813523729488, 9338.766530836647, 9387.436753794795, 9404.38871473352, 517990.0, 526220.0, 554208.0, 554973.0, 563088.0, 71062.0, 78951.0, 81325.0, 82098.0, 82314.17685823185, 1149.166854030821, 1154.3420250457327, 1163.4764356039984, 1173.0674114079327, 1176.7352345722315, 14749.926250368679, 15389.692206156038, 15455.149966751937, 15625.687486249984, 15773.526794196192, 33497.0, 34721.65278347184, 34814.303713926085, 35271.470927936614, 36589.81705091458, 43142.78428607837, 44604.0, 45329.0934181308, 46949.295760562934, 47322.76338618285, 8599.484030958163, 8890.95554522249, 8958.68644597436, 8972.955135224282, 8976.0, 10459.581616735246, 11634.6509604712, 16995.83004169992, 17185.74221386705, 17470.912645436692, 13890.791638125234, 14092.084014539023, 14210.78683819723, 14540.127592344494, 14668.55994320172, 13663.316834158451, 13823.79264311016, 14168.43326266979, 14352.354144063333, 14415.135091894519, 14615.342309596306, 14617.342219600356, 15149.697006059596, 15572.221388930282, 15626.921865390601, 9356.970733219205, 9514.857277140987, 9599.376040557341, 9633.470159141314, 9707.854382184132, 9646.469444180637, 9745.707628771148, 11244.718882028015, 14809.407623694931, 15151.696966060837], "unit": "score", "name": "jquery.html", "value": 8811.363095831108}, {"lowerIsBetter": false, "replicates": [1305.9347032648366, 1688.907110108944, 1758.4988278340675, 1761.8678599105067, 1810.1130446081424, 6774.187097548295, 7701.614919254036, 7740.071191457019, 7771.766846994585, 7814.179511151333, 7640.2741739534795, 7788.844223115534, 7799.493032952854, 7817.374610031198, 7819.960900195505, 2036.389083275019, 2073.8237249833783, 2205.0848897707433, 2205.6691496275607, 2236.206146817881, 2217.8225741940687, 2233.486298151426, 2239.2162743039967, 2239.697640818485, 2243.181238847825, 2172.2397160993605, 2243.6858839762444, 2245.1244014834147, 2248.6402175651897, 2251.133313674239, 2234.20685656592, 2263.2531264682616, 2269.8297627677907, 2296.2422400607925, 2297.310806757983, 2282.3723476044056, 2294.025039358266, 2299.54009198161, 2318.258157389636, 2323.2913961241816, 7733.6133193340675, 7809.219078092202, 7810.414218933603, 7819.296263336327, 7825.491343062739, 4608.0, 4706.647001474903, 4714.481407045222, 4719.10337035962, 4724.149653062447, 3001.5797788309656, 3009.1724775686644, 3039.316153865385, 3052.4658184817567, 3125.749940004817, 948.5636607160715, 951.2722767083187, 971.7619183300137, 973.2408721197477, 1015.5531566110961, 10699.946500267526, 10716.249862509627, 10753.51609177589, 10768.24622276441, 10777.353358798418, 4140.648044916155, 4167.124903770182, 4222.176675548239, 4226.809793559236, 4239.342901850218, 9155.816883662423, 9176.44941303524, 9193.908060919306, 9202.217811486098, 9220.170184683277, 4655.138799322136, 4680.976595117071, 4684.063187362541, 4712.858614241578, 4720.929186062212, 4295.892602684958, 4298.398224248608, 4300.80646370914, 4304.5910638489295, 4312.116016216668, 3399.184195792992, 3453.637368076366, 3567.8572857085946, 3596.2987217492337, 3684.042149041215, 1119.7256672115384, 1133.3369978562469, 1136.965891023254, 1138.1009002887793, 1146.3378101752492, 1027.1525991057258, 1039.2880876599554, 1042.0569384706853, 1182.7043239190202, 1358.7554240236852, 7047.119110111236, 7128.536645118051, 7144.9285507145305, 7190.352868241779, 7255.600941948138, 1087.9292845964987, 1092.0881064311388, 1099.983500247497, 1102.2835157147917, 1108.1633366808007, 5788.594798364158, 5858.619189752652, 5863.442972917566, 5863.560232982458, 5869.383714709979, 9101.40840845343, 9222.584983675752, 9388.483633400092, 9528.666496672584, 9544.0455954404, 9315.673951411669, 9349.90650093504, 9430.0, 9447.0, 9456.8581471278, 7325.523840950428, 7346.412287017026, 7400.074990626172, 7407.8888816667795, 7424.554526728413, 6991.056207411934, 7018.719251229893, 7026.473014524034, 7052.0832291801735, 7057.400120989773, 8151.429399942184, 8351.874721879298, 8442.240198382175, 8544.102869198645, 8588.355873309401, 8571.185737354941, 8581.699640512552, 8689.391742577958, 8704.0, 8714.69498567547, 6828.351306625863, 7002.404795592432, 7010.439164866696, 7018.6490675465, 7039.225685174524, 6784.08414863987, 6966.686499107451, 7108.182559005573, 7321.487495875238, 7386.298301661333, 6924.203716572659, 6924.961255811669, 7062.611556364449, 7073.115860517435, 7139.464540159405, 6983.930160698328, 7000.299970002959, 7062.364387204971, 7095.538789978635, 7160.319769621878, 7023.578585284899, 7066.893996589953, 7106.395956343768, 7124.821879453055, 7147.070880785673, 6286.245650521967, 6308.243010838729, 6336.017917222838, 6337.144485494399, 6370.617762934239, 6585.539012269095, 6609.570377925419, 6617.536772425884, 6618.2719900811835, 6625.933740662532], "unit": "score", "name": "mootools.html", "value": 4467.795463978039}, {"lowerIsBetter": false, "replicates": [333.3898964894243, 333.4498078171019, 334.4732047025933, 340.4773672412846, 340.4824666506908, 5846.736896839642, 5962.34414214436, 5964.105384192373, 6002.249718785158, 6043.335233124364, 5742.770289188438, 5931.584789064767, 5932.288125424944, 5934.139549765281, 5952.3750006249265, 4576.244919588264, 4580.244259697146, 4584.656150788687, 4589.380433641449, 4593.081383723252, 4410.735355878642, 4481.350204220403, 4485.327200919855, 4534.97732511337, 4572.9314060289125, 4480.417545719052, 4580.450345958489, 4609.193391156534, 4611.4696809866955, 4624.190766615846, 4574.977125114387, 4577.130345234412, 4594.908101837945, 4601.976990115028, 4604.884877878063, 4027.556968733437, 4029.4560234368278, 4039.151778126597, 4057.2494088593703, 4065.57311482296, 5548.472895074961, 5636.408177141382, 5664.6601203927485, 5676.148577713335, 5705.62913410627, 5257.947420525784, 5273.947260527384, 5273.947260527422, 5281.656692315026, 5281.947180528184, 6061.818145455643, 6300.747970081191, 6302.968485157545, 6315.684215789192, 6316.115743795872, 4231.386448964914, 4317.546657600969, 4372.846950356722, 4374.912501749947, 4411.845585404495, 6464.967675161641, 6508.926027205505, 6521.184851893513, 6525.3474652535315, 6534.248561415403, 4499.820007199741, 4504.774761261924, 4507.549245075466, 4508.932366014513, 4509.233430316854, 4474.843380481668, 4565.56627120423, 4570.063137056895, 4571.0, 4586.72479651222, 5267.473252674778, 5273.499017593323, 5277.366715994029, 5277.894442111136, 5284.39229488606, 6350.745970161234, 6353.872922541524, 6354.52341074412, 6356.872862542816, 6358.872822543616, 1604.9598760031092, 1623.6996155710995, 1623.951281461558, 1625.0168647968046, 1625.9512614363668, 1042.3224903812581, 1053.136428128927, 1053.8682664666917, 1057.7408534908843, 1086.625114335553, 6012.579119461683, 6024.367441418675, 6025.698715064229, 6066.636001839904, 6099.20710307666, 6526.086347911296, 6536.640484773383, 6538.313477084933, 6539.574927629689, 6551.312112228243, 5960.225170727777, 6074.665893375906, 6083.178770865965, 6088.726007329681, 6090.543209259324, 3530.2586456843837, 3549.6627820357025, 3550.55618047744, 3553.058439513531, 3553.431450967833, 6617.735290588419, 6618.371254730793, 6625.17185351831, 6629.933700662931, 6633.369829866155, 6664.266930637626, 6677.332266773284, 6677.866442671217, 6685.331466853276, 6690.565113267622, 6430.292667806538, 6596.241432235259, 6607.9669601651685, 6608.603483790892, 6610.471162307004, 6356.396142366468, 6496.902546461902, 6503.772367967098, 6508.219013718384, 6521.152250207443, 6398.456131228898, 6505.967470162619, 6516.348365163446, 6544.770933017321, 6560.507961902781, 6629.668516574248, 6662.700178492077, 6664.7000884959325, 6666.100076489612, 6675.132232809898, 4406.823727050882, 4451.221036318696, 4454.977725111354, 4459.710118842265, 4462.709923854939, 6448.355164483514, 6465.838354040999, 6506.869862602816, 6515.413612774873, 6528.445082167879, 6329.335419780857, 6334.271558770801, 6347.365263473615, 6351.2060992375955, 6353.777617783356, 6213.1922850029205, 6327.303996560283, 6330.177076979963, 6332.3034466207755, 6342.048692695948, 6194.38056194377, 6217.720202590804, 6223.782167624111, 6225.968870155621, 6226.782062627786, 6363.331850155667, 6364.872702546016, 6370.458511026614, 6371.490280777434, 6377.840553986188, 6057.273127224761, 6192.876142477216, 6195.19462469876, 6201.689915504297, 6204.751809927552], "unit": "score", "name": "prototype.html", "value": 4763.065937580041}, {"lowerIsBetter": false, "replicates": [734.9485536012479, 796.303234669664, 798.4450806689349, 808.6644042722271, 824.4146655874331, 13742.175469471838, 13864.237466939314, 13866.584002479916, 13893.0, 13946.511872084478, 14695.559133225994, 14807.703845923075, 14807.777883331759, 14810.407583696666, 14816.111033338007, 817.8446095241915, 835.8202986357932, 835.9038710548274, 836.6778790165799, 837.5519097282955, 689.396777819408, 701.5124488480508, 836.1554829622095, 852.2585350744861, 852.47146769003, 854.6965827131372, 877.1184959116111, 887.3167660901103, 888.8133491966695, 890.2477406591453, 713.9464540159457, 729.4456213277947, 856.5160684213431, 871.7341210930664, 882.629295695806, 520.1443625236465, 635.7012204264034, 645.3224114679615, 646.5635695905245, 646.7186773753432, 13378.264195469343, 13446.394912228972, 13476.595702128952, 13485.730285394335, 13500.729985400336, 11435.771284574263, 11755.0, 11883.465244063951, 12741.260628964817, 12824.80762788559, 10452.790944181073, 10478.685639430829, 10484.108850747696, 10545.683629491128, 10647.57409703611, 3518.1732292911147, 3571.589267234275, 3575.213453040327, 3594.7663401878795, 3613.765105268149, 47670.5232947673, 47785.52214477846, 47882.28176577354, 47907.76046119747, 47914.0, 9660.806783864284, 9806.460644664468, 9846.507674616241, 9889.159421449114, 10092.192624590016, 17543.0, 17623.383181588582, 17627.735583966252, 17637.50081243083, 17678.381256655954, 7428.702851885864, 7533.623318834037, 7537.660805263777, 7602.543847369176, 7678.500897441649, 4183.414321994923, 4223.53181870348, 4304.053108316165, 4402.603765661106, 4452.0873220989615, 3131.3424180921807, 3140.309131991004, 3157.6526582076413, 3160.0, 3164.9683503165134, 533.0165844017858, 542.8588566972616, 551.892380985712, 556.3824155187739, 556.966582005081, 512.2469969145351, 576.7087620751494, 578.6007654718231, 587.7443312159224, 598.5092224376057, 6972.860542789116, 7346.375558077516, 7509.436792240604, 7529.849403012018, 7557.244275572399, 471.1096028506126, 519.8388499565147, 520.5133200457584, 589.0927970924813, 601.6720887116531, 3734.066483379155, 3747.4004159334377, 3770.5852356240794, 3800.5059342285326, 3824.8661296855034, 51198.488015120114, 51775.22337164945, 52408.0, 61298.0, 61488.07767883485, 42976.35535466971, 43449.13101737948, 43527.0, 43629.56370436255, 49917.25124123141, 44001.339979900324, 44299.778501107285, 44725.55274447279, 45794.313085303744, 45910.31134532985, 8266.628001739817, 8438.240558349778, 8544.615492302986, 8653.956730216309, 8929.598168082583, 35225.29549409049, 35821.82089089538, 36006.45990310095, 36145.0, 36414.8179259102, 41467.1706565873, 41481.58518414777, 43578.0, 45122.323165153204, 45484.31773523334, 10253.538590763284, 10360.896391035993, 10764.838527422251, 10819.080378167944, 10954.890451095705, 11515.942420287845, 11693.889080537336, 12321.322327271728, 12461.688457788629, 12632.936835315764, 10653.573857045942, 10810.29733067348, 10947.83578246311, 11208.327500350006, 11839.348835814113, 10924.836127457935, 11130.387828669178, 11214.271072380268, 11402.429878506207, 11470.598529051444, 10584.259101863103, 10744.30162039465, 10807.837882431613, 10821.404822734825, 10939.195032819496, 9534.809303814023, 9620.904386862301, 9747.512624368896, 9853.359531630422, 10140.29017968735, 8880.378373513791, 8911.777205569913, 9536.952315238379, 9696.660616878375, 9823.0], "unit": "score", "name": "yui.html", "value": 6167.227544401908}], "name": "dromaeo_css", "value": 6947.294573714242}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 106.0, 112.0, 110.0, 112.0, 101.0, 110.0, 111.0, 117.0], "unit": "score", "name": "ai-astar", "value": 110.0}, {"lowerIsBetter": true, "replicates": [150.0, 131.0, 154.0, 167.0, 126.0, 149.0, 157.0, 126.0, 171.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 145.7}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 158.0, 159.0, 163.0, 160.0, 159.0, 161.0, 165.0, 170.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 87.0, 91.0, 73.0, 72.0, 71.0, 110.0, 97.0, 73.0], "unit": "score", "name": "audio-fft", "value": 81.6}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 145.0, 93.0, 92.0, 94.0, 135.0, 93.0, 93.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 106.6}, {"lowerIsBetter": true, "replicates": [111.0, 109.0, 109.0, 111.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [60.0, 57.0, 58.0, 56.0, 57.0, 57.0, 58.0, 66.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.9}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 67.0, 67.0, 67.0, 68.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [91.0, 84.0, 93.0, 85.0, 84.0, 83.0, 85.0, 87.0, 86.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [133.0, 125.0, 115.0, 117.0, 113.0, 127.0, 119.0, 122.0, 115.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.7}, {"lowerIsBetter": true, "replicates": [143.0, 152.0, 151.0, 158.0, 155.0, 146.0, 164.0, 143.0, 151.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 66.0, 69.0, 68.0, 69.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1508.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.59032952475576], "unit": "score", "name": "Richards", "value": 213.18877800000007}, {"lowerIsBetter": false, "replicates": [189.14318138831095], "unit": "score", "name": "DeltaBlue", "value": 349.565866}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [2032.520325203252], "unit": "score", "name": "RayTrace", "value": 364.0745880000001}, {"lowerIsBetter": false, "replicates": [783.6990595611285], "unit": "score", "name": "Earley", "value": 850.4067880000003}, {"lowerIsBetter": false, "replicates": [11964.285714285714], "unit": "score", "name": "Boyer", "value": 55.704370149253705}, {"lowerIsBetter": false, "replicates": [25974.358974358973], "unit": "score", "name": "RegExp", "value": 35.072472852912156}, {"lowerIsBetter": false, "replicates": [663.1299734748011], "unit": "score", "name": "Splay", "value": 122.88842799999998}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19652.012237266972}]} 23:08:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19652.01"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1508.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6947.30"}}} 23:08:36 INFO - Return code: 0 23:08:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:08:36 ERROR - # TBPL SUCCESS # 23:08:36 INFO - Running post-action listener: _resource_record_post_action 23:08:36 INFO - Running post-run listener: _resource_record_post_run 23:08:37 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 32768; Write bytes: 319291392; Read time: 312; Write time: 225892 23:08:37 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 8298496; Read time: 0; Write time: 664 23:08:37 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 32768; Write bytes: 310992896; Read time: 312; Write time: 225228 23:08:37 INFO - Running post-run listener: _upload_blobber_files 23:08:37 INFO - Blob upload gear active. 23:08:37 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:08:37 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:08:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:08:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:08:38 INFO - (blobuploader) - INFO - Open directory for files ... 23:08:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:08:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:08:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:08:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:08:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:08:39 INFO - (blobuploader) - INFO - Done attempting. 23:08:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:08:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:08:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:08:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:08:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:08:39 INFO - (blobuploader) - INFO - Done attempting. 23:08:39 INFO - (blobuploader) - INFO - Iteration through files over. 23:08:39 INFO - Return code: 0 23:08:39 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:08:39 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:08:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4f039de41d84980c07862d6afd0b416eed59fd2309f57a9de0d6ec7acd9f8679723c48fce65b3ec6ee3ed22ae634de5b2c911bf12616c17f1466f0671359b10", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10ee03d00173f6f39e37814fb046c81c7ee5dc1caf1838ae89f5af3f392759c28fd83681f3d398e6e0574489c1dbb79ab38ee51463723aa4137a913587e23382"} 23:08:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:08:39 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:08:39 INFO - Contents: 23:08:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4f039de41d84980c07862d6afd0b416eed59fd2309f57a9de0d6ec7acd9f8679723c48fce65b3ec6ee3ed22ae634de5b2c911bf12616c17f1466f0671359b10", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10ee03d00173f6f39e37814fb046c81c7ee5dc1caf1838ae89f5af3f392759c28fd83681f3d398e6e0574489c1dbb79ab38ee51463723aa4137a913587e23382"} 23:08:39 INFO - Copying logs to upload dir... 23:08:39 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1273.945796 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-21 23:08:39.843858) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 23:08:39.847534) ========= 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=a9e534cca236dfa67d42a089000001c1-1450763974.273791-935948795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4f039de41d84980c07862d6afd0b416eed59fd2309f57a9de0d6ec7acd9f8679723c48fce65b3ec6ee3ed22ae634de5b2c911bf12616c17f1466f0671359b10", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10ee03d00173f6f39e37814fb046c81c7ee5dc1caf1838ae89f5af3f392759c28fd83681f3d398e6e0574489c1dbb79ab38ee51463723aa4137a913587e23382"} build_url:https://queue.taskcluster.net/v1/task/XX-D3zUJQECVFWyjmqiRgQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011319 build_url: 'https://queue.taskcluster.net/v1/task/XX-D3zUJQECVFWyjmqiRgQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4f039de41d84980c07862d6afd0b416eed59fd2309f57a9de0d6ec7acd9f8679723c48fce65b3ec6ee3ed22ae634de5b2c911bf12616c17f1466f0671359b10", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10ee03d00173f6f39e37814fb046c81c7ee5dc1caf1838ae89f5af3f392759c28fd83681f3d398e6e0574489c1dbb79ab38ee51463723aa4137a913587e23382"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 23:08:39.872313) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 23:08:39.872623) ========= 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=a9e534cca236dfa67d42a089000001c1-1450763974.273791-935948795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 23:08:39.959123) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 23:08:39.959447) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 23:08:39.959767) ========= ========= Total master_lag: 0.23 =========