builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1452560364.84 results: success (0) buildid: 20160111143012 builduid: a6c916efd13543409298ba920a877eb2 revision: 08d1d3f7266007e2492a77d579ae3f3008c51dfc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 16:59:24.841586) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 16:59:24.842105) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 16:59:24.842419) ========= 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=41bf3e9aed84707956354da8000001c5-1452560327.928548-85019509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006294 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 16:59:24.871871) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 16:59:24.872216) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 16:59:24.971543) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 16:59:24.971804) ========= 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=41bf3e9aed84707956354da8000001c5-1452560327.928548-85019509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004554 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 16:59:25.021868) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 16:59:25.022159) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 16:59:25.022521) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 16:59:25.022790) ========= 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=41bf3e9aed84707956354da8000001c5-1452560327.928548-85019509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-11 16:59:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 35.1M=0s 2016-01-11 16:59:25 (35.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104086 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 16:59:25.139397) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 16:59:25.139720) ========= 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=41bf3e9aed84707956354da8000001c5-1452560327.928548-85019509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019711 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 16:59:25.189292) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 16:59:25.189640) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 08d1d3f7266007e2492a77d579ae3f3008c51dfc --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 08d1d3f7266007e2492a77d579ae3f3008c51dfc --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=41bf3e9aed84707956354da8000001c5-1452560327.928548-85019509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-11 16:59:25,242 truncating revision to first 12 chars 2016-01-11 16:59:25,243 Setting DEBUG logging. 2016-01-11 16:59:25,243 attempt 1/10 2016-01-11 16:59:25,243 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/08d1d3f72660?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-11 16:59:25,515 unpacking tar archive at: fx-team-08d1d3f72660/testing/mozharness/ program finished with exit code 0 elapsedTime=0.609899 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 16:59:25.812774) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 16:59:25.813099) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 16:59:25.823477) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 16:59:25.823736) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 16:59:25.824109) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 34 secs) (at 2016-01-11 16:59:25.824383) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1452560327.928548-85019509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:59:25 INFO - MultiFileLogger online at 20160111 16:59:25 in /builds/slave/test-pgo 16:59:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:59:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:59:25 INFO - {'append_to_log': False, 16:59:25 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:59:25 INFO - 'blob_upload_branch': 'Fx-Team', 16:59:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:59:25 INFO - 'branch': 'Fx-Team', 16:59:25 INFO - 'buildbot_json_path': 'buildprops.json', 16:59:25 INFO - 'config_files': ('talos/linux_config.py',), 16:59:25 INFO - 'default_actions': ('clobber', 16:59:25 INFO - 'read-buildbot-config', 16:59:25 INFO - 'download-and-extract', 16:59:25 INFO - 'populate-webroot', 16:59:25 INFO - 'create-virtualenv', 16:59:25 INFO - 'install', 16:59:25 INFO - 'run-tests'), 16:59:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:59:25 INFO - 'download_minidump_stackwalk': True, 16:59:25 INFO - 'download_symbols': 'ondemand', 16:59:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:59:25 INFO - 'tooltool.py': '/tools/tooltool.py', 16:59:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:59:25 INFO - '/tools/misc-python/virtualenv.py')}, 16:59:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:59:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:59:25 INFO - 'installer_path': 'installer.exe', 16:59:25 INFO - 'log_level': 'info', 16:59:25 INFO - 'log_name': 'talos', 16:59:25 INFO - 'log_to_console': True, 16:59:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:59:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:59:25 INFO - 'opt_config_files': (), 16:59:25 INFO - 'pip_index': False, 16:59:25 INFO - 'sps_profile': False, 16:59:25 INFO - 'sps_profile_interval': 0, 16:59:25 INFO - 'suite': 'dromaeojs', 16:59:25 INFO - 'system_bits': '32', 16:59:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:59:25 INFO - 'title': 'talos-linux64-ix-026', 16:59:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:59:25 INFO - 'use_talos_json': True, 16:59:25 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:59:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:59:25 INFO - 'work_dir': 'build'} 16:59:25 INFO - ##### 16:59:25 INFO - ##### Running clobber step. 16:59:25 INFO - ##### 16:59:25 INFO - Running pre-action listener: _resource_record_pre_action 16:59:25 INFO - Running main action method: clobber 16:59:25 INFO - rmtree: /builds/slave/test-pgo/build 16:59:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:59:26 INFO - Running post-action listener: _resource_record_post_action 16:59:26 INFO - ##### 16:59:26 INFO - ##### Running read-buildbot-config step. 16:59:26 INFO - ##### 16:59:26 INFO - Running pre-action listener: _resource_record_pre_action 16:59:26 INFO - Running main action method: read_buildbot_config 16:59:26 INFO - Using buildbot properties: 16:59:26 INFO - { 16:59:26 INFO - "project": "", 16:59:26 INFO - "product": "firefox", 16:59:26 INFO - "script_repo_revision": "production", 16:59:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:59:26 INFO - "repository": "", 16:59:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 16:59:26 INFO - "buildid": "20160111143012", 16:59:26 INFO - "pgo_build": "True", 16:59:26 INFO - "basedir": "/builds/slave/test-pgo", 16:59:26 INFO - "buildnumber": 889, 16:59:26 INFO - "slavename": "talos-linux64-ix-026", 16:59:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:59:26 INFO - "platform": "ubuntu64_hw", 16:59:26 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:59:26 INFO - "branch": "fx-team", 16:59:26 INFO - "repo_path": "integration/fx-team", 16:59:26 INFO - "revision": "08d1d3f7266007e2492a77d579ae3f3008c51dfc", 16:59:26 INFO - "stage_platform": "linux64-pgo", 16:59:26 INFO - "builduid": "a6c916efd13543409298ba920a877eb2", 16:59:26 INFO - "slavebuilddir": "test" 16:59:26 INFO - } 16:59:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/RIkQWdUHSiGyg3jOyqyUaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:59:26 INFO - Running post-action listener: _resource_record_post_action 16:59:26 INFO - ##### 16:59:26 INFO - ##### Running download-and-extract step. 16:59:26 INFO - ##### 16:59:26 INFO - Running pre-action listener: _resource_record_pre_action 16:59:26 INFO - Running main action method: download_and_extract 16:59:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:59:26 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')]} 16:59:26 INFO - https://queue.taskcluster.net/v1/task/RIkQWdUHSiGyg3jOyqyUaA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:59:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIkQWdUHSiGyg3jOyqyUaA/artifacts/public/build/test_packages.json 16:59:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIkQWdUHSiGyg3jOyqyUaA/artifacts/public/build/test_packages.json 16:59:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIkQWdUHSiGyg3jOyqyUaA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:59:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIkQWdUHSiGyg3jOyqyUaA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:59:30 INFO - Downloaded 1302 bytes. 16:59:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:59:30 INFO - Using the following test package requirements: 16:59:30 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:59:30 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:59:30 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:30 INFO - u'jsshell-linux-x86_64.zip'], 16:59:30 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:59:30 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:59:30 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:59:30 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:59:30 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:59:30 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:59:30 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:59:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:30 INFO - https://queue.taskcluster.net/v1/task/RIkQWdUHSiGyg3jOyqyUaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:59:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIkQWdUHSiGyg3jOyqyUaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:59:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIkQWdUHSiGyg3jOyqyUaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:59:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIkQWdUHSiGyg3jOyqyUaA/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 16:59:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIkQWdUHSiGyg3jOyqyUaA/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 16:59:50 INFO - Downloaded 24025152 bytes. 16:59:50 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 16:59:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:59:50 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 16:59:51 INFO - Return code: 0 16:59:51 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 16:59:51 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')]} 16:59:51 INFO - https://queue.taskcluster.net/v1/task/RIkQWdUHSiGyg3jOyqyUaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:59:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIkQWdUHSiGyg3jOyqyUaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:59:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIkQWdUHSiGyg3jOyqyUaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:59:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIkQWdUHSiGyg3jOyqyUaA/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 16:59:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIkQWdUHSiGyg3jOyqyUaA/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 16:59:56 INFO - Downloaded 24025152 bytes. 16:59:56 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 16:59:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:59:56 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 16:59:57 INFO - Return code: 0 16:59: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')]} 16:59:57 INFO - https://queue.taskcluster.net/v1/task/RIkQWdUHSiGyg3jOyqyUaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:59:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIkQWdUHSiGyg3jOyqyUaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:59:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIkQWdUHSiGyg3jOyqyUaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:59:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIkQWdUHSiGyg3jOyqyUaA/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 16:59:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIkQWdUHSiGyg3jOyqyUaA/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 17:00:00 INFO - Downloaded 11132285 bytes. 17:00:00 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 17:00:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:00:00 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 17:00:00 INFO - Return code: 0 17:00:00 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')]} 17:00:00 INFO - https://queue.taskcluster.net/v1/task/RIkQWdUHSiGyg3jOyqyUaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:00:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIkQWdUHSiGyg3jOyqyUaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:00:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIkQWdUHSiGyg3jOyqyUaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:00:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIkQWdUHSiGyg3jOyqyUaA/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 17:00:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RIkQWdUHSiGyg3jOyqyUaA/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 17:00:05 INFO - Downloaded 55797130 bytes. 17:00:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RIkQWdUHSiGyg3jOyqyUaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:00:05 INFO - mkdir: /builds/slave/test-pgo/properties 17:00:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:00:05 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:00:05 INFO - Contents: 17:00:05 INFO - build_url:https://queue.taskcluster.net/v1/task/RIkQWdUHSiGyg3jOyqyUaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:00:05 INFO - Running post-action listener: _resource_record_post_action 17:00:05 INFO - Running post-action listener: set_extra_try_arguments 17:00:05 INFO - ##### 17:00:05 INFO - ##### Running populate-webroot step. 17:00:05 INFO - ##### 17:00:05 INFO - Running pre-action listener: _resource_record_pre_action 17:00:05 INFO - Running main action method: populate_webroot 17:00:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:00:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:00:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:00:05 INFO - '--tppagecycles', 17:00:05 INFO - '7'], 17:00:05 INFO - 'tests': ['tsvgm']}}, 17:00:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:00:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:00:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:00:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:00:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:00:05 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:00:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:00:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:05 INFO - 'talos_options': ['--e10s'], 17:00:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:00:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:05 INFO - 'tests': ['damp', 'tps']}, 17:00:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:05 INFO - 'talos_options': ['--e10s'], 17:00:05 INFO - 'tests': ['damp', 'tps']}, 17:00:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:00:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:00:05 INFO - 'other': {'tests': ['a11yr', 17:00:05 INFO - 'ts_paint', 17:00:05 INFO - 'tpaint', 17:00:05 INFO - 'sessionrestore', 17:00:05 INFO - 'sessionrestore_no_auto_restore']}, 17:00:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:00:05 INFO - 'tests': ['a11yr', 17:00:05 INFO - 'ts_paint', 17:00:05 INFO - 'tpaint', 17:00:05 INFO - 'sessionrestore', 17:00:05 INFO - 'sessionrestore_no_auto_restore']}, 17:00:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:00:05 INFO - 'tests': ['a11yr', 17:00:05 INFO - 'ts_paint', 17:00:05 INFO - 'tpaint', 17:00:05 INFO - 'sessionrestore', 17:00:05 INFO - 'sessionrestore_no_auto_restore']}, 17:00:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:00:05 INFO - 'tests': ['a11yr', 17:00:05 INFO - 'ts_paint', 17:00:05 INFO - 'tpaint', 17:00:05 INFO - 'sessionrestore', 17:00:05 INFO - 'sessionrestore_no_auto_restore']}, 17:00:05 INFO - 'other_l64': {'tests': ['a11yr', 17:00:05 INFO - 'ts_paint', 17:00:05 INFO - 'tpaint', 17:00:05 INFO - 'sessionrestore', 17:00:05 INFO - 'sessionrestore_no_auto_restore']}, 17:00:05 INFO - 'other_nol64': {'tests': ['a11yr', 17:00:05 INFO - 'ts_paint', 17:00:05 INFO - 'tpaint', 17:00:05 INFO - 'sessionrestore', 17:00:05 INFO - 'sessionrestore_no_auto_restore']}, 17:00:05 INFO - 'svgr': {'tests': ['tsvgx', 17:00:05 INFO - 'tsvgr_opacity', 17:00:05 INFO - 'tart', 17:00:05 INFO - 'tscrollx', 17:00:05 INFO - 'cart']}, 17:00:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:00:05 INFO - 'tests': ['tsvgx', 17:00:05 INFO - 'tsvgr_opacity', 17:00:05 INFO - 'tart', 17:00:05 INFO - 'tscrollx', 17:00:05 INFO - 'cart']}, 17:00:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:05 INFO - 'tests': ['tp5o']}, 17:00:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:05 INFO - 'talos_options': ['--e10s'], 17:00:05 INFO - 'tests': ['tp5o']}, 17:00:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:05 INFO - 'talos_options': ['--xperf_path', 17:00:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:00:05 INFO - 'tests': ['tp5n']}, 17:00:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:00:05 INFO - 'talos_options': ['--e10s', 17:00:05 INFO - '--xperf_path', 17:00:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:00:05 INFO - 'tests': ['tp5n']}}, 17:00:05 INFO - 'talos.zip': {'path': '', 17:00:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:00:05 INFO - Running post-action listener: _resource_record_post_action 17:00:05 INFO - ##### 17:00:05 INFO - ##### Running create-virtualenv step. 17:00:05 INFO - ##### 17:00:05 INFO - Running pre-action listener: _resource_record_pre_action 17:00:05 INFO - Running main action method: create_virtualenv 17:00:05 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:00:05 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 17:00:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:00:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:00:05 INFO - Using real prefix '/usr' 17:00:05 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:00:05 INFO - Installing distribute.............................................................................................................................................................................................done. 17:00:07 INFO - Installing pip.................done. 17:00:07 INFO - Return code: 0 17:00:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:00:07 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')]} 17:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:07 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')]} 17:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:07 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 0x7f6e7f4a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1461560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0740>, '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 0x14f1640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f1af0>, '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': '41bf3e9aed84707956354da8000001c5-1452560327.928548-85019509', '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 17:00:07 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 17:00:07 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 17:00:07 INFO - Using env: {'DISPLAY': ':0', 17:00:07 INFO - 'HOME': '/home/cltbld', 17:00:07 INFO - 'LANG': 'en_US.UTF-8', 17:00:07 INFO - 'LANGUAGE': 'en_US:en', 17:00:07 INFO - 'LOGNAME': 'cltbld', 17:00:07 INFO - 'MAIL': '/var/mail/cltbld', 17:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:07 INFO - 'MOZ_NO_REMOTE': '1', 17:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:07 INFO - 'NO_EM_RESTART': '1', 17:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:07 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:07 INFO - 'SHELL': '/bin/bash', 17:00:07 INFO - 'SHLVL': '1', 17:00:07 INFO - 'TERM': 'linux', 17:00:07 INFO - 'TMOUT': '86400', 17:00:07 INFO - 'USER': 'cltbld', 17:00:07 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452560327.928548-85019509', 17:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:07 INFO - '_': '/tools/buildbot/bin/python'} 17:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:07 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 17:00:07 INFO - Cleaning up... 17:00:07 INFO - Return code: 0 17:00:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:00:07 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')]} 17:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:07 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')]} 17:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:07 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 0x7f6e7f4a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1461560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0740>, '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 0x14f1640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f1af0>, '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': '41bf3e9aed84707956354da8000001c5-1452560327.928548-85019509', '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 17:00:07 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 17:00:07 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 17:00:07 INFO - Using env: {'DISPLAY': ':0', 17:00:07 INFO - 'HOME': '/home/cltbld', 17:00:07 INFO - 'LANG': 'en_US.UTF-8', 17:00:07 INFO - 'LANGUAGE': 'en_US:en', 17:00:07 INFO - 'LOGNAME': 'cltbld', 17:00:07 INFO - 'MAIL': '/var/mail/cltbld', 17:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:07 INFO - 'MOZ_NO_REMOTE': '1', 17:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:07 INFO - 'NO_EM_RESTART': '1', 17:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:07 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:07 INFO - 'SHELL': '/bin/bash', 17:00:07 INFO - 'SHLVL': '1', 17:00:07 INFO - 'TERM': 'linux', 17:00:07 INFO - 'TMOUT': '86400', 17:00:07 INFO - 'USER': 'cltbld', 17:00:07 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452560327.928548-85019509', 17:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:07 INFO - '_': '/tools/buildbot/bin/python'} 17:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:08 INFO - Downloading/unpacking psutil>=0.7.1 17:00:08 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 17:00:08 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 17:00:08 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 17:00:08 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 17:00:08 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 17:00:08 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 17:00:09 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 17:00:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:00:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:00:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:00:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:00:09 INFO - Installing collected packages: psutil 17:00:09 INFO - Running setup.py install for psutil 17:00:09 INFO - building 'psutil._psutil_linux' extension 17:00:09 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 17:00:10 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 17:00:10 INFO - building 'psutil._psutil_posix' extension 17:00:10 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 17:00:10 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 17:00:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:00:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:00:10 INFO - Successfully installed psutil 17:00:10 INFO - Cleaning up... 17:00:10 INFO - Return code: 0 17:00:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6e7f4a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1461560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0740>, '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 0x14f1640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f1af0>, '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': '41bf3e9aed84707956354da8000001c5-1452560327.928548-85019509', '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 17:00:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 17:00:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:00:10 INFO - Using env: {'DISPLAY': ':0', 17:00:10 INFO - 'HOME': '/home/cltbld', 17:00:10 INFO - 'LANG': 'en_US.UTF-8', 17:00:10 INFO - 'LANGUAGE': 'en_US:en', 17:00:10 INFO - 'LOGNAME': 'cltbld', 17:00:10 INFO - 'MAIL': '/var/mail/cltbld', 17:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:10 INFO - 'MOZ_NO_REMOTE': '1', 17:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:10 INFO - 'NO_EM_RESTART': '1', 17:00:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:10 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:10 INFO - 'SHELL': '/bin/bash', 17:00:10 INFO - 'SHLVL': '1', 17:00:10 INFO - 'TERM': 'linux', 17:00:10 INFO - 'TMOUT': '86400', 17:00:10 INFO - 'USER': 'cltbld', 17:00:10 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452560327.928548-85019509', 17:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:10 INFO - '_': '/tools/buildbot/bin/python'} 17:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:00:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:00:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:00:12 INFO - Installing collected packages: mozsystemmonitor 17:00:12 INFO - Running setup.py install for mozsystemmonitor 17:00:12 INFO - Successfully installed mozsystemmonitor 17:00:12 INFO - Cleaning up... 17:00:12 INFO - Return code: 0 17:00:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:00:12 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')]} 17:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:12 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')]} 17:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:12 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 0x7f6e7f4a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1461560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0740>, '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 0x14f1640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f1af0>, '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': '41bf3e9aed84707956354da8000001c5-1452560327.928548-85019509', '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 17:00:12 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 17:00:12 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 17:00:12 INFO - Using env: {'DISPLAY': ':0', 17:00:12 INFO - 'HOME': '/home/cltbld', 17:00:12 INFO - 'LANG': 'en_US.UTF-8', 17:00:12 INFO - 'LANGUAGE': 'en_US:en', 17:00:12 INFO - 'LOGNAME': 'cltbld', 17:00:12 INFO - 'MAIL': '/var/mail/cltbld', 17:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:12 INFO - 'MOZ_NO_REMOTE': '1', 17:00:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:12 INFO - 'NO_EM_RESTART': '1', 17:00:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:12 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:12 INFO - 'SHELL': '/bin/bash', 17:00:12 INFO - 'SHLVL': '1', 17:00:12 INFO - 'TERM': 'linux', 17:00:12 INFO - 'TMOUT': '86400', 17:00:12 INFO - 'USER': 'cltbld', 17:00:12 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452560327.928548-85019509', 17:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:12 INFO - '_': '/tools/buildbot/bin/python'} 17:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:12 INFO - Downloading/unpacking blobuploader==1.2.4 17:00: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 17:00: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 17:00: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 17:00: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 17:00: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 17:00: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 17:00:14 INFO - Downloading blobuploader-1.2.4.tar.gz 17:00:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:00:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:00:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:00: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 17:00: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 17:00: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 17:00: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 17:00: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 17:00: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 17:00:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:00:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:00:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:00: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 17:00: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 17:00: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 17:00: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 17:00: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 17:00: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 17:00:15 INFO - Downloading docopt-0.6.1.tar.gz 17:00:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:00:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:00:15 INFO - Installing collected packages: blobuploader, requests, docopt 17:00:15 INFO - Running setup.py install for blobuploader 17:00:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:00:15 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:00:15 INFO - Running setup.py install for requests 17:00:15 INFO - Running setup.py install for docopt 17:00:15 INFO - Successfully installed blobuploader requests docopt 17:00:15 INFO - Cleaning up... 17:00:15 INFO - Return code: 0 17:00:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:15 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 0x7f6e7f4a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1461560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0740>, '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 0x14f1640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f1af0>, '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': '41bf3e9aed84707956354da8000001c5-1452560327.928548-85019509', '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 17:00:15 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 17:00:15 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 17:00:15 INFO - Using env: {'DISPLAY': ':0', 17:00:15 INFO - 'HOME': '/home/cltbld', 17:00:15 INFO - 'LANG': 'en_US.UTF-8', 17:00:15 INFO - 'LANGUAGE': 'en_US:en', 17:00:15 INFO - 'LOGNAME': 'cltbld', 17:00:15 INFO - 'MAIL': '/var/mail/cltbld', 17:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:15 INFO - 'MOZ_NO_REMOTE': '1', 17:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:15 INFO - 'NO_EM_RESTART': '1', 17:00:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:15 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:15 INFO - 'SHELL': '/bin/bash', 17:00:15 INFO - 'SHLVL': '1', 17:00:15 INFO - 'TERM': 'linux', 17:00:15 INFO - 'TMOUT': '86400', 17:00:15 INFO - 'USER': 'cltbld', 17:00:15 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452560327.928548-85019509', 17:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:15 INFO - '_': '/tools/buildbot/bin/python'} 17:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:00:16 INFO - Running setup.py (path:/tmp/pip-NDzYcO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:00:16 INFO - Running setup.py (path:/tmp/pip-tF1J7n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:00:16 INFO - Running setup.py (path:/tmp/pip-sKwOnM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:00:16 INFO - Running setup.py (path:/tmp/pip-HK6V4r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:00:16 INFO - Running setup.py (path:/tmp/pip-2AxM19-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:00:16 INFO - Running setup.py (path:/tmp/pip-wMMpyt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:00:16 INFO - Running setup.py (path:/tmp/pip-ZVPfjX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:00:16 INFO - Running setup.py (path:/tmp/pip-yyAvKM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:00:16 INFO - Running setup.py (path:/tmp/pip-_l2lMr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:00:16 INFO - Running setup.py (path:/tmp/pip-o_alGF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:00:16 INFO - Running setup.py (path:/tmp/pip-EaRqNn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:00:16 INFO - Running setup.py (path:/tmp/pip-bN00Qm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:00:16 INFO - Running setup.py (path:/tmp/pip-IoL9kt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:00:16 INFO - Running setup.py (path:/tmp/pip-qYuler-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:00:16 INFO - Running setup.py (path:/tmp/pip-evNkpl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:00:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:00:17 INFO - Running setup.py (path:/tmp/pip-qWNjLW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:00:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:00:17 INFO - Running setup.py (path:/tmp/pip-6NbWWE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:00:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:00:17 INFO - Running setup.py install for manifestparser 17:00:17 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:00:17 INFO - Running setup.py install for mozcrash 17:00:17 INFO - Running setup.py install for mozdebug 17:00:17 INFO - Running setup.py install for mozdevice 17:00:17 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:00:17 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:00:17 INFO - Running setup.py install for mozfile 17:00:17 INFO - Running setup.py install for mozhttpd 17:00:17 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:00:17 INFO - Running setup.py install for mozinfo 17:00:17 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:00:17 INFO - Running setup.py install for mozInstall 17:00:17 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:00:17 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:00:17 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:00:17 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:00:18 INFO - Running setup.py install for mozleak 17:00:18 INFO - Running setup.py install for mozlog 17:00:18 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:00:18 INFO - Running setup.py install for moznetwork 17:00:18 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:00:18 INFO - Running setup.py install for mozprocess 17:00:18 INFO - Running setup.py install for mozprofile 17:00:18 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:00:18 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:00:18 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:00:18 INFO - Running setup.py install for mozrunner 17:00:18 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:00:18 INFO - Running setup.py install for mozscreenshot 17:00:18 INFO - Running setup.py install for moztest 17:00:18 INFO - Running setup.py install for mozversion 17:00:18 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:00:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:00:18 INFO - Cleaning up... 17:00:18 INFO - Return code: 0 17:00:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:18 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 0x7f6e7f4a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1461560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0740>, '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 0x14f1640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f1af0>, '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': '41bf3e9aed84707956354da8000001c5-1452560327.928548-85019509', '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 17:00:18 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 17:00:18 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 17:00:18 INFO - Using env: {'DISPLAY': ':0', 17:00:18 INFO - 'HOME': '/home/cltbld', 17:00:18 INFO - 'LANG': 'en_US.UTF-8', 17:00:18 INFO - 'LANGUAGE': 'en_US:en', 17:00:18 INFO - 'LOGNAME': 'cltbld', 17:00:18 INFO - 'MAIL': '/var/mail/cltbld', 17:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:18 INFO - 'MOZ_NO_REMOTE': '1', 17:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:18 INFO - 'NO_EM_RESTART': '1', 17:00:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:18 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:18 INFO - 'SHELL': '/bin/bash', 17:00:18 INFO - 'SHLVL': '1', 17:00:18 INFO - 'TERM': 'linux', 17:00:18 INFO - 'TMOUT': '86400', 17:00:18 INFO - 'USER': 'cltbld', 17:00:18 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452560327.928548-85019509', 17:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:18 INFO - '_': '/tools/buildbot/bin/python'} 17:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:00:19 INFO - Running setup.py (path:/tmp/pip-ynxRpM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:00:19 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)) 17:00:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:00:19 INFO - Running setup.py (path:/tmp/pip-sNbzih-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:00:19 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)) 17:00:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:00:19 INFO - Running setup.py (path:/tmp/pip-6QpTUF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:00:19 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)) 17:00:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:00:19 INFO - Running setup.py (path:/tmp/pip-EOnpgW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:00:19 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)) 17:00:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:00:19 INFO - Running setup.py (path:/tmp/pip-HQkaHv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:00:19 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)) 17:00:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:00:19 INFO - Running setup.py (path:/tmp/pip-wZiPTL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:00:19 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)) 17:00:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:00:19 INFO - Running setup.py (path:/tmp/pip-dM837F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:00:19 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)) 17:00:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:00:19 INFO - Running setup.py (path:/tmp/pip-94WwrC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:00:19 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)) 17:00:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:00:19 INFO - Running setup.py (path:/tmp/pip-SEK6Ww-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:00:19 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)) 17:00:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:00:19 INFO - Running setup.py (path:/tmp/pip-7gOVwZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:00:19 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)) 17:00:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:00:19 INFO - Running setup.py (path:/tmp/pip-D09Nb2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:00:19 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)) 17:00:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:00:19 INFO - Running setup.py (path:/tmp/pip-kYGO_H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:00:20 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)) 17:00:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:00:20 INFO - Running setup.py (path:/tmp/pip-rS0zKO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:00:20 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)) 17:00:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:00:20 INFO - Running setup.py (path:/tmp/pip-Z1ZmVM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:00:20 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)) 17:00:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:00:20 INFO - Running setup.py (path:/tmp/pip-P_B448-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:00:20 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)) 17:00:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:00:20 INFO - Running setup.py (path:/tmp/pip-rX2p9g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:00:20 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)) 17:00:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:00:20 INFO - Running setup.py (path:/tmp/pip-rXQXTb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:00:20 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)) 17:00:20 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)) 17:00:20 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)) 17:00:20 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)) 17:00:20 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)) 17:00:20 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)) 17:00:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:00:20 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 17:00:20 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 17:00:20 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 17:00:20 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 17:00:20 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 17:00:20 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 17:00:22 INFO - Downloading blessings-1.5.1.tar.gz 17:00:22 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 17:00:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:00:22 INFO - Installing collected packages: blessings 17:00:22 INFO - Running setup.py install for blessings 17:00:22 INFO - Successfully installed blessings 17:00:22 INFO - Cleaning up... 17:00:22 INFO - Return code: 0 17:00:22 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:00:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:00:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:00:22 INFO - Reading from file tmpfile_stdout 17:00:22 INFO - Current package versions: 17:00:22 INFO - argparse == 1.2.1 17:00:22 INFO - blessings == 1.5.1 17:00:22 INFO - blobuploader == 1.2.4 17:00:22 INFO - docopt == 0.6.1 17:00:22 INFO - manifestparser == 1.1 17:00:22 INFO - mozInstall == 1.12 17:00:22 INFO - mozcrash == 0.16 17:00:22 INFO - mozdebug == 0.1 17:00:22 INFO - mozdevice == 0.47 17:00:22 INFO - mozfile == 1.2 17:00:22 INFO - mozhttpd == 0.7 17:00:22 INFO - mozinfo == 0.9 17:00:22 INFO - mozleak == 0.1 17:00:22 INFO - mozlog == 3.1 17:00:22 INFO - moznetwork == 0.27 17:00:22 INFO - mozprocess == 0.22 17:00:22 INFO - mozprofile == 0.28 17:00:22 INFO - mozrunner == 6.11 17:00:22 INFO - mozscreenshot == 0.1 17:00:22 INFO - mozsystemmonitor == 0.0 17:00:22 INFO - moztest == 0.7 17:00:22 INFO - mozversion == 1.4 17:00:22 INFO - psutil == 3.1.1 17:00:22 INFO - requests == 1.2.3 17:00:22 INFO - wsgiref == 0.1.2 17:00:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f6e7f4a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1461560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0740>, '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 0x14f1640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f1af0>, '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': '41bf3e9aed84707956354da8000001c5-1452560327.928548-85019509', '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 17:00:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 17:00:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 17:00:22 INFO - Using env: {'DISPLAY': ':0', 17:00:22 INFO - 'HOME': '/home/cltbld', 17:00:22 INFO - 'LANG': 'en_US.UTF-8', 17:00:22 INFO - 'LANGUAGE': 'en_US:en', 17:00:22 INFO - 'LOGNAME': 'cltbld', 17:00:22 INFO - 'MAIL': '/var/mail/cltbld', 17:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:22 INFO - 'MOZ_NO_REMOTE': '1', 17:00:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:22 INFO - 'NO_EM_RESTART': '1', 17:00:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:22 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:22 INFO - 'SHELL': '/bin/bash', 17:00:22 INFO - 'SHLVL': '1', 17:00:22 INFO - 'TERM': 'linux', 17:00:22 INFO - 'TMOUT': '86400', 17:00:22 INFO - 'USER': 'cltbld', 17:00:22 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452560327.928548-85019509', 17:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:22 INFO - '_': '/tools/buildbot/bin/python'} 17:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:22 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)) 17:00:22 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)) 17:00:22 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)) 17:00:22 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)) 17:00:22 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)) 17:00:22 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)) 17:00:22 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)) 17:00:22 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)) 17:00:22 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)) 17:00:22 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)) 17:00:22 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)) 17:00:22 INFO - Cleaning up... 17:00:22 INFO - Return code: 0 17:00:22 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f6e7f4a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1461560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0740>, '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 0x14f1640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f1af0>, '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': '41bf3e9aed84707956354da8000001c5-1452560327.928548-85019509', '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 17:00:22 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 17:00:22 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 17:00:22 INFO - Using env: {'DISPLAY': ':0', 17:00:22 INFO - 'HOME': '/home/cltbld', 17:00:22 INFO - 'LANG': 'en_US.UTF-8', 17:00:22 INFO - 'LANGUAGE': 'en_US:en', 17:00:22 INFO - 'LOGNAME': 'cltbld', 17:00:22 INFO - 'MAIL': '/var/mail/cltbld', 17:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:22 INFO - 'MOZ_NO_REMOTE': '1', 17:00:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:22 INFO - 'NO_EM_RESTART': '1', 17:00:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:22 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:22 INFO - 'SHELL': '/bin/bash', 17:00:22 INFO - 'SHLVL': '1', 17:00:22 INFO - 'TERM': 'linux', 17:00:22 INFO - 'TMOUT': '86400', 17:00:22 INFO - 'USER': 'cltbld', 17:00:22 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452560327.928548-85019509', 17:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:22 INFO - '_': '/tools/buildbot/bin/python'} 17:00:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:23 INFO - Downloading/unpacking jsonschema 17:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:00:24 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 17:00:24 INFO - Downloading/unpacking functools32 (from jsonschema) 17:00:24 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 17:00:24 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 17:00:24 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 17:00:24 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 17:00:24 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 17:00:24 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 17:00:24 INFO - Downloading functools32-3.2.3-2.tar.gz 17:00:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 17:00:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:00:24 INFO - warning: no files found matching '*.txt' 17:00:24 INFO - no previously-included directories found matching 'build' 17:00:24 INFO - no previously-included directories found matching 'dist' 17:00:24 INFO - no previously-included directories found matching '.git*' 17:00:25 INFO - Installing collected packages: jsonschema, functools32 17:00:25 INFO - Running setup.py install for functools32 17:00:25 INFO - warning: no files found matching '*.txt' 17:00:25 INFO - no previously-included directories found matching 'build' 17:00:25 INFO - no previously-included directories found matching 'dist' 17:00:25 INFO - no previously-included directories found matching '.git*' 17:00:25 INFO - Successfully installed jsonschema functools32 17:00:25 INFO - Cleaning up... 17:00:25 INFO - Return code: 0 17:00:25 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6e7f4a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1461560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0740>, '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 0x14f1640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f1af0>, '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': '41bf3e9aed84707956354da8000001c5-1452560327.928548-85019509', '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 17:00:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 17:00:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:00:25 INFO - Using env: {'DISPLAY': ':0', 17:00:25 INFO - 'HOME': '/home/cltbld', 17:00:25 INFO - 'LANG': 'en_US.UTF-8', 17:00:25 INFO - 'LANGUAGE': 'en_US:en', 17:00:25 INFO - 'LOGNAME': 'cltbld', 17:00:25 INFO - 'MAIL': '/var/mail/cltbld', 17:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:25 INFO - 'MOZ_NO_REMOTE': '1', 17:00:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:25 INFO - 'NO_EM_RESTART': '1', 17:00:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:25 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:25 INFO - 'SHELL': '/bin/bash', 17:00:25 INFO - 'SHLVL': '1', 17:00:25 INFO - 'TERM': 'linux', 17:00:25 INFO - 'TMOUT': '86400', 17:00:25 INFO - 'USER': 'cltbld', 17:00:25 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452560327.928548-85019509', 17:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:25 INFO - '_': '/tools/buildbot/bin/python'} 17:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:25 INFO - Downloading/unpacking flake8 17:00:25 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 17:00:25 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 17:00:25 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 17:00:25 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 17:00:25 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 17:00:25 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 17:00:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:00:27 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 17:00:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:00:27 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 17:00:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:27 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 17:00:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:00:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:00:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:00:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:00:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:00:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:00:27 INFO - no previously-included directories found matching 'docs/_build' 17:00:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:00:27 INFO - Running setup.py install for pep8 17:00:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:00:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:00:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:00:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:00:27 INFO - no previously-included directories found matching 'docs/_build' 17:00:27 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:00:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:00:27 INFO - Cleaning up... 17:00:28 INFO - Return code: 0 17:00:28 INFO - Running post-action listener: _resource_record_post_action 17:00:28 INFO - Running post-action listener: _start_resource_monitoring 17:00:28 INFO - Starting resource monitoring. 17:00:28 INFO - ##### 17:00:28 INFO - ##### Running install step. 17:00:28 INFO - ##### 17:00:28 INFO - Running pre-action listener: _resource_record_pre_action 17:00:28 INFO - Running main action method: install 17:00:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:00:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:00:28 INFO - Reading from file tmpfile_stdout 17:00:28 INFO - Detecting whether we're running mozinstall >=1.0... 17:00:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:00:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:00:28 INFO - Reading from file tmpfile_stdout 17:00:28 INFO - Output received: 17:00:28 INFO - Usage: mozinstall [options] installer 17:00:28 INFO - Options: 17:00:28 INFO - -h, --help show this help message and exit 17:00:28 INFO - -d DEST, --destination=DEST 17:00:28 INFO - Directory to install application into. [default: 17:00:28 INFO - "/builds/slave/test-pgo"] 17:00:28 INFO - --app=APP Application being installed. [default: firefox] 17:00:28 INFO - mkdir: /builds/slave/test-pgo/build/application 17:00:28 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'] 17:00:28 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 17:00:44 INFO - Reading from file tmpfile_stdout 17:00:44 INFO - Output received: 17:00:44 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:00:44 INFO - Running post-action listener: _resource_record_post_action 17:00:44 INFO - ##### 17:00:44 INFO - ##### Running run-tests step. 17:00:44 INFO - ##### 17:00:44 INFO - Running pre-action listener: _resource_record_pre_action 17:00:44 INFO - Running main action method: run_tests 17:00:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:00:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:00:44 INFO - Python 2.7.3 17:00:44 INFO - Return code: 0 17:00:44 INFO - grabbing minidump binary from tooltool 17:00: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')]} 17:00:44 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 0x14f0740>, '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 0x14f1640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f1af0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:00:44 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 17:00:44 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 17:00:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:00:44 INFO - Return code: 0 17:00:44 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:00:44 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:00:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:00:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:00:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:00:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:00:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:00:45 INFO - Return code: 0 17:00:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RIkQWdUHSiGyg3jOyqyUaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 17:00:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RIkQWdUHSiGyg3jOyqyUaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 17:00:45 INFO - Using env: {'DISPLAY': ':0', 17:00:45 INFO - 'HOME': '/home/cltbld', 17:00:45 INFO - 'LANG': 'en_US.UTF-8', 17:00:45 INFO - 'LANGUAGE': 'en_US:en', 17:00:45 INFO - 'LOGNAME': 'cltbld', 17:00:45 INFO - 'MAIL': '/var/mail/cltbld', 17:00:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:00:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:00:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:45 INFO - 'MOZ_NO_REMOTE': '1', 17:00:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:00:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:45 INFO - 'NO_EM_RESTART': '1', 17:00:45 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:45 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:45 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:00:45 INFO - 'SHELL': '/bin/bash', 17:00:45 INFO - 'SHLVL': '1', 17:00:45 INFO - 'TERM': 'linux', 17:00:45 INFO - 'TMOUT': '86400', 17:00:45 INFO - 'USER': 'cltbld', 17:00:45 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452560327.928548-85019509', 17:00:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:45 INFO - '_': '/tools/buildbot/bin/python'} 17:00:45 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RIkQWdUHSiGyg3jOyqyUaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:00:45 INFO - mozversion application_buildid: 20160111143012 17:00:45 INFO - mozversion application_changeset: 08d1d3f7266007e2492a77d579ae3f3008c51dfc 17:00:45 INFO - mozversion application_display_name: Nightly 17:00:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:00:45 INFO - mozversion application_name: Firefox 17:00:45 INFO - mozversion application_remotingname: firefox 17:00:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:00:45 INFO - mozversion application_vendor: Mozilla 17:00:45 INFO - mozversion application_version: 46.0a1 17:00:45 INFO - mozversion platform_buildid: 20160111143012 17:00:45 INFO - mozversion platform_changeset: 08d1d3f7266007e2492a77d579ae3f3008c51dfc 17:00:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:00:45 INFO - mozversion platform_version: 46.0a1 17:00:45 INFO - using testdate: 1452560445 17:00:45 INFO - actual date: 1452560445 17:00:45 INFO - starting webserver on 'localhost:34251' 17:00:45 INFO - SUITE-START | Running 3 tests 17:00:45 INFO - TEST-START | dromaeo_css 17:00:45 INFO - operating with platform_type : linux_ 17:00:45 INFO - Initialising browser for dromaeo_css test... 17:00:45 INFO - TEST-INFO | started process 27373 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRHMY6B/profile http://localhost:34251/getInfo.html) 17:00:49 INFO - PROCESS | 27373 | __metrics Screen width/height:1600/1200 17:00:49 INFO - PROCESS | 27373 | colorDepth:24 17:00:49 INFO - PROCESS | 27373 | Browser inner width/height: 1024/697 17:00:49 INFO - PROCESS | 27373 | __metrics 17:00:49 INFO - PROCESS | 27373 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:00:49 INFO - PROCESS | 27373 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:00:50 INFO - TEST-INFO | 27373: exit 0 17:00:50 INFO - Browser initialized. 17:00:50 INFO - Running cycle 1/1 for dromaeo_css test... 17:00:50 INFO - TEST-INFO | started process 27468 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRHMY6B/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:01:02 INFO - PROCESS | 27468 | RSS: Main: 148418560 17:01:02 INFO - PROCESS | 27468 | 17:01:53 INFO - PROCESS | 27468 | 1452560513581 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] 17:04:02 INFO - PROCESS | 27468 | Cycle 1(1): loaded http://localhost:34251/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34251/tests/dromaeo/cssquery-ext.html) 17:04:03 INFO - PROCESS | 27468 | RSS: Main: 238022656 17:04:03 INFO - PROCESS | 27468 | 17:07:05 INFO - PROCESS | 27468 | Cycle 1(1): loaded http://localhost:34251/tests/dromaeo/cssquery-ext.html (next: http://localhost:34251/tests/dromaeo/cssquery-jquery.html) 17:07:05 INFO - PROCESS | 27468 | RSS: Main: 234237952 17:07:05 INFO - PROCESS | 27468 | 17:10:07 INFO - PROCESS | 27468 | Cycle 1(1): loaded http://localhost:34251/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34251/tests/dromaeo/cssquery-mootools.html) 17:10:08 INFO - PROCESS | 27468 | RSS: Main: 245403648 17:10:08 INFO - PROCESS | 27468 | 17:13:10 INFO - PROCESS | 27468 | Cycle 1(1): loaded http://localhost:34251/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34251/tests/dromaeo/cssquery-prototype.html) 17:13:10 INFO - PROCESS | 27468 | RSS: Main: 207826944 17:13:10 INFO - PROCESS | 27468 | 17:16:13 INFO - PROCESS | 27468 | Cycle 1(1): loaded http://localhost:34251/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34251/tests/dromaeo/cssquery-yui.html) 17:16:13 INFO - PROCESS | 27468 | RSS: Main: 212811776 17:16:13 INFO - PROCESS | 27468 | 17:19:16 INFO - PROCESS | 27468 | Cycle 1(1): loaded http://localhost:34251/tests/dromaeo/cssquery-yui.html (next: http://localhost:34251/tests/dromaeo/cssquery-dojo.html) 17:19:16 INFO - PROCESS | 27468 | RSS: Main: 287531008 17:19:16 INFO - PROCESS | 27468 | 17:19:16 INFO - PROCESS | 27468 | __start_tp_report 17:19:16 INFO - PROCESS | 27468 | _x_x_mozilla_page_load 17:19:16 INFO - PROCESS | 27468 | _x_x_mozilla_page_load_details 17:19:16 INFO - PROCESS | 27468 | |i|pagename|runs| 17:19:16 INFO - PROCESS | 27468 | |0;dojo.html;3114.7663925205607;3176.571162893009;3213.180638937071;3222.854971526281;3243.0270918724386;5040.798368065282;5161.225816127583;5239.1617341225365;5284.075286824809;5336.839894803157;5162.690238585687;5192.818251361203;5200.713960732158;5210.452902445246;5252.159654455288;4726.291056341551;4746.406699162605;4762.238041913294;4832.202686556714;4854.393200849894;528.6288661900114;4651.604613607848;4779.80880764769;4790.952090479085;4822.035592881421;4623.79192936317;4682.719036857782;4691.695039822401;4713.1516327060945;4722.480527142012;4653.232216684243;4660.4174478190225;4660.790264438108;4663.417072865892;4698.859034228979;4621.768911554409;4669.463011753658;4687.95312046882;4734.502877197879;4736.3369128322065;5053.69677819332;5112.539871411591;5125.743712814382;5140.768665410065;5162.1224391853475;5554.222408862763;5564.10974244123;5574.581906356999;5574.944250557523;5608.775648974036;5479.04116779562;5569.610127291091;5588.804391846266;5621.634593751393;5641.746121424546;5126.794928202868;5223.608229382773;5225.503577160163;5227.8170264040955;5240.8470136569895;5748.942510574924;5775.913361299584;5776.624519406309;5776.653400795965;5779.942200578024;5441.918371224435;5462.262594549765;5524.06090964537;5544.833654990357;5566.916496252559;5672.8865422691315;5682.488576028178;5684.63049901755;5691.402402747734;5704.971475142598;5587.552995760329;5636.436356364331;5642.04085305499;5643.717814109278;5645.125005624135;5371.704556249366;5384.138537833927;5479.205515200353;5557.305336832896;5615.438456154352;4364.934525982113;4369.890752731144;4391.626711729475;4411.897025743564;4412.382266482695;3914.530256369254;3915.314819906505;3918.6669133123432;3918.8824335269987;3922.0194951262183;5121.231815227671;5207.297014903015;5208.7916483341;5209.843704688866;5236.345456817898;5653.434656534314;5676.716164191774;5680.801171958961;5687.976164290385;5690.77236910519;5218.191180367049;5239.711815850165;5255.947440525622;5257.605679574047;5300.072487314705;4612.815487380534;4718.693284936468;4748.786304616231;4794.041191761662;4854.393200849894;5652.74562644682;5707.200991861143;5709.172170035322;5709.229254050733;5717.342505611825;5482.150266708666;5524.779008839762;5525.171224316385;5532.197831314517;5580.051391263414;5539.8892022158525;5556.16657501378;5617.297837770278;5678.034734095297;5720.456556627114;5536.889262214814;5538.058530049821;5538.8061417851795;5539;5549.223108764857;5458.972705136608;5608.887822243614;5615.157726341082;5615.719214039364;5618;5289.629725919149;5433.9456605435025;5487.972560137334;5488.1493368527945;5533.695646739468;5470.562355011669;5481.260029896072;5482.369527504388;5482.753276102665;5484.451554844483;5231.686098834082;5319.574434045345;5375.838724838261;5384.623076384615;5442.401335853132;5378.542823860016;5386.8383948481605;5415.296011518478;5443.455654434525;5465.344158700981;5298.046351656739;5327;5330.173823057432;5331.5201631853315;5337.653052551572 17:19:16 INFO - PROCESS | 27468 | |1;ext.html;508.01698712990344;524.2267655208566;527.8495628745807;538.5772168847453;553.3581045986654;27946.30134246645;28537;35810.283794324096;36015.4597681035;36047.4592881107;38951.41572876402;39445.40831887517;39489.605103948954;39493.605063949355;39508.80245598775;7351.301626345488;7444.330010299072;8593.22660960515;8865.734027979172;8872.334574906876;10086.798264034715;10247.641332553361;10302;10337.896621033806;10337.948310258476;9814.607415703364;9906.20750339971;9913.206943444544;9921.817200215977;9931;9906.702798916043;9998.05018523239;10007.349522281065;10009.049140331657;10013.198944084492;9876.160526355268;10009.798824141077;10021.89978100217;10316.845247321296;10316.948415257952;38752.80623596892;39250;39259.214815703526;39287.4106888394;39324.41013384802;2989.312458134641;3033.893813716509;3042.3458956324275;3068.9079327620207;3183.8885639002756;29810.85094574535;29888.114545108998;30426.239344016354;30620.693793062008;30904;3843.442700808367;3923.431102490123;3950.8222130003933;3997.1805779815068;4003.219372222418;249015;249788;249829;250252;252354;51003.744981275595;58514.70742646259;58818.7059064702;58849.41150588525;58884;45599.31601025987;59947.400525994184;60840;61162;61180.69409652923;14526.854731452762;14763.557093287218;14788.852111478747;14903.850961490247;14966.476173333882;11328.660140195807;11361.772764544663;11367.886321136682;11371.260868043551;11379.94310028461;18361.908190459228;18444.446666600023;18565.44303670892;18573.628527429377;19272.421827345202;7622.8094297643;7722.652480638272;7745.605790957682;7809.609519524115;7941.483803552751;885.5749240364532;892.4154678685471;930.1303281431883;1043.838205078214;1053.1785207538132;23723;25874;25965.22104336835;26107.869460652575;27840.8607956963;978.7699890525721;1000.849872519128;1011.0849681038525;1024.8718910136233;1096.6655170173015;13430.597082087554;13494.52769153075;13599.116057456235;13620.455181792815;13695.794563081561;339833;342975;344186;345652;345992;50619.493805062215;50708.74645626748;50896;50907.49092509101;50963.490365096615;1332.460353556811;1339.8660133986523;1357.8845798107272;1358.1443690475135;1361.8365796104333;24173.51652966966;24444.266671999867;25720.614190787528;26186.345341365857;28384.432311353245;41333.79333103436;41856.79071604623;41868.162636746485;41905.58094419139;41918.58081419269;216866;218091;219143;219490;219882.61408631067;26075.217743467725;27363;27754.167374977977;27760.583591245744;27880;33295.50056749199;34806.127142199606;35327.293454131286;35674.8216258917;35978.10054748652;32237;33635.831820840736;34812.65187348094;35155.47266790949;35237.295254094264;33824;34342.48486272758;34567.4814877772;34765.65234347624;34795.30409391849;33539.32921341608;33782;34301.313973720884;34346.48480272848;34387.14032149216;28598.285042874093;29893.70106298909;32155.35689286248;34623.480647790806;35133.648663513035;23665.40271187825;24078;24105;24282.15012474555;24323.63514547248 17:19:16 INFO - PROCESS | 27468 | |2;jquery.html;348.0984250790454;353.9433690609502;357.3442732585705;360.4863070125071;361.5227899173092;13480.460781568725;13570.660733481667;16897.408590699328;16968.660626787474;17764.11179441029;14749.262536873168;15359.69280614387;15587.376504939817;15590.766138507932;16350.182490875468;5250.527452529272;5420.4850539198915;5436.048691478995;5446.319210098738;5446.91829622556;3986.4618276532588;4076.6331030207275;5340.732963351837;5424.83725488236;5711.571632127586;5604.1593760935775;5847.590668653196;5900.203472531218;5905.173275741399;5906.3798301178185;5759.769609215627;5760.56795740319;5813.09896965971;5819.7963071292725;5829.271341082364;4978.5270399312;5087.669301495428;5091.083604951107;5207.6875387476875;5212.973935130338;19503.609927801364;19625.705614415794;19789.80210197894;19798;19868.80131198684;2015.3752336775499;2039.1027947703112;2104.074207348762;2153.332466935255;2664.3205982474537;12254.877451225462;12656.240625562496;12674.36628168597;12916.87083129166;13030.478780848754;1788.7853457585043;1801.351513455155;1814.7368631548352;1819.9363022294287;1852.8795628284117;51589;53748;53868.191977120376;53999.46000539984;54034;8877.112288771072;8944.68693595721;9094.136057074567;9155.679551215675;9157.77105572366;11801.52793888235;11831.408429578487;11840.407979600985;11854.288742675468;11860.584879529175;7192.7122915083855;7235.312645298688;7275.563466192046;7334.3765779908235;7380.114386273682;7207.5675459472595;7212.783616491513;7241.5293005954445;7293.307135822089;7295.452841036943;5635.605507614509;5697.686627235542;5745.425457454305;5762.942370576325;5913.349531551526;1524.3750062474332;1585.326236349547;1614.136437006196;1684.3010150787286;1750.7723995880453;868.68727258187;903.0698380667923;906.5784410249134;915.9313051521029;984.8424252119627;15436.768448473282;15467.845321546865;15575.532734017997;16211.313231996013;16698.916505417394;869.1621854644591;901.1664210605295;910.0717268386209;997.3716558568201;1023.22746326523;8700.695475658322;8811.823763524693;8894.911050889537;9058.094190580889;9181.403208791407;257390;260096;287437;369284;373094.7488413245;64072;69733.3026669737;72879;77617.22382776212;80205.19794802094;500.46450298181327;513.6994858008032;515.3120584020375;518.9740512974336;519.6232731269723;9759.36564123358;10097.19222462216;10114.747131321481;10312.845307320245;10533.631322903662;32051.67948320487;33129.337413252084;33558.832205838815;33606.831965840014;34334.65665343314;41667.58332416759;41672.37491437692;42668;42795.14409711851;45139.77430112829;7105.32499412555;7451.850962980601;7470.2903224193615;7546.320831125225;7624.733134340271;10587.947060264649;11212.103031757602;11226.719332016764;11427.200095993201;11490.82763758561;8391.16088391156;9330.206932410549;9484.430934143973;9765.85351219718;10105.89894101079;9531.142197202285;9621.08599683029;9633.9036609633;9736;9749.56126974302;9798.118169364792;9912.530614285231;9984.301098923006;10020.549075291776;10349.689509314732;7262.709491620276;7414.888776668462;7466.925330746841;7651.808704782202;7710.11333696632;9566.282528810229;10067.546960386946;10095.646652367132;10281.228907832092;10307.433091180057 17:19:16 INFO - PROCESS | 27468 | |3;mootools.html;1320.702841860581;1453.6075259679887;1470.7279153356626;1607.1883698732138;1766.840984311411;6969.895451568231;7432.9256707432905;7509.924900750991;7577;7582.128055273645;7351.595662238575;7482.96258518708;7527.3601743851705;7527.397808175347;7529.924700752991;1921.9423417297503;1958.9706154407695;2125.872447653138;2214.092222188907;2235.4299653588314;2175.4778853075227;2177.912883484659;2179.030331502482;2179.302623160589;2179.9564008719894;2136.177571634924;2218.866867987918;2220.167437211046;2221.688963545105;2225.688403623494;2153.214076861942;2169.4793249620134;2176.0534167637047;2202.50443650179;2207.9668804967937;2186.10369748404;2199.2412617646887;2225.2879078694823;2225.5993921094196;2228.476308067603;7728.729494467723;7780.066392032935;7785.961070194669;7788.415868809862;7796.4932279401655;4549.24937385331;4717.481077081518;4739.668223224376;4744.620430365562;4760.523947605247;2970.8217506949654;3029.2578318312153;3058.5870907427434;3076.09255269696;3113.9221519461967;952.618952419031;955.9474228917406;980.2011360741045;982.778874753182;994.383482241008;10359.171266298677;10436.112930400925;10446.529906154241;10449.373037617766;10456.738581535523;4089.7137200395687;4215.156968606291;4221.852235171754;4259.2759230930815;4272.87181384559;8684.392092553588;8949.686760963335;8959.059298773665;8960.103989600988;8983.865242021375;4807.18277892759;4812.903741925212;4835.323054772335;4842.6368022398465;4844.297576851407;4389.648828093745;4399.868003959887;4405.383246345515;4441.467023957146;4443.37792709021;3209.1335339458215;3251.837408129584;3263.738900887923;3307.5534802801794;3388.1360253135294;1030.1346868630387;1033.679559336608;1038.8441733739849;1038.9064984151312;1045.0281238448165;1181.1908842442954;1193.0694058634278;1197.7724232395817;1199.8080307150815;1218.0620921890272;7260.891086633705;7348.669309881068;7349.375303099189;7362.300581444754;7401.111866576045;1105.1269497097364;1108.5731993182683;1112.2158877990996;1115.9107271418268;1143.7140714821294;5773.422657734193;5913.940860591425;5921.585489015728;5933.851653708605;5934.940650593525;9383.62465501386;9526.142647161789;9548.236141108695;9687.17658998979;9690.37012594179;9446.811063778687;9478.857817132748;9488.573014214377;9550.61797528105;9559.091886270793;7333.2666733327305;7418.96290518544;7427.480076394709;7525.736599219001;7529.73645922401;7175.390091842252;7204.747833825791;7244.492885497964;7247;7256.7822965311125;8270.338372930271;8384.580770961305;8432.114627963976;8656.437331573428;8657.220850123267;8718.43330183536;8819.029906710384;8920.330975176757;8964.14840590143;8999.460032398078;6657.167854018247;6739.528233023641;6749.291324410866;6759.5606285591275;6763.7632682855865;6599.8020059398295;6720;6751.729930802713;7098.751543695946;7284.053073100463;6946.235914049349;7036.859262814817;7060;7112.359887609933;7138.678759455941;6639.070530125689;6783.728650853911;6857.7256909723055;6902.827429314308;7010.50926435165;6759.763408280686;6771.898421523582;6815.284395138439;6833.863322733617;6835.316468353125;6096.237970253718;6236.937630623635;6366.427021568081;6496.317886621837;6514.250861151028;6538.444232240313;6608.570442921195;6608.636524991171;6615.834604134935;6619.040239165198 17:19:16 INFO - PROCESS | 27468 | |4;prototype.html;313.7270574600098;318.4474935986065;340.5334691472683;342.35637002435425;352.4079546362111;5756.079027355624;5919.881602367956;5925;5939.85150371241;6002.129691194774;5732.7133643317875;5868.530517558595;5908.763649454017;5921.73352199151;5949.345571987089;4556.9088618227615;4568.771561421932;4571.51999040101;4576.519465456129;4576.771161441923;4401.845935392262;4493.41585593874;4576.565226303496;4580.97709511452;4583.472900616439;4473.597376236138;4504.423451791863;4543.772811359436;4545.522720114373;4546.295324224734;4522.276435770277;4535.115652447774;4539.659525535598;4550.453945526558;4557.361969324297;4049.9190016199805;4056.898577535556;4057.5739547347694;4075.6943229257627;4083.1629515949157;5543.36251331094;5651.632643878176;5652;5655.208270842086;5664.178694089375;5336.519713225828;5349.679019258857;5351.598630102719;5359.624826262163;5359.624826262163;6229.688515574203;6245.3442388549;6256.499480041586;6259.968700156515;6265.906011409833;4211.157768446323;4226.704130710851;4360.978195109036;4457.754823484707;4490.259107247301;6537.280899101095;6555.770548030796;6560.212774467047;6606.735730570819;6641.966790166067;4592.15045216636;4597.172508948354;4598.770061496979;4598.954010459919;4601.493835678073;4555.293929440942;4667.043256132485;4672.415948006499;4673.439187297478;4676.672632915731;5318.680879147263;5330.653507521999;5332.573394128461;5336.866578335573;5342.572594192456;6359.936400635935;6368.235811702532;6380.776672816522;6442.903356449657;6450.387213214831;1629.6577718678973;1634.6322077532698;1635.5911022244438;1636.1737322651984;1638.5084474657556;1096.681962230944;1106.3140852671233;1111.433169083773;1119.960801371948;1129.5425352732157;5932.2584676915385;5958.076498142795;5989.041753319535;5999.280086389661;6006.759729610767;6507.056476810836;6507.657243392375;6511.967440162769;6513.12072870166;6521.152250207443;5964.701764911824;5992.700364981821;5993.580449368503;5995.5803093783015;6009.248843894513;3406.5741782277214;3503.982480087634;3507.0530956641564;3522.471629255581;3546.0957455848593;6844.931550684529;6848.863022739517;6852.074969879102;6853.383195512428;6854.794356169323;6751.493637977172;6756.223034351113;6760.966195169091;6767.526273160832;6767.830804229835;6624;6755.49333799967;6765.932340676629;6773.153355830521;6884.965575172092;6586.341365863375;6597.9443289073515;6606.504512161511;6609.966950165219;6612.768553100618;6249.562530622813;6362.809115726535;6437.742490300523;6512.980975897487;6540.50946179029;6861.382475577222;6865.656717164222;6866.896996545156;6867.313268673092;6885.104936358442;4473.642108631367;4504.806226349954;4504.842330518416;4508.165989291861;4508.436445444319;6388.712507937061;6484.643344616092;6573;6595.637239951849;6627.701753421204;6448.226212854487;6454.838629034311;6463.127477790438;6472.288048314776;6476.838079048061;6424.164858568356;6432.099506069248;6432.517561183024;6442.194725659293;6443.581167224115;6080.3615620361;6170.352113028247;6223.284322302812;6291.716872740646;6292.024736165901;6426.132472116392;6437.7124575084235;6444.967775161094;6450.612963222222;6452;6165.84585385351;6298.275698294755;6298.401651843067;6305.369463053841;6311.053341998737 17:19:16 INFO - PROCESS | 27468 | |5;yui.html;820.9055958564765;836.9748907532776;838.6268110690737;843.6878355008648;853.9359548033899;13007.414666340013;13161.341932903364;13167.539136130237;13183.274919879426;13189.868101318983;11549.307041577511;13837.308134593255;13976.091554049006;14121.505747298846;14129.858701412983;672.8385187554976;681.0839420978775;789.7235967411403;806.2662976691212;807.769785611098;785.3403141361256;785.6386062411298;792.1326147868104;793.012699189507;793.809485723428;837.2339309531772;839.2404873589381;839.5214727605268;839.8068444257824;839.9706010289641;688.1570076656106;691.7682576336958;815.0463957170125;827.954462504562;840.0465471689646;604.7792555717175;605.4702135631322;605.7334772699998;605.9212302400659;606.2210060072786;13163.473461061547;13229.470821167142;13231.139975901631;13235.735285294337;13236;12105.394730263451;12647.747045059048;12709.872901271054;12751.234925904475;12810.679733006657;10600.893991060067;10741.355518668905;10834.241603087787;10867.29362591429;10904.61833835812;3564.9821750891338;3643.143861192618;3646.726495512847;3647.507586475845;3678.5401824771902;45195.32207016897;45776.313355299695;45822.54177458216;46131.76934115341;46312;9142.451452912846;9605.327627066039;9674.371165874196;9773.804523909483;9858.162056225301;17195.570110747332;17607.09482935327;17704;17708;17715.114244287735;7236.819079522948;7306.378473401332;7340.926590734024;7369.373603243785;7448.627568621548;3914.784686842194;3987.6211759882763;4114.753114813121;4191.97904010478;4361.9127617447475;2986;3025.1680787783534;3029.621297337833;3036.1347016100303;3038.437888990544;563.2115038945509;566.5043087298614;568.9829305120853;569.5187566506378;584.5060923519619;573.5640912906138;597.4503456819737;660.2671035150978;669.2537820330297;675.1729131813587;7810.1799311072655;8128.512289262663;8141;8157.428979971463;8224.300934420642;560.2856358143318;561.6180996922133;562.4965655738173;612.1338306296541;666.7932940788371;3520.542329497149;3597.730170237243;3637.5271214741915;3678.981605092011;3996.440498330236;54148.72925635425;54386;54416.18375724367;54699.72650136724;55747.442525574224;50316.74841625769;51063;51068.46794596168;51551.226731599054;51830;42394.78802605967;44202.778986104866;44853.55146448559;44983.77508112438;46584.767076164404;7807.531548107132;7828.921710782819;7889.723859664884;7961.084475285416;8017.959910200411;33517;33575.83212083924;34023.65976340304;34335.828320858236;34346.31307373789;41093.1781364377;43817.561824382625;44231.55768442275;44615;44867.32699009452;9296.72109836706;9370;9397.248220142508;9451.574679139592;9472.763180920532;11388.665323608475;11420.657380278604;11476.827847582459;11611.245269057485;11703.063754899758;10532.789344212919;10672.146228301872;10725.517351719036;10776.084032856981;11005.457661030754;10648.467576621293;10725.517351719036;10744;11004.559817607205;11076.11391088727;10293.639722609672;10638.62764803259;10876.075533579735;11110.666679999613;11115.110791136527;9047.230985366317;9345.766355840886;9354.625814967325;9516.95241523788;9613.663521776703;8156.469829461066;8697.739067827975;8711.56442177876;8932.508712020901;9056 17:19:16 INFO - PROCESS | 27468 | __end_tp_report 17:19:16 INFO - PROCESS | 27468 | __start_cc_report 17:19:16 INFO - PROCESS | 27468 | _x_x_mozilla_cycle_collect,736 17:19:16 INFO - PROCESS | 27468 | __end_cc_report 17:19:16 INFO - PROCESS | 27468 | __startTimestamp1452561556705__endTimestamp 17:19:16 INFO - PROCESS | 27468 | 17:19:16 INFO - PROCESS | 27468 | ------- Summary: start ------- 17:19:16 INFO - PROCESS | 27468 | Number of tests: 6 17:19:16 INFO - PROCESS | 27468 | 17:19:16 INFO - PROCESS | 27468 | [#0] dojo.html Cycles:165 Average:5154.35 Median:5337.65 stddev:665.01 (12.5%) stddev-sans-first:647.51 17:19:16 INFO - PROCESS | 27468 | Values: 3114.8 3176.6 3213.2 3222.9 3243.0 5040.8 5161.2 5239.2 5284.1 5336.8 5162.7 5192.8 5200.7 5210.5 5252.2 4726.3 4746.4 4762.2 4832.2 4854.4 528.6 4651.6 4779.8 4791.0 4822.0 4623.8 4682.7 4691.7 4713.2 4722.5 4653.2 4660.4 4660.8 4663.4 4698.9 4621.8 4669.5 4688.0 4734.5 4736.3 5053.7 5112.5 5125.7 5140.8 5162.1 5554.2 5564.1 5574.6 5574.9 5608.8 5479.0 5569.6 5588.8 5621.6 5641.7 5126.8 5223.6 5225.5 5227.8 5240.8 5748.9 5775.9 5776.6 5776.7 5779.9 5441.9 5462.3 5524.1 5544.8 5566.9 5672.9 5682.5 5684.6 5691.4 5705.0 5587.6 5636.4 5642.0 5643.7 5645.1 5371.7 5384.1 5479.2 5557.3 5615.4 4364.9 4369.9 4391.6 4411.9 4412.4 3914.5 3915.3 3918.7 3918.9 3922.0 5121.2 5207.3 5208.8 5209.8 5236.3 5653.4 5676.7 5680.8 5688.0 5690.8 5218.2 5239.7 5255.9 5257.6 5300.1 4612.8 4718.7 4748.8 4794.0 4854.4 5652.7 5707.2 5709.2 5709.2 5717.3 5482.2 5524.8 5525.2 5532.2 5580.1 5539.9 5556.2 5617.3 5678.0 5720.5 5536.9 5538.1 5538.8 5539.0 5549.2 5459.0 5608.9 5615.2 5615.7 5618.0 5289.6 5433.9 5488.0 5488.1 5533.7 5470.6 5481.3 5482.4 5482.8 5484.5 5231.7 5319.6 5375.8 5384.6 5442.4 5378.5 5386.8 5415.3 5443.5 5465.3 5298.0 5327.0 5330.2 5331.5 5337.7 17:19:16 INFO - PROCESS | 27468 | 17:19:16 INFO - PROCESS | 27468 | [#1] ext.html Cycles:180 Average:43345.76 Median:33587.58 stddev:72263.21 (215.1%) stddev-sans-first:72394.34 17:19:16 INFO - PROCESS | 27468 | Values: 508.0 524.2 527.8 538.6 553.4 27946.3 28537.0 35810.3 36015.5 36047.5 38951.4 39445.4 39489.6 39493.6 39508.8 7351.3 7444.3 8593.2 8865.7 8872.3 10086.8 10247.6 10302.0 10337.9 10337.9 9814.6 9906.2 9913.2 9921.8 9931.0 9906.7 9998.1 10007.3 10009.0 10013.2 9876.2 10009.8 10021.9 10316.8 10316.9 38752.8 39250.0 39259.2 39287.4 39324.4 2989.3 3033.9 3042.3 3068.9 3183.9 29810.9 29888.1 30426.2 30620.7 30904.0 3843.4 3923.4 3950.8 3997.2 4003.2 249015.0 249788.0 249829.0 250252.0 252354.0 51003.7 58514.7 58818.7 58849.4 58884.0 45599.3 59947.4 60840.0 61162.0 61180.7 14526.9 14763.6 14788.9 14903.9 14966.5 11328.7 11361.8 11367.9 11371.3 11379.9 18361.9 18444.4 18565.4 18573.6 19272.4 7622.8 7722.7 7745.6 7809.6 7941.5 885.6 892.4 930.1 1043.8 1053.2 23723.0 25874.0 25965.2 26107.9 27840.9 978.8 1000.8 1011.1 1024.9 1096.7 13430.6 13494.5 13599.1 13620.5 13695.8 339833.0 342975.0 344186.0 345652.0 345992.0 50619.5 50708.7 50896.0 50907.5 50963.5 1332.5 1339.9 1357.9 1358.1 1361.8 24173.5 24444.3 25720.6 26186.3 28384.4 41333.8 41856.8 41868.2 41905.6 41918.6 216866.0 218091.0 219143.0 219490.0 219882.6 26075.2 27363.0 27754.2 27760.6 27880.0 33295.5 34806.1 35327.3 35674.8 35978.1 32237.0 33635.8 34812.7 35155.5 35237.3 33824.0 34342.5 34567.5 34765.7 34795.3 33539.3 33782.0 34301.3 34346.5 34387.1 28598.3 29893.7 32155.4 34623.5 35133.6 23665.4 24078.0 24105.0 24282.2 24323.6 17:19:16 INFO - PROCESS | 27468 | 17:19:16 INFO - PROCESS | 27468 | [#2] jquery.html Cycles:180 Average:20901.63 Median:26053.99 stddev:51907.67 (199.2%) stddev-sans-first:52030.35 17:19:16 INFO - PROCESS | 27468 | Values: 348.1 353.9 357.3 360.5 361.5 13480.5 13570.7 16897.4 16968.7 17764.1 14749.3 15359.7 15587.4 15590.8 16350.2 5250.5 5420.5 5436.0 5446.3 5446.9 3986.5 4076.6 5340.7 5424.8 5711.6 5604.2 5847.6 5900.2 5905.2 5906.4 5759.8 5760.6 5813.1 5819.8 5829.3 4978.5 5087.7 5091.1 5207.7 5213.0 19503.6 19625.7 19789.8 19798.0 19868.8 2015.4 2039.1 2104.1 2153.3 2664.3 12254.9 12656.2 12674.4 12916.9 13030.5 1788.8 1801.4 1814.7 1819.9 1852.9 51589.0 53748.0 53868.2 53999.5 54034.0 8877.1 8944.7 9094.1 9155.7 9157.8 11801.5 11831.4 11840.4 11854.3 11860.6 7192.7 7235.3 7275.6 7334.4 7380.1 7207.6 7212.8 7241.5 7293.3 7295.5 5635.6 5697.7 5745.4 5762.9 5913.3 1524.4 1585.3 1614.1 1684.3 1750.8 868.7 903.1 906.6 915.9 984.8 15436.8 15467.8 15575.5 16211.3 16698.9 869.2 901.2 910.1 997.4 1023.2 8700.7 8811.8 8894.9 9058.1 9181.4 257390.0 260096.0 287437.0 369284.0 373094.7 64072.0 69733.3 72879.0 77617.2 80205.2 500.5 513.7 515.3 519.0 519.6 9759.4 10097.2 10114.7 10312.8 10533.6 32051.7 33129.3 33558.8 33606.8 34334.7 41667.6 41672.4 42668.0 42795.1 45139.8 7105.3 7451.9 7470.3 7546.3 7624.7 10587.9 11212.1 11226.7 11427.2 11490.8 8391.2 9330.2 9484.4 9765.9 10105.9 9531.1 9621.1 9633.9 9736.0 9749.6 9798.1 9912.5 9984.3 10020.5 10349.7 7262.7 7414.9 7466.9 7651.8 7710.1 9566.3 10067.5 10095.6 10281.2 10307.4 17:19:16 INFO - PROCESS | 27468 | 17:19:16 INFO - PROCESS | 27468 | [#3] mootools.html Cycles:180 Average:5412.13 Median:6569.12 stddev:2833.13 (43.1%) stddev-sans-first:2824.39 17:19:16 INFO - PROCESS | 27468 | Values: 1320.7 1453.6 1470.7 1607.2 1766.8 6969.9 7432.9 7509.9 7577.0 7582.1 7351.6 7483.0 7527.4 7527.4 7529.9 1921.9 1959.0 2125.9 2214.1 2235.4 2175.5 2177.9 2179.0 2179.3 2180.0 2136.2 2218.9 2220.2 2221.7 2225.7 2153.2 2169.5 2176.1 2202.5 2208.0 2186.1 2199.2 2225.3 2225.6 2228.5 7728.7 7780.1 7786.0 7788.4 7796.5 4549.2 4717.5 4739.7 4744.6 4760.5 2970.8 3029.3 3058.6 3076.1 3113.9 952.6 955.9 980.2 982.8 994.4 10359.2 10436.1 10446.5 10449.4 10456.7 4089.7 4215.2 4221.9 4259.3 4272.9 8684.4 8949.7 8959.1 8960.1 8983.9 4807.2 4812.9 4835.3 4842.6 4844.3 4389.6 4399.9 4405.4 4441.5 4443.4 3209.1 3251.8 3263.7 3307.6 3388.1 1030.1 1033.7 1038.8 1038.9 1045.0 1181.2 1193.1 1197.8 1199.8 1218.1 7260.9 7348.7 7349.4 7362.3 7401.1 1105.1 1108.6 1112.2 1115.9 1143.7 5773.4 5913.9 5921.6 5933.9 5934.9 9383.6 9526.1 9548.2 9687.2 9690.4 9446.8 9478.9 9488.6 9550.6 9559.1 7333.3 7419.0 7427.5 7525.7 7529.7 7175.4 7204.7 7244.5 7247.0 7256.8 8270.3 8384.6 8432.1 8656.4 8657.2 8718.4 8819.0 8920.3 8964.1 8999.5 6657.2 6739.5 6749.3 6759.6 6763.8 6599.8 6720.0 6751.7 7098.8 7284.1 6946.2 7036.9 7060.0 7112.4 7138.7 6639.1 6783.7 6857.7 6902.8 7010.5 6759.8 6771.9 6815.3 6833.9 6835.3 6096.2 6236.9 6366.4 6496.3 6514.3 6538.4 6608.6 6608.6 6615.8 6619.0 17:19:16 INFO - PROCESS | 27468 | 17:19:16 INFO - PROCESS | 27468 | [#4] prototype.html Cycles:180 Average:5315.03 Median:5961.39 stddev:1599.30 (26.8%) stddev-sans-first:1559.11 17:19:16 INFO - PROCESS | 27468 | Values: 313.7 318.4 340.5 342.4 352.4 5756.1 5919.9 5925.0 5939.9 6002.1 5732.7 5868.5 5908.8 5921.7 5949.3 4556.9 4568.8 4571.5 4576.5 4576.8 4401.8 4493.4 4576.6 4581.0 4583.5 4473.6 4504.4 4543.8 4545.5 4546.3 4522.3 4535.1 4539.7 4550.5 4557.4 4049.9 4056.9 4057.6 4075.7 4083.2 5543.4 5651.6 5652.0 5655.2 5664.2 5336.5 5349.7 5351.6 5359.6 5359.6 6229.7 6245.3 6256.5 6260.0 6265.9 4211.2 4226.7 4361.0 4457.8 4490.3 6537.3 6555.8 6560.2 6606.7 6642.0 4592.2 4597.2 4598.8 4599.0 4601.5 4555.3 4667.0 4672.4 4673.4 4676.7 5318.7 5330.7 5332.6 5336.9 5342.6 6359.9 6368.2 6380.8 6442.9 6450.4 1629.7 1634.6 1635.6 1636.2 1638.5 1096.7 1106.3 1111.4 1120.0 1129.5 5932.3 5958.1 5989.0 5999.3 6006.8 6507.1 6507.7 6512.0 6513.1 6521.2 5964.7 5992.7 5993.6 5995.6 6009.2 3406.6 3504.0 3507.1 3522.5 3546.1 6844.9 6848.9 6852.1 6853.4 6854.8 6751.5 6756.2 6761.0 6767.5 6767.8 6624.0 6755.5 6765.9 6773.2 6885.0 6586.3 6597.9 6606.5 6610.0 6612.8 6249.6 6362.8 6437.7 6513.0 6540.5 6861.4 6865.7 6866.9 6867.3 6885.1 4473.6 4504.8 4504.8 4508.2 4508.4 6388.7 6484.6 6573.0 6595.6 6627.7 6448.2 6454.8 6463.1 6472.3 6476.8 6424.2 6432.1 6432.5 6442.2 6443.6 6080.4 6170.4 6223.3 6291.7 6292.0 6426.1 6437.7 6445.0 6450.6 6452.0 6165.8 6298.3 6298.4 6305.4 6311.1 17:19:16 INFO - PROCESS | 27468 | 17:19:16 INFO - PROCESS | 27468 | [#5] yui.html Cycles:180 Average:13334.44 Median:50689.87 stddev:15454.54 (30.5%) stddev-sans-first:15469.32 17:19:16 INFO - PROCESS | 27468 | Values: 820.9 837.0 838.6 843.7 853.9 13007.4 13161.3 13167.5 13183.3 13189.9 11549.3 13837.3 13976.1 14121.5 14129.9 672.8 681.1 789.7 806.3 807.8 785.3 785.6 792.1 793.0 793.8 837.2 839.2 839.5 839.8 840.0 688.2 691.8 815.0 828.0 840.0 604.8 605.5 605.7 605.9 606.2 13163.5 13229.5 13231.1 13235.7 13236.0 12105.4 12647.7 12709.9 12751.2 12810.7 10600.9 10741.4 10834.2 10867.3 10904.6 3565.0 3643.1 3646.7 3647.5 3678.5 45195.3 45776.3 45822.5 46131.8 46312.0 9142.5 9605.3 9674.4 9773.8 9858.2 17195.6 17607.1 17704.0 17708.0 17715.1 7236.8 7306.4 7340.9 7369.4 7448.6 3914.8 3987.6 4114.8 4192.0 4361.9 2986.0 3025.2 3029.6 3036.1 3038.4 563.2 566.5 569.0 569.5 584.5 573.6 597.5 660.3 669.3 675.2 7810.2 8128.5 8141.0 8157.4 8224.3 560.3 561.6 562.5 612.1 666.8 3520.5 3597.7 3637.5 3679.0 3996.4 54148.7 54386.0 54416.2 54699.7 55747.4 50316.7 51063.0 51068.5 51551.2 51830.0 42394.8 44202.8 44853.6 44983.8 46584.8 7807.5 7828.9 7889.7 7961.1 8018.0 33517.0 33575.8 34023.7 34335.8 34346.3 41093.2 43817.6 44231.6 44615.0 44867.3 9296.7 9370.0 9397.2 9451.6 9472.8 11388.7 11420.7 11476.8 11611.2 11703.1 10532.8 10672.1 10725.5 10776.1 11005.5 10648.5 10725.5 10744.0 11004.6 11076.1 10293.6 10638.6 10876.1 11110.7 11115.1 9047.2 9345.8 9354.6 9517.0 9613.7 8156.5 8697.7 8711.6 8932.5 9056.0 17:19:16 INFO - PROCESS | 27468 | -------- Summary: end -------- 17:19:16 INFO - PROCESS | 27468 | 17:19:17 INFO - TEST-INFO | 27468: exit 0 17:19:17 INFO - TEST-OK | dromaeo_css | took 1111550ms 17:19:17 INFO - TEST-START | kraken 17:19:17 INFO - operating with platform_type : linux_ 17:19:17 INFO - Initialising browser for kraken test... 17:19:17 INFO - TEST-INFO | started process 27664 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJcz6bV/profile http://localhost:34251/getInfo.html) 17:19:21 INFO - PROCESS | 27664 | __metrics Screen width/height:1600/1200 17:19:21 INFO - PROCESS | 27664 | colorDepth:24 17:19:21 INFO - PROCESS | 27664 | Browser inner width/height: 1024/697 17:19:21 INFO - PROCESS | 27664 | __metrics 17:19:21 INFO - PROCESS | 27664 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:19:21 INFO - PROCESS | 27664 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:19:22 INFO - TEST-INFO | 27664: exit 0 17:19:22 INFO - Browser initialized. 17:19:22 INFO - Running cycle 1/1 for kraken test... 17:19:22 INFO - TEST-INFO | started process 27748 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJcz6bV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:19:34 INFO - PROCESS | 27748 | RSS: Main: 148819968 17:19:34 INFO - PROCESS | 27748 | 17:19:36 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:34251/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34251/tests/kraken/driver.html?testName=audio-beat-detection) 17:19:37 INFO - PROCESS | 27748 | RSS: Main: 185180160 17:19:37 INFO - PROCESS | 27748 | 17:19:39 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:34251/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34251/tests/kraken/driver.html?testName=audio-dft) 17:19:40 INFO - PROCESS | 27748 | RSS: Main: 175431680 17:19:40 INFO - PROCESS | 27748 | 17:19:43 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:34251/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34251/tests/kraken/driver.html?testName=audio-fft) 17:19:43 INFO - PROCESS | 27748 | RSS: Main: 160686080 17:19:43 INFO - PROCESS | 27748 | 17:19:45 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:34251/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34251/tests/kraken/driver.html?testName=audio-oscillator) 17:19:46 INFO - PROCESS | 27748 | RSS: Main: 162357248 17:19:46 INFO - PROCESS | 27748 | 17:19:48 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:34251/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34251/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:19:49 INFO - PROCESS | 27748 | RSS: Main: 165392384 17:19:49 INFO - PROCESS | 27748 | 17:19:52 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:34251/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34251/tests/kraken/driver.html?testName=imaging-darkroom) 17:19:52 INFO - PROCESS | 27748 | RSS: Main: 164622336 17:19:52 INFO - PROCESS | 27748 | 17:19:56 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:34251/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34251/tests/kraken/driver.html?testName=imaging-desaturate) 17:19:56 INFO - PROCESS | 27748 | RSS: Main: 164212736 17:19:56 INFO - PROCESS | 27748 | 17:19:59 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:34251/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34251/tests/kraken/driver.html?testName=json-parse-financial) 17:19:59 INFO - PROCESS | 27748 | RSS: Main: 163958784 17:19:59 INFO - PROCESS | 27748 | 17:20:01 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:34251/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34251/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:20:01 INFO - PROCESS | 27748 | RSS: Main: 173568000 17:20:01 INFO - PROCESS | 27748 | 17:20:03 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:34251/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34251/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:20:04 INFO - PROCESS | 27748 | RSS: Main: 170237952 17:20:04 INFO - PROCESS | 27748 | 17:20:06 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:34251/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34251/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:20:06 INFO - PROCESS | 27748 | RSS: Main: 182407168 17:20:06 INFO - PROCESS | 27748 | 17:20:09 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:34251/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:20:10 INFO - PROCESS | 27748 | RSS: Main: 189104128 17:20:10 INFO - PROCESS | 27748 | 17:20:12 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:34251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:20:13 INFO - PROCESS | 27748 | RSS: Main: 187502592 17:20:13 INFO - PROCESS | 27748 | 17:20:14 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:34251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34251/tests/kraken/driver.html?testName=ai-astar) 17:20:15 INFO - PROCESS | 27748 | RSS: Main: 246226944 17:20:15 INFO - PROCESS | 27748 | 17:20:15 INFO - PROCESS | 27748 | __start_tp_report 17:20:15 INFO - PROCESS | 27748 | _x_x_mozilla_page_load 17:20:15 INFO - PROCESS | 27748 | _x_x_mozilla_page_load_details 17:20:15 INFO - PROCESS | 27748 | |i|pagename|runs| 17:20:15 INFO - PROCESS | 27748 | |0;ai-astar;108;110;103;110;110;109;99;109;109;115 17:20:15 INFO - PROCESS | 27748 | |1;audio-beat-detection;155;122;154;175;126;160;148;123;163;127 17:20:15 INFO - PROCESS | 27748 | |2;audio-dft;161;161;161;162;162;160;162;163;163;160 17:20:15 INFO - PROCESS | 27748 | |3;audio-fft;71;72;79;98;72;72;74;105;92;74 17:20:15 INFO - PROCESS | 27748 | |4;audio-oscillator;96;96;139;95;97;97;145;95;96;141 17:20:15 INFO - PROCESS | 27748 | |5;imaging-gaussian-blur;110;110;110;110;110;110;110;109;110;110 17:20:15 INFO - PROCESS | 27748 | |6;imaging-darkroom;146;146;146;152;145;145;145;145;146;145 17:20:15 INFO - PROCESS | 27748 | |7;imaging-desaturate;96;96;96;97;96;95;96;96;96;96 17:20:15 INFO - PROCESS | 27748 | |8;json-parse-financial;57;55;55;53;55;55;55;64;53;53 17:20:15 INFO - PROCESS | 27748 | |9;json-stringify-tinderbox;67;68;69;68;69;68;69;69;69;69 17:20:15 INFO - PROCESS | 27748 | |10;stanford-crypto-aes;85;86;84;88;86;85;85;86;84;85 17:20:15 INFO - PROCESS | 27748 | |11;stanford-crypto-ccm;124;119;116;131;126;134;118;116;127;117 17:20:15 INFO - PROCESS | 27748 | |12;stanford-crypto-pbkdf2;145;154;155;154;148;145;155;161;152;147 17:20:15 INFO - PROCESS | 27748 | |13;stanford-crypto-sha256-iterative;67;68;69;67;66;69;66;68;66;66 17:20:15 INFO - PROCESS | 27748 | __end_tp_report 17:20:15 INFO - PROCESS | 27748 | __start_cc_report 17:20:15 INFO - PROCESS | 27748 | _x_x_mozilla_cycle_collect,938 17:20:15 INFO - PROCESS | 27748 | __end_cc_report 17:20:15 INFO - PROCESS | 27748 | __startTimestamp1452561615149__endTimestamp 17:20:15 INFO - PROCESS | 27748 | 17:20:15 INFO - PROCESS | 27748 | ------- Summary: start ------- 17:20:15 INFO - PROCESS | 27748 | Number of tests: 14 17:20:15 INFO - PROCESS | 27748 | 17:20:15 INFO - PROCESS | 27748 | [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:4.34 (3.9%) stddev-sans-first:4.60 17:20:15 INFO - PROCESS | 27748 | Values: 108.0 110.0 103.0 110.0 110.0 109.0 99.0 109.0 109.0 115.0 17:20:15 INFO - PROCESS | 27748 | 17:20:15 INFO - PROCESS | 27748 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:154.50 stddev:19.25 (12.5%) stddev-sans-first:20.10 17:20:15 INFO - PROCESS | 27748 | Values: 155.0 122.0 154.0 175.0 126.0 160.0 148.0 123.0 163.0 127.0 17:20:15 INFO - PROCESS | 27748 | 17:20:15 INFO - PROCESS | 27748 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 17:20:15 INFO - PROCESS | 27748 | Values: 161.0 161.0 161.0 162.0 162.0 160.0 162.0 163.0 163.0 160.0 17:20:15 INFO - PROCESS | 27748 | 17:20:15 INFO - PROCESS | 27748 | [#3] audio-fft Cycles:10 Average:80.90 Median:74.00 stddev:12.61 (17.0%) stddev-sans-first:12.85 17:20:15 INFO - PROCESS | 27748 | Values: 71.0 72.0 79.0 98.0 72.0 72.0 74.0 105.0 92.0 74.0 17:20:15 INFO - PROCESS | 27748 | 17:20:15 INFO - PROCESS | 27748 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:96.00 stddev:22.12 (23.0%) stddev-sans-first:22.90 17:20:15 INFO - PROCESS | 27748 | Values: 96.0 96.0 139.0 95.0 97.0 97.0 145.0 95.0 96.0 141.0 17:20:15 INFO - PROCESS | 27748 | 17:20:15 INFO - PROCESS | 27748 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:20:15 INFO - PROCESS | 27748 | Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 17:20:15 INFO - PROCESS | 27748 | 17:20:15 INFO - PROCESS | 27748 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:2.13 (1.5%) stddev-sans-first:2.26 17:20:15 INFO - PROCESS | 27748 | Values: 146.0 146.0 146.0 152.0 145.0 145.0 145.0 145.0 146.0 145.0 17:20:15 INFO - PROCESS | 27748 | 17:20:15 INFO - PROCESS | 27748 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 17:20:15 INFO - PROCESS | 27748 | Values: 96.0 96.0 96.0 97.0 96.0 95.0 96.0 96.0 96.0 96.0 17:20:15 INFO - PROCESS | 27748 | 17:20:15 INFO - PROCESS | 27748 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.00 stddev:3.24 (5.9%) stddev-sans-first:3.39 17:20:15 INFO - PROCESS | 27748 | Values: 57.0 55.0 55.0 53.0 55.0 55.0 55.0 64.0 53.0 53.0 17:20:15 INFO - PROCESS | 27748 | 17:20:15 INFO - PROCESS | 27748 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.71 (1.0%) stddev-sans-first:0.50 17:20:15 INFO - PROCESS | 27748 | Values: 67.0 68.0 69.0 68.0 69.0 68.0 69.0 69.0 69.0 69.0 17:20:15 INFO - PROCESS | 27748 | 17:20:15 INFO - PROCESS | 27748 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.50 stddev:1.17 (1.4%) stddev-sans-first:1.24 17:20:15 INFO - PROCESS | 27748 | Values: 85.0 86.0 84.0 88.0 86.0 85.0 85.0 86.0 84.0 85.0 17:20:15 INFO - PROCESS | 27748 | 17:20:15 INFO - PROCESS | 27748 | [#11] stanford-crypto-ccm Cycles:10 Average:122.80 Median:125.00 stddev:6.55 (5.2%) stddev-sans-first:6.93 17:20:15 INFO - PROCESS | 27748 | Values: 124.0 119.0 116.0 131.0 126.0 134.0 118.0 116.0 127.0 117.0 17:20:15 INFO - PROCESS | 27748 | 17:20:15 INFO - PROCESS | 27748 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.60 Median:154.00 stddev:5.21 (3.4%) stddev-sans-first:4.95 17:20:15 INFO - PROCESS | 27748 | Values: 145.0 154.0 155.0 154.0 148.0 145.0 155.0 161.0 152.0 147.0 17:20:15 INFO - PROCESS | 27748 | 17:20:15 INFO - PROCESS | 27748 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.23 (1.8%) stddev-sans-first:1.30 17:20:15 INFO - PROCESS | 27748 | Values: 67.0 68.0 69.0 67.0 66.0 69.0 66.0 68.0 66.0 66.0 17:20:15 INFO - PROCESS | 27748 | -------- Summary: end -------- 17:20:15 INFO - PROCESS | 27748 | 17:20:16 INFO - TEST-INFO | 27748: exit 0 17:20:16 INFO - TEST-OK | kraken | took 58794ms 17:20:16 INFO - TEST-START | v8_7 17:20:16 INFO - operating with platform_type : linux_ 17:20:16 INFO - Initialising browser for v8_7 test... 17:20:16 INFO - TEST-INFO | started process 27998 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpen2k2e/profile http://localhost:34251/getInfo.html) 17:20:20 INFO - PROCESS | 27998 | __metrics Screen width/height:1600/1200 17:20:20 INFO - PROCESS | 27998 | colorDepth:24 17:20:20 INFO - PROCESS | 27998 | Browser inner width/height: 1024/697 17:20:20 INFO - PROCESS | 27998 | __metrics 17:20:20 INFO - PROCESS | 27998 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:20:20 INFO - PROCESS | 27998 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:20:21 INFO - TEST-INFO | 27998: exit 0 17:20:21 INFO - Browser initialized. 17:20:21 INFO - Running cycle 1/1 for v8_7 test... 17:20:21 INFO - TEST-INFO | started process 28079 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpen2k2e/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:20:32 INFO - PROCESS | 28079 | RSS: Main: 148041728 17:20:32 INFO - PROCESS | 28079 | 17:20:55 INFO - PROCESS | 28079 | Cycle 1(1): loaded http://localhost:34251/tests/v8_7/run.html (next: http://localhost:34251/tests/v8_7/run.html) 17:20:55 INFO - PROCESS | 28079 | RSS: Main: 530100224 17:20:55 INFO - PROCESS | 28079 | 17:20:55 INFO - PROCESS | 28079 | __start_tp_report 17:20:55 INFO - PROCESS | 28079 | _x_x_mozilla_page_load 17:20:55 INFO - PROCESS | 28079 | _x_x_mozilla_page_load_details 17:20:55 INFO - PROCESS | 28079 | |i|pagename|runs| 17:20:55 INFO - PROCESS | 28079 | |0;Richards;167.22408026755852 17:20:55 INFO - PROCESS | 28079 | |1;DeltaBlue;190.11406844106463 17:20:55 INFO - PROCESS | 28079 | |2;Encrypt;279.72027972027973 17:20:55 INFO - PROCESS | 28079 | |3;Decrypt;5291.005291005291 17:20:55 INFO - PROCESS | 28079 | |4;RayTrace;1119.8208286674133 17:20:55 INFO - PROCESS | 28079 | |5;Earley;787.4015748031496 17:20:55 INFO - PROCESS | 28079 | |6;Boyer;12550 17:20:55 INFO - PROCESS | 28079 | |7;RegExp;42937.5 17:20:55 INFO - PROCESS | 28079 | |8;Splay;566.8934240362812 17:20:55 INFO - PROCESS | 28079 | |9;NavierStokes;4830.917874396136 17:20:55 INFO - PROCESS | 28079 | __end_tp_report 17:20:55 INFO - PROCESS | 28079 | __startTimestamp1452561655306__endTimestamp 17:20:55 INFO - PROCESS | 28079 | 17:20:55 INFO - PROCESS | 28079 | ------- Summary: start ------- 17:20:55 INFO - PROCESS | 28079 | Number of tests: 10 17:20:55 INFO - PROCESS | 28079 | 17:20:55 INFO - PROCESS | 28079 | [#0] Richards Cycles:1 Average:167.22 Median:167.22 stddev:0.00 (0.0%) 17:20:55 INFO - PROCESS | 28079 | Values: 167.2 17:20:55 INFO - PROCESS | 28079 | 17:20:55 INFO - PROCESS | 28079 | [#1] DeltaBlue Cycles:1 Average:190.11 Median:190.11 stddev:0.00 (0.0%) 17:20:55 INFO - PROCESS | 28079 | Values: 190.1 17:20:55 INFO - PROCESS | 28079 | 17:20:55 INFO - PROCESS | 28079 | [#2] Encrypt Cycles:1 Average:279.72 Median:279.72 stddev:0.00 (0.0%) 17:20:55 INFO - PROCESS | 28079 | Values: 279.7 17:20:55 INFO - PROCESS | 28079 | 17:20:55 INFO - PROCESS | 28079 | [#3] Decrypt Cycles:1 Average:5291.01 Median:5291.01 stddev:0.00 (0.0%) 17:20:55 INFO - PROCESS | 28079 | Values: 5291.0 17:20:55 INFO - PROCESS | 28079 | 17:20:55 INFO - PROCESS | 28079 | [#4] RayTrace Cycles:1 Average:1119.82 Median:1119.82 stddev:0.00 (0.0%) 17:20:55 INFO - PROCESS | 28079 | Values: 1119.8 17:20:55 INFO - PROCESS | 28079 | 17:20:55 INFO - PROCESS | 28079 | [#5] Earley Cycles:1 Average:787.40 Median:787.40 stddev:0.00 (0.0%) 17:20:55 INFO - PROCESS | 28079 | Values: 787.4 17:20:55 INFO - PROCESS | 28079 | 17:20:55 INFO - PROCESS | 28079 | [#6] Boyer Cycles:1 Average:12550.00 Median:12550.00 stddev:0.00 (0.0%) 17:20:55 INFO - PROCESS | 28079 | Values: 12550.0 17:20:55 INFO - PROCESS | 28079 | 17:20:55 INFO - PROCESS | 28079 | [#7] RegExp Cycles:1 Average:42937.50 Median:42937.50 stddev:0.00 (0.0%) 17:20:55 INFO - PROCESS | 28079 | Values: 42937.5 17:20:55 INFO - PROCESS | 28079 | 17:20:55 INFO - PROCESS | 28079 | [#8] Splay Cycles:1 Average:566.89 Median:566.89 stddev:0.00 (0.0%) 17:20:55 INFO - PROCESS | 28079 | Values: 566.9 17:20:55 INFO - PROCESS | 28079 | 17:20:55 INFO - PROCESS | 28079 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 17:20:55 INFO - PROCESS | 28079 | Values: 4830.9 17:20:55 INFO - PROCESS | 28079 | -------- Summary: end -------- 17:20:55 INFO - PROCESS | 28079 | 17:20:56 INFO - TEST-INFO | 28079: exit 0 17:20:56 INFO - TEST-OK | v8_7 | took 40025ms 17:20:56 INFO - SUITE-END | took 1210s 17:20:56 INFO - Completed test suite (00:20:10) 17:20:56 INFO - Working with test: dromaeo_css 17:20:56 INFO - Generating results file: dromaeo_css 17:20:56 INFO - Working with test: kraken 17:20:56 INFO - Generating results file: kraken 17:20:56 INFO - javascript benchmark 17:20:56 INFO - Working with test: v8_7 17:20:56 INFO - Generating results file: v8_7 17:20:56 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:20:56 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 17:20:56 INFO - process_Request line: dromaeo_css 6712.61 graph.html#tests=[[72,64,35]] 17:20:56 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:20:56 INFO - process_Request line: kraken 1508.60 graph.html#tests=[[232,64,35]] 17:20:56 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:20:56 INFO - process_Request line: v8_7 20020.43 graph.html#tests=[[230,64,35]] 17:20:56 INFO - RETURN: dromaeo_css: 6712.61 17:20:56 INFO - RETURN: kraken: 1508.60 17:20:56 INFO - RETURN: v8_7: 20020.43 17:20:56 INFO - javascript benchmark 17:20:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3114.7663925205607, 3176.571162893009, 3213.180638937071, 3222.854971526281, 3243.0270918724386, 5040.798368065282, 5161.225816127583, 5239.1617341225365, 5284.075286824809, 5336.839894803157, 5162.690238585687, 5192.818251361203, 5200.713960732158, 5210.452902445246, 5252.159654455288, 4726.291056341551, 4746.406699162605, 4762.238041913294, 4832.202686556714, 4854.393200849894, 528.6288661900114, 4651.604613607848, 4779.80880764769, 4790.952090479085, 4822.035592881421, 4623.79192936317, 4682.719036857782, 4691.695039822401, 4713.1516327060945, 4722.480527142012, 4653.232216684243, 4660.4174478190225, 4660.790264438108, 4663.417072865892, 4698.859034228979, 4621.768911554409, 4669.463011753658, 4687.95312046882, 4734.502877197879, 4736.3369128322065, 5053.69677819332, 5112.539871411591, 5125.743712814382, 5140.768665410065, 5162.1224391853475, 5554.222408862763, 5564.10974244123, 5574.581906356999, 5574.944250557523, 5608.775648974036, 5479.04116779562, 5569.610127291091, 5588.804391846266, 5621.634593751393, 5641.746121424546, 5126.794928202868, 5223.608229382773, 5225.503577160163, 5227.8170264040955, 5240.8470136569895, 5748.942510574924, 5775.913361299584, 5776.624519406309, 5776.653400795965, 5779.942200578024, 5441.918371224435, 5462.262594549765, 5524.06090964537, 5544.833654990357, 5566.916496252559, 5672.8865422691315, 5682.488576028178, 5684.63049901755, 5691.402402747734, 5704.971475142598, 5587.552995760329, 5636.436356364331, 5642.04085305499, 5643.717814109278, 5645.125005624135, 5371.704556249366, 5384.138537833927, 5479.205515200353, 5557.305336832896, 5615.438456154352, 4364.934525982113, 4369.890752731144, 4391.626711729475, 4411.897025743564, 4412.382266482695, 3914.530256369254, 3915.314819906505, 3918.6669133123432, 3918.8824335269987, 3922.0194951262183, 5121.231815227671, 5207.297014903015, 5208.7916483341, 5209.843704688866, 5236.345456817898, 5653.434656534314, 5676.716164191774, 5680.801171958961, 5687.976164290385, 5690.77236910519, 5218.191180367049, 5239.711815850165, 5255.947440525622, 5257.605679574047, 5300.072487314705, 4612.815487380534, 4718.693284936468, 4748.786304616231, 4794.041191761662, 4854.393200849894, 5652.74562644682, 5707.200991861143, 5709.172170035322, 5709.229254050733, 5717.342505611825, 5482.150266708666, 5524.779008839762, 5525.171224316385, 5532.197831314517, 5580.051391263414, 5539.8892022158525, 5556.16657501378, 5617.297837770278, 5678.034734095297, 5720.456556627114, 5536.889262214814, 5538.058530049821, 5538.8061417851795, 5539.0, 5549.223108764857, 5458.972705136608, 5608.887822243614, 5615.157726341082, 5615.719214039364, 5618.0, 5289.629725919149, 5433.9456605435025, 5487.972560137334, 5488.1493368527945, 5533.695646739468, 5470.562355011669, 5481.260029896072, 5482.369527504388, 5482.753276102665, 5484.451554844483, 5231.686098834082, 5319.574434045345, 5375.838724838261, 5384.623076384615, 5442.401335853132, 5378.542823860016, 5386.8383948481605, 5415.296011518478, 5443.455654434525, 5465.344158700981, 5298.046351656739, 5327.0, 5330.173823057432, 5331.5201631853315, 5337.653052551572], "unit": "score", "name": "dojo.html", "value": 5114.836375771803}, {"lowerIsBetter": false, "replicates": [508.01698712990344, 524.2267655208566, 527.8495628745807, 538.5772168847453, 553.3581045986654, 27946.30134246645, 28537.0, 35810.283794324096, 36015.4597681035, 36047.4592881107, 38951.41572876402, 39445.40831887517, 39489.605103948954, 39493.605063949355, 39508.80245598775, 7351.301626345488, 7444.330010299072, 8593.22660960515, 8865.734027979172, 8872.334574906876, 10086.798264034715, 10247.641332553361, 10302.0, 10337.896621033806, 10337.948310258476, 9814.607415703364, 9906.20750339971, 9913.206943444544, 9921.817200215977, 9931.0, 9906.702798916043, 9998.05018523239, 10007.349522281065, 10009.049140331657, 10013.198944084492, 9876.160526355268, 10009.798824141077, 10021.89978100217, 10316.845247321296, 10316.948415257952, 38752.80623596892, 39250.0, 39259.214815703526, 39287.4106888394, 39324.41013384802, 2989.312458134641, 3033.893813716509, 3042.3458956324275, 3068.9079327620207, 3183.8885639002756, 29810.85094574535, 29888.114545108998, 30426.239344016354, 30620.693793062008, 30904.0, 3843.442700808367, 3923.431102490123, 3950.8222130003933, 3997.1805779815068, 4003.219372222418, 249015.0, 249788.0, 249829.0, 250252.0, 252354.0, 51003.744981275595, 58514.70742646259, 58818.7059064702, 58849.41150588525, 58884.0, 45599.31601025987, 59947.400525994184, 60840.0, 61162.0, 61180.69409652923, 14526.854731452762, 14763.557093287218, 14788.852111478747, 14903.850961490247, 14966.476173333882, 11328.660140195807, 11361.772764544663, 11367.886321136682, 11371.260868043551, 11379.94310028461, 18361.908190459228, 18444.446666600023, 18565.44303670892, 18573.628527429377, 19272.421827345202, 7622.8094297643, 7722.652480638272, 7745.605790957682, 7809.609519524115, 7941.483803552751, 885.5749240364532, 892.4154678685471, 930.1303281431883, 1043.838205078214, 1053.1785207538132, 23723.0, 25874.0, 25965.22104336835, 26107.869460652575, 27840.8607956963, 978.7699890525721, 1000.849872519128, 1011.0849681038525, 1024.8718910136233, 1096.6655170173015, 13430.597082087554, 13494.52769153075, 13599.116057456235, 13620.455181792815, 13695.794563081561, 339833.0, 342975.0, 344186.0, 345652.0, 345992.0, 50619.493805062215, 50708.74645626748, 50896.0, 50907.49092509101, 50963.490365096615, 1332.460353556811, 1339.8660133986523, 1357.8845798107272, 1358.1443690475135, 1361.8365796104333, 24173.51652966966, 24444.266671999867, 25720.614190787528, 26186.345341365857, 28384.432311353245, 41333.79333103436, 41856.79071604623, 41868.162636746485, 41905.58094419139, 41918.58081419269, 216866.0, 218091.0, 219143.0, 219490.0, 219882.61408631067, 26075.217743467725, 27363.0, 27754.167374977977, 27760.583591245744, 27880.0, 33295.50056749199, 34806.127142199606, 35327.293454131286, 35674.8216258917, 35978.10054748652, 32237.0, 33635.831820840736, 34812.65187348094, 35155.47266790949, 35237.295254094264, 33824.0, 34342.48486272758, 34567.4814877772, 34765.65234347624, 34795.30409391849, 33539.32921341608, 33782.0, 34301.313973720884, 34346.48480272848, 34387.14032149216, 28598.285042874093, 29893.70106298909, 32155.35689286248, 34623.480647790806, 35133.648663513035, 23665.40271187825, 24078.0, 24105.0, 24282.15012474555, 24323.63514547248], "unit": "score", "name": "ext.html", "value": 17762.131712605264}, {"lowerIsBetter": false, "replicates": [348.0984250790454, 353.9433690609502, 357.3442732585705, 360.4863070125071, 361.5227899173092, 13480.460781568725, 13570.660733481667, 16897.408590699328, 16968.660626787474, 17764.11179441029, 14749.262536873168, 15359.69280614387, 15587.376504939817, 15590.766138507932, 16350.182490875468, 5250.527452529272, 5420.4850539198915, 5436.048691478995, 5446.319210098738, 5446.91829622556, 3986.4618276532588, 4076.6331030207275, 5340.732963351837, 5424.83725488236, 5711.571632127586, 5604.1593760935775, 5847.590668653196, 5900.203472531218, 5905.173275741399, 5906.3798301178185, 5759.769609215627, 5760.56795740319, 5813.09896965971, 5819.7963071292725, 5829.271341082364, 4978.5270399312, 5087.669301495428, 5091.083604951107, 5207.6875387476875, 5212.973935130338, 19503.609927801364, 19625.705614415794, 19789.80210197894, 19798.0, 19868.80131198684, 2015.3752336775499, 2039.1027947703112, 2104.074207348762, 2153.332466935255, 2664.3205982474537, 12254.877451225462, 12656.240625562496, 12674.36628168597, 12916.87083129166, 13030.478780848754, 1788.7853457585043, 1801.351513455155, 1814.7368631548352, 1819.9363022294287, 1852.8795628284117, 51589.0, 53748.0, 53868.191977120376, 53999.46000539984, 54034.0, 8877.112288771072, 8944.68693595721, 9094.136057074567, 9155.679551215675, 9157.77105572366, 11801.52793888235, 11831.408429578487, 11840.407979600985, 11854.288742675468, 11860.584879529175, 7192.7122915083855, 7235.312645298688, 7275.563466192046, 7334.3765779908235, 7380.114386273682, 7207.5675459472595, 7212.783616491513, 7241.5293005954445, 7293.307135822089, 7295.452841036943, 5635.605507614509, 5697.686627235542, 5745.425457454305, 5762.942370576325, 5913.349531551526, 1524.3750062474332, 1585.326236349547, 1614.136437006196, 1684.3010150787286, 1750.7723995880453, 868.68727258187, 903.0698380667923, 906.5784410249134, 915.9313051521029, 984.8424252119627, 15436.768448473282, 15467.845321546865, 15575.532734017997, 16211.313231996013, 16698.916505417394, 869.1621854644591, 901.1664210605295, 910.0717268386209, 997.3716558568201, 1023.22746326523, 8700.695475658322, 8811.823763524693, 8894.911050889537, 9058.094190580889, 9181.403208791407, 257390.0, 260096.0, 287437.0, 369284.0, 373094.7488413245, 64072.0, 69733.3026669737, 72879.0, 77617.22382776212, 80205.19794802094, 500.46450298181327, 513.6994858008032, 515.3120584020375, 518.9740512974336, 519.6232731269723, 9759.36564123358, 10097.19222462216, 10114.747131321481, 10312.845307320245, 10533.631322903662, 32051.67948320487, 33129.337413252084, 33558.832205838815, 33606.831965840014, 34334.65665343314, 41667.58332416759, 41672.37491437692, 42668.0, 42795.14409711851, 45139.77430112829, 7105.32499412555, 7451.850962980601, 7470.2903224193615, 7546.320831125225, 7624.733134340271, 10587.947060264649, 11212.103031757602, 11226.719332016764, 11427.200095993201, 11490.82763758561, 8391.16088391156, 9330.206932410549, 9484.430934143973, 9765.85351219718, 10105.89894101079, 9531.142197202285, 9621.08599683029, 9633.9036609633, 9736.0, 9749.56126974302, 9798.118169364792, 9912.530614285231, 9984.301098923006, 10020.549075291776, 10349.689509314732, 7262.709491620276, 7414.888776668462, 7466.925330746841, 7651.808704782202, 7710.11333696632, 9566.282528810229, 10067.546960386946, 10095.646652367132, 10281.228907832092, 10307.433091180057], "unit": "score", "name": "jquery.html", "value": 7804.989896015285}, {"lowerIsBetter": false, "replicates": [1320.702841860581, 1453.6075259679887, 1470.7279153356626, 1607.1883698732138, 1766.840984311411, 6969.895451568231, 7432.9256707432905, 7509.924900750991, 7577.0, 7582.128055273645, 7351.595662238575, 7482.96258518708, 7527.3601743851705, 7527.397808175347, 7529.924700752991, 1921.9423417297503, 1958.9706154407695, 2125.872447653138, 2214.092222188907, 2235.4299653588314, 2175.4778853075227, 2177.912883484659, 2179.030331502482, 2179.302623160589, 2179.9564008719894, 2136.177571634924, 2218.866867987918, 2220.167437211046, 2221.688963545105, 2225.688403623494, 2153.214076861942, 2169.4793249620134, 2176.0534167637047, 2202.50443650179, 2207.9668804967937, 2186.10369748404, 2199.2412617646887, 2225.2879078694823, 2225.5993921094196, 2228.476308067603, 7728.729494467723, 7780.066392032935, 7785.961070194669, 7788.415868809862, 7796.4932279401655, 4549.24937385331, 4717.481077081518, 4739.668223224376, 4744.620430365562, 4760.523947605247, 2970.8217506949654, 3029.2578318312153, 3058.5870907427434, 3076.09255269696, 3113.9221519461967, 952.618952419031, 955.9474228917406, 980.2011360741045, 982.778874753182, 994.383482241008, 10359.171266298677, 10436.112930400925, 10446.529906154241, 10449.373037617766, 10456.738581535523, 4089.7137200395687, 4215.156968606291, 4221.852235171754, 4259.2759230930815, 4272.87181384559, 8684.392092553588, 8949.686760963335, 8959.059298773665, 8960.103989600988, 8983.865242021375, 4807.18277892759, 4812.903741925212, 4835.323054772335, 4842.6368022398465, 4844.297576851407, 4389.648828093745, 4399.868003959887, 4405.383246345515, 4441.467023957146, 4443.37792709021, 3209.1335339458215, 3251.837408129584, 3263.738900887923, 3307.5534802801794, 3388.1360253135294, 1030.1346868630387, 1033.679559336608, 1038.8441733739849, 1038.9064984151312, 1045.0281238448165, 1181.1908842442954, 1193.0694058634278, 1197.7724232395817, 1199.8080307150815, 1218.0620921890272, 7260.891086633705, 7348.669309881068, 7349.375303099189, 7362.300581444754, 7401.111866576045, 1105.1269497097364, 1108.5731993182683, 1112.2158877990996, 1115.9107271418268, 1143.7140714821294, 5773.422657734193, 5913.940860591425, 5921.585489015728, 5933.851653708605, 5934.940650593525, 9383.62465501386, 9526.142647161789, 9548.236141108695, 9687.17658998979, 9690.37012594179, 9446.811063778687, 9478.857817132748, 9488.573014214377, 9550.61797528105, 9559.091886270793, 7333.2666733327305, 7418.96290518544, 7427.480076394709, 7525.736599219001, 7529.73645922401, 7175.390091842252, 7204.747833825791, 7244.492885497964, 7247.0, 7256.7822965311125, 8270.338372930271, 8384.580770961305, 8432.114627963976, 8656.437331573428, 8657.220850123267, 8718.43330183536, 8819.029906710384, 8920.330975176757, 8964.14840590143, 8999.460032398078, 6657.167854018247, 6739.528233023641, 6749.291324410866, 6759.5606285591275, 6763.7632682855865, 6599.8020059398295, 6720.0, 6751.729930802713, 7098.751543695946, 7284.053073100463, 6946.235914049349, 7036.859262814817, 7060.0, 7112.359887609933, 7138.678759455941, 6639.070530125689, 6783.728650853911, 6857.7256909723055, 6902.827429314308, 7010.50926435165, 6759.763408280686, 6771.898421523582, 6815.284395138439, 6833.863322733617, 6835.316468353125, 6096.237970253718, 6236.937630623635, 6366.427021568081, 6496.317886621837, 6514.250861151028, 6538.444232240313, 6608.570442921195, 6608.636524991171, 6615.834604134935, 6619.040239165198], "unit": "score", "name": "mootools.html", "value": 4420.611991495081}, {"lowerIsBetter": false, "replicates": [313.7270574600098, 318.4474935986065, 340.5334691472683, 342.35637002435425, 352.4079546362111, 5756.079027355624, 5919.881602367956, 5925.0, 5939.85150371241, 6002.129691194774, 5732.7133643317875, 5868.530517558595, 5908.763649454017, 5921.73352199151, 5949.345571987089, 4556.9088618227615, 4568.771561421932, 4571.51999040101, 4576.519465456129, 4576.771161441923, 4401.845935392262, 4493.41585593874, 4576.565226303496, 4580.97709511452, 4583.472900616439, 4473.597376236138, 4504.423451791863, 4543.772811359436, 4545.522720114373, 4546.295324224734, 4522.276435770277, 4535.115652447774, 4539.659525535598, 4550.453945526558, 4557.361969324297, 4049.9190016199805, 4056.898577535556, 4057.5739547347694, 4075.6943229257627, 4083.1629515949157, 5543.36251331094, 5651.632643878176, 5652.0, 5655.208270842086, 5664.178694089375, 5336.519713225828, 5349.679019258857, 5351.598630102719, 5359.624826262163, 5359.624826262163, 6229.688515574203, 6245.3442388549, 6256.499480041586, 6259.968700156515, 6265.906011409833, 4211.157768446323, 4226.704130710851, 4360.978195109036, 4457.754823484707, 4490.259107247301, 6537.280899101095, 6555.770548030796, 6560.212774467047, 6606.735730570819, 6641.966790166067, 4592.15045216636, 4597.172508948354, 4598.770061496979, 4598.954010459919, 4601.493835678073, 4555.293929440942, 4667.043256132485, 4672.415948006499, 4673.439187297478, 4676.672632915731, 5318.680879147263, 5330.653507521999, 5332.573394128461, 5336.866578335573, 5342.572594192456, 6359.936400635935, 6368.235811702532, 6380.776672816522, 6442.903356449657, 6450.387213214831, 1629.6577718678973, 1634.6322077532698, 1635.5911022244438, 1636.1737322651984, 1638.5084474657556, 1096.681962230944, 1106.3140852671233, 1111.433169083773, 1119.960801371948, 1129.5425352732157, 5932.2584676915385, 5958.076498142795, 5989.041753319535, 5999.280086389661, 6006.759729610767, 6507.056476810836, 6507.657243392375, 6511.967440162769, 6513.12072870166, 6521.152250207443, 5964.701764911824, 5992.700364981821, 5993.580449368503, 5995.5803093783015, 6009.248843894513, 3406.5741782277214, 3503.982480087634, 3507.0530956641564, 3522.471629255581, 3546.0957455848593, 6844.931550684529, 6848.863022739517, 6852.074969879102, 6853.383195512428, 6854.794356169323, 6751.493637977172, 6756.223034351113, 6760.966195169091, 6767.526273160832, 6767.830804229835, 6624.0, 6755.49333799967, 6765.932340676629, 6773.153355830521, 6884.965575172092, 6586.341365863375, 6597.9443289073515, 6606.504512161511, 6609.966950165219, 6612.768553100618, 6249.562530622813, 6362.809115726535, 6437.742490300523, 6512.980975897487, 6540.50946179029, 6861.382475577222, 6865.656717164222, 6866.896996545156, 6867.313268673092, 6885.104936358442, 4473.642108631367, 4504.806226349954, 4504.842330518416, 4508.165989291861, 4508.436445444319, 6388.712507937061, 6484.643344616092, 6573.0, 6595.637239951849, 6627.701753421204, 6448.226212854487, 6454.838629034311, 6463.127477790438, 6472.288048314776, 6476.838079048061, 6424.164858568356, 6432.099506069248, 6432.517561183024, 6442.194725659293, 6443.581167224115, 6080.3615620361, 6170.352113028247, 6223.284322302812, 6291.716872740646, 6292.024736165901, 6426.132472116392, 6437.7124575084235, 6444.967775161094, 6450.612963222222, 6452.0, 6165.84585385351, 6298.275698294755, 6298.401651843067, 6305.369463053841, 6311.053341998737], "unit": "score", "name": "prototype.html", "value": 4797.270047945743}, {"lowerIsBetter": false, "replicates": [820.9055958564765, 836.9748907532776, 838.6268110690737, 843.6878355008648, 853.9359548033899, 13007.414666340013, 13161.341932903364, 13167.539136130237, 13183.274919879426, 13189.868101318983, 11549.307041577511, 13837.308134593255, 13976.091554049006, 14121.505747298846, 14129.858701412983, 672.8385187554976, 681.0839420978775, 789.7235967411403, 806.2662976691212, 807.769785611098, 785.3403141361256, 785.6386062411298, 792.1326147868104, 793.012699189507, 793.809485723428, 837.2339309531772, 839.2404873589381, 839.5214727605268, 839.8068444257824, 839.9706010289641, 688.1570076656106, 691.7682576336958, 815.0463957170125, 827.954462504562, 840.0465471689646, 604.7792555717175, 605.4702135631322, 605.7334772699998, 605.9212302400659, 606.2210060072786, 13163.473461061547, 13229.470821167142, 13231.139975901631, 13235.735285294337, 13236.0, 12105.394730263451, 12647.747045059048, 12709.872901271054, 12751.234925904475, 12810.679733006657, 10600.893991060067, 10741.355518668905, 10834.241603087787, 10867.29362591429, 10904.61833835812, 3564.9821750891338, 3643.143861192618, 3646.726495512847, 3647.507586475845, 3678.5401824771902, 45195.32207016897, 45776.313355299695, 45822.54177458216, 46131.76934115341, 46312.0, 9142.451452912846, 9605.327627066039, 9674.371165874196, 9773.804523909483, 9858.162056225301, 17195.570110747332, 17607.09482935327, 17704.0, 17708.0, 17715.114244287735, 7236.819079522948, 7306.378473401332, 7340.926590734024, 7369.373603243785, 7448.627568621548, 3914.784686842194, 3987.6211759882763, 4114.753114813121, 4191.97904010478, 4361.9127617447475, 2986.0, 3025.1680787783534, 3029.621297337833, 3036.1347016100303, 3038.437888990544, 563.2115038945509, 566.5043087298614, 568.9829305120853, 569.5187566506378, 584.5060923519619, 573.5640912906138, 597.4503456819737, 660.2671035150978, 669.2537820330297, 675.1729131813587, 7810.1799311072655, 8128.512289262663, 8141.0, 8157.428979971463, 8224.300934420642, 560.2856358143318, 561.6180996922133, 562.4965655738173, 612.1338306296541, 666.7932940788371, 3520.542329497149, 3597.730170237243, 3637.5271214741915, 3678.981605092011, 3996.440498330236, 54148.72925635425, 54386.0, 54416.18375724367, 54699.72650136724, 55747.442525574224, 50316.74841625769, 51063.0, 51068.46794596168, 51551.226731599054, 51830.0, 42394.78802605967, 44202.778986104866, 44853.55146448559, 44983.77508112438, 46584.767076164404, 7807.531548107132, 7828.921710782819, 7889.723859664884, 7961.084475285416, 8017.959910200411, 33517.0, 33575.83212083924, 34023.65976340304, 34335.828320858236, 34346.31307373789, 41093.1781364377, 43817.561824382625, 44231.55768442275, 44615.0, 44867.32699009452, 9296.72109836706, 9370.0, 9397.248220142508, 9451.574679139592, 9472.763180920532, 11388.665323608475, 11420.657380278604, 11476.827847582459, 11611.245269057485, 11703.063754899758, 10532.789344212919, 10672.146228301872, 10725.517351719036, 10776.084032856981, 11005.457661030754, 10648.467576621293, 10725.517351719036, 10744.0, 11004.559817607205, 11076.11391088727, 10293.639722609672, 10638.62764803259, 10876.075533579735, 11110.666679999613, 11115.110791136527, 9047.230985366317, 9345.766355840886, 9354.625814967325, 9516.95241523788, 9613.663521776703, 8156.469829461066, 8697.739067827975, 8711.56442177876, 8932.508712020901, 9056.0], "unit": "score", "name": "yui.html", "value": 6083.257558048934}], "name": "dromaeo_css", "value": 6712.611077724076}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 103.0, 110.0, 110.0, 109.0, 99.0, 109.0, 109.0, 115.0], "unit": "score", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [155.0, 122.0, 154.0, 175.0, 126.0, 160.0, 148.0, 123.0, 163.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.3}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 162.0, 162.0, 160.0, 162.0, 163.0, 163.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 79.0, 98.0, 72.0, 72.0, 74.0, 105.0, 92.0, 74.0], "unit": "score", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 139.0, 95.0, 97.0, 97.0, 145.0, 95.0, 96.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 109.7}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 152.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 55.0, 53.0, 55.0, 55.0, 55.0, 64.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.5}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 69.0, 68.0, 69.0, 68.0, 69.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 84.0, 88.0, 86.0, 85.0, 85.0, 86.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [124.0, 119.0, 116.0, 131.0, 126.0, 134.0, 118.0, 116.0, 127.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.8}, {"lowerIsBetter": true, "replicates": [145.0, 154.0, 155.0, 154.0, 148.0, 145.0, 155.0, 161.0, 152.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 69.0, 67.0, 66.0, 69.0, 66.0, 68.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1508.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.22408026755852], "unit": "score", "name": "Richards", "value": 211.10596}, {"lowerIsBetter": false, "replicates": [190.11406844106463], "unit": "score", "name": "DeltaBlue", "value": 347.7806799999999}, {"lowerIsBetter": false, "replicates": [279.72027972027973], "unit": "score", "name": "Encrypt", "value": 951.5970750000004}, {"lowerIsBetter": false, "replicates": [5291.005291005291], "unit": "score", "name": "Decrypt", "value": 50.30820900000001}, {"lowerIsBetter": false, "replicates": [1119.8208286674133], "unit": "score", "name": "RayTrace", "value": 660.8101769999998}, {"lowerIsBetter": false, "replicates": [787.4015748031496], "unit": "score", "name": "Earley", "value": 846.4080099999996}, {"lowerIsBetter": false, "replicates": [12550.0], "unit": "score", "name": "Boyer", "value": 53.10462151394425}, {"lowerIsBetter": false, "replicates": [42937.5], "unit": "score", "name": "RegExp", "value": 21.216535662299844}, {"lowerIsBetter": false, "replicates": [566.8934240362812], "unit": "score", "name": "Splay", "value": 143.75012399999997}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20020.43087081639}]} 17:20:56 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20020.43"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1508.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6712.61"}}} 17:20:56 INFO - Return code: 0 17:20:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:20:56 INFO - # TBPL SUCCESS # 17:20:56 INFO - Running post-action listener: _resource_record_post_action 17:20:56 INFO - Running post-run listener: _resource_record_post_run 17:20:57 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 8192; Write bytes: 548421632; Read time: 20; Write time: 502036 17:20:57 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 250331136; Read time: 0; Write time: 231316 17:20:57 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 8192; Write bytes: 298090496; Read time: 20; Write time: 270720 17:20:57 INFO - Running post-run listener: _upload_blobber_files 17:20:57 INFO - Blob upload gear active. 17:20:57 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:20:57 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 17:20:57 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'] 17:20:57 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 17:20:58 INFO - (blobuploader) - INFO - Open directory for files ... 17:20:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:20:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:20:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:59 INFO - (blobuploader) - INFO - Done attempting. 17:20:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:20:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:21:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:21:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:21:00 INFO - (blobuploader) - INFO - Done attempting. 17:21:00 INFO - (blobuploader) - INFO - Iteration through files over. 17:21:00 INFO - Return code: 0 17:21:00 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:21:00 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:21:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d2f7d2e7810dd248d36b0d181afc7db7569f9ddc134615d740fa0bc7430cea610c3ac4c595758db85bae199bb5695c3500bf71ed1cbd5932a4ba73000eca317", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64aad1cfa106bddd277bff02a06f8c73f9a2cd6e72eb372995b2f1e424f2f3e6a21af46ee94ce1eb793ad9e7c1c835f4afd8bbb8a8d658d77cad9eb4079184d4"} 17:21:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:21:00 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:21:00 INFO - Contents: 17:21:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d2f7d2e7810dd248d36b0d181afc7db7569f9ddc134615d740fa0bc7430cea610c3ac4c595758db85bae199bb5695c3500bf71ed1cbd5932a4ba73000eca317", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64aad1cfa106bddd277bff02a06f8c73f9a2cd6e72eb372995b2f1e424f2f3e6a21af46ee94ce1eb793ad9e7c1c835f4afd8bbb8a8d658d77cad9eb4079184d4"} 17:21:00 INFO - Copying logs to upload dir... 17:21:00 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1294.221901 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 34 secs) (at 2016-01-11 17:21:00.058921) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 17:21:00.062651) ========= 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=41bf3e9aed84707956354da8000001c5-1452560327.928548-85019509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d2f7d2e7810dd248d36b0d181afc7db7569f9ddc134615d740fa0bc7430cea610c3ac4c595758db85bae199bb5695c3500bf71ed1cbd5932a4ba73000eca317", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64aad1cfa106bddd277bff02a06f8c73f9a2cd6e72eb372995b2f1e424f2f3e6a21af46ee94ce1eb793ad9e7c1c835f4afd8bbb8a8d658d77cad9eb4079184d4"} build_url:https://queue.taskcluster.net/v1/task/RIkQWdUHSiGyg3jOyqyUaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011231 build_url: 'https://queue.taskcluster.net/v1/task/RIkQWdUHSiGyg3jOyqyUaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d2f7d2e7810dd248d36b0d181afc7db7569f9ddc134615d740fa0bc7430cea610c3ac4c595758db85bae199bb5695c3500bf71ed1cbd5932a4ba73000eca317", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64aad1cfa106bddd277bff02a06f8c73f9a2cd6e72eb372995b2f1e424f2f3e6a21af46ee94ce1eb793ad9e7c1c835f4afd8bbb8a8d658d77cad9eb4079184d4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 17:21:00.090818) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 17:21:00.091260) ========= 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=41bf3e9aed84707956354da8000001c5-1452560327.928548-85019509 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004410 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 17:21:00.174345) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 17:21:00.174694) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 17:21:00.174982) ========= ========= Total master_lag: 0.23 =========