builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1452581909.06 results: success (0) buildid: 20160111203200 builduid: 8023b37fc7034a87afa696498af8c4de revision: d9661fecd939146a14c5c591f395a68e2d75d211 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:29.059803) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:29.060273) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:29.060594) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1452581630.560416-1703302380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006375 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:29.091964) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:29.092603) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:29.157047) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:29.157705) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1452581630.560416-1703302380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:29.244757) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:29.245029) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:29.245397) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:29.245705) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1452581630.560416-1703302380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-11 22:58:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 8.80M=0.001s 2016-01-11 22:58:30 (8.80 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181843 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:29.443401) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:29.444152) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1452581630.560416-1703302380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020439 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:29.496757) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:29.497455) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d9661fecd939146a14c5c591f395a68e2d75d211 --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 d9661fecd939146a14c5c591f395a68e2d75d211 --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=e0e61f6f900f4dc42e3e8956000001ad-1452581630.560416-1703302380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-11 22:58:30,294 truncating revision to first 12 chars 2016-01-11 22:58:30,294 Setting DEBUG logging. 2016-01-11 22:58:30,294 attempt 1/10 2016-01-11 22:58:30,294 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d9661fecd939?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-11 22:58:30,872 unpacking tar archive at: fx-team-d9661fecd939/testing/mozharness/ program finished with exit code 0 elapsedTime=0.920986 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:30.440366) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:30.440910) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:30.455142) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:30.455648) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:30.456761) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-11 22:58:30.457185) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1452581630.560416-1703302380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:58:31 INFO - MultiFileLogger online at 20160111 22:58:31 in /builds/slave/test-pgo 22:58:31 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 22:58:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:58:31 INFO - {'append_to_log': False, 22:58:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:58:31 INFO - 'blob_upload_branch': 'Fx-Team', 22:58:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:58:31 INFO - 'branch': 'Fx-Team', 22:58:31 INFO - 'buildbot_json_path': 'buildprops.json', 22:58:31 INFO - 'config_files': ('talos/linux_config.py',), 22:58:31 INFO - 'default_actions': ('clobber', 22:58:31 INFO - 'read-buildbot-config', 22:58:31 INFO - 'download-and-extract', 22:58:31 INFO - 'populate-webroot', 22:58:31 INFO - 'create-virtualenv', 22:58:31 INFO - 'install', 22:58:31 INFO - 'run-tests'), 22:58:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:58:31 INFO - 'download_minidump_stackwalk': True, 22:58:31 INFO - 'download_symbols': 'ondemand', 22:58:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:58:31 INFO - 'tooltool.py': '/tools/tooltool.py', 22:58:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:58:31 INFO - '/tools/misc-python/virtualenv.py')}, 22:58:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:58:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:58:31 INFO - 'installer_path': 'installer.exe', 22:58:31 INFO - 'log_level': 'info', 22:58:31 INFO - 'log_name': 'talos', 22:58:31 INFO - 'log_to_console': True, 22:58:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:58:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:58:31 INFO - 'opt_config_files': (), 22:58:31 INFO - 'pip_index': False, 22:58:31 INFO - 'sps_profile': False, 22:58:31 INFO - 'sps_profile_interval': 0, 22:58:31 INFO - 'suite': 'dromaeojs', 22:58:31 INFO - 'system_bits': '32', 22:58:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:58:31 INFO - 'title': 'talos-linux64-ix-067', 22:58:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:58:31 INFO - 'use_talos_json': True, 22:58:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:58:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:58:31 INFO - 'work_dir': 'build'} 22:58:31 INFO - ##### 22:58:31 INFO - ##### Running clobber step. 22:58:31 INFO - ##### 22:58:31 INFO - Running pre-action listener: _resource_record_pre_action 22:58:31 INFO - Running main action method: clobber 22:58:31 INFO - rmtree: /builds/slave/test-pgo/build 22:58:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:58:31 INFO - Running post-action listener: _resource_record_post_action 22:58:31 INFO - ##### 22:58:31 INFO - ##### Running read-buildbot-config step. 22:58:31 INFO - ##### 22:58:31 INFO - Running pre-action listener: _resource_record_pre_action 22:58:31 INFO - Running main action method: read_buildbot_config 22:58:31 INFO - Using buildbot properties: 22:58:31 INFO - { 22:58:31 INFO - "project": "", 22:58:31 INFO - "product": "firefox", 22:58:31 INFO - "script_repo_revision": "production", 22:58:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:58:31 INFO - "repository": "", 22:58:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 22:58:31 INFO - "buildid": "20160111203200", 22:58:31 INFO - "pgo_build": "True", 22:58:31 INFO - "basedir": "/builds/slave/test-pgo", 22:58:31 INFO - "buildnumber": 413, 22:58:31 INFO - "slavename": "talos-linux64-ix-067", 22:58:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:58:31 INFO - "platform": "ubuntu64_hw", 22:58:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:58:31 INFO - "branch": "fx-team", 22:58:31 INFO - "repo_path": "integration/fx-team", 22:58:31 INFO - "revision": "d9661fecd939146a14c5c591f395a68e2d75d211", 22:58:31 INFO - "stage_platform": "linux64-pgo", 22:58:31 INFO - "builduid": "8023b37fc7034a87afa696498af8c4de", 22:58:31 INFO - "slavebuilddir": "test" 22:58:31 INFO - } 22:58:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:58:31 INFO - Running post-action listener: _resource_record_post_action 22:58:31 INFO - ##### 22:58:31 INFO - ##### Running download-and-extract step. 22:58:31 INFO - ##### 22:58:31 INFO - Running pre-action listener: _resource_record_pre_action 22:58:31 INFO - Running main action method: download_and_extract 22:58:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:31 INFO - https://queue.taskcluster.net/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:58:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/test_packages.json 22:58:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/test_packages.json 22:58:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:58:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:58:33 INFO - Downloaded 1302 bytes. 22:58:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:58:33 INFO - Using the following test package requirements: 22:58:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:58:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:58:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:33 INFO - u'jsshell-linux-x86_64.zip'], 22:58:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:58:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:58:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:58:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:58:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:58:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:58:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:58:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:33 INFO - https://queue.taskcluster.net/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:58:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:58:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:58:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:58:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:58:36 INFO - Downloaded 24025103 bytes. 22:58:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 22:58:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:58:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:58:37 INFO - Return code: 0 22:58:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:37 INFO - https://queue.taskcluster.net/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:58:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:58:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:58:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:58:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:58:41 INFO - Downloaded 24025103 bytes. 22:58:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 22:58:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:58:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:58:42 INFO - Return code: 0 22:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:42 INFO - https://queue.taskcluster.net/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:58:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:58:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:58:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:58:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:58:44 INFO - Downloaded 11132285 bytes. 22:58:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 22:58:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:58:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 22:58:44 INFO - Return code: 0 22:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:44 INFO - https://queue.taskcluster.net/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:58:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:58:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:58:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:58:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:58:51 INFO - Downloaded 55801592 bytes. 22:58:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:58:51 INFO - mkdir: /builds/slave/test-pgo/properties 22:58:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:58:51 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:58:51 INFO - Contents: 22:58:51 INFO - build_url:https://queue.taskcluster.net/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:58:51 INFO - Running post-action listener: _resource_record_post_action 22:58:51 INFO - Running post-action listener: set_extra_try_arguments 22:58:51 INFO - ##### 22:58:51 INFO - ##### Running populate-webroot step. 22:58:51 INFO - ##### 22:58:51 INFO - Running pre-action listener: _resource_record_pre_action 22:58:51 INFO - Running main action method: populate_webroot 22:58:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:58:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:58:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:58:51 INFO - '--tppagecycles', 22:58:51 INFO - '7'], 22:58:51 INFO - 'tests': ['tsvgm']}}, 22:58:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:58:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:58:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:58:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:58:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:58:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:58:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:58:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:51 INFO - 'talos_options': ['--e10s'], 22:58:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:58:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:51 INFO - 'tests': ['damp', 'tps']}, 22:58:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:51 INFO - 'talos_options': ['--e10s'], 22:58:51 INFO - 'tests': ['damp', 'tps']}, 22:58:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:58:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:58:51 INFO - 'other': {'tests': ['a11yr', 22:58:51 INFO - 'ts_paint', 22:58:51 INFO - 'tpaint', 22:58:51 INFO - 'sessionrestore', 22:58:51 INFO - 'sessionrestore_no_auto_restore']}, 22:58:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:58:51 INFO - 'tests': ['a11yr', 22:58:51 INFO - 'ts_paint', 22:58:51 INFO - 'tpaint', 22:58:51 INFO - 'sessionrestore', 22:58:51 INFO - 'sessionrestore_no_auto_restore']}, 22:58:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:58:51 INFO - 'tests': ['a11yr', 22:58:51 INFO - 'ts_paint', 22:58:51 INFO - 'tpaint', 22:58:51 INFO - 'sessionrestore', 22:58:51 INFO - 'sessionrestore_no_auto_restore']}, 22:58:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:58:51 INFO - 'tests': ['a11yr', 22:58:51 INFO - 'ts_paint', 22:58:51 INFO - 'tpaint', 22:58:51 INFO - 'sessionrestore', 22:58:51 INFO - 'sessionrestore_no_auto_restore']}, 22:58:51 INFO - 'other_l64': {'tests': ['a11yr', 22:58:51 INFO - 'ts_paint', 22:58:51 INFO - 'tpaint', 22:58:51 INFO - 'sessionrestore', 22:58:51 INFO - 'sessionrestore_no_auto_restore']}, 22:58:51 INFO - 'other_nol64': {'tests': ['a11yr', 22:58:51 INFO - 'ts_paint', 22:58:51 INFO - 'tpaint', 22:58:51 INFO - 'sessionrestore', 22:58:51 INFO - 'sessionrestore_no_auto_restore']}, 22:58:51 INFO - 'svgr': {'tests': ['tsvgx', 22:58:51 INFO - 'tsvgr_opacity', 22:58:51 INFO - 'tart', 22:58:51 INFO - 'tscrollx', 22:58:51 INFO - 'cart']}, 22:58:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:58:51 INFO - 'tests': ['tsvgx', 22:58:51 INFO - 'tsvgr_opacity', 22:58:51 INFO - 'tart', 22:58:51 INFO - 'tscrollx', 22:58:51 INFO - 'cart']}, 22:58:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:51 INFO - 'tests': ['tp5o']}, 22:58:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:51 INFO - 'talos_options': ['--e10s'], 22:58:51 INFO - 'tests': ['tp5o']}, 22:58:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:51 INFO - 'talos_options': ['--xperf_path', 22:58:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:58:51 INFO - 'tests': ['tp5n']}, 22:58:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:51 INFO - 'talos_options': ['--e10s', 22:58:51 INFO - '--xperf_path', 22:58:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:58:51 INFO - 'tests': ['tp5n']}}, 22:58:51 INFO - 'talos.zip': {'path': '', 22:58:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:58:51 INFO - Running post-action listener: _resource_record_post_action 22:58:51 INFO - ##### 22:58:51 INFO - ##### Running create-virtualenv step. 22:58:51 INFO - ##### 22:58:51 INFO - Running pre-action listener: _resource_record_pre_action 22:58:51 INFO - Running main action method: create_virtualenv 22:58:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:58:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 22:58:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:58:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:58:51 INFO - Using real prefix '/usr' 22:58:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:58:51 INFO - Installing distribute.............................................................................................................................................................................................done. 22:58:53 INFO - Installing pip.................done. 22:58:53 INFO - Return code: 0 22:58:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:58: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')]} 22:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58: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')]} 22:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:53 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 0x7f881fc05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e840>, '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 0x1d7b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7bb60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1452581630.560416-1703302380', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:58:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:58:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:58:53 INFO - Using env: {'DISPLAY': ':0', 22:58:53 INFO - 'HOME': '/home/cltbld', 22:58:53 INFO - 'LANG': 'en_US.UTF-8', 22:58:53 INFO - 'LANGUAGE': 'en_US:en', 22:58:53 INFO - 'LOGNAME': 'cltbld', 22:58:53 INFO - 'MAIL': '/var/mail/cltbld', 22:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:53 INFO - 'MOZ_NO_REMOTE': '1', 22:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:53 INFO - 'NO_EM_RESTART': '1', 22:58:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:53 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:53 INFO - 'SHELL': '/bin/bash', 22:58:53 INFO - 'SHLVL': '1', 22:58:53 INFO - 'TERM': 'linux', 22:58:53 INFO - 'TMOUT': '86400', 22:58:53 INFO - 'USER': 'cltbld', 22:58:53 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452581630.560416-1703302380', 22:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:53 INFO - '_': '/tools/buildbot/bin/python'} 22:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:58:53 INFO - Cleaning up... 22:58:53 INFO - Return code: 0 22:58:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:58: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')]} 22:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58: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')]} 22:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:53 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 0x7f881fc05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e840>, '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 0x1d7b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7bb60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1452581630.560416-1703302380', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:58:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:58:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:58:53 INFO - Using env: {'DISPLAY': ':0', 22:58:53 INFO - 'HOME': '/home/cltbld', 22:58:53 INFO - 'LANG': 'en_US.UTF-8', 22:58:53 INFO - 'LANGUAGE': 'en_US:en', 22:58:53 INFO - 'LOGNAME': 'cltbld', 22:58:53 INFO - 'MAIL': '/var/mail/cltbld', 22:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:53 INFO - 'MOZ_NO_REMOTE': '1', 22:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:53 INFO - 'NO_EM_RESTART': '1', 22:58:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:53 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:53 INFO - 'SHELL': '/bin/bash', 22:58:53 INFO - 'SHLVL': '1', 22:58:53 INFO - 'TERM': 'linux', 22:58:53 INFO - 'TMOUT': '86400', 22:58:53 INFO - 'USER': 'cltbld', 22:58:53 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452581630.560416-1703302380', 22:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:53 INFO - '_': '/tools/buildbot/bin/python'} 22:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:54 INFO - Downloading/unpacking psutil>=0.7.1 22:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:55 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:58:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:58:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:58:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:58:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:58:56 INFO - Installing collected packages: psutil 22:58:56 INFO - Running setup.py install for psutil 22:58:56 INFO - building 'psutil._psutil_linux' extension 22:58:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:58:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:58:56 INFO - building 'psutil._psutil_posix' extension 22:58:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:58:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:58:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:58:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:58:56 INFO - Successfully installed psutil 22:58:56 INFO - Cleaning up... 22:58:56 INFO - Return code: 0 22:58:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:56 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 0x7f881fc05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e840>, '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 0x1d7b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7bb60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1452581630.560416-1703302380', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:58:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 22:58:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:58:56 INFO - Using env: {'DISPLAY': ':0', 22:58:56 INFO - 'HOME': '/home/cltbld', 22:58:56 INFO - 'LANG': 'en_US.UTF-8', 22:58:56 INFO - 'LANGUAGE': 'en_US:en', 22:58:56 INFO - 'LOGNAME': 'cltbld', 22:58:56 INFO - 'MAIL': '/var/mail/cltbld', 22:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:56 INFO - 'MOZ_NO_REMOTE': '1', 22:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:56 INFO - 'NO_EM_RESTART': '1', 22:58:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:56 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:56 INFO - 'SHELL': '/bin/bash', 22:58:56 INFO - 'SHLVL': '1', 22:58:56 INFO - 'TERM': 'linux', 22:58:56 INFO - 'TMOUT': '86400', 22:58:56 INFO - 'USER': 'cltbld', 22:58:56 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452581630.560416-1703302380', 22:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:56 INFO - '_': '/tools/buildbot/bin/python'} 22:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:58:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:58:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:58:58 INFO - Installing collected packages: mozsystemmonitor 22:58:58 INFO - Running setup.py install for mozsystemmonitor 22:58:58 INFO - Successfully installed mozsystemmonitor 22:58:58 INFO - Cleaning up... 22:58:58 INFO - Return code: 0 22:58:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f881fc05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e840>, '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 0x1d7b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7bb60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1452581630.560416-1703302380', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:58:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:58:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:58:58 INFO - Using env: {'DISPLAY': ':0', 22:58:58 INFO - 'HOME': '/home/cltbld', 22:58:58 INFO - 'LANG': 'en_US.UTF-8', 22:58:58 INFO - 'LANGUAGE': 'en_US:en', 22:58:58 INFO - 'LOGNAME': 'cltbld', 22:58:58 INFO - 'MAIL': '/var/mail/cltbld', 22:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:58 INFO - 'MOZ_NO_REMOTE': '1', 22:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:58 INFO - 'NO_EM_RESTART': '1', 22:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:58 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:58 INFO - 'SHELL': '/bin/bash', 22:58:58 INFO - 'SHLVL': '1', 22:58:58 INFO - 'TERM': 'linux', 22:58:58 INFO - 'TMOUT': '86400', 22:58:58 INFO - 'USER': 'cltbld', 22:58:58 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452581630.560416-1703302380', 22:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:58 INFO - '_': '/tools/buildbot/bin/python'} 22:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:58 INFO - Downloading/unpacking blobuploader==1.2.4 22:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:00 INFO - Downloading blobuploader-1.2.4.tar.gz 22:59:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:59:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:59:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:59:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:59:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:01 INFO - Downloading docopt-0.6.1.tar.gz 22:59:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:59:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:59:01 INFO - Installing collected packages: blobuploader, requests, docopt 22:59:01 INFO - Running setup.py install for blobuploader 22:59:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:59:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:59:01 INFO - Running setup.py install for requests 22:59:01 INFO - Running setup.py install for docopt 22:59:01 INFO - Successfully installed blobuploader requests docopt 22:59:01 INFO - Cleaning up... 22:59:01 INFO - Return code: 0 22:59:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:01 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 0x7f881fc05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e840>, '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 0x1d7b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7bb60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1452581630.560416-1703302380', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:59:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:59:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:59:01 INFO - Using env: {'DISPLAY': ':0', 22:59:01 INFO - 'HOME': '/home/cltbld', 22:59:01 INFO - 'LANG': 'en_US.UTF-8', 22:59:01 INFO - 'LANGUAGE': 'en_US:en', 22:59:01 INFO - 'LOGNAME': 'cltbld', 22:59:01 INFO - 'MAIL': '/var/mail/cltbld', 22:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:01 INFO - 'MOZ_NO_REMOTE': '1', 22:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:01 INFO - 'NO_EM_RESTART': '1', 22:59:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:59:01 INFO - 'PWD': '/builds/slave/test-pgo', 22:59:01 INFO - 'SHELL': '/bin/bash', 22:59:01 INFO - 'SHLVL': '1', 22:59:01 INFO - 'TERM': 'linux', 22:59:01 INFO - 'TMOUT': '86400', 22:59:01 INFO - 'USER': 'cltbld', 22:59:01 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452581630.560416-1703302380', 22:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:01 INFO - '_': '/tools/buildbot/bin/python'} 22:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:59:02 INFO - Running setup.py (path:/tmp/pip-MqdrSb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:59:02 INFO - Running setup.py (path:/tmp/pip-quYUMe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:59:02 INFO - Running setup.py (path:/tmp/pip-lwVLbg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:59:02 INFO - Running setup.py (path:/tmp/pip-HNe4zO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:59:02 INFO - Running setup.py (path:/tmp/pip-fPS9Pq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:59:02 INFO - Running setup.py (path:/tmp/pip-yyCSY8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:59:02 INFO - Running setup.py (path:/tmp/pip-534Yyr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:59:02 INFO - Running setup.py (path:/tmp/pip-x7dTQt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:59:02 INFO - Running setup.py (path:/tmp/pip-t0Dz5a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:59:02 INFO - Running setup.py (path:/tmp/pip-PgbkAO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:59:02 INFO - Running setup.py (path:/tmp/pip-I4uKO2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:59:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:59:02 INFO - Running setup.py (path:/tmp/pip-mk7VWB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:59:03 INFO - Running setup.py (path:/tmp/pip-3HUZmZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:59:03 INFO - Running setup.py (path:/tmp/pip-y0zSKQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:59:03 INFO - Running setup.py (path:/tmp/pip-N02X8C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:59:03 INFO - Running setup.py (path:/tmp/pip-rXoCK5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:59:03 INFO - Running setup.py (path:/tmp/pip-Wi_rTv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:59:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:59:03 INFO - Running setup.py install for manifestparser 22:59:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:59:03 INFO - Running setup.py install for mozcrash 22:59:03 INFO - Running setup.py install for mozdebug 22:59:03 INFO - Running setup.py install for mozdevice 22:59:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:59:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:59:03 INFO - Running setup.py install for mozfile 22:59:03 INFO - Running setup.py install for mozhttpd 22:59:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:59:03 INFO - Running setup.py install for mozinfo 22:59:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:59:04 INFO - Running setup.py install for mozInstall 22:59:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:59:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:59:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:59:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:59:04 INFO - Running setup.py install for mozleak 22:59:04 INFO - Running setup.py install for mozlog 22:59:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:59:04 INFO - Running setup.py install for moznetwork 22:59:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:59:04 INFO - Running setup.py install for mozprocess 22:59:04 INFO - Running setup.py install for mozprofile 22:59:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:59:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:59:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:59:04 INFO - Running setup.py install for mozrunner 22:59:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:59:04 INFO - Running setup.py install for mozscreenshot 22:59:04 INFO - Running setup.py install for moztest 22:59:05 INFO - Running setup.py install for mozversion 22:59:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:59:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:59:05 INFO - Cleaning up... 22:59:05 INFO - Return code: 0 22:59:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f881fc05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e840>, '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 0x1d7b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7bb60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1452581630.560416-1703302380', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:59:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:59:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:59:05 INFO - Using env: {'DISPLAY': ':0', 22:59:05 INFO - 'HOME': '/home/cltbld', 22:59:05 INFO - 'LANG': 'en_US.UTF-8', 22:59:05 INFO - 'LANGUAGE': 'en_US:en', 22:59:05 INFO - 'LOGNAME': 'cltbld', 22:59:05 INFO - 'MAIL': '/var/mail/cltbld', 22:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:05 INFO - 'MOZ_NO_REMOTE': '1', 22:59:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:05 INFO - 'NO_EM_RESTART': '1', 22:59:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:59:05 INFO - 'PWD': '/builds/slave/test-pgo', 22:59:05 INFO - 'SHELL': '/bin/bash', 22:59:05 INFO - 'SHLVL': '1', 22:59:05 INFO - 'TERM': 'linux', 22:59:05 INFO - 'TMOUT': '86400', 22:59:05 INFO - 'USER': 'cltbld', 22:59:05 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452581630.560416-1703302380', 22:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:05 INFO - '_': '/tools/buildbot/bin/python'} 22:59:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:59:05 INFO - Running setup.py (path:/tmp/pip-kGFrKs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 22:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:59:05 INFO - Running setup.py (path:/tmp/pip-BWBjiK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:59:05 INFO - Running setup.py (path:/tmp/pip-Eu3m9o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:59:05 INFO - Running setup.py (path:/tmp/pip-eKkMp2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:59:05 INFO - Running setup.py (path:/tmp/pip-m8PXuy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 22:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:59:05 INFO - Running setup.py (path:/tmp/pip-E1ygIQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 22:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:59:05 INFO - Running setup.py (path:/tmp/pip-Rh5ri6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 22:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:59:05 INFO - Running setup.py (path:/tmp/pip-W3OmWa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 22:59:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:59:05 INFO - Running setup.py (path:/tmp/pip-jL1lKS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 22:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:59:06 INFO - Running setup.py (path:/tmp/pip-fqjMM_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:59:06 INFO - Running setup.py (path:/tmp/pip-diiqKA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 22:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:59:06 INFO - Running setup.py (path:/tmp/pip-MUC8Hc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 22:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:59:06 INFO - Running setup.py (path:/tmp/pip-66wVd1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 22:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:59:06 INFO - Running setup.py (path:/tmp/pip-X3l_nC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 22:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:59:06 INFO - Running setup.py (path:/tmp/pip-UtKxCH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 22:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:59:06 INFO - Running setup.py (path:/tmp/pip-hAMNFX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 22:59:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:59:06 INFO - Running setup.py (path:/tmp/pip-JPMBqh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 22:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:59:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:08 INFO - Downloading blessings-1.5.1.tar.gz 22:59:08 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 22:59:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:59:08 INFO - Installing collected packages: blessings 22:59:08 INFO - Running setup.py install for blessings 22:59:08 INFO - Successfully installed blessings 22:59:08 INFO - Cleaning up... 22:59:08 INFO - Return code: 0 22:59:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:59:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:59:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:59:08 INFO - Reading from file tmpfile_stdout 22:59:08 INFO - Current package versions: 22:59:08 INFO - argparse == 1.2.1 22:59:08 INFO - blessings == 1.5.1 22:59:08 INFO - blobuploader == 1.2.4 22:59:08 INFO - docopt == 0.6.1 22:59:08 INFO - manifestparser == 1.1 22:59:08 INFO - mozInstall == 1.12 22:59:08 INFO - mozcrash == 0.16 22:59:08 INFO - mozdebug == 0.1 22:59:08 INFO - mozdevice == 0.47 22:59:08 INFO - mozfile == 1.2 22:59:08 INFO - mozhttpd == 0.7 22:59:08 INFO - mozinfo == 0.9 22:59:08 INFO - mozleak == 0.1 22:59:08 INFO - mozlog == 3.1 22:59:08 INFO - moznetwork == 0.27 22:59:08 INFO - mozprocess == 0.22 22:59:08 INFO - mozprofile == 0.28 22:59:08 INFO - mozrunner == 6.11 22:59:08 INFO - mozscreenshot == 0.1 22:59:08 INFO - mozsystemmonitor == 0.0 22:59:08 INFO - moztest == 0.7 22:59:08 INFO - mozversion == 1.4 22:59:08 INFO - psutil == 3.1.1 22:59:08 INFO - requests == 1.2.3 22:59:08 INFO - wsgiref == 0.1.2 22:59:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:08 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 0x7f881fc05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e840>, '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 0x1d7b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7bb60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1452581630.560416-1703302380', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:59:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 22:59:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:59:08 INFO - Using env: {'DISPLAY': ':0', 22:59:08 INFO - 'HOME': '/home/cltbld', 22:59:08 INFO - 'LANG': 'en_US.UTF-8', 22:59:08 INFO - 'LANGUAGE': 'en_US:en', 22:59:08 INFO - 'LOGNAME': 'cltbld', 22:59:08 INFO - 'MAIL': '/var/mail/cltbld', 22:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:08 INFO - 'MOZ_NO_REMOTE': '1', 22:59:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:08 INFO - 'NO_EM_RESTART': '1', 22:59:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:59:08 INFO - 'PWD': '/builds/slave/test-pgo', 22:59:08 INFO - 'SHELL': '/bin/bash', 22:59:08 INFO - 'SHLVL': '1', 22:59:08 INFO - 'TERM': 'linux', 22:59:08 INFO - 'TMOUT': '86400', 22:59:08 INFO - 'USER': 'cltbld', 22:59:08 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452581630.560416-1703302380', 22:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:08 INFO - '_': '/tools/buildbot/bin/python'} 22:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 22:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 22:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 22:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 22:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 22:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 22:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 22:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:59:08 INFO - Cleaning up... 22:59:08 INFO - Return code: 0 22:59:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:08 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 0x7f881fc05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e840>, '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 0x1d7b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7bb60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1452581630.560416-1703302380', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:59:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:59:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:59:09 INFO - Using env: {'DISPLAY': ':0', 22:59:09 INFO - 'HOME': '/home/cltbld', 22:59:09 INFO - 'LANG': 'en_US.UTF-8', 22:59:09 INFO - 'LANGUAGE': 'en_US:en', 22:59:09 INFO - 'LOGNAME': 'cltbld', 22:59:09 INFO - 'MAIL': '/var/mail/cltbld', 22:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:09 INFO - 'MOZ_NO_REMOTE': '1', 22:59:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:09 INFO - 'NO_EM_RESTART': '1', 22:59:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:59:09 INFO - 'PWD': '/builds/slave/test-pgo', 22:59:09 INFO - 'SHELL': '/bin/bash', 22:59:09 INFO - 'SHLVL': '1', 22:59:09 INFO - 'TERM': 'linux', 22:59:09 INFO - 'TMOUT': '86400', 22:59:09 INFO - 'USER': 'cltbld', 22:59:09 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452581630.560416-1703302380', 22:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:09 INFO - '_': '/tools/buildbot/bin/python'} 22:59:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:09 INFO - Downloading/unpacking jsonschema 22:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:59:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 22:59:10 INFO - Downloading/unpacking functools32 (from jsonschema) 22:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:11 INFO - Downloading functools32-3.2.3-2.tar.gz 22:59:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:59:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:59:11 INFO - warning: no files found matching '*.txt' 22:59:11 INFO - no previously-included directories found matching 'build' 22:59:11 INFO - no previously-included directories found matching 'dist' 22:59:11 INFO - no previously-included directories found matching '.git*' 22:59:11 INFO - Installing collected packages: jsonschema, functools32 22:59:11 INFO - Running setup.py install for functools32 22:59:11 INFO - warning: no files found matching '*.txt' 22:59:11 INFO - no previously-included directories found matching 'build' 22:59:11 INFO - no previously-included directories found matching 'dist' 22:59:11 INFO - no previously-included directories found matching '.git*' 22:59:11 INFO - Successfully installed jsonschema functools32 22:59:11 INFO - Cleaning up... 22:59:11 INFO - Return code: 0 22:59:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f881fc05f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e840>, '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 0x1d7b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7bb60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1452581630.560416-1703302380', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:59:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:59:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:59:11 INFO - Using env: {'DISPLAY': ':0', 22:59:11 INFO - 'HOME': '/home/cltbld', 22:59:11 INFO - 'LANG': 'en_US.UTF-8', 22:59:11 INFO - 'LANGUAGE': 'en_US:en', 22:59:11 INFO - 'LOGNAME': 'cltbld', 22:59:11 INFO - 'MAIL': '/var/mail/cltbld', 22:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:11 INFO - 'MOZ_NO_REMOTE': '1', 22:59:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:11 INFO - 'NO_EM_RESTART': '1', 22:59:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:59:11 INFO - 'PWD': '/builds/slave/test-pgo', 22:59:11 INFO - 'SHELL': '/bin/bash', 22:59:11 INFO - 'SHLVL': '1', 22:59:11 INFO - 'TERM': 'linux', 22:59:11 INFO - 'TMOUT': '86400', 22:59:11 INFO - 'USER': 'cltbld', 22:59:11 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452581630.560416-1703302380', 22:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:11 INFO - '_': '/tools/buildbot/bin/python'} 22:59:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:11 INFO - Downloading/unpacking flake8 22:59: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 22:59: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 22:59: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 22:59: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 22:59: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 22:59: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 22:59:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:59:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 22:59:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:59: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 22:59: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 22:59: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 22:59: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 22:59: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 22:59: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 22:59:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:59:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 22:59:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:59: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 22:59: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 22:59: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 22:59: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 22:59: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 22:59: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 22:59:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 22:59:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:59: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 22:59: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 22:59: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 22:59: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 22:59: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 22:59: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 22:59:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:59:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:59:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:59:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:59:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:59:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:59:13 INFO - no previously-included directories found matching 'docs/_build' 22:59:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:59:14 INFO - Running setup.py install for pep8 22:59:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:59:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:59:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:59:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:59:14 INFO - no previously-included directories found matching 'docs/_build' 22:59:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:59:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:59:14 INFO - Cleaning up... 22:59:14 INFO - Return code: 0 22:59:14 INFO - Running post-action listener: _resource_record_post_action 22:59:14 INFO - Running post-action listener: _start_resource_monitoring 22:59:14 INFO - Starting resource monitoring. 22:59:14 INFO - ##### 22:59:14 INFO - ##### Running install step. 22:59:14 INFO - ##### 22:59:14 INFO - Running pre-action listener: _resource_record_pre_action 22:59:14 INFO - Running main action method: install 22:59:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:59:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:59:14 INFO - Reading from file tmpfile_stdout 22:59:14 INFO - Detecting whether we're running mozinstall >=1.0... 22:59:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:59:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:59:14 INFO - Reading from file tmpfile_stdout 22:59:14 INFO - Output received: 22:59:14 INFO - Usage: mozinstall [options] installer 22:59:14 INFO - Options: 22:59:14 INFO - -h, --help show this help message and exit 22:59:14 INFO - -d DEST, --destination=DEST 22:59:14 INFO - Directory to install application into. [default: 22:59:14 INFO - "/builds/slave/test-pgo"] 22:59:14 INFO - --app=APP Application being installed. [default: firefox] 22:59:14 INFO - mkdir: /builds/slave/test-pgo/build/application 22:59:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:59:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:59:30 INFO - Reading from file tmpfile_stdout 22:59:30 INFO - Output received: 22:59:30 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:59:30 INFO - Running post-action listener: _resource_record_post_action 22:59:30 INFO - ##### 22:59:30 INFO - ##### Running run-tests step. 22:59:30 INFO - ##### 22:59:30 INFO - Running pre-action listener: _resource_record_pre_action 22:59:30 INFO - Running main action method: run_tests 22:59:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:59:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:59:30 INFO - Python 2.7.3 22:59:30 INFO - Return code: 0 22:59:30 INFO - grabbing minidump binary from tooltool 22:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:30 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 0x1e0e840>, '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 0x1d7b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7bb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:59:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 22:59:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:59:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:59:30 INFO - Return code: 0 22:59:30 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:59:30 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:59:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:59:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:59:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:59:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:59:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:59:31 INFO - Return code: 0 22:59:31 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/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 22:59:31 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/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 22:59:31 INFO - Using env: {'DISPLAY': ':0', 22:59:31 INFO - 'HOME': '/home/cltbld', 22:59:31 INFO - 'LANG': 'en_US.UTF-8', 22:59:31 INFO - 'LANGUAGE': 'en_US:en', 22:59:31 INFO - 'LOGNAME': 'cltbld', 22:59:31 INFO - 'MAIL': '/var/mail/cltbld', 22:59:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:59:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:59:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:31 INFO - 'MOZ_NO_REMOTE': '1', 22:59:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:59:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:31 INFO - 'NO_EM_RESTART': '1', 22:59:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:59:31 INFO - 'PWD': '/builds/slave/test-pgo', 22:59:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:59:31 INFO - 'SHELL': '/bin/bash', 22:59:31 INFO - 'SHLVL': '1', 22:59:31 INFO - 'TERM': 'linux', 22:59:31 INFO - 'TMOUT': '86400', 22:59:31 INFO - 'USER': 'cltbld', 22:59:31 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452581630.560416-1703302380', 22:59:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:31 INFO - '_': '/tools/buildbot/bin/python'} 22:59:31 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/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:59:31 INFO - mozversion application_buildid: 20160111203200 22:59:31 INFO - mozversion application_changeset: d9661fecd939146a14c5c591f395a68e2d75d211 22:59:31 INFO - mozversion application_display_name: Nightly 22:59:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:59:31 INFO - mozversion application_name: Firefox 22:59:31 INFO - mozversion application_remotingname: firefox 22:59:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:59:31 INFO - mozversion application_vendor: Mozilla 22:59:31 INFO - mozversion application_version: 46.0a1 22:59:31 INFO - mozversion platform_buildid: 20160111203200 22:59:31 INFO - mozversion platform_changeset: d9661fecd939146a14c5c591f395a68e2d75d211 22:59:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:59:31 INFO - mozversion platform_version: 46.0a1 22:59:31 INFO - using testdate: 1452581971 22:59:31 INFO - actual date: 1452581971 22:59:31 INFO - starting webserver on 'localhost:59762' 22:59:31 INFO - SUITE-START | Running 3 tests 22:59:31 INFO - TEST-START | dromaeo_css 22:59:31 INFO - operating with platform_type : linux_ 22:59:31 INFO - Initialising browser for dromaeo_css test... 22:59:31 INFO - TEST-INFO | started process 3747 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTYm2RZ/profile http://localhost:59762/getInfo.html) 22:59:35 INFO - PROCESS | 3747 | __metrics Screen width/height:1600/1200 22:59:35 INFO - PROCESS | 3747 | colorDepth:24 22:59:35 INFO - PROCESS | 3747 | Browser inner width/height: 1024/697 22:59:35 INFO - PROCESS | 3747 | __metrics 22:59:35 INFO - PROCESS | 3747 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:59:35 INFO - PROCESS | 3747 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:59:36 INFO - TEST-INFO | 3747: exit 0 22:59:36 INFO - Browser initialized. 22:59:36 INFO - Running cycle 1/1 for dromaeo_css test... 22:59:36 INFO - TEST-INFO | started process 3838 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTYm2RZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:59:48 INFO - PROCESS | 3838 | RSS: Main: 147963904 22:59:48 INFO - PROCESS | 3838 | 23:00:39 INFO - PROCESS | 3838 | 1452582039518 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] 23:02:47 INFO - PROCESS | 3838 | Cycle 1(1): loaded http://localhost:59762/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59762/tests/dromaeo/cssquery-ext.html) 23:02:48 INFO - PROCESS | 3838 | RSS: Main: 235241472 23:02:48 INFO - PROCESS | 3838 | 23:05:50 INFO - PROCESS | 3838 | Cycle 1(1): loaded http://localhost:59762/tests/dromaeo/cssquery-ext.html (next: http://localhost:59762/tests/dromaeo/cssquery-jquery.html) 23:05:51 INFO - PROCESS | 3838 | RSS: Main: 227635200 23:05:51 INFO - PROCESS | 3838 | 23:08:53 INFO - PROCESS | 3838 | Cycle 1(1): loaded http://localhost:59762/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59762/tests/dromaeo/cssquery-mootools.html) 23:08:54 INFO - PROCESS | 3838 | RSS: Main: 225816576 23:08:54 INFO - PROCESS | 3838 | 23:11:55 INFO - PROCESS | 3838 | Cycle 1(1): loaded http://localhost:59762/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59762/tests/dromaeo/cssquery-prototype.html) 23:11:56 INFO - PROCESS | 3838 | RSS: Main: 209108992 23:11:56 INFO - PROCESS | 3838 | 23:14:59 INFO - PROCESS | 3838 | Cycle 1(1): loaded http://localhost:59762/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59762/tests/dromaeo/cssquery-yui.html) 23:14:59 INFO - PROCESS | 3838 | RSS: Main: 209469440 23:14:59 INFO - PROCESS | 3838 | 23:18:02 INFO - PROCESS | 3838 | Cycle 1(1): loaded http://localhost:59762/tests/dromaeo/cssquery-yui.html (next: http://localhost:59762/tests/dromaeo/cssquery-dojo.html) 23:18:02 INFO - PROCESS | 3838 | RSS: Main: 268115968 23:18:02 INFO - PROCESS | 3838 | 23:18:02 INFO - PROCESS | 3838 | __start_tp_report 23:18:02 INFO - PROCESS | 3838 | _x_x_mozilla_page_load 23:18:02 INFO - PROCESS | 3838 | _x_x_mozilla_page_load_details 23:18:02 INFO - PROCESS | 3838 | |i|pagename|runs| 23:18:02 INFO - PROCESS | 3838 | |0;dojo.html;2990.850457477128;3013.2165636934396;3032.7877048606592;3041.224487755623;3047.512398016318;4852.02959408118;4951.727654978979;4954.925676114852;4964.627652926027;5000.899802043549;4869.391326084239;4892.6575139740235;4899.43656479505;4927.1870141426625;4953.405591329037;4349.151915376503;4490.640748740093;4492.258777301741;4509.954900450986;4614.792334344963;4524.072565124158;4528.20756367636;4578.427696537933;4596.287575425815;4639.234526303156;4431.822727090913;4514.0971805639;4517.706349087299;4538.047010127877;4544.750038747868;4633.119707255611;4647.60495357895;4649.883752906205;4657.69724967876;4680.508546602626;4506.121306345264;4609.2394754865745;4613.907721845544;4635.605973492257;4647.395838540968;4825.396825396825;4878.146324393217;4892.633052521075;4895.926561101586;4931.9753401232765;5329.280547126127;5336.43967383423;5336.546393556552;5337.946620533823;5382.085045542267;5337.306150200449;5364.6512976656395;5365.382980957201;5427.891442171174;5435.157550579666;5007.073691367109;5030.144875371196;5054.1407960646775;5054.570361519312;5091.821786237501;5496.5053145217125;5525.834224973257;5526.281583394133;5528.253685752452;5530.336359636869;5229.346331708536;5242.423333433319;5337.973310133424;5342.519173274424;5391.56867450603;5358.5981051421295;5375.139977603565;5376.193570964387;5382.407935127133;5412.07994640912;5336.332958380202;5338.332708411449;5342.652727572773;5356.732163391893;5391.838244852661;5280.287161233261;5302.310699609104;5335.279737235501;5362.383325917492;5379.973100134553;4183.811728472226;4191.622753952159;4192.014876504019;4224.957750422518;4236.2374772540625;3724.478572999782;3727.6645101940953;3730.813459327077;3762.492063571383;3762.680172185395;4957.752112394366;4967.5777558907175;5003.3495645565845;5004.574611158019;5056.924146137811;5335.279737235501;5349.919751203657;5353.732313384316;5357.062514060024;5373.247745315659;5024.221245706921;5028.773705183203;5029.421616514074;5031.622628302892;5069.949300506948;4539.0694907543875;4585.747783871919;4620.584147426748;4634.467036290802;4681.180793361148;5539;5540.501354878;5556.638818476786;5561.249231353796;5570.108782594765;5326.147816349366;5335.306410166809;5336.67979921206;5342.519173274424;5367.409584945731;5417.783288668409;5517.393086760373;5603.607747457639;5629.831105066854;5705.34388545306;5330.413654498079;5354.9464505354445;5356.973215133899;5361.27622770921;5368.543673787772;5216.008958297912;5412;5437.102878025082;5452.6183167177915;5482.205080263259;5215.322008138917;5223.634345595772;5282.022825777243;5285.497877701612;5327.200919862052;5209.71346575942;5212.374515058217;5215.895682086261;5216.347956505437;5266.631335806457;5018.573421259234;5121.411037730709;5123.180291153547;5128.974355128201;5159.432462429205;5044.394672639307;5226.790928362823;5234.241035049972;5256.816011439734;5275.630705850707;5169.896602068013;5176.223566465061;5178.61160412963;5183.429822719422;5197.4282828889545 23:18:02 INFO - PROCESS | 3838 | |1;ext.html;514.2902794144082;528.7620570743167;547.7671989404503;564.3538148819601;577.7198058941412;28756.424871502557;29335.119946401588;29340.413191736177;29344.26639334018;35589.2882142357;38780.612193878056;39314.21371572574;39511;39676.80161599195;39678.404823927594;8356.707515236983;8495.787605309855;8520.616572254263;8566;8569.785755356135;8219.71231006915;8279.379046571501;8314.127016663255;8322.459040162401;8351.206635369661;8321.66713331466;8474.618642161118;8559.058503564604;8559.101294364096;8562.186592273723;8446;8503.702370417037;8507;8508.3618728595;8511.957440212791;8455.069942306342;8615.526146061964;8626.482411055356;8634.136586341378;8643.783905402415;38799;39081;39221.60778392208;39279;39324.41013384802;2941.911742647724;3167.889123880653;3389.237421580149;3488.8778892738887;3549.396602577542;27767.444651107067;27814.860925695444;28215.15354539367;29771.553426698618;29810.70189298101;3257.446234140202;3358.580177477815;3375.696187343151;3379.509971054208;3459.15250763562;192796;193075;193124.9999999986;193314;193426;51716.48283517192;52836.20745688818;56042.719786400805;56559.43440565542;59003;52646.73676631669;52851.73574132105;53067.20399194015;53067.46932530702;53077.46922530803;14214.85785142156;14349.928250358891;14362.640933976734;14404.927975360266;14411.78382324266;9704.175145112744;10013.549390277454;10161.441120738431;10402.635907743344;10470.528826202839;19399.127039283267;19529.08242302877;19578;20156.395308140778;20161;7212.170600380919;7292.45306602007;7303.561786292839;7348.5958272294465;7419.406447484188;901.2249465459699;963.5615794813343;968.5157421289356;990.8612794208673;1051.673981065872;27914.302142446602;28147.57778633281;28152.577711334347;28464.28839278993;28479.430411391655;997.6059456514781;1009.0514915978956;1019.5106348952544;1071.464267866067;1093.4860615510697;13184.472621095048;13294.667633309246;13348.332583370793;15414;15489.845101549066;326142;333215;333233;333241;333412;48017.27974080392;48037.279440808416;48090;48128;48241.27638085432;1279.2004996876951;1284.9743005139844;1299.2009913902882;1302.049503862186;1315;28083.43833123367;28801.711982879904;29066.41867162687;29362.412751744418;29625.555616665337;42707.35938960856;43552.34671479994;48373.75813120912;49067.263991040876;49124.75437622789;239042;241077;241363;241401;241944;26136.8693156533;30267.69732302737;30327.393452131277;30541.694583054774;30637.23406914845;30658;37123.628763713095;37869.81065094657;38029;38343.233135337694;32582;33779;34145.48781768325;34393.65606343905;34494.48258276078;33371.666283336854;34665.306693866485;35502;35927.46108808422;37181.25637487289;34311;34907.650923491456;35075.649243507236;35151;35177.82411087928;28899.711002890544;29566.40867182601;29645.851770741006;29869.253268668457;29936.550951735306;22941.426464338525;22947.885260574258;23234.883825580764;23305.650415244123;23349 23:18:02 INFO - PROCESS | 3838 | |2;jquery.html;346.8785924926276;350.2592017882178;353.0414923482744;359.9352116619009;360.1805891596618;13489.595312140651;14016.43934242629;16132;16179.352825886965;17174.398896038627;14148.93882958777;14178.787318190236;14826.406943722239;14842.480513182041;14871.033382830108;5023.522765337306;5054.418741844689;5238.4499627539135;5244.9213261800915;5246.868828279305;3853.402722578005;4008.919821603566;5162.328897243353;5556.722163891809;5771.913421298684;4825.90348193036;5693;5725.255716756816;5749.856253593673;5765.423457654243;4964.007198560303;4966.304717339575;4974.452810190876;4994.450610432849;4998.3502144721315;4724.5039270876405;4927.359443272388;4946.480619534969;4981.551660350549;4989.426215985171;11699.532018719241;11897.464614092387;16437;19605.80394196054;19638.214471421124;1870.9064546772606;1877.4836919847014;1910.2359056377422;1930.9806901930942;2032.1769683278148;8815.294776417872;9018.278537716968;9097.363184577081;10937.179711521667;12365.763423657652;1696.787901512311;1736.8089510153873;1737.8957262564286;1795.5062357851564;1816;52515.21227181595;52586.211206831926;52773.999999999614;53050;53722;8578.027053777667;8767.1671191238;9050.27597792175;9071.773205669779;9142.908570914338;10898.782024359627;10920.781584368267;10929.30595757659;10935.453227338601;10956.12351011917;6559.836004099936;6574.3754343337305;6649.168853893263;6683.997400389981;6826.965865170642;6206.0690896365;6457.580257283262;6512.251091124486;6521.250056243498;6527.771527996498;3277.2462333663393;3569.196930690574;3630.8547658093908;3659.432787917877;3669.3028324618235;1432.4127107885718;1528.8700460460987;1535.8617724404858;1565.4833904811612;1608.4209684513567;433.9913201735948;447.08794060117646;841.869510225916;882.250087425683;999.2905037423366;9512.857307140399;9604.807903841884;9721.562529686182;9989;10325.225608079425;825.7110011495928;854.428171204666;905.3345790843724;909.5134103254727;916.7708072981754;8533.786655333666;8552.315814734806;8593.69922052725;8861.113888611088;8878.556072196365;357406;368901;459985;501875;548118;68681.65659171772;70054.64972675206;70418.9437158443;72224.63887680529;73233.26766732371;1128.1933417606451;1140.5779861451317;1148.5405837665;1165.6561314412268;1167.538822165257;14378.568642940729;14398;14938.633540372672;15010.174440405883;15178.165200914056;32853.67146328506;33600;34101.65898340985;34282.48576271308;34458.2222045302;40445;41003.38494922638;41410.58589414067;42143.157136857706;42277.57722422737;6626.304238054935;6758.493113016445;6969.58182509051;7031.261717519586;7184.461165412719;7823.804404889924;10132.088112069654;10222.28444008942;10718.303310284806;10839.403832788958;8982.730518084469;9442.52787360643;9745;9767.120959113714;9777.315587909063;9247.76880577991;9449.905500945177;9663.565139568596;9875.40747555149;9941.30410871232;9664.516774161124;9680.806383872425;9778.41329520231;9955.20358371343;10062.195024397884;6664.733410663519;6888.552244104118;6899.0341352211735;7088.645567721696;7168.53404528704;9226.169644732006;9581.664641737505;9642.180414664552;9689.12797848197;9746.366486178376 23:18:02 INFO - PROCESS | 3838 | |3;mootools.html;1291.7933130699078;1426.3937826423767;1432.878205352545;1467.3983666696656;1573.5515378117245;6752.155980502437;7486.401087912967;7576.393888488921;7610.961945190274;7619.276168763972;7633.732819351324;7634.9236507634905;7678.846423071549;7689.846203075935;7693.576853273068;1977.3672424824063;2030.5938812237537;2272.5682120397155;2277.7038984931937;2282.8287878409187;2280.851744636602;2337.2053501809382;2341.285907798121;2345.460544074855;2346.343023953296;2248.8313376496744;2271;2291.209532711212;2297.264875239924;2299.321700098475;2175.934721958336;2188.3325585696434;2217.9556408871813;2254.0870947266385;2263.875486848223;2280.646499792535;2290.118304452781;2300.332903458012;2300.7469178390365;2315.2938353802083;7533.7363192288;7537;7569.243075692441;7579.772606821804;7585;4534.8866278342975;4656;4662.254039353721;4663.27719203524;4670.883227919295;3009.1875193697797;3082.3835232953497;3138.73320767735;3140.921476963071;3151.243701511644;954.4511905654276;965.2567523007315;984.8965858584888;998.3760149906309;1017.6743442098532;10460.320079194827;10595.523201455953;10600.204984626107;10605.575776968912;10611.946940265248;4031.596840315945;4135.110951145518;4141.958580414157;4151.771652559139;4219.7046206765235;8844.73465796027;8845;8849.51327676984;8850.557472126367;8861.778455538662;4608.539146085364;4623.976880115578;4633.235516139866;4634.050019745944;4641.257398816173;4141.772202528829;4187.91624167515;4192.224438478891;4225.9577404225565;4227.3447615619625;3257.706806387389;3325.4014277430297;3334.233126380946;3447.8620855166014;3524.22467057247;1051.363924825485;1084.3819023156882;1086.2124959404528;1088.7659153282082;1088.9618863339904;1256.0956111599633;1262.8863402293837;1267.7464507098616;1315.5592876386518;1316.9407376668073;7315.56106633593;7339.266073392618;7348.52234604749;7353.522021068614;7365.042544469185;1087.6682611803317;1091.7543552700579;1098.3025778630467;1115.2137742891405;1119.6696974392573;5734.082546792577;5791.797287094932;5812.273465816773;5815.592908496449;5816.447437493432;9231.815363692824;9277.62889484413;9476.810463790824;9589.041095890494;9593.808123837483;9249.167574918156;9323.90676093244;9381.155695987394;9426.293028022927;9433.05669433065;7240.637968101574;7318.743843965436;7334.523255988343;7427.034485516956;7444.404447644176;7129.857402851811;7175.569465832067;7180.210176880434;7185.281471852982;7196.676149573177;8114.675412983651;8308.459950103224;8388.370872184489;8400.159984001551;8552.529610871461;8612.18184272493;8789.121087891159;8791.648334066565;8805.69180078694;8808.823823523366;6438.645874476949;6616.206055273398;6616.305287944697;6616.8345791355605;6628.5691430056895;6589.4728421725185;6768.323167683192;6855.4172895304455;7024.1571011478945;7030.753923612649;6773.221079575912;6862.039314496074;6915.861682766417;6972.58164510131;6990.825229369307;6762.763303284361;6778.152730908637;6798.660066996729;6915.515913886181;6928.341807528277;6885.862282754417;6900.102986611709;6913.930860691329;6921.965390173017;6931.202911665223;6360.936390636034;6408.58344207625;6433.099366088845;6435.935640643534;6442.645654489048;6497.967510162419;6528.738850445929;6542.378474044958;6549.24683661366;6564.901526477202 23:18:02 INFO - PROCESS | 3838 | |4;prototype.html;317.29402080371165;319.83848156680875;320.9630892447368;322.098125249302;328.80436140496397;5567.582431317657;5674.914876276854;5713.542916566675;5717.456841600047;5723.885522289552;5529.751161197746;5649.4633009864;5689.8577535561635;5690.231818704474;5693.800716974907;4186.204621121992;4232.555581663927;4421.845235416761;4426.77866106695;4429.291313389858;4312.417823593822;4356.847510337139;4379.540148284416;4380.540043295456;4389.824407023715;4310.633596144316;4318.244307246219;4331.436913201295;4340.153670034345;4343.435353404053;4335.761533115678;4339.435873336462;4341.9782901085455;4351.73889566627;4358.8910277243;3856.5564960029396;3860.073582340246;3891.7081218908697;3897.9805100974313;3906.687465002793;5287.444818294062;5446.373667028302;5458.426865179139;5481.890362192734;5489.039418101816;4990.82532111378;4994.900101997976;5007.649464537484;5009.624278179152;5010.048090862724;5769.278840144982;5890.587658863881;5963.612365196248;6050.788222412194;6073.210482637273;4156.2726522858375;4179.26862799012;4195.307774217251;4199.538050814408;4207.389928460387;6224.906626400608;6298.685065746694;6311.2426508819235;6311.495080393557;6314.179156709644;4258.5954334338185;4266.914661706748;4273.594008569181;4277.486701595766;4281.828726850953;4239.851605193803;4277.123189746095;4284.807183676742;4285.292926667127;4313.180495705806;4992.650514464025;5010.624203184776;5012.223105418666;5016.724080175625;5016.774245158977;6043.214382130383;6044;6095.634261944298;6098.176746139303;6102.4507794298725;1483.6290927268183;1518.4837155367006;1518.840521745201;1522.3149582687836;1522.6574020845221;1007.7279134633754;1022.320157095538;1026.1329176845702;1038.4755698372273;1051.153821173947;5758.049921762946;5764.596478246483;5767.798127065533;5777.942220577825;5778.739956701958;6220.968895155585;6222.875542489215;6231.563790534709;6256.905041617699;6274.9686251569365;5802.941970580325;5806.361300256968;5806.82579522615;5809.506191973645;5820.505257053113;3282.770206085599;3367.898963031113;3376.274101068233;3376.915577110592;3377.7804442711144;6507.804765857032;6514.902276465857;6515.381038801306;6518.152640156749;6518.217813862367;6354.26925903527;6360.395762402657;6360.427561519486;6370.8088757337355;6373.745050198033;6341.4292713656;6505.41451269388;6509.2839787623325;6514.967425162844;6517.663878904813;6032.1856549365275;6093.786717464867;6126.23422072241;6201.96899015502;6218.782342617987;6166.290876549254;6174.043023331391;6215.378462153929;6243.7814676486105;6244.750209991549;6555.311692272243;6560.803175904731;6560.901586476111;6565.671716414065;6568.244651864906;4192.098698779777;4272.209641216385;4275.123599662;4294.098239369768;4329.610335069859;6239.032949892774;6242.625442473466;6244.687765611792;6244.812655620339;6245.313015568193;6054.697265136638;6075.605085669417;6094.360092190256;6097.75608975636;6103.877922441615;5928.347881733092;6064.423879731418;6080.90878636812;6082.391760823883;6093.878122437615;6052.213212282375;6052.788152414821;6054.576179667381;6057.57596968208;6062.454379105901;6171.444569988543;6175.814725558241;6190.0405437157315;6198.72105755233;6211.223597050369;5835.503982161564;5972.5520585955355;6051;6051.062085376773;6062.787802426894 23:18:02 INFO - PROCESS | 3838 | |5;yui.html;667.4193451697024;705.8623568404163;739.5303981971454;768.0514564512825;780.1496368957836;13202.075854690176;13284;13308.866911330884;13334;13350.999999999987;12262.693432664166;12325.075619328563;12380.442880070395;12403.627891163256;12421;640.174175313847;640.446014197718;768.8193274580469;772.0735117858565;786.6656670914838;772.5673622771266;775.4223103787687;776.4370831147429;776.8252143267777;777.8211011467366;818.7830224990382;824.2499325613693;828.0684230240979;828.2752591482453;829.3945419843518;681.0465348512073;692.6259819697383;793.9444238903279;806.9314108300802;811.0915774332785;595.3183604772511;596.4810614765139;597.1878245585999;597.4682532546037;598.2970010237952;12989.675258118528;13018.34908254593;13076.803847942288;13093.607191784262;13168.473261069641;10849.945750271198;12317.322547259897;12635.241885486808;13049.804252936214;13398.732025359535;9340.626374944994;9358.251339892793;9401.858972115424;9701.466419346933;10247.38515689061;3300.4554248549202;3392.6098498672723;3406.693397594204;3428.639516237149;3439.002689220123;39537.60462395368;40138.99652508681;40200.597994019976;40201.597984020074;42795.78602107001;9029.864552031724;9258.305627077862;9525;9733.464659443798;10024.298299119138;16785.24466399015;17310.65378692419;17450;17477.475675729747;17593.648127037388;7114.679839407239;7317.853642927112;7401.8149546261775;7440.925590744131;7574.3183113520045;3850.306944749916;3891.4746509220895;3973.0861901762755;3991.560928297885;3993.2612466693754;2855.814372065809;2863.441628882348;2869.756070734011;2874.1233923653067;2879.3089658481813;507.59392486011046;509.96175286853634;531.5189753273294;533.5011764000672;537.6881408782897;457.70249337930613;498.29988865643827;498.6235392278879;580.8199458167896;593.8070127208674;8082.797930051795;8398.706045288385;8453.842022556908;8734.956325218332;9293.907060929305;463.4878459302422;543.0876128104743;554.603458527155;558.7066789935317;589.5637228450915;3645.398509245998;3692.2615476904725;3931.272714547818;4005.2590270799997;4036.9596304037173;55312;55316.72341638266;55335.44664553383;55375.44624553784;57248;47745;48161.277580836315;48505.029899401816;48860.511394885594;49105.75447122813;43023.78488107539;43349.349759753626;43410.13179736325;44026.779866101104;44724.77637611791;7955.602219888867;7955.761327160194;8053.6778528858185;8251.368021351695;8371.330293576377;32676.673233268313;32881.67118328786;33369;33677.66322336745;33920.1519961993;39357.80321098376;41656.1668766629;42598.5740142607;42950.78524607482;43057.56942430536;8738.69414570487;8811.515366654896;8856.690015849414;8887.11128887132;9358.485283309212;10622.681319560426;11051.226414150933;11077.833832492357;11087.722806929569;11960.521579136737;9830.950845245728;10044.447555384524;10414.739631509274;10608.628697995533;11212.83180752273;10061.69814905554;10467.842982355423;10487;10587.682369528926;11175.081558194526;10004.63039029723;10122.493875306352;10249.436281004319;10552.155827533625;11410.372429516456;8280.254777070093;8522.957385213282;8540.74377768668;8549.14508549165;9220.815583688423;8415.284700800501;8814;9172.954135229282;9380.437173769596;9770.68095807057 23:18:02 INFO - PROCESS | 3838 | __end_tp_report 23:18:02 INFO - PROCESS | 3838 | __start_cc_report 23:18:02 INFO - PROCESS | 3838 | _x_x_mozilla_cycle_collect,724 23:18:02 INFO - PROCESS | 3838 | __end_cc_report 23:18:02 INFO - PROCESS | 3838 | __startTimestamp1452583082559__endTimestamp 23:18:02 INFO - PROCESS | 3838 | 23:18:02 INFO - PROCESS | 3838 | ------- Summary: start ------- 23:18:02 INFO - PROCESS | 3838 | Number of tests: 6 23:18:02 INFO - PROCESS | 3838 | 23:18:02 INFO - PROCESS | 3838 | [#0] dojo.html Cycles:165 Average:4982.73 Median:5176.22 stddev:543.65 (10.5%) stddev-sans-first:522.38 23:18:02 INFO - PROCESS | 3838 | Values: 2990.9 3013.2 3032.8 3041.2 3047.5 4852.0 4951.7 4954.9 4964.6 5000.9 4869.4 4892.7 4899.4 4927.2 4953.4 4349.2 4490.6 4492.3 4510.0 4614.8 4524.1 4528.2 4578.4 4596.3 4639.2 4431.8 4514.1 4517.7 4538.0 4544.8 4633.1 4647.6 4649.9 4657.7 4680.5 4506.1 4609.2 4613.9 4635.6 4647.4 4825.4 4878.1 4892.6 4895.9 4932.0 5329.3 5336.4 5336.5 5337.9 5382.1 5337.3 5364.7 5365.4 5427.9 5435.2 5007.1 5030.1 5054.1 5054.6 5091.8 5496.5 5525.8 5526.3 5528.3 5530.3 5229.3 5242.4 5338.0 5342.5 5391.6 5358.6 5375.1 5376.2 5382.4 5412.1 5336.3 5338.3 5342.7 5356.7 5391.8 5280.3 5302.3 5335.3 5362.4 5380.0 4183.8 4191.6 4192.0 4225.0 4236.2 3724.5 3727.7 3730.8 3762.5 3762.7 4957.8 4967.6 5003.3 5004.6 5056.9 5335.3 5349.9 5353.7 5357.1 5373.2 5024.2 5028.8 5029.4 5031.6 5069.9 4539.1 4585.7 4620.6 4634.5 4681.2 5539.0 5540.5 5556.6 5561.2 5570.1 5326.1 5335.3 5336.7 5342.5 5367.4 5417.8 5517.4 5603.6 5629.8 5705.3 5330.4 5354.9 5357.0 5361.3 5368.5 5216.0 5412.0 5437.1 5452.6 5482.2 5215.3 5223.6 5282.0 5285.5 5327.2 5209.7 5212.4 5215.9 5216.3 5266.6 5018.6 5121.4 5123.2 5129.0 5159.4 5044.4 5226.8 5234.2 5256.8 5275.6 5169.9 5176.2 5178.6 5183.4 5197.4 23:18:02 INFO - PROCESS | 3838 | 23:18:02 INFO - PROCESS | 3838 | [#1] ext.html Cycles:180 Average:41811.22 Median:34352.33 stddev:68499.57 (199.4%) stddev-sans-first:68621.55 23:18:02 INFO - PROCESS | 3838 | Values: 514.3 528.8 547.8 564.4 577.7 28756.4 29335.1 29340.4 29344.3 35589.3 38780.6 39314.2 39511.0 39676.8 39678.4 8356.7 8495.8 8520.6 8566.0 8569.8 8219.7 8279.4 8314.1 8322.5 8351.2 8321.7 8474.6 8559.1 8559.1 8562.2 8446.0 8503.7 8507.0 8508.4 8512.0 8455.1 8615.5 8626.5 8634.1 8643.8 38799.0 39081.0 39221.6 39279.0 39324.4 2941.9 3167.9 3389.2 3488.9 3549.4 27767.4 27814.9 28215.2 29771.6 29810.7 3257.4 3358.6 3375.7 3379.5 3459.2 192796.0 193075.0 193125.0 193314.0 193426.0 51716.5 52836.2 56042.7 56559.4 59003.0 52646.7 52851.7 53067.2 53067.5 53077.5 14214.9 14349.9 14362.6 14404.9 14411.8 9704.2 10013.5 10161.4 10402.6 10470.5 19399.1 19529.1 19578.0 20156.4 20161.0 7212.2 7292.5 7303.6 7348.6 7419.4 901.2 963.6 968.5 990.9 1051.7 27914.3 28147.6 28152.6 28464.3 28479.4 997.6 1009.1 1019.5 1071.5 1093.5 13184.5 13294.7 13348.3 15414.0 15489.8 326142.0 333215.0 333233.0 333241.0 333412.0 48017.3 48037.3 48090.0 48128.0 48241.3 1279.2 1285.0 1299.2 1302.0 1315.0 28083.4 28801.7 29066.4 29362.4 29625.6 42707.4 43552.3 48373.8 49067.3 49124.8 239042.0 241077.0 241363.0 241401.0 241944.0 26136.9 30267.7 30327.4 30541.7 30637.2 30658.0 37123.6 37869.8 38029.0 38343.2 32582.0 33779.0 34145.5 34393.7 34494.5 33371.7 34665.3 35502.0 35927.5 37181.3 34311.0 34907.7 35075.6 35151.0 35177.8 28899.7 29566.4 29645.9 29869.3 29936.6 22941.4 22947.9 23234.9 23305.7 23349.0 23:18:02 INFO - PROCESS | 3838 | 23:18:02 INFO - PROCESS | 3838 | [#2] jquery.html Cycles:180 Average:24119.34 Median:253436.68 stddev:74278.77 (29.3%) stddev-sans-first:74465.69 23:18:02 INFO - PROCESS | 3838 | Values: 346.9 350.3 353.0 359.9 360.2 13489.6 14016.4 16132.0 16179.4 17174.4 14148.9 14178.8 14826.4 14842.5 14871.0 5023.5 5054.4 5238.4 5244.9 5246.9 3853.4 4008.9 5162.3 5556.7 5771.9 4825.9 5693.0 5725.3 5749.9 5765.4 4964.0 4966.3 4974.5 4994.5 4998.4 4724.5 4927.4 4946.5 4981.6 4989.4 11699.5 11897.5 16437.0 19605.8 19638.2 1870.9 1877.5 1910.2 1931.0 2032.2 8815.3 9018.3 9097.4 10937.2 12365.8 1696.8 1736.8 1737.9 1795.5 1816.0 52515.2 52586.2 52774.0 53050.0 53722.0 8578.0 8767.2 9050.3 9071.8 9142.9 10898.8 10920.8 10929.3 10935.5 10956.1 6559.8 6574.4 6649.2 6684.0 6827.0 6206.1 6457.6 6512.3 6521.3 6527.8 3277.2 3569.2 3630.9 3659.4 3669.3 1432.4 1528.9 1535.9 1565.5 1608.4 434.0 447.1 841.9 882.3 999.3 9512.9 9604.8 9721.6 9989.0 10325.2 825.7 854.4 905.3 909.5 916.8 8533.8 8552.3 8593.7 8861.1 8878.6 357406.0 368901.0 459985.0 501875.0 548118.0 68681.7 70054.6 70418.9 72224.6 73233.3 1128.2 1140.6 1148.5 1165.7 1167.5 14378.6 14398.0 14938.6 15010.2 15178.2 32853.7 33600.0 34101.7 34282.5 34458.2 40445.0 41003.4 41410.6 42143.2 42277.6 6626.3 6758.5 6969.6 7031.3 7184.5 7823.8 10132.1 10222.3 10718.3 10839.4 8982.7 9442.5 9745.0 9767.1 9777.3 9247.8 9449.9 9663.6 9875.4 9941.3 9664.5 9680.8 9778.4 9955.2 10062.2 6664.7 6888.6 6899.0 7088.6 7168.5 9226.2 9581.7 9642.2 9689.1 9746.4 23:18:02 INFO - PROCESS | 3838 | 23:18:02 INFO - PROCESS | 3838 | [#3] mootools.html Cycles:180 Average:5387.29 Median:6440.65 stddev:2798.17 (43.4%) stddev-sans-first:2789.09 23:18:02 INFO - PROCESS | 3838 | Values: 1291.8 1426.4 1432.9 1467.4 1573.6 6752.2 7486.4 7576.4 7611.0 7619.3 7633.7 7634.9 7678.8 7689.8 7693.6 1977.4 2030.6 2272.6 2277.7 2282.8 2280.9 2337.2 2341.3 2345.5 2346.3 2248.8 2271.0 2291.2 2297.3 2299.3 2175.9 2188.3 2218.0 2254.1 2263.9 2280.6 2290.1 2300.3 2300.7 2315.3 7533.7 7537.0 7569.2 7579.8 7585.0 4534.9 4656.0 4662.3 4663.3 4670.9 3009.2 3082.4 3138.7 3140.9 3151.2 954.5 965.3 984.9 998.4 1017.7 10460.3 10595.5 10600.2 10605.6 10611.9 4031.6 4135.1 4142.0 4151.8 4219.7 8844.7 8845.0 8849.5 8850.6 8861.8 4608.5 4624.0 4633.2 4634.1 4641.3 4141.8 4187.9 4192.2 4226.0 4227.3 3257.7 3325.4 3334.2 3447.9 3524.2 1051.4 1084.4 1086.2 1088.8 1089.0 1256.1 1262.9 1267.7 1315.6 1316.9 7315.6 7339.3 7348.5 7353.5 7365.0 1087.7 1091.8 1098.3 1115.2 1119.7 5734.1 5791.8 5812.3 5815.6 5816.4 9231.8 9277.6 9476.8 9589.0 9593.8 9249.2 9323.9 9381.2 9426.3 9433.1 7240.6 7318.7 7334.5 7427.0 7444.4 7129.9 7175.6 7180.2 7185.3 7196.7 8114.7 8308.5 8388.4 8400.2 8552.5 8612.2 8789.1 8791.6 8805.7 8808.8 6438.6 6616.2 6616.3 6616.8 6628.6 6589.5 6768.3 6855.4 7024.2 7030.8 6773.2 6862.0 6915.9 6972.6 6990.8 6762.8 6778.2 6798.7 6915.5 6928.3 6885.9 6900.1 6913.9 6922.0 6931.2 6360.9 6408.6 6433.1 6435.9 6442.6 6498.0 6528.7 6542.4 6549.2 6564.9 23:18:02 INFO - PROCESS | 3838 | 23:18:02 INFO - PROCESS | 3838 | [#4] prototype.html Cycles:180 Average:5063.52 Median:5761.32 stddev:1532.75 (26.6%) stddev-sans-first:1495.08 23:18:02 INFO - PROCESS | 3838 | Values: 317.3 319.8 321.0 322.1 328.8 5567.6 5674.9 5713.5 5717.5 5723.9 5529.8 5649.5 5689.9 5690.2 5693.8 4186.2 4232.6 4421.8 4426.8 4429.3 4312.4 4356.8 4379.5 4380.5 4389.8 4310.6 4318.2 4331.4 4340.2 4343.4 4335.8 4339.4 4342.0 4351.7 4358.9 3856.6 3860.1 3891.7 3898.0 3906.7 5287.4 5446.4 5458.4 5481.9 5489.0 4990.8 4994.9 5007.6 5009.6 5010.0 5769.3 5890.6 5963.6 6050.8 6073.2 4156.3 4179.3 4195.3 4199.5 4207.4 6224.9 6298.7 6311.2 6311.5 6314.2 4258.6 4266.9 4273.6 4277.5 4281.8 4239.9 4277.1 4284.8 4285.3 4313.2 4992.7 5010.6 5012.2 5016.7 5016.8 6043.2 6044.0 6095.6 6098.2 6102.5 1483.6 1518.5 1518.8 1522.3 1522.7 1007.7 1022.3 1026.1 1038.5 1051.2 5758.0 5764.6 5767.8 5777.9 5778.7 6221.0 6222.9 6231.6 6256.9 6275.0 5802.9 5806.4 5806.8 5809.5 5820.5 3282.8 3367.9 3376.3 3376.9 3377.8 6507.8 6514.9 6515.4 6518.2 6518.2 6354.3 6360.4 6360.4 6370.8 6373.7 6341.4 6505.4 6509.3 6515.0 6517.7 6032.2 6093.8 6126.2 6202.0 6218.8 6166.3 6174.0 6215.4 6243.8 6244.8 6555.3 6560.8 6560.9 6565.7 6568.2 4192.1 4272.2 4275.1 4294.1 4329.6 6239.0 6242.6 6244.7 6244.8 6245.3 6054.7 6075.6 6094.4 6097.8 6103.9 5928.3 6064.4 6080.9 6082.4 6093.9 6052.2 6052.8 6054.6 6057.6 6062.5 6171.4 6175.8 6190.0 6198.7 6211.2 5835.5 5972.6 6051.0 6051.1 6062.8 23:18:02 INFO - PROCESS | 3838 | 23:18:02 INFO - PROCESS | 3838 | [#5] yui.html Cycles:180 Average:12909.49 Median:48682.77 stddev:14914.37 (30.6%) stddev-sans-first:14927.87 23:18:02 INFO - PROCESS | 3838 | Values: 667.4 705.9 739.5 768.1 780.1 13202.1 13284.0 13308.9 13334.0 13351.0 12262.7 12325.1 12380.4 12403.6 12421.0 640.2 640.4 768.8 772.1 786.7 772.6 775.4 776.4 776.8 777.8 818.8 824.2 828.1 828.3 829.4 681.0 692.6 793.9 806.9 811.1 595.3 596.5 597.2 597.5 598.3 12989.7 13018.3 13076.8 13093.6 13168.5 10849.9 12317.3 12635.2 13049.8 13398.7 9340.6 9358.3 9401.9 9701.5 10247.4 3300.5 3392.6 3406.7 3428.6 3439.0 39537.6 40139.0 40200.6 40201.6 42795.8 9029.9 9258.3 9525.0 9733.5 10024.3 16785.2 17310.7 17450.0 17477.5 17593.6 7114.7 7317.9 7401.8 7440.9 7574.3 3850.3 3891.5 3973.1 3991.6 3993.3 2855.8 2863.4 2869.8 2874.1 2879.3 507.6 510.0 531.5 533.5 537.7 457.7 498.3 498.6 580.8 593.8 8082.8 8398.7 8453.8 8735.0 9293.9 463.5 543.1 554.6 558.7 589.6 3645.4 3692.3 3931.3 4005.3 4037.0 55312.0 55316.7 55335.4 55375.4 57248.0 47745.0 48161.3 48505.0 48860.5 49105.8 43023.8 43349.3 43410.1 44026.8 44724.8 7955.6 7955.8 8053.7 8251.4 8371.3 32676.7 32881.7 33369.0 33677.7 33920.2 39357.8 41656.2 42598.6 42950.8 43057.6 8738.7 8811.5 8856.7 8887.1 9358.5 10622.7 11051.2 11077.8 11087.7 11960.5 9831.0 10044.4 10414.7 10608.6 11212.8 10061.7 10467.8 10487.0 10587.7 11175.1 10004.6 10122.5 10249.4 10552.2 11410.4 8280.3 8523.0 8540.7 8549.1 9220.8 8415.3 8814.0 9173.0 9380.4 9770.7 23:18:02 INFO - PROCESS | 3838 | -------- Summary: end -------- 23:18:02 INFO - PROCESS | 3838 | 23:18:03 INFO - TEST-INFO | 3838: exit 0 23:18:03 INFO - TEST-OK | dromaeo_css | took 1111446ms 23:18:03 INFO - TEST-START | kraken 23:18:03 INFO - operating with platform_type : linux_ 23:18:03 INFO - Initialising browser for kraken test... 23:18:03 INFO - TEST-INFO | started process 4039 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyzVSzq/profile http://localhost:59762/getInfo.html) 23:18:06 INFO - PROCESS | 4039 | __metrics Screen width/height:1600/1200 23:18:06 INFO - PROCESS | 4039 | colorDepth:24 23:18:06 INFO - PROCESS | 4039 | Browser inner width/height: 1024/697 23:18:06 INFO - PROCESS | 4039 | __metrics 23:18:07 INFO - PROCESS | 4039 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:18:07 INFO - PROCESS | 4039 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:18:07 INFO - TEST-INFO | 4039: exit 0 23:18:07 INFO - Browser initialized. 23:18:07 INFO - Running cycle 1/1 for kraken test... 23:18:07 INFO - TEST-INFO | started process 4121 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyzVSzq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:18:19 INFO - PROCESS | 4121 | RSS: Main: 148709376 23:18:19 INFO - PROCESS | 4121 | 23:18:22 INFO - PROCESS | 4121 | Cycle 1(1): loaded http://localhost:59762/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59762/tests/kraken/driver.html?testName=audio-beat-detection) 23:18:22 INFO - PROCESS | 4121 | RSS: Main: 186048512 23:18:22 INFO - PROCESS | 4121 | 23:18:25 INFO - PROCESS | 4121 | Cycle 1(1): loaded http://localhost:59762/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59762/tests/kraken/driver.html?testName=audio-dft) 23:18:26 INFO - PROCESS | 4121 | RSS: Main: 175833088 23:18:26 INFO - PROCESS | 4121 | 23:18:28 INFO - PROCESS | 4121 | Cycle 1(1): loaded http://localhost:59762/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59762/tests/kraken/driver.html?testName=audio-fft) 23:18:29 INFO - PROCESS | 4121 | RSS: Main: 161464320 23:18:29 INFO - PROCESS | 4121 | 23:18:31 INFO - PROCESS | 4121 | Cycle 1(1): loaded http://localhost:59762/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59762/tests/kraken/driver.html?testName=audio-oscillator) 23:18:32 INFO - PROCESS | 4121 | RSS: Main: 162336768 23:18:32 INFO - PROCESS | 4121 | 23:18:34 INFO - PROCESS | 4121 | Cycle 1(1): loaded http://localhost:59762/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59762/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:18:34 INFO - PROCESS | 4121 | RSS: Main: 164167680 23:18:34 INFO - PROCESS | 4121 | 23:18:37 INFO - PROCESS | 4121 | Cycle 1(1): loaded http://localhost:59762/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59762/tests/kraken/driver.html?testName=imaging-darkroom) 23:18:38 INFO - PROCESS | 4121 | RSS: Main: 163848192 23:18:38 INFO - PROCESS | 4121 | 23:18:41 INFO - PROCESS | 4121 | Cycle 1(1): loaded http://localhost:59762/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59762/tests/kraken/driver.html?testName=imaging-desaturate) 23:18:42 INFO - PROCESS | 4121 | RSS: Main: 166469632 23:18:42 INFO - PROCESS | 4121 | 23:18:45 INFO - PROCESS | 4121 | Cycle 1(1): loaded http://localhost:59762/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59762/tests/kraken/driver.html?testName=json-parse-financial) 23:18:45 INFO - PROCESS | 4121 | RSS: Main: 164802560 23:18:45 INFO - PROCESS | 4121 | 23:18:47 INFO - PROCESS | 4121 | Cycle 1(1): loaded http://localhost:59762/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59762/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:18:47 INFO - PROCESS | 4121 | RSS: Main: 175935488 23:18:47 INFO - PROCESS | 4121 | 23:18:49 INFO - PROCESS | 4121 | Cycle 1(1): loaded http://localhost:59762/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59762/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:18:50 INFO - PROCESS | 4121 | RSS: Main: 175693824 23:18:50 INFO - PROCESS | 4121 | 23:18:52 INFO - PROCESS | 4121 | Cycle 1(1): loaded http://localhost:59762/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59762/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:18:52 INFO - PROCESS | 4121 | RSS: Main: 186638336 23:18:52 INFO - PROCESS | 4121 | 23:18:55 INFO - PROCESS | 4121 | Cycle 1(1): loaded http://localhost:59762/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59762/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:18:55 INFO - PROCESS | 4121 | RSS: Main: 194473984 23:18:55 INFO - PROCESS | 4121 | 23:18:58 INFO - PROCESS | 4121 | Cycle 1(1): loaded http://localhost:59762/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59762/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:18:59 INFO - PROCESS | 4121 | RSS: Main: 191496192 23:18:59 INFO - PROCESS | 4121 | 23:19:00 INFO - PROCESS | 4121 | Cycle 1(1): loaded http://localhost:59762/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59762/tests/kraken/driver.html?testName=ai-astar) 23:19:01 INFO - PROCESS | 4121 | RSS: Main: 248934400 23:19:01 INFO - PROCESS | 4121 | 23:19:01 INFO - PROCESS | 4121 | __start_tp_report 23:19:01 INFO - PROCESS | 4121 | _x_x_mozilla_page_load 23:19:01 INFO - PROCESS | 4121 | _x_x_mozilla_page_load_details 23:19:01 INFO - PROCESS | 4121 | |i|pagename|runs| 23:19:01 INFO - PROCESS | 4121 | |0;ai-astar;108;112;103;110;110;110;100;110;110;117 23:19:01 INFO - PROCESS | 4121 | |1;audio-beat-detection;162;127;148;164;128;152;158;127;164;127 23:19:01 INFO - PROCESS | 4121 | |2;audio-dft;161;162;162;162;163;161;161;164;163;162 23:19:01 INFO - PROCESS | 4121 | |3;audio-fft;75;71;86;89;72;73;72;114;91;73 23:19:01 INFO - PROCESS | 4121 | |4;audio-oscillator;97;96;138;96;96;97;141;96;96;138 23:19:01 INFO - PROCESS | 4121 | |5;imaging-gaussian-blur;110;109;109;110;109;109;109;109;109;109 23:19:01 INFO - PROCESS | 4121 | |6;imaging-darkroom;145;146;145;146;146;145;147;146;146;146 23:19:01 INFO - PROCESS | 4121 | |7;imaging-desaturate;97;96;96;97;96;95;96;96;95;95 23:19:01 INFO - PROCESS | 4121 | |8;json-parse-financial;57;56;57;55;57;57;57;65;53;53 23:19:01 INFO - PROCESS | 4121 | |9;json-stringify-tinderbox;68;68;68;67;67;68;68;68;67;67 23:19:01 INFO - PROCESS | 4121 | |10;stanford-crypto-aes;86;86;88;88;95;89;90;88;88;87 23:19:01 INFO - PROCESS | 4121 | |11;stanford-crypto-ccm;118;118;119;120;129;117;133;116;131;125 23:19:01 INFO - PROCESS | 4121 | |12;stanford-crypto-pbkdf2;159;148;165;157;155;144;159;161;156;154 23:19:01 INFO - PROCESS | 4121 | |13;stanford-crypto-sha256-iterative;70;69;69;68;70;70;69;67;68;67 23:19:01 INFO - PROCESS | 4121 | __end_tp_report 23:19:01 INFO - PROCESS | 4121 | __start_cc_report 23:19:01 INFO - PROCESS | 4121 | _x_x_mozilla_cycle_collect,950 23:19:01 INFO - PROCESS | 4121 | __end_cc_report 23:19:01 INFO - PROCESS | 4121 | __startTimestamp1452583141003__endTimestamp 23:19:01 INFO - PROCESS | 4121 | 23:19:01 INFO - PROCESS | 4121 | ------- Summary: start ------- 23:19:01 INFO - PROCESS | 4121 | Number of tests: 14 23:19:01 INFO - PROCESS | 4121 | 23:19:01 INFO - PROCESS | 4121 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:4.67 (4.2%) stddev-sans-first:4.94 23:19:01 INFO - PROCESS | 4121 | Values: 108.0 112.0 103.0 110.0 110.0 110.0 100.0 110.0 110.0 117.0 23:19:01 INFO - PROCESS | 4121 | 23:19:01 INFO - PROCESS | 4121 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:155.00 stddev:16.65 (10.7%) stddev-sans-first:16.58 23:19:01 INFO - PROCESS | 4121 | Values: 162.0 127.0 148.0 164.0 128.0 152.0 158.0 127.0 164.0 127.0 23:19:01 INFO - PROCESS | 4121 | 23:19:01 INFO - PROCESS | 4121 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:0.97 23:19:01 INFO - PROCESS | 4121 | Values: 161.0 162.0 162.0 162.0 163.0 161.0 161.0 164.0 163.0 162.0 23:19:01 INFO - PROCESS | 4121 | 23:19:01 INFO - PROCESS | 4121 | [#3] audio-fft Cycles:10 Average:81.60 Median:74.00 stddev:13.75 (18.6%) stddev-sans-first:14.37 23:19:01 INFO - PROCESS | 4121 | Values: 75.0 71.0 86.0 89.0 72.0 73.0 72.0 114.0 91.0 73.0 23:19:01 INFO - PROCESS | 4121 | 23:19:01 INFO - PROCESS | 4121 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:96.00 stddev:20.65 (21.5%) stddev-sans-first:21.44 23:19:01 INFO - PROCESS | 4121 | Values: 97.0 96.0 138.0 96.0 96.0 97.0 141.0 96.0 96.0 138.0 23:19:01 INFO - PROCESS | 4121 | 23:19:01 INFO - PROCESS | 4121 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 23:19:01 INFO - PROCESS | 4121 | Values: 110.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 23:19:01 INFO - PROCESS | 4121 | 23:19:01 INFO - PROCESS | 4121 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 23:19:01 INFO - PROCESS | 4121 | Values: 145.0 146.0 145.0 146.0 146.0 145.0 147.0 146.0 146.0 146.0 23:19:01 INFO - PROCESS | 4121 | 23:19:01 INFO - PROCESS | 4121 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 23:19:01 INFO - PROCESS | 4121 | Values: 97.0 96.0 96.0 97.0 96.0 95.0 96.0 96.0 95.0 95.0 23:19:01 INFO - PROCESS | 4121 | 23:19:01 INFO - PROCESS | 4121 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:3.33 (5.9%) stddev-sans-first:3.54 23:19:01 INFO - PROCESS | 4121 | Values: 57.0 56.0 57.0 55.0 57.0 57.0 57.0 65.0 53.0 53.0 23:19:01 INFO - PROCESS | 4121 | 23:19:01 INFO - PROCESS | 4121 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 23:19:01 INFO - PROCESS | 4121 | Values: 68.0 68.0 68.0 67.0 67.0 68.0 68.0 68.0 67.0 67.0 23:19:01 INFO - PROCESS | 4121 | 23:19:01 INFO - PROCESS | 4121 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:88.00 stddev:2.59 (2.9%) stddev-sans-first:2.59 23:19:01 INFO - PROCESS | 4121 | Values: 86.0 86.0 88.0 88.0 95.0 89.0 90.0 88.0 88.0 87.0 23:19:01 INFO - PROCESS | 4121 | 23:19:01 INFO - PROCESS | 4121 | [#11] stanford-crypto-ccm Cycles:10 Average:122.60 Median:122.50 stddev:6.35 (5.2%) stddev-sans-first:6.51 23:19:01 INFO - PROCESS | 4121 | Values: 118.0 118.0 119.0 120.0 129.0 117.0 133.0 116.0 131.0 125.0 23:19:01 INFO - PROCESS | 4121 | 23:19:01 INFO - PROCESS | 4121 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.80 Median:158.00 stddev:6.12 (3.9%) stddev-sans-first:6.39 23:19:01 INFO - PROCESS | 4121 | Values: 159.0 148.0 165.0 157.0 155.0 144.0 159.0 161.0 156.0 154.0 23:19:01 INFO - PROCESS | 4121 | 23:19:01 INFO - PROCESS | 4121 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.16 (1.7%) stddev-sans-first:1.13 23:19:01 INFO - PROCESS | 4121 | Values: 70.0 69.0 69.0 68.0 70.0 70.0 69.0 67.0 68.0 67.0 23:19:01 INFO - PROCESS | 4121 | -------- Summary: end -------- 23:19:01 INFO - PROCESS | 4121 | 23:19:01 INFO - TEST-INFO | 4121: exit 0 23:19:01 INFO - TEST-OK | kraken | took 58632ms 23:19:01 INFO - TEST-START | v8_7 23:19:01 INFO - operating with platform_type : linux_ 23:19:01 INFO - Initialising browser for v8_7 test... 23:19:01 INFO - TEST-INFO | started process 4372 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVJfBYx/profile http://localhost:59762/getInfo.html) 23:19:05 INFO - PROCESS | 4372 | __metrics Screen width/height:1600/1200 23:19:05 INFO - PROCESS | 4372 | colorDepth:24 23:19:05 INFO - PROCESS | 4372 | Browser inner width/height: 1024/697 23:19:05 INFO - PROCESS | 4372 | __metrics 23:19:05 INFO - PROCESS | 4372 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:19:05 INFO - PROCESS | 4372 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:19:06 INFO - TEST-INFO | 4372: exit 0 23:19:06 INFO - Browser initialized. 23:19:06 INFO - Running cycle 1/1 for v8_7 test... 23:19:06 INFO - TEST-INFO | started process 4453 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVJfBYx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:19:18 INFO - PROCESS | 4453 | RSS: Main: 148217856 23:19:18 INFO - PROCESS | 4453 | 23:19:40 INFO - PROCESS | 4453 | Cycle 1(1): loaded http://localhost:59762/tests/v8_7/run.html (next: http://localhost:59762/tests/v8_7/run.html) 23:19:40 INFO - PROCESS | 4453 | RSS: Main: 587948032 23:19:40 INFO - PROCESS | 4453 | 23:19:40 INFO - PROCESS | 4453 | __start_tp_report 23:19:40 INFO - PROCESS | 4453 | _x_x_mozilla_page_load 23:19:40 INFO - PROCESS | 4453 | _x_x_mozilla_page_load_details 23:19:40 INFO - PROCESS | 4453 | |i|pagename|runs| 23:19:40 INFO - PROCESS | 4453 | |0;Richards;170.32873445750297 23:19:40 INFO - PROCESS | 4453 | |1;DeltaBlue;196.7729240456513 23:19:40 INFO - PROCESS | 4453 | |2;Encrypt;283.5270768358378 23:19:40 INFO - PROCESS | 4453 | |3;Decrypt;5170.103092783505 23:19:40 INFO - PROCESS | 4453 | |4;RayTrace;1998.0039920159682 23:19:40 INFO - PROCESS | 4453 | |5;Earley;800 23:19:40 INFO - PROCESS | 4453 | |6;Boyer;12432.098765432098 23:19:40 INFO - PROCESS | 4453 | |7;RegExp;42936.17021276596 23:19:40 INFO - PROCESS | 4453 | |8;Splay;641.025641025641 23:19:40 INFO - PROCESS | 4453 | |9;NavierStokes;4840.579710144928 23:19:40 INFO - PROCESS | 4453 | __end_tp_report 23:19:40 INFO - PROCESS | 4453 | __startTimestamp1452583180971__endTimestamp 23:19:40 INFO - PROCESS | 4453 | 23:19:40 INFO - PROCESS | 4453 | ------- Summary: start ------- 23:19:40 INFO - PROCESS | 4453 | Number of tests: 10 23:19:40 INFO - PROCESS | 4453 | 23:19:40 INFO - PROCESS | 4453 | [#0] Richards Cycles:1 Average:170.33 Median:170.33 stddev:0.00 (0.0%) 23:19:40 INFO - PROCESS | 4453 | Values: 170.3 23:19:40 INFO - PROCESS | 4453 | 23:19:40 INFO - PROCESS | 4453 | [#1] DeltaBlue Cycles:1 Average:196.77 Median:196.77 stddev:0.00 (0.0%) 23:19:40 INFO - PROCESS | 4453 | Values: 196.8 23:19:40 INFO - PROCESS | 4453 | 23:19:40 INFO - PROCESS | 4453 | [#2] Encrypt Cycles:1 Average:283.53 Median:283.53 stddev:0.00 (0.0%) 23:19:40 INFO - PROCESS | 4453 | Values: 283.5 23:19:40 INFO - PROCESS | 4453 | 23:19:40 INFO - PROCESS | 4453 | [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 23:19:40 INFO - PROCESS | 4453 | Values: 5170.1 23:19:40 INFO - PROCESS | 4453 | 23:19:40 INFO - PROCESS | 4453 | [#4] RayTrace Cycles:1 Average:1998.00 Median:1998.00 stddev:0.00 (0.0%) 23:19:40 INFO - PROCESS | 4453 | Values: 1998.0 23:19:40 INFO - PROCESS | 4453 | 23:19:40 INFO - PROCESS | 4453 | [#5] Earley Cycles:1 Average:800.00 Median:800.00 stddev:0.00 (0.0%) 23:19:40 INFO - PROCESS | 4453 | Values: 800.0 23:19:40 INFO - PROCESS | 4453 | 23:19:40 INFO - PROCESS | 4453 | [#6] Boyer Cycles:1 Average:12432.10 Median:12432.10 stddev:0.00 (0.0%) 23:19:40 INFO - PROCESS | 4453 | Values: 12432.1 23:19:40 INFO - PROCESS | 4453 | 23:19:40 INFO - PROCESS | 4453 | [#7] RegExp Cycles:1 Average:42936.17 Median:42936.17 stddev:0.00 (0.0%) 23:19:40 INFO - PROCESS | 4453 | Values: 42936.2 23:19:40 INFO - PROCESS | 4453 | 23:19:40 INFO - PROCESS | 4453 | [#8] Splay Cycles:1 Average:641.03 Median:641.03 stddev:0.00 (0.0%) 23:19:40 INFO - PROCESS | 4453 | Values: 641.0 23:19:40 INFO - PROCESS | 4453 | 23:19:40 INFO - PROCESS | 4453 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 23:19:40 INFO - PROCESS | 4453 | Values: 4840.6 23:19:40 INFO - PROCESS | 4453 | -------- Summary: end -------- 23:19:40 INFO - PROCESS | 4453 | 23:19:41 INFO - TEST-INFO | 4453: exit 0 23:19:41 INFO - TEST-OK | v8_7 | took 39960ms 23:19:41 INFO - SUITE-END | took 1210s 23:19:41 INFO - Completed test suite (00:20:10) 23:19:41 INFO - Working with test: dromaeo_css 23:19:41 INFO - Generating results file: dromaeo_css 23:19:41 INFO - Working with test: kraken 23:19:41 INFO - Generating results file: kraken 23:19:41 INFO - javascript benchmark 23:19:41 INFO - Working with test: v8_7 23:19:41 INFO - Generating results file: v8_7 23:19:41 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:19:42 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 23:19:42 INFO - process_Request line: dromaeo_css 6506.59 graph.html#tests=[[72,64,35]] 23:19:42 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:19:42 INFO - process_Request line: kraken 1518.30 graph.html#tests=[[232,64,35]] 23:19:42 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:19:42 INFO - process_Request line: v8_7 18563.22 graph.html#tests=[[230,64,35]] 23:19:42 INFO - RETURN: dromaeo_css: 6506.59 23:19:42 INFO - RETURN: kraken: 1518.30 23:19:42 INFO - RETURN: v8_7: 18563.22 23:19:42 INFO - javascript benchmark 23:19:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2990.850457477128, 3013.2165636934396, 3032.7877048606592, 3041.224487755623, 3047.512398016318, 4852.02959408118, 4951.727654978979, 4954.925676114852, 4964.627652926027, 5000.899802043549, 4869.391326084239, 4892.6575139740235, 4899.43656479505, 4927.1870141426625, 4953.405591329037, 4349.151915376503, 4490.640748740093, 4492.258777301741, 4509.954900450986, 4614.792334344963, 4524.072565124158, 4528.20756367636, 4578.427696537933, 4596.287575425815, 4639.234526303156, 4431.822727090913, 4514.0971805639, 4517.706349087299, 4538.047010127877, 4544.750038747868, 4633.119707255611, 4647.60495357895, 4649.883752906205, 4657.69724967876, 4680.508546602626, 4506.121306345264, 4609.2394754865745, 4613.907721845544, 4635.605973492257, 4647.395838540968, 4825.396825396825, 4878.146324393217, 4892.633052521075, 4895.926561101586, 4931.9753401232765, 5329.280547126127, 5336.43967383423, 5336.546393556552, 5337.946620533823, 5382.085045542267, 5337.306150200449, 5364.6512976656395, 5365.382980957201, 5427.891442171174, 5435.157550579666, 5007.073691367109, 5030.144875371196, 5054.1407960646775, 5054.570361519312, 5091.821786237501, 5496.5053145217125, 5525.834224973257, 5526.281583394133, 5528.253685752452, 5530.336359636869, 5229.346331708536, 5242.423333433319, 5337.973310133424, 5342.519173274424, 5391.56867450603, 5358.5981051421295, 5375.139977603565, 5376.193570964387, 5382.407935127133, 5412.07994640912, 5336.332958380202, 5338.332708411449, 5342.652727572773, 5356.732163391893, 5391.838244852661, 5280.287161233261, 5302.310699609104, 5335.279737235501, 5362.383325917492, 5379.973100134553, 4183.811728472226, 4191.622753952159, 4192.014876504019, 4224.957750422518, 4236.2374772540625, 3724.478572999782, 3727.6645101940953, 3730.813459327077, 3762.492063571383, 3762.680172185395, 4957.752112394366, 4967.5777558907175, 5003.3495645565845, 5004.574611158019, 5056.924146137811, 5335.279737235501, 5349.919751203657, 5353.732313384316, 5357.062514060024, 5373.247745315659, 5024.221245706921, 5028.773705183203, 5029.421616514074, 5031.622628302892, 5069.949300506948, 4539.0694907543875, 4585.747783871919, 4620.584147426748, 4634.467036290802, 4681.180793361148, 5539.0, 5540.501354878, 5556.638818476786, 5561.249231353796, 5570.108782594765, 5326.147816349366, 5335.306410166809, 5336.67979921206, 5342.519173274424, 5367.409584945731, 5417.783288668409, 5517.393086760373, 5603.607747457639, 5629.831105066854, 5705.34388545306, 5330.413654498079, 5354.9464505354445, 5356.973215133899, 5361.27622770921, 5368.543673787772, 5216.008958297912, 5412.0, 5437.102878025082, 5452.6183167177915, 5482.205080263259, 5215.322008138917, 5223.634345595772, 5282.022825777243, 5285.497877701612, 5327.200919862052, 5209.71346575942, 5212.374515058217, 5215.895682086261, 5216.347956505437, 5266.631335806457, 5018.573421259234, 5121.411037730709, 5123.180291153547, 5128.974355128201, 5159.432462429205, 5044.394672639307, 5226.790928362823, 5234.241035049972, 5256.816011439734, 5275.630705850707, 5169.896602068013, 5176.223566465061, 5178.61160412963, 5183.429822719422, 5197.4282828889545], "unit": "score", "name": "dojo.html", "value": 4948.2647039782005}, {"lowerIsBetter": false, "replicates": [514.2902794144082, 528.7620570743167, 547.7671989404503, 564.3538148819601, 577.7198058941412, 28756.424871502557, 29335.119946401588, 29340.413191736177, 29344.26639334018, 35589.2882142357, 38780.612193878056, 39314.21371572574, 39511.0, 39676.80161599195, 39678.404823927594, 8356.707515236983, 8495.787605309855, 8520.616572254263, 8566.0, 8569.785755356135, 8219.71231006915, 8279.379046571501, 8314.127016663255, 8322.459040162401, 8351.206635369661, 8321.66713331466, 8474.618642161118, 8559.058503564604, 8559.101294364096, 8562.186592273723, 8446.0, 8503.702370417037, 8507.0, 8508.3618728595, 8511.957440212791, 8455.069942306342, 8615.526146061964, 8626.482411055356, 8634.136586341378, 8643.783905402415, 38799.0, 39081.0, 39221.60778392208, 39279.0, 39324.41013384802, 2941.911742647724, 3167.889123880653, 3389.237421580149, 3488.8778892738887, 3549.396602577542, 27767.444651107067, 27814.860925695444, 28215.15354539367, 29771.553426698618, 29810.70189298101, 3257.446234140202, 3358.580177477815, 3375.696187343151, 3379.509971054208, 3459.15250763562, 192796.0, 193075.0, 193124.9999999986, 193314.0, 193426.0, 51716.48283517192, 52836.20745688818, 56042.719786400805, 56559.43440565542, 59003.0, 52646.73676631669, 52851.73574132105, 53067.20399194015, 53067.46932530702, 53077.46922530803, 14214.85785142156, 14349.928250358891, 14362.640933976734, 14404.927975360266, 14411.78382324266, 9704.175145112744, 10013.549390277454, 10161.441120738431, 10402.635907743344, 10470.528826202839, 19399.127039283267, 19529.08242302877, 19578.0, 20156.395308140778, 20161.0, 7212.170600380919, 7292.45306602007, 7303.561786292839, 7348.5958272294465, 7419.406447484188, 901.2249465459699, 963.5615794813343, 968.5157421289356, 990.8612794208673, 1051.673981065872, 27914.302142446602, 28147.57778633281, 28152.577711334347, 28464.28839278993, 28479.430411391655, 997.6059456514781, 1009.0514915978956, 1019.5106348952544, 1071.464267866067, 1093.4860615510697, 13184.472621095048, 13294.667633309246, 13348.332583370793, 15414.0, 15489.845101549066, 326142.0, 333215.0, 333233.0, 333241.0, 333412.0, 48017.27974080392, 48037.279440808416, 48090.0, 48128.0, 48241.27638085432, 1279.2004996876951, 1284.9743005139844, 1299.2009913902882, 1302.049503862186, 1315.0, 28083.43833123367, 28801.711982879904, 29066.41867162687, 29362.412751744418, 29625.555616665337, 42707.35938960856, 43552.34671479994, 48373.75813120912, 49067.263991040876, 49124.75437622789, 239042.0, 241077.0, 241363.0, 241401.0, 241944.0, 26136.8693156533, 30267.69732302737, 30327.393452131277, 30541.694583054774, 30637.23406914845, 30658.0, 37123.628763713095, 37869.81065094657, 38029.0, 38343.233135337694, 32582.0, 33779.0, 34145.48781768325, 34393.65606343905, 34494.48258276078, 33371.666283336854, 34665.306693866485, 35502.0, 35927.46108808422, 37181.25637487289, 34311.0, 34907.650923491456, 35075.649243507236, 35151.0, 35177.82411087928, 28899.711002890544, 29566.40867182601, 29645.851770741006, 29869.253268668457, 29936.550951735306, 22941.426464338525, 22947.885260574258, 23234.883825580764, 23305.650415244123, 23349.0], "unit": "score", "name": "ext.html", "value": 17284.82154094778}, {"lowerIsBetter": false, "replicates": [346.8785924926276, 350.2592017882178, 353.0414923482744, 359.9352116619009, 360.1805891596618, 13489.595312140651, 14016.43934242629, 16132.0, 16179.352825886965, 17174.398896038627, 14148.93882958777, 14178.787318190236, 14826.406943722239, 14842.480513182041, 14871.033382830108, 5023.522765337306, 5054.418741844689, 5238.4499627539135, 5244.9213261800915, 5246.868828279305, 3853.402722578005, 4008.919821603566, 5162.328897243353, 5556.722163891809, 5771.913421298684, 4825.90348193036, 5693.0, 5725.255716756816, 5749.856253593673, 5765.423457654243, 4964.007198560303, 4966.304717339575, 4974.452810190876, 4994.450610432849, 4998.3502144721315, 4724.5039270876405, 4927.359443272388, 4946.480619534969, 4981.551660350549, 4989.426215985171, 11699.532018719241, 11897.464614092387, 16437.0, 19605.80394196054, 19638.214471421124, 1870.9064546772606, 1877.4836919847014, 1910.2359056377422, 1930.9806901930942, 2032.1769683278148, 8815.294776417872, 9018.278537716968, 9097.363184577081, 10937.179711521667, 12365.763423657652, 1696.787901512311, 1736.8089510153873, 1737.8957262564286, 1795.5062357851564, 1816.0, 52515.21227181595, 52586.211206831926, 52773.999999999614, 53050.0, 53722.0, 8578.027053777667, 8767.1671191238, 9050.27597792175, 9071.773205669779, 9142.908570914338, 10898.782024359627, 10920.781584368267, 10929.30595757659, 10935.453227338601, 10956.12351011917, 6559.836004099936, 6574.3754343337305, 6649.168853893263, 6683.997400389981, 6826.965865170642, 6206.0690896365, 6457.580257283262, 6512.251091124486, 6521.250056243498, 6527.771527996498, 3277.2462333663393, 3569.196930690574, 3630.8547658093908, 3659.432787917877, 3669.3028324618235, 1432.4127107885718, 1528.8700460460987, 1535.8617724404858, 1565.4833904811612, 1608.4209684513567, 433.9913201735948, 447.08794060117646, 841.869510225916, 882.250087425683, 999.2905037423366, 9512.857307140399, 9604.807903841884, 9721.562529686182, 9989.0, 10325.225608079425, 825.7110011495928, 854.428171204666, 905.3345790843724, 909.5134103254727, 916.7708072981754, 8533.786655333666, 8552.315814734806, 8593.69922052725, 8861.113888611088, 8878.556072196365, 357406.0, 368901.0, 459985.0, 501875.0, 548118.0, 68681.65659171772, 70054.64972675206, 70418.9437158443, 72224.63887680529, 73233.26766732371, 1128.1933417606451, 1140.5779861451317, 1148.5405837665, 1165.6561314412268, 1167.538822165257, 14378.568642940729, 14398.0, 14938.633540372672, 15010.174440405883, 15178.165200914056, 32853.67146328506, 33600.0, 34101.65898340985, 34282.48576271308, 34458.2222045302, 40445.0, 41003.38494922638, 41410.58589414067, 42143.157136857706, 42277.57722422737, 6626.304238054935, 6758.493113016445, 6969.58182509051, 7031.261717519586, 7184.461165412719, 7823.804404889924, 10132.088112069654, 10222.28444008942, 10718.303310284806, 10839.403832788958, 8982.730518084469, 9442.52787360643, 9745.0, 9767.120959113714, 9777.315587909063, 9247.76880577991, 9449.905500945177, 9663.565139568596, 9875.40747555149, 9941.30410871232, 9664.516774161124, 9680.806383872425, 9778.41329520231, 9955.20358371343, 10062.195024397884, 6664.733410663519, 6888.552244104118, 6899.0341352211735, 7088.645567721696, 7168.53404528704, 9226.169644732006, 9581.664641737505, 9642.180414664552, 9689.12797848197, 9746.366486178376], "unit": "score", "name": "jquery.html", "value": 7489.509883400182}, {"lowerIsBetter": false, "replicates": [1291.7933130699078, 1426.3937826423767, 1432.878205352545, 1467.3983666696656, 1573.5515378117245, 6752.155980502437, 7486.401087912967, 7576.393888488921, 7610.961945190274, 7619.276168763972, 7633.732819351324, 7634.9236507634905, 7678.846423071549, 7689.846203075935, 7693.576853273068, 1977.3672424824063, 2030.5938812237537, 2272.5682120397155, 2277.7038984931937, 2282.8287878409187, 2280.851744636602, 2337.2053501809382, 2341.285907798121, 2345.460544074855, 2346.343023953296, 2248.8313376496744, 2271.0, 2291.209532711212, 2297.264875239924, 2299.321700098475, 2175.934721958336, 2188.3325585696434, 2217.9556408871813, 2254.0870947266385, 2263.875486848223, 2280.646499792535, 2290.118304452781, 2300.332903458012, 2300.7469178390365, 2315.2938353802083, 7533.7363192288, 7537.0, 7569.243075692441, 7579.772606821804, 7585.0, 4534.8866278342975, 4656.0, 4662.254039353721, 4663.27719203524, 4670.883227919295, 3009.1875193697797, 3082.3835232953497, 3138.73320767735, 3140.921476963071, 3151.243701511644, 954.4511905654276, 965.2567523007315, 984.8965858584888, 998.3760149906309, 1017.6743442098532, 10460.320079194827, 10595.523201455953, 10600.204984626107, 10605.575776968912, 10611.946940265248, 4031.596840315945, 4135.110951145518, 4141.958580414157, 4151.771652559139, 4219.7046206765235, 8844.73465796027, 8845.0, 8849.51327676984, 8850.557472126367, 8861.778455538662, 4608.539146085364, 4623.976880115578, 4633.235516139866, 4634.050019745944, 4641.257398816173, 4141.772202528829, 4187.91624167515, 4192.224438478891, 4225.9577404225565, 4227.3447615619625, 3257.706806387389, 3325.4014277430297, 3334.233126380946, 3447.8620855166014, 3524.22467057247, 1051.363924825485, 1084.3819023156882, 1086.2124959404528, 1088.7659153282082, 1088.9618863339904, 1256.0956111599633, 1262.8863402293837, 1267.7464507098616, 1315.5592876386518, 1316.9407376668073, 7315.56106633593, 7339.266073392618, 7348.52234604749, 7353.522021068614, 7365.042544469185, 1087.6682611803317, 1091.7543552700579, 1098.3025778630467, 1115.2137742891405, 1119.6696974392573, 5734.082546792577, 5791.797287094932, 5812.273465816773, 5815.592908496449, 5816.447437493432, 9231.815363692824, 9277.62889484413, 9476.810463790824, 9589.041095890494, 9593.808123837483, 9249.167574918156, 9323.90676093244, 9381.155695987394, 9426.293028022927, 9433.05669433065, 7240.637968101574, 7318.743843965436, 7334.523255988343, 7427.034485516956, 7444.404447644176, 7129.857402851811, 7175.569465832067, 7180.210176880434, 7185.281471852982, 7196.676149573177, 8114.675412983651, 8308.459950103224, 8388.370872184489, 8400.159984001551, 8552.529610871461, 8612.18184272493, 8789.121087891159, 8791.648334066565, 8805.69180078694, 8808.823823523366, 6438.645874476949, 6616.206055273398, 6616.305287944697, 6616.8345791355605, 6628.5691430056895, 6589.4728421725185, 6768.323167683192, 6855.4172895304455, 7024.1571011478945, 7030.753923612649, 6773.221079575912, 6862.039314496074, 6915.861682766417, 6972.58164510131, 6990.825229369307, 6762.763303284361, 6778.152730908637, 6798.660066996729, 6915.515913886181, 6928.341807528277, 6885.862282754417, 6900.102986611709, 6913.930860691329, 6921.965390173017, 6931.202911665223, 6360.936390636034, 6408.58344207625, 6433.099366088845, 6435.935640643534, 6442.645654489048, 6497.967510162419, 6528.738850445929, 6542.378474044958, 6549.24683661366, 6564.901526477202], "unit": "score", "name": "mootools.html", "value": 4425.182003439618}, {"lowerIsBetter": false, "replicates": [317.29402080371165, 319.83848156680875, 320.9630892447368, 322.098125249302, 328.80436140496397, 5567.582431317657, 5674.914876276854, 5713.542916566675, 5717.456841600047, 5723.885522289552, 5529.751161197746, 5649.4633009864, 5689.8577535561635, 5690.231818704474, 5693.800716974907, 4186.204621121992, 4232.555581663927, 4421.845235416761, 4426.77866106695, 4429.291313389858, 4312.417823593822, 4356.847510337139, 4379.540148284416, 4380.540043295456, 4389.824407023715, 4310.633596144316, 4318.244307246219, 4331.436913201295, 4340.153670034345, 4343.435353404053, 4335.761533115678, 4339.435873336462, 4341.9782901085455, 4351.73889566627, 4358.8910277243, 3856.5564960029396, 3860.073582340246, 3891.7081218908697, 3897.9805100974313, 3906.687465002793, 5287.444818294062, 5446.373667028302, 5458.426865179139, 5481.890362192734, 5489.039418101816, 4990.82532111378, 4994.900101997976, 5007.649464537484, 5009.624278179152, 5010.048090862724, 5769.278840144982, 5890.587658863881, 5963.612365196248, 6050.788222412194, 6073.210482637273, 4156.2726522858375, 4179.26862799012, 4195.307774217251, 4199.538050814408, 4207.389928460387, 6224.906626400608, 6298.685065746694, 6311.2426508819235, 6311.495080393557, 6314.179156709644, 4258.5954334338185, 4266.914661706748, 4273.594008569181, 4277.486701595766, 4281.828726850953, 4239.851605193803, 4277.123189746095, 4284.807183676742, 4285.292926667127, 4313.180495705806, 4992.650514464025, 5010.624203184776, 5012.223105418666, 5016.724080175625, 5016.774245158977, 6043.214382130383, 6044.0, 6095.634261944298, 6098.176746139303, 6102.4507794298725, 1483.6290927268183, 1518.4837155367006, 1518.840521745201, 1522.3149582687836, 1522.6574020845221, 1007.7279134633754, 1022.320157095538, 1026.1329176845702, 1038.4755698372273, 1051.153821173947, 5758.049921762946, 5764.596478246483, 5767.798127065533, 5777.942220577825, 5778.739956701958, 6220.968895155585, 6222.875542489215, 6231.563790534709, 6256.905041617699, 6274.9686251569365, 5802.941970580325, 5806.361300256968, 5806.82579522615, 5809.506191973645, 5820.505257053113, 3282.770206085599, 3367.898963031113, 3376.274101068233, 3376.915577110592, 3377.7804442711144, 6507.804765857032, 6514.902276465857, 6515.381038801306, 6518.152640156749, 6518.217813862367, 6354.26925903527, 6360.395762402657, 6360.427561519486, 6370.8088757337355, 6373.745050198033, 6341.4292713656, 6505.41451269388, 6509.2839787623325, 6514.967425162844, 6517.663878904813, 6032.1856549365275, 6093.786717464867, 6126.23422072241, 6201.96899015502, 6218.782342617987, 6166.290876549254, 6174.043023331391, 6215.378462153929, 6243.7814676486105, 6244.750209991549, 6555.311692272243, 6560.803175904731, 6560.901586476111, 6565.671716414065, 6568.244651864906, 4192.098698779777, 4272.209641216385, 4275.123599662, 4294.098239369768, 4329.610335069859, 6239.032949892774, 6242.625442473466, 6244.687765611792, 6244.812655620339, 6245.313015568193, 6054.697265136638, 6075.605085669417, 6094.360092190256, 6097.75608975636, 6103.877922441615, 5928.347881733092, 6064.423879731418, 6080.90878636812, 6082.391760823883, 6093.878122437615, 6052.213212282375, 6052.788152414821, 6054.576179667381, 6057.57596968208, 6062.454379105901, 6171.444569988543, 6175.814725558241, 6190.0405437157315, 6198.72105755233, 6211.223597050369, 5835.503982161564, 5972.5520585955355, 6051.0, 6051.062085376773, 6062.787802426894], "unit": "score", "name": "prototype.html", "value": 4565.203491181381}, {"lowerIsBetter": false, "replicates": [667.4193451697024, 705.8623568404163, 739.5303981971454, 768.0514564512825, 780.1496368957836, 13202.075854690176, 13284.0, 13308.866911330884, 13334.0, 13350.999999999987, 12262.693432664166, 12325.075619328563, 12380.442880070395, 12403.627891163256, 12421.0, 640.174175313847, 640.446014197718, 768.8193274580469, 772.0735117858565, 786.6656670914838, 772.5673622771266, 775.4223103787687, 776.4370831147429, 776.8252143267777, 777.8211011467366, 818.7830224990382, 824.2499325613693, 828.0684230240979, 828.2752591482453, 829.3945419843518, 681.0465348512073, 692.6259819697383, 793.9444238903279, 806.9314108300802, 811.0915774332785, 595.3183604772511, 596.4810614765139, 597.1878245585999, 597.4682532546037, 598.2970010237952, 12989.675258118528, 13018.34908254593, 13076.803847942288, 13093.607191784262, 13168.473261069641, 10849.945750271198, 12317.322547259897, 12635.241885486808, 13049.804252936214, 13398.732025359535, 9340.626374944994, 9358.251339892793, 9401.858972115424, 9701.466419346933, 10247.38515689061, 3300.4554248549202, 3392.6098498672723, 3406.693397594204, 3428.639516237149, 3439.002689220123, 39537.60462395368, 40138.99652508681, 40200.597994019976, 40201.597984020074, 42795.78602107001, 9029.864552031724, 9258.305627077862, 9525.0, 9733.464659443798, 10024.298299119138, 16785.24466399015, 17310.65378692419, 17450.0, 17477.475675729747, 17593.648127037388, 7114.679839407239, 7317.853642927112, 7401.8149546261775, 7440.925590744131, 7574.3183113520045, 3850.306944749916, 3891.4746509220895, 3973.0861901762755, 3991.560928297885, 3993.2612466693754, 2855.814372065809, 2863.441628882348, 2869.756070734011, 2874.1233923653067, 2879.3089658481813, 507.59392486011046, 509.96175286853634, 531.5189753273294, 533.5011764000672, 537.6881408782897, 457.70249337930613, 498.29988865643827, 498.6235392278879, 580.8199458167896, 593.8070127208674, 8082.797930051795, 8398.706045288385, 8453.842022556908, 8734.956325218332, 9293.907060929305, 463.4878459302422, 543.0876128104743, 554.603458527155, 558.7066789935317, 589.5637228450915, 3645.398509245998, 3692.2615476904725, 3931.272714547818, 4005.2590270799997, 4036.9596304037173, 55312.0, 55316.72341638266, 55335.44664553383, 55375.44624553784, 57248.0, 47745.0, 48161.277580836315, 48505.029899401816, 48860.511394885594, 49105.75447122813, 43023.78488107539, 43349.349759753626, 43410.13179736325, 44026.779866101104, 44724.77637611791, 7955.602219888867, 7955.761327160194, 8053.6778528858185, 8251.368021351695, 8371.330293576377, 32676.673233268313, 32881.67118328786, 33369.0, 33677.66322336745, 33920.1519961993, 39357.80321098376, 41656.1668766629, 42598.5740142607, 42950.78524607482, 43057.56942430536, 8738.69414570487, 8811.515366654896, 8856.690015849414, 8887.11128887132, 9358.485283309212, 10622.681319560426, 11051.226414150933, 11077.833832492357, 11087.722806929569, 11960.521579136737, 9830.950845245728, 10044.447555384524, 10414.739631509274, 10608.628697995533, 11212.83180752273, 10061.69814905554, 10467.842982355423, 10487.0, 10587.682369528926, 11175.081558194526, 10004.63039029723, 10122.493875306352, 10249.436281004319, 10552.155827533625, 11410.372429516456, 8280.254777070093, 8522.957385213282, 8540.74377768668, 8549.14508549165, 9220.815583688423, 8415.284700800501, 8814.0, 9172.954135229282, 9380.437173769596, 9770.68095807057], "unit": "score", "name": "yui.html", "value": 5862.998606614725}], "name": "dromaeo_css", "value": 6506.588446518588}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 112.0, 103.0, 110.0, 110.0, 110.0, 100.0, 110.0, 110.0, 117.0], "unit": "score", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [162.0, 127.0, 148.0, 164.0, 128.0, 152.0, 158.0, 127.0, 164.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.7}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 162.0, 163.0, 161.0, 161.0, 164.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [75.0, 71.0, 86.0, 89.0, 72.0, 73.0, 72.0, 114.0, 91.0, 73.0], "unit": "score", "name": "audio-fft", "value": 81.6}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 138.0, 96.0, 96.0, 97.0, 141.0, 96.0, 96.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 97.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 57.0, 55.0, 57.0, 57.0, 57.0, 65.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 67.0, 67.0, 68.0, 68.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 88.0, 88.0, 95.0, 89.0, 90.0, 88.0, 88.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.5}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 119.0, 120.0, 129.0, 117.0, 133.0, 116.0, 131.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.6}, {"lowerIsBetter": true, "replicates": [159.0, 148.0, 165.0, 157.0, 155.0, 144.0, 159.0, 161.0, 156.0, 154.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 155.8}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 68.0, 70.0, 70.0, 69.0, 67.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1518.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.32873445750297], "unit": "score", "name": "Richards", "value": 207.25804199999993}, {"lowerIsBetter": false, "replicates": [196.7729240456513], "unit": "score", "name": "DeltaBlue", "value": 336.0116760000001}, {"lowerIsBetter": false, "replicates": [283.5270768358378], "unit": "score", "name": "Encrypt", "value": 938.8203869999999}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1998.0039920159682], "unit": "score", "name": "RayTrace", "value": 370.36412487512496}, {"lowerIsBetter": false, "replicates": [800.0], "unit": "score", "name": "Earley", "value": 833.0787499999997}, {"lowerIsBetter": false, "replicates": [12432.098765432098], "unit": "score", "name": "Boyer", "value": 53.608245283018846}, {"lowerIsBetter": false, "replicates": [42936.17021276596], "unit": "score", "name": "RegExp", "value": 21.21719276511396}, {"lowerIsBetter": false, "replicates": [641.025641025641], "unit": "score", "name": "Splay", "value": 127.12596000000005}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 18563.22251684645}]} 23:19:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "18563.22"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1518.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6506.59"}}} 23:19:42 INFO - Return code: 0 23:19:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:19:42 INFO - # TBPL SUCCESS # 23:19:42 INFO - Running post-action listener: _resource_record_post_action 23:19:42 INFO - Running post-run listener: _resource_record_post_run 23:19:43 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 541822976; Read time: 0; Write time: 365692 23:19:43 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 178540544; Read time: 0; Write time: 159236 23:19:43 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 302567424; Read time: 0; Write time: 174808 23:19:43 INFO - Running post-run listener: _upload_blobber_files 23:19:43 INFO - Blob upload gear active. 23:19:43 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:19:43 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:19:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:19:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:19:43 INFO - (blobuploader) - INFO - Open directory for files ... 23:19:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:19:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:19:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:19:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:19:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:19:44 INFO - (blobuploader) - INFO - Done attempting. 23:19:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:19:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:19:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:19:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:19:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:19:45 INFO - (blobuploader) - INFO - Done attempting. 23:19:45 INFO - (blobuploader) - INFO - Iteration through files over. 23:19:45 INFO - Return code: 0 23:19:45 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:19:45 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:19:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ce0486f9319f6b7e976cd9e20d980a935fa52a9876d262f6f69d1af8dbaf38e8dc20d165c4225398113b2af913b4b9813f834ee4bab292e50ed8a4eca1ec4d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0cac005d615b099d01c71028a0bbd7e54fa48197ee3580fbb1f1678908bc3eef9fb88cbb53f3f59b01f4e203edae571fb7bad44dbe808aac05c6353be0d5a381"} 23:19:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:19:45 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:19:45 INFO - Contents: 23:19:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7ce0486f9319f6b7e976cd9e20d980a935fa52a9876d262f6f69d1af8dbaf38e8dc20d165c4225398113b2af913b4b9813f834ee4bab292e50ed8a4eca1ec4d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0cac005d615b099d01c71028a0bbd7e54fa48197ee3580fbb1f1678908bc3eef9fb88cbb53f3f59b01f4e203edae571fb7bad44dbe808aac05c6353be0d5a381"} 23:19:45 INFO - Copying logs to upload dir... 23:19:45 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1274.198786 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-11 23:19:44.667870) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 23:19:44.672442) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1452581630.560416-1703302380 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/7ce0486f9319f6b7e976cd9e20d980a935fa52a9876d262f6f69d1af8dbaf38e8dc20d165c4225398113b2af913b4b9813f834ee4bab292e50ed8a4eca1ec4d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0cac005d615b099d01c71028a0bbd7e54fa48197ee3580fbb1f1678908bc3eef9fb88cbb53f3f59b01f4e203edae571fb7bad44dbe808aac05c6353be0d5a381"} build_url:https://queue.taskcluster.net/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011361 build_url: 'https://queue.taskcluster.net/v1/task/HXRhM9slRqSZYV-ccWQnSA/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/7ce0486f9319f6b7e976cd9e20d980a935fa52a9876d262f6f69d1af8dbaf38e8dc20d165c4225398113b2af913b4b9813f834ee4bab292e50ed8a4eca1ec4d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0cac005d615b099d01c71028a0bbd7e54fa48197ee3580fbb1f1678908bc3eef9fb88cbb53f3f59b01f4e203edae571fb7bad44dbe808aac05c6353be0d5a381"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 23:19:44.702841) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 23:19:44.703197) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1452581630.560416-1703302380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004627 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 23:19:44.787486) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 23:19:44.787831) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 23:19:44.788135) ========= ========= Total master_lag: 0.29 =========