builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1452096711.12 results: success (0) buildid: 20160106053005 builduid: 96095daa61dc4db69264d846038cd53d revision: 44f79bbe2b515a2d27806ff23a23bbb4a9776e2e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 08:11:51.120922) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 08:11:51.121431) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 08:11:51.121781) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452096710.536507-1756438155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005607 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 08:11:51.145607) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 08:11:51.146021) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 08:11:51.160518) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 08:11:51.161021) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452096710.536507-1756438155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 08:11:51.212337) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 08:11:51.212675) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 08:11:51.213108) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 08:11:51.213417) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452096710.536507-1756438155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-06 08:11:51-- 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% 60.9M=0s 2016-01-06 08:11:51 (60.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100352 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 08:11:51.327524) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 08:11:51.327935) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452096710.536507-1756438155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020648 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 08:11:51.378770) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 08:11:51.379169) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 44f79bbe2b515a2d27806ff23a23bbb4a9776e2e --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 44f79bbe2b515a2d27806ff23a23bbb4a9776e2e --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=a4ce256d2ec601f24a60a71e000001bc-1452096710.536507-1756438155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-06 08:11:51,664 truncating revision to first 12 chars 2016-01-06 08:11:51,664 Setting DEBUG logging. 2016-01-06 08:11:51,664 attempt 1/10 2016-01-06 08:11:51,664 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/44f79bbe2b51?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-06 08:11:52,300 unpacking tar archive at: fx-team-44f79bbe2b51/testing/mozharness/ program finished with exit code 0 elapsedTime=0.906756 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 08:11:52.303272) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 08:11:52.303678) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 08:11:52.313648) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 08:11:52.314066) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 08:11:52.314537) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-06 08:11:52.314881) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1452096710.536507-1756438155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:11:52 INFO - MultiFileLogger online at 20160106 08:11:52 in /builds/slave/test-pgo 08:11:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:11:52 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:11:52 INFO - {'append_to_log': False, 08:11:52 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:11:52 INFO - 'blob_upload_branch': 'Fx-Team', 08:11:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:11:52 INFO - 'branch': 'Fx-Team', 08:11:52 INFO - 'buildbot_json_path': 'buildprops.json', 08:11:52 INFO - 'config_files': ('talos/linux_config.py',), 08:11:52 INFO - 'default_actions': ('clobber', 08:11:52 INFO - 'read-buildbot-config', 08:11:52 INFO - 'download-and-extract', 08:11:52 INFO - 'populate-webroot', 08:11:52 INFO - 'create-virtualenv', 08:11:52 INFO - 'install', 08:11:52 INFO - 'run-tests'), 08:11:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:11:52 INFO - 'download_minidump_stackwalk': True, 08:11:52 INFO - 'download_symbols': 'ondemand', 08:11:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:11:52 INFO - 'tooltool.py': '/tools/tooltool.py', 08:11:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:11:52 INFO - '/tools/misc-python/virtualenv.py')}, 08:11:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:11:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:11:52 INFO - 'installer_path': 'installer.exe', 08:11:52 INFO - 'log_level': 'info', 08:11:52 INFO - 'log_name': 'talos', 08:11:52 INFO - 'log_to_console': True, 08:11:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:11:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:11:52 INFO - 'opt_config_files': (), 08:11:52 INFO - 'pip_index': False, 08:11:52 INFO - 'sps_profile': False, 08:11:52 INFO - 'sps_profile_interval': 0, 08:11:52 INFO - 'suite': 'dromaeojs', 08:11:52 INFO - 'system_bits': '32', 08:11:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:11:52 INFO - 'title': 'talos-linux64-ix-062', 08:11:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:11:52 INFO - 'use_talos_json': True, 08:11:52 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:11:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:11:52 INFO - 'work_dir': 'build'} 08:11:52 INFO - ##### 08:11:52 INFO - ##### Running clobber step. 08:11:52 INFO - ##### 08:11:52 INFO - Running pre-action listener: _resource_record_pre_action 08:11:52 INFO - Running main action method: clobber 08:11:52 INFO - rmtree: /builds/slave/test-pgo/build 08:11:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:11:53 INFO - Running post-action listener: _resource_record_post_action 08:11:53 INFO - ##### 08:11:53 INFO - ##### Running read-buildbot-config step. 08:11:53 INFO - ##### 08:11:53 INFO - Running pre-action listener: _resource_record_pre_action 08:11:53 INFO - Running main action method: read_buildbot_config 08:11:53 INFO - Using buildbot properties: 08:11:53 INFO - { 08:11:53 INFO - "project": "", 08:11:53 INFO - "product": "firefox", 08:11:53 INFO - "script_repo_revision": "production", 08:11:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:11:53 INFO - "repository": "", 08:11:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:11:53 INFO - "buildid": "20160106053005", 08:11:53 INFO - "pgo_build": "True", 08:11:53 INFO - "basedir": "/builds/slave/test-pgo", 08:11:53 INFO - "buildnumber": 877, 08:11:53 INFO - "slavename": "talos-linux64-ix-062", 08:11:53 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:11:53 INFO - "platform": "ubuntu64_hw", 08:11:53 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:11:53 INFO - "branch": "fx-team", 08:11:53 INFO - "repo_path": "integration/fx-team", 08:11:53 INFO - "revision": "44f79bbe2b515a2d27806ff23a23bbb4a9776e2e", 08:11:53 INFO - "stage_platform": "linux64-pgo", 08:11:53 INFO - "builduid": "96095daa61dc4db69264d846038cd53d", 08:11:53 INFO - "slavebuilddir": "test" 08:11:53 INFO - } 08:11:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:11:53 INFO - Running post-action listener: _resource_record_post_action 08:11:53 INFO - ##### 08:11:53 INFO - ##### Running download-and-extract step. 08:11:53 INFO - ##### 08:11:53 INFO - Running pre-action listener: _resource_record_pre_action 08:11:53 INFO - Running main action method: download_and_extract 08:11:53 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:53 INFO - https://queue.taskcluster.net/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:11:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/artifacts/public/build/test_packages.json 08:11:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/artifacts/public/build/test_packages.json 08:11:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:11:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:11:54 INFO - Downloaded 1302 bytes. 08:11:54 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:11:54 INFO - Using the following test package requirements: 08:11:54 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:11:54 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:11:54 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:54 INFO - u'jsshell-linux-x86_64.zip'], 08:11:54 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:11:54 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:11:54 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:11:54 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:11:54 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:11:54 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:11:54 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:11:54 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:54 INFO - https://queue.taskcluster.net/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:11:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:11:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:11:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/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 08:11:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/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 08:11:57 INFO - Downloaded 24097693 bytes. 08:11:57 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 08:11:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:11:57 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 08:11:58 INFO - Return code: 0 08:11:58 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 08:11: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')]} 08:11:58 INFO - https://queue.taskcluster.net/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:11:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:11:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:11:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/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 08:11:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/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 08:12:01 INFO - Downloaded 24097693 bytes. 08:12:01 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 08:12:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:12:01 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 08:12:02 INFO - Return code: 0 08:12: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')]} 08:12:02 INFO - https://queue.taskcluster.net/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:12:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:12:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:12:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/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 08:12:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/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 08:12:03 INFO - Downloaded 11132285 bytes. 08:12:03 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 08:12:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:12:03 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 08:12:03 INFO - Return code: 0 08:12:03 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')]} 08:12:03 INFO - https://queue.taskcluster.net/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:12:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:12:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:12:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/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 08:12:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/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 08:12:08 INFO - Downloaded 55068349 bytes. 08:12:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:12:08 INFO - mkdir: /builds/slave/test-pgo/properties 08:12:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:12:08 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:12:08 INFO - Contents: 08:12:08 INFO - build_url:https://queue.taskcluster.net/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:12:08 INFO - Running post-action listener: _resource_record_post_action 08:12:08 INFO - Running post-action listener: set_extra_try_arguments 08:12:08 INFO - ##### 08:12:08 INFO - ##### Running populate-webroot step. 08:12:08 INFO - ##### 08:12:08 INFO - Running pre-action listener: _resource_record_pre_action 08:12:08 INFO - Running main action method: populate_webroot 08:12:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:12:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:12:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:12:08 INFO - '--tppagecycles', 08:12:08 INFO - '7'], 08:12:08 INFO - 'tests': ['tsvgm']}}, 08:12:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:12:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:12:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:12:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:12:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:12:08 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:12:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:12:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:08 INFO - 'talos_options': ['--e10s'], 08:12:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:12:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:08 INFO - 'tests': ['damp', 'tps']}, 08:12:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:08 INFO - 'talos_options': ['--e10s'], 08:12:08 INFO - 'tests': ['damp', 'tps']}, 08:12:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:12:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:12:08 INFO - 'other': {'tests': ['a11yr', 08:12:08 INFO - 'ts_paint', 08:12:08 INFO - 'tpaint', 08:12:08 INFO - 'sessionrestore', 08:12:08 INFO - 'sessionrestore_no_auto_restore']}, 08:12:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:12:08 INFO - 'tests': ['a11yr', 08:12:08 INFO - 'ts_paint', 08:12:08 INFO - 'tpaint', 08:12:08 INFO - 'sessionrestore', 08:12:08 INFO - 'sessionrestore_no_auto_restore']}, 08:12:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:12:08 INFO - 'tests': ['a11yr', 08:12:08 INFO - 'ts_paint', 08:12:08 INFO - 'tpaint', 08:12:08 INFO - 'sessionrestore', 08:12:08 INFO - 'sessionrestore_no_auto_restore']}, 08:12:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:12:08 INFO - 'tests': ['a11yr', 08:12:08 INFO - 'ts_paint', 08:12:08 INFO - 'tpaint', 08:12:08 INFO - 'sessionrestore', 08:12:08 INFO - 'sessionrestore_no_auto_restore']}, 08:12:08 INFO - 'other_l64': {'tests': ['a11yr', 08:12:08 INFO - 'ts_paint', 08:12:08 INFO - 'tpaint', 08:12:08 INFO - 'sessionrestore', 08:12:08 INFO - 'sessionrestore_no_auto_restore']}, 08:12:08 INFO - 'other_nol64': {'tests': ['a11yr', 08:12:08 INFO - 'ts_paint', 08:12:08 INFO - 'tpaint', 08:12:08 INFO - 'sessionrestore', 08:12:08 INFO - 'sessionrestore_no_auto_restore']}, 08:12:08 INFO - 'svgr': {'tests': ['tsvgx', 08:12:08 INFO - 'tsvgr_opacity', 08:12:08 INFO - 'tart', 08:12:08 INFO - 'tscrollx', 08:12:08 INFO - 'cart']}, 08:12:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:12:08 INFO - 'tests': ['tsvgx', 08:12:08 INFO - 'tsvgr_opacity', 08:12:08 INFO - 'tart', 08:12:08 INFO - 'tscrollx', 08:12:08 INFO - 'cart']}, 08:12:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:08 INFO - 'tests': ['tp5o']}, 08:12:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:08 INFO - 'talos_options': ['--e10s'], 08:12:08 INFO - 'tests': ['tp5o']}, 08:12:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:08 INFO - 'talos_options': ['--xperf_path', 08:12:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:12:08 INFO - 'tests': ['tp5n']}, 08:12:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:08 INFO - 'talos_options': ['--e10s', 08:12:08 INFO - '--xperf_path', 08:12:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:12:08 INFO - 'tests': ['tp5n']}}, 08:12:08 INFO - 'talos.zip': {'path': '', 08:12:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:12:08 INFO - Running post-action listener: _resource_record_post_action 08:12:08 INFO - ##### 08:12:08 INFO - ##### Running create-virtualenv step. 08:12:08 INFO - ##### 08:12:08 INFO - Running pre-action listener: _resource_record_pre_action 08:12:08 INFO - Running main action method: create_virtualenv 08:12:08 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:12:08 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 08:12:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:12:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:12:08 INFO - Using real prefix '/usr' 08:12:08 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:12:08 INFO - Installing distribute.............................................................................................................................................................................................done. 08:12:10 INFO - Installing pip.................done. 08:12:10 INFO - Return code: 0 08:12:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:12:10 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')]} 08:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:10 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')]} 08:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:10 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 0x7f063e9d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aff840>, '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 0x1a6c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6cb60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452096710.536507-1756438155', '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 08:12:10 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 08:12:10 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 08:12:10 INFO - Using env: {'DISPLAY': ':0', 08:12:10 INFO - 'HOME': '/home/cltbld', 08:12:10 INFO - 'LANG': 'en_US.UTF-8', 08:12:10 INFO - 'LANGUAGE': 'en_US:en', 08:12:10 INFO - 'LOGNAME': 'cltbld', 08:12:10 INFO - 'MAIL': '/var/mail/cltbld', 08:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:10 INFO - 'MOZ_NO_REMOTE': '1', 08:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:10 INFO - 'NO_EM_RESTART': '1', 08:12:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:12:10 INFO - 'PWD': '/builds/slave/test-pgo', 08:12:10 INFO - 'SHELL': '/bin/bash', 08:12:10 INFO - 'SHLVL': '1', 08:12:10 INFO - 'TERM': 'linux', 08:12:10 INFO - 'TMOUT': '86400', 08:12:10 INFO - 'USER': 'cltbld', 08:12:10 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452096710.536507-1756438155', 08:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:10 INFO - '_': '/tools/buildbot/bin/python'} 08:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:10 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 08:12:10 INFO - Cleaning up... 08:12:10 INFO - Return code: 0 08:12:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:12:10 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')]} 08:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:10 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')]} 08:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:10 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 0x7f063e9d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aff840>, '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 0x1a6c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6cb60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452096710.536507-1756438155', '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 08:12:10 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 08:12:10 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 08:12:10 INFO - Using env: {'DISPLAY': ':0', 08:12:10 INFO - 'HOME': '/home/cltbld', 08:12:10 INFO - 'LANG': 'en_US.UTF-8', 08:12:10 INFO - 'LANGUAGE': 'en_US:en', 08:12:10 INFO - 'LOGNAME': 'cltbld', 08:12:10 INFO - 'MAIL': '/var/mail/cltbld', 08:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:10 INFO - 'MOZ_NO_REMOTE': '1', 08:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:10 INFO - 'NO_EM_RESTART': '1', 08:12:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:12:10 INFO - 'PWD': '/builds/slave/test-pgo', 08:12:10 INFO - 'SHELL': '/bin/bash', 08:12:10 INFO - 'SHLVL': '1', 08:12:10 INFO - 'TERM': 'linux', 08:12:10 INFO - 'TMOUT': '86400', 08:12:10 INFO - 'USER': 'cltbld', 08:12:10 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452096710.536507-1756438155', 08:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:10 INFO - '_': '/tools/buildbot/bin/python'} 08:12:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:11 INFO - Downloading/unpacking psutil>=0.7.1 08:12:11 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 08:12:11 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 08:12:11 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 08:12:11 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 08:12:11 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 08:12:11 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 08:12:12 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 08:12:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:12:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:12:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:12:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:12:13 INFO - Installing collected packages: psutil 08:12:13 INFO - Running setup.py install for psutil 08:12:13 INFO - building 'psutil._psutil_linux' extension 08:12:13 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 08:12:13 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 08:12:13 INFO - building 'psutil._psutil_posix' extension 08:12:13 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 08:12:13 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 08:12:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:12:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:12:13 INFO - Successfully installed psutil 08:12:13 INFO - Cleaning up... 08:12:13 INFO - Return code: 0 08:12:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:12:13 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')]} 08:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:13 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')]} 08:12:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:13 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 0x7f063e9d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aff840>, '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 0x1a6c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6cb60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452096710.536507-1756438155', '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 08:12:13 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 08:12:13 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 08:12:13 INFO - Using env: {'DISPLAY': ':0', 08:12:13 INFO - 'HOME': '/home/cltbld', 08:12:13 INFO - 'LANG': 'en_US.UTF-8', 08:12:13 INFO - 'LANGUAGE': 'en_US:en', 08:12:13 INFO - 'LOGNAME': 'cltbld', 08:12:13 INFO - 'MAIL': '/var/mail/cltbld', 08:12:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:13 INFO - 'MOZ_NO_REMOTE': '1', 08:12:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:13 INFO - 'NO_EM_RESTART': '1', 08:12:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:12:13 INFO - 'PWD': '/builds/slave/test-pgo', 08:12:13 INFO - 'SHELL': '/bin/bash', 08:12:13 INFO - 'SHLVL': '1', 08:12:13 INFO - 'TERM': 'linux', 08:12:13 INFO - 'TMOUT': '86400', 08:12:13 INFO - 'USER': 'cltbld', 08:12:13 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452096710.536507-1756438155', 08:12:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:13 INFO - '_': '/tools/buildbot/bin/python'} 08:12:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:12:13 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 08:12:13 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 08:12:13 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 08:12:13 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 08:12:13 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 08:12:13 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 08:12:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:12:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:12:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:12:15 INFO - Installing collected packages: mozsystemmonitor 08:12:15 INFO - Running setup.py install for mozsystemmonitor 08:12:15 INFO - Successfully installed mozsystemmonitor 08:12:15 INFO - Cleaning up... 08:12:15 INFO - Return code: 0 08:12:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f063e9d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aff840>, '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 0x1a6c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6cb60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452096710.536507-1756438155', '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 08:12:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 08:12:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:12:15 INFO - Using env: {'DISPLAY': ':0', 08:12:15 INFO - 'HOME': '/home/cltbld', 08:12:15 INFO - 'LANG': 'en_US.UTF-8', 08:12:15 INFO - 'LANGUAGE': 'en_US:en', 08:12:15 INFO - 'LOGNAME': 'cltbld', 08:12:15 INFO - 'MAIL': '/var/mail/cltbld', 08:12:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:15 INFO - 'MOZ_NO_REMOTE': '1', 08:12:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:15 INFO - 'NO_EM_RESTART': '1', 08:12:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:12:15 INFO - 'PWD': '/builds/slave/test-pgo', 08:12:15 INFO - 'SHELL': '/bin/bash', 08:12:15 INFO - 'SHLVL': '1', 08:12:15 INFO - 'TERM': 'linux', 08:12:15 INFO - 'TMOUT': '86400', 08:12:15 INFO - 'USER': 'cltbld', 08:12:15 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452096710.536507-1756438155', 08:12:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:15 INFO - '_': '/tools/buildbot/bin/python'} 08:12:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:15 INFO - Downloading/unpacking blobuploader==1.2.4 08:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:17 INFO - Downloading blobuploader-1.2.4.tar.gz 08:12:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:12:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:12:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:12:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:12:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:12:18 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 08:12:18 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 08:12:18 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 08:12:18 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 08:12:18 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 08:12:18 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 08:12:18 INFO - Downloading docopt-0.6.1.tar.gz 08:12:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:12:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:12:18 INFO - Installing collected packages: blobuploader, requests, docopt 08:12:18 INFO - Running setup.py install for blobuploader 08:12:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:12:18 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:12:18 INFO - Running setup.py install for requests 08:12:18 INFO - Running setup.py install for docopt 08:12:18 INFO - Successfully installed blobuploader requests docopt 08:12:18 INFO - Cleaning up... 08:12:18 INFO - Return code: 0 08:12:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:12:18 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')]} 08:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:18 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')]} 08:12:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:18 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 0x7f063e9d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aff840>, '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 0x1a6c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6cb60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452096710.536507-1756438155', '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 08:12:18 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 08:12:18 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 08:12:18 INFO - Using env: {'DISPLAY': ':0', 08:12:18 INFO - 'HOME': '/home/cltbld', 08:12:18 INFO - 'LANG': 'en_US.UTF-8', 08:12:18 INFO - 'LANGUAGE': 'en_US:en', 08:12:18 INFO - 'LOGNAME': 'cltbld', 08:12:18 INFO - 'MAIL': '/var/mail/cltbld', 08:12:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:18 INFO - 'MOZ_NO_REMOTE': '1', 08:12:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:18 INFO - 'NO_EM_RESTART': '1', 08:12:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:12:18 INFO - 'PWD': '/builds/slave/test-pgo', 08:12:18 INFO - 'SHELL': '/bin/bash', 08:12:18 INFO - 'SHLVL': '1', 08:12:18 INFO - 'TERM': 'linux', 08:12:18 INFO - 'TMOUT': '86400', 08:12:18 INFO - 'USER': 'cltbld', 08:12:18 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452096710.536507-1756438155', 08:12:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:18 INFO - '_': '/tools/buildbot/bin/python'} 08:12:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:12:19 INFO - Running setup.py (path:/tmp/pip-IWGeDS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:12:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:12:19 INFO - Running setup.py (path:/tmp/pip-GkP9Vd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:12:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:12:19 INFO - Running setup.py (path:/tmp/pip-0LYr8C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:12:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:12:19 INFO - Running setup.py (path:/tmp/pip-oKZO5_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:12:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:12:19 INFO - Running setup.py (path:/tmp/pip-0uzh6s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:12:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:12:19 INFO - Running setup.py (path:/tmp/pip-kOrWff-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:12:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:12:19 INFO - Running setup.py (path:/tmp/pip-_GAvD3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:12:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:12:19 INFO - Running setup.py (path:/tmp/pip-H2u6aJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:12:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:12:19 INFO - Running setup.py (path:/tmp/pip-BAxpQ2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:12:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:12:19 INFO - Running setup.py (path:/tmp/pip-a6OaTz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:12:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:12:19 INFO - Running setup.py (path:/tmp/pip-RpDfku-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:12:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:12:19 INFO - Running setup.py (path:/tmp/pip-Yfruqy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:12:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:12:20 INFO - Running setup.py (path:/tmp/pip-ic7u5_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:12:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:12:20 INFO - Running setup.py (path:/tmp/pip-gZnGfA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:12:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:12:20 INFO - Running setup.py (path:/tmp/pip-7THq9h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:12:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:12:20 INFO - Running setup.py (path:/tmp/pip-XNo1Pb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:12:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:12:20 INFO - Running setup.py (path:/tmp/pip-04GGqj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:12:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:12:20 INFO - Running setup.py install for manifestparser 08:12:20 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:12:20 INFO - Running setup.py install for mozcrash 08:12:20 INFO - Running setup.py install for mozdebug 08:12:20 INFO - Running setup.py install for mozdevice 08:12:20 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:12:20 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:12:20 INFO - Running setup.py install for mozfile 08:12:20 INFO - Running setup.py install for mozhttpd 08:12:20 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:12:20 INFO - Running setup.py install for mozinfo 08:12:21 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:12:21 INFO - Running setup.py install for mozInstall 08:12:21 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:12:21 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:12:21 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:12:21 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:12:21 INFO - Running setup.py install for mozleak 08:12:21 INFO - Running setup.py install for mozlog 08:12:21 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:12:21 INFO - Running setup.py install for moznetwork 08:12:21 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:12:21 INFO - Running setup.py install for mozprocess 08:12:21 INFO - Running setup.py install for mozprofile 08:12:21 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:12:21 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:12:21 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:12:21 INFO - Running setup.py install for mozrunner 08:12:21 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:12:21 INFO - Running setup.py install for mozscreenshot 08:12:21 INFO - Running setup.py install for moztest 08:12:22 INFO - Running setup.py install for mozversion 08:12:22 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:12:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:12:22 INFO - Cleaning up... 08:12:22 INFO - Return code: 0 08:12:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f063e9d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aff840>, '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 0x1a6c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6cb60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452096710.536507-1756438155', '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 08:12:22 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 08:12:22 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 08:12:22 INFO - Using env: {'DISPLAY': ':0', 08:12:22 INFO - 'HOME': '/home/cltbld', 08:12:22 INFO - 'LANG': 'en_US.UTF-8', 08:12:22 INFO - 'LANGUAGE': 'en_US:en', 08:12:22 INFO - 'LOGNAME': 'cltbld', 08:12:22 INFO - 'MAIL': '/var/mail/cltbld', 08:12:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:22 INFO - 'MOZ_NO_REMOTE': '1', 08:12:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:22 INFO - 'NO_EM_RESTART': '1', 08:12:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:12:22 INFO - 'PWD': '/builds/slave/test-pgo', 08:12:22 INFO - 'SHELL': '/bin/bash', 08:12:22 INFO - 'SHLVL': '1', 08:12:22 INFO - 'TERM': 'linux', 08:12:22 INFO - 'TMOUT': '86400', 08:12:22 INFO - 'USER': 'cltbld', 08:12:22 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452096710.536507-1756438155', 08:12:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:22 INFO - '_': '/tools/buildbot/bin/python'} 08:12:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:12:22 INFO - Running setup.py (path:/tmp/pip-rxu_em-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:12:22 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)) 08:12:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:12:22 INFO - Running setup.py (path:/tmp/pip-TxjlUL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:12:22 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)) 08:12:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:12:22 INFO - Running setup.py (path:/tmp/pip-mF7VhQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:12:22 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)) 08:12:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:12:22 INFO - Running setup.py (path:/tmp/pip-Cu99JP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:12:22 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)) 08:12:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:12:22 INFO - Running setup.py (path:/tmp/pip-0bX293-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:12:22 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)) 08:12:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:12:22 INFO - Running setup.py (path:/tmp/pip-Miah1n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:12:22 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)) 08:12:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:12:22 INFO - Running setup.py (path:/tmp/pip-yQQiI2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:12:22 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)) 08:12:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:12:22 INFO - Running setup.py (path:/tmp/pip-3Oqxmy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:12:22 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)) 08:12:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:12:22 INFO - Running setup.py (path:/tmp/pip-Lo2wan-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:12:22 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)) 08:12:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:12:23 INFO - Running setup.py (path:/tmp/pip-bo_gU2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:12:23 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)) 08:12:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:12:23 INFO - Running setup.py (path:/tmp/pip-seekRf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:12:23 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)) 08:12:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:12:23 INFO - Running setup.py (path:/tmp/pip-mS1QeX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:12:23 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)) 08:12:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:12:23 INFO - Running setup.py (path:/tmp/pip-oKQViw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:12:23 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)) 08:12:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:12:23 INFO - Running setup.py (path:/tmp/pip-abXtJO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:12:23 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)) 08:12:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:12:23 INFO - Running setup.py (path:/tmp/pip-7YpAjO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:12:23 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)) 08:12:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:12:23 INFO - Running setup.py (path:/tmp/pip-3GUOAW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:12:23 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)) 08:12:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:12:23 INFO - Running setup.py (path:/tmp/pip-vU9kxB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:12:23 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)) 08:12:23 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)) 08:12:23 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)) 08:12:23 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)) 08:12:23 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)) 08:12:23 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)) 08:12:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:12:23 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 08:12:23 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 08:12:23 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 08:12:23 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 08:12:23 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 08:12:23 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 08:12:25 INFO - Downloading blessings-1.5.1.tar.gz 08:12:25 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 08:12:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:12:25 INFO - Installing collected packages: blessings 08:12:25 INFO - Running setup.py install for blessings 08:12:25 INFO - Successfully installed blessings 08:12:25 INFO - Cleaning up... 08:12:25 INFO - Return code: 0 08:12:25 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:12:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:12:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:12:25 INFO - Reading from file tmpfile_stdout 08:12:25 INFO - Current package versions: 08:12:25 INFO - argparse == 1.2.1 08:12:25 INFO - blessings == 1.5.1 08:12:25 INFO - blobuploader == 1.2.4 08:12:25 INFO - docopt == 0.6.1 08:12:25 INFO - manifestparser == 1.1 08:12:25 INFO - mozInstall == 1.12 08:12:25 INFO - mozcrash == 0.16 08:12:25 INFO - mozdebug == 0.1 08:12:25 INFO - mozdevice == 0.47 08:12:25 INFO - mozfile == 1.2 08:12:25 INFO - mozhttpd == 0.7 08:12:25 INFO - mozinfo == 0.9 08:12:25 INFO - mozleak == 0.1 08:12:25 INFO - mozlog == 3.1 08:12:25 INFO - moznetwork == 0.27 08:12:25 INFO - mozprocess == 0.22 08:12:25 INFO - mozprofile == 0.28 08:12:25 INFO - mozrunner == 6.11 08:12:25 INFO - mozscreenshot == 0.1 08:12:25 INFO - mozsystemmonitor == 0.0 08:12:25 INFO - moztest == 0.7 08:12:25 INFO - mozversion == 1.4 08:12:25 INFO - psutil == 3.1.1 08:12:25 INFO - requests == 1.2.3 08:12:25 INFO - wsgiref == 0.1.2 08:12:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:12:25 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')]} 08:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:25 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')]} 08:12:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:25 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 0x7f063e9d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aff840>, '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 0x1a6c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6cb60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452096710.536507-1756438155', '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 08:12:25 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 08:12:25 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 08:12:25 INFO - Using env: {'DISPLAY': ':0', 08:12:25 INFO - 'HOME': '/home/cltbld', 08:12:25 INFO - 'LANG': 'en_US.UTF-8', 08:12:25 INFO - 'LANGUAGE': 'en_US:en', 08:12:25 INFO - 'LOGNAME': 'cltbld', 08:12:25 INFO - 'MAIL': '/var/mail/cltbld', 08:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:25 INFO - 'MOZ_NO_REMOTE': '1', 08:12:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:25 INFO - 'NO_EM_RESTART': '1', 08:12:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:12:25 INFO - 'PWD': '/builds/slave/test-pgo', 08:12:25 INFO - 'SHELL': '/bin/bash', 08:12:25 INFO - 'SHLVL': '1', 08:12:25 INFO - 'TERM': 'linux', 08:12:25 INFO - 'TMOUT': '86400', 08:12:25 INFO - 'USER': 'cltbld', 08:12:25 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452096710.536507-1756438155', 08:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:25 INFO - '_': '/tools/buildbot/bin/python'} 08:12:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:25 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)) 08:12:25 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)) 08:12:25 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)) 08:12:25 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)) 08:12:25 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)) 08:12:25 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)) 08:12:25 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)) 08:12:25 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)) 08:12:25 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)) 08:12:25 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)) 08:12:25 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)) 08:12:25 INFO - Cleaning up... 08:12:25 INFO - Return code: 0 08:12:25 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:12:25 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')]} 08:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:25 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')]} 08:12:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:25 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 0x7f063e9d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aff840>, '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 0x1a6c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6cb60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452096710.536507-1756438155', '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 08:12:25 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 08:12:25 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 08:12:25 INFO - Using env: {'DISPLAY': ':0', 08:12:25 INFO - 'HOME': '/home/cltbld', 08:12:25 INFO - 'LANG': 'en_US.UTF-8', 08:12:25 INFO - 'LANGUAGE': 'en_US:en', 08:12:25 INFO - 'LOGNAME': 'cltbld', 08:12:25 INFO - 'MAIL': '/var/mail/cltbld', 08:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:25 INFO - 'MOZ_NO_REMOTE': '1', 08:12:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:25 INFO - 'NO_EM_RESTART': '1', 08:12:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:12:25 INFO - 'PWD': '/builds/slave/test-pgo', 08:12:25 INFO - 'SHELL': '/bin/bash', 08:12:25 INFO - 'SHLVL': '1', 08:12:25 INFO - 'TERM': 'linux', 08:12:25 INFO - 'TMOUT': '86400', 08:12:25 INFO - 'USER': 'cltbld', 08:12:25 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452096710.536507-1756438155', 08:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:25 INFO - '_': '/tools/buildbot/bin/python'} 08:12:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:26 INFO - Downloading/unpacking jsonschema 08:12:26 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 08:12:26 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 08:12:26 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 08:12:26 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 08:12:26 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 08:12:26 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 08:12:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:12:27 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 08:12:27 INFO - Downloading/unpacking functools32 (from jsonschema) 08:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:28 INFO - Downloading functools32-3.2.3-2.tar.gz 08:12:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:12:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:12:28 INFO - warning: no files found matching '*.txt' 08:12:28 INFO - no previously-included directories found matching 'build' 08:12:28 INFO - no previously-included directories found matching 'dist' 08:12:28 INFO - no previously-included directories found matching '.git*' 08:12:28 INFO - Installing collected packages: jsonschema, functools32 08:12:28 INFO - Running setup.py install for functools32 08:12:28 INFO - warning: no files found matching '*.txt' 08:12:28 INFO - no previously-included directories found matching 'build' 08:12:28 INFO - no previously-included directories found matching 'dist' 08:12:28 INFO - no previously-included directories found matching '.git*' 08:12:28 INFO - Successfully installed jsonschema functools32 08:12:28 INFO - Cleaning up... 08:12:28 INFO - Return code: 0 08:12:28 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:12:28 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')]} 08:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:28 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')]} 08:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:28 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 0x7f063e9d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aff840>, '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 0x1a6c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6cb60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452096710.536507-1756438155', '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 08:12:28 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 08:12:28 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 08:12:28 INFO - Using env: {'DISPLAY': ':0', 08:12:28 INFO - 'HOME': '/home/cltbld', 08:12:28 INFO - 'LANG': 'en_US.UTF-8', 08:12:28 INFO - 'LANGUAGE': 'en_US:en', 08:12:28 INFO - 'LOGNAME': 'cltbld', 08:12:28 INFO - 'MAIL': '/var/mail/cltbld', 08:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:28 INFO - 'MOZ_NO_REMOTE': '1', 08:12:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:28 INFO - 'NO_EM_RESTART': '1', 08:12:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:12:28 INFO - 'PWD': '/builds/slave/test-pgo', 08:12:28 INFO - 'SHELL': '/bin/bash', 08:12:28 INFO - 'SHLVL': '1', 08:12:28 INFO - 'TERM': 'linux', 08:12:28 INFO - 'TMOUT': '86400', 08:12:28 INFO - 'USER': 'cltbld', 08:12:28 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452096710.536507-1756438155', 08:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:28 INFO - '_': '/tools/buildbot/bin/python'} 08:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:28 INFO - Downloading/unpacking flake8 08:12:28 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 08:12:28 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 08:12:28 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 08:12:28 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 08:12:28 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 08:12:28 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 08:12:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:12:30 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 08:12:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:12:30 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 08:12:30 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 08:12:30 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 08:12:30 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 08:12:30 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 08:12:30 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 08:12:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:12:30 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 08:12:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:12:30 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 08:12:30 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 08:12:30 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 08:12:30 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 08:12:30 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 08:12:30 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 08:12:30 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 08:12:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:12:30 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 08:12:30 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 08:12:30 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 08:12:30 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 08:12:30 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 08:12:30 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 08:12:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:12:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:12:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:12:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:12:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:12:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:12:30 INFO - no previously-included directories found matching 'docs/_build' 08:12:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:12:31 INFO - Running setup.py install for pep8 08:12:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:12:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:12:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:12:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:12:31 INFO - no previously-included directories found matching 'docs/_build' 08:12:31 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:12:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:12:31 INFO - Cleaning up... 08:12:31 INFO - Return code: 0 08:12:31 INFO - Running post-action listener: _resource_record_post_action 08:12:31 INFO - Running post-action listener: _start_resource_monitoring 08:12:31 INFO - Starting resource monitoring. 08:12:31 INFO - ##### 08:12:31 INFO - ##### Running install step. 08:12:31 INFO - ##### 08:12:31 INFO - Running pre-action listener: _resource_record_pre_action 08:12:31 INFO - Running main action method: install 08:12:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:12:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:12:31 INFO - Reading from file tmpfile_stdout 08:12:31 INFO - Detecting whether we're running mozinstall >=1.0... 08:12:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:12:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:12:31 INFO - Reading from file tmpfile_stdout 08:12:31 INFO - Output received: 08:12:31 INFO - Usage: mozinstall [options] installer 08:12:31 INFO - Options: 08:12:31 INFO - -h, --help show this help message and exit 08:12:31 INFO - -d DEST, --destination=DEST 08:12:31 INFO - Directory to install application into. [default: 08:12:31 INFO - "/builds/slave/test-pgo"] 08:12:31 INFO - --app=APP Application being installed. [default: firefox] 08:12:31 INFO - mkdir: /builds/slave/test-pgo/build/application 08:12:31 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'] 08:12:31 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 08:12:47 INFO - Reading from file tmpfile_stdout 08:12:47 INFO - Output received: 08:12:47 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:12:47 INFO - Running post-action listener: _resource_record_post_action 08:12:47 INFO - ##### 08:12:47 INFO - ##### Running run-tests step. 08:12:47 INFO - ##### 08:12:47 INFO - Running pre-action listener: _resource_record_pre_action 08:12:47 INFO - Running main action method: run_tests 08:12:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:12:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:12:47 INFO - Python 2.7.3 08:12:47 INFO - Return code: 0 08:12:47 INFO - grabbing minidump binary from tooltool 08:12: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')]} 08:12:47 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 0x1aff840>, '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 0x1a6c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6cb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:12:47 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 08:12:47 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 08:12:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:12:47 INFO - Return code: 0 08:12:47 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:12:47 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:12:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:12:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:12:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:12:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:12:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:12:48 INFO - Return code: 0 08:12:48 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/NJR5g7nuSK2YF5Rlz9LIlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 08:12:48 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/NJR5g7nuSK2YF5Rlz9LIlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 08:12:48 INFO - Using env: {'DISPLAY': ':0', 08:12:48 INFO - 'HOME': '/home/cltbld', 08:12:48 INFO - 'LANG': 'en_US.UTF-8', 08:12:48 INFO - 'LANGUAGE': 'en_US:en', 08:12:48 INFO - 'LOGNAME': 'cltbld', 08:12:48 INFO - 'MAIL': '/var/mail/cltbld', 08:12:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:12:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:48 INFO - 'MOZ_NO_REMOTE': '1', 08:12:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:48 INFO - 'NO_EM_RESTART': '1', 08:12:48 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:12:48 INFO - 'PWD': '/builds/slave/test-pgo', 08:12:48 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:12:48 INFO - 'SHELL': '/bin/bash', 08:12:48 INFO - 'SHLVL': '1', 08:12:48 INFO - 'TERM': 'linux', 08:12:48 INFO - 'TMOUT': '86400', 08:12:48 INFO - 'USER': 'cltbld', 08:12:48 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452096710.536507-1756438155', 08:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:48 INFO - '_': '/tools/buildbot/bin/python'} 08:12:48 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/NJR5g7nuSK2YF5Rlz9LIlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 08:12:48 INFO - mozversion application_buildid: 20160106053005 08:12:48 INFO - mozversion application_changeset: 44f79bbe2b515a2d27806ff23a23bbb4a9776e2e 08:12:48 INFO - mozversion application_display_name: Nightly 08:12:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:12:48 INFO - mozversion application_name: Firefox 08:12:48 INFO - mozversion application_remotingname: firefox 08:12:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:12:48 INFO - mozversion application_vendor: Mozilla 08:12:48 INFO - mozversion application_version: 46.0a1 08:12:48 INFO - mozversion platform_buildid: 20160106053005 08:12:48 INFO - mozversion platform_changeset: 44f79bbe2b515a2d27806ff23a23bbb4a9776e2e 08:12:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:12:48 INFO - mozversion platform_version: 46.0a1 08:12:48 INFO - using testdate: 1452096768 08:12:48 INFO - actual date: 1452096768 08:12:48 INFO - starting webserver on 'localhost:34046' 08:12:48 INFO - SUITE-START | Running 3 tests 08:12:48 INFO - TEST-START | dromaeo_css 08:12:48 INFO - operating with platform_type : linux_ 08:12:48 INFO - Initialising browser for dromaeo_css test... 08:12:48 INFO - TEST-INFO | started process 7355 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZSr5AW/profile http://localhost:34046/getInfo.html) 08:12:52 INFO - PROCESS | 7355 | __metrics Screen width/height:1600/1200 08:12:52 INFO - PROCESS | 7355 | colorDepth:24 08:12:52 INFO - PROCESS | 7355 | Browser inner width/height: 1024/697 08:12:52 INFO - PROCESS | 7355 | __metrics 08:12:52 INFO - PROCESS | 7355 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:12:52 INFO - PROCESS | 7355 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:12:53 INFO - TEST-INFO | 7355: exit 0 08:12:53 INFO - Browser initialized. 08:12:53 INFO - Running cycle 1/1 for dromaeo_css test... 08:12:53 INFO - TEST-INFO | started process 7453 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZSr5AW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:13:05 INFO - PROCESS | 7453 | RSS: Main: 149389312 08:13:05 INFO - PROCESS | 7453 | 08:13:56 INFO - PROCESS | 7453 | 1452096836799 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] 08:16:05 INFO - PROCESS | 7453 | Cycle 1(1): loaded http://localhost:34046/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34046/tests/dromaeo/cssquery-ext.html) 08:16:06 INFO - PROCESS | 7453 | RSS: Main: 250691584 08:16:06 INFO - PROCESS | 7453 | 08:19:08 INFO - PROCESS | 7453 | Cycle 1(1): loaded http://localhost:34046/tests/dromaeo/cssquery-ext.html (next: http://localhost:34046/tests/dromaeo/cssquery-jquery.html) 08:19:09 INFO - PROCESS | 7453 | RSS: Main: 242958336 08:19:09 INFO - PROCESS | 7453 | 08:22:11 INFO - PROCESS | 7453 | Cycle 1(1): loaded http://localhost:34046/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34046/tests/dromaeo/cssquery-mootools.html) 08:22:12 INFO - PROCESS | 7453 | RSS: Main: 224952320 08:22:12 INFO - PROCESS | 7453 | 08:25:13 INFO - PROCESS | 7453 | Cycle 1(1): loaded http://localhost:34046/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34046/tests/dromaeo/cssquery-prototype.html) 08:25:14 INFO - PROCESS | 7453 | RSS: Main: 216371200 08:25:14 INFO - PROCESS | 7453 | 08:28:17 INFO - PROCESS | 7453 | Cycle 1(1): loaded http://localhost:34046/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34046/tests/dromaeo/cssquery-yui.html) 08:28:17 INFO - PROCESS | 7453 | RSS: Main: 221057024 08:28:17 INFO - PROCESS | 7453 | 08:31:20 INFO - PROCESS | 7453 | Cycle 1(1): loaded http://localhost:34046/tests/dromaeo/cssquery-yui.html (next: http://localhost:34046/tests/dromaeo/cssquery-dojo.html) 08:31:20 INFO - PROCESS | 7453 | RSS: Main: 291962880 08:31:20 INFO - PROCESS | 7453 | 08:31:20 INFO - PROCESS | 7453 | __start_tp_report 08:31:20 INFO - PROCESS | 7453 | _x_x_mozilla_page_load 08:31:20 INFO - PROCESS | 7453 | _x_x_mozilla_page_load_details 08:31:20 INFO - PROCESS | 7453 | |i|pagename|runs| 08:31:20 INFO - PROCESS | 7453 | |0;dojo.html;3013.306939403937;3058.9082327530155;3124.562561241425;3129.358481511289;3158.368326334732;5153.948460515394;5173.4567870373585;5195.688258704471;5235.240890070937;5264.6051546134;5279.841604751864;5289.814856480024;5315.893682126355;5353.143497040474;5367.194920761887;4765.451973023095;4767.833125840596;4776.188048031834;4777.546133117348;4831.975840120795;4715.858524244261;4829.637777166709;4842.12841688496;4845.079434907357;4918.975405122969;4748.477667456577;4776;4878.487758785312;4894.510548945077;4913.975430122862;4826.879328016793;4837.564619184291;4840.854774356775;4842.080004799077;4862.44081930579;4791.377120974251;4794.856154315376;4795.496472870368;4838.274258861164;4842.12841688496;4975.900481990376;5037.370328708911;5153.433122356538;5282.550983166436;5301.549368303698;5707.315122185323;5711.343195532525;5721.513671337942;5739.397363276879;5741.368449470555;5726.5705072119345;5740.167675687002;5748.195252664588;5758.2514273144225;5770.7691692332255;5214.582833373321;5225.5035771602015;5317.867053323698;5322.281491998569;5329.227262046981;5804.82585522435;5848.824535263949;5864.120381942657;5870.911936320958;5944.64332140073;5614.691191984399;5635.971820140955;5663.546916246691;5664.065429204135;5667.518260947865;5462.617616766867;5636.689982050944;5642.322921249476;5725;5843.2403787507355;5643.40744221859;5665.6034077614995;5673.489385955201;5677.318721753416;5684.204211410406;5692.8861422771315;5699.458551437607;5705.486506214377;5708.543316534668;5717.285339332583;4269.295566231599;4281.272183728774;4311.568843115726;4314.180305741899;4360.825566977285;3911.92176156481;3923.7253392262837;3935.173613541131;3951.328274193394;3956.9604303957167;5263.052650522866;5269.762860671279;5274.7890084396195;5277.182036784305;5317.627766056339;5600.35595906476;5647.181158731961;5651.632643878134;5678.375378708339;5725.227094342211;5259.39516955555;5287.947120528823;5289.365276166807;5291.920621190685;5307.708076055854;4893.926591101136;4901.387326584177;4904.6566740327835;4916.164252077084;4937.259411088294;5630.0991841305195;5748.7125643717645;5773.711314434261;5826.126081087871;5913.05391137416;5710.628809127394;5712.80005199816;5716.828495145152;5720.313562372542;5724.8282551523525;5879.470847623735;5885.264341957255;5910.320313164041;5911.231539899785;5914.201582786269;5403.108487099585;5437.9939711153565;5481.123020316731;5497.532709719719;5645.887082258249;5502.724863756876;5603.691796951207;5638.464345887134;5640.871825634971;5647.519960803378;5526.889462210653;5534.695591742493;5538.307711536058;5541.501264886179;5544.7227638617105;5500.092484740133;5519.530839878656;5525.613207075467;5528.226048353315;5555.749991250323;5247.895042099213;5290.206469029677;5416.75624596902;5428.7557059931605;5461.208124821958;5344.893102138013;5345.518903298722;5355.892882142413;5391.056565101013;5399.70301633414;5235.869103272296;5252.290940722954;5254.106801843619;5257.2639830423;5290.28581141541 08:31:20 INFO - PROCESS | 7453 | |1;ext.html;527.2355085126565;532.5021105266576;535.213236542283;549.6207616744449;550.1774846604326;26733.465330693376;27758;27779.861100694518;27826.3043423914;35630.2873942521;40775.796121019426;41745.373819392735;41862.58137418625;41891.37162942559;41934.16131677364;8448.577571121436;8603.096674849145;8624.180702833251;8626.137386261387;8641.006284277295;7505;7735.1491335953;8608.096149904264;10124.544395502184;10376.066154046135;9972.60109595619;10121.949390253076;10146.391216526996;10158.644447444341;10210.744731381701;7514.624268786539;10024.398536087858;10125.240606954434;10141.746456338577;10147.441890696009;7429.368503677194;10013.79972400548;10251.538680759384;10253.43606101664;10259.281850270485;35418.64581354179;35476.29047419037;35599;35739.64260357415;35794.82102589496;3162.652108268089;3175.539546765706;3179.2210908327606;3287.1946373138735;3378.847951842173;29969;30504.237394065327;30534.389312213854;30549;31473.370532589448;3357.2781851901714;3456.6024907135497;3631.2555926035366;3641.927161456756;3790.2608991246716;275381;276405;277090;277217.99999999796;278013;52936.735316323175;53648.46351536435;59723;62081.68959155175;63124.68437657874;55344.72327638336;55360.72319638376;55373;55443.72278138664;55582.16626750602;15288.312025958858;15459.458918937784;15497.14765687898;15498;15500.689986200212;11476.368799716096;11528.193026488234;11535.711607209887;11536.59621913229;11553.422328883522;19901.60196796056;20082;20210.494737631678;20353.898230508752;20360.592788144153;7814.413918956101;7897.210278972057;7990.480618759762;8025.799355016171;8111.310538604284;893.4862454088925;911.3529394130242;963.9132478077007;1061.9751939378536;1136.4431428599926;28073.578896316572;28096.578551321745;28335.43329133447;28545.42909141847;28631.713682863323;985.1921424431897;994.5176589354157;1023.2734758321675;1040.1990467340106;1105.9668209953713;14896.329665165094;15870.841291587167;16194;16241.756373654405;16302.673946521003;388075;394425;394614;396388;398348;54422.45577544253;54514.45485545094;55016;55081;55179.17231241534;1320.650027742649;1329.7274058817918;1332.3538084029433;1334.846492653338;1341.215388997428;28293.858530707214;29268.56097158502;30084.548731768602;30506.542401864433;30552.541711873895;44424.33363499485;44462.3330650047;45088;45129;45547.31679024751;308414;316882;318514;320899;322213;39488.21023579455;39563.80218098891;40067.79966100151;40134;40155.39766903557;43641.78179109084;43969;43995.56004439915;44924.55075449204;45078.54921450744;36634.63365366312;36740.81629591835;37708.811455942545;37817.81091094527;38939;36750;37071.258574827814;37940.241195176495;38025;38063.23873522569;36426;37045.6295437053;37229;37468.25063498769;37585.81207093947;31799;32555.18612034718;33752;33887.322253554295;33928;25115;25356.112536061148;25467.10865119712;25472.363190920376;25644.87177564175 08:31:20 INFO - PROCESS | 7453 | |2;jquery.html;365.5083912138175;365.6325392980055;365.92864391443663;367.4561648759835;368.7676763638907;13879.444822207124;13882.4447022119;16049.83950160498;16111.83888161118;16712.498625041237;16040.35838566456;16419.58951026225;16825.495235142935;17006.40477583285;17008.4047058353;5366.597505187107;5495.53287970523;5497.092979658351;5499.230107784913;5511.862203444906;4091.6317531422164;4280.785960701968;5450.4549545045575;5488.5609151268;5820;5940.495057920082;5977.7608895644125;5978.671173085479;5979.342272350038;5995.490383317423;4988.102141614508;5150.484951504857;5158.045761534128;5165.483451654842;5958.761649534035;4832.565069143794;4952.158133117378;4953;4956.330895329156;5167.354080739908;11705.765884682343;12069.818952715716;12151.453184606626;12157.148999570034;17956.371526996492;2026.138890971346;2054.732884724991;2114.7039414481983;2119.7668256491775;2180.1824315881545;8691.739247822576;9080.909190908138;9089.63641454341;9423;11255.60605378816;1804.9097545122822;1870.5978214683773;1875.8117446437295;1893.848492120627;1920.4430715092606;59786.701066494825;61551.692241538956;61955;63016.684916575585;64218.35781642217;10261.127804136582;10275.332103413255;10386.584536618602;10413.791724165474;10471.371717696962;13649.181049137083;13656;13659.863401366058;13660.112092713942;13667.111637743516;7297.233790452032;7668.80827979305;7690.038745156856;7691.077070751546;7727.150013498623;7391.33477986973;7392.852142957111;7443.106827180773;7447;7469.327760501581;4450.287953927356;4509.706869053501;4523.95476045242;4574.954250457519;4579.313103034571;1715.794104707443;1739.5651087228193;1761.1810508113788;1767.2400867627043;1830.9267629294945;399.436794120289;402.23374471631587;856.8115014696757;917.1882883648019;1018.2719355660738;9727;10306.227032972558;10435.94782026085;14315.856841431452;16104.67790644204;842.8862103616055;882.6557642519423;927.4435338796668;929.1126973740062;930.283681565191;9200.769980750401;9303.395279306824;9676.661316853877;9677.177439917687;9686.709398717909;496855.5471667928;497223;505117;563164;571715;40812.38781418281;40924.590754092074;63955;81134.59432702916;84198.5790071058;1114.593173491686;1132.903703185222;1140.5095808802296;1147.3173461790223;1149.7240662241002;14750.704985900436;14993.925030374778;15185.468508602145;15310.234488275764;15433.22833858325;32554.511682325257;32876.34247315088;33641.3271734559;34113.82943085368;36061.0984725384;42032.78983605062;42055.789721052424;42720.14559708851;42744;43033.354499683155;8961.283097352065;9381.108794664497;9385;9421.764455888657;9422.340436169403;17086.48740537736;17170.828291716924;17416.216270267614;17626.206820693355;17691;11837.881621184022;12014.819777703517;12026.098042647012;13096.869031309947;14211.218382989035;13311.46754129824;13356.332183390987;13606.93196534011;14216.644583885485;14372;11866;12240.75518489643;13673.453061877812;13819.861801381858;14567.781483277548;8688.78278043054;8972.596233169654;9226.677066302647;9228.446293222429;9279.443233406017;9828.213742900694;9889.752756181153;11348.602798901999;14004.759865768063;14254.928725356307 08:31:20 INFO - PROCESS | 7453 | |3;mootools.html;1315.907886447949;1462.3127130248783;1472.676011277519;1605.25355709595;1799.5770993816443;6974.3374379433935;7131.3581777640065;7449.106107267129;7548.773536793891;7560.39516838653;7491.513051651639;7560.546367217957;7616.923830761691;7633.694652213905;7637;2003.4690806936173;2036.1244664794133;2322.965155522664;2353.4234112642425;2354.5761762882676;2345.2026311054324;2370.3244575296044;2370.9881450592725;2373.347329484397;2385.9284221473386;2249.5388445368662;2298.2415802785126;2298.5517824024323;2300.7929286364224;2301.137073597401;2305.6195727704994;2322.4890524084676;2357.776011278934;2358.233574088428;2358.481134150484;2346.9647955280684;2359.728631207416;2398.484325869946;2399.2802159352123;2401.1955994741606;7727.884081738778;7803.882941755822;7813.609319534001;7823.8435231295625;7831.960840195819;4701.68352861196;4772.045590881838;4811.061842940628;4817.759112044384;4821.566059054702;2935.6330458692664;3027.742641875443;3044.5737596736476;3081.4915538936275;3083.629964404286;917.0691747875911;920.5903372999018;943.5848226780195;951.9476428796413;967.8257913575553;9662.56518456671;9753.951230243874;9757.707268781947;9768.560414781352;9774.413535187912;4043.7169398141846;4109.219248342805;4127.958720412757;4243.766592837424;4342.41377414045;8607.870881936651;8852.336074794417;8854.645814167361;8862.689805856764;8874;4648.604868586208;4650.09323181983;4680.602148817321;4687.250039993584;4696.9060618787435;4272.252355837716;4305.48334199898;4321.092570560155;4323.870283891489;4328.5455027222315;3263.461528847761;3300.4884242941903;3428.6914177724125;3447.500112483676;3457.291255292659;1101.867775866885;1117.9217454778088;1120.8262719278525;1124.9650321704053;1130.7003644034337;1059.2902755154066;1286.8713128687057;1288.2270637617542;1307.1438207973792;1331.6937104466026;7019.227884932653;7070.75252366175;7083.114610673666;7192.712291508281;7199.280071992759;598.8293336399105;608.9512838972871;610.7770663707804;611.1993288791608;745.9925400746032;5442.428545002796;5510.311211098613;5563.304586926634;5583.553315734732;5584.246126772915;9172;9336.673216437528;9350.859737103949;9377;9500.762480937894;9269.536523173814;9349.579268932914;9446.527673616292;9531.52342382892;9549.904500955041;6980.197277313073;7038.472114591426;7293.489455738153;7369.7052117915755;7392.96303518479;7021.297870212938;7079.327463890922;7079.68141433647;7088.539244949062;7092.5389849659605;8233.79415514617;8430.494170349553;8614.138586141336;8614.310855131449;8635.654573816977;8675.609597567998;8691.304695624462;8771.517566533646;8826.64693412282;8863.379563430499;6755.763548275787;6960.721571137098;6967.686454109476;6971.337722916315;6987.790366289019;6475.514336424882;6597;6862.519623626298;6955.095837541087;7029.437644988491;6547.377999090078;6628.469722422291;6830.282820303796;6830.897536536857;6976.127984002;6577.704003319766;6753.3246675332075;6815.522913396213;6835.316468353125;7018.613976231356;7099.609521476368;7121.786346409616;7154.463415243981;7173.713051478091;7189;6252.562320637512;6338.334474880256;6389.7763578274535;6559.442447392025;6596.90104648421;6373.139626150596;6422.100905873088;6424.775132870327;6425.550211485338;6435.680685459563 08:31:20 INFO - PROCESS | 7453 | |4;prototype.html;339.6467673619436;344.80173900007486;346.158834033299;346.52526039326125;350.5215381004928;5766.740496677649;5867.1492633568105;5892.2340095787595;5901.350851406352;5952.7321270542825;5764.740586673599;5885.058390657496;5887.676177810219;5894.322152952412;5922.703864806753;4605.723656580599;4605.9769701151445;4610.262358022717;4617.676762626617;4619.792109355087;4379.978100109495;4448.488423831269;4453.131639330332;4496.505384407713;4626.329182268569;4550.544945505456;4555.157295900252;4565.908681826361;4585.19759042168;4609.101225261059;4549.567791059877;4552.817887284521;4553.635709143261;4558.680892337537;4595.977020114878;4051.1290072634524;4052.2098190852794;4064.4919385076864;4074.388841673743;4075.4701888754566;5517.641353312022;5663.093904975184;5665.5467562594895;5670.3479099903625;5705.115707065412;5265.86835329116;5273.393559740641;5280.07598670235;5284.920726189111;5291.100512912814;5972.9701351493395;6290.716917738713;6300.59046161998;6301.968490157566;6305.905411418832;4208.831646734127;4281.785910704483;4362.345648152771;4363.061941682554;4400.691951563392;6453.451456626192;6509.2839787623325;6546.738130474775;6549.639769812658;6552.705128269239;4472.932906006413;4496.3705081288645;4500.257457519538;4500.7622903701085;4502.144592527409;4479.574440428154;4560.452745670541;4569.268916973335;4569.474510431343;4589.059242855206;5258.079836028756;5260.605454590845;5261.868453288698;5265.183896496049;5270.552003079782;6298.118263443122;6302.873942521124;6303.086052522359;6303.6217826929615;6305.4009869062365;1605.2214675882187;1626.7071927053007;1627.3409269245738;1627.8453546913024;1629.0144462600192;1084.38732116354;1090.2804149261449;1093.0326660905157;1093.2347356850237;1119.3899324867966;5968.074948383008;5982.700864956735;5986.580939334205;5987.101934709828;5997.310309314485;6489;6491.805245842632;6493.285738568754;6499.09012738217;6503.9349606504275;5867.295924489089;5953.196318497034;5969.134475501028;5970.701464926823;5980.910286345708;3471.913202169966;3516.331896939573;3541.3979623464074;3542.557180352456;3552.289542091592;6738.831529211809;6742.123523941857;6753.966230168818;6754.324567543206;6760.830979225559;6683;6685.565438246498;6687.933120668828;6691.59850408977;6693.665316734144;6559.704813283413;6697.866042679119;6736.562123461959;6742.393184613408;6744.696488658022;6259.1550140730415;6440.8389790255615;6474.741010359721;6480.384363485461;6486.772962946275;6346.936530634634;6494;6512.902306465501;6516.771912983023;6522.478201743944;6725.596464212163;6726.192856857208;6778.084958530535;6792.3547263011915;6820.795376138723;4461.375407442895;4474.865754027384;4527.932081018722;4537.523560026149;4547.704399214041;6531.248906375828;6571.3757193066585;6584.868302634016;6587.901181482377;6589.604623722592;6392.169018027626;6403.487720982217;6413.743450261937;6414.230292364946;6425.614463132227;6280.340564240689;6359.586626869239;6413.7113829876835;6415.582987105823;6416.711247993945;6246.281677606951;6266.68666566679;6267.1539342188225;6272;6279.403456671792;6393.264774550986;6397;6402.519811014099;6403.231612206565;6411.3909178627955;6158.538109641705;6268.1851359323;6281.780137695158;6292.622442653455;6307.274663413583 08:31:20 INFO - PROCESS | 7453 | |5;yui.html;577.9913301300479;653.2879161713734;664.5514277862443;708.4828075504885;737.1191426245637;10889.401082940434;11134.220604557684;11156.609518666839;11157.832632510519;11167.385793781339;11980.880191198085;12067.3966301685;12069.879301206985;12072.939635301811;12081.15431919766;787.4684587903171;802.8554860125175;802.9156938521459;804.1395706593947;806.1213277527494;664.5082638847242;671.1744554198339;791.8020494876281;800.075912321267;816.2368185746317;847.9194476524721;859.4671303791627;863.8229163021597;863.87905693203;864.8789169516273;695.1901035293877;841.4908980067032;848.707196017373;849.3502470609989;849.995750021249;516.5738265930585;618.3661746709614;622.0731110645106;626.2485017978444;627.0500192208807;11899.226550274205;11917.582884598998;11940.283582985048;11951.820722689166;11956.760864782742;10893.782124357469;12369.196002259825;12392.132550721453;12715.237085774883;12717.236965782082;8771.649134034631;9001.909980900173;9112.225460835836;9225.308101892319;9376.203022743006;3585.8924232273075;3591.856325746967;3614.5301110855685;3621.9275614487565;3651.1967367179177;47627.76186119047;47899.52100478986;47952.52047479516;48072.03855922897;48198.759006205095;9470.90529094714;9611.855822162674;9644.421334719938;9829.55766990487;9830.361026533252;18156.092195390444;18181.81818181828;18295.359662411753;18334;18341.90829045873;7443.55338679681;7568.697252109964;7645.655945482466;7767.766966990999;7828.138904720477;3953.723239373216;4241.130568233505;4295.570442955742;4355.60799528044;4466.709663871903;2780.207640822356;2816.0847724489213;2817.8591070446805;2818.873150708223;2819.5488721804413;503.4260942525524;504.6643981752167;511.5089514066538;515.5875299760177;518.6395455158629;567.9472833519831;597.5667640960356;602.0848310567912;602.2111034544761;642.4635429416489;8228.177182281725;8230.711925082593;8314.875276870851;8442.113578074337;8554.743357699279;418.7526662384312;483.9588634965997;501.64633933077096;569.8062658695981;607.1227076873963;3864.516935383077;3997.3004724173734;4007.992007992008;4039.2931237033404;4214.241436541391;53216.733916330944;53342.46657533375;53552.73223633857;53663.463365366624;56479.352064793195;48423.5157648426;48767.512324877;49328.50671493311;49643;50306.49693503091;43490;44522.77738611351;44608.33087503625;44789.552104478535;45077.54922450799;7684.211571495203;8109.75670729879;8164.918350816416;8185.467944583583;8262;32312.35375292434;32808.67191328056;33396.66603334033;33453.66546334603;33472.16319592029;39922.20155596814;40294;42219.3667095;42858.142837142455;43189.13621727611;9819.263555233243;9951.15415189717;9979.251556133464;10065.69802905914;10073.496325183565;10195.337303075275;10577.31247468912;10962.725931851768;11016.834747478955;11112.499937502993;11066.28069175501;11129.387883666475;11148.55405783792;11291.943540282246;11393.031592314746;10848;11013.83479247828;11390.886091138982;11755.588554400554;11920.225185362924;10935.671929842118;11214.215004949576;11258.211925165488;11400;11438.313701177956;8699.695510657097;8970.147835955573;8978.326625502983;8981.345212998822;9237.538123093953;8523.616437260214;8718.738437846874;9051.094890510896;9727.367721098106;9999.400035997864 08:31:20 INFO - PROCESS | 7453 | __end_tp_report 08:31:20 INFO - PROCESS | 7453 | __start_cc_report 08:31:20 INFO - PROCESS | 7453 | _x_x_mozilla_cycle_collect,842 08:31:20 INFO - PROCESS | 7453 | __end_cc_report 08:31:20 INFO - PROCESS | 7453 | __startTimestamp1452097880382__endTimestamp 08:31:20 INFO - PROCESS | 7453 | 08:31:20 INFO - PROCESS | 7453 | ------- Summary: start ------- 08:31:20 INFO - PROCESS | 7453 | Number of tests: 6 08:31:20 INFO - PROCESS | 7453 | 08:31:20 INFO - PROCESS | 7453 | [#0] dojo.html Cycles:165 Average:5246.21 Median:5353.14 stddev:589.93 (11.0%) stddev-sans-first:565.14 08:31:20 INFO - PROCESS | 7453 | Values: 3013.3 3058.9 3124.6 3129.4 3158.4 5153.9 5173.5 5195.7 5235.2 5264.6 5279.8 5289.8 5315.9 5353.1 5367.2 4765.5 4767.8 4776.2 4777.5 4832.0 4715.9 4829.6 4842.1 4845.1 4919.0 4748.5 4776.0 4878.5 4894.5 4914.0 4826.9 4837.6 4840.9 4842.1 4862.4 4791.4 4794.9 4795.5 4838.3 4842.1 4975.9 5037.4 5153.4 5282.6 5301.5 5707.3 5711.3 5721.5 5739.4 5741.4 5726.6 5740.2 5748.2 5758.3 5770.8 5214.6 5225.5 5317.9 5322.3 5329.2 5804.8 5848.8 5864.1 5870.9 5944.6 5614.7 5636.0 5663.5 5664.1 5667.5 5462.6 5636.7 5642.3 5725.0 5843.2 5643.4 5665.6 5673.5 5677.3 5684.2 5692.9 5699.5 5705.5 5708.5 5717.3 4269.3 4281.3 4311.6 4314.2 4360.8 3911.9 3923.7 3935.2 3951.3 3957.0 5263.1 5269.8 5274.8 5277.2 5317.6 5600.4 5647.2 5651.6 5678.4 5725.2 5259.4 5287.9 5289.4 5291.9 5307.7 4893.9 4901.4 4904.7 4916.2 4937.3 5630.1 5748.7 5773.7 5826.1 5913.1 5710.6 5712.8 5716.8 5720.3 5724.8 5879.5 5885.3 5910.3 5911.2 5914.2 5403.1 5438.0 5481.1 5497.5 5645.9 5502.7 5603.7 5638.5 5640.9 5647.5 5526.9 5534.7 5538.3 5541.5 5544.7 5500.1 5519.5 5525.6 5528.2 5555.7 5247.9 5290.2 5416.8 5428.8 5461.2 5344.9 5345.5 5355.9 5391.1 5399.7 5235.9 5252.3 5254.1 5257.3 5290.3 08:31:20 INFO - PROCESS | 7453 | 08:31:20 INFO - PROCESS | 7453 | [#1] ext.html Cycles:180 Average:49466.16 Median:35447.47 stddev:87471.47 (246.8%) stddev-sans-first:87639.68 08:31:20 INFO - PROCESS | 7453 | Values: 527.2 532.5 535.2 549.6 550.2 26733.5 27758.0 27779.9 27826.3 35630.3 40775.8 41745.4 41862.6 41891.4 41934.2 8448.6 8603.1 8624.2 8626.1 8641.0 7505.0 7735.1 8608.1 10124.5 10376.1 9972.6 10121.9 10146.4 10158.6 10210.7 7514.6 10024.4 10125.2 10141.7 10147.4 7429.4 10013.8 10251.5 10253.4 10259.3 35418.6 35476.3 35599.0 35739.6 35794.8 3162.7 3175.5 3179.2 3287.2 3378.8 29969.0 30504.2 30534.4 30549.0 31473.4 3357.3 3456.6 3631.3 3641.9 3790.3 275381.0 276405.0 277090.0 277218.0 278013.0 52936.7 53648.5 59723.0 62081.7 63124.7 55344.7 55360.7 55373.0 55443.7 55582.2 15288.3 15459.5 15497.1 15498.0 15500.7 11476.4 11528.2 11535.7 11536.6 11553.4 19901.6 20082.0 20210.5 20353.9 20360.6 7814.4 7897.2 7990.5 8025.8 8111.3 893.5 911.4 963.9 1062.0 1136.4 28073.6 28096.6 28335.4 28545.4 28631.7 985.2 994.5 1023.3 1040.2 1106.0 14896.3 15870.8 16194.0 16241.8 16302.7 388075.0 394425.0 394614.0 396388.0 398348.0 54422.5 54514.5 55016.0 55081.0 55179.2 1320.7 1329.7 1332.4 1334.8 1341.2 28293.9 29268.6 30084.5 30506.5 30552.5 44424.3 44462.3 45088.0 45129.0 45547.3 308414.0 316882.0 318514.0 320899.0 322213.0 39488.2 39563.8 40067.8 40134.0 40155.4 43641.8 43969.0 43995.6 44924.6 45078.5 36634.6 36740.8 37708.8 37817.8 38939.0 36750.0 37071.3 37940.2 38025.0 38063.2 36426.0 37045.6 37229.0 37468.3 37585.8 31799.0 32555.2 33752.0 33887.3 33928.0 25115.0 25356.1 25467.1 25472.4 25644.9 08:31:20 INFO - PROCESS | 7453 | 08:31:20 INFO - PROCESS | 7453 | [#2] jquery.html Cycles:180 Average:27375.01 Median:20607.31 stddev:86149.11 (418.1%) stddev-sans-first:86366.91 08:31:20 INFO - PROCESS | 7453 | Values: 365.5 365.6 365.9 367.5 368.8 13879.4 13882.4 16049.8 16111.8 16712.5 16040.4 16419.6 16825.5 17006.4 17008.4 5366.6 5495.5 5497.1 5499.2 5511.9 4091.6 4280.8 5450.5 5488.6 5820.0 5940.5 5977.8 5978.7 5979.3 5995.5 4988.1 5150.5 5158.0 5165.5 5958.8 4832.6 4952.2 4953.0 4956.3 5167.4 11705.8 12069.8 12151.5 12157.1 17956.4 2026.1 2054.7 2114.7 2119.8 2180.2 8691.7 9080.9 9089.6 9423.0 11255.6 1804.9 1870.6 1875.8 1893.8 1920.4 59786.7 61551.7 61955.0 63016.7 64218.4 10261.1 10275.3 10386.6 10413.8 10471.4 13649.2 13656.0 13659.9 13660.1 13667.1 7297.2 7668.8 7690.0 7691.1 7727.2 7391.3 7392.9 7443.1 7447.0 7469.3 4450.3 4509.7 4524.0 4575.0 4579.3 1715.8 1739.6 1761.2 1767.2 1830.9 399.4 402.2 856.8 917.2 1018.3 9727.0 10306.2 10435.9 14315.9 16104.7 842.9 882.7 927.4 929.1 930.3 9200.8 9303.4 9676.7 9677.2 9686.7 496855.5 497223.0 505117.0 563164.0 571715.0 40812.4 40924.6 63955.0 81134.6 84198.6 1114.6 1132.9 1140.5 1147.3 1149.7 14750.7 14993.9 15185.5 15310.2 15433.2 32554.5 32876.3 33641.3 34113.8 36061.1 42032.8 42055.8 42720.1 42744.0 43033.4 8961.3 9381.1 9385.0 9421.8 9422.3 17086.5 17170.8 17416.2 17626.2 17691.0 11837.9 12014.8 12026.1 13096.9 14211.2 13311.5 13356.3 13606.9 14216.6 14372.0 11866.0 12240.8 13673.5 13819.9 14567.8 8688.8 8972.6 9226.7 9228.4 9279.4 9828.2 9889.8 11348.6 14004.8 14254.9 08:31:20 INFO - PROCESS | 7453 | 08:31:20 INFO - PROCESS | 7453 | [#3] mootools.html Cycles:180 Average:5359.91 Median:6587.30 stddev:2766.36 (42.0%) stddev-sans-first:2757.42 08:31:20 INFO - PROCESS | 7453 | Values: 1315.9 1462.3 1472.7 1605.3 1799.6 6974.3 7131.4 7449.1 7548.8 7560.4 7491.5 7560.5 7616.9 7633.7 7637.0 2003.5 2036.1 2323.0 2353.4 2354.6 2345.2 2370.3 2371.0 2373.3 2385.9 2249.5 2298.2 2298.6 2300.8 2301.1 2305.6 2322.5 2357.8 2358.2 2358.5 2347.0 2359.7 2398.5 2399.3 2401.2 7727.9 7803.9 7813.6 7823.8 7832.0 4701.7 4772.0 4811.1 4817.8 4821.6 2935.6 3027.7 3044.6 3081.5 3083.6 917.1 920.6 943.6 951.9 967.8 9662.6 9754.0 9757.7 9768.6 9774.4 4043.7 4109.2 4128.0 4243.8 4342.4 8607.9 8852.3 8854.6 8862.7 8874.0 4648.6 4650.1 4680.6 4687.3 4696.9 4272.3 4305.5 4321.1 4323.9 4328.5 3263.5 3300.5 3428.7 3447.5 3457.3 1101.9 1117.9 1120.8 1125.0 1130.7 1059.3 1286.9 1288.2 1307.1 1331.7 7019.2 7070.8 7083.1 7192.7 7199.3 598.8 609.0 610.8 611.2 746.0 5442.4 5510.3 5563.3 5583.6 5584.2 9172.0 9336.7 9350.9 9377.0 9500.8 9269.5 9349.6 9446.5 9531.5 9549.9 6980.2 7038.5 7293.5 7369.7 7393.0 7021.3 7079.3 7079.7 7088.5 7092.5 8233.8 8430.5 8614.1 8614.3 8635.7 8675.6 8691.3 8771.5 8826.6 8863.4 6755.8 6960.7 6967.7 6971.3 6987.8 6475.5 6597.0 6862.5 6955.1 7029.4 6547.4 6628.5 6830.3 6830.9 6976.1 6577.7 6753.3 6815.5 6835.3 7018.6 7099.6 7121.8 7154.5 7173.7 7189.0 6252.6 6338.3 6389.8 6559.4 6596.9 6373.1 6422.1 6424.8 6425.6 6435.7 08:31:20 INFO - PROCESS | 7453 | 08:31:20 INFO - PROCESS | 7453 | [#4] prototype.html Cycles:180 Average:5285.65 Median:5952.96 stddev:1584.11 (26.6%) stddev-sans-first:1544.44 08:31:20 INFO - PROCESS | 7453 | Values: 339.6 344.8 346.2 346.5 350.5 5766.7 5867.1 5892.2 5901.4 5952.7 5764.7 5885.1 5887.7 5894.3 5922.7 4605.7 4606.0 4610.3 4617.7 4619.8 4380.0 4448.5 4453.1 4496.5 4626.3 4550.5 4555.2 4565.9 4585.2 4609.1 4549.6 4552.8 4553.6 4558.7 4596.0 4051.1 4052.2 4064.5 4074.4 4075.5 5517.6 5663.1 5665.5 5670.3 5705.1 5265.9 5273.4 5280.1 5284.9 5291.1 5973.0 6290.7 6300.6 6302.0 6305.9 4208.8 4281.8 4362.3 4363.1 4400.7 6453.5 6509.3 6546.7 6549.6 6552.7 4472.9 4496.4 4500.3 4500.8 4502.1 4479.6 4560.5 4569.3 4569.5 4589.1 5258.1 5260.6 5261.9 5265.2 5270.6 6298.1 6302.9 6303.1 6303.6 6305.4 1605.2 1626.7 1627.3 1627.8 1629.0 1084.4 1090.3 1093.0 1093.2 1119.4 5968.1 5982.7 5986.6 5987.1 5997.3 6489.0 6491.8 6493.3 6499.1 6503.9 5867.3 5953.2 5969.1 5970.7 5980.9 3471.9 3516.3 3541.4 3542.6 3552.3 6738.8 6742.1 6754.0 6754.3 6760.8 6683.0 6685.6 6687.9 6691.6 6693.7 6559.7 6697.9 6736.6 6742.4 6744.7 6259.2 6440.8 6474.7 6480.4 6486.8 6346.9 6494.0 6512.9 6516.8 6522.5 6725.6 6726.2 6778.1 6792.4 6820.8 4461.4 4474.9 4527.9 4537.5 4547.7 6531.2 6571.4 6584.9 6587.9 6589.6 6392.2 6403.5 6413.7 6414.2 6425.6 6280.3 6359.6 6413.7 6415.6 6416.7 6246.3 6266.7 6267.2 6272.0 6279.4 6393.3 6397.0 6402.5 6403.2 6411.4 6158.5 6268.2 6281.8 6292.6 6307.3 08:31:20 INFO - PROCESS | 7453 | 08:31:20 INFO - PROCESS | 7453 | [#5] yui.html Cycles:180 Average:13128.14 Median:49048.01 stddev:15273.30 (31.1%) stddev-sans-first:15287.07 08:31:20 INFO - PROCESS | 7453 | Values: 578.0 653.3 664.6 708.5 737.1 10889.4 11134.2 11156.6 11157.8 11167.4 11980.9 12067.4 12069.9 12072.9 12081.2 787.5 802.9 802.9 804.1 806.1 664.5 671.2 791.8 800.1 816.2 847.9 859.5 863.8 863.9 864.9 695.2 841.5 848.7 849.4 850.0 516.6 618.4 622.1 626.2 627.1 11899.2 11917.6 11940.3 11951.8 11956.8 10893.8 12369.2 12392.1 12715.2 12717.2 8771.6 9001.9 9112.2 9225.3 9376.2 3585.9 3591.9 3614.5 3621.9 3651.2 47627.8 47899.5 47952.5 48072.0 48198.8 9470.9 9611.9 9644.4 9829.6 9830.4 18156.1 18181.8 18295.4 18334.0 18341.9 7443.6 7568.7 7645.7 7767.8 7828.1 3953.7 4241.1 4295.6 4355.6 4466.7 2780.2 2816.1 2817.9 2818.9 2819.5 503.4 504.7 511.5 515.6 518.6 567.9 597.6 602.1 602.2 642.5 8228.2 8230.7 8314.9 8442.1 8554.7 418.8 484.0 501.6 569.8 607.1 3864.5 3997.3 4008.0 4039.3 4214.2 53216.7 53342.5 53552.7 53663.5 56479.4 48423.5 48767.5 49328.5 49643.0 50306.5 43490.0 44522.8 44608.3 44789.6 45077.5 7684.2 8109.8 8164.9 8185.5 8262.0 32312.4 32808.7 33396.7 33453.7 33472.2 39922.2 40294.0 42219.4 42858.1 43189.1 9819.3 9951.2 9979.3 10065.7 10073.5 10195.3 10577.3 10962.7 11016.8 11112.5 11066.3 11129.4 11148.6 11291.9 11393.0 10848.0 11013.8 11390.9 11755.6 11920.2 10935.7 11214.2 11258.2 11400.0 11438.3 8699.7 8970.1 8978.3 8981.3 9237.5 8523.6 8718.7 9051.1 9727.4 9999.4 08:31:20 INFO - PROCESS | 7453 | -------- Summary: end -------- 08:31:20 INFO - PROCESS | 7453 | 08:31:21 INFO - TEST-INFO | 7453: exit 0 08:31:21 INFO - TEST-OK | dromaeo_css | took 1112468ms 08:31:21 INFO - TEST-START | kraken 08:31:21 INFO - operating with platform_type : linux_ 08:31:21 INFO - Initialising browser for kraken test... 08:31:21 INFO - TEST-INFO | started process 7655 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpq3ECvm/profile http://localhost:34046/getInfo.html) 08:31:25 INFO - PROCESS | 7655 | __metrics Screen width/height:1600/1200 08:31:25 INFO - PROCESS | 7655 | colorDepth:24 08:31:25 INFO - PROCESS | 7655 | Browser inner width/height: 1024/697 08:31:25 INFO - PROCESS | 7655 | __metrics 08:31:25 INFO - PROCESS | 7655 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:31:25 INFO - PROCESS | 7655 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:31:25 INFO - PROCESS | 7655 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 08:31:26 INFO - TEST-INFO | 7655: exit 0 08:31:26 INFO - Browser initialized. 08:31:26 INFO - Running cycle 1/1 for kraken test... 08:31:26 INFO - TEST-INFO | started process 7737 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpq3ECvm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:31:37 INFO - PROCESS | 7737 | RSS: Main: 147767296 08:31:37 INFO - PROCESS | 7737 | 08:31:40 INFO - PROCESS | 7737 | Cycle 1(1): loaded http://localhost:34046/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34046/tests/kraken/driver.html?testName=audio-beat-detection) 08:31:40 INFO - PROCESS | 7737 | RSS: Main: 183803904 08:31:40 INFO - PROCESS | 7737 | 08:31:43 INFO - PROCESS | 7737 | Cycle 1(1): loaded http://localhost:34046/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34046/tests/kraken/driver.html?testName=audio-dft) 08:31:44 INFO - PROCESS | 7737 | RSS: Main: 174489600 08:31:44 INFO - PROCESS | 7737 | 08:31:47 INFO - PROCESS | 7737 | Cycle 1(1): loaded http://localhost:34046/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34046/tests/kraken/driver.html?testName=audio-fft) 08:31:47 INFO - PROCESS | 7737 | RSS: Main: 157413376 08:31:47 INFO - PROCESS | 7737 | 08:31:49 INFO - PROCESS | 7737 | Cycle 1(1): loaded http://localhost:34046/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34046/tests/kraken/driver.html?testName=audio-oscillator) 08:31:50 INFO - PROCESS | 7737 | RSS: Main: 161112064 08:31:50 INFO - PROCESS | 7737 | 08:31:52 INFO - PROCESS | 7737 | Cycle 1(1): loaded http://localhost:34046/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34046/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:31:53 INFO - PROCESS | 7737 | RSS: Main: 162611200 08:31:53 INFO - PROCESS | 7737 | 08:31:55 INFO - PROCESS | 7737 | Cycle 1(1): loaded http://localhost:34046/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34046/tests/kraken/driver.html?testName=imaging-darkroom) 08:31:56 INFO - PROCESS | 7737 | RSS: Main: 163487744 08:31:56 INFO - PROCESS | 7737 | 08:31:59 INFO - PROCESS | 7737 | Cycle 1(1): loaded http://localhost:34046/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34046/tests/kraken/driver.html?testName=imaging-desaturate) 08:32:00 INFO - PROCESS | 7737 | RSS: Main: 163594240 08:32:00 INFO - PROCESS | 7737 | 08:32:03 INFO - PROCESS | 7737 | Cycle 1(1): loaded http://localhost:34046/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34046/tests/kraken/driver.html?testName=json-parse-financial) 08:32:03 INFO - PROCESS | 7737 | RSS: Main: 162889728 08:32:03 INFO - PROCESS | 7737 | 08:32:05 INFO - PROCESS | 7737 | Cycle 1(1): loaded http://localhost:34046/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34046/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:32:05 INFO - PROCESS | 7737 | RSS: Main: 172601344 08:32:05 INFO - PROCESS | 7737 | 08:32:07 INFO - PROCESS | 7737 | Cycle 1(1): loaded http://localhost:34046/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34046/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:32:08 INFO - PROCESS | 7737 | RSS: Main: 169283584 08:32:08 INFO - PROCESS | 7737 | 08:32:10 INFO - PROCESS | 7737 | Cycle 1(1): loaded http://localhost:34046/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34046/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:32:11 INFO - PROCESS | 7737 | RSS: Main: 182190080 08:32:11 INFO - PROCESS | 7737 | 08:32:13 INFO - PROCESS | 7737 | Cycle 1(1): loaded http://localhost:34046/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34046/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:32:14 INFO - PROCESS | 7737 | RSS: Main: 188735488 08:32:14 INFO - PROCESS | 7737 | 08:32:16 INFO - PROCESS | 7737 | Cycle 1(1): loaded http://localhost:34046/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34046/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:32:17 INFO - PROCESS | 7737 | RSS: Main: 188022784 08:32:17 INFO - PROCESS | 7737 | 08:32:18 INFO - PROCESS | 7737 | Cycle 1(1): loaded http://localhost:34046/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34046/tests/kraken/driver.html?testName=ai-astar) 08:32:19 INFO - PROCESS | 7737 | RSS: Main: 244641792 08:32:19 INFO - PROCESS | 7737 | 08:32:19 INFO - PROCESS | 7737 | __start_tp_report 08:32:19 INFO - PROCESS | 7737 | _x_x_mozilla_page_load 08:32:19 INFO - PROCESS | 7737 | _x_x_mozilla_page_load_details 08:32:19 INFO - PROCESS | 7737 | |i|pagename|runs| 08:32:19 INFO - PROCESS | 7737 | |0;ai-astar;110;110;104;111;111;113;100;110;110;117 08:32:19 INFO - PROCESS | 7737 | |1;audio-beat-detection;148;125;158;173;130;153;150;131;175;130 08:32:19 INFO - PROCESS | 7737 | |2;audio-dft;161;164;161;161;162;165;161;163;162;161 08:32:19 INFO - PROCESS | 7737 | |3;audio-fft;75;72;82;94;72;74;72;110;94;71 08:32:19 INFO - PROCESS | 7737 | |4;audio-oscillator;98;98;152;98;97;97;150;97;97;141 08:32:19 INFO - PROCESS | 7737 | |5;imaging-gaussian-blur;109;109;109;110;109;109;110;109;110;110 08:32:19 INFO - PROCESS | 7737 | |6;imaging-darkroom;147;145;146;146;146;146;148;147;146;146 08:32:19 INFO - PROCESS | 7737 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;96;96 08:32:19 INFO - PROCESS | 7737 | |8;json-parse-financial;59;58;58;57;59;58;60;60;61;57 08:32:19 INFO - PROCESS | 7737 | |9;json-stringify-tinderbox;68;67;68;68;69;69;68;69;68;69 08:32:19 INFO - PROCESS | 7737 | |10;stanford-crypto-aes;93;86;87;87;85;86;87;86;86;88 08:32:19 INFO - PROCESS | 7737 | |11;stanford-crypto-ccm;116;128;119;117;124;121;117;119;117;121 08:32:19 INFO - PROCESS | 7737 | |12;stanford-crypto-pbkdf2;159;145;154;156;144;145;152;156;153;150 08:32:19 INFO - PROCESS | 7737 | |13;stanford-crypto-sha256-iterative;70;70;69;69;69;68;78;70;70;69 08:32:19 INFO - PROCESS | 7737 | __end_tp_report 08:32:19 INFO - PROCESS | 7737 | __start_cc_report 08:32:19 INFO - PROCESS | 7737 | _x_x_mozilla_cycle_collect,933 08:32:19 INFO - PROCESS | 7737 | __end_cc_report 08:32:19 INFO - PROCESS | 7737 | __startTimestamp1452097939172__endTimestamp 08:32:19 INFO - PROCESS | 7737 | 08:32:19 INFO - PROCESS | 7737 | ------- Summary: start ------- 08:32:19 INFO - PROCESS | 7737 | Number of tests: 14 08:32:19 INFO - PROCESS | 7737 | 08:32:19 INFO - PROCESS | 7737 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.50 stddev:4.65 (4.2%) stddev-sans-first:4.93 08:32:19 INFO - PROCESS | 7737 | Values: 110.0 110.0 104.0 111.0 111.0 113.0 100.0 110.0 110.0 117.0 08:32:19 INFO - PROCESS | 7737 | 08:32:19 INFO - PROCESS | 7737 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:151.50 stddev:18.09 (11.9%) stddev-sans-first:19.18 08:32:19 INFO - PROCESS | 7737 | Values: 148.0 125.0 158.0 173.0 130.0 153.0 150.0 131.0 175.0 130.0 08:32:19 INFO - PROCESS | 7737 | 08:32:19 INFO - PROCESS | 7737 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.45 (0.9%) stddev-sans-first:1.48 08:32:19 INFO - PROCESS | 7737 | Values: 161.0 164.0 161.0 161.0 162.0 165.0 161.0 163.0 162.0 161.0 08:32:19 INFO - PROCESS | 7737 | 08:32:19 INFO - PROCESS | 7737 | [#3] audio-fft Cycles:10 Average:81.60 Median:74.50 stddev:13.35 (17.9%) stddev-sans-first:13.95 08:32:19 INFO - PROCESS | 7737 | Values: 75.0 72.0 82.0 94.0 72.0 74.0 72.0 110.0 94.0 71.0 08:32:19 INFO - PROCESS | 7737 | 08:32:19 INFO - PROCESS | 7737 | [#4] audio-oscillator Cycles:10 Average:112.50 Median:97.00 stddev:24.43 (25.2%) stddev-sans-first:25.34 08:32:19 INFO - PROCESS | 7737 | Values: 98.0 98.0 152.0 98.0 97.0 97.0 150.0 97.0 97.0 141.0 08:32:19 INFO - PROCESS | 7737 | 08:32:19 INFO - PROCESS | 7737 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:32:19 INFO - PROCESS | 7737 | Values: 109.0 109.0 109.0 110.0 109.0 109.0 110.0 109.0 110.0 110.0 08:32:19 INFO - PROCESS | 7737 | 08:32:19 INFO - PROCESS | 7737 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 08:32:19 INFO - PROCESS | 7737 | Values: 147.0 145.0 146.0 146.0 146.0 146.0 148.0 147.0 146.0 146.0 08:32:19 INFO - PROCESS | 7737 | 08:32:19 INFO - PROCESS | 7737 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 08:32:19 INFO - PROCESS | 7737 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 08:32:19 INFO - PROCESS | 7737 | 08:32:19 INFO - PROCESS | 7737 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:59.00 stddev:1.34 (2.3%) stddev-sans-first:1.41 08:32:19 INFO - PROCESS | 7737 | Values: 59.0 58.0 58.0 57.0 59.0 58.0 60.0 60.0 61.0 57.0 08:32:19 INFO - PROCESS | 7737 | 08:32:19 INFO - PROCESS | 7737 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 08:32:19 INFO - PROCESS | 7737 | Values: 68.0 67.0 68.0 68.0 69.0 69.0 68.0 69.0 68.0 69.0 08:32:19 INFO - PROCESS | 7737 | 08:32:19 INFO - PROCESS | 7737 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:87.00 stddev:2.23 (2.6%) stddev-sans-first:0.88 08:32:19 INFO - PROCESS | 7737 | Values: 93.0 86.0 87.0 87.0 85.0 86.0 87.0 86.0 86.0 88.0 08:32:19 INFO - PROCESS | 7737 | 08:32:19 INFO - PROCESS | 7737 | [#11] stanford-crypto-ccm Cycles:10 Average:119.90 Median:120.00 stddev:3.75 (3.1%) stddev-sans-first:3.71 08:32:19 INFO - PROCESS | 7737 | Values: 116.0 128.0 119.0 117.0 124.0 121.0 117.0 119.0 117.0 121.0 08:32:19 INFO - PROCESS | 7737 | 08:32:19 INFO - PROCESS | 7737 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.40 Median:153.50 stddev:5.25 (3.4%) stddev-sans-first:4.80 08:32:19 INFO - PROCESS | 7737 | Values: 159.0 145.0 154.0 156.0 144.0 145.0 152.0 156.0 153.0 150.0 08:32:19 INFO - PROCESS | 7737 | 08:32:19 INFO - PROCESS | 7737 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.00 stddev:2.82 (4.0%) stddev-sans-first:2.99 08:32:19 INFO - PROCESS | 7737 | Values: 70.0 70.0 69.0 69.0 69.0 68.0 78.0 70.0 70.0 69.0 08:32:19 INFO - PROCESS | 7737 | -------- Summary: end -------- 08:32:19 INFO - PROCESS | 7737 | 08:32:19 INFO - TEST-INFO | 7737: exit 0 08:32:20 INFO - TEST-OK | kraken | took 58896ms 08:32:20 INFO - TEST-START | v8_7 08:32:20 INFO - operating with platform_type : linux_ 08:32:20 INFO - Initialising browser for v8_7 test... 08:32:20 INFO - TEST-INFO | started process 7987 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAqlnkF/profile http://localhost:34046/getInfo.html) 08:32:23 INFO - PROCESS | 7987 | __metrics Screen width/height:1600/1200 08:32:23 INFO - PROCESS | 7987 | colorDepth:24 08:32:23 INFO - PROCESS | 7987 | Browser inner width/height: 1024/697 08:32:23 INFO - PROCESS | 7987 | __metrics 08:32:23 INFO - PROCESS | 7987 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:32:23 INFO - PROCESS | 7987 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:32:24 INFO - TEST-INFO | 7987: exit 0 08:32:24 INFO - Browser initialized. 08:32:24 INFO - Running cycle 1/1 for v8_7 test... 08:32:24 INFO - TEST-INFO | started process 8070 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAqlnkF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:32:36 INFO - PROCESS | 8070 | RSS: Main: 150437888 08:32:36 INFO - PROCESS | 8070 | 08:32:57 INFO - PROCESS | 8070 | Cycle 1(1): loaded http://localhost:34046/tests/v8_7/run.html (next: http://localhost:34046/tests/v8_7/run.html) 08:32:58 INFO - PROCESS | 8070 | RSS: Main: 590372864 08:32:58 INFO - PROCESS | 8070 | 08:32:58 INFO - PROCESS | 8070 | __start_tp_report 08:32:58 INFO - PROCESS | 8070 | _x_x_mozilla_page_load 08:32:58 INFO - PROCESS | 8070 | _x_x_mozilla_page_load_details 08:32:58 INFO - PROCESS | 8070 | |i|pagename|runs| 08:32:58 INFO - PROCESS | 8070 | |0;Richards;168.37851490149856 08:32:58 INFO - PROCESS | 8070 | |1;DeltaBlue;191.93857965451056 08:32:58 INFO - PROCESS | 8070 | |2;Encrypt;288.6836027713626 08:32:58 INFO - PROCESS | 8070 | |3;Decrypt;5186.5284974093265 08:32:58 INFO - PROCESS | 8070 | |4;RayTrace;2040.8163265306123 08:32:58 INFO - PROCESS | 8070 | |5;Earley;804.5052292839904 08:32:58 INFO - PROCESS | 8070 | |6;Boyer;12708.860759493671 08:32:58 INFO - PROCESS | 8070 | |7;RegExp;26076.923076923078 08:32:58 INFO - PROCESS | 8070 | |8;Splay;664.4518272425249 08:32:58 INFO - PROCESS | 8070 | |9;NavierStokes;4887.804878048781 08:32:58 INFO - PROCESS | 8070 | __end_tp_report 08:32:58 INFO - PROCESS | 8070 | __startTimestamp1452097978131__endTimestamp 08:32:58 INFO - PROCESS | 8070 | 08:32:58 INFO - PROCESS | 8070 | ------- Summary: start ------- 08:32:58 INFO - PROCESS | 8070 | Number of tests: 10 08:32:58 INFO - PROCESS | 8070 | 08:32:58 INFO - PROCESS | 8070 | [#0] Richards Cycles:1 Average:168.38 Median:168.38 stddev:0.00 (0.0%) 08:32:58 INFO - PROCESS | 8070 | Values: 168.4 08:32:58 INFO - PROCESS | 8070 | 08:32:58 INFO - PROCESS | 8070 | [#1] DeltaBlue Cycles:1 Average:191.94 Median:191.94 stddev:0.00 (0.0%) 08:32:58 INFO - PROCESS | 8070 | Values: 191.9 08:32:58 INFO - PROCESS | 8070 | 08:32:58 INFO - PROCESS | 8070 | [#2] Encrypt Cycles:1 Average:288.68 Median:288.68 stddev:0.00 (0.0%) 08:32:58 INFO - PROCESS | 8070 | Values: 288.7 08:32:58 INFO - PROCESS | 8070 | 08:32:58 INFO - PROCESS | 8070 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 08:32:58 INFO - PROCESS | 8070 | Values: 5186.5 08:32:58 INFO - PROCESS | 8070 | 08:32:58 INFO - PROCESS | 8070 | [#4] RayTrace Cycles:1 Average:2040.82 Median:2040.82 stddev:0.00 (0.0%) 08:32:58 INFO - PROCESS | 8070 | Values: 2040.8 08:32:58 INFO - PROCESS | 8070 | 08:32:58 INFO - PROCESS | 8070 | [#5] Earley Cycles:1 Average:804.51 Median:804.51 stddev:0.00 (0.0%) 08:32:58 INFO - PROCESS | 8070 | Values: 804.5 08:32:58 INFO - PROCESS | 8070 | 08:32:58 INFO - PROCESS | 8070 | [#6] Boyer Cycles:1 Average:12708.86 Median:12708.86 stddev:0.00 (0.0%) 08:32:58 INFO - PROCESS | 8070 | Values: 12708.9 08:32:58 INFO - PROCESS | 8070 | 08:32:58 INFO - PROCESS | 8070 | [#7] RegExp Cycles:1 Average:26076.92 Median:26076.92 stddev:0.00 (0.0%) 08:32:58 INFO - PROCESS | 8070 | Values: 26076.9 08:32:58 INFO - PROCESS | 8070 | 08:32:58 INFO - PROCESS | 8070 | [#8] Splay Cycles:1 Average:664.45 Median:664.45 stddev:0.00 (0.0%) 08:32:58 INFO - PROCESS | 8070 | Values: 664.5 08:32:58 INFO - PROCESS | 8070 | 08:32:58 INFO - PROCESS | 8070 | [#9] NavierStokes Cycles:1 Average:4887.80 Median:4887.80 stddev:0.00 (0.0%) 08:32:58 INFO - PROCESS | 8070 | Values: 4887.8 08:32:58 INFO - PROCESS | 8070 | -------- Summary: end -------- 08:32:58 INFO - PROCESS | 8070 | 08:32:59 INFO - TEST-INFO | 8070: exit 0 08:32:59 INFO - TEST-OK | v8_7 | took 38973ms 08:32:59 INFO - SUITE-END | took 1210s 08:32:59 INFO - Completed test suite (00:20:10) 08:32:59 INFO - Working with test: dromaeo_css 08:32:59 INFO - Generating results file: dromaeo_css 08:32:59 INFO - Working with test: kraken 08:32:59 INFO - Generating results file: kraken 08:32:59 INFO - javascript benchmark 08:32:59 INFO - Working with test: v8_7 08:32:59 INFO - Generating results file: v8_7 08:32:59 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:32:59 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 08:32:59 INFO - process_Request line: dromaeo_css 6834.28 graph.html#tests=[[72,64,35]] 08:32:59 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:32:59 INFO - process_Request line: kraken 1520.40 graph.html#tests=[[232,64,35]] 08:32:59 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:33:00 INFO - process_Request line: v8_7 19329.41 graph.html#tests=[[230,64,35]] 08:33:00 INFO - RETURN: dromaeo_css: 6834.28 08:33:00 INFO - RETURN: kraken: 1520.40 08:33:00 INFO - RETURN: v8_7: 19329.41 08:33:00 INFO - javascript benchmark 08:33:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3013.306939403937, 3058.9082327530155, 3124.562561241425, 3129.358481511289, 3158.368326334732, 5153.948460515394, 5173.4567870373585, 5195.688258704471, 5235.240890070937, 5264.6051546134, 5279.841604751864, 5289.814856480024, 5315.893682126355, 5353.143497040474, 5367.194920761887, 4765.451973023095, 4767.833125840596, 4776.188048031834, 4777.546133117348, 4831.975840120795, 4715.858524244261, 4829.637777166709, 4842.12841688496, 4845.079434907357, 4918.975405122969, 4748.477667456577, 4776.0, 4878.487758785312, 4894.510548945077, 4913.975430122862, 4826.879328016793, 4837.564619184291, 4840.854774356775, 4842.080004799077, 4862.44081930579, 4791.377120974251, 4794.856154315376, 4795.496472870368, 4838.274258861164, 4842.12841688496, 4975.900481990376, 5037.370328708911, 5153.433122356538, 5282.550983166436, 5301.549368303698, 5707.315122185323, 5711.343195532525, 5721.513671337942, 5739.397363276879, 5741.368449470555, 5726.5705072119345, 5740.167675687002, 5748.195252664588, 5758.2514273144225, 5770.7691692332255, 5214.582833373321, 5225.5035771602015, 5317.867053323698, 5322.281491998569, 5329.227262046981, 5804.82585522435, 5848.824535263949, 5864.120381942657, 5870.911936320958, 5944.64332140073, 5614.691191984399, 5635.971820140955, 5663.546916246691, 5664.065429204135, 5667.518260947865, 5462.617616766867, 5636.689982050944, 5642.322921249476, 5725.0, 5843.2403787507355, 5643.40744221859, 5665.6034077614995, 5673.489385955201, 5677.318721753416, 5684.204211410406, 5692.8861422771315, 5699.458551437607, 5705.486506214377, 5708.543316534668, 5717.285339332583, 4269.295566231599, 4281.272183728774, 4311.568843115726, 4314.180305741899, 4360.825566977285, 3911.92176156481, 3923.7253392262837, 3935.173613541131, 3951.328274193394, 3956.9604303957167, 5263.052650522866, 5269.762860671279, 5274.7890084396195, 5277.182036784305, 5317.627766056339, 5600.35595906476, 5647.181158731961, 5651.632643878134, 5678.375378708339, 5725.227094342211, 5259.39516955555, 5287.947120528823, 5289.365276166807, 5291.920621190685, 5307.708076055854, 4893.926591101136, 4901.387326584177, 4904.6566740327835, 4916.164252077084, 4937.259411088294, 5630.0991841305195, 5748.7125643717645, 5773.711314434261, 5826.126081087871, 5913.05391137416, 5710.628809127394, 5712.80005199816, 5716.828495145152, 5720.313562372542, 5724.8282551523525, 5879.470847623735, 5885.264341957255, 5910.320313164041, 5911.231539899785, 5914.201582786269, 5403.108487099585, 5437.9939711153565, 5481.123020316731, 5497.532709719719, 5645.887082258249, 5502.724863756876, 5603.691796951207, 5638.464345887134, 5640.871825634971, 5647.519960803378, 5526.889462210653, 5534.695591742493, 5538.307711536058, 5541.501264886179, 5544.7227638617105, 5500.092484740133, 5519.530839878656, 5525.613207075467, 5528.226048353315, 5555.749991250323, 5247.895042099213, 5290.206469029677, 5416.75624596902, 5428.7557059931605, 5461.208124821958, 5344.893102138013, 5345.518903298722, 5355.892882142413, 5391.056565101013, 5399.70301633414, 5235.869103272296, 5252.290940722954, 5254.106801843619, 5257.2639830423, 5290.28581141541], "unit": "score", "name": "dojo.html", "value": 5207.289325834746}, {"lowerIsBetter": false, "replicates": [527.2355085126565, 532.5021105266576, 535.213236542283, 549.6207616744449, 550.1774846604326, 26733.465330693376, 27758.0, 27779.861100694518, 27826.3043423914, 35630.2873942521, 40775.796121019426, 41745.373819392735, 41862.58137418625, 41891.37162942559, 41934.16131677364, 8448.577571121436, 8603.096674849145, 8624.180702833251, 8626.137386261387, 8641.006284277295, 7505.0, 7735.1491335953, 8608.096149904264, 10124.544395502184, 10376.066154046135, 9972.60109595619, 10121.949390253076, 10146.391216526996, 10158.644447444341, 10210.744731381701, 7514.624268786539, 10024.398536087858, 10125.240606954434, 10141.746456338577, 10147.441890696009, 7429.368503677194, 10013.79972400548, 10251.538680759384, 10253.43606101664, 10259.281850270485, 35418.64581354179, 35476.29047419037, 35599.0, 35739.64260357415, 35794.82102589496, 3162.652108268089, 3175.539546765706, 3179.2210908327606, 3287.1946373138735, 3378.847951842173, 29969.0, 30504.237394065327, 30534.389312213854, 30549.0, 31473.370532589448, 3357.2781851901714, 3456.6024907135497, 3631.2555926035366, 3641.927161456756, 3790.2608991246716, 275381.0, 276405.0, 277090.0, 277217.99999999796, 278013.0, 52936.735316323175, 53648.46351536435, 59723.0, 62081.68959155175, 63124.68437657874, 55344.72327638336, 55360.72319638376, 55373.0, 55443.72278138664, 55582.16626750602, 15288.312025958858, 15459.458918937784, 15497.14765687898, 15498.0, 15500.689986200212, 11476.368799716096, 11528.193026488234, 11535.711607209887, 11536.59621913229, 11553.422328883522, 19901.60196796056, 20082.0, 20210.494737631678, 20353.898230508752, 20360.592788144153, 7814.413918956101, 7897.210278972057, 7990.480618759762, 8025.799355016171, 8111.310538604284, 893.4862454088925, 911.3529394130242, 963.9132478077007, 1061.9751939378536, 1136.4431428599926, 28073.578896316572, 28096.578551321745, 28335.43329133447, 28545.42909141847, 28631.713682863323, 985.1921424431897, 994.5176589354157, 1023.2734758321675, 1040.1990467340106, 1105.9668209953713, 14896.329665165094, 15870.841291587167, 16194.0, 16241.756373654405, 16302.673946521003, 388075.0, 394425.0, 394614.0, 396388.0, 398348.0, 54422.45577544253, 54514.45485545094, 55016.0, 55081.0, 55179.17231241534, 1320.650027742649, 1329.7274058817918, 1332.3538084029433, 1334.846492653338, 1341.215388997428, 28293.858530707214, 29268.56097158502, 30084.548731768602, 30506.542401864433, 30552.541711873895, 44424.33363499485, 44462.3330650047, 45088.0, 45129.0, 45547.31679024751, 308414.0, 316882.0, 318514.0, 320899.0, 322213.0, 39488.21023579455, 39563.80218098891, 40067.79966100151, 40134.0, 40155.39766903557, 43641.78179109084, 43969.0, 43995.56004439915, 44924.55075449204, 45078.54921450744, 36634.63365366312, 36740.81629591835, 37708.811455942545, 37817.81091094527, 38939.0, 36750.0, 37071.258574827814, 37940.241195176495, 38025.0, 38063.23873522569, 36426.0, 37045.6295437053, 37229.0, 37468.25063498769, 37585.81207093947, 31799.0, 32555.18612034718, 33752.0, 33887.322253554295, 33928.0, 25115.0, 25356.112536061148, 25467.10865119712, 25472.363190920376, 25644.87177564175], "unit": "score", "name": "ext.html", "value": 18744.6101805015}, {"lowerIsBetter": false, "replicates": [365.5083912138175, 365.6325392980055, 365.92864391443663, 367.4561648759835, 368.7676763638907, 13879.444822207124, 13882.4447022119, 16049.83950160498, 16111.83888161118, 16712.498625041237, 16040.35838566456, 16419.58951026225, 16825.495235142935, 17006.40477583285, 17008.4047058353, 5366.597505187107, 5495.53287970523, 5497.092979658351, 5499.230107784913, 5511.862203444906, 4091.6317531422164, 4280.785960701968, 5450.4549545045575, 5488.5609151268, 5820.0, 5940.495057920082, 5977.7608895644125, 5978.671173085479, 5979.342272350038, 5995.490383317423, 4988.102141614508, 5150.484951504857, 5158.045761534128, 5165.483451654842, 5958.761649534035, 4832.565069143794, 4952.158133117378, 4953.0, 4956.330895329156, 5167.354080739908, 11705.765884682343, 12069.818952715716, 12151.453184606626, 12157.148999570034, 17956.371526996492, 2026.138890971346, 2054.732884724991, 2114.7039414481983, 2119.7668256491775, 2180.1824315881545, 8691.739247822576, 9080.909190908138, 9089.63641454341, 9423.0, 11255.60605378816, 1804.9097545122822, 1870.5978214683773, 1875.8117446437295, 1893.848492120627, 1920.4430715092606, 59786.701066494825, 61551.692241538956, 61955.0, 63016.684916575585, 64218.35781642217, 10261.127804136582, 10275.332103413255, 10386.584536618602, 10413.791724165474, 10471.371717696962, 13649.181049137083, 13656.0, 13659.863401366058, 13660.112092713942, 13667.111637743516, 7297.233790452032, 7668.80827979305, 7690.038745156856, 7691.077070751546, 7727.150013498623, 7391.33477986973, 7392.852142957111, 7443.106827180773, 7447.0, 7469.327760501581, 4450.287953927356, 4509.706869053501, 4523.95476045242, 4574.954250457519, 4579.313103034571, 1715.794104707443, 1739.5651087228193, 1761.1810508113788, 1767.2400867627043, 1830.9267629294945, 399.436794120289, 402.23374471631587, 856.8115014696757, 917.1882883648019, 1018.2719355660738, 9727.0, 10306.227032972558, 10435.94782026085, 14315.856841431452, 16104.67790644204, 842.8862103616055, 882.6557642519423, 927.4435338796668, 929.1126973740062, 930.283681565191, 9200.769980750401, 9303.395279306824, 9676.661316853877, 9677.177439917687, 9686.709398717909, 496855.5471667928, 497223.0, 505117.0, 563164.0, 571715.0, 40812.38781418281, 40924.590754092074, 63955.0, 81134.59432702916, 84198.5790071058, 1114.593173491686, 1132.903703185222, 1140.5095808802296, 1147.3173461790223, 1149.7240662241002, 14750.704985900436, 14993.925030374778, 15185.468508602145, 15310.234488275764, 15433.22833858325, 32554.511682325257, 32876.34247315088, 33641.3271734559, 34113.82943085368, 36061.0984725384, 42032.78983605062, 42055.789721052424, 42720.14559708851, 42744.0, 43033.354499683155, 8961.283097352065, 9381.108794664497, 9385.0, 9421.764455888657, 9422.340436169403, 17086.48740537736, 17170.828291716924, 17416.216270267614, 17626.206820693355, 17691.0, 11837.881621184022, 12014.819777703517, 12026.098042647012, 13096.869031309947, 14211.218382989035, 13311.46754129824, 13356.332183390987, 13606.93196534011, 14216.644583885485, 14372.0, 11866.0, 12240.75518489643, 13673.453061877812, 13819.861801381858, 14567.781483277548, 8688.78278043054, 8972.596233169654, 9226.677066302647, 9228.446293222429, 9279.443233406017, 9828.213742900694, 9889.752756181153, 11348.602798901999, 14004.759865768063, 14254.928725356307], "unit": "score", "name": "jquery.html", "value": 8409.153838137168}, {"lowerIsBetter": false, "replicates": [1315.907886447949, 1462.3127130248783, 1472.676011277519, 1605.25355709595, 1799.5770993816443, 6974.3374379433935, 7131.3581777640065, 7449.106107267129, 7548.773536793891, 7560.39516838653, 7491.513051651639, 7560.546367217957, 7616.923830761691, 7633.694652213905, 7637.0, 2003.4690806936173, 2036.1244664794133, 2322.965155522664, 2353.4234112642425, 2354.5761762882676, 2345.2026311054324, 2370.3244575296044, 2370.9881450592725, 2373.347329484397, 2385.9284221473386, 2249.5388445368662, 2298.2415802785126, 2298.5517824024323, 2300.7929286364224, 2301.137073597401, 2305.6195727704994, 2322.4890524084676, 2357.776011278934, 2358.233574088428, 2358.481134150484, 2346.9647955280684, 2359.728631207416, 2398.484325869946, 2399.2802159352123, 2401.1955994741606, 7727.884081738778, 7803.882941755822, 7813.609319534001, 7823.8435231295625, 7831.960840195819, 4701.68352861196, 4772.045590881838, 4811.061842940628, 4817.759112044384, 4821.566059054702, 2935.6330458692664, 3027.742641875443, 3044.5737596736476, 3081.4915538936275, 3083.629964404286, 917.0691747875911, 920.5903372999018, 943.5848226780195, 951.9476428796413, 967.8257913575553, 9662.56518456671, 9753.951230243874, 9757.707268781947, 9768.560414781352, 9774.413535187912, 4043.7169398141846, 4109.219248342805, 4127.958720412757, 4243.766592837424, 4342.41377414045, 8607.870881936651, 8852.336074794417, 8854.645814167361, 8862.689805856764, 8874.0, 4648.604868586208, 4650.09323181983, 4680.602148817321, 4687.250039993584, 4696.9060618787435, 4272.252355837716, 4305.48334199898, 4321.092570560155, 4323.870283891489, 4328.5455027222315, 3263.461528847761, 3300.4884242941903, 3428.6914177724125, 3447.500112483676, 3457.291255292659, 1101.867775866885, 1117.9217454778088, 1120.8262719278525, 1124.9650321704053, 1130.7003644034337, 1059.2902755154066, 1286.8713128687057, 1288.2270637617542, 1307.1438207973792, 1331.6937104466026, 7019.227884932653, 7070.75252366175, 7083.114610673666, 7192.712291508281, 7199.280071992759, 598.8293336399105, 608.9512838972871, 610.7770663707804, 611.1993288791608, 745.9925400746032, 5442.428545002796, 5510.311211098613, 5563.304586926634, 5583.553315734732, 5584.246126772915, 9172.0, 9336.673216437528, 9350.859737103949, 9377.0, 9500.762480937894, 9269.536523173814, 9349.579268932914, 9446.527673616292, 9531.52342382892, 9549.904500955041, 6980.197277313073, 7038.472114591426, 7293.489455738153, 7369.7052117915755, 7392.96303518479, 7021.297870212938, 7079.327463890922, 7079.68141433647, 7088.539244949062, 7092.5389849659605, 8233.79415514617, 8430.494170349553, 8614.138586141336, 8614.310855131449, 8635.654573816977, 8675.609597567998, 8691.304695624462, 8771.517566533646, 8826.64693412282, 8863.379563430499, 6755.763548275787, 6960.721571137098, 6967.686454109476, 6971.337722916315, 6987.790366289019, 6475.514336424882, 6597.0, 6862.519623626298, 6955.095837541087, 7029.437644988491, 6547.377999090078, 6628.469722422291, 6830.282820303796, 6830.897536536857, 6976.127984002, 6577.704003319766, 6753.3246675332075, 6815.522913396213, 6835.316468353125, 7018.613976231356, 7099.609521476368, 7121.786346409616, 7154.463415243981, 7173.713051478091, 7189.0, 6252.562320637512, 6338.334474880256, 6389.7763578274535, 6559.442447392025, 6596.90104648421, 6373.139626150596, 6422.100905873088, 6424.775132870327, 6425.550211485338, 6435.680685459563], "unit": "score", "name": "mootools.html", "value": 4367.163775620365}, {"lowerIsBetter": false, "replicates": [339.6467673619436, 344.80173900007486, 346.158834033299, 346.52526039326125, 350.5215381004928, 5766.740496677649, 5867.1492633568105, 5892.2340095787595, 5901.350851406352, 5952.7321270542825, 5764.740586673599, 5885.058390657496, 5887.676177810219, 5894.322152952412, 5922.703864806753, 4605.723656580599, 4605.9769701151445, 4610.262358022717, 4617.676762626617, 4619.792109355087, 4379.978100109495, 4448.488423831269, 4453.131639330332, 4496.505384407713, 4626.329182268569, 4550.544945505456, 4555.157295900252, 4565.908681826361, 4585.19759042168, 4609.101225261059, 4549.567791059877, 4552.817887284521, 4553.635709143261, 4558.680892337537, 4595.977020114878, 4051.1290072634524, 4052.2098190852794, 4064.4919385076864, 4074.388841673743, 4075.4701888754566, 5517.641353312022, 5663.093904975184, 5665.5467562594895, 5670.3479099903625, 5705.115707065412, 5265.86835329116, 5273.393559740641, 5280.07598670235, 5284.920726189111, 5291.100512912814, 5972.9701351493395, 6290.716917738713, 6300.59046161998, 6301.968490157566, 6305.905411418832, 4208.831646734127, 4281.785910704483, 4362.345648152771, 4363.061941682554, 4400.691951563392, 6453.451456626192, 6509.2839787623325, 6546.738130474775, 6549.639769812658, 6552.705128269239, 4472.932906006413, 4496.3705081288645, 4500.257457519538, 4500.7622903701085, 4502.144592527409, 4479.574440428154, 4560.452745670541, 4569.268916973335, 4569.474510431343, 4589.059242855206, 5258.079836028756, 5260.605454590845, 5261.868453288698, 5265.183896496049, 5270.552003079782, 6298.118263443122, 6302.873942521124, 6303.086052522359, 6303.6217826929615, 6305.4009869062365, 1605.2214675882187, 1626.7071927053007, 1627.3409269245738, 1627.8453546913024, 1629.0144462600192, 1084.38732116354, 1090.2804149261449, 1093.0326660905157, 1093.2347356850237, 1119.3899324867966, 5968.074948383008, 5982.700864956735, 5986.580939334205, 5987.101934709828, 5997.310309314485, 6489.0, 6491.805245842632, 6493.285738568754, 6499.09012738217, 6503.9349606504275, 5867.295924489089, 5953.196318497034, 5969.134475501028, 5970.701464926823, 5980.910286345708, 3471.913202169966, 3516.331896939573, 3541.3979623464074, 3542.557180352456, 3552.289542091592, 6738.831529211809, 6742.123523941857, 6753.966230168818, 6754.324567543206, 6760.830979225559, 6683.0, 6685.565438246498, 6687.933120668828, 6691.59850408977, 6693.665316734144, 6559.704813283413, 6697.866042679119, 6736.562123461959, 6742.393184613408, 6744.696488658022, 6259.1550140730415, 6440.8389790255615, 6474.741010359721, 6480.384363485461, 6486.772962946275, 6346.936530634634, 6494.0, 6512.902306465501, 6516.771912983023, 6522.478201743944, 6725.596464212163, 6726.192856857208, 6778.084958530535, 6792.3547263011915, 6820.795376138723, 4461.375407442895, 4474.865754027384, 4527.932081018722, 4537.523560026149, 4547.704399214041, 6531.248906375828, 6571.3757193066585, 6584.868302634016, 6587.901181482377, 6589.604623722592, 6392.169018027626, 6403.487720982217, 6413.743450261937, 6414.230292364946, 6425.614463132227, 6280.340564240689, 6359.586626869239, 6413.7113829876835, 6415.582987105823, 6416.711247993945, 6246.281677606951, 6266.68666566679, 6267.1539342188225, 6272.0, 6279.403456671792, 6393.264774550986, 6397.0, 6402.519811014099, 6403.231612206565, 6411.3909178627955, 6158.538109641705, 6268.1851359323, 6281.780137695158, 6292.622442653455, 6307.274663413583], "unit": "score", "name": "prototype.html", "value": 4776.321298187916}, {"lowerIsBetter": false, "replicates": [577.9913301300479, 653.2879161713734, 664.5514277862443, 708.4828075504885, 737.1191426245637, 10889.401082940434, 11134.220604557684, 11156.609518666839, 11157.832632510519, 11167.385793781339, 11980.880191198085, 12067.3966301685, 12069.879301206985, 12072.939635301811, 12081.15431919766, 787.4684587903171, 802.8554860125175, 802.9156938521459, 804.1395706593947, 806.1213277527494, 664.5082638847242, 671.1744554198339, 791.8020494876281, 800.075912321267, 816.2368185746317, 847.9194476524721, 859.4671303791627, 863.8229163021597, 863.87905693203, 864.8789169516273, 695.1901035293877, 841.4908980067032, 848.707196017373, 849.3502470609989, 849.995750021249, 516.5738265930585, 618.3661746709614, 622.0731110645106, 626.2485017978444, 627.0500192208807, 11899.226550274205, 11917.582884598998, 11940.283582985048, 11951.820722689166, 11956.760864782742, 10893.782124357469, 12369.196002259825, 12392.132550721453, 12715.237085774883, 12717.236965782082, 8771.649134034631, 9001.909980900173, 9112.225460835836, 9225.308101892319, 9376.203022743006, 3585.8924232273075, 3591.856325746967, 3614.5301110855685, 3621.9275614487565, 3651.1967367179177, 47627.76186119047, 47899.52100478986, 47952.52047479516, 48072.03855922897, 48198.759006205095, 9470.90529094714, 9611.855822162674, 9644.421334719938, 9829.55766990487, 9830.361026533252, 18156.092195390444, 18181.81818181828, 18295.359662411753, 18334.0, 18341.90829045873, 7443.55338679681, 7568.697252109964, 7645.655945482466, 7767.766966990999, 7828.138904720477, 3953.723239373216, 4241.130568233505, 4295.570442955742, 4355.60799528044, 4466.709663871903, 2780.207640822356, 2816.0847724489213, 2817.8591070446805, 2818.873150708223, 2819.5488721804413, 503.4260942525524, 504.6643981752167, 511.5089514066538, 515.5875299760177, 518.6395455158629, 567.9472833519831, 597.5667640960356, 602.0848310567912, 602.2111034544761, 642.4635429416489, 8228.177182281725, 8230.711925082593, 8314.875276870851, 8442.113578074337, 8554.743357699279, 418.7526662384312, 483.9588634965997, 501.64633933077096, 569.8062658695981, 607.1227076873963, 3864.516935383077, 3997.3004724173734, 4007.992007992008, 4039.2931237033404, 4214.241436541391, 53216.733916330944, 53342.46657533375, 53552.73223633857, 53663.463365366624, 56479.352064793195, 48423.5157648426, 48767.512324877, 49328.50671493311, 49643.0, 50306.49693503091, 43490.0, 44522.77738611351, 44608.33087503625, 44789.552104478535, 45077.54922450799, 7684.211571495203, 8109.75670729879, 8164.918350816416, 8185.467944583583, 8262.0, 32312.35375292434, 32808.67191328056, 33396.66603334033, 33453.66546334603, 33472.16319592029, 39922.20155596814, 40294.0, 42219.3667095, 42858.142837142455, 43189.13621727611, 9819.263555233243, 9951.15415189717, 9979.251556133464, 10065.69802905914, 10073.496325183565, 10195.337303075275, 10577.31247468912, 10962.725931851768, 11016.834747478955, 11112.499937502993, 11066.28069175501, 11129.387883666475, 11148.55405783792, 11291.943540282246, 11393.031592314746, 10848.0, 11013.83479247828, 11390.886091138982, 11755.588554400554, 11920.225185362924, 10935.671929842118, 11214.215004949576, 11258.211925165488, 11400.0, 11438.313701177956, 8699.695510657097, 8970.147835955573, 8978.326625502983, 8981.345212998822, 9237.538123093953, 8523.616437260214, 8718.738437846874, 9051.094890510896, 9727.367721098106, 9999.400035997864], "unit": "score", "name": "yui.html", "value": 5950.928984123386}], "name": "dromaeo_css", "value": 6834.284904192966}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 104.0, 111.0, 111.0, 113.0, 100.0, 110.0, 110.0, 117.0], "unit": "score", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [148.0, 125.0, 158.0, 173.0, 130.0, 153.0, 150.0, 131.0, 175.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 147.3}, {"lowerIsBetter": true, "replicates": [161.0, 164.0, 161.0, 161.0, 162.0, 165.0, 161.0, 163.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [75.0, 72.0, 82.0, 94.0, 72.0, 74.0, 72.0, 110.0, 94.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.6}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 152.0, 98.0, 97.0, 97.0, 150.0, 97.0, 97.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 112.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 146.0, 146.0, 146.0, 146.0, 148.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 58.0, 57.0, 59.0, 58.0, 60.0, 60.0, 61.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.7}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 68.0, 69.0, 69.0, 68.0, 69.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [93.0, 86.0, 87.0, 87.0, 85.0, 86.0, 87.0, 86.0, 86.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.1}, {"lowerIsBetter": true, "replicates": [116.0, 128.0, 119.0, 117.0, 124.0, 121.0, 117.0, 119.0, 117.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.9}, {"lowerIsBetter": true, "replicates": [159.0, 145.0, 154.0, 156.0, 144.0, 145.0, 152.0, 156.0, 153.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.4}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 69.0, 69.0, 69.0, 68.0, 78.0, 70.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.2}], "name": "kraken", "value": 1520.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.37851490149856], "unit": "score", "name": "Richards", "value": 209.65857799999998}, {"lowerIsBetter": false, "replicates": [191.93857965451056], "unit": "score", "name": "DeltaBlue", "value": 344.4747799999999}, {"lowerIsBetter": false, "replicates": [288.6836027713626], "unit": "score", "name": "Encrypt", "value": 922.0509840000003}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [2040.8163265306123], "unit": "score", "name": "RayTrace", "value": 362.5946099999999}, {"lowerIsBetter": false, "replicates": [804.5052292839904], "unit": "score", "name": "Earley", "value": 828.4135089999997}, {"lowerIsBetter": false, "replicates": [12708.860759493671], "unit": "score", "name": "Boyer", "value": 52.440813745019945}, {"lowerIsBetter": false, "replicates": [26076.923076923078], "unit": "score", "name": "RegExp", "value": 34.934528023598794}, {"lowerIsBetter": false, "replicates": [664.4518272425249], "unit": "score", "name": "Splay", "value": 122.64395499999999}, {"lowerIsBetter": false, "replicates": [4887.804878048781], "unit": "score", "name": "NavierStokes", "value": 303.61277445109783}], "name": "v8_7", "value": 19329.41321368511}]} 08:33:00 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19329.41"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1520.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6834.28"}}} 08:33:00 INFO - Return code: 0 08:33:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:33:00 INFO - # TBPL SUCCESS # 08:33:00 INFO - Running post-action listener: _resource_record_post_action 08:33:00 INFO - Running post-run listener: _resource_record_post_run 08:33:01 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 548159488; Read time: 56; Write time: 505472 08:33:01 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 238800896; Read time: 0; Write time: 282408 08:33:01 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 309358592; Read time: 56; Write time: 223064 08:33:01 INFO - Running post-run listener: _upload_blobber_files 08:33:01 INFO - Blob upload gear active. 08:33:01 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:33:01 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 08:33:01 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'] 08:33:01 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 08:33:06 INFO - (blobuploader) - INFO - Open directory for files ... 08:33:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:33:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:33:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:33:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:33:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:33:07 INFO - (blobuploader) - INFO - Done attempting. 08:33:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:33:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:33:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:33:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:33:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:33:08 INFO - (blobuploader) - INFO - Done attempting. 08:33:08 INFO - (blobuploader) - INFO - Iteration through files over. 08:33:08 INFO - Return code: 0 08:33:08 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:33:08 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:33:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d49e8460ea3ca004bac3e599a8774fbbf669d7db94128f40f8da8ce3e278577f50db579bfa3b4db782e80ea5ef6f8c1d35f0c5e268ed27e6c39cf9b197114f31", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc58764525c3e80945bd8fe077c5c1087bec823179b1ba20fdf754960b3ccf82e311e8e667e2653bc36bc4ed0759e297c62593519072225e2217f44e144494d6"} 08:33:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:33:08 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:33:08 INFO - Contents: 08:33:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d49e8460ea3ca004bac3e599a8774fbbf669d7db94128f40f8da8ce3e278577f50db579bfa3b4db782e80ea5ef6f8c1d35f0c5e268ed27e6c39cf9b197114f31", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc58764525c3e80945bd8fe077c5c1087bec823179b1ba20fdf754960b3ccf82e311e8e667e2653bc36bc4ed0759e297c62593519072225e2217f44e144494d6"} 08:33:08 INFO - Copying logs to upload dir... 08:33:08 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1275.964970 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-06 08:33:08.310346) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 08:33:08.314275) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452096710.536507-1756438155 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/d49e8460ea3ca004bac3e599a8774fbbf669d7db94128f40f8da8ce3e278577f50db579bfa3b4db782e80ea5ef6f8c1d35f0c5e268ed27e6c39cf9b197114f31", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc58764525c3e80945bd8fe077c5c1087bec823179b1ba20fdf754960b3ccf82e311e8e667e2653bc36bc4ed0759e297c62593519072225e2217f44e144494d6"} build_url:https://queue.taskcluster.net/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/NJR5g7nuSK2YF5Rlz9LIlw/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/d49e8460ea3ca004bac3e599a8774fbbf669d7db94128f40f8da8ce3e278577f50db579bfa3b4db782e80ea5ef6f8c1d35f0c5e268ed27e6c39cf9b197114f31", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc58764525c3e80945bd8fe077c5c1087bec823179b1ba20fdf754960b3ccf82e311e8e667e2653bc36bc4ed0759e297c62593519072225e2217f44e144494d6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 08:33:08.338964) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 08:33:08.339305) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452096710.536507-1756438155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004598 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 08:33:08.423996) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 08:33:08.424343) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 08:33:08.424663) ========= ========= Total master_lag: 0.25 =========