builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-007 starttime: 1452581909.15 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.153248) ========= 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.153795) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:29.154126) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452576654.220644-845968638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006318 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:29.185927) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:29.186258) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:29.270647) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:29.270977) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452576654.220644-845968638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020175 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:29.320859) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:29.321172) ========= 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.321596) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:29.321893) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452576654.220644-845968638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-11 22:58:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.2M=0s 2016-01-11 22:58:29 (34.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168558 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:29.523449) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:29.523959) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452576654.220644-845968638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.067366 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:29.603170) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-11 22:58:29.603784) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452576654.220644-845968638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-11 22:58:29,771 truncating revision to first 12 chars 2016-01-11 22:58:29,771 Setting DEBUG logging. 2016-01-11 22:58:29,771 attempt 1/10 2016-01-11 22:58:29,772 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,623 unpacking tar archive at: fx-team-d9661fecd939/testing/mozharness/ program finished with exit code 0 elapsedTime=1.157116 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-11 22:58:30.774826) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:30.775139) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:30.785657) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 22:58:30.786006) ========= 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.786459) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-01-11 22:58:30.786761) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=b5f16d05e5ea93ddf675e67e000001bf-1452576654.220644-845968638 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-e10s --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-e10s', 22:58:31 INFO - 'system_bits': '32', 22:58:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:58:31 INFO - 'title': 'talos-linux64-ix-007', 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:32 INFO - Running post-action listener: _resource_record_post_action 22:58:32 INFO - ##### 22:58:32 INFO - ##### Running read-buildbot-config step. 22:58:32 INFO - ##### 22:58:32 INFO - Running pre-action listener: _resource_record_pre_action 22:58:32 INFO - Running main action method: read_buildbot_config 22:58:32 INFO - Using buildbot properties: 22:58:32 INFO - { 22:58:32 INFO - "project": "", 22:58:32 INFO - "product": "firefox", 22:58:32 INFO - "script_repo_revision": "production", 22:58:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:58:32 INFO - "repository": "", 22:58:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 22:58:32 INFO - "buildid": "20160111203200", 22:58:32 INFO - "pgo_build": "True", 22:58:32 INFO - "basedir": "/builds/slave/test-pgo", 22:58:32 INFO - "buildnumber": 197, 22:58:32 INFO - "slavename": "talos-linux64-ix-007", 22:58:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:58:32 INFO - "platform": "ubuntu64_hw", 22:58:32 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:58:32 INFO - "branch": "fx-team", 22:58:32 INFO - "repo_path": "integration/fx-team", 22:58:32 INFO - "revision": "d9661fecd939146a14c5c591f395a68e2d75d211", 22:58:32 INFO - "stage_platform": "linux64-pgo", 22:58:32 INFO - "builduid": "8023b37fc7034a87afa696498af8c4de", 22:58:32 INFO - "slavebuilddir": "test" 22:58:32 INFO - } 22:58:32 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:32 INFO - Running post-action listener: _resource_record_post_action 22:58:32 INFO - ##### 22:58:32 INFO - ##### Running download-and-extract step. 22:58:32 INFO - ##### 22:58:32 INFO - Running pre-action listener: _resource_record_pre_action 22:58:32 INFO - Running main action method: download_and_extract 22:58:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:32 INFO - https://queue.taskcluster.net/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:58:32 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:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HXRhM9slRqSZYV-ccWQnSA/artifacts/public/build/test_packages.json 22:58:32 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:32 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:36 INFO - Downloaded 1302 bytes. 22:58:36 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:58:36 INFO - Using the following test package requirements: 22:58:36 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:58:36 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:58:36 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:36 INFO - u'jsshell-linux-x86_64.zip'], 22:58:36 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:58:36 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:58:36 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:58:36 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:58:36 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:58:36 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:58:36 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:58:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:58:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:36 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:36 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:36 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:36 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:36 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:39 INFO - Downloaded 24025103 bytes. 22:58:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 22:58:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:58:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:58:40 INFO - Return code: 0 22:58:40 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:40 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:40 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:40 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:40 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:40 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:42 INFO - Downloaded 24025103 bytes. 22:58:42 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:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:58:42 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: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.talos.tests.zip 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.talos.tests.zip 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.talos.tests.zip 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.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:58:44 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:46 INFO - Downloaded 11132285 bytes. 22:58:46 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:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:58:46 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:46 INFO - Return code: 0 22:58:46 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:46 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:46 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:46 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:46 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:46 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:50 INFO - Downloaded 55801592 bytes. 22:58:50 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:50 INFO - mkdir: /builds/slave/test-pgo/properties 22:58:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:58:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:58:50 INFO - Contents: 22:58:50 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:50 INFO - Running post-action listener: _resource_record_post_action 22:58:50 INFO - Running post-action listener: set_extra_try_arguments 22:58:50 INFO - ##### 22:58:50 INFO - ##### Running populate-webroot step. 22:58:50 INFO - ##### 22:58:50 INFO - Running pre-action listener: _resource_record_pre_action 22:58:50 INFO - Running main action method: populate_webroot 22:58:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:58:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:58:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:58:50 INFO - '--tppagecycles', 22:58:50 INFO - '7'], 22:58:50 INFO - 'tests': ['tsvgm']}}, 22:58:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:58:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:58:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:58:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:58:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:58:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:58:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:58:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:50 INFO - 'talos_options': ['--e10s'], 22:58:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:58:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:50 INFO - 'tests': ['damp', 'tps']}, 22:58:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:50 INFO - 'talos_options': ['--e10s'], 22:58:50 INFO - 'tests': ['damp', 'tps']}, 22:58:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:58:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:58:50 INFO - 'other': {'tests': ['a11yr', 22:58:50 INFO - 'ts_paint', 22:58:50 INFO - 'tpaint', 22:58:50 INFO - 'sessionrestore', 22:58:50 INFO - 'sessionrestore_no_auto_restore']}, 22:58:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:58:50 INFO - 'tests': ['a11yr', 22:58:50 INFO - 'ts_paint', 22:58:50 INFO - 'tpaint', 22:58:50 INFO - 'sessionrestore', 22:58:50 INFO - 'sessionrestore_no_auto_restore']}, 22:58:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:58:50 INFO - 'tests': ['a11yr', 22:58:50 INFO - 'ts_paint', 22:58:50 INFO - 'tpaint', 22:58:50 INFO - 'sessionrestore', 22:58:50 INFO - 'sessionrestore_no_auto_restore']}, 22:58:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:58:50 INFO - 'tests': ['a11yr', 22:58:50 INFO - 'ts_paint', 22:58:50 INFO - 'tpaint', 22:58:50 INFO - 'sessionrestore', 22:58:50 INFO - 'sessionrestore_no_auto_restore']}, 22:58:50 INFO - 'other_l64': {'tests': ['a11yr', 22:58:50 INFO - 'ts_paint', 22:58:50 INFO - 'tpaint', 22:58:50 INFO - 'sessionrestore', 22:58:50 INFO - 'sessionrestore_no_auto_restore']}, 22:58:50 INFO - 'other_nol64': {'tests': ['a11yr', 22:58:50 INFO - 'ts_paint', 22:58:50 INFO - 'tpaint', 22:58:50 INFO - 'sessionrestore', 22:58:50 INFO - 'sessionrestore_no_auto_restore']}, 22:58:50 INFO - 'svgr': {'tests': ['tsvgx', 22:58:50 INFO - 'tsvgr_opacity', 22:58:50 INFO - 'tart', 22:58:50 INFO - 'tscrollx', 22:58:50 INFO - 'cart']}, 22:58:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:58:50 INFO - 'tests': ['tsvgx', 22:58:50 INFO - 'tsvgr_opacity', 22:58:50 INFO - 'tart', 22:58:50 INFO - 'tscrollx', 22:58:50 INFO - 'cart']}, 22:58:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:50 INFO - 'tests': ['tp5o']}, 22:58:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:50 INFO - 'talos_options': ['--e10s'], 22:58:50 INFO - 'tests': ['tp5o']}, 22:58:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:50 INFO - 'talos_options': ['--xperf_path', 22:58:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:58:50 INFO - 'tests': ['tp5n']}, 22:58:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:50 INFO - 'talos_options': ['--e10s', 22:58:50 INFO - '--xperf_path', 22:58:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:58:50 INFO - 'tests': ['tp5n']}}, 22:58:50 INFO - 'talos.zip': {'path': '', 22:58:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:58:50 INFO - Running post-action listener: _resource_record_post_action 22:58:50 INFO - ##### 22:58:50 INFO - ##### Running create-virtualenv step. 22:58:50 INFO - ##### 22:58:50 INFO - Running pre-action listener: _resource_record_pre_action 22:58:50 INFO - Running main action method: create_virtualenv 22:58:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:58:50 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:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:58:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:58:50 INFO - Using real prefix '/usr' 22:58:50 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 0x7f421cf87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2680630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2711840>, '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 0x267e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267eb60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452576654.220644-845968638', '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452576654.220644-845968638', 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 0x7f421cf87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2680630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2711840>, '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 0x267e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267eb60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452576654.220644-845968638', '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452576654.220644-845968638', 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 - Downloading/unpacking psutil>=0.7.1 22:58:53 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:53 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:53 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:53 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:53 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:53 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 - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:58:56 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:56 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:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:58:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:58:57 INFO - Successfully installed psutil 22:58:57 INFO - Cleaning up... 22:58:57 INFO - Return code: 0 22:58:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:57 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 0x7f421cf87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2680630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2711840>, '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 0x267e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267eb60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452576654.220644-845968638', '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:57 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:57 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:57 INFO - Using env: {'DISPLAY': ':0', 22:58:57 INFO - 'HOME': '/home/cltbld', 22:58:57 INFO - 'LANG': 'en_US.UTF-8', 22:58:57 INFO - 'LANGUAGE': 'en_US:en', 22:58:57 INFO - 'LOGNAME': 'cltbld', 22:58:57 INFO - 'MAIL': '/var/mail/cltbld', 22:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:57 INFO - 'MOZ_NO_REMOTE': '1', 22:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:57 INFO - 'NO_EM_RESTART': '1', 22:58:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:57 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:57 INFO - 'SHELL': '/bin/bash', 22:58:57 INFO - 'SHLVL': '1', 22:58:57 INFO - 'TERM': 'linux', 22:58:57 INFO - 'TMOUT': '86400', 22:58:57 INFO - 'USER': 'cltbld', 22:58:57 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452576654.220644-845968638', 22:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:57 INFO - '_': '/tools/buildbot/bin/python'} 22:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:58:57 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:57 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:57 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:57 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:57 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:57 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:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:58:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:58:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:58:59 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:59 INFO - Installing collected packages: mozsystemmonitor 22:58:59 INFO - Running setup.py install for mozsystemmonitor 22:58:59 INFO - Successfully installed mozsystemmonitor 22:58:59 INFO - Cleaning up... 22:58:59 INFO - Return code: 0 22:58:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f421cf87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2680630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2711840>, '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 0x267e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267eb60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452576654.220644-845968638', '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:59 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:59 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:59 INFO - Using env: {'DISPLAY': ':0', 22:58:59 INFO - 'HOME': '/home/cltbld', 22:58:59 INFO - 'LANG': 'en_US.UTF-8', 22:58:59 INFO - 'LANGUAGE': 'en_US:en', 22:58:59 INFO - 'LOGNAME': 'cltbld', 22:58:59 INFO - 'MAIL': '/var/mail/cltbld', 22:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:59 INFO - 'MOZ_NO_REMOTE': '1', 22:58:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:59 INFO - 'NO_EM_RESTART': '1', 22:58:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:59 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:59 INFO - 'SHELL': '/bin/bash', 22:58:59 INFO - 'SHLVL': '1', 22:58:59 INFO - 'TERM': 'linux', 22:58:59 INFO - 'TMOUT': '86400', 22:58:59 INFO - 'USER': 'cltbld', 22:58:59 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452576654.220644-845968638', 22:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:59 INFO - '_': '/tools/buildbot/bin/python'} 22:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:59 INFO - Downloading/unpacking blobuploader==1.2.4 22:58:59 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:59 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:59 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:59 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:59 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:59 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 blobuploader-1.2.4.tar.gz 22:59:01 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:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:59:01 INFO - Downloading/unpacking requests==1.2.3. (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 - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:59:01 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:02 INFO - Running setup.py install for docopt 22:59:02 INFO - Successfully installed blobuploader requests docopt 22:59:02 INFO - Cleaning up... 22:59:02 INFO - Return code: 0 22:59:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:02 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 0x7f421cf87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2680630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2711840>, '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 0x267e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267eb60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452576654.220644-845968638', '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:02 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:02 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:02 INFO - Using env: {'DISPLAY': ':0', 22:59:02 INFO - 'HOME': '/home/cltbld', 22:59:02 INFO - 'LANG': 'en_US.UTF-8', 22:59:02 INFO - 'LANGUAGE': 'en_US:en', 22:59:02 INFO - 'LOGNAME': 'cltbld', 22:59:02 INFO - 'MAIL': '/var/mail/cltbld', 22:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:02 INFO - 'MOZ_NO_REMOTE': '1', 22:59:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:02 INFO - 'NO_EM_RESTART': '1', 22:59:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:59:02 INFO - 'PWD': '/builds/slave/test-pgo', 22:59:02 INFO - 'SHELL': '/bin/bash', 22:59:02 INFO - 'SHLVL': '1', 22:59:02 INFO - 'TERM': 'linux', 22:59:02 INFO - 'TMOUT': '86400', 22:59:02 INFO - 'USER': 'cltbld', 22:59:02 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452576654.220644-845968638', 22:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:02 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-8cTHlS-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-UUbELM-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-CCLX7P-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-7b6zTJ-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-vEd7Sy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:59:03 INFO - Running setup.py (path:/tmp/pip-mq3x_8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:59:03 INFO - Running setup.py (path:/tmp/pip-ud6qF1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:59:03 INFO - Running setup.py (path:/tmp/pip-FQjj0a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:59:03 INFO - Running setup.py (path:/tmp/pip-WbG5if-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:59:03 INFO - Running setup.py (path:/tmp/pip-0aoeVj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:59:03 INFO - Running setup.py (path:/tmp/pip-WJeVHP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:59:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:59:03 INFO - Running setup.py (path:/tmp/pip-FGoC1t-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-xY3eGF-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-HLad4O-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-IcYOYM-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-wxlrUJ-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-TE4nde-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:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:59:04 INFO - Running setup.py install for mozcrash 22:59:04 INFO - Running setup.py install for mozdebug 22:59:04 INFO - Running setup.py install for mozdevice 22:59:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:59:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:59:04 INFO - Running setup.py install for mozfile 22:59:04 INFO - Running setup.py install for mozhttpd 22:59:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:59:04 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:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:59:05 INFO - Running setup.py install for mozprocess 22:59:05 INFO - Running setup.py install for mozprofile 22:59:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:59:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:59:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:59:05 INFO - Running setup.py install for mozrunner 22:59:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:59:05 INFO - Running setup.py install for mozscreenshot 22:59:05 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 0x7f421cf87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2680630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2711840>, '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 0x267e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267eb60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452576654.220644-845968638', '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452576654.220644-845968638', 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-BfzjbQ-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-Hh9i8a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:59:06 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:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:59:06 INFO - Running setup.py (path:/tmp/pip-4Sp8xb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:59:06 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:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:59:06 INFO - Running setup.py (path:/tmp/pip-X2mj4A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:59:06 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:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:59:06 INFO - Running setup.py (path:/tmp/pip-6IGwzy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:59:06 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:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:59:06 INFO - Running setup.py (path:/tmp/pip-b9RlDS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:59:06 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:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:59:06 INFO - Running setup.py (path:/tmp/pip-2VbCWi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:59:06 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:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:59:06 INFO - Running setup.py (path:/tmp/pip-ywgPvV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:59:06 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:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:59:06 INFO - Running setup.py (path:/tmp/pip-XXlYwJ-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-Ve6K9a-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-5x6fmF-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-RZQxal-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-4TH8Sw-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-6rS8xf-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-3BPIYL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:59:07 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:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:59:07 INFO - Running setup.py (path:/tmp/pip-9dJ7zJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:59:07 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:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:59:07 INFO - Running setup.py (path:/tmp/pip-JLfJvD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:59:07 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:07 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:07 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:07 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:07 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:07 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:07 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:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22: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:09 INFO - Successfully installed blessings 22:59:09 INFO - Cleaning up... 22:59:09 INFO - Return code: 0 22:59:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:59:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:59:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:59:09 INFO - Reading from file tmpfile_stdout 22:59:09 INFO - Current package versions: 22:59:09 INFO - argparse == 1.2.1 22:59:09 INFO - blessings == 1.5.1 22:59:09 INFO - blobuploader == 1.2.4 22:59:09 INFO - docopt == 0.6.1 22:59:09 INFO - manifestparser == 1.1 22:59:09 INFO - mozInstall == 1.12 22:59:09 INFO - mozcrash == 0.16 22:59:09 INFO - mozdebug == 0.1 22:59:09 INFO - mozdevice == 0.47 22:59:09 INFO - mozfile == 1.2 22:59:09 INFO - mozhttpd == 0.7 22:59:09 INFO - mozinfo == 0.9 22:59:09 INFO - mozleak == 0.1 22:59:09 INFO - mozlog == 3.1 22:59:09 INFO - moznetwork == 0.27 22:59:09 INFO - mozprocess == 0.22 22:59:09 INFO - mozprofile == 0.28 22:59:09 INFO - mozrunner == 6.11 22:59:09 INFO - mozscreenshot == 0.1 22:59:09 INFO - mozsystemmonitor == 0.0 22:59:09 INFO - moztest == 0.7 22:59:09 INFO - mozversion == 1.4 22:59:09 INFO - psutil == 3.1.1 22:59:09 INFO - requests == 1.2.3 22:59:09 INFO - wsgiref == 0.1.2 22:59:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:59:09 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:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:09 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:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:09 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 0x7f421cf87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2680630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2711840>, '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 0x267e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267eb60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452576654.220644-845968638', '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', '-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:09 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: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': 'b5f16d05e5ea93ddf675e67e000001bf-1452576654.220644-845968638', 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 - 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:09 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:09 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:09 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:09 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:09 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:09 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:09 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:09 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:09 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:09 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:09 INFO - Cleaning up... 22:59:09 INFO - Return code: 0 22:59:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:59:09 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:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:09 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:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:09 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 0x7f421cf87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2680630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2711840>, '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 0x267e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267eb60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452576654.220644-845968638', '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452576654.220644-845968638', 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:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:59:11 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:11 INFO - Downloading/unpacking functools32 (from jsonschema) 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: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 0x7f421cf87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2680630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2711840>, '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 0x267e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267eb60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452576654.220644-845968638', '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452576654.220644-845968638', 22:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:11 INFO - '_': '/tools/buildbot/bin/python'} 22:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:12 INFO - Downloading/unpacking flake8 22:59:12 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:12 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:12 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:12 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:12 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:12 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:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:59:14 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:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:59:14 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:14 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:14 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:14 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:14 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:14 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:14 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:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:59:14 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:14 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:14 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:14 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:14 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:14 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:14 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:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package 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 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:15 INFO - Reading from file tmpfile_stdout 22:59:15 INFO - Detecting whether we're running mozinstall >=1.0... 22:59:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:59:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:59:15 INFO - Reading from file tmpfile_stdout 22:59:15 INFO - Output received: 22:59:15 INFO - Usage: mozinstall [options] installer 22:59:15 INFO - Options: 22:59:15 INFO - -h, --help show this help message and exit 22:59:15 INFO - -d DEST, --destination=DEST 22:59:15 INFO - Directory to install application into. [default: 22:59:15 INFO - "/builds/slave/test-pgo"] 22:59:15 INFO - --app=APP Application being installed. [default: firefox] 22:59:15 INFO - mkdir: /builds/slave/test-pgo/build/application 22:59:15 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:15 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:31 INFO - Reading from file tmpfile_stdout 22:59:31 INFO - Output received: 22:59:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:59:31 INFO - Running post-action listener: _resource_record_post_action 22:59:31 INFO - ##### 22:59:31 INFO - ##### Running run-tests step. 22:59:31 INFO - ##### 22:59:31 INFO - Running pre-action listener: _resource_record_pre_action 22:59:31 INFO - Running main action method: run_tests 22:59:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:59:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:59:31 INFO - Python 2.7.3 22:59:31 INFO - Return code: 0 22:59:31 INFO - grabbing minidump binary from tooltool 22:59: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:59:31 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 0x2711840>, '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 0x267e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x267eb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:59:31 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:31 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:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:59:31 INFO - Return code: 0 22:59:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:59:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:59:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:59:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:59:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:59:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:59:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:59:32 INFO - Return code: 0 22:59:32 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-e10s', '--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-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 22:59:32 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-e10s --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-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:59:32 INFO - Using env: {'DISPLAY': ':0', 22:59:32 INFO - 'HOME': '/home/cltbld', 22:59:32 INFO - 'LANG': 'en_US.UTF-8', 22:59:32 INFO - 'LANGUAGE': 'en_US:en', 22:59:32 INFO - 'LOGNAME': 'cltbld', 22:59:32 INFO - 'MAIL': '/var/mail/cltbld', 22:59:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:59:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:32 INFO - 'MOZ_NO_REMOTE': '1', 22:59:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:59:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:32 INFO - 'NO_EM_RESTART': '1', 22:59:32 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:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:59:32 INFO - 'PWD': '/builds/slave/test-pgo', 22:59:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:59:32 INFO - 'SHELL': '/bin/bash', 22:59:32 INFO - 'SHLVL': '1', 22:59:32 INFO - 'TERM': 'linux', 22:59:32 INFO - 'TMOUT': '86400', 22:59:32 INFO - 'USER': 'cltbld', 22:59:32 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452576654.220644-845968638', 22:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:32 INFO - '_': '/tools/buildbot/bin/python'} 22:59:32 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-e10s', '--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-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:59:32 INFO - mozversion application_buildid: 20160111203200 22:59:32 INFO - mozversion application_changeset: d9661fecd939146a14c5c591f395a68e2d75d211 22:59:32 INFO - mozversion application_display_name: Nightly 22:59:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:59:32 INFO - mozversion application_name: Firefox 22:59:32 INFO - mozversion application_remotingname: firefox 22:59:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:59:32 INFO - mozversion application_vendor: Mozilla 22:59:32 INFO - mozversion application_version: 46.0a1 22:59:32 INFO - mozversion platform_buildid: 20160111203200 22:59:32 INFO - mozversion platform_changeset: d9661fecd939146a14c5c591f395a68e2d75d211 22:59:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:59:32 INFO - mozversion platform_version: 46.0a1 22:59:32 INFO - using testdate: 1452581972 22:59:32 INFO - actual date: 1452581972 22:59:32 INFO - starting webserver on 'localhost:36613' 22:59:32 INFO - SUITE-START | Running 3 tests 22:59:32 INFO - TEST-START | dromaeo_css 22:59:32 INFO - operating with platform_type : linux_ 22:59:32 INFO - Initialising browser for dromaeo_css test... 22:59:32 INFO - TEST-INFO | started process 6388 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1bcd3Q/profile http://localhost:36613/getInfo.html) 22:59:36 INFO - PROCESS | 6388 | 22:59:36 INFO - PROCESS | 6388 | (process:6474): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:59:37 INFO - PROCESS | 6388 | __metrics Screen width/height:1600/1200 22:59:37 INFO - PROCESS | 6388 | colorDepth:24 22:59:37 INFO - PROCESS | 6388 | Browser inner width/height: 1024/697 22:59:37 INFO - PROCESS | 6388 | __metrics 22:59:37 INFO - PROCESS | 6388 | 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:38 INFO - TEST-INFO | 6388: exit 0 22:59:38 INFO - Browser initialized. 22:59:38 INFO - Running cycle 1/1 for dromaeo_css test... 22:59:38 INFO - TEST-INFO | started process 6523 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1bcd3Q/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:59:39 INFO - PROCESS | 6523 | 22:59:39 INFO - PROCESS | 6523 | (process:6580): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:59:50 INFO - PROCESS | 6523 | RSS: Main: 149975040 22:59:50 INFO - PROCESS | 6523 | 23:00:39 INFO - PROCESS | 6523 | 1452582039808 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:48 INFO - PROCESS | 6523 | Cycle 1(1): loaded http://localhost:36613/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36613/tests/dromaeo/cssquery-ext.html) 23:02:49 INFO - PROCESS | 6523 | RSS: Main: 156135424 23:02:49 INFO - PROCESS | 6523 | 23:05:51 INFO - PROCESS | 6523 | Cycle 1(1): loaded http://localhost:36613/tests/dromaeo/cssquery-ext.html (next: http://localhost:36613/tests/dromaeo/cssquery-jquery.html) 23:05:51 INFO - PROCESS | 6523 | RSS: Main: 150982656 23:05:51 INFO - PROCESS | 6523 | 23:08:53 INFO - PROCESS | 6523 | Cycle 1(1): loaded http://localhost:36613/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36613/tests/dromaeo/cssquery-mootools.html) 23:08:54 INFO - PROCESS | 6523 | RSS: Main: 151621632 23:08:54 INFO - PROCESS | 6523 | 23:11:55 INFO - PROCESS | 6523 | Cycle 1(1): loaded http://localhost:36613/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36613/tests/dromaeo/cssquery-prototype.html) 23:11:56 INFO - PROCESS | 6523 | RSS: Main: 150962176 23:11:56 INFO - PROCESS | 6523 | 23:14:58 INFO - PROCESS | 6523 | Cycle 1(1): loaded http://localhost:36613/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36613/tests/dromaeo/cssquery-yui.html) 23:14:59 INFO - PROCESS | 6523 | RSS: Main: 150999040 23:14:59 INFO - PROCESS | 6523 | 23:18:01 INFO - PROCESS | 6523 | Cycle 1(1): loaded http://localhost:36613/tests/dromaeo/cssquery-yui.html (next: http://localhost:36613/tests/dromaeo/cssquery-dojo.html) 23:18:02 INFO - PROCESS | 6523 | RSS: Main: 153944064 23:18:02 INFO - PROCESS | 6523 | 23:18:02 INFO - PROCESS | 6523 | __start_tp_report 23:18:02 INFO - PROCESS | 6523 | _x_x_mozilla_page_load 23:18:02 INFO - PROCESS | 6523 | _x_x_mozilla_page_load_details 23:18:02 INFO - PROCESS | 6523 | |i|pagename|runs| 23:18:02 INFO - PROCESS | 6523 | |0;dojo.html;3110.237991692036;3118.391913576853;3145.8427078646077;3166.050184944517;3178.682131786823;5037.420696619881;5132.101882170619;5139.460356662553;5149.098907691153;5202.8179013734525;5070.543651071403;5124.9743751281285;5128.179491281387;5147.459516750743;5187.066328060948;4397.615715138649;4630.259158534644;4898.902021959559;4903.558679718824;4937;4578.633709303248;4827.7586120694;4874.97562512187;4878.902421951559;4879.365682461275;4659.673822832403;4719.150552900476;4754.881127971794;4755.83354582588;4759.8096076156735;4659.953400465985;4664.230401983668;4675.18184317743;4717.174494463489;4731.929021064687;4599.839005634787;4665.930011049837;4678.789454474523;4698.107359601699;4705.270683044134;4923.335349727777;4958.057968985881;4985.775640096204;4993.976234871879;5067.949320506785;5465.808696695636;5482.616216864821;5489.478499542537;5493.038718224295;5534.75093620788;5403.054465468566;5530.225768392428;5533.142362933751;5559.833205003816;5564.554835613141;5138.023775482647;5153.6392452528335;5171.146760784466;5232.947670523284;5251.52736253739;5659.915101273484;5663.207150998864;5686.9715651421475;5696.629719068247;5700.8859822803315;5456.317960254968;5462.426445223274;5466.671999680032;5475.753591088411;5508.44915508454;5426.565874730091;5475.616706830563;5506.531944784658;5529.30883639545;5580.386157522669;5492.203630473559;5550.278463799761;5553.083741182741;5558.999380111619;5560.054790685593;5380.946190538123;5551.583631227674;5564.749586268627;5574.1917421973585;5618.91571626426;4278.058827058042;4278.379634952915;4329.545397733255;4347.804348804311;4376.606105450461;3860.9227815443533;3876.3991581304945;3878.1274213302345;3890.008047947755;3898.3372826619543;4987.1771157759285;5090.261912022736;5219.660722053054;5223.791048358099;5304.655197412233;5525.254090697785;5583.441655834466;5595.720213989365;5636.2954630671165;5689.231953686282;5169.06956747789;5226.555742761831;5226.973865130726;5231.3199284092825;5259.237410575445;4670.229412147026;4700.294955756595;4762.928556071662;4801.567858892717;4802.543758342952;5775.942240577624;5791.739371728282;5818.069108942549;5833.533317334603;5836.387179346192;5571.303587051619;5590.720463976866;5615.18579805934;5638.041532939328;5639.971800140973;5590.385057643737;5620.241267428844;5703.857403564778;5737.139429085671;5839.5036421904615;5466.890662186814;5485.369182544058;5488.807891723771;5490.725463726878;5491.945080549303;5565.471280228372;5567.610267281251;5572.3034620672415;5574.219609254788;5626.043572592751;5283.656562323436;5346.786128554814;5377.758000889891;5475.835724928259;5483.2049352844415;5395.946040539544;5435.402105768441;5441.483059109379;5448.4006759257245;5454.072807622634;5189.948100518946;5341.198820176849;5364.061289274283;5392.083345831296;5414.512693857571;5364.892702145858;5391.838244852661;5482.890342193054;5485.807996720096;5513.8345849624575;5358.46415358461;5367.194920761917;5380.757865895966;5381.677099373894;5382.977234325465 23:18:02 INFO - PROCESS | 6523 | |1;ext.html;511.2152845382338;525.2384043137449;546.1152932249756;546.8660178256326;554.2572952243995;34054.31891362171;34717;34884.651153488456;34891.82554087233;35040;35320.823395883046;35690;35743.10642233946;35846.10384740383;35847.64152358476;8151.266386025257;8265.95867020664;8282.213189746995;8362;8378.245957863792;8174.100848906615;8342.916570834304;8361.456505327134;8403.36974726895;8403.411761176689;8373.49759014461;8479.533625650587;8479.703210387637;8483.915160848404;8492.702755403561;8331.625076871525;8402.915970840275;8413.579321033954;8426.241638252526;8456.534890581015;8306.252437280613;8391.580420978926;8443.577821108982;8450.492970421732;8451.704190353308;34933.475997860056;35660.28679426397;35703;35722.64277357219;35749.82125089384;2981.329200929795;2981.3590078133307;3067.6778938211614;3124.703153200465;3214.517822326646;26800.463990720273;26932.461350773072;27132.728672713416;27879.581806272923;28077.71922280792;3732.7013838893095;3753.1367785409507;3788.507494025759;3927.8232479538487;4053.736507127057;257481;257637;258047;258181;258531.9999999981;49336;49741.00517989692;55556;55902.440975590536;55965.160522592196;52011;52047.21929171065;52168.73915630398;52341;52517.47482525202;13387.933060334635;13440.731185376238;13580.456781728817;13625.454981800814;13627.795583066261;10522.579096836194;10540.525676344583;10601.25791194609;10611.681649550526;10619.628313009007;17983.640327193643;18147.45557633273;18626.34807781748;18682.53293667642;18755.437336879917;6967.407770339477;7113;7139.178994415709;7193.820154496179;7195.100612423447;831.015246932375;849.4308813095241;883.9867401988976;885.4288983605538;964.0937518732369;23078.307650770505;23248.53502929932;23422.99286606837;23483.295501134995;23759.1684291049;981.8154606001732;1008.4100801031332;1014.5586669798661;1017.97455063624;1129.6102844518628;13415.798763018562;13434.731305373838;13597.932010340082;13609.251491167883;13610.455581776618;338130;341876;341983;343238;344650;48384.7580762101;48398.27402588894;48546.27180592294;48611;48668.7566562172;1308.6597484654058;1326.7412854493282;1337.3513845784787;1338.1569611145112;1338.417788262109;24537.263882083567;25224;25735.227943161735;25757.35606609775;25763.484730305663;39345.80327098346;39609.2078158441;40038.79980600078;40619.593804062766;40680;308034;312869;312915;313644;313692;29277.121686349445;29533.85233073821;30647.387052258386;30674.539881901343;30676.84661576678;36263;36614;38687.22625547417;39288.2142357157;40628.59371406248;33118.337633247684;33225.66774332226;33339;33506.66493335035;33905.66094339124;33447.33105337831;34191;35063.47404788981;35518.644813552564;35751.28497429985;34231;34425.827870860485;34900.65099348974;35165.824170880005;35416.29167416689;25814.354641134123;26366.85048806309;29423.705762942955;30726.692733072385;30979.535306969963;23521.882390587936;23786.88106559456;23818.88090559536;23939.401514962265;24137.39656508531 23:18:02 INFO - PROCESS | 6523 | |2;jquery.html;343.57245644347734;345.44383542496576;348.79769733554525;348.91277180704816;354.91659460026904;13560.72878542431;13985.510507132252;16144.757828632566;16563.58591035225;17926.193321300558;13921.93039034806;14165.504207352744;15133.31900064497;15227.695446091098;15264.847351526481;5061.569766569837;5102.1836506159025;5288.180332048539;5292.576593872481;5293.232481290211;4910.607151427895;5121.411037730652;5121.820736274231;5175.094358487249;5175.275461435402;4920.507949205086;5063.544281014708;5066.923996140061;5081.872953176163;5155.61332900034;5335.226392173133;5352.277442545245;5355.437679043722;5386.569074474032;5395.73021348931;5001.674891132065;5158.97420512895;5170.095233334189;5171.836336824222;5173.068847607429;18670.346537871246;18794.718079228824;18852.15165317564;19408;19445.805541944683;1869.6447674941717;1873.8313551780404;1963.2735887721635;2105.589410065038;2255.391044418014;9020.32347573928;9030.277577793826;9657.227421806308;12023.15837891348;12100.939495302468;1663.9251233694513;1703.2505697493064;1737.1140718233667;1743.0587482759295;1765.523308706655;53411.732941335045;54694.906101878136;56347.15479267814;56358;56392;8602.741917742478;8852.822943541094;9155.450672959643;9744.928057913623;9826.115649591571;12037.217580857216;12046;12050.27698338085;12053.698657533632;12063.095267854946;6808.761693340709;6923.896141557881;6933.618650974245;7202.567845929261;7224.060872086595;7062.081929349254;7087.610181439967;7108.289171082851;7131.750388736369;7153.7138514459875;3631.1103779573646;3652.2878038782183;3662.853485860536;3663.9267214655556;3684.115812205105;1536.185821514599;1605.2856478867025;1607.9758803617956;1609.7746315515838;1619.5303362024881;421.8776554799135;451.2464184811373;906.428949761646;913.2739472119681;918.9816203676023;9808.46053467052;10018.398896066114;10381.96180381971;10404.58381664725;10434.843477347846;841.4362377207286;851.9148085191555;908.7818923458323;929.2798081486767;950.325269058962;8655.17775811297;9326.207272381924;9740.074692904305;9854.458004809661;9919.454430006275;395844;405939;502824;503671;509496;42173.367399489034;43067.13865722668;43331.78334108373;72416.275837242;76527.61736191284;1125.4766533561933;1142.5258517715222;1167.1129941244715;1197.6466942252057;1221.450347343699;15213.315400807212;15343.769843452134;15406.614834629225;15461.5311545403;15790.9210453947;33509.99470015903;33949;34169.31661366808;34657.480137798455;35200.647993519735;43074.569254308306;43197.568024320615;44006.779966099966;44106.11787764291;44466;6972.895406569007;7146.3568278855155;7232.855342893007;7306.196318405077;7335.449841262033;10563;10664.253502254767;10707.196960227859;10824.56701731922;10995.945020274847;8506.74479765608;9332.440053596805;9693.321467497208;9783.853242201514;10063.49682515886;6489.772857949949;7237.529560578546;9588;9832.803343933225;10135.391876487434;6929.1684997800585;7286.526375785557;7401.111866576045;7504.549727016397;7620.5808680523105;8556.614952327285;8952.418092824206;8994.595243214202;9277.907220927704;9412.15290623847;9050.728478145666;9295;9372.156505914229;9421.293402994666;9465.242780577399 23:18:02 INFO - PROCESS | 6523 | |3;mootools.html;1267.9429425675844;1273.7325161716042;1317.8813906748396;1550.100941453957;1550.1396724817737;7730.304272615464;7757.495762775416;7898.96050519748;7901;7939.483933544316;7862.292393684582;7888.1323054463965;7936.682532698699;7945.165757595456;7978.720744773934;2301.620232661609;2341.0518739910362;2341.84777989431;2344.4138965258685;2345.718513778349;2367.573836709392;2385.403649087728;2398.556267090594;2402.5675378431874;2405.434722840131;2304.665823455598;2321.1875843454823;2354.587947109249;2368.27767530903;2372.620380739082;2359.4691194481275;2361.4568649210605;2361.8700971446565;2373.2642880707035;2392.2583998960376;2335.497867958397;2363.397333679901;2368.064614477272;2370.4073981504625;2379.1910750344964;7778.144404115543;7800.843983120362;7821.608919554;7822.335101516378;7844.2155784421675;4541.6593755468475;4692.343071969927;4699.318598803188;4724.314974328738;4731.266653668652;3192.6488086310487;3242.7730058895886;3282.2778988622463;3298.191942973963;3307.6196237432764;1070.6252811515985;1083.1984331594563;1084.728817795551;1089.3355053417408;1090.334895713614;10529.473526323653;10601.681949541526;10634.9468252659;10682.305650132794;10685;4072.8778136655355;4146.150039241948;4172.269852775813;4239.236937351307;4273.786310684453;8493.617787199591;8517.829643407222;8526.829463410697;8547.102554231717;8561.785955351166;4497.6851620386915;4501.932471012938;4505.977470112694;4528.935700110472;4530.501644819067;4122.91754164915;4133.9793301033305;4138.772367519755;4160.43834082395;4177.4569305990635;3366.5118557808983;3372;3383.983080084584;3393.474011528217;3399;1052.7420781908481;1057.9894201058046;1067.354250678344;1070.641335152717;1078.9028987391016;952.5046975572664;957.9329446938787;995.4574756757585;1005.5324274212526;1205.2406983600451;6880.071190389333;6967.059446974695;7005.1593808742255;7007.614581197981;7020.403265722369;1097.5116073347283;1112.8213558089485;1115.9497822598003;1134.444122380028;1156.346664134761;5533.1976863354585;5568.916466253009;5589.105743081169;5600.607957443021;5627.099664053813;9237.769055773659;9614.423134611805;9762.560684769202;9788.559514821707;9814.705558833246;9463.38487998278;9542.093501117382;9610;9651.083147101013;9664.420134791935;7325;7560.546367217985;7565.962170189224;7574.356179724675;7585.279398457138;6998.265182156004;7061.823454413475;7064.858702826017;7092.503524753218;7117.181524124792;8409.453385529921;8556.657733690583;8718.215360617321;8747.16901894319;8750.256228220673;8745.562721863755;8822.823543529223;8852.159044890725;8936.151065648754;8945.821083578161;6376.298607153302;6500.707468164039;6529.085927970183;6536.281009089092;6575.967120164369;7362.3741981932135;7432.442566807619;7451.515651482637;7483.550986940801;7510.286522780327;7073.893891591733;7127.429805615642;7152.785416437515;7180.066591343092;7298.744543940937;7007.089078419773;7101.82245443868;7145.21402645719;7149.85700285981;7277.854442911006;7119.786406407608;7149.964250178716;7150.96424517874;7169.0680211574245;7225.494215405081;6172.105044768394;6188.412100850412;6190.783322583688;6191.783287584913;6296.653684047421;6386.297507274103;6431.935680643321;6436.16329877113;6436.935630643634;6438.678066096582 23:18:02 INFO - PROCESS | 6523 | |4;prototype.html;313.1404295209649;319.5286951746175;326.8202488631253;328.62372583392016;328.64670479234826;6186.969065154673;6242.500599952004;6252.687365631723;6268.498520118391;6326.848871383729;6192.225971753531;6206.9068963965465;6212.763405174133;6222.968885155579;6232.3144454110125;4518.847693838066;4667.463241727194;4698.483166851644;4721.2209985352465;4748.90502189956;4643.117807616542;4656.348111264426;4675.859724208279;4681.204195286792;4713.033828065256;4565.748883811389;4610.2854057621125;4619.122366750324;4622.815087396517;4632.305154226876;4606.124836281096;4612.630989520831;4628.282616194495;4640.048789998043;4642.164410406125;3920.353141731611;3962.7424217425773;3977.423273625337;3984.163325701606;4043.9375918281594;5785.27684039495;5818.156367326714;5823.242978412779;5837.620554663933;5887.116932460122;5543.77824887004;5547.1124620061;5555.388907220243;5560.443955604448;5562.3047119110115;6542.182227221598;6551.246606640249;6574.539782215247;6594.07682924391;6603.405693487609;4517.373745451635;4652.976735116336;4654.394928659286;4656.627469802442;4667.766611669403;6853.074834897275;6916.585004899722;6930.826729331807;6935.445164386837;6950.617716025617;4723.716577005391;4767.523247675204;4770.212914869077;4780.808767649325;4788.209945358977;4558.316252562142;4729.574338309569;4794.424669039738;4828.179209534317;4854.101991131652;5477.589180811455;5479.863003424946;5492.148716948879;5512.476314750093;5515.200295957064;6650.73397064112;6693.497987650946;6705.128333316735;6705.396514313735;6709.966450167718;1656.2050215896438;1692.2892385198247;1692.356904376329;1697.3041053168142;1698.388580111159;1092.5029111754134;1097.078454098545;1098.5001824169983;1127.1095834290982;1130.4743294367993;6315.400036996478;6316.084167795644;6319.05214217871;6320.778772742932;6351.04734289851;6839.931600684029;6845.828854278583;6845.931540684629;6865.588064716033;6869.656517174121;6190.102435146879;6327.7028209217;6329.493640508748;6333.1766870306565;6340.651264180515;3727.105494681257;3753.0242137044565;3755.7370984030854;3756.6243375662216;3761.7366784324836;7099.148102227766;7218;7295.781126566211;7297.416206703451;7306.890396644055;6994.860102798018;7023.262557431498;7030.086088808423;7037.437005039687;7051.964740176266;7125;7227.205007449176;7255.600941948138;7259.564426134343;7261.963690181516;6910.20532638753;6912.893936970061;6914.688839002157;6931.722731090902;6939.514234003571;6860.931390686029;6863.176418829772;6863.794086177422;6870.038194652652;6885.001674757233;7118.750843720445;7142.750003750051;7190.96404517974;7247.927520724937;7265.09186351706;4511.977440112779;4545.363649089196;4545.727256364628;4567.451905771329;4567.748773817339;6855.5886646801355;6886.655667216719;6911.3779759821855;6928.064711264116;6965.442764578923;6533.575317604341;6693.598384096969;6695.163104611924;6704.094947182068;6714.429273511806;6641.169853768279;6700.095487109178;6708.83227919306;6719.462443004646;6725.092112564741;6588.571742836701;6596.373344532261;6597.406233439014;6602.372774586406;6603.702833372414;6557.573757705733;6732.3267673232285;6739.292374300628;6755.493337999571;6762.7294908205085;6570.211574611078;6591.143151390289;6592.077109204619;6594.439472644879;6603.20761508622 23:18:02 INFO - PROCESS | 6523 | |5;yui.html;624.6907780648579;686.2554128770284;733.6258508160836;745.0351794426217;825.7935516120973;12891.419886105125;12952.093353465261;13039.543615973444;13111.606651800437;13158.407871645775;12309.076819238548;12448.1908675936;12519.812202816966;12888.871111288909;12893.806592901114;779.7231982646164;783.193310889783;793.6150966781106;793.9245771651713;809.6478032056045;795.598222897436;798.4610387988114;801.2068052627915;801.9478733882308;802.6428239433454;836.4186890111345;840.2018082821344;840.7982084299786;841.4110122913985;841.7643059943196;832.937529685273;833.7040350675544;834.3283656656389;837.8826964225013;838.1116017021976;596.1921596237123;603.1826874584962;603.499095750526;612.10326871134;616.6454288783967;13907.374168162458;13913.860861391358;13949.511767088205;13970.790438143436;14020.158790472604;11445.94277028618;11917.761644767055;11958.820617690655;12640.431180596803;12795.04037197214;9240.95379523098;9507.049295070507;9518.333716639838;9579.042095790435;9603.231741460737;3345.9498107528407;3347.966520334814;3393.983030084834;3395.7962522248745;3477.078574177845;46646;46684.766576166905;47069;47091.64541772898;47359.28961065587;8910.9752378476;8923.464592124494;9137.04061073591;9243.722688319362;9469.47917864524;17106.657866842594;17108.144592770313;17108.74336884948;17165.7425138623;17175.398861040052;6990.266022067712;7047.224805271416;7123.109611298588;7129.215786263507;7297.087864016998;4007.6593489553716;4025.798710064485;4042.555318914917;4049.57479464652;4119.526254480773;2866.498362786504;2891.4506243813607;2891.6819149893495;2906.084583356236;2909.9563506546997;529.6716036057592;540.2760301196415;543.5461389739532;553.9889202215933;556.9081101618187;466.9696469729525;474.99801256061363;481.4102724162942;489.4713709194062;524.7638562646824;8199.631016604268;8381.832363352698;8427.241548260687;9395.953020234992;9453.196478299422;539.8434454008373;569.2883895131087;585.7130006296884;609.3419107364036;625.8466675664491;3840.8847734568008;3882.6311500407414;4104.220198162339;4290.0776333087915;4314.223439780807;55289.1706624401;55787;56048.439515604325;56186;58509;48543.75728121407;48804.755976219894;50156.24765628519;50666.24000639993;50743.999999999265;45343;46044;46126.5387346129;46411.76794116008;46538;8572.442791218551;8631.827363452821;8859.246964007874;8891.558728472268;9003.54982250898;33394.33211335808;33813.323733525685;34113;34370.250379969046;34545.30909381748;41017.17965640611;42348.36477452779;43361.3495797557;45151.77424112859;45453.31820022769;9260.583273752833;9383.859242111237;9918.256130790363;10402.895971040496;10877.51051202682;10476.266661333633;10623.89376106229;10679.19906007037;10703.785924281316;10869.076128528848;9958;10092.405788438009;10138.746531336776;10667.065659210555;10687.679369618612;10176.898231017594;10475.633352832614;10502.107320877505;10591.311564748266;10724.088452481627;9458;10181.440020798631;10401.167906567305;10630.574777008833;10671.51978161;8072.556009419303;8598.833854052746;8744.44913046709;8755.91244087551;9110.31672624569;8365.749027529184;8812.91187088121;9188.908110919072;9275.67535136267;9375.10936461035 23:18:02 INFO - PROCESS | 6523 | __end_tp_report 23:18:02 INFO - PROCESS | 6523 | __start_cc_report 23:18:02 INFO - PROCESS | 6523 | _x_x_mozilla_cycle_collect,341 23:18:02 INFO - PROCESS | 6523 | __end_cc_report 23:18:02 INFO - PROCESS | 6523 | __startTimestamp1452583082145__endTimestamp 23:18:02 INFO - PROCESS | 6523 | 23:18:02 INFO - PROCESS | 6523 | ------- Summary: start ------- 23:18:02 INFO - PROCESS | 6523 | Number of tests: 6 23:18:02 INFO - PROCESS | 6523 | 23:18:02 INFO - PROCESS | 6523 | [#0] dojo.html Cycles:165 Average:5154.73 Median:5367.19 stddev:562.68 (10.5%) stddev-sans-first:541.07 23:18:02 INFO - PROCESS | 6523 | Values: 3110.2 3118.4 3145.8 3166.1 3178.7 5037.4 5132.1 5139.5 5149.1 5202.8 5070.5 5125.0 5128.2 5147.5 5187.1 4397.6 4630.3 4898.9 4903.6 4937.0 4578.6 4827.8 4875.0 4878.9 4879.4 4659.7 4719.2 4754.9 4755.8 4759.8 4660.0 4664.2 4675.2 4717.2 4731.9 4599.8 4665.9 4678.8 4698.1 4705.3 4923.3 4958.1 4985.8 4994.0 5067.9 5465.8 5482.6 5489.5 5493.0 5534.8 5403.1 5530.2 5533.1 5559.8 5564.6 5138.0 5153.6 5171.1 5232.9 5251.5 5659.9 5663.2 5687.0 5696.6 5700.9 5456.3 5462.4 5466.7 5475.8 5508.4 5426.6 5475.6 5506.5 5529.3 5580.4 5492.2 5550.3 5553.1 5559.0 5560.1 5380.9 5551.6 5564.7 5574.2 5618.9 4278.1 4278.4 4329.5 4347.8 4376.6 3860.9 3876.4 3878.1 3890.0 3898.3 4987.2 5090.3 5219.7 5223.8 5304.7 5525.3 5583.4 5595.7 5636.3 5689.2 5169.1 5226.6 5227.0 5231.3 5259.2 4670.2 4700.3 4762.9 4801.6 4802.5 5775.9 5791.7 5818.1 5833.5 5836.4 5571.3 5590.7 5615.2 5638.0 5640.0 5590.4 5620.2 5703.9 5737.1 5839.5 5466.9 5485.4 5488.8 5490.7 5491.9 5565.5 5567.6 5572.3 5574.2 5626.0 5283.7 5346.8 5377.8 5475.8 5483.2 5395.9 5435.4 5441.5 5448.4 5454.1 5189.9 5341.2 5364.1 5392.1 5414.5 5364.9 5391.8 5482.9 5485.8 5513.8 5358.5 5367.2 5380.8 5381.7 5383.0 23:18:02 INFO - PROCESS | 6523 | 23:18:02 INFO - PROCESS | 6523 | [#1] ext.html Cycles:180 Average:45228.40 Median:34888.24 stddev:80351.90 (230.3%) stddev-sans-first:80507.17 23:18:02 INFO - PROCESS | 6523 | Values: 511.2 525.2 546.1 546.9 554.3 34054.3 34717.0 34884.7 34891.8 35040.0 35320.8 35690.0 35743.1 35846.1 35847.6 8151.3 8266.0 8282.2 8362.0 8378.2 8174.1 8342.9 8361.5 8403.4 8403.4 8373.5 8479.5 8479.7 8483.9 8492.7 8331.6 8402.9 8413.6 8426.2 8456.5 8306.3 8391.6 8443.6 8450.5 8451.7 34933.5 35660.3 35703.0 35722.6 35749.8 2981.3 2981.4 3067.7 3124.7 3214.5 26800.5 26932.5 27132.7 27879.6 28077.7 3732.7 3753.1 3788.5 3927.8 4053.7 257481.0 257637.0 258047.0 258181.0 258532.0 49336.0 49741.0 55556.0 55902.4 55965.2 52011.0 52047.2 52168.7 52341.0 52517.5 13387.9 13440.7 13580.5 13625.5 13627.8 10522.6 10540.5 10601.3 10611.7 10619.6 17983.6 18147.5 18626.3 18682.5 18755.4 6967.4 7113.0 7139.2 7193.8 7195.1 831.0 849.4 884.0 885.4 964.1 23078.3 23248.5 23423.0 23483.3 23759.2 981.8 1008.4 1014.6 1018.0 1129.6 13415.8 13434.7 13597.9 13609.3 13610.5 338130.0 341876.0 341983.0 343238.0 344650.0 48384.8 48398.3 48546.3 48611.0 48668.8 1308.7 1326.7 1337.4 1338.2 1338.4 24537.3 25224.0 25735.2 25757.4 25763.5 39345.8 39609.2 40038.8 40619.6 40680.0 308034.0 312869.0 312915.0 313644.0 313692.0 29277.1 29533.9 30647.4 30674.5 30676.8 36263.0 36614.0 38687.2 39288.2 40628.6 33118.3 33225.7 33339.0 33506.7 33905.7 33447.3 34191.0 35063.5 35518.6 35751.3 34231.0 34425.8 34900.7 35165.8 35416.3 25814.4 26366.9 29423.7 30726.7 30979.5 23521.9 23786.9 23818.9 23939.4 24137.4 23:18:02 INFO - PROCESS | 6523 | 23:18:02 INFO - PROCESS | 6523 | [#2] jquery.html Cycles:180 Average:24519.35 Median:5062.56 stddev:76183.61 (1504.8%) stddev-sans-first:76375.69 23:18:02 INFO - PROCESS | 6523 | Values: 343.6 345.4 348.8 348.9 354.9 13560.7 13985.5 16144.8 16563.6 17926.2 13921.9 14165.5 15133.3 15227.7 15264.8 5061.6 5102.2 5288.2 5292.6 5293.2 4910.6 5121.4 5121.8 5175.1 5175.3 4920.5 5063.5 5066.9 5081.9 5155.6 5335.2 5352.3 5355.4 5386.6 5395.7 5001.7 5159.0 5170.1 5171.8 5173.1 18670.3 18794.7 18852.2 19408.0 19445.8 1869.6 1873.8 1963.3 2105.6 2255.4 9020.3 9030.3 9657.2 12023.2 12100.9 1663.9 1703.3 1737.1 1743.1 1765.5 53411.7 54694.9 56347.2 56358.0 56392.0 8602.7 8852.8 9155.5 9744.9 9826.1 12037.2 12046.0 12050.3 12053.7 12063.1 6808.8 6923.9 6933.6 7202.6 7224.1 7062.1 7087.6 7108.3 7131.8 7153.7 3631.1 3652.3 3662.9 3663.9 3684.1 1536.2 1605.3 1608.0 1609.8 1619.5 421.9 451.2 906.4 913.3 919.0 9808.5 10018.4 10382.0 10404.6 10434.8 841.4 851.9 908.8 929.3 950.3 8655.2 9326.2 9740.1 9854.5 9919.5 395844.0 405939.0 502824.0 503671.0 509496.0 42173.4 43067.1 43331.8 72416.3 76527.6 1125.5 1142.5 1167.1 1197.6 1221.5 15213.3 15343.8 15406.6 15461.5 15790.9 33510.0 33949.0 34169.3 34657.5 35200.6 43074.6 43197.6 44006.8 44106.1 44466.0 6972.9 7146.4 7232.9 7306.2 7335.4 10563.0 10664.3 10707.2 10824.6 10995.9 8506.7 9332.4 9693.3 9783.9 10063.5 6489.8 7237.5 9588.0 9832.8 10135.4 6929.2 7286.5 7401.1 7504.5 7620.6 8556.6 8952.4 8994.6 9277.9 9412.2 9050.7 9295.0 9372.2 9421.3 9465.2 23:18:02 INFO - PROCESS | 6523 | 23:18:02 INFO - PROCESS | 6523 | [#3] mootools.html Cycles:180 Average:5453.40 Median:6244.22 stddev:2844.15 (45.5%) stddev-sans-first:2834.72 23:18:02 INFO - PROCESS | 6523 | Values: 1267.9 1273.7 1317.9 1550.1 1550.1 7730.3 7757.5 7899.0 7901.0 7939.5 7862.3 7888.1 7936.7 7945.2 7978.7 2301.6 2341.1 2341.8 2344.4 2345.7 2367.6 2385.4 2398.6 2402.6 2405.4 2304.7 2321.2 2354.6 2368.3 2372.6 2359.5 2361.5 2361.9 2373.3 2392.3 2335.5 2363.4 2368.1 2370.4 2379.2 7778.1 7800.8 7821.6 7822.3 7844.2 4541.7 4692.3 4699.3 4724.3 4731.3 3192.6 3242.8 3282.3 3298.2 3307.6 1070.6 1083.2 1084.7 1089.3 1090.3 10529.5 10601.7 10634.9 10682.3 10685.0 4072.9 4146.2 4172.3 4239.2 4273.8 8493.6 8517.8 8526.8 8547.1 8561.8 4497.7 4501.9 4506.0 4528.9 4530.5 4122.9 4134.0 4138.8 4160.4 4177.5 3366.5 3372.0 3384.0 3393.5 3399.0 1052.7 1058.0 1067.4 1070.6 1078.9 952.5 957.9 995.5 1005.5 1205.2 6880.1 6967.1 7005.2 7007.6 7020.4 1097.5 1112.8 1115.9 1134.4 1156.3 5533.2 5568.9 5589.1 5600.6 5627.1 9237.8 9614.4 9762.6 9788.6 9814.7 9463.4 9542.1 9610.0 9651.1 9664.4 7325.0 7560.5 7566.0 7574.4 7585.3 6998.3 7061.8 7064.9 7092.5 7117.2 8409.5 8556.7 8718.2 8747.2 8750.3 8745.6 8822.8 8852.2 8936.2 8945.8 6376.3 6500.7 6529.1 6536.3 6576.0 7362.4 7432.4 7451.5 7483.6 7510.3 7073.9 7127.4 7152.8 7180.1 7298.7 7007.1 7101.8 7145.2 7149.9 7277.9 7119.8 7150.0 7151.0 7169.1 7225.5 6172.1 6188.4 6190.8 6191.8 6296.7 6386.3 6431.9 6436.2 6436.9 6438.7 23:18:02 INFO - PROCESS | 6523 | 23:18:02 INFO - PROCESS | 6523 | [#4] prototype.html Cycles:180 Average:5549.83 Median:6315.74 stddev:1707.20 (27.0%) stddev-sans-first:1666.12 23:18:02 INFO - PROCESS | 6523 | Values: 313.1 319.5 326.8 328.6 328.6 6187.0 6242.5 6252.7 6268.5 6326.8 6192.2 6206.9 6212.8 6223.0 6232.3 4518.8 4667.5 4698.5 4721.2 4748.9 4643.1 4656.3 4675.9 4681.2 4713.0 4565.7 4610.3 4619.1 4622.8 4632.3 4606.1 4612.6 4628.3 4640.0 4642.2 3920.4 3962.7 3977.4 3984.2 4043.9 5785.3 5818.2 5823.2 5837.6 5887.1 5543.8 5547.1 5555.4 5560.4 5562.3 6542.2 6551.2 6574.5 6594.1 6603.4 4517.4 4653.0 4654.4 4656.6 4667.8 6853.1 6916.6 6930.8 6935.4 6950.6 4723.7 4767.5 4770.2 4780.8 4788.2 4558.3 4729.6 4794.4 4828.2 4854.1 5477.6 5479.9 5492.1 5512.5 5515.2 6650.7 6693.5 6705.1 6705.4 6710.0 1656.2 1692.3 1692.4 1697.3 1698.4 1092.5 1097.1 1098.5 1127.1 1130.5 6315.4 6316.1 6319.1 6320.8 6351.0 6839.9 6845.8 6845.9 6865.6 6869.7 6190.1 6327.7 6329.5 6333.2 6340.7 3727.1 3753.0 3755.7 3756.6 3761.7 7099.1 7218.0 7295.8 7297.4 7306.9 6994.9 7023.3 7030.1 7037.4 7052.0 7125.0 7227.2 7255.6 7259.6 7262.0 6910.2 6912.9 6914.7 6931.7 6939.5 6860.9 6863.2 6863.8 6870.0 6885.0 7118.8 7142.8 7191.0 7247.9 7265.1 4512.0 4545.4 4545.7 4567.5 4567.7 6855.6 6886.7 6911.4 6928.1 6965.4 6533.6 6693.6 6695.2 6704.1 6714.4 6641.2 6700.1 6708.8 6719.5 6725.1 6588.6 6596.4 6597.4 6602.4 6603.7 6557.6 6732.3 6739.3 6755.5 6762.7 6570.2 6591.1 6592.1 6594.4 6603.2 23:18:02 INFO - PROCESS | 6523 | 23:18:02 INFO - PROCESS | 6523 | [#5] yui.html Cycles:180 Average:13303.24 Median:25322.86 stddev:15644.49 (61.8%) stddev-sans-first:15659.40 23:18:02 INFO - PROCESS | 6523 | Values: 624.7 686.3 733.6 745.0 825.8 12891.4 12952.1 13039.5 13111.6 13158.4 12309.1 12448.2 12519.8 12888.9 12893.8 779.7 783.2 793.6 793.9 809.6 795.6 798.5 801.2 801.9 802.6 836.4 840.2 840.8 841.4 841.8 832.9 833.7 834.3 837.9 838.1 596.2 603.2 603.5 612.1 616.6 13907.4 13913.9 13949.5 13970.8 14020.2 11445.9 11917.8 11958.8 12640.4 12795.0 9241.0 9507.0 9518.3 9579.0 9603.2 3345.9 3348.0 3394.0 3395.8 3477.1 46646.0 46684.8 47069.0 47091.6 47359.3 8911.0 8923.5 9137.0 9243.7 9469.5 17106.7 17108.1 17108.7 17165.7 17175.4 6990.3 7047.2 7123.1 7129.2 7297.1 4007.7 4025.8 4042.6 4049.6 4119.5 2866.5 2891.5 2891.7 2906.1 2910.0 529.7 540.3 543.5 554.0 556.9 467.0 475.0 481.4 489.5 524.8 8199.6 8381.8 8427.2 9396.0 9453.2 539.8 569.3 585.7 609.3 625.8 3840.9 3882.6 4104.2 4290.1 4314.2 55289.2 55787.0 56048.4 56186.0 58509.0 48543.8 48804.8 50156.2 50666.2 50744.0 45343.0 46044.0 46126.5 46411.8 46538.0 8572.4 8631.8 8859.2 8891.6 9003.5 33394.3 33813.3 34113.0 34370.3 34545.3 41017.2 42348.4 43361.3 45151.8 45453.3 9260.6 9383.9 9918.3 10402.9 10877.5 10476.3 10623.9 10679.2 10703.8 10869.1 9958.0 10092.4 10138.7 10667.1 10687.7 10176.9 10475.6 10502.1 10591.3 10724.1 9458.0 10181.4 10401.2 10630.6 10671.5 8072.6 8598.8 8744.4 8755.9 9110.3 8365.7 8812.9 9188.9 9275.7 9375.1 23:18:02 INFO - PROCESS | 6523 | -------- Summary: end -------- 23:18:02 INFO - PROCESS | 6523 | 23:18:02 INFO - TEST-INFO | 6523: exit 0 23:18:02 INFO - TEST-OK | dromaeo_css | took 1110320ms 23:18:02 INFO - TEST-START | kraken 23:18:02 INFO - operating with platform_type : linux_ 23:18:02 INFO - Initialising browser for kraken test... 23:18:02 INFO - TEST-INFO | started process 6765 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpk0lnZP/profile http://localhost:36613/getInfo.html) 23:18:06 INFO - PROCESS | 6765 | 23:18:06 INFO - PROCESS | 6765 | (process:6841): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:18:07 INFO - PROCESS | 6765 | __metrics Screen width/height:1600/1200 23:18:07 INFO - PROCESS | 6765 | colorDepth:24 23:18:07 INFO - PROCESS | 6765 | Browser inner width/height: 1024/697 23:18:07 INFO - PROCESS | 6765 | __metrics 23:18:07 INFO - PROCESS | 6765 | 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:08 INFO - TEST-INFO | 6765: exit 0 23:18:08 INFO - Browser initialized. 23:18:08 INFO - Running cycle 1/1 for kraken test... 23:18:08 INFO - TEST-INFO | started process 6890 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpk0lnZP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:18:09 INFO - PROCESS | 6890 | 23:18:09 INFO - PROCESS | 6890 | (process:6948): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:18:20 INFO - PROCESS | 6890 | RSS: Main: 150687744 23:18:20 INFO - PROCESS | 6890 | 23:18:22 INFO - PROCESS | 6890 | Cycle 1(1): loaded http://localhost:36613/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36613/tests/kraken/driver.html?testName=audio-beat-detection) 23:18:23 INFO - PROCESS | 6890 | RSS: Main: 151605248 23:18:23 INFO - PROCESS | 6890 | 23:18:25 INFO - PROCESS | 6890 | Cycle 1(1): loaded http://localhost:36613/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36613/tests/kraken/driver.html?testName=audio-dft) 23:18:26 INFO - PROCESS | 6890 | RSS: Main: 151560192 23:18:26 INFO - PROCESS | 6890 | 23:18:29 INFO - PROCESS | 6890 | Cycle 1(1): loaded http://localhost:36613/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36613/tests/kraken/driver.html?testName=audio-fft) 23:18:30 INFO - PROCESS | 6890 | RSS: Main: 147005440 23:18:30 INFO - PROCESS | 6890 | 23:18:32 INFO - PROCESS | 6890 | Cycle 1(1): loaded http://localhost:36613/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36613/tests/kraken/driver.html?testName=audio-oscillator) 23:18:32 INFO - PROCESS | 6890 | RSS: Main: 146141184 23:18:32 INFO - PROCESS | 6890 | 23:18:34 INFO - PROCESS | 6890 | Cycle 1(1): loaded http://localhost:36613/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36613/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:18:35 INFO - PROCESS | 6890 | RSS: Main: 147165184 23:18:35 INFO - PROCESS | 6890 | 23:18:38 INFO - PROCESS | 6890 | Cycle 1(1): loaded http://localhost:36613/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36613/tests/kraken/driver.html?testName=imaging-darkroom) 23:18:38 INFO - PROCESS | 6890 | RSS: Main: 148111360 23:18:38 INFO - PROCESS | 6890 | 23:18:42 INFO - PROCESS | 6890 | Cycle 1(1): loaded http://localhost:36613/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36613/tests/kraken/driver.html?testName=imaging-desaturate) 23:18:42 INFO - PROCESS | 6890 | RSS: Main: 147070976 23:18:42 INFO - PROCESS | 6890 | 23:18:45 INFO - PROCESS | 6890 | Cycle 1(1): loaded http://localhost:36613/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36613/tests/kraken/driver.html?testName=json-parse-financial) 23:18:46 INFO - PROCESS | 6890 | RSS: Main: 148131840 23:18:46 INFO - PROCESS | 6890 | 23:18:47 INFO - PROCESS | 6890 | Cycle 1(1): loaded http://localhost:36613/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36613/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:18:48 INFO - PROCESS | 6890 | RSS: Main: 148058112 23:18:48 INFO - PROCESS | 6890 | 23:18:50 INFO - PROCESS | 6890 | Cycle 1(1): loaded http://localhost:36613/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36613/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:18:50 INFO - PROCESS | 6890 | RSS: Main: 147877888 23:18:50 INFO - PROCESS | 6890 | 23:18:53 INFO - PROCESS | 6890 | Cycle 1(1): loaded http://localhost:36613/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36613/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:18:53 INFO - PROCESS | 6890 | RSS: Main: 149757952 23:18:53 INFO - PROCESS | 6890 | 23:18:56 INFO - PROCESS | 6890 | Cycle 1(1): loaded http://localhost:36613/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36613/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:18:56 INFO - PROCESS | 6890 | RSS: Main: 148688896 23:18:56 INFO - PROCESS | 6890 | 23:18:59 INFO - PROCESS | 6890 | Cycle 1(1): loaded http://localhost:36613/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36613/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:18:59 INFO - PROCESS | 6890 | RSS: Main: 149180416 23:18:59 INFO - PROCESS | 6890 | 23:19:01 INFO - PROCESS | 6890 | Cycle 1(1): loaded http://localhost:36613/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36613/tests/kraken/driver.html?testName=ai-astar) 23:19:01 INFO - PROCESS | 6890 | RSS: Main: 149942272 23:19:01 INFO - PROCESS | 6890 | 23:19:01 INFO - PROCESS | 6890 | __start_tp_report 23:19:01 INFO - PROCESS | 6890 | _x_x_mozilla_page_load 23:19:01 INFO - PROCESS | 6890 | _x_x_mozilla_page_load_details 23:19:01 INFO - PROCESS | 6890 | |i|pagename|runs| 23:19:01 INFO - PROCESS | 6890 | |0;ai-astar;111;106;111;111;110;123;112;110;113;113 23:19:01 INFO - PROCESS | 6890 | |1;audio-beat-detection;155;127;153;165;127;150;149;125;165;126 23:19:01 INFO - PROCESS | 6890 | |2;audio-dft;163;161;162;162;161;162;161;165;168;162 23:19:01 INFO - PROCESS | 6890 | |3;audio-fft;76;76;75;73;71;73;133;75;71;71 23:19:01 INFO - PROCESS | 6890 | |4;audio-oscillator;98;97;139;97;97;97;138;96;97;136 23:19:01 INFO - PROCESS | 6890 | |5;imaging-gaussian-blur;110;111;110;109;109;110;110;109;110;110 23:19:01 INFO - PROCESS | 6890 | |6;imaging-darkroom;147;148;147;147;146;147;145;146;146;147 23:19:01 INFO - PROCESS | 6890 | |7;imaging-desaturate;96;97;96;96;95;98;96;96;96;97 23:19:01 INFO - PROCESS | 6890 | |8;json-parse-financial;57;57;57;56;57;57;58;57;61;56 23:19:01 INFO - PROCESS | 6890 | |9;json-stringify-tinderbox;67;68;67;68;68;70;68;67;68;68 23:19:01 INFO - PROCESS | 6890 | |10;stanford-crypto-aes;87;89;88;89;87;89;96;88;96;96 23:19:01 INFO - PROCESS | 6890 | |11;stanford-crypto-ccm;120;126;117;123;121;121;119;123;134;132 23:19:01 INFO - PROCESS | 6890 | |12;stanford-crypto-pbkdf2;143;156;155;152;155;139;155;153;142;141 23:19:01 INFO - PROCESS | 6890 | |13;stanford-crypto-sha256-iterative;67;71;69;69;69;70;68;68;70;68 23:19:01 INFO - PROCESS | 6890 | __end_tp_report 23:19:01 INFO - PROCESS | 6890 | __start_cc_report 23:19:01 INFO - PROCESS | 6890 | _x_x_mozilla_cycle_collect,743 23:19:01 INFO - PROCESS | 6890 | __end_cc_report 23:19:01 INFO - PROCESS | 6890 | __startTimestamp1452583141816__endTimestamp 23:19:01 INFO - PROCESS | 6890 | 23:19:01 INFO - PROCESS | 6890 | ------- Summary: start ------- 23:19:01 INFO - PROCESS | 6890 | Number of tests: 14 23:19:01 INFO - PROCESS | 6890 | 23:19:01 INFO - PROCESS | 6890 | [#0] ai-astar Cycles:10 Average:112.00 Median:111.50 stddev:4.35 (3.9%) stddev-sans-first:4.59 23:19:01 INFO - PROCESS | 6890 | Values: 111.0 106.0 111.0 111.0 110.0 123.0 112.0 110.0 113.0 113.0 23:19:01 INFO - PROCESS | 6890 | 23:19:01 INFO - PROCESS | 6890 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:151.50 stddev:16.36 (10.8%) stddev-sans-first:16.87 23:19:01 INFO - PROCESS | 6890 | Values: 155.0 127.0 153.0 165.0 127.0 150.0 149.0 125.0 165.0 126.0 23:19:01 INFO - PROCESS | 6890 | 23:19:01 INFO - PROCESS | 6890 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.00 stddev:2.21 (1.4%) stddev-sans-first:2.35 23:19:01 INFO - PROCESS | 6890 | Values: 163.0 161.0 162.0 162.0 161.0 162.0 161.0 165.0 168.0 162.0 23:19:01 INFO - PROCESS | 6890 | 23:19:01 INFO - PROCESS | 6890 | [#3] audio-fft Cycles:10 Average:79.40 Median:74.00 stddev:18.94 (25.6%) stddev-sans-first:20.05 23:19:01 INFO - PROCESS | 6890 | Values: 76.0 76.0 75.0 73.0 71.0 73.0 133.0 75.0 71.0 71.0 23:19:01 INFO - PROCESS | 6890 | 23:19:01 INFO - PROCESS | 6890 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:97.00 stddev:19.66 (20.3%) stddev-sans-first:20.43 23:19:01 INFO - PROCESS | 6890 | Values: 98.0 97.0 139.0 97.0 97.0 97.0 138.0 96.0 97.0 136.0 23:19:01 INFO - PROCESS | 6890 | 23:19:01 INFO - PROCESS | 6890 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 23:19:01 INFO - PROCESS | 6890 | Values: 110.0 111.0 110.0 109.0 109.0 110.0 110.0 109.0 110.0 110.0 23:19:01 INFO - PROCESS | 6890 | 23:19:01 INFO - PROCESS | 6890 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.84 (0.6%) stddev-sans-first:0.88 23:19:01 INFO - PROCESS | 6890 | Values: 147.0 148.0 147.0 147.0 146.0 147.0 145.0 146.0 146.0 147.0 23:19:01 INFO - PROCESS | 6890 | 23:19:01 INFO - PROCESS | 6890 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 23:19:01 INFO - PROCESS | 6890 | Values: 96.0 97.0 96.0 96.0 95.0 98.0 96.0 96.0 96.0 97.0 23:19:01 INFO - PROCESS | 6890 | 23:19:01 INFO - PROCESS | 6890 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.00 stddev:1.42 (2.5%) stddev-sans-first:1.50 23:19:01 INFO - PROCESS | 6890 | Values: 57.0 57.0 57.0 56.0 57.0 57.0 58.0 57.0 61.0 56.0 23:19:01 INFO - PROCESS | 6890 | 23:19:01 INFO - PROCESS | 6890 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 23:19:01 INFO - PROCESS | 6890 | Values: 67.0 68.0 67.0 68.0 68.0 70.0 68.0 67.0 68.0 68.0 23:19:01 INFO - PROCESS | 6890 | 23:19:01 INFO - PROCESS | 6890 | [#10] stanford-crypto-aes Cycles:10 Average:90.50 Median:89.00 stddev:3.87 (4.3%) stddev-sans-first:3.89 23:19:01 INFO - PROCESS | 6890 | Values: 87.0 89.0 88.0 89.0 87.0 89.0 96.0 88.0 96.0 96.0 23:19:01 INFO - PROCESS | 6890 | 23:19:01 INFO - PROCESS | 6890 | [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:123.00 stddev:5.54 (4.5%) stddev-sans-first:5.72 23:19:01 INFO - PROCESS | 6890 | Values: 120.0 126.0 117.0 123.0 121.0 121.0 119.0 123.0 134.0 132.0 23:19:01 INFO - PROCESS | 6890 | 23:19:01 INFO - PROCESS | 6890 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.10 Median:154.00 stddev:6.92 (4.5%) stddev-sans-first:6.98 23:19:01 INFO - PROCESS | 6890 | Values: 143.0 156.0 155.0 152.0 155.0 139.0 155.0 153.0 142.0 141.0 23:19:01 INFO - PROCESS | 6890 | 23:19:01 INFO - PROCESS | 6890 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.20 (1.7%) stddev-sans-first:1.05 23:19:01 INFO - PROCESS | 6890 | Values: 67.0 71.0 69.0 69.0 69.0 70.0 68.0 68.0 70.0 68.0 23:19:01 INFO - PROCESS | 6890 | -------- Summary: end -------- 23:19:01 INFO - PROCESS | 6890 | 23:19:02 INFO - TEST-INFO | 6890: exit 0 23:19:02 INFO - TEST-OK | kraken | took 60109ms 23:19:02 INFO - TEST-START | v8_7 23:19:02 INFO - operating with platform_type : linux_ 23:19:02 INFO - Initialising browser for v8_7 test... 23:19:02 INFO - TEST-INFO | started process 7176 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCEjkR9/profile http://localhost:36613/getInfo.html) 23:19:06 INFO - PROCESS | 7176 | 23:19:06 INFO - PROCESS | 7176 | (process:7249): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:19:07 INFO - PROCESS | 7176 | __metrics Screen width/height:1600/1200 23:19:07 INFO - PROCESS | 7176 | colorDepth:24 23:19:07 INFO - PROCESS | 7176 | Browser inner width/height: 1024/697 23:19:07 INFO - PROCESS | 7176 | __metrics 23:19:07 INFO - PROCESS | 7176 | 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:08 INFO - TEST-INFO | 7176: exit 0 23:19:08 INFO - Browser initialized. 23:19:08 INFO - Running cycle 1/1 for v8_7 test... 23:19:08 INFO - TEST-INFO | started process 7298 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCEjkR9/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:10 INFO - PROCESS | 7298 | 23:19:10 INFO - PROCESS | 7298 | (process:7359): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:19:20 INFO - PROCESS | 7298 | RSS: Main: 150802432 23:19:20 INFO - PROCESS | 7298 | 23:19:42 INFO - PROCESS | 7298 | Cycle 1(1): loaded http://localhost:36613/tests/v8_7/run.html (next: http://localhost:36613/tests/v8_7/run.html) 23:19:43 INFO - PROCESS | 7298 | RSS: Main: 146132992 23:19:43 INFO - PROCESS | 7298 | 23:19:43 INFO - PROCESS | 7298 | __start_tp_report 23:19:43 INFO - PROCESS | 7298 | _x_x_mozilla_page_load 23:19:43 INFO - PROCESS | 7298 | _x_x_mozilla_page_load_details 23:19:43 INFO - PROCESS | 7298 | |i|pagename|runs| 23:19:43 INFO - PROCESS | 7298 | |0;Richards;167.5603217158177 23:19:43 INFO - PROCESS | 7298 | |1;DeltaBlue;190.5487804878049 23:19:43 INFO - PROCESS | 7298 | |2;Encrypt;280.662363177098 23:19:43 INFO - PROCESS | 7298 | |3;Decrypt;5208.333333333333 23:19:43 INFO - PROCESS | 7298 | |4;RayTrace;1060.4453870625662 23:19:43 INFO - PROCESS | 7298 | |5;Earley;729.3946024799417 23:19:43 INFO - PROCESS | 7298 | |6;Boyer;12219.512195121952 23:19:43 INFO - PROCESS | 7298 | |7;RegExp;41040 23:19:43 INFO - PROCESS | 7298 | |8;Splay;585.1375073142189 23:19:43 INFO - PROCESS | 7298 | |9;NavierStokes;4830.917874396136 23:19:43 INFO - PROCESS | 7298 | __end_tp_report 23:19:43 INFO - PROCESS | 7298 | __startTimestamp1452583183225__endTimestamp 23:19:43 INFO - PROCESS | 7298 | 23:19:43 INFO - PROCESS | 7298 | ------- Summary: start ------- 23:19:43 INFO - PROCESS | 7298 | Number of tests: 10 23:19:43 INFO - PROCESS | 7298 | 23:19:43 INFO - PROCESS | 7298 | [#0] Richards Cycles:1 Average:167.56 Median:167.56 stddev:0.00 (0.0%) 23:19:43 INFO - PROCESS | 7298 | Values: 167.6 23:19:43 INFO - PROCESS | 7298 | 23:19:43 INFO - PROCESS | 7298 | [#1] DeltaBlue Cycles:1 Average:190.55 Median:190.55 stddev:0.00 (0.0%) 23:19:43 INFO - PROCESS | 7298 | Values: 190.5 23:19:43 INFO - PROCESS | 7298 | 23:19:43 INFO - PROCESS | 7298 | [#2] Encrypt Cycles:1 Average:280.66 Median:280.66 stddev:0.00 (0.0%) 23:19:43 INFO - PROCESS | 7298 | Values: 280.7 23:19:43 INFO - PROCESS | 7298 | 23:19:43 INFO - PROCESS | 7298 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 23:19:43 INFO - PROCESS | 7298 | Values: 5208.3 23:19:43 INFO - PROCESS | 7298 | 23:19:43 INFO - PROCESS | 7298 | [#4] RayTrace Cycles:1 Average:1060.45 Median:1060.45 stddev:0.00 (0.0%) 23:19:43 INFO - PROCESS | 7298 | Values: 1060.4 23:19:43 INFO - PROCESS | 7298 | 23:19:43 INFO - PROCESS | 7298 | [#5] Earley Cycles:1 Average:729.39 Median:729.39 stddev:0.00 (0.0%) 23:19:43 INFO - PROCESS | 7298 | Values: 729.4 23:19:43 INFO - PROCESS | 7298 | 23:19:43 INFO - PROCESS | 7298 | [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 23:19:43 INFO - PROCESS | 7298 | Values: 12219.5 23:19:43 INFO - PROCESS | 7298 | 23:19:43 INFO - PROCESS | 7298 | [#7] RegExp Cycles:1 Average:41040.00 Median:41040.00 stddev:0.00 (0.0%) 23:19:43 INFO - PROCESS | 7298 | Values: 41040.0 23:19:43 INFO - PROCESS | 7298 | 23:19:43 INFO - PROCESS | 7298 | [#8] Splay Cycles:1 Average:585.14 Median:585.14 stddev:0.00 (0.0%) 23:19:43 INFO - PROCESS | 7298 | Values: 585.1 23:19:43 INFO - PROCESS | 7298 | 23:19:43 INFO - PROCESS | 7298 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 23:19:43 INFO - PROCESS | 7298 | Values: 4830.9 23:19:43 INFO - PROCESS | 7298 | -------- Summary: end -------- 23:19:43 INFO - PROCESS | 7298 | 23:19:44 INFO - TEST-INFO | 7298: exit 0 23:19:44 INFO - TEST-OK | v8_7 | took 41182ms 23:19:44 INFO - SUITE-END | took 1211s 23:19:44 INFO - Completed test suite (00:20:11) 23:19:44 INFO - Working with test: dromaeo_css 23:19:44 INFO - Generating results file: dromaeo_css 23:19:44 INFO - Working with test: kraken 23:19:44 INFO - Generating results file: kraken 23:19:44 INFO - javascript benchmark 23:19:44 INFO - Working with test: v8_7 23:19:44 INFO - Generating results file: v8_7 23:19:44 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:19:44 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 23:19:44 INFO - process_Request line: dromaeo_css 6688.13 graph.html#tests=[[72,64,43]] 23:19:44 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:19:44 INFO - process_Request line: kraken 1517.50 graph.html#tests=[[232,64,43]] 23:19:44 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:19:44 INFO - process_Request line: v8_7 20378.91 graph.html#tests=[[230,64,43]] 23:19:44 INFO - RETURN: dromaeo_css: 6688.13 23:19:44 INFO - RETURN: kraken: 1517.50 23:19:44 INFO - RETURN: v8_7: 20378.91 23:19:44 INFO - javascript benchmark 23:19:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3110.237991692036, 3118.391913576853, 3145.8427078646077, 3166.050184944517, 3178.682131786823, 5037.420696619881, 5132.101882170619, 5139.460356662553, 5149.098907691153, 5202.8179013734525, 5070.543651071403, 5124.9743751281285, 5128.179491281387, 5147.459516750743, 5187.066328060948, 4397.615715138649, 4630.259158534644, 4898.902021959559, 4903.558679718824, 4937.0, 4578.633709303248, 4827.7586120694, 4874.97562512187, 4878.902421951559, 4879.365682461275, 4659.673822832403, 4719.150552900476, 4754.881127971794, 4755.83354582588, 4759.8096076156735, 4659.953400465985, 4664.230401983668, 4675.18184317743, 4717.174494463489, 4731.929021064687, 4599.839005634787, 4665.930011049837, 4678.789454474523, 4698.107359601699, 4705.270683044134, 4923.335349727777, 4958.057968985881, 4985.775640096204, 4993.976234871879, 5067.949320506785, 5465.808696695636, 5482.616216864821, 5489.478499542537, 5493.038718224295, 5534.75093620788, 5403.054465468566, 5530.225768392428, 5533.142362933751, 5559.833205003816, 5564.554835613141, 5138.023775482647, 5153.6392452528335, 5171.146760784466, 5232.947670523284, 5251.52736253739, 5659.915101273484, 5663.207150998864, 5686.9715651421475, 5696.629719068247, 5700.8859822803315, 5456.317960254968, 5462.426445223274, 5466.671999680032, 5475.753591088411, 5508.44915508454, 5426.565874730091, 5475.616706830563, 5506.531944784658, 5529.30883639545, 5580.386157522669, 5492.203630473559, 5550.278463799761, 5553.083741182741, 5558.999380111619, 5560.054790685593, 5380.946190538123, 5551.583631227674, 5564.749586268627, 5574.1917421973585, 5618.91571626426, 4278.058827058042, 4278.379634952915, 4329.545397733255, 4347.804348804311, 4376.606105450461, 3860.9227815443533, 3876.3991581304945, 3878.1274213302345, 3890.008047947755, 3898.3372826619543, 4987.1771157759285, 5090.261912022736, 5219.660722053054, 5223.791048358099, 5304.655197412233, 5525.254090697785, 5583.441655834466, 5595.720213989365, 5636.2954630671165, 5689.231953686282, 5169.06956747789, 5226.555742761831, 5226.973865130726, 5231.3199284092825, 5259.237410575445, 4670.229412147026, 4700.294955756595, 4762.928556071662, 4801.567858892717, 4802.543758342952, 5775.942240577624, 5791.739371728282, 5818.069108942549, 5833.533317334603, 5836.387179346192, 5571.303587051619, 5590.720463976866, 5615.18579805934, 5638.041532939328, 5639.971800140973, 5590.385057643737, 5620.241267428844, 5703.857403564778, 5737.139429085671, 5839.5036421904615, 5466.890662186814, 5485.369182544058, 5488.807891723771, 5490.725463726878, 5491.945080549303, 5565.471280228372, 5567.610267281251, 5572.3034620672415, 5574.219609254788, 5626.043572592751, 5283.656562323436, 5346.786128554814, 5377.758000889891, 5475.835724928259, 5483.2049352844415, 5395.946040539544, 5435.402105768441, 5441.483059109379, 5448.4006759257245, 5454.072807622634, 5189.948100518946, 5341.198820176849, 5364.061289274283, 5392.083345831296, 5414.512693857571, 5364.892702145858, 5391.838244852661, 5482.890342193054, 5485.807996720096, 5513.8345849624575, 5358.46415358461, 5367.194920761917, 5380.757865895966, 5381.677099373894, 5382.977234325465], "unit": "score", "name": "dojo.html", "value": 5119.34402194084}, {"lowerIsBetter": false, "replicates": [511.2152845382338, 525.2384043137449, 546.1152932249756, 546.8660178256326, 554.2572952243995, 34054.31891362171, 34717.0, 34884.651153488456, 34891.82554087233, 35040.0, 35320.823395883046, 35690.0, 35743.10642233946, 35846.10384740383, 35847.64152358476, 8151.266386025257, 8265.95867020664, 8282.213189746995, 8362.0, 8378.245957863792, 8174.100848906615, 8342.916570834304, 8361.456505327134, 8403.36974726895, 8403.411761176689, 8373.49759014461, 8479.533625650587, 8479.703210387637, 8483.915160848404, 8492.702755403561, 8331.625076871525, 8402.915970840275, 8413.579321033954, 8426.241638252526, 8456.534890581015, 8306.252437280613, 8391.580420978926, 8443.577821108982, 8450.492970421732, 8451.704190353308, 34933.475997860056, 35660.28679426397, 35703.0, 35722.64277357219, 35749.82125089384, 2981.329200929795, 2981.3590078133307, 3067.6778938211614, 3124.703153200465, 3214.517822326646, 26800.463990720273, 26932.461350773072, 27132.728672713416, 27879.581806272923, 28077.71922280792, 3732.7013838893095, 3753.1367785409507, 3788.507494025759, 3927.8232479538487, 4053.736507127057, 257481.0, 257637.0, 258047.0, 258181.0, 258531.9999999981, 49336.0, 49741.00517989692, 55556.0, 55902.440975590536, 55965.160522592196, 52011.0, 52047.21929171065, 52168.73915630398, 52341.0, 52517.47482525202, 13387.933060334635, 13440.731185376238, 13580.456781728817, 13625.454981800814, 13627.795583066261, 10522.579096836194, 10540.525676344583, 10601.25791194609, 10611.681649550526, 10619.628313009007, 17983.640327193643, 18147.45557633273, 18626.34807781748, 18682.53293667642, 18755.437336879917, 6967.407770339477, 7113.0, 7139.178994415709, 7193.820154496179, 7195.100612423447, 831.015246932375, 849.4308813095241, 883.9867401988976, 885.4288983605538, 964.0937518732369, 23078.307650770505, 23248.53502929932, 23422.99286606837, 23483.295501134995, 23759.1684291049, 981.8154606001732, 1008.4100801031332, 1014.5586669798661, 1017.97455063624, 1129.6102844518628, 13415.798763018562, 13434.731305373838, 13597.932010340082, 13609.251491167883, 13610.455581776618, 338130.0, 341876.0, 341983.0, 343238.0, 344650.0, 48384.7580762101, 48398.27402588894, 48546.27180592294, 48611.0, 48668.7566562172, 1308.6597484654058, 1326.7412854493282, 1337.3513845784787, 1338.1569611145112, 1338.417788262109, 24537.263882083567, 25224.0, 25735.227943161735, 25757.35606609775, 25763.484730305663, 39345.80327098346, 39609.2078158441, 40038.79980600078, 40619.593804062766, 40680.0, 308034.0, 312869.0, 312915.0, 313644.0, 313692.0, 29277.121686349445, 29533.85233073821, 30647.387052258386, 30674.539881901343, 30676.84661576678, 36263.0, 36614.0, 38687.22625547417, 39288.2142357157, 40628.59371406248, 33118.337633247684, 33225.66774332226, 33339.0, 33506.66493335035, 33905.66094339124, 33447.33105337831, 34191.0, 35063.47404788981, 35518.644813552564, 35751.28497429985, 34231.0, 34425.827870860485, 34900.65099348974, 35165.824170880005, 35416.29167416689, 25814.354641134123, 26366.85048806309, 29423.705762942955, 30726.692733072385, 30979.535306969963, 23521.882390587936, 23786.88106559456, 23818.88090559536, 23939.401514962265, 24137.39656508531], "unit": "score", "name": "ext.html", "value": 17160.17705994428}, {"lowerIsBetter": false, "replicates": [343.57245644347734, 345.44383542496576, 348.79769733554525, 348.91277180704816, 354.91659460026904, 13560.72878542431, 13985.510507132252, 16144.757828632566, 16563.58591035225, 17926.193321300558, 13921.93039034806, 14165.504207352744, 15133.31900064497, 15227.695446091098, 15264.847351526481, 5061.569766569837, 5102.1836506159025, 5288.180332048539, 5292.576593872481, 5293.232481290211, 4910.607151427895, 5121.411037730652, 5121.820736274231, 5175.094358487249, 5175.275461435402, 4920.507949205086, 5063.544281014708, 5066.923996140061, 5081.872953176163, 5155.61332900034, 5335.226392173133, 5352.277442545245, 5355.437679043722, 5386.569074474032, 5395.73021348931, 5001.674891132065, 5158.97420512895, 5170.095233334189, 5171.836336824222, 5173.068847607429, 18670.346537871246, 18794.718079228824, 18852.15165317564, 19408.0, 19445.805541944683, 1869.6447674941717, 1873.8313551780404, 1963.2735887721635, 2105.589410065038, 2255.391044418014, 9020.32347573928, 9030.277577793826, 9657.227421806308, 12023.15837891348, 12100.939495302468, 1663.9251233694513, 1703.2505697493064, 1737.1140718233667, 1743.0587482759295, 1765.523308706655, 53411.732941335045, 54694.906101878136, 56347.15479267814, 56358.0, 56392.0, 8602.741917742478, 8852.822943541094, 9155.450672959643, 9744.928057913623, 9826.115649591571, 12037.217580857216, 12046.0, 12050.27698338085, 12053.698657533632, 12063.095267854946, 6808.761693340709, 6923.896141557881, 6933.618650974245, 7202.567845929261, 7224.060872086595, 7062.081929349254, 7087.610181439967, 7108.289171082851, 7131.750388736369, 7153.7138514459875, 3631.1103779573646, 3652.2878038782183, 3662.853485860536, 3663.9267214655556, 3684.115812205105, 1536.185821514599, 1605.2856478867025, 1607.9758803617956, 1609.7746315515838, 1619.5303362024881, 421.8776554799135, 451.2464184811373, 906.428949761646, 913.2739472119681, 918.9816203676023, 9808.46053467052, 10018.398896066114, 10381.96180381971, 10404.58381664725, 10434.843477347846, 841.4362377207286, 851.9148085191555, 908.7818923458323, 929.2798081486767, 950.325269058962, 8655.17775811297, 9326.207272381924, 9740.074692904305, 9854.458004809661, 9919.454430006275, 395844.0, 405939.0, 502824.0, 503671.0, 509496.0, 42173.367399489034, 43067.13865722668, 43331.78334108373, 72416.275837242, 76527.61736191284, 1125.4766533561933, 1142.5258517715222, 1167.1129941244715, 1197.6466942252057, 1221.450347343699, 15213.315400807212, 15343.769843452134, 15406.614834629225, 15461.5311545403, 15790.9210453947, 33509.99470015903, 33949.0, 34169.31661366808, 34657.480137798455, 35200.647993519735, 43074.569254308306, 43197.568024320615, 44006.779966099966, 44106.11787764291, 44466.0, 6972.895406569007, 7146.3568278855155, 7232.855342893007, 7306.196318405077, 7335.449841262033, 10563.0, 10664.253502254767, 10707.196960227859, 10824.56701731922, 10995.945020274847, 8506.74479765608, 9332.440053596805, 9693.321467497208, 9783.853242201514, 10063.49682515886, 6489.772857949949, 7237.529560578546, 9588.0, 9832.803343933225, 10135.391876487434, 6929.1684997800585, 7286.526375785557, 7401.111866576045, 7504.549727016397, 7620.5808680523105, 8556.614952327285, 8952.418092824206, 8994.595243214202, 9277.907220927704, 9412.15290623847, 9050.728478145666, 9295.0, 9372.156505914229, 9421.293402994666, 9465.242780577399], "unit": "score", "name": "jquery.html", "value": 7645.320487836172}, {"lowerIsBetter": false, "replicates": [1267.9429425675844, 1273.7325161716042, 1317.8813906748396, 1550.100941453957, 1550.1396724817737, 7730.304272615464, 7757.495762775416, 7898.96050519748, 7901.0, 7939.483933544316, 7862.292393684582, 7888.1323054463965, 7936.682532698699, 7945.165757595456, 7978.720744773934, 2301.620232661609, 2341.0518739910362, 2341.84777989431, 2344.4138965258685, 2345.718513778349, 2367.573836709392, 2385.403649087728, 2398.556267090594, 2402.5675378431874, 2405.434722840131, 2304.665823455598, 2321.1875843454823, 2354.587947109249, 2368.27767530903, 2372.620380739082, 2359.4691194481275, 2361.4568649210605, 2361.8700971446565, 2373.2642880707035, 2392.2583998960376, 2335.497867958397, 2363.397333679901, 2368.064614477272, 2370.4073981504625, 2379.1910750344964, 7778.144404115543, 7800.843983120362, 7821.608919554, 7822.335101516378, 7844.2155784421675, 4541.6593755468475, 4692.343071969927, 4699.318598803188, 4724.314974328738, 4731.266653668652, 3192.6488086310487, 3242.7730058895886, 3282.2778988622463, 3298.191942973963, 3307.6196237432764, 1070.6252811515985, 1083.1984331594563, 1084.728817795551, 1089.3355053417408, 1090.334895713614, 10529.473526323653, 10601.681949541526, 10634.9468252659, 10682.305650132794, 10685.0, 4072.8778136655355, 4146.150039241948, 4172.269852775813, 4239.236937351307, 4273.786310684453, 8493.617787199591, 8517.829643407222, 8526.829463410697, 8547.102554231717, 8561.785955351166, 4497.6851620386915, 4501.932471012938, 4505.977470112694, 4528.935700110472, 4530.501644819067, 4122.91754164915, 4133.9793301033305, 4138.772367519755, 4160.43834082395, 4177.4569305990635, 3366.5118557808983, 3372.0, 3383.983080084584, 3393.474011528217, 3399.0, 1052.7420781908481, 1057.9894201058046, 1067.354250678344, 1070.641335152717, 1078.9028987391016, 952.5046975572664, 957.9329446938787, 995.4574756757585, 1005.5324274212526, 1205.2406983600451, 6880.071190389333, 6967.059446974695, 7005.1593808742255, 7007.614581197981, 7020.403265722369, 1097.5116073347283, 1112.8213558089485, 1115.9497822598003, 1134.444122380028, 1156.346664134761, 5533.1976863354585, 5568.916466253009, 5589.105743081169, 5600.607957443021, 5627.099664053813, 9237.769055773659, 9614.423134611805, 9762.560684769202, 9788.559514821707, 9814.705558833246, 9463.38487998278, 9542.093501117382, 9610.0, 9651.083147101013, 9664.420134791935, 7325.0, 7560.546367217985, 7565.962170189224, 7574.356179724675, 7585.279398457138, 6998.265182156004, 7061.823454413475, 7064.858702826017, 7092.503524753218, 7117.181524124792, 8409.453385529921, 8556.657733690583, 8718.215360617321, 8747.16901894319, 8750.256228220673, 8745.562721863755, 8822.823543529223, 8852.159044890725, 8936.151065648754, 8945.821083578161, 6376.298607153302, 6500.707468164039, 6529.085927970183, 6536.281009089092, 6575.967120164369, 7362.3741981932135, 7432.442566807619, 7451.515651482637, 7483.550986940801, 7510.286522780327, 7073.893891591733, 7127.429805615642, 7152.785416437515, 7180.066591343092, 7298.744543940937, 7007.089078419773, 7101.82245443868, 7145.21402645719, 7149.85700285981, 7277.854442911006, 7119.786406407608, 7149.964250178716, 7150.96424517874, 7169.0680211574245, 7225.494215405081, 6172.105044768394, 6188.412100850412, 6190.783322583688, 6191.783287584913, 6296.653684047421, 6386.297507274103, 6431.935680643321, 6436.16329877113, 6436.935630643634, 6438.678066096582], "unit": "score", "name": "mootools.html", "value": 4466.561393964727}, {"lowerIsBetter": false, "replicates": [313.1404295209649, 319.5286951746175, 326.8202488631253, 328.62372583392016, 328.64670479234826, 6186.969065154673, 6242.500599952004, 6252.687365631723, 6268.498520118391, 6326.848871383729, 6192.225971753531, 6206.9068963965465, 6212.763405174133, 6222.968885155579, 6232.3144454110125, 4518.847693838066, 4667.463241727194, 4698.483166851644, 4721.2209985352465, 4748.90502189956, 4643.117807616542, 4656.348111264426, 4675.859724208279, 4681.204195286792, 4713.033828065256, 4565.748883811389, 4610.2854057621125, 4619.122366750324, 4622.815087396517, 4632.305154226876, 4606.124836281096, 4612.630989520831, 4628.282616194495, 4640.048789998043, 4642.164410406125, 3920.353141731611, 3962.7424217425773, 3977.423273625337, 3984.163325701606, 4043.9375918281594, 5785.27684039495, 5818.156367326714, 5823.242978412779, 5837.620554663933, 5887.116932460122, 5543.77824887004, 5547.1124620061, 5555.388907220243, 5560.443955604448, 5562.3047119110115, 6542.182227221598, 6551.246606640249, 6574.539782215247, 6594.07682924391, 6603.405693487609, 4517.373745451635, 4652.976735116336, 4654.394928659286, 4656.627469802442, 4667.766611669403, 6853.074834897275, 6916.585004899722, 6930.826729331807, 6935.445164386837, 6950.617716025617, 4723.716577005391, 4767.523247675204, 4770.212914869077, 4780.808767649325, 4788.209945358977, 4558.316252562142, 4729.574338309569, 4794.424669039738, 4828.179209534317, 4854.101991131652, 5477.589180811455, 5479.863003424946, 5492.148716948879, 5512.476314750093, 5515.200295957064, 6650.73397064112, 6693.497987650946, 6705.128333316735, 6705.396514313735, 6709.966450167718, 1656.2050215896438, 1692.2892385198247, 1692.356904376329, 1697.3041053168142, 1698.388580111159, 1092.5029111754134, 1097.078454098545, 1098.5001824169983, 1127.1095834290982, 1130.4743294367993, 6315.400036996478, 6316.084167795644, 6319.05214217871, 6320.778772742932, 6351.04734289851, 6839.931600684029, 6845.828854278583, 6845.931540684629, 6865.588064716033, 6869.656517174121, 6190.102435146879, 6327.7028209217, 6329.493640508748, 6333.1766870306565, 6340.651264180515, 3727.105494681257, 3753.0242137044565, 3755.7370984030854, 3756.6243375662216, 3761.7366784324836, 7099.148102227766, 7218.0, 7295.781126566211, 7297.416206703451, 7306.890396644055, 6994.860102798018, 7023.262557431498, 7030.086088808423, 7037.437005039687, 7051.964740176266, 7125.0, 7227.205007449176, 7255.600941948138, 7259.564426134343, 7261.963690181516, 6910.20532638753, 6912.893936970061, 6914.688839002157, 6931.722731090902, 6939.514234003571, 6860.931390686029, 6863.176418829772, 6863.794086177422, 6870.038194652652, 6885.001674757233, 7118.750843720445, 7142.750003750051, 7190.96404517974, 7247.927520724937, 7265.09186351706, 4511.977440112779, 4545.363649089196, 4545.727256364628, 4567.451905771329, 4567.748773817339, 6855.5886646801355, 6886.655667216719, 6911.3779759821855, 6928.064711264116, 6965.442764578923, 6533.575317604341, 6693.598384096969, 6695.163104611924, 6704.094947182068, 6714.429273511806, 6641.169853768279, 6700.095487109178, 6708.83227919306, 6719.462443004646, 6725.092112564741, 6588.571742836701, 6596.373344532261, 6597.406233439014, 6602.372774586406, 6603.702833372414, 6557.573757705733, 6732.3267673232285, 6739.292374300628, 6755.493337999571, 6762.7294908205085, 6570.211574611078, 6591.143151390289, 6592.077109204619, 6594.439472644879, 6603.20761508622], "unit": "score", "name": "prototype.html", "value": 4985.4207153819725}, {"lowerIsBetter": false, "replicates": [624.6907780648579, 686.2554128770284, 733.6258508160836, 745.0351794426217, 825.7935516120973, 12891.419886105125, 12952.093353465261, 13039.543615973444, 13111.606651800437, 13158.407871645775, 12309.076819238548, 12448.1908675936, 12519.812202816966, 12888.871111288909, 12893.806592901114, 779.7231982646164, 783.193310889783, 793.6150966781106, 793.9245771651713, 809.6478032056045, 795.598222897436, 798.4610387988114, 801.2068052627915, 801.9478733882308, 802.6428239433454, 836.4186890111345, 840.2018082821344, 840.7982084299786, 841.4110122913985, 841.7643059943196, 832.937529685273, 833.7040350675544, 834.3283656656389, 837.8826964225013, 838.1116017021976, 596.1921596237123, 603.1826874584962, 603.499095750526, 612.10326871134, 616.6454288783967, 13907.374168162458, 13913.860861391358, 13949.511767088205, 13970.790438143436, 14020.158790472604, 11445.94277028618, 11917.761644767055, 11958.820617690655, 12640.431180596803, 12795.04037197214, 9240.95379523098, 9507.049295070507, 9518.333716639838, 9579.042095790435, 9603.231741460737, 3345.9498107528407, 3347.966520334814, 3393.983030084834, 3395.7962522248745, 3477.078574177845, 46646.0, 46684.766576166905, 47069.0, 47091.64541772898, 47359.28961065587, 8910.9752378476, 8923.464592124494, 9137.04061073591, 9243.722688319362, 9469.47917864524, 17106.657866842594, 17108.144592770313, 17108.74336884948, 17165.7425138623, 17175.398861040052, 6990.266022067712, 7047.224805271416, 7123.109611298588, 7129.215786263507, 7297.087864016998, 4007.6593489553716, 4025.798710064485, 4042.555318914917, 4049.57479464652, 4119.526254480773, 2866.498362786504, 2891.4506243813607, 2891.6819149893495, 2906.084583356236, 2909.9563506546997, 529.6716036057592, 540.2760301196415, 543.5461389739532, 553.9889202215933, 556.9081101618187, 466.9696469729525, 474.99801256061363, 481.4102724162942, 489.4713709194062, 524.7638562646824, 8199.631016604268, 8381.832363352698, 8427.241548260687, 9395.953020234992, 9453.196478299422, 539.8434454008373, 569.2883895131087, 585.7130006296884, 609.3419107364036, 625.8466675664491, 3840.8847734568008, 3882.6311500407414, 4104.220198162339, 4290.0776333087915, 4314.223439780807, 55289.1706624401, 55787.0, 56048.439515604325, 56186.0, 58509.0, 48543.75728121407, 48804.755976219894, 50156.24765628519, 50666.24000639993, 50743.999999999265, 45343.0, 46044.0, 46126.5387346129, 46411.76794116008, 46538.0, 8572.442791218551, 8631.827363452821, 8859.246964007874, 8891.558728472268, 9003.54982250898, 33394.33211335808, 33813.323733525685, 34113.0, 34370.250379969046, 34545.30909381748, 41017.17965640611, 42348.36477452779, 43361.3495797557, 45151.77424112859, 45453.31820022769, 9260.583273752833, 9383.859242111237, 9918.256130790363, 10402.895971040496, 10877.51051202682, 10476.266661333633, 10623.89376106229, 10679.19906007037, 10703.785924281316, 10869.076128528848, 9958.0, 10092.405788438009, 10138.746531336776, 10667.065659210555, 10687.679369618612, 10176.898231017594, 10475.633352832614, 10502.107320877505, 10591.311564748266, 10724.088452481627, 9458.0, 10181.440020798631, 10401.167906567305, 10630.574777008833, 10671.51978161, 8072.556009419303, 8598.833854052746, 8744.44913046709, 8755.91244087551, 9110.31672624569, 8365.749027529184, 8812.91187088121, 9188.908110919072, 9275.67535136267, 9375.10936461035], "unit": "score", "name": "yui.html", "value": 5983.9567989352945}], "name": "dromaeo_css", "value": 6688.133490143185}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 111.0, 111.0, 110.0, 123.0, 112.0, 110.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.0}, {"lowerIsBetter": true, "replicates": [155.0, 127.0, 153.0, 165.0, 127.0, 150.0, 149.0, 125.0, 165.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 144.2}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 162.0, 162.0, 161.0, 162.0, 161.0, 165.0, 168.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.7}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 75.0, 73.0, 71.0, 73.0, 133.0, 75.0, 71.0, 71.0], "unit": "score", "name": "audio-fft", "value": 79.4}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 139.0, 97.0, 97.0, 97.0, 138.0, 96.0, 97.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 147.0, 147.0, 146.0, 147.0, 145.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 95.0, 98.0, 96.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 57.0, 56.0, 57.0, 57.0, 58.0, 57.0, 61.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 68.0, 70.0, 68.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [87.0, 89.0, 88.0, 89.0, 87.0, 89.0, 96.0, 88.0, 96.0, 96.0], "unit": "score", "name": "stanford-crypto-aes", "value": 90.5}, {"lowerIsBetter": true, "replicates": [120.0, 126.0, 117.0, 123.0, 121.0, 121.0, 119.0, 123.0, 134.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.6}, {"lowerIsBetter": true, "replicates": [143.0, 156.0, 155.0, 152.0, 155.0, 139.0, 155.0, 153.0, 142.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.1}, {"lowerIsBetter": true, "replicates": [67.0, 71.0, 69.0, 69.0, 69.0, 70.0, 68.0, 68.0, 70.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1517.4999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.5603217158177], "unit": "score", "name": "Richards", "value": 210.68233600000002}, {"lowerIsBetter": false, "replicates": [190.5487804878049], "unit": "score", "name": "DeltaBlue", "value": 346.9872640000001}, {"lowerIsBetter": false, "replicates": [280.662363177098], "unit": "score", "name": "Encrypt", "value": 948.4029029999999}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1060.4453870625662], "unit": "score", "name": "RayTrace", "value": 697.809627}, {"lowerIsBetter": false, "replicates": [729.3946024799417], "unit": "score", "name": "Earley", "value": 913.7207730000002}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [41040.0], "unit": "score", "name": "RegExp", "value": 22.197490253411285}, {"lowerIsBetter": false, "replicates": [585.1375073142189], "unit": "score", "name": "Splay", "value": 139.26811900000004}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20378.91029547061}]} 23:19:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20378.91"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1517.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6688.13"}}} 23:19:44 INFO - Return code: 0 23:19:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:19:44 INFO - # TBPL SUCCESS # 23:19:44 INFO - Running post-action listener: _resource_record_post_action 23:19:44 INFO - Running post-run listener: _resource_record_post_run 23:19:45 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 598016; Write bytes: 328781824; Read time: 188; Write time: 338240 23:19:45 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13352960; Read time: 0; Write time: 9060 23:19:45 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 598016; Write bytes: 309583872; Read time: 188; Write time: 316656 23:19:45 INFO - Running post-run listener: _upload_blobber_files 23:19:45 INFO - Blob upload gear active. 23:19:45 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:19:45 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:45 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:45 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:46 INFO - (blobuploader) - INFO - Open directory for files ... 23:19:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:19:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:19:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:19:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:19:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:19:46 INFO - (blobuploader) - INFO - Done attempting. 23:19:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:19:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:19:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:19:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:19:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:19:47 INFO - (blobuploader) - INFO - Done attempting. 23:19:47 INFO - (blobuploader) - INFO - Iteration through files over. 23:19:47 INFO - Return code: 0 23:19:47 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:19:47 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:19:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42e95a8ccba293ae21c6c1da14aacd326e95cb96b9826fbf67cdef5804ebeb9d595a00b68f7c96fc01464163ee36815cc1ea83e6dd56c427daac7d610dc828a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/880115d19e37c1594bc583afc862a645da4f3d63f5d99e6ebe6b64ddaf5b9ebc32896bcefd3f63aac6eaa6502983752dc0417e139dade8e4fe923a8e91f53381"} 23:19:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:19:47 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:19:47 INFO - Contents: 23:19:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42e95a8ccba293ae21c6c1da14aacd326e95cb96b9826fbf67cdef5804ebeb9d595a00b68f7c96fc01464163ee36815cc1ea83e6dd56c427daac7d610dc828a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/880115d19e37c1594bc583afc862a645da4f3d63f5d99e6ebe6b64ddaf5b9ebc32896bcefd3f63aac6eaa6502983752dc0417e139dade8e4fe923a8e91f53381"} 23:19:47 INFO - Copying logs to upload dir... 23:19:47 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1276.799456 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-01-11 23:19:47.613966) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 23:19:47.619066) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452576654.220644-845968638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42e95a8ccba293ae21c6c1da14aacd326e95cb96b9826fbf67cdef5804ebeb9d595a00b68f7c96fc01464163ee36815cc1ea83e6dd56c427daac7d610dc828a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/880115d19e37c1594bc583afc862a645da4f3d63f5d99e6ebe6b64ddaf5b9ebc32896bcefd3f63aac6eaa6502983752dc0417e139dade8e4fe923a8e91f53381"} 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.011181 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42e95a8ccba293ae21c6c1da14aacd326e95cb96b9826fbf67cdef5804ebeb9d595a00b68f7c96fc01464163ee36815cc1ea83e6dd56c427daac7d610dc828a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/880115d19e37c1594bc583afc862a645da4f3d63f5d99e6ebe6b64ddaf5b9ebc32896bcefd3f63aac6eaa6502983752dc0417e139dade8e4fe923a8e91f53381"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 23:19:47.643916) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 23:19:47.644255) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452576654.220644-845968638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 23:19:47.727929) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 23:19:47.728429) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 23:19:47.728955) ========= ========= Total master_lag: 0.23 =========