builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1452333564.61 results: success (0) buildid: 20160108233006 builduid: 72d14c6322d44eb9990d6bc86d552f65 revision: 27279907f6f7068bbad54ff5f261671db1cb8dac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-09 01:59:24.610445) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-09 01:59:24.611422) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-09 01:59:24.611811) ========= 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=8887e36bb8e381bfd44124ac000001a8-1452323779.353320-645972442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006202 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-09 01:59:24.666910) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-09 01:59:24.667318) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-09 01:59:24.762510) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 01:59:24.762835) ========= 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=8887e36bb8e381bfd44124ac000001a8-1452323779.353320-645972442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004597 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 01:59:24.833113) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-09 01:59:24.833415) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-09 01:59:24.833868) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 01:59:24.834191) ========= 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=8887e36bb8e381bfd44124ac000001a8-1452323779.353320-645972442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-09 01: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% 43.4M=0s 2016-01-09 01:59:25 (43.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177833 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 01:59:25.041905) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 01:59:25.042236) ========= 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=8887e36bb8e381bfd44124ac000001a8-1452323779.353320-645972442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015085 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 01:59:25.098969) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-09 01:59:25.099356) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 27279907f6f7068bbad54ff5f261671db1cb8dac --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 27279907f6f7068bbad54ff5f261671db1cb8dac --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=8887e36bb8e381bfd44124ac000001a8-1452323779.353320-645972442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-09 01:59:25,585 truncating revision to first 12 chars 2016-01-09 01:59:25,585 Setting DEBUG logging. 2016-01-09 01:59:25,585 attempt 1/10 2016-01-09 01:59:25,585 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/27279907f6f7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-09 01:59:26,380 unpacking tar archive at: fx-team-27279907f6f7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.078952 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-09 01:59:26.191436) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-09 01:59:26.191790) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-09 01:59:26.203153) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-09 01:59:26.203497) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-09 01:59:26.204061) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-09 01:59:26.204394) ========= /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=8887e36bb8e381bfd44124ac000001a8-1452323779.353320-645972442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:59:26 INFO - MultiFileLogger online at 20160109 01:59:26 in /builds/slave/test-pgo 01:59:26 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 01:59:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:59:26 INFO - {'append_to_log': False, 01:59:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:59:26 INFO - 'blob_upload_branch': 'Fx-Team', 01:59:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:59:26 INFO - 'branch': 'Fx-Team', 01:59:26 INFO - 'buildbot_json_path': 'buildprops.json', 01:59:26 INFO - 'config_files': ('talos/linux_config.py',), 01:59:26 INFO - 'default_actions': ('clobber', 01:59:26 INFO - 'read-buildbot-config', 01:59:26 INFO - 'download-and-extract', 01:59:26 INFO - 'populate-webroot', 01:59:26 INFO - 'create-virtualenv', 01:59:26 INFO - 'install', 01:59:26 INFO - 'run-tests'), 01:59:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:59:26 INFO - 'download_minidump_stackwalk': True, 01:59:26 INFO - 'download_symbols': 'ondemand', 01:59:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:59:26 INFO - 'tooltool.py': '/tools/tooltool.py', 01:59:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:59:26 INFO - '/tools/misc-python/virtualenv.py')}, 01:59:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:59:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:59:26 INFO - 'installer_path': 'installer.exe', 01:59:26 INFO - 'log_level': 'info', 01:59:26 INFO - 'log_name': 'talos', 01:59:26 INFO - 'log_to_console': True, 01:59:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:59:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:59:26 INFO - 'opt_config_files': (), 01:59:26 INFO - 'pip_index': False, 01:59:26 INFO - 'sps_profile': False, 01:59:26 INFO - 'sps_profile_interval': 0, 01:59:26 INFO - 'suite': 'dromaeojs', 01:59:26 INFO - 'system_bits': '32', 01:59:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:59:26 INFO - 'title': 'talos-linux64-ix-001', 01:59:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:59:26 INFO - 'use_talos_json': True, 01:59:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:59:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:59:26 INFO - 'work_dir': 'build'} 01:59:26 INFO - ##### 01:59:26 INFO - ##### Running clobber step. 01:59:26 INFO - ##### 01:59:26 INFO - Running pre-action listener: _resource_record_pre_action 01:59:26 INFO - Running main action method: clobber 01:59:26 INFO - rmtree: /builds/slave/test-pgo/build 01:59:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:59:27 INFO - Running post-action listener: _resource_record_post_action 01:59:27 INFO - ##### 01:59:27 INFO - ##### Running read-buildbot-config step. 01:59:27 INFO - ##### 01:59:27 INFO - Running pre-action listener: _resource_record_pre_action 01:59:27 INFO - Running main action method: read_buildbot_config 01:59:27 INFO - Using buildbot properties: 01:59:27 INFO - { 01:59:27 INFO - "project": "", 01:59:27 INFO - "product": "firefox", 01:59:27 INFO - "script_repo_revision": "production", 01:59:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:59:27 INFO - "repository": "", 01:59:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 01:59:27 INFO - "buildid": "20160108233006", 01:59:27 INFO - "pgo_build": "True", 01:59:27 INFO - "basedir": "/builds/slave/test-pgo", 01:59:27 INFO - "buildnumber": 885, 01:59:27 INFO - "slavename": "talos-linux64-ix-001", 01:59:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:59:27 INFO - "platform": "ubuntu64_hw", 01:59:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 01:59:27 INFO - "branch": "fx-team", 01:59:27 INFO - "repo_path": "integration/fx-team", 01:59:27 INFO - "revision": "27279907f6f7068bbad54ff5f261671db1cb8dac", 01:59:27 INFO - "stage_platform": "linux64-pgo", 01:59:27 INFO - "builduid": "72d14c6322d44eb9990d6bc86d552f65", 01:59:27 INFO - "slavebuilddir": "test" 01:59:27 INFO - } 01:59:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/BF6NwFNPQJqRIXGbGCgosQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 01:59:27 INFO - Running post-action listener: _resource_record_post_action 01:59:27 INFO - ##### 01:59:27 INFO - ##### Running download-and-extract step. 01:59:27 INFO - ##### 01:59:27 INFO - Running pre-action listener: _resource_record_pre_action 01:59:27 INFO - Running main action method: download_and_extract 01:59:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:27 INFO - https://queue.taskcluster.net/v1/task/BF6NwFNPQJqRIXGbGCgosQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:59:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BF6NwFNPQJqRIXGbGCgosQ/artifacts/public/build/test_packages.json 01:59:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BF6NwFNPQJqRIXGbGCgosQ/artifacts/public/build/test_packages.json 01:59:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BF6NwFNPQJqRIXGbGCgosQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:59:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BF6NwFNPQJqRIXGbGCgosQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:59:31 INFO - Downloaded 1302 bytes. 01:59:31 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:59:31 INFO - Using the following test package requirements: 01:59:31 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:59:31 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:59:31 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:31 INFO - u'jsshell-linux-x86_64.zip'], 01:59:31 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:59:31 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:59:31 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:59:31 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:59:31 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:59:31 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:59:31 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:59:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:59:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:31 INFO - https://queue.taskcluster.net/v1/task/BF6NwFNPQJqRIXGbGCgosQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:59:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BF6NwFNPQJqRIXGbGCgosQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:59:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BF6NwFNPQJqRIXGbGCgosQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:59:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BF6NwFNPQJqRIXGbGCgosQ/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 01:59:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BF6NwFNPQJqRIXGbGCgosQ/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 01:59:41 INFO - Downloaded 24028364 bytes. 01:59:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 01:59:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:59:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 01:59:42 INFO - Return code: 0 01:59:42 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 01:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:42 INFO - https://queue.taskcluster.net/v1/task/BF6NwFNPQJqRIXGbGCgosQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:59:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BF6NwFNPQJqRIXGbGCgosQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:59:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BF6NwFNPQJqRIXGbGCgosQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:59:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BF6NwFNPQJqRIXGbGCgosQ/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 01:59:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BF6NwFNPQJqRIXGbGCgosQ/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 01:59:44 INFO - Downloaded 24028364 bytes. 01:59:44 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 01:59:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:59:44 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 01:59:46 INFO - Return code: 0 01:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:46 INFO - https://queue.taskcluster.net/v1/task/BF6NwFNPQJqRIXGbGCgosQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:59:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BF6NwFNPQJqRIXGbGCgosQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:59:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BF6NwFNPQJqRIXGbGCgosQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:59:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BF6NwFNPQJqRIXGbGCgosQ/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 01:59:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BF6NwFNPQJqRIXGbGCgosQ/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 01:59:47 INFO - Downloaded 11132285 bytes. 01:59:47 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 01:59:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:59:47 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 01:59:47 INFO - Return code: 0 01:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:47 INFO - https://queue.taskcluster.net/v1/task/BF6NwFNPQJqRIXGbGCgosQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:59:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BF6NwFNPQJqRIXGbGCgosQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:59:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BF6NwFNPQJqRIXGbGCgosQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:59:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BF6NwFNPQJqRIXGbGCgosQ/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 01:59:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BF6NwFNPQJqRIXGbGCgosQ/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 01:59:48 INFO - Downloaded 55913279 bytes. 01:59:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BF6NwFNPQJqRIXGbGCgosQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:59:48 INFO - mkdir: /builds/slave/test-pgo/properties 01:59:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:59:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:59:48 INFO - Contents: 01:59:48 INFO - build_url:https://queue.taskcluster.net/v1/task/BF6NwFNPQJqRIXGbGCgosQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:59:48 INFO - Running post-action listener: _resource_record_post_action 01:59:48 INFO - Running post-action listener: set_extra_try_arguments 01:59:48 INFO - ##### 01:59:48 INFO - ##### Running populate-webroot step. 01:59:48 INFO - ##### 01:59:48 INFO - Running pre-action listener: _resource_record_pre_action 01:59:48 INFO - Running main action method: populate_webroot 01:59:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:59:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:59:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:59:48 INFO - '--tppagecycles', 01:59:48 INFO - '7'], 01:59:48 INFO - 'tests': ['tsvgm']}}, 01:59:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:59:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:59:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:59:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:59:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:59:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:59:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:59:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:48 INFO - 'talos_options': ['--e10s'], 01:59:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:59:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:48 INFO - 'tests': ['damp', 'tps']}, 01:59:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:48 INFO - 'talos_options': ['--e10s'], 01:59:48 INFO - 'tests': ['damp', 'tps']}, 01:59:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:59:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:59:48 INFO - 'other': {'tests': ['a11yr', 01:59:48 INFO - 'ts_paint', 01:59:48 INFO - 'tpaint', 01:59:48 INFO - 'sessionrestore', 01:59:48 INFO - 'sessionrestore_no_auto_restore']}, 01:59:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:59:48 INFO - 'tests': ['a11yr', 01:59:48 INFO - 'ts_paint', 01:59:48 INFO - 'tpaint', 01:59:48 INFO - 'sessionrestore', 01:59:48 INFO - 'sessionrestore_no_auto_restore']}, 01:59:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:59:48 INFO - 'tests': ['a11yr', 01:59:48 INFO - 'ts_paint', 01:59:48 INFO - 'tpaint', 01:59:48 INFO - 'sessionrestore', 01:59:48 INFO - 'sessionrestore_no_auto_restore']}, 01:59:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:59:48 INFO - 'tests': ['a11yr', 01:59:48 INFO - 'ts_paint', 01:59:48 INFO - 'tpaint', 01:59:48 INFO - 'sessionrestore', 01:59:48 INFO - 'sessionrestore_no_auto_restore']}, 01:59:48 INFO - 'other_l64': {'tests': ['a11yr', 01:59:48 INFO - 'ts_paint', 01:59:48 INFO - 'tpaint', 01:59:48 INFO - 'sessionrestore', 01:59:48 INFO - 'sessionrestore_no_auto_restore']}, 01:59:48 INFO - 'other_nol64': {'tests': ['a11yr', 01:59:48 INFO - 'ts_paint', 01:59:48 INFO - 'tpaint', 01:59:48 INFO - 'sessionrestore', 01:59:48 INFO - 'sessionrestore_no_auto_restore']}, 01:59:48 INFO - 'svgr': {'tests': ['tsvgx', 01:59:48 INFO - 'tsvgr_opacity', 01:59:48 INFO - 'tart', 01:59:48 INFO - 'tscrollx', 01:59:48 INFO - 'cart']}, 01:59:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:59:48 INFO - 'tests': ['tsvgx', 01:59:48 INFO - 'tsvgr_opacity', 01:59:48 INFO - 'tart', 01:59:48 INFO - 'tscrollx', 01:59:48 INFO - 'cart']}, 01:59:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:48 INFO - 'tests': ['tp5o']}, 01:59:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:48 INFO - 'talos_options': ['--e10s'], 01:59:48 INFO - 'tests': ['tp5o']}, 01:59:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:48 INFO - 'talos_options': ['--xperf_path', 01:59:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:59:48 INFO - 'tests': ['tp5n']}, 01:59:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:48 INFO - 'talos_options': ['--e10s', 01:59:48 INFO - '--xperf_path', 01:59:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:59:48 INFO - 'tests': ['tp5n']}}, 01:59:48 INFO - 'talos.zip': {'path': '', 01:59:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:59:48 INFO - Running post-action listener: _resource_record_post_action 01:59:48 INFO - ##### 01:59:48 INFO - ##### Running create-virtualenv step. 01:59:48 INFO - ##### 01:59:48 INFO - Running pre-action listener: _resource_record_pre_action 01:59:48 INFO - Running main action method: create_virtualenv 01:59:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:59:48 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 01:59:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:59:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:59:48 INFO - Using real prefix '/usr' 01:59:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:59:49 INFO - Installing distribute.............................................................................................................................................................................................done. 01:59:51 INFO - Installing pip.................done. 01:59:51 INFO - Return code: 0 01:59:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01: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')]} 01:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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')]} 01:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:51 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 0x7f2a63c83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe50660>, '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 0xe51560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe51a10>, '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': '8887e36bb8e381bfd44124ac000001a8-1452323779.353320-645972442', '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 01:59:51 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 01:59:51 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 01:59:51 INFO - Using env: {'DISPLAY': ':0', 01:59:51 INFO - 'HOME': '/home/cltbld', 01:59:51 INFO - 'LANG': 'en_US.UTF-8', 01:59:51 INFO - 'LANGUAGE': 'en_US:en', 01:59:51 INFO - 'LOGNAME': 'cltbld', 01:59:51 INFO - 'MAIL': '/var/mail/cltbld', 01:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:51 INFO - 'MOZ_NO_REMOTE': '1', 01:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:51 INFO - 'NO_EM_RESTART': '1', 01:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:59:51 INFO - 'PWD': '/builds/slave/test-pgo', 01:59:51 INFO - 'SHELL': '/bin/bash', 01:59:51 INFO - 'SHLVL': '1', 01:59:51 INFO - 'TERM': 'linux', 01:59:51 INFO - 'TMOUT': '86400', 01:59:51 INFO - 'USER': 'cltbld', 01:59:51 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452323779.353320-645972442', 01:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:51 INFO - '_': '/tools/buildbot/bin/python'} 01:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:51 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 01:59:51 INFO - Cleaning up... 01:59:51 INFO - Return code: 0 01:59:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01: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')]} 01:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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')]} 01:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:51 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 0x7f2a63c83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe50660>, '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 0xe51560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe51a10>, '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': '8887e36bb8e381bfd44124ac000001a8-1452323779.353320-645972442', '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 01:59:51 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 01:59:51 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 01:59:51 INFO - Using env: {'DISPLAY': ':0', 01:59:51 INFO - 'HOME': '/home/cltbld', 01:59:51 INFO - 'LANG': 'en_US.UTF-8', 01:59:51 INFO - 'LANGUAGE': 'en_US:en', 01:59:51 INFO - 'LOGNAME': 'cltbld', 01:59:51 INFO - 'MAIL': '/var/mail/cltbld', 01:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:51 INFO - 'MOZ_NO_REMOTE': '1', 01:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:51 INFO - 'NO_EM_RESTART': '1', 01:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:59:51 INFO - 'PWD': '/builds/slave/test-pgo', 01:59:51 INFO - 'SHELL': '/bin/bash', 01:59:51 INFO - 'SHLVL': '1', 01:59:51 INFO - 'TERM': 'linux', 01:59:51 INFO - 'TMOUT': '86400', 01:59:51 INFO - 'USER': 'cltbld', 01:59:51 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452323779.353320-645972442', 01:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:51 INFO - '_': '/tools/buildbot/bin/python'} 01:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:51 INFO - Downloading/unpacking psutil>=0.7.1 01:59:51 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 01:59:51 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 01:59:51 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 01:59:51 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 01:59:51 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 01:59:51 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 01:59:53 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 01:59:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:59:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:59:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:59:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:59:53 INFO - Installing collected packages: psutil 01:59:53 INFO - Running setup.py install for psutil 01:59:53 INFO - building 'psutil._psutil_linux' extension 01:59:53 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 01:59:53 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 01:59:53 INFO - building 'psutil._psutil_posix' extension 01:59:53 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 01:59:54 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 01:59:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:59:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:59:54 INFO - Successfully installed psutil 01:59:54 INFO - Cleaning up... 01:59:54 INFO - Return code: 0 01:59:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:54 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 0x7f2a63c83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe50660>, '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 0xe51560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe51a10>, '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': '8887e36bb8e381bfd44124ac000001a8-1452323779.353320-645972442', '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 01:59:54 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 01:59:54 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 01:59:54 INFO - Using env: {'DISPLAY': ':0', 01:59:54 INFO - 'HOME': '/home/cltbld', 01:59:54 INFO - 'LANG': 'en_US.UTF-8', 01:59:54 INFO - 'LANGUAGE': 'en_US:en', 01:59:54 INFO - 'LOGNAME': 'cltbld', 01:59:54 INFO - 'MAIL': '/var/mail/cltbld', 01:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:54 INFO - 'MOZ_NO_REMOTE': '1', 01:59:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:54 INFO - 'NO_EM_RESTART': '1', 01:59:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:59:54 INFO - 'PWD': '/builds/slave/test-pgo', 01:59:54 INFO - 'SHELL': '/bin/bash', 01:59:54 INFO - 'SHLVL': '1', 01:59:54 INFO - 'TERM': 'linux', 01:59:54 INFO - 'TMOUT': '86400', 01:59:54 INFO - 'USER': 'cltbld', 01:59:54 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452323779.353320-645972442', 01:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:54 INFO - '_': '/tools/buildbot/bin/python'} 01:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:59:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:59:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:59:56 INFO - Installing collected packages: mozsystemmonitor 01:59:56 INFO - Running setup.py install for mozsystemmonitor 01:59:56 INFO - Successfully installed mozsystemmonitor 01:59:56 INFO - Cleaning up... 01:59:56 INFO - Return code: 0 01:59:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2a63c83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe50660>, '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 0xe51560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe51a10>, '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': '8887e36bb8e381bfd44124ac000001a8-1452323779.353320-645972442', '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 01:59:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 01:59:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:59:56 INFO - Using env: {'DISPLAY': ':0', 01:59:56 INFO - 'HOME': '/home/cltbld', 01:59:56 INFO - 'LANG': 'en_US.UTF-8', 01:59:56 INFO - 'LANGUAGE': 'en_US:en', 01:59:56 INFO - 'LOGNAME': 'cltbld', 01:59:56 INFO - 'MAIL': '/var/mail/cltbld', 01:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:56 INFO - 'MOZ_NO_REMOTE': '1', 01:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:56 INFO - 'NO_EM_RESTART': '1', 01:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:59:56 INFO - 'PWD': '/builds/slave/test-pgo', 01:59:56 INFO - 'SHELL': '/bin/bash', 01:59:56 INFO - 'SHLVL': '1', 01:59:56 INFO - 'TERM': 'linux', 01:59:56 INFO - 'TMOUT': '86400', 01:59:56 INFO - 'USER': 'cltbld', 01:59:56 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452323779.353320-645972442', 01:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:56 INFO - '_': '/tools/buildbot/bin/python'} 01:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:56 INFO - Downloading/unpacking blobuploader==1.2.4 01:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:58 INFO - Downloading blobuploader-1.2.4.tar.gz 01:59:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:59:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:59:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:59:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:59:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:58 INFO - Downloading docopt-0.6.1.tar.gz 01:59:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:59:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:59:59 INFO - Installing collected packages: blobuploader, requests, docopt 01:59:59 INFO - Running setup.py install for blobuploader 01:59:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:59:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:59:59 INFO - Running setup.py install for requests 01:59:59 INFO - Running setup.py install for docopt 01:59:59 INFO - Successfully installed blobuploader requests docopt 01:59:59 INFO - Cleaning up... 01:59:59 INFO - Return code: 0 01:59:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:59 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 0x7f2a63c83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe50660>, '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 0xe51560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe51a10>, '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': '8887e36bb8e381bfd44124ac000001a8-1452323779.353320-645972442', '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 01:59:59 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 01:59:59 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 01:59:59 INFO - Using env: {'DISPLAY': ':0', 01:59:59 INFO - 'HOME': '/home/cltbld', 01:59:59 INFO - 'LANG': 'en_US.UTF-8', 01:59:59 INFO - 'LANGUAGE': 'en_US:en', 01:59:59 INFO - 'LOGNAME': 'cltbld', 01:59:59 INFO - 'MAIL': '/var/mail/cltbld', 01:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:59 INFO - 'MOZ_NO_REMOTE': '1', 01:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:59:59 INFO - 'NO_EM_RESTART': '1', 01:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:59:59 INFO - 'PWD': '/builds/slave/test-pgo', 01:59:59 INFO - 'SHELL': '/bin/bash', 01:59:59 INFO - 'SHLVL': '1', 01:59:59 INFO - 'TERM': 'linux', 01:59:59 INFO - 'TMOUT': '86400', 01:59:59 INFO - 'USER': 'cltbld', 01:59:59 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452323779.353320-645972442', 01:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:59 INFO - '_': '/tools/buildbot/bin/python'} 01:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:59:59 INFO - Running setup.py (path:/tmp/pip-maz2sw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:59:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:59:59 INFO - Running setup.py (path:/tmp/pip-PAme3G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:59:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:59:59 INFO - Running setup.py (path:/tmp/pip-7bAuLh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:00:00 INFO - Running setup.py (path:/tmp/pip-JpQv6Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:00:00 INFO - Running setup.py (path:/tmp/pip-R0bnFD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:00:00 INFO - Running setup.py (path:/tmp/pip-cwIBHq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:00:00 INFO - Running setup.py (path:/tmp/pip-JeuN39-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:00:00 INFO - Running setup.py (path:/tmp/pip-qqyNpw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:00:00 INFO - Running setup.py (path:/tmp/pip-raADNj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:00:00 INFO - Running setup.py (path:/tmp/pip-x6g43m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:00:00 INFO - Running setup.py (path:/tmp/pip-Omcm40-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:00:00 INFO - Running setup.py (path:/tmp/pip-Q4YY_K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:00:00 INFO - Running setup.py (path:/tmp/pip-_p_Lfz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:00:00 INFO - Running setup.py (path:/tmp/pip-6fFFb6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:00:00 INFO - Running setup.py (path:/tmp/pip-YLAMuj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:00:00 INFO - Running setup.py (path:/tmp/pip-vPgRLL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:00:01 INFO - Running setup.py (path:/tmp/pip-gpfqdE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:00:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:00:01 INFO - Running setup.py install for manifestparser 02:00:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 02:00:01 INFO - Running setup.py install for mozcrash 02:00:01 INFO - Running setup.py install for mozdebug 02:00:01 INFO - Running setup.py install for mozdevice 02:00:01 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 02:00:01 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 02:00:01 INFO - Running setup.py install for mozfile 02:00:01 INFO - Running setup.py install for mozhttpd 02:00:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 02:00:01 INFO - Running setup.py install for mozinfo 02:00:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 02:00:01 INFO - Running setup.py install for mozInstall 02:00:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 02:00:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 02:00:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 02:00:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 02:00:01 INFO - Running setup.py install for mozleak 02:00:02 INFO - Running setup.py install for mozlog 02:00:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 02:00:02 INFO - Running setup.py install for moznetwork 02:00:02 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 02:00:02 INFO - Running setup.py install for mozprocess 02:00:02 INFO - Running setup.py install for mozprofile 02:00:02 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 02:00:02 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 02:00:02 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 02:00:02 INFO - Running setup.py install for mozrunner 02:00:02 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 02:00:02 INFO - Running setup.py install for mozscreenshot 02:00:02 INFO - Running setup.py install for moztest 02:00:02 INFO - Running setup.py install for mozversion 02:00:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 02:00:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:00:02 INFO - Cleaning up... 02:00:02 INFO - Return code: 0 02:00:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f2a63c83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe50660>, '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 0xe51560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe51a10>, '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': '8887e36bb8e381bfd44124ac000001a8-1452323779.353320-645972442', '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 02:00:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 02:00:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 02:00:02 INFO - Using env: {'DISPLAY': ':0', 02:00:02 INFO - 'HOME': '/home/cltbld', 02:00:02 INFO - 'LANG': 'en_US.UTF-8', 02:00:02 INFO - 'LANGUAGE': 'en_US:en', 02:00:02 INFO - 'LOGNAME': 'cltbld', 02:00:02 INFO - 'MAIL': '/var/mail/cltbld', 02:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:02 INFO - 'MOZ_NO_REMOTE': '1', 02:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:02 INFO - 'NO_EM_RESTART': '1', 02:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:02 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:02 INFO - 'SHELL': '/bin/bash', 02:00:02 INFO - 'SHLVL': '1', 02:00:02 INFO - 'TERM': 'linux', 02:00:02 INFO - 'TMOUT': '86400', 02:00:02 INFO - 'USER': 'cltbld', 02:00:02 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452323779.353320-645972442', 02:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:02 INFO - '_': '/tools/buildbot/bin/python'} 02:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:00:03 INFO - Running setup.py (path:/tmp/pip-PmTdex-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:00:03 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)) 02:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:00:03 INFO - Running setup.py (path:/tmp/pip-8thvbs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:00:03 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)) 02:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:00:03 INFO - Running setup.py (path:/tmp/pip-zgsv1E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:00:03 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)) 02:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:00:03 INFO - Running setup.py (path:/tmp/pip-e5zhhX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:00:03 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)) 02:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:00:03 INFO - Running setup.py (path:/tmp/pip-lHdka_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:00:03 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)) 02:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:00:03 INFO - Running setup.py (path:/tmp/pip-s0YtkA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:00:03 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)) 02:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:00:03 INFO - Running setup.py (path:/tmp/pip-F0bkKO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:00:03 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)) 02:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:00:03 INFO - Running setup.py (path:/tmp/pip-exkVPp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:00:03 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)) 02:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:00:03 INFO - Running setup.py (path:/tmp/pip-UMFrQS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:00:03 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)) 02:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:00:03 INFO - Running setup.py (path:/tmp/pip-4KYOnz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:00:03 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)) 02:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:00:03 INFO - Running setup.py (path:/tmp/pip-BchI8X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:00:03 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)) 02:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:00:03 INFO - Running setup.py (path:/tmp/pip-k2mgNN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:00:03 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)) 02:00:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:00:04 INFO - Running setup.py (path:/tmp/pip-ZWm8q8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:00:04 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)) 02:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:00:04 INFO - Running setup.py (path:/tmp/pip-i_I_fy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:00:04 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)) 02:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:00:04 INFO - Running setup.py (path:/tmp/pip-Bx7X2Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:00:04 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)) 02:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:00:04 INFO - Running setup.py (path:/tmp/pip-03euT8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:00:04 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)) 02:00:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:00:04 INFO - Running setup.py (path:/tmp/pip-T7Woa6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:00:04 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)) 02:00:04 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)) 02:00:04 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)) 02:00:04 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)) 02:00:04 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)) 02:00:04 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)) 02:00:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 02:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:06 INFO - Downloading blessings-1.5.1.tar.gz 02:00:06 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 02:00:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 02:00:06 INFO - Installing collected packages: blessings 02:00:06 INFO - Running setup.py install for blessings 02:00:06 INFO - Successfully installed blessings 02:00:06 INFO - Cleaning up... 02:00:06 INFO - Return code: 0 02:00:06 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 02:00:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:00:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:00:06 INFO - Reading from file tmpfile_stdout 02:00:06 INFO - Current package versions: 02:00:06 INFO - argparse == 1.2.1 02:00:06 INFO - blessings == 1.5.1 02:00:06 INFO - blobuploader == 1.2.4 02:00:06 INFO - docopt == 0.6.1 02:00:06 INFO - manifestparser == 1.1 02:00:06 INFO - mozInstall == 1.12 02:00:06 INFO - mozcrash == 0.16 02:00:06 INFO - mozdebug == 0.1 02:00:06 INFO - mozdevice == 0.47 02:00:06 INFO - mozfile == 1.2 02:00:06 INFO - mozhttpd == 0.7 02:00:06 INFO - mozinfo == 0.9 02:00:06 INFO - mozleak == 0.1 02:00:06 INFO - mozlog == 3.1 02:00:06 INFO - moznetwork == 0.27 02:00:06 INFO - mozprocess == 0.22 02:00:06 INFO - mozprofile == 0.28 02:00:06 INFO - mozrunner == 6.11 02:00:06 INFO - mozscreenshot == 0.1 02:00:06 INFO - mozsystemmonitor == 0.0 02:00:06 INFO - moztest == 0.7 02:00:06 INFO - mozversion == 1.4 02:00:06 INFO - psutil == 3.1.1 02:00:06 INFO - requests == 1.2.3 02:00:06 INFO - wsgiref == 0.1.2 02:00:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:00:06 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')]} 02:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:06 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')]} 02:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:06 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 0x7f2a63c83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe50660>, '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 0xe51560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe51a10>, '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': '8887e36bb8e381bfd44124ac000001a8-1452323779.353320-645972442', '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 02:00:06 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 02:00:06 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 02:00:06 INFO - Using env: {'DISPLAY': ':0', 02:00:06 INFO - 'HOME': '/home/cltbld', 02:00:06 INFO - 'LANG': 'en_US.UTF-8', 02:00:06 INFO - 'LANGUAGE': 'en_US:en', 02:00:06 INFO - 'LOGNAME': 'cltbld', 02:00:06 INFO - 'MAIL': '/var/mail/cltbld', 02:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:06 INFO - 'MOZ_NO_REMOTE': '1', 02:00:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:06 INFO - 'NO_EM_RESTART': '1', 02:00:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:06 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:06 INFO - 'SHELL': '/bin/bash', 02:00:06 INFO - 'SHLVL': '1', 02:00:06 INFO - 'TERM': 'linux', 02:00:06 INFO - 'TMOUT': '86400', 02:00:06 INFO - 'USER': 'cltbld', 02:00:06 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452323779.353320-645972442', 02:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:06 INFO - '_': '/tools/buildbot/bin/python'} 02:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:06 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)) 02:00:06 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)) 02:00:06 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)) 02:00:06 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)) 02:00:06 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)) 02:00:06 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)) 02:00:06 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)) 02:00:06 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)) 02:00:06 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)) 02:00:06 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)) 02:00:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 02:00:06 INFO - Cleaning up... 02:00:06 INFO - Return code: 0 02:00:06 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 02:00:06 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')]} 02:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:06 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')]} 02:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:06 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 0x7f2a63c83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe50660>, '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 0xe51560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe51a10>, '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': '8887e36bb8e381bfd44124ac000001a8-1452323779.353320-645972442', '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 02:00:06 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 02:00:06 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 02:00:06 INFO - Using env: {'DISPLAY': ':0', 02:00:06 INFO - 'HOME': '/home/cltbld', 02:00:06 INFO - 'LANG': 'en_US.UTF-8', 02:00:06 INFO - 'LANGUAGE': 'en_US:en', 02:00:06 INFO - 'LOGNAME': 'cltbld', 02:00:06 INFO - 'MAIL': '/var/mail/cltbld', 02:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:06 INFO - 'MOZ_NO_REMOTE': '1', 02:00:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:06 INFO - 'NO_EM_RESTART': '1', 02:00:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:06 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:06 INFO - 'SHELL': '/bin/bash', 02:00:06 INFO - 'SHLVL': '1', 02:00:06 INFO - 'TERM': 'linux', 02:00:06 INFO - 'TMOUT': '86400', 02:00:06 INFO - 'USER': 'cltbld', 02:00:06 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452323779.353320-645972442', 02:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:06 INFO - '_': '/tools/buildbot/bin/python'} 02:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:06 INFO - Downloading/unpacking jsonschema 02:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:00:08 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 02:00:08 INFO - Downloading/unpacking functools32 (from jsonschema) 02: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 02: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 02: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 02: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 02: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 02: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 02:00:08 INFO - Downloading functools32-3.2.3-2.tar.gz 02:00:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 02:00:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 02:00:08 INFO - warning: no files found matching '*.txt' 02:00:08 INFO - no previously-included directories found matching 'build' 02:00:08 INFO - no previously-included directories found matching 'dist' 02:00:08 INFO - no previously-included directories found matching '.git*' 02:00:08 INFO - Installing collected packages: jsonschema, functools32 02:00:09 INFO - Running setup.py install for functools32 02:00:09 INFO - warning: no files found matching '*.txt' 02:00:09 INFO - no previously-included directories found matching 'build' 02:00:09 INFO - no previously-included directories found matching 'dist' 02:00:09 INFO - no previously-included directories found matching '.git*' 02:00:09 INFO - Successfully installed jsonschema functools32 02:00:09 INFO - Cleaning up... 02:00:09 INFO - Return code: 0 02:00:09 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 02:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2a63c83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc1480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe50660>, '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 0xe51560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe51a10>, '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': '8887e36bb8e381bfd44124ac000001a8-1452323779.353320-645972442', '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 02:00:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 02:00:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:00:09 INFO - Using env: {'DISPLAY': ':0', 02:00:09 INFO - 'HOME': '/home/cltbld', 02:00:09 INFO - 'LANG': 'en_US.UTF-8', 02:00:09 INFO - 'LANGUAGE': 'en_US:en', 02:00:09 INFO - 'LOGNAME': 'cltbld', 02:00:09 INFO - 'MAIL': '/var/mail/cltbld', 02:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:09 INFO - 'MOZ_NO_REMOTE': '1', 02:00:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:09 INFO - 'NO_EM_RESTART': '1', 02:00:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:09 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:09 INFO - 'SHELL': '/bin/bash', 02:00:09 INFO - 'SHLVL': '1', 02:00:09 INFO - 'TERM': 'linux', 02:00:09 INFO - 'TMOUT': '86400', 02:00:09 INFO - 'USER': 'cltbld', 02:00:09 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452323779.353320-645972442', 02:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:09 INFO - '_': '/tools/buildbot/bin/python'} 02:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:09 INFO - Downloading/unpacking flake8 02:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:00:11 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 02:00:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:00:11 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 02:00:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:11 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 02:00:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 02:00:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 02:00:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:00:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:00:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:00:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:00:11 INFO - no previously-included directories found matching 'docs/_build' 02:00:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:00:11 INFO - Running setup.py install for pep8 02:00:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:00:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:00:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:00:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:00:11 INFO - no previously-included directories found matching 'docs/_build' 02:00:11 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 02:00:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:00:11 INFO - Cleaning up... 02:00:11 INFO - Return code: 0 02:00:11 INFO - Running post-action listener: _resource_record_post_action 02:00:11 INFO - Running post-action listener: _start_resource_monitoring 02:00:12 INFO - Starting resource monitoring. 02:00:12 INFO - ##### 02:00:12 INFO - ##### Running install step. 02:00:12 INFO - ##### 02:00:12 INFO - Running pre-action listener: _resource_record_pre_action 02:00:12 INFO - Running main action method: install 02:00:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:00:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:00:12 INFO - Reading from file tmpfile_stdout 02:00:12 INFO - Detecting whether we're running mozinstall >=1.0... 02:00:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 02:00:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 02:00:12 INFO - Reading from file tmpfile_stdout 02:00:12 INFO - Output received: 02:00:12 INFO - Usage: mozinstall [options] installer 02:00:12 INFO - Options: 02:00:12 INFO - -h, --help show this help message and exit 02:00:12 INFO - -d DEST, --destination=DEST 02:00:12 INFO - Directory to install application into. [default: 02:00:12 INFO - "/builds/slave/test-pgo"] 02:00:12 INFO - --app=APP Application being installed. [default: firefox] 02:00:12 INFO - mkdir: /builds/slave/test-pgo/build/application 02:00:12 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'] 02:00:12 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 02:00:28 INFO - Reading from file tmpfile_stdout 02:00:28 INFO - Output received: 02:00:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 02:00:28 INFO - Running post-action listener: _resource_record_post_action 02:00:28 INFO - ##### 02:00:28 INFO - ##### Running run-tests step. 02:00:28 INFO - ##### 02:00:28 INFO - Running pre-action listener: _resource_record_pre_action 02:00:28 INFO - Running main action method: run_tests 02:00:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 02:00:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 02:00:28 INFO - Python 2.7.3 02:00:28 INFO - Return code: 0 02:00:28 INFO - grabbing minidump binary from tooltool 02:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:28 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 0xe50660>, '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 0xe51560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe51a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 02:00:28 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 02:00:28 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 02:00:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:00:28 INFO - Return code: 0 02:00:28 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 02:00:28 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 02:00:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 02:00:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 02:00:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 02:00:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 02:00:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 02:00:29 INFO - Return code: 0 02:00:29 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/BF6NwFNPQJqRIXGbGCgosQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 02:00:29 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/BF6NwFNPQJqRIXGbGCgosQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 02:00:29 INFO - Using env: {'DISPLAY': ':0', 02:00:29 INFO - 'HOME': '/home/cltbld', 02:00:29 INFO - 'LANG': 'en_US.UTF-8', 02:00:29 INFO - 'LANGUAGE': 'en_US:en', 02:00:29 INFO - 'LOGNAME': 'cltbld', 02:00:29 INFO - 'MAIL': '/var/mail/cltbld', 02:00:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:00:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 02:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:29 INFO - 'MOZ_NO_REMOTE': '1', 02:00:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:00:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:29 INFO - 'NO_EM_RESTART': '1', 02:00:29 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:29 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:29 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 02:00:29 INFO - 'SHELL': '/bin/bash', 02:00:29 INFO - 'SHLVL': '1', 02:00:29 INFO - 'TERM': 'linux', 02:00:29 INFO - 'TMOUT': '86400', 02:00:29 INFO - 'USER': 'cltbld', 02:00:29 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452323779.353320-645972442', 02:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:29 INFO - '_': '/tools/buildbot/bin/python'} 02:00:29 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/BF6NwFNPQJqRIXGbGCgosQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 02:00:29 INFO - mozversion application_buildid: 20160108233006 02:00:29 INFO - mozversion application_changeset: 27279907f6f7068bbad54ff5f261671db1cb8dac 02:00:29 INFO - mozversion application_display_name: Nightly 02:00:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:00:29 INFO - mozversion application_name: Firefox 02:00:29 INFO - mozversion application_remotingname: firefox 02:00:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:00:29 INFO - mozversion application_vendor: Mozilla 02:00:29 INFO - mozversion application_version: 46.0a1 02:00:29 INFO - mozversion platform_buildid: 20160108233006 02:00:29 INFO - mozversion platform_changeset: 27279907f6f7068bbad54ff5f261671db1cb8dac 02:00:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:00:29 INFO - mozversion platform_version: 46.0a1 02:00:29 INFO - using testdate: 1452333629 02:00:29 INFO - actual date: 1452333629 02:00:29 INFO - starting webserver on 'localhost:56389' 02:00:29 INFO - SUITE-START | Running 3 tests 02:00:29 INFO - TEST-START | dromaeo_css 02:00:29 INFO - operating with platform_type : linux_ 02:00:29 INFO - Initialising browser for dromaeo_css test... 02:00:29 INFO - TEST-INFO | started process 19346 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQSyIyo/profile http://localhost:56389/getInfo.html) 02:00:33 INFO - PROCESS | 19346 | __metrics Screen width/height:1600/1200 02:00:33 INFO - PROCESS | 19346 | colorDepth:24 02:00:33 INFO - PROCESS | 19346 | Browser inner width/height: 1024/697 02:00:33 INFO - PROCESS | 19346 | __metrics 02:00:33 INFO - PROCESS | 19346 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:00:33 INFO - PROCESS | 19346 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:00:35 INFO - TEST-INFO | 19346: exit 0 02:00:35 INFO - Browser initialized. 02:00:35 INFO - Running cycle 1/1 for dromaeo_css test... 02:00:35 INFO - TEST-INFO | started process 19439 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQSyIyo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:00:46 INFO - PROCESS | 19439 | RSS: Main: 148623360 02:00:46 INFO - PROCESS | 19439 | 02:01:38 INFO - PROCESS | 19439 | 1452333698415 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] 02:03:46 INFO - PROCESS | 19439 | Cycle 1(1): loaded http://localhost:56389/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56389/tests/dromaeo/cssquery-ext.html) 02:03:47 INFO - PROCESS | 19439 | RSS: Main: 256290816 02:03:47 INFO - PROCESS | 19439 | 02:06:50 INFO - PROCESS | 19439 | Cycle 1(1): loaded http://localhost:56389/tests/dromaeo/cssquery-ext.html (next: http://localhost:56389/tests/dromaeo/cssquery-jquery.html) 02:06:50 INFO - PROCESS | 19439 | RSS: Main: 236818432 02:06:50 INFO - PROCESS | 19439 | 02:09:52 INFO - PROCESS | 19439 | Cycle 1(1): loaded http://localhost:56389/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56389/tests/dromaeo/cssquery-mootools.html) 02:09:53 INFO - PROCESS | 19439 | RSS: Main: 238702592 02:09:53 INFO - PROCESS | 19439 | 02:12:55 INFO - PROCESS | 19439 | Cycle 1(1): loaded http://localhost:56389/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56389/tests/dromaeo/cssquery-prototype.html) 02:12:55 INFO - PROCESS | 19439 | RSS: Main: 216813568 02:12:55 INFO - PROCESS | 19439 | 02:15:58 INFO - PROCESS | 19439 | Cycle 1(1): loaded http://localhost:56389/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56389/tests/dromaeo/cssquery-yui.html) 02:15:58 INFO - PROCESS | 19439 | RSS: Main: 217530368 02:15:58 INFO - PROCESS | 19439 | 02:19:01 INFO - PROCESS | 19439 | Cycle 1(1): loaded http://localhost:56389/tests/dromaeo/cssquery-yui.html (next: http://localhost:56389/tests/dromaeo/cssquery-dojo.html) 02:19:01 INFO - PROCESS | 19439 | RSS: Main: 265453568 02:19:01 INFO - PROCESS | 19439 | 02:19:01 INFO - PROCESS | 19439 | __start_tp_report 02:19:01 INFO - PROCESS | 19439 | _x_x_mozilla_page_load 02:19:01 INFO - PROCESS | 19439 | _x_x_mozilla_page_load_details 02:19:01 INFO - PROCESS | 19439 | |i|pagename|runs| 02:19:01 INFO - PROCESS | 19439 | |0;dojo.html;2999.7450216731577;3099.4575949208884;3135.2632131449104;3141.481655526838;3162.320101178247;4946.925796113062;5032.773525191366;5040.697558146509;5069.062223488652;5103.566196873261;4984.227444746061;5004.524570165838;5050.242463630458;5055.368078990126;5062.519060689237;4580.221362368406;4587.793549290273;4607.746573938432;4635.490096089427;4680.3447517347595;4609.308603709437;4624.14453326134;4648.628109751212;4653.813847446098;4674.929876051862;4357.085012147453;4455.710378825383;4518.457785065781;4606.677532572721;4618.5381461853885;4687.929681054787;4692.95307046932;4710.5289471052965;4715;4731.858044258678;4643.767811609406;4650.000249946278;4673.953260467386;4684.414448193976;4719.433667959833;4785.569298763093;4865.927011094836;4948.653594248404;4973.552380285755;5045.344105266328;5429.619926605139;5455.699936503491;5456.454354564551;5457.372402173722;5461.9453805462235;5474.507294343528;5484.287042684426;5486.835394938158;5493.285872836545;5494.835154945318;4892.681975671606;4994.300797888299;5006.224035274538;5034.521720436553;5115.718635475085;5505.504504594605;5509.559235261169;5514.420985796514;5524.088525393265;5551.111822108443;5286.973565132226;5299.5230429261555;5303.231031500411;5306.336707911511;5307.787688492494;5260.526552610283;5369.838904832861;5373.247745315659;5383.16560933056;5456.6725996439545;5327.467253274642;5327.840164795062;5330.307060082165;5362.490563396471;5363.651362661414;5280.6039547034125;5300.469953004668;5341.0653135701095;5349.411564727877;5388.164834450667;4101.774402407897;4171.853985110567;4173.937390939138;4175;4177.811998460076;3739.8691045813266;3745.9250814984093;3764.4541541476333;3774.735768496234;3835.6931445484292;4980.9252861207115;5000.424951130666;5002.474740152232;5006.123928312531;5046.899062018812;5320.467953204648;5330.893382132335;5331.360236771535;5339.466053394707;5340.946590534123;4918.680285781413;4939.234418665113;5013.373328333958;5045.545900868866;5058.696478211319;4605.0559635274685;4626.051659409813;4627.930581041287;4630.32860235264;4677.438707355139;5363.946360536423;5540.889182216414;5541.168824676331;5543.944560554423;5550.306211723535;5261.079311120615;5282.366116066097;5282.524572788468;5304.07178743726;5368.812091576776;5435.239066530768;5436;5438.510534051796;5444.401115877171;5493.670379777226;5161.148410512224;5239.8472336086;5259.39516955555;5271.156614941591;5292.073887069824;5323.228131920927;5334.439883812144;5391.973040134932;5398.217258497574;5424.349078110494;5255.921161182662;5260.079486089995;5262.47375262486;5265.420803711512;5302.072137376021;5080.46655101209;5171.92242116361;5226.320578324793;5234.371875374827;5246.921296180637;5138.537531622172;5171.482851714798;5260.316158899319;5287.286216360742;5289.7619607117;5333.493318134771;5342.519173274424;5342.973285133549;5350.143976963823;5391.892162156813;5209.296744939385;5220.903610241891;5221.791128354976;5229.424763276113;5230.712310822942 02:19:01 INFO - PROCESS | 19439 | |1;ext.html;519.1719207863459;535.3655917737482;539.9703016334103;549.159785528142;556.6159350048467;27151.32121696956;27675.308117297027;27705.722942770568;27741.167764967035;34528;37925.620743792555;37995.24009519815;38442;38463;38481;8368.372372072105;8545.786355341104;8572.828543429128;8574.44266122703;8589.785255368603;7342.963285183593;7522.2101679323705;8280.089190189074;9928.6524971626;10222.591096356136;9548.474833884133;9561.330706850524;9595.904040959571;9604.951975240148;9614.855777163348;7311.744088956914;9873.802523949516;9897.505124743806;9920.553575089067;9923.404595724207;7314;9921.255905807093;10145.949270253675;10183.338083024653;10187.235957303157;36032.81983590065;36614.45078323827;36635.81682091599;36745;36790;3333.1500467380906;3343.648916863743;3442.6729460701195;3538.7699799512948;3686.907827304312;28195.718042819513;28293.15120546387;28565.428691426056;29074.70925290741;29955.25111872199;3862.324093283692;3891.8248678809523;3951.644352008333;3982.780947047911;4042.353223484258;190448;191525;191552;191595;264727;48569;54426;54642.45357546453;54774.72612636911;54801.45198547964;44240.3363949541;59184.7040764802;59620.10569841456;60149;60293.69853150706;14512.709745805025;14661.780073298909;14715.190664513555;14788.778168327484;14847.554573362817;10614.416207108683;10642.840357394645;10650.57397704083;10667.253292269466;10669.679909602724;17542.29830806779;17672.96760872516;17736.556586085193;17757.644847102987;18172.36396726108;7337.339639432476;7512.586807725627;7595.3164215220895;7600.251942053359;7685;912.7216199059351;996.9351992120489;997.4214955326039;1040.1210976724656;1066.5627092891878;25798.226053218434;26359.20922372332;26620.600690989264;26630.46739065208;26767.732322676915;1008.5612758450097;1072.871255449351;1106.833974903771;1121.2823792772633;1169.4620474581789;13212.735745285232;15150.848491515164;15261;15382.615434614225;15640.843591564166;289734;292285;293281;293665;294336;50600.24099638508;50710.746446267534;50908.49091509112;50976.23535646968;50995.23507147396;1327.8937684985178;1339.8459177194748;1344.9798253026213;1346.2931960720505;1348.6223857319967;23031.88484057569;26060.739392605832;27592.448151036464;28444;28846.423071538873;40403.797981009906;40965.38551921664;40998.38502422526;41031.79484102561;41056.58943410528;236165;237977;240340;240465;240699;29511.409771804872;31284;31587.526187107673;31919.521207181446;32073.518897217025;37149.25701486009;37253.4411983815;37505.437418438196;37895.62104378921;37987;32394.83802580972;32395.676043239266;33876;34700.305993879476;34828.30343393169;34127.4880876792;35043.12392190113;35144.297114058085;35289.82355088208;35646.287074258886;32097.197570060936;32759.672403276614;32911.34177316392;34274.65725342715;34628;30145.69854301429;31205.843970780003;31865.522017169296;31938;31940.5208921871;24205.190754219213;24452.33984371124;24528.6320705186;24637.99868544264;24771.752282476944 02:19:01 INFO - PROCESS | 19439 | |2;jquery.html;348.65309017527557;349.29093939303215;352.73368606701933;357.42811501597447;360.81937719006936;16953.321867125316;17002;17215.569610759736;17838.64322713545;17885.731714024285;12589.370531473436;13197;15466.767998480032;15654;15903.12532810695;5159.303494028305;5353.357597088355;5356.3572371315495;5358.678479291255;5360.061989151903;4962.40451145863;5167.302414174094;5173.327467429229;5173.482651734834;5176.55999240065;3754.155315054118;3913.7456065355805;5092.821751238707;5320.361556613192;5328.706921119337;5090.211017292326;5258.579313654898;5263.552598029172;5284.471552844723;5306.071437498442;5070.416902056274;5073.695578265316;5080.491950804927;5081.822136225214;5084.161113416282;11076.723081922935;11593.420328983517;11599.536018559247;11614.419279036014;12159.574414895525;2056.10177853303;2057.845661575388;2075.439631299556;2129.169623846701;2155.5796619659172;8826.602802873886;8880.955595222047;9104.8634270486;9165.58754856033;11002.899710028933;1795.1473050301133;1812.8730988830787;1821.8997955112463;1822.2619838965109;1857.3777784442227;53888;54435;54898.451015489336;54993;56510;9560.28297877662;9649.758756031015;9744.12302892743;9761.853572196424;9771.755706107262;12448.128630995925;12453.93773031129;12480.126391152713;12485.188462749893;12507.437165327583;7037.753678621224;7097.858042839114;7109.431245500347;7116.71533138679;7150.499465037501;6844.691988860513;6858.622775747382;6878.965605171942;6892.138482689664;6897.206821215524;4094;4123;4172.5410204877435;4218.915621687549;4270.935935960963;1661.2358315174913;1732.8613710903098;1759.9120043997748;1770.8317709817547;1780.2433965564583;802.3982013489882;914.346242436661;935.8409070458039;957.7031120352713;1002.659095907395;15277.465288714842;15334.233288335761;15403.22983850803;16396.016239025696;16493.83506164923;810.3962547901733;908.7001289574424;921.428714197202;954.8207963165485;978.5694294510392;8606.397552171287;8827.69103081389;8964.417312874642;9039.141281578239;9104.590293436679;522779;533605;544006.2397504055;550362;553145;64697;70205.64897175481;70326;70445.2955470449;72260.27739722641;1134.4157758754247;1160.0603511155991;1163.1973937982764;1170.6019953216119;1172.261475270574;14782.926085369505;15043.398264069752;15366.078035317916;15388.846111538742;15647.139407332706;31564;31602.683973159976;31812.204694882814;32347.35305293834;32591;42952.78523607487;43328;44573;45271.547284526736;46273.53726462827;7045.260247674126;7208.783736487704;7212.675429605575;7240.674169662272;7386.298301661333;9232.353735238468;11020.614278500214;11313.604023859454;11456.656300311004;11700.47347869331;9299.86050209261;9657.372270802376;9962.750931226778;10050.145737612385;10227.693169204937;9621.422714637145;9824.705258842247;10130.79738405213;10156.695299141038;10214;9937.65218217359;10011.099001089937;10068.848967265643;10189.541470633987;10259.384436933808;6305.5901366411035;7187.964060179875;7264.455165862687;7311;7407.555546667218;7942.324902383131;9673.758156045873;9704.85442718374;9760.365576237522;9784.315097943076 02:19:01 INFO - PROCESS | 19439 | |3;mootools.html;1260.3320240272658;1452.4916279302245;1465.8387577366489;1600.623853394452;1756.7277072053828;6864.931350686498;7463.925360746398;7570.6971721131085;7610.771676849689;7629.809254768634;7366.226546212638;7564.924350756491;7565.773026809191;7572.280633339838;7576.507527010741;2252.087904398717;2274.9772502275014;2278.646809744484;2279.669447930049;2280.281711260956;2237.149883044449;2242.686023956639;2301.3326135420707;2306.5732839424677;2323.4075310795806;2208.5251670890757;2233.586786444505;2249.302716157988;2279.6010698127843;2281.258590957937;2246.1240116354634;2283.04112272845;2297.069686776858;2298.5058212484314;2299.724033116037;2273.874936878471;2290.2556669082446;2291.8395712300144;2292.85096468729;2293.621552443845;7827.6868925242925;7870.29167374939;7874.173211812735;7880.842383152305;7885.763427097197;4492.865214043584;4537.296719008559;4598.747068911209;4631.907361852744;4632.0967411354795;2925.605043319146;2967.510360790467;3050.5424186372;3073.89241376553;3082.7071428214285;1007.6070332570304;1009.9040591143903;1058.539535302146;1072.3887384191014;1086.4676308608805;10221.182305415548;10226.079652831206;10228.488575571191;10241.743956401075;10245.334053286513;4252.936205956913;4286.335617979218;4365.541618130114;4391.494978077498;4396.472423309224;8856.202941735146;8881.378303518692;8883.555822208993;8886.022537520868;8887.955560222157;4560.6807523473035;4602.88492787683;4606.009707912748;4606.95393046072;4613.1465678848845;3793.6206379362393;3865.381538953754;4167.1040726244;4168.7290326128705;4256.446661933991;3704.7591906526527;3728.6084961079237;3751.249750050001;3782.111203867089;3786.450964610116;1176.8823117688335;1184.419634379148;1197.22180582622;1198.1972078707113;1215.4408971873038;1101.4437708956925;1115.5370521233597;1116.4864162485349;1283.9037072219621;1378.8345398552037;7241.275872412716;7293.270672932665;7394.260573942563;7416.22129676387;7429.665665045086;490.03463177540186;496.4762175904456;505.7016360347339;512.7333786431035;512.8974205158909;5665.915011274834;5729.742161602738;5731.684757338303;5733.8566535836935;5735.913961290584;8987.505687187137;9577.664781732607;9649.517524123767;9654.469004204695;9701.17540009093;9450.054994500495;9481.09929556691;9567.856482152773;9571.569279382444;9578.13796758295;7280.96359518199;7469.514481558681;7507.549547027196;7521.661525231378;7537.773866784005;7206.89189662166;7207.736296989461;7225.205227424874;7260.092488438945;7277.053982982178;8385.32917366597;8463.111373305714;8523.74428767138;8624.094470080801;8669.91330086691;8513.31893448535;8783.648654053766;8784.736457906272;8800.339974502065;8816.250618697482;6082.665453400105;6240.968795155995;6550.934490655032;6980.162380514371;7070.646467676698;6981.96509017472;6989.30106989297;7028.8945665814035;7037;7042.718291268292;6639.601623902581;6699.497537684791;6799.898001529882;6817.522773406013;6875.862482750217;6726.226483954408;6740.561863478858;6834.760783372558;6852.417544508772;6874.415674667709;6834.419074378733;6869.519133660596;6913.758018469531;6925.58446493212;6926.272741362084;6385.138006369267;6391.041343798282;6421.839454013687;6440.388163124496;6446.355364463704;6471.029345598198;6537.248216455168;6542.476601871934;6554.14796076507;6571.408573228432 02:19:01 INFO - PROCESS | 19439 | |4;prototype.html;327.93441311737655;328.5482461615279;329.22796043278504;333.0275595261835;338.4990214482564;5727.885442291152;5781.392953739854;5835.912461313078;5860.150278209657;5882.911756323648;5615.466530679579;5787.739551720172;5794.246747922764;5806.9709651451785;5824.271966004249;4507.932381014271;4509.1658043262105;4512.390827238313;4515.79678914448;4520.525344838794;4362.650987920974;4432.135733531963;4437.423134992463;4441.2893936970095;4506.256467682829;4322.13557288542;4408.845690400836;4421.668374871898;4433.84481543146;4436.423264975565;4393.0994146199955;4393.209222339993;4410.2723050696595;4412.823487060514;4414.933775993362;3893.7274390792654;3904.141088960424;3913.4129880517867;3920.2551515212017;3925.960740392588;5362.678239305654;5494.725263736837;5506.256655351516;5509.228707980846;5522.696251706155;5165.767540460651;5166.173412254021;5166.9224961625605;5167.948320516784;5170.353705786777;6086.573939824214;6091.177691011701;6096.420840020235;6099.48154406876;6107.0228763397645;4319.524852266248;4323.0705398339505;4324.675649326282;4326.740395576276;4340.305551111807;6251.843703907393;6412.39082287182;6413.35866413355;6422.743090276384;6425.325340839238;4433.7118087324225;4435.955640443554;4438.223310920576;4441.600255976978;4442.267025940748;4496.280595104833;4500.054988452396;4500.527444618333;4500.819967201341;4503.662225333113;5042.520960508819;5148.3564554430695;5148.871278218;5148.9742551287;5157.922631160535;6176.629402235881;6178.567500274938;6179.28938172107;6183.103449999725;6189.81430557084;1567.9843201568067;1595.728726116563;1597.209381356236;1598.5923589484607;1602.0788046873095;1076.3272954403499;1083.4528563075753;1083.6911480228255;1085.1969542538466;1109.5395410904546;5803.303603567599;5818.418158184148;5820.73806678692;5847.093700476433;5866.885291794545;6097.908531372033;6221.129041934133;6317.399847014526;6327.430531252209;6338.58799178052;5799.2750906136735;5898.233229680114;5940.524758019348;5940.821775346746;5945.227120474397;3388.4070287699556;3422.5892892853017;3429.451287793991;3431.828408579611;3433.3305005524185;6473.902891456632;6661.16735408074;6692.665366731741;6695.363940425652;6708.6310252936555;6529.249136349285;6656.068150458939;6677.065210870385;6691.498137639696;6692.230393504712;6725.293844146392;6737.831554211184;6738.191417029988;6746.055552222692;6752.392284694303;6311.90532142009;6412.551121421456;6423.614583125028;6439.3238709934785;6441.001644745072;6308.873822523432;6347.587406818542;6358.078078678658;6358.586691865014;6363.745450182126;6699;6705.362990515893;6721.260661327152;6726.058351830649;6733.562318449285;4432.756198409118;4468.620167285687;4473;4473.150101480708;4478.462584489882;6247.875042499034;6423.582467139621;6470;6474.773382931763;6484.513661475314;6266.937330626818;6287.685615719287;6288.993760998218;6289.937100628935;6297.496200303873;6131.110988906495;6264.937350626436;6267.2479302484;6269.655168965751;6282.497400207881;6122.755089796358;6153.476954458921;6155.507559395327;6156.661383623765;6159.384061593805;6303.023031430135;6309.968450157719;6310.1796766420075;6310.337414571404;6316.526260530387;5815.098659707752;6153.169322141453;6163.260408750979;6164.489700023523;6167.383261673796 02:19:01 INFO - PROCESS | 19439 | |5;yui.html;719.0472623773502;768.4774353439666;829.1294141151789;838.8238469921316;877.991220087799;12393.69015774605;12519.248845069302;12525.185862918905;12525.749485010318;12527.812082818753;11990.64028079157;12389.442475088621;12403.93798031011;12433.937830310859;12462.937685311561;652.9869402611945;662.3542046504667;783.9804004899895;804.1154729797234;806.4556424413527;819.2381085590398;822.8683410654296;825.5376988886213;825.9752207433756;826.2233500509532;852.7740148860557;855.8972923249219;856.0326830681321;856.4176360075146;856.4647095565272;684.9760258390958;695.7043256615943;837.4975014991018;855.0807881527321;857.1813917708573;626.408044398044;626.8088233088906;627.1971875998729;627.3694936588699;627.6892937995676;11865.703357416134;11981.28112313264;11984.64046078619;12002.279863208149;12012.879871201263;11477.827832582518;11585.826212606818;11829.467673954692;11966.521339146424;12190.817137742852;9551;9710.951445242728;9871.654492092814;9872.851907221397;9904.266753318212;3387.830608469567;3466.324066806974;3470.774399664014;3520.6479352064844;3561.732870034758;42563.36154957678;43479.78260108711;44014.11971760579;44120.3381949271;44271.557284427065;9522.571484283224;9526.285528585384;9739.26955478342;9791.755206119904;9895.455749933679;17451.563710907074;17492.300307987538;17501;17503.299868005393;17589;7073.328033836778;7201.207867134611;7204.459665525106;7257.52826066304;7526.209747976383;4041.515018197835;4051.2505186540584;4090.509138903291;4211.536730959592;4236.703430759879;2904.6804851466322;2929.3555417808047;2929.7070292970534;2932.985335073354;2936.265933516621;534.8662834291428;555.4501043966444;568.4713216708418;569.7806344557375;572.7937942340754;568.951639110672;627.8493161641173;653.3140202787055;671.5064427645676;680.9897851532132;8210.712625058095;8249.83500330002;8370.3303735701;8444.113368096385;8646.654133834576;514.3621908833095;544.4609836262072;682.9823562891233;690.2648679156682;727.31995584129;3754.2303827715255;3849.8460061597784;3946.3883098119836;4006.959930400717;4045.3122969095325;49338.75330623324;49822;54661.45338546563;55190.17214741782;55314;46298;46754.5324546757;46932;47212.29181562279;48460;42890;42988;43206.56793432026;43253.78373108177;43454.34818477726;8304.833903321778;8480.27917626984;8514;8587.742367728979;8938;32016.71933122649;32361.838190808896;32457.675423245466;33446.498302525;33699;41161.79419102885;42385.5761442394;43507.347389789815;43743.78128109339;44227.778861105486;10933.56265749361;11009.394483303175;11043.834342484708;11131.165162612675;11133.109351251718;12110.757784844078;12354.25874447536;12464.875351246734;12899.742005159656;13092;11260.380679062402;11375.488103035548;11396.886031139915;11456.140789440658;11876.82184767212;11231.831522527005;11618;11674.533018679158;11732.472038758106;12068.758624827278;11460.484278207667;11466.94266528662;11635.592754253561;11838.763224735629;11865.466054027416;8241.464304820167;8793.692220772242;8809.11908809114;9116.453012819253;9202.125798049176;8310.958445207736;8490.32077433816;8616.526091065052;8905.465672059698;9559.761005974906 02:19:01 INFO - PROCESS | 19439 | __end_tp_report 02:19:01 INFO - PROCESS | 19439 | __start_cc_report 02:19:01 INFO - PROCESS | 19439 | _x_x_mozilla_cycle_collect,908 02:19:01 INFO - PROCESS | 19439 | __end_cc_report 02:19:01 INFO - PROCESS | 19439 | __startTimestamp1452334741820__endTimestamp 02:19:01 INFO - PROCESS | 19439 | 02:19:01 INFO - PROCESS | 19439 | ------- Summary: start ------- 02:19:01 INFO - PROCESS | 19439 | Number of tests: 6 02:19:01 INFO - PROCESS | 19439 | 02:19:01 INFO - PROCESS | 19439 | [#0] dojo.html Cycles:165 Average:5003.34 Median:5221.79 stddev:525.79 (10.1%) stddev-sans-first:503.36 02:19:01 INFO - PROCESS | 19439 | Values: 2999.7 3099.5 3135.3 3141.5 3162.3 4946.9 5032.8 5040.7 5069.1 5103.6 4984.2 5004.5 5050.2 5055.4 5062.5 4580.2 4587.8 4607.7 4635.5 4680.3 4609.3 4624.1 4648.6 4653.8 4674.9 4357.1 4455.7 4518.5 4606.7 4618.5 4687.9 4693.0 4710.5 4715.0 4731.9 4643.8 4650.0 4674.0 4684.4 4719.4 4785.6 4865.9 4948.7 4973.6 5045.3 5429.6 5455.7 5456.5 5457.4 5461.9 5474.5 5484.3 5486.8 5493.3 5494.8 4892.7 4994.3 5006.2 5034.5 5115.7 5505.5 5509.6 5514.4 5524.1 5551.1 5287.0 5299.5 5303.2 5306.3 5307.8 5260.5 5369.8 5373.2 5383.2 5456.7 5327.5 5327.8 5330.3 5362.5 5363.7 5280.6 5300.5 5341.1 5349.4 5388.2 4101.8 4171.9 4173.9 4175.0 4177.8 3739.9 3745.9 3764.5 3774.7 3835.7 4980.9 5000.4 5002.5 5006.1 5046.9 5320.5 5330.9 5331.4 5339.5 5340.9 4918.7 4939.2 5013.4 5045.5 5058.7 4605.1 4626.1 4627.9 4630.3 4677.4 5363.9 5540.9 5541.2 5543.9 5550.3 5261.1 5282.4 5282.5 5304.1 5368.8 5435.2 5436.0 5438.5 5444.4 5493.7 5161.1 5239.8 5259.4 5271.2 5292.1 5323.2 5334.4 5392.0 5398.2 5424.3 5255.9 5260.1 5262.5 5265.4 5302.1 5080.5 5171.9 5226.3 5234.4 5246.9 5138.5 5171.5 5260.3 5287.3 5289.8 5333.5 5342.5 5343.0 5350.1 5391.9 5209.3 5220.9 5221.8 5229.4 5230.7 02:19:01 INFO - PROCESS | 19439 | 02:19:01 INFO - PROCESS | 19439 | [#1] ext.html Cycles:180 Average:40971.33 Median:3338.40 stddev:64901.93 (1944.1%) stddev-sans-first:65012.92 02:19:01 INFO - PROCESS | 19439 | Values: 519.2 535.4 540.0 549.2 556.6 27151.3 27675.3 27705.7 27741.2 34528.0 37925.6 37995.2 38442.0 38463.0 38481.0 8368.4 8545.8 8572.8 8574.4 8589.8 7343.0 7522.2 8280.1 9928.7 10222.6 9548.5 9561.3 9595.9 9605.0 9614.9 7311.7 9873.8 9897.5 9920.6 9923.4 7314.0 9921.3 10145.9 10183.3 10187.2 36032.8 36614.5 36635.8 36745.0 36790.0 3333.2 3343.6 3442.7 3538.8 3686.9 28195.7 28293.2 28565.4 29074.7 29955.3 3862.3 3891.8 3951.6 3982.8 4042.4 190448.0 191525.0 191552.0 191595.0 264727.0 48569.0 54426.0 54642.5 54774.7 54801.5 44240.3 59184.7 59620.1 60149.0 60293.7 14512.7 14661.8 14715.2 14788.8 14847.6 10614.4 10642.8 10650.6 10667.3 10669.7 17542.3 17673.0 17736.6 17757.6 18172.4 7337.3 7512.6 7595.3 7600.3 7685.0 912.7 996.9 997.4 1040.1 1066.6 25798.2 26359.2 26620.6 26630.5 26767.7 1008.6 1072.9 1106.8 1121.3 1169.5 13212.7 15150.8 15261.0 15382.6 15640.8 289734.0 292285.0 293281.0 293665.0 294336.0 50600.2 50710.7 50908.5 50976.2 50995.2 1327.9 1339.8 1345.0 1346.3 1348.6 23031.9 26060.7 27592.4 28444.0 28846.4 40403.8 40965.4 40998.4 41031.8 41056.6 236165.0 237977.0 240340.0 240465.0 240699.0 29511.4 31284.0 31587.5 31919.5 32073.5 37149.3 37253.4 37505.4 37895.6 37987.0 32394.8 32395.7 33876.0 34700.3 34828.3 34127.5 35043.1 35144.3 35289.8 35646.3 32097.2 32759.7 32911.3 34274.7 34628.0 30145.7 31205.8 31865.5 31938.0 31940.5 24205.2 24452.3 24528.6 24638.0 24771.8 02:19:01 INFO - PROCESS | 19439 | 02:19:01 INFO - PROCESS | 19439 | [#2] jquery.html Cycles:180 Average:27055.36 Median:5081.16 stddev:88360.13 (1739.0%) stddev-sans-first:88585.24 02:19:01 INFO - PROCESS | 19439 | Values: 348.7 349.3 352.7 357.4 360.8 16953.3 17002.0 17215.6 17838.6 17885.7 12589.4 13197.0 15466.8 15654.0 15903.1 5159.3 5353.4 5356.4 5358.7 5360.1 4962.4 5167.3 5173.3 5173.5 5176.6 3754.2 3913.7 5092.8 5320.4 5328.7 5090.2 5258.6 5263.6 5284.5 5306.1 5070.4 5073.7 5080.5 5081.8 5084.2 11076.7 11593.4 11599.5 11614.4 12159.6 2056.1 2057.8 2075.4 2129.2 2155.6 8826.6 8881.0 9104.9 9165.6 11002.9 1795.1 1812.9 1821.9 1822.3 1857.4 53888.0 54435.0 54898.5 54993.0 56510.0 9560.3 9649.8 9744.1 9761.9 9771.8 12448.1 12453.9 12480.1 12485.2 12507.4 7037.8 7097.9 7109.4 7116.7 7150.5 6844.7 6858.6 6879.0 6892.1 6897.2 4094.0 4123.0 4172.5 4218.9 4270.9 1661.2 1732.9 1759.9 1770.8 1780.2 802.4 914.3 935.8 957.7 1002.7 15277.5 15334.2 15403.2 16396.0 16493.8 810.4 908.7 921.4 954.8 978.6 8606.4 8827.7 8964.4 9039.1 9104.6 522779.0 533605.0 544006.2 550362.0 553145.0 64697.0 70205.6 70326.0 70445.3 72260.3 1134.4 1160.1 1163.2 1170.6 1172.3 14782.9 15043.4 15366.1 15388.8 15647.1 31564.0 31602.7 31812.2 32347.4 32591.0 42952.8 43328.0 44573.0 45271.5 46273.5 7045.3 7208.8 7212.7 7240.7 7386.3 9232.4 11020.6 11313.6 11456.7 11700.5 9299.9 9657.4 9962.8 10050.1 10227.7 9621.4 9824.7 10130.8 10156.7 10214.0 9937.7 10011.1 10068.8 10189.5 10259.4 6305.6 7188.0 7264.5 7311.0 7407.6 7942.3 9673.8 9704.9 9760.4 9784.3 02:19:01 INFO - PROCESS | 19439 | 02:19:01 INFO - PROCESS | 19439 | [#3] mootools.html Cycles:180 Average:5394.79 Median:6161.82 stddev:2818.69 (45.7%) stddev-sans-first:2809.47 02:19:01 INFO - PROCESS | 19439 | Values: 1260.3 1452.5 1465.8 1600.6 1756.7 6864.9 7463.9 7570.7 7610.8 7629.8 7366.2 7564.9 7565.8 7572.3 7576.5 2252.1 2275.0 2278.6 2279.7 2280.3 2237.1 2242.7 2301.3 2306.6 2323.4 2208.5 2233.6 2249.3 2279.6 2281.3 2246.1 2283.0 2297.1 2298.5 2299.7 2273.9 2290.3 2291.8 2292.9 2293.6 7827.7 7870.3 7874.2 7880.8 7885.8 4492.9 4537.3 4598.7 4631.9 4632.1 2925.6 2967.5 3050.5 3073.9 3082.7 1007.6 1009.9 1058.5 1072.4 1086.5 10221.2 10226.1 10228.5 10241.7 10245.3 4252.9 4286.3 4365.5 4391.5 4396.5 8856.2 8881.4 8883.6 8886.0 8888.0 4560.7 4602.9 4606.0 4607.0 4613.1 3793.6 3865.4 4167.1 4168.7 4256.4 3704.8 3728.6 3751.2 3782.1 3786.5 1176.9 1184.4 1197.2 1198.2 1215.4 1101.4 1115.5 1116.5 1283.9 1378.8 7241.3 7293.3 7394.3 7416.2 7429.7 490.0 496.5 505.7 512.7 512.9 5665.9 5729.7 5731.7 5733.9 5735.9 8987.5 9577.7 9649.5 9654.5 9701.2 9450.1 9481.1 9567.9 9571.6 9578.1 7281.0 7469.5 7507.5 7521.7 7537.8 7206.9 7207.7 7225.2 7260.1 7277.1 8385.3 8463.1 8523.7 8624.1 8669.9 8513.3 8783.6 8784.7 8800.3 8816.3 6082.7 6241.0 6550.9 6980.2 7070.6 6982.0 6989.3 7028.9 7037.0 7042.7 6639.6 6699.5 6799.9 6817.5 6875.9 6726.2 6740.6 6834.8 6852.4 6874.4 6834.4 6869.5 6913.8 6925.6 6926.3 6385.1 6391.0 6421.8 6440.4 6446.4 6471.0 6537.2 6542.5 6554.1 6571.4 02:19:01 INFO - PROCESS | 19439 | 02:19:01 INFO - PROCESS | 19439 | [#4] prototype.html Cycles:180 Average:5190.53 Median:5822.51 stddev:1563.58 (26.9%) stddev-sans-first:1524.78 02:19:01 INFO - PROCESS | 19439 | Values: 327.9 328.5 329.2 333.0 338.5 5727.9 5781.4 5835.9 5860.2 5882.9 5615.5 5787.7 5794.2 5807.0 5824.3 4507.9 4509.2 4512.4 4515.8 4520.5 4362.7 4432.1 4437.4 4441.3 4506.3 4322.1 4408.8 4421.7 4433.8 4436.4 4393.1 4393.2 4410.3 4412.8 4414.9 3893.7 3904.1 3913.4 3920.3 3926.0 5362.7 5494.7 5506.3 5509.2 5522.7 5165.8 5166.2 5166.9 5167.9 5170.4 6086.6 6091.2 6096.4 6099.5 6107.0 4319.5 4323.1 4324.7 4326.7 4340.3 6251.8 6412.4 6413.4 6422.7 6425.3 4433.7 4436.0 4438.2 4441.6 4442.3 4496.3 4500.1 4500.5 4500.8 4503.7 5042.5 5148.4 5148.9 5149.0 5157.9 6176.6 6178.6 6179.3 6183.1 6189.8 1568.0 1595.7 1597.2 1598.6 1602.1 1076.3 1083.5 1083.7 1085.2 1109.5 5803.3 5818.4 5820.7 5847.1 5866.9 6097.9 6221.1 6317.4 6327.4 6338.6 5799.3 5898.2 5940.5 5940.8 5945.2 3388.4 3422.6 3429.5 3431.8 3433.3 6473.9 6661.2 6692.7 6695.4 6708.6 6529.2 6656.1 6677.1 6691.5 6692.2 6725.3 6737.8 6738.2 6746.1 6752.4 6311.9 6412.6 6423.6 6439.3 6441.0 6308.9 6347.6 6358.1 6358.6 6363.7 6699.0 6705.4 6721.3 6726.1 6733.6 4432.8 4468.6 4473.0 4473.2 4478.5 6247.9 6423.6 6470.0 6474.8 6484.5 6266.9 6287.7 6289.0 6289.9 6297.5 6131.1 6264.9 6267.2 6269.7 6282.5 6122.8 6153.5 6155.5 6156.7 6159.4 6303.0 6310.0 6310.2 6310.3 6316.5 5815.1 6153.2 6163.3 6164.5 6167.4 02:19:01 INFO - PROCESS | 19439 | 02:19:01 INFO - PROCESS | 19439 | [#5] yui.html Cycles:180 Average:13039.21 Median:46526.27 stddev:14744.60 (31.7%) stddev-sans-first:14756.93 02:19:01 INFO - PROCESS | 19439 | Values: 719.0 768.5 829.1 838.8 878.0 12393.7 12519.2 12525.2 12525.7 12527.8 11990.6 12389.4 12403.9 12433.9 12462.9 653.0 662.4 784.0 804.1 806.5 819.2 822.9 825.5 826.0 826.2 852.8 855.9 856.0 856.4 856.5 685.0 695.7 837.5 855.1 857.2 626.4 626.8 627.2 627.4 627.7 11865.7 11981.3 11984.6 12002.3 12012.9 11477.8 11585.8 11829.5 11966.5 12190.8 9551.0 9711.0 9871.7 9872.9 9904.3 3387.8 3466.3 3470.8 3520.6 3561.7 42563.4 43479.8 44014.1 44120.3 44271.6 9522.6 9526.3 9739.3 9791.8 9895.5 17451.6 17492.3 17501.0 17503.3 17589.0 7073.3 7201.2 7204.5 7257.5 7526.2 4041.5 4051.3 4090.5 4211.5 4236.7 2904.7 2929.4 2929.7 2933.0 2936.3 534.9 555.5 568.5 569.8 572.8 569.0 627.8 653.3 671.5 681.0 8210.7 8249.8 8370.3 8444.1 8646.7 514.4 544.5 683.0 690.3 727.3 3754.2 3849.8 3946.4 4007.0 4045.3 49338.8 49822.0 54661.5 55190.2 55314.0 46298.0 46754.5 46932.0 47212.3 48460.0 42890.0 42988.0 43206.6 43253.8 43454.3 8304.8 8480.3 8514.0 8587.7 8938.0 32016.7 32361.8 32457.7 33446.5 33699.0 41161.8 42385.6 43507.3 43743.8 44227.8 10933.6 11009.4 11043.8 11131.2 11133.1 12110.8 12354.3 12464.9 12899.7 13092.0 11260.4 11375.5 11396.9 11456.1 11876.8 11231.8 11618.0 11674.5 11732.5 12068.8 11460.5 11466.9 11635.6 11838.8 11865.5 8241.5 8793.7 8809.1 9116.5 9202.1 8311.0 8490.3 8616.5 8905.5 9559.8 02:19:01 INFO - PROCESS | 19439 | -------- Summary: end -------- 02:19:01 INFO - PROCESS | 19439 | 02:19:02 INFO - TEST-INFO | 19439: exit 0 02:19:02 INFO - TEST-OK | dromaeo_css | took 1112875ms 02:19:02 INFO - TEST-START | kraken 02:19:02 INFO - operating with platform_type : linux_ 02:19:02 INFO - Initialising browser for kraken test... 02:19:02 INFO - TEST-INFO | started process 19635 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpP6uu4m/profile http://localhost:56389/getInfo.html) 02:19:06 INFO - PROCESS | 19635 | __metrics Screen width/height:1600/1200 02:19:06 INFO - PROCESS | 19635 | colorDepth:24 02:19:06 INFO - PROCESS | 19635 | Browser inner width/height: 1024/697 02:19:06 INFO - PROCESS | 19635 | __metrics 02:19:06 INFO - PROCESS | 19635 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:19:06 INFO - PROCESS | 19635 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:19:07 INFO - TEST-INFO | 19635: exit 0 02:19:07 INFO - Browser initialized. 02:19:07 INFO - Running cycle 1/1 for kraken test... 02:19:07 INFO - TEST-INFO | started process 19717 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpP6uu4m/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:19:19 INFO - PROCESS | 19717 | RSS: Main: 149286912 02:19:19 INFO - PROCESS | 19717 | 02:19:21 INFO - PROCESS | 19717 | Cycle 1(1): loaded http://localhost:56389/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56389/tests/kraken/driver.html?testName=audio-beat-detection) 02:19:22 INFO - PROCESS | 19717 | RSS: Main: 185073664 02:19:22 INFO - PROCESS | 19717 | 02:19:24 INFO - PROCESS | 19717 | Cycle 1(1): loaded http://localhost:56389/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56389/tests/kraken/driver.html?testName=audio-dft) 02:19:25 INFO - PROCESS | 19717 | RSS: Main: 174981120 02:19:25 INFO - PROCESS | 19717 | 02:19:28 INFO - PROCESS | 19717 | Cycle 1(1): loaded http://localhost:56389/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56389/tests/kraken/driver.html?testName=audio-fft) 02:19:28 INFO - PROCESS | 19717 | RSS: Main: 159420416 02:19:28 INFO - PROCESS | 19717 | 02:19:31 INFO - PROCESS | 19717 | Cycle 1(1): loaded http://localhost:56389/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56389/tests/kraken/driver.html?testName=audio-oscillator) 02:19:31 INFO - PROCESS | 19717 | RSS: Main: 160866304 02:19:31 INFO - PROCESS | 19717 | 02:19:33 INFO - PROCESS | 19717 | Cycle 1(1): loaded http://localhost:56389/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56389/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:19:34 INFO - PROCESS | 19717 | RSS: Main: 164470784 02:19:34 INFO - PROCESS | 19717 | 02:19:37 INFO - PROCESS | 19717 | Cycle 1(1): loaded http://localhost:56389/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56389/tests/kraken/driver.html?testName=imaging-darkroom) 02:19:37 INFO - PROCESS | 19717 | RSS: Main: 164851712 02:19:37 INFO - PROCESS | 19717 | 02:19:41 INFO - PROCESS | 19717 | Cycle 1(1): loaded http://localhost:56389/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56389/tests/kraken/driver.html?testName=imaging-desaturate) 02:19:41 INFO - PROCESS | 19717 | RSS: Main: 166514688 02:19:41 INFO - PROCESS | 19717 | 02:19:44 INFO - PROCESS | 19717 | Cycle 1(1): loaded http://localhost:56389/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56389/tests/kraken/driver.html?testName=json-parse-financial) 02:19:45 INFO - PROCESS | 19717 | RSS: Main: 164622336 02:19:45 INFO - PROCESS | 19717 | 02:19:46 INFO - PROCESS | 19717 | Cycle 1(1): loaded http://localhost:56389/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56389/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:19:47 INFO - PROCESS | 19717 | RSS: Main: 175497216 02:19:47 INFO - PROCESS | 19717 | 02:19:49 INFO - PROCESS | 19717 | Cycle 1(1): loaded http://localhost:56389/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56389/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:19:49 INFO - PROCESS | 19717 | RSS: Main: 172859392 02:19:49 INFO - PROCESS | 19717 | 02:19:51 INFO - PROCESS | 19717 | Cycle 1(1): loaded http://localhost:56389/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56389/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:19:52 INFO - PROCESS | 19717 | RSS: Main: 182136832 02:19:52 INFO - PROCESS | 19717 | 02:19:54 INFO - PROCESS | 19717 | Cycle 1(1): loaded http://localhost:56389/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:19:55 INFO - PROCESS | 19717 | RSS: Main: 189849600 02:19:55 INFO - PROCESS | 19717 | 02:19:57 INFO - PROCESS | 19717 | Cycle 1(1): loaded http://localhost:56389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:19:58 INFO - PROCESS | 19717 | RSS: Main: 190267392 02:19:58 INFO - PROCESS | 19717 | 02:20:00 INFO - PROCESS | 19717 | Cycle 1(1): loaded http://localhost:56389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56389/tests/kraken/driver.html?testName=ai-astar) 02:20:00 INFO - PROCESS | 19717 | RSS: Main: 248053760 02:20:00 INFO - PROCESS | 19717 | 02:20:00 INFO - PROCESS | 19717 | __start_tp_report 02:20:00 INFO - PROCESS | 19717 | _x_x_mozilla_page_load 02:20:00 INFO - PROCESS | 19717 | _x_x_mozilla_page_load_details 02:20:00 INFO - PROCESS | 19717 | |i|pagename|runs| 02:20:00 INFO - PROCESS | 19717 | |0;ai-astar;110;110;105;110;110;110;100;110;110;110 02:20:00 INFO - PROCESS | 19717 | |1;audio-beat-detection;156;126;151;168;126;159;150;126;161;124 02:20:00 INFO - PROCESS | 19717 | |2;audio-dft;161;160;161;160;160;159;160;162;161;162 02:20:00 INFO - PROCESS | 19717 | |3;audio-fft;74;74;86;91;71;75;71;101;95;74 02:20:00 INFO - PROCESS | 19717 | |4;audio-oscillator;96;96;141;96;96;96;137;95;96;135 02:20:00 INFO - PROCESS | 19717 | |5;imaging-gaussian-blur;110;108;109;110;109;110;109;109;110;109 02:20:00 INFO - PROCESS | 19717 | |6;imaging-darkroom;146;145;146;147;145;145;145;145;145;145 02:20:00 INFO - PROCESS | 19717 | |7;imaging-desaturate;96;96;95;96;96;95;96;96;96;96 02:20:00 INFO - PROCESS | 19717 | |8;json-parse-financial;57;56;57;55;57;59;55;64;54;55 02:20:00 INFO - PROCESS | 19717 | |9;json-stringify-tinderbox;68;68;69;67;68;68;68;68;68;68 02:20:00 INFO - PROCESS | 19717 | |10;stanford-crypto-aes;84;84;88;85;86;84;84;85;88;92 02:20:00 INFO - PROCESS | 19717 | |11;stanford-crypto-ccm;116;117;118;114;122;117;119;117;116;121 02:20:00 INFO - PROCESS | 19717 | |12;stanford-crypto-pbkdf2;141;140;161;153;155;140;151;142;149;140 02:20:00 INFO - PROCESS | 19717 | |13;stanford-crypto-sha256-iterative;67;69;68;70;69;68;67;68;70;69 02:20:00 INFO - PROCESS | 19717 | __end_tp_report 02:20:00 INFO - PROCESS | 19717 | __start_cc_report 02:20:00 INFO - PROCESS | 19717 | _x_x_mozilla_cycle_collect,955 02:20:00 INFO - PROCESS | 19717 | __end_cc_report 02:20:00 INFO - PROCESS | 19717 | __startTimestamp1452334800331__endTimestamp 02:20:00 INFO - PROCESS | 19717 | 02:20:00 INFO - PROCESS | 19717 | ------- Summary: start ------- 02:20:00 INFO - PROCESS | 19717 | Number of tests: 14 02:20:00 INFO - PROCESS | 19717 | 02:20:00 INFO - PROCESS | 19717 | [#0] ai-astar Cycles:10 Average:108.50 Median:110.00 stddev:3.37 (3.1%) stddev-sans-first:3.54 02:20:00 INFO - PROCESS | 19717 | Values: 110.0 110.0 105.0 110.0 110.0 110.0 100.0 110.0 110.0 110.0 02:20:00 INFO - PROCESS | 19717 | 02:20:00 INFO - PROCESS | 19717 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:153.50 stddev:17.28 (11.3%) stddev-sans-first:17.83 02:20:00 INFO - PROCESS | 19717 | Values: 156.0 126.0 151.0 168.0 126.0 159.0 150.0 126.0 161.0 124.0 02:20:00 INFO - PROCESS | 19717 | 02:20:00 INFO - PROCESS | 19717 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 02:20:00 INFO - PROCESS | 19717 | Values: 161.0 160.0 161.0 160.0 160.0 159.0 160.0 162.0 161.0 162.0 02:20:00 INFO - PROCESS | 19717 | 02:20:00 INFO - PROCESS | 19717 | [#3] audio-fft Cycles:10 Average:81.20 Median:74.50 stddev:11.07 (14.9%) stddev-sans-first:11.43 02:20:00 INFO - PROCESS | 19717 | Values: 74.0 74.0 86.0 91.0 71.0 75.0 71.0 101.0 95.0 74.0 02:20:00 INFO - PROCESS | 19717 | 02:20:00 INFO - PROCESS | 19717 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:96.00 stddev:20.25 (21.1%) stddev-sans-first:20.97 02:20:00 INFO - PROCESS | 19717 | Values: 96.0 96.0 141.0 96.0 96.0 96.0 137.0 95.0 96.0 135.0 02:20:00 INFO - PROCESS | 19717 | 02:20:00 INFO - PROCESS | 19717 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 02:20:00 INFO - PROCESS | 19717 | Values: 110.0 108.0 109.0 110.0 109.0 110.0 109.0 109.0 110.0 109.0 02:20:00 INFO - PROCESS | 19717 | 02:20:00 INFO - PROCESS | 19717 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 02:20:00 INFO - PROCESS | 19717 | Values: 146.0 145.0 146.0 147.0 145.0 145.0 145.0 145.0 145.0 145.0 02:20:00 INFO - PROCESS | 19717 | 02:20:00 INFO - PROCESS | 19717 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:20:00 INFO - PROCESS | 19717 | Values: 96.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 02:20:00 INFO - PROCESS | 19717 | 02:20:00 INFO - PROCESS | 19717 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.00 stddev:2.88 (5.1%) stddev-sans-first:3.06 02:20:00 INFO - PROCESS | 19717 | Values: 57.0 56.0 57.0 55.0 57.0 59.0 55.0 64.0 54.0 55.0 02:20:00 INFO - PROCESS | 19717 | 02:20:00 INFO - PROCESS | 19717 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 02:20:00 INFO - PROCESS | 19717 | Values: 68.0 68.0 69.0 67.0 68.0 68.0 68.0 68.0 68.0 68.0 02:20:00 INFO - PROCESS | 19717 | 02:20:00 INFO - PROCESS | 19717 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:85.50 stddev:2.62 (3.1%) stddev-sans-first:2.68 02:20:00 INFO - PROCESS | 19717 | Values: 84.0 84.0 88.0 85.0 86.0 84.0 84.0 85.0 88.0 92.0 02:20:00 INFO - PROCESS | 19717 | 02:20:00 INFO - PROCESS | 19717 | [#11] stanford-crypto-ccm Cycles:10 Average:117.70 Median:117.50 stddev:2.41 (2.0%) stddev-sans-first:2.47 02:20:00 INFO - PROCESS | 19717 | Values: 116.0 117.0 118.0 114.0 122.0 117.0 119.0 117.0 116.0 121.0 02:20:00 INFO - PROCESS | 19717 | 02:20:00 INFO - PROCESS | 19717 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.20 Median:150.00 stddev:7.63 (5.1%) stddev-sans-first:7.75 02:20:00 INFO - PROCESS | 19717 | Values: 141.0 140.0 161.0 153.0 155.0 140.0 151.0 142.0 149.0 140.0 02:20:00 INFO - PROCESS | 19717 | 02:20:00 INFO - PROCESS | 19717 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.08 (1.6%) stddev-sans-first:1.00 02:20:00 INFO - PROCESS | 19717 | Values: 67.0 69.0 68.0 70.0 69.0 68.0 67.0 68.0 70.0 69.0 02:20:00 INFO - PROCESS | 19717 | -------- Summary: end -------- 02:20:00 INFO - PROCESS | 19717 | 02:20:01 INFO - TEST-INFO | 19717: exit 0 02:20:01 INFO - TEST-OK | kraken | took 58713ms 02:20:01 INFO - TEST-START | v8_7 02:20:01 INFO - operating with platform_type : linux_ 02:20:01 INFO - Initialising browser for v8_7 test... 02:20:01 INFO - TEST-INFO | started process 19966 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppP8kh8/profile http://localhost:56389/getInfo.html) 02:20:05 INFO - PROCESS | 19966 | __metrics Screen width/height:1600/1200 02:20:05 INFO - PROCESS | 19966 | colorDepth:24 02:20:05 INFO - PROCESS | 19966 | Browser inner width/height: 1024/697 02:20:05 INFO - PROCESS | 19966 | __metrics 02:20:05 INFO - PROCESS | 19966 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:20:05 INFO - PROCESS | 19966 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:20:06 INFO - TEST-INFO | 19966: exit 0 02:20:06 INFO - Browser initialized. 02:20:06 INFO - Running cycle 1/1 for v8_7 test... 02:20:06 INFO - TEST-INFO | started process 20048 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppP8kh8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:20:18 INFO - PROCESS | 20048 | RSS: Main: 148860928 02:20:18 INFO - PROCESS | 20048 | 02:20:40 INFO - PROCESS | 20048 | Cycle 1(1): loaded http://localhost:56389/tests/v8_7/run.html (next: http://localhost:56389/tests/v8_7/run.html) 02:20:40 INFO - PROCESS | 20048 | RSS: Main: 548962304 02:20:40 INFO - PROCESS | 20048 | 02:20:40 INFO - PROCESS | 20048 | __start_tp_report 02:20:40 INFO - PROCESS | 20048 | _x_x_mozilla_page_load 02:20:40 INFO - PROCESS | 20048 | _x_x_mozilla_page_load_details 02:20:40 INFO - PROCESS | 20048 | |i|pagename|runs| 02:20:40 INFO - PROCESS | 20048 | |0;Richards;167.44809109176154 02:20:40 INFO - PROCESS | 20048 | |1;DeltaBlue;190.04180919802357 02:20:40 INFO - PROCESS | 20048 | |2;Encrypt;280.0336040324839 02:20:40 INFO - PROCESS | 20048 | |3;Decrypt;5256.544502617801 02:20:40 INFO - PROCESS | 20048 | |4;RayTrace;1953.125 02:20:40 INFO - PROCESS | 20048 | |5;Earley;799.3605115907275 02:20:40 INFO - PROCESS | 20048 | |6;Boyer;12048.192771084337 02:20:40 INFO - PROCESS | 20048 | |7;RegExp;42541.666666666664 02:20:40 INFO - PROCESS | 20048 | |8;Splay;567.9501698754246 02:20:40 INFO - PROCESS | 20048 | |9;NavierStokes;4845.410628019324 02:20:40 INFO - PROCESS | 20048 | __end_tp_report 02:20:40 INFO - PROCESS | 20048 | __startTimestamp1452334840955__endTimestamp 02:20:40 INFO - PROCESS | 20048 | 02:20:40 INFO - PROCESS | 20048 | ------- Summary: start ------- 02:20:40 INFO - PROCESS | 20048 | Number of tests: 10 02:20:40 INFO - PROCESS | 20048 | 02:20:40 INFO - PROCESS | 20048 | [#0] Richards Cycles:1 Average:167.45 Median:167.45 stddev:0.00 (0.0%) 02:20:40 INFO - PROCESS | 20048 | Values: 167.4 02:20:40 INFO - PROCESS | 20048 | 02:20:40 INFO - PROCESS | 20048 | [#1] DeltaBlue Cycles:1 Average:190.04 Median:190.04 stddev:0.00 (0.0%) 02:20:40 INFO - PROCESS | 20048 | Values: 190.0 02:20:40 INFO - PROCESS | 20048 | 02:20:40 INFO - PROCESS | 20048 | [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 02:20:40 INFO - PROCESS | 20048 | Values: 280.0 02:20:40 INFO - PROCESS | 20048 | 02:20:40 INFO - PROCESS | 20048 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 02:20:40 INFO - PROCESS | 20048 | Values: 5256.5 02:20:40 INFO - PROCESS | 20048 | 02:20:40 INFO - PROCESS | 20048 | [#4] RayTrace Cycles:1 Average:1953.13 Median:1953.13 stddev:0.00 (0.0%) 02:20:40 INFO - PROCESS | 20048 | Values: 1953.1 02:20:40 INFO - PROCESS | 20048 | 02:20:40 INFO - PROCESS | 20048 | [#5] Earley Cycles:1 Average:799.36 Median:799.36 stddev:0.00 (0.0%) 02:20:40 INFO - PROCESS | 20048 | Values: 799.4 02:20:40 INFO - PROCESS | 20048 | 02:20:40 INFO - PROCESS | 20048 | [#6] Boyer Cycles:1 Average:12048.19 Median:12048.19 stddev:0.00 (0.0%) 02:20:40 INFO - PROCESS | 20048 | Values: 12048.2 02:20:40 INFO - PROCESS | 20048 | 02:20:40 INFO - PROCESS | 20048 | [#7] RegExp Cycles:1 Average:42541.67 Median:42541.67 stddev:0.00 (0.0%) 02:20:40 INFO - PROCESS | 20048 | Values: 42541.7 02:20:40 INFO - PROCESS | 20048 | 02:20:40 INFO - PROCESS | 20048 | [#8] Splay Cycles:1 Average:567.95 Median:567.95 stddev:0.00 (0.0%) 02:20:40 INFO - PROCESS | 20048 | Values: 568.0 02:20:40 INFO - PROCESS | 20048 | 02:20:40 INFO - PROCESS | 20048 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 02:20:40 INFO - PROCESS | 20048 | Values: 4845.4 02:20:40 INFO - PROCESS | 20048 | -------- Summary: end -------- 02:20:40 INFO - PROCESS | 20048 | 02:20:41 INFO - TEST-INFO | 20048: exit 0 02:20:41 INFO - TEST-OK | v8_7 | took 40631ms 02:20:41 INFO - SUITE-END | took 1212s 02:20:41 INFO - Completed test suite (00:20:12) 02:20:41 INFO - Working with test: dromaeo_css 02:20:41 INFO - Generating results file: dromaeo_css 02:20:41 INFO - Working with test: kraken 02:20:41 INFO - Generating results file: kraken 02:20:41 INFO - javascript benchmark 02:20:41 INFO - Working with test: v8_7 02:20:41 INFO - Generating results file: v8_7 02:20:41 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:20:42 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 02:20:42 INFO - process_Request line: dromaeo_css 6633.41 graph.html#tests=[[72,64,35]] 02:20:42 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:20:42 INFO - process_Request line: kraken 1498.20 graph.html#tests=[[232,64,35]] 02:20:42 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:20:42 INFO - process_Request line: v8_7 18997.51 graph.html#tests=[[230,64,35]] 02:20:42 INFO - RETURN: dromaeo_css: 6633.41 02:20:42 INFO - RETURN: kraken: 1498.20 02:20:42 INFO - RETURN: v8_7: 18997.51 02:20:42 INFO - javascript benchmark 02:20:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2999.7450216731577, 3099.4575949208884, 3135.2632131449104, 3141.481655526838, 3162.320101178247, 4946.925796113062, 5032.773525191366, 5040.697558146509, 5069.062223488652, 5103.566196873261, 4984.227444746061, 5004.524570165838, 5050.242463630458, 5055.368078990126, 5062.519060689237, 4580.221362368406, 4587.793549290273, 4607.746573938432, 4635.490096089427, 4680.3447517347595, 4609.308603709437, 4624.14453326134, 4648.628109751212, 4653.813847446098, 4674.929876051862, 4357.085012147453, 4455.710378825383, 4518.457785065781, 4606.677532572721, 4618.5381461853885, 4687.929681054787, 4692.95307046932, 4710.5289471052965, 4715.0, 4731.858044258678, 4643.767811609406, 4650.000249946278, 4673.953260467386, 4684.414448193976, 4719.433667959833, 4785.569298763093, 4865.927011094836, 4948.653594248404, 4973.552380285755, 5045.344105266328, 5429.619926605139, 5455.699936503491, 5456.454354564551, 5457.372402173722, 5461.9453805462235, 5474.507294343528, 5484.287042684426, 5486.835394938158, 5493.285872836545, 5494.835154945318, 4892.681975671606, 4994.300797888299, 5006.224035274538, 5034.521720436553, 5115.718635475085, 5505.504504594605, 5509.559235261169, 5514.420985796514, 5524.088525393265, 5551.111822108443, 5286.973565132226, 5299.5230429261555, 5303.231031500411, 5306.336707911511, 5307.787688492494, 5260.526552610283, 5369.838904832861, 5373.247745315659, 5383.16560933056, 5456.6725996439545, 5327.467253274642, 5327.840164795062, 5330.307060082165, 5362.490563396471, 5363.651362661414, 5280.6039547034125, 5300.469953004668, 5341.0653135701095, 5349.411564727877, 5388.164834450667, 4101.774402407897, 4171.853985110567, 4173.937390939138, 4175.0, 4177.811998460076, 3739.8691045813266, 3745.9250814984093, 3764.4541541476333, 3774.735768496234, 3835.6931445484292, 4980.9252861207115, 5000.424951130666, 5002.474740152232, 5006.123928312531, 5046.899062018812, 5320.467953204648, 5330.893382132335, 5331.360236771535, 5339.466053394707, 5340.946590534123, 4918.680285781413, 4939.234418665113, 5013.373328333958, 5045.545900868866, 5058.696478211319, 4605.0559635274685, 4626.051659409813, 4627.930581041287, 4630.32860235264, 4677.438707355139, 5363.946360536423, 5540.889182216414, 5541.168824676331, 5543.944560554423, 5550.306211723535, 5261.079311120615, 5282.366116066097, 5282.524572788468, 5304.07178743726, 5368.812091576776, 5435.239066530768, 5436.0, 5438.510534051796, 5444.401115877171, 5493.670379777226, 5161.148410512224, 5239.8472336086, 5259.39516955555, 5271.156614941591, 5292.073887069824, 5323.228131920927, 5334.439883812144, 5391.973040134932, 5398.217258497574, 5424.349078110494, 5255.921161182662, 5260.079486089995, 5262.47375262486, 5265.420803711512, 5302.072137376021, 5080.46655101209, 5171.92242116361, 5226.320578324793, 5234.371875374827, 5246.921296180637, 5138.537531622172, 5171.482851714798, 5260.316158899319, 5287.286216360742, 5289.7619607117, 5333.493318134771, 5342.519173274424, 5342.973285133549, 5350.143976963823, 5391.892162156813, 5209.296744939385, 5220.903610241891, 5221.791128354976, 5229.424763276113, 5230.712310822942], "unit": "score", "name": "dojo.html", "value": 4971.30619195088}, {"lowerIsBetter": false, "replicates": [519.1719207863459, 535.3655917737482, 539.9703016334103, 549.159785528142, 556.6159350048467, 27151.32121696956, 27675.308117297027, 27705.722942770568, 27741.167764967035, 34528.0, 37925.620743792555, 37995.24009519815, 38442.0, 38463.0, 38481.0, 8368.372372072105, 8545.786355341104, 8572.828543429128, 8574.44266122703, 8589.785255368603, 7342.963285183593, 7522.2101679323705, 8280.089190189074, 9928.6524971626, 10222.591096356136, 9548.474833884133, 9561.330706850524, 9595.904040959571, 9604.951975240148, 9614.855777163348, 7311.744088956914, 9873.802523949516, 9897.505124743806, 9920.553575089067, 9923.404595724207, 7314.0, 9921.255905807093, 10145.949270253675, 10183.338083024653, 10187.235957303157, 36032.81983590065, 36614.45078323827, 36635.81682091599, 36745.0, 36790.0, 3333.1500467380906, 3343.648916863743, 3442.6729460701195, 3538.7699799512948, 3686.907827304312, 28195.718042819513, 28293.15120546387, 28565.428691426056, 29074.70925290741, 29955.25111872199, 3862.324093283692, 3891.8248678809523, 3951.644352008333, 3982.780947047911, 4042.353223484258, 190448.0, 191525.0, 191552.0, 191595.0, 264727.0, 48569.0, 54426.0, 54642.45357546453, 54774.72612636911, 54801.45198547964, 44240.3363949541, 59184.7040764802, 59620.10569841456, 60149.0, 60293.69853150706, 14512.709745805025, 14661.780073298909, 14715.190664513555, 14788.778168327484, 14847.554573362817, 10614.416207108683, 10642.840357394645, 10650.57397704083, 10667.253292269466, 10669.679909602724, 17542.29830806779, 17672.96760872516, 17736.556586085193, 17757.644847102987, 18172.36396726108, 7337.339639432476, 7512.586807725627, 7595.3164215220895, 7600.251942053359, 7685.0, 912.7216199059351, 996.9351992120489, 997.4214955326039, 1040.1210976724656, 1066.5627092891878, 25798.226053218434, 26359.20922372332, 26620.600690989264, 26630.46739065208, 26767.732322676915, 1008.5612758450097, 1072.871255449351, 1106.833974903771, 1121.2823792772633, 1169.4620474581789, 13212.735745285232, 15150.848491515164, 15261.0, 15382.615434614225, 15640.843591564166, 289734.0, 292285.0, 293281.0, 293665.0, 294336.0, 50600.24099638508, 50710.746446267534, 50908.49091509112, 50976.23535646968, 50995.23507147396, 1327.8937684985178, 1339.8459177194748, 1344.9798253026213, 1346.2931960720505, 1348.6223857319967, 23031.88484057569, 26060.739392605832, 27592.448151036464, 28444.0, 28846.423071538873, 40403.797981009906, 40965.38551921664, 40998.38502422526, 41031.79484102561, 41056.58943410528, 236165.0, 237977.0, 240340.0, 240465.0, 240699.0, 29511.409771804872, 31284.0, 31587.526187107673, 31919.521207181446, 32073.518897217025, 37149.25701486009, 37253.4411983815, 37505.437418438196, 37895.62104378921, 37987.0, 32394.83802580972, 32395.676043239266, 33876.0, 34700.305993879476, 34828.30343393169, 34127.4880876792, 35043.12392190113, 35144.297114058085, 35289.82355088208, 35646.287074258886, 32097.197570060936, 32759.672403276614, 32911.34177316392, 34274.65725342715, 34628.0, 30145.69854301429, 31205.843970780003, 31865.522017169296, 31938.0, 31940.5208921871, 24205.190754219213, 24452.33984371124, 24528.6320705186, 24637.99868544264, 24771.752282476944], "unit": "score", "name": "ext.html", "value": 17517.2721567535}, {"lowerIsBetter": false, "replicates": [348.65309017527557, 349.29093939303215, 352.73368606701933, 357.42811501597447, 360.81937719006936, 16953.321867125316, 17002.0, 17215.569610759736, 17838.64322713545, 17885.731714024285, 12589.370531473436, 13197.0, 15466.767998480032, 15654.0, 15903.12532810695, 5159.303494028305, 5353.357597088355, 5356.3572371315495, 5358.678479291255, 5360.061989151903, 4962.40451145863, 5167.302414174094, 5173.327467429229, 5173.482651734834, 5176.55999240065, 3754.155315054118, 3913.7456065355805, 5092.821751238707, 5320.361556613192, 5328.706921119337, 5090.211017292326, 5258.579313654898, 5263.552598029172, 5284.471552844723, 5306.071437498442, 5070.416902056274, 5073.695578265316, 5080.491950804927, 5081.822136225214, 5084.161113416282, 11076.723081922935, 11593.420328983517, 11599.536018559247, 11614.419279036014, 12159.574414895525, 2056.10177853303, 2057.845661575388, 2075.439631299556, 2129.169623846701, 2155.5796619659172, 8826.602802873886, 8880.955595222047, 9104.8634270486, 9165.58754856033, 11002.899710028933, 1795.1473050301133, 1812.8730988830787, 1821.8997955112463, 1822.2619838965109, 1857.3777784442227, 53888.0, 54435.0, 54898.451015489336, 54993.0, 56510.0, 9560.28297877662, 9649.758756031015, 9744.12302892743, 9761.853572196424, 9771.755706107262, 12448.128630995925, 12453.93773031129, 12480.126391152713, 12485.188462749893, 12507.437165327583, 7037.753678621224, 7097.858042839114, 7109.431245500347, 7116.71533138679, 7150.499465037501, 6844.691988860513, 6858.622775747382, 6878.965605171942, 6892.138482689664, 6897.206821215524, 4094.0, 4123.0, 4172.5410204877435, 4218.915621687549, 4270.935935960963, 1661.2358315174913, 1732.8613710903098, 1759.9120043997748, 1770.8317709817547, 1780.2433965564583, 802.3982013489882, 914.346242436661, 935.8409070458039, 957.7031120352713, 1002.659095907395, 15277.465288714842, 15334.233288335761, 15403.22983850803, 16396.016239025696, 16493.83506164923, 810.3962547901733, 908.7001289574424, 921.428714197202, 954.8207963165485, 978.5694294510392, 8606.397552171287, 8827.69103081389, 8964.417312874642, 9039.141281578239, 9104.590293436679, 522779.0, 533605.0, 544006.2397504055, 550362.0, 553145.0, 64697.0, 70205.64897175481, 70326.0, 70445.2955470449, 72260.27739722641, 1134.4157758754247, 1160.0603511155991, 1163.1973937982764, 1170.6019953216119, 1172.261475270574, 14782.926085369505, 15043.398264069752, 15366.078035317916, 15388.846111538742, 15647.139407332706, 31564.0, 31602.683973159976, 31812.204694882814, 32347.35305293834, 32591.0, 42952.78523607487, 43328.0, 44573.0, 45271.547284526736, 46273.53726462827, 7045.260247674126, 7208.783736487704, 7212.675429605575, 7240.674169662272, 7386.298301661333, 9232.353735238468, 11020.614278500214, 11313.604023859454, 11456.656300311004, 11700.47347869331, 9299.86050209261, 9657.372270802376, 9962.750931226778, 10050.145737612385, 10227.693169204937, 9621.422714637145, 9824.705258842247, 10130.79738405213, 10156.695299141038, 10214.0, 9937.65218217359, 10011.099001089937, 10068.848967265643, 10189.541470633987, 10259.384436933808, 6305.5901366411035, 7187.964060179875, 7264.455165862687, 7311.0, 7407.555546667218, 7942.324902383131, 9673.758156045873, 9704.85442718374, 9760.365576237522, 9784.315097943076], "unit": "score", "name": "jquery.html", "value": 7865.342319625813}, {"lowerIsBetter": false, "replicates": [1260.3320240272658, 1452.4916279302245, 1465.8387577366489, 1600.623853394452, 1756.7277072053828, 6864.931350686498, 7463.925360746398, 7570.6971721131085, 7610.771676849689, 7629.809254768634, 7366.226546212638, 7564.924350756491, 7565.773026809191, 7572.280633339838, 7576.507527010741, 2252.087904398717, 2274.9772502275014, 2278.646809744484, 2279.669447930049, 2280.281711260956, 2237.149883044449, 2242.686023956639, 2301.3326135420707, 2306.5732839424677, 2323.4075310795806, 2208.5251670890757, 2233.586786444505, 2249.302716157988, 2279.6010698127843, 2281.258590957937, 2246.1240116354634, 2283.04112272845, 2297.069686776858, 2298.5058212484314, 2299.724033116037, 2273.874936878471, 2290.2556669082446, 2291.8395712300144, 2292.85096468729, 2293.621552443845, 7827.6868925242925, 7870.29167374939, 7874.173211812735, 7880.842383152305, 7885.763427097197, 4492.865214043584, 4537.296719008559, 4598.747068911209, 4631.907361852744, 4632.0967411354795, 2925.605043319146, 2967.510360790467, 3050.5424186372, 3073.89241376553, 3082.7071428214285, 1007.6070332570304, 1009.9040591143903, 1058.539535302146, 1072.3887384191014, 1086.4676308608805, 10221.182305415548, 10226.079652831206, 10228.488575571191, 10241.743956401075, 10245.334053286513, 4252.936205956913, 4286.335617979218, 4365.541618130114, 4391.494978077498, 4396.472423309224, 8856.202941735146, 8881.378303518692, 8883.555822208993, 8886.022537520868, 8887.955560222157, 4560.6807523473035, 4602.88492787683, 4606.009707912748, 4606.95393046072, 4613.1465678848845, 3793.6206379362393, 3865.381538953754, 4167.1040726244, 4168.7290326128705, 4256.446661933991, 3704.7591906526527, 3728.6084961079237, 3751.249750050001, 3782.111203867089, 3786.450964610116, 1176.8823117688335, 1184.419634379148, 1197.22180582622, 1198.1972078707113, 1215.4408971873038, 1101.4437708956925, 1115.5370521233597, 1116.4864162485349, 1283.9037072219621, 1378.8345398552037, 7241.275872412716, 7293.270672932665, 7394.260573942563, 7416.22129676387, 7429.665665045086, 490.03463177540186, 496.4762175904456, 505.7016360347339, 512.7333786431035, 512.8974205158909, 5665.915011274834, 5729.742161602738, 5731.684757338303, 5733.8566535836935, 5735.913961290584, 8987.505687187137, 9577.664781732607, 9649.517524123767, 9654.469004204695, 9701.17540009093, 9450.054994500495, 9481.09929556691, 9567.856482152773, 9571.569279382444, 9578.13796758295, 7280.96359518199, 7469.514481558681, 7507.549547027196, 7521.661525231378, 7537.773866784005, 7206.89189662166, 7207.736296989461, 7225.205227424874, 7260.092488438945, 7277.053982982178, 8385.32917366597, 8463.111373305714, 8523.74428767138, 8624.094470080801, 8669.91330086691, 8513.31893448535, 8783.648654053766, 8784.736457906272, 8800.339974502065, 8816.250618697482, 6082.665453400105, 6240.968795155995, 6550.934490655032, 6980.162380514371, 7070.646467676698, 6981.96509017472, 6989.30106989297, 7028.8945665814035, 7037.0, 7042.718291268292, 6639.601623902581, 6699.497537684791, 6799.898001529882, 6817.522773406013, 6875.862482750217, 6726.226483954408, 6740.561863478858, 6834.760783372558, 6852.417544508772, 6874.415674667709, 6834.419074378733, 6869.519133660596, 6913.758018469531, 6925.58446493212, 6926.272741362084, 6385.138006369267, 6391.041343798282, 6421.839454013687, 6440.388163124496, 6446.355364463704, 6471.029345598198, 6537.248216455168, 6542.476601871934, 6554.14796076507, 6571.408573228432], "unit": "score", "name": "mootools.html", "value": 4365.934033737727}, {"lowerIsBetter": false, "replicates": [327.93441311737655, 328.5482461615279, 329.22796043278504, 333.0275595261835, 338.4990214482564, 5727.885442291152, 5781.392953739854, 5835.912461313078, 5860.150278209657, 5882.911756323648, 5615.466530679579, 5787.739551720172, 5794.246747922764, 5806.9709651451785, 5824.271966004249, 4507.932381014271, 4509.1658043262105, 4512.390827238313, 4515.79678914448, 4520.525344838794, 4362.650987920974, 4432.135733531963, 4437.423134992463, 4441.2893936970095, 4506.256467682829, 4322.13557288542, 4408.845690400836, 4421.668374871898, 4433.84481543146, 4436.423264975565, 4393.0994146199955, 4393.209222339993, 4410.2723050696595, 4412.823487060514, 4414.933775993362, 3893.7274390792654, 3904.141088960424, 3913.4129880517867, 3920.2551515212017, 3925.960740392588, 5362.678239305654, 5494.725263736837, 5506.256655351516, 5509.228707980846, 5522.696251706155, 5165.767540460651, 5166.173412254021, 5166.9224961625605, 5167.948320516784, 5170.353705786777, 6086.573939824214, 6091.177691011701, 6096.420840020235, 6099.48154406876, 6107.0228763397645, 4319.524852266248, 4323.0705398339505, 4324.675649326282, 4326.740395576276, 4340.305551111807, 6251.843703907393, 6412.39082287182, 6413.35866413355, 6422.743090276384, 6425.325340839238, 4433.7118087324225, 4435.955640443554, 4438.223310920576, 4441.600255976978, 4442.267025940748, 4496.280595104833, 4500.054988452396, 4500.527444618333, 4500.819967201341, 4503.662225333113, 5042.520960508819, 5148.3564554430695, 5148.871278218, 5148.9742551287, 5157.922631160535, 6176.629402235881, 6178.567500274938, 6179.28938172107, 6183.103449999725, 6189.81430557084, 1567.9843201568067, 1595.728726116563, 1597.209381356236, 1598.5923589484607, 1602.0788046873095, 1076.3272954403499, 1083.4528563075753, 1083.6911480228255, 1085.1969542538466, 1109.5395410904546, 5803.303603567599, 5818.418158184148, 5820.73806678692, 5847.093700476433, 5866.885291794545, 6097.908531372033, 6221.129041934133, 6317.399847014526, 6327.430531252209, 6338.58799178052, 5799.2750906136735, 5898.233229680114, 5940.524758019348, 5940.821775346746, 5945.227120474397, 3388.4070287699556, 3422.5892892853017, 3429.451287793991, 3431.828408579611, 3433.3305005524185, 6473.902891456632, 6661.16735408074, 6692.665366731741, 6695.363940425652, 6708.6310252936555, 6529.249136349285, 6656.068150458939, 6677.065210870385, 6691.498137639696, 6692.230393504712, 6725.293844146392, 6737.831554211184, 6738.191417029988, 6746.055552222692, 6752.392284694303, 6311.90532142009, 6412.551121421456, 6423.614583125028, 6439.3238709934785, 6441.001644745072, 6308.873822523432, 6347.587406818542, 6358.078078678658, 6358.586691865014, 6363.745450182126, 6699.0, 6705.362990515893, 6721.260661327152, 6726.058351830649, 6733.562318449285, 4432.756198409118, 4468.620167285687, 4473.0, 4473.150101480708, 4478.462584489882, 6247.875042499034, 6423.582467139621, 6470.0, 6474.773382931763, 6484.513661475314, 6266.937330626818, 6287.685615719287, 6288.993760998218, 6289.937100628935, 6297.496200303873, 6131.110988906495, 6264.937350626436, 6267.2479302484, 6269.655168965751, 6282.497400207881, 6122.755089796358, 6153.476954458921, 6155.507559395327, 6156.661383623765, 6159.384061593805, 6303.023031430135, 6309.968450157719, 6310.1796766420075, 6310.337414571404, 6316.526260530387, 5815.098659707752, 6153.169322141453, 6163.260408750979, 6164.489700023523, 6167.383261673796], "unit": "score", "name": "prototype.html", "value": 4686.465106780182}, {"lowerIsBetter": false, "replicates": [719.0472623773502, 768.4774353439666, 829.1294141151789, 838.8238469921316, 877.991220087799, 12393.69015774605, 12519.248845069302, 12525.185862918905, 12525.749485010318, 12527.812082818753, 11990.64028079157, 12389.442475088621, 12403.93798031011, 12433.937830310859, 12462.937685311561, 652.9869402611945, 662.3542046504667, 783.9804004899895, 804.1154729797234, 806.4556424413527, 819.2381085590398, 822.8683410654296, 825.5376988886213, 825.9752207433756, 826.2233500509532, 852.7740148860557, 855.8972923249219, 856.0326830681321, 856.4176360075146, 856.4647095565272, 684.9760258390958, 695.7043256615943, 837.4975014991018, 855.0807881527321, 857.1813917708573, 626.408044398044, 626.8088233088906, 627.1971875998729, 627.3694936588699, 627.6892937995676, 11865.703357416134, 11981.28112313264, 11984.64046078619, 12002.279863208149, 12012.879871201263, 11477.827832582518, 11585.826212606818, 11829.467673954692, 11966.521339146424, 12190.817137742852, 9551.0, 9710.951445242728, 9871.654492092814, 9872.851907221397, 9904.266753318212, 3387.830608469567, 3466.324066806974, 3470.774399664014, 3520.6479352064844, 3561.732870034758, 42563.36154957678, 43479.78260108711, 44014.11971760579, 44120.3381949271, 44271.557284427065, 9522.571484283224, 9526.285528585384, 9739.26955478342, 9791.755206119904, 9895.455749933679, 17451.563710907074, 17492.300307987538, 17501.0, 17503.299868005393, 17589.0, 7073.328033836778, 7201.207867134611, 7204.459665525106, 7257.52826066304, 7526.209747976383, 4041.515018197835, 4051.2505186540584, 4090.509138903291, 4211.536730959592, 4236.703430759879, 2904.6804851466322, 2929.3555417808047, 2929.7070292970534, 2932.985335073354, 2936.265933516621, 534.8662834291428, 555.4501043966444, 568.4713216708418, 569.7806344557375, 572.7937942340754, 568.951639110672, 627.8493161641173, 653.3140202787055, 671.5064427645676, 680.9897851532132, 8210.712625058095, 8249.83500330002, 8370.3303735701, 8444.113368096385, 8646.654133834576, 514.3621908833095, 544.4609836262072, 682.9823562891233, 690.2648679156682, 727.31995584129, 3754.2303827715255, 3849.8460061597784, 3946.3883098119836, 4006.959930400717, 4045.3122969095325, 49338.75330623324, 49822.0, 54661.45338546563, 55190.17214741782, 55314.0, 46298.0, 46754.5324546757, 46932.0, 47212.29181562279, 48460.0, 42890.0, 42988.0, 43206.56793432026, 43253.78373108177, 43454.34818477726, 8304.833903321778, 8480.27917626984, 8514.0, 8587.742367728979, 8938.0, 32016.71933122649, 32361.838190808896, 32457.675423245466, 33446.498302525, 33699.0, 41161.79419102885, 42385.5761442394, 43507.347389789815, 43743.78128109339, 44227.778861105486, 10933.56265749361, 11009.394483303175, 11043.834342484708, 11131.165162612675, 11133.109351251718, 12110.757784844078, 12354.25874447536, 12464.875351246734, 12899.742005159656, 13092.0, 11260.380679062402, 11375.488103035548, 11396.886031139915, 11456.140789440658, 11876.82184767212, 11231.831522527005, 11618.0, 11674.533018679158, 11732.472038758106, 12068.758624827278, 11460.484278207667, 11466.94266528662, 11635.592754253561, 11838.763224735629, 11865.466054027416, 8241.464304820167, 8793.692220772242, 8809.11908809114, 9116.453012819253, 9202.125798049176, 8310.958445207736, 8490.32077433816, 8616.526091065052, 8905.465672059698, 9559.761005974906], "unit": "score", "name": "yui.html", "value": 6078.639330787634}], "name": "dromaeo_css", "value": 6633.41160054946}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 105.0, 110.0, 110.0, 110.0, 100.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.5}, {"lowerIsBetter": true, "replicates": [156.0, 126.0, 151.0, 168.0, 126.0, 159.0, 150.0, 126.0, 161.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 144.7}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 160.0, 160.0, 159.0, 160.0, 162.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 86.0, 91.0, 71.0, 75.0, 71.0, 101.0, 95.0, 74.0], "unit": "score", "name": "audio-fft", "value": 81.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 141.0, 96.0, 96.0, 96.0, 137.0, 95.0, 96.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 108.4}, {"lowerIsBetter": true, "replicates": [110.0, 108.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 147.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 57.0, 55.0, 57.0, 59.0, 55.0, 64.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 88.0, 85.0, 86.0, 84.0, 84.0, 85.0, 88.0, 92.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 118.0, 114.0, 122.0, 117.0, 119.0, 117.0, 116.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.7}, {"lowerIsBetter": true, "replicates": [141.0, 140.0, 161.0, 153.0, 155.0, 140.0, 151.0, 142.0, 149.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.2}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 70.0, 69.0, 68.0, 67.0, 68.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1498.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.44809109176154], "unit": "score", "name": "Richards", "value": 210.82354399999997}, {"lowerIsBetter": false, "replicates": [190.04180919802357], "unit": "score", "name": "DeltaBlue", "value": 347.91291599999994}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1953.125], "unit": "score", "name": "RayTrace", "value": 378.87436799999995}, {"lowerIsBetter": false, "replicates": [799.3605115907275], "unit": "score", "name": "Earley", "value": 833.7452129999997}, {"lowerIsBetter": false, "replicates": [12048.192771084337], "unit": "score", "name": "Boyer", "value": 55.31642899999996}, {"lowerIsBetter": false, "replicates": [42541.666666666664], "unit": "score", "name": "RegExp", "value": 21.413947110675796}, {"lowerIsBetter": false, "replicates": [567.9501698754246], "unit": "score", "name": "Splay", "value": 143.48265802592218}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 18997.505896178583}]} 02:20:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "18997.51"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1498.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6633.41"}}} 02:20:42 INFO - Return code: 0 02:20:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:20:42 INFO - # TBPL SUCCESS # 02:20:42 INFO - Running post-action listener: _resource_record_post_action 02:20:42 INFO - Running post-run listener: _resource_record_post_run 02:20:43 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 550473728; Read time: 0; Write time: 385824 02:20:43 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 239267840; Read time: 0; Write time: 219000 02:20:43 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 311205888; Read time: 0; Write time: 166824 02:20:43 INFO - Running post-run listener: _upload_blobber_files 02:20:43 INFO - Blob upload gear active. 02:20:43 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:20:43 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:20:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 02:20:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 02:20:43 INFO - (blobuploader) - INFO - Open directory for files ... 02:20:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 02:20:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:20:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:20:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:20:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:20:44 INFO - (blobuploader) - INFO - Done attempting. 02:20:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:20:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:20:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:20:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:20:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:20:45 INFO - (blobuploader) - INFO - Done attempting. 02:20:45 INFO - (blobuploader) - INFO - Iteration through files over. 02:20:45 INFO - Return code: 0 02:20:45 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:20:45 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:20:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/195227afe9983bf759bbc1673463ae2ac7490e8555f820e779b0829ac2c09e3a1f0735132d81b7c1be22c1a05158c9f5979eb61b28593be1426c68707cac2ee9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b2f882fb02a7c4f982d22f225beee862c379d43dcc8b5934257e2f3bda05036905fd8c75e85d079be894ab2db57d3d36624a901b8c3621d79f628d78777463d"} 02:20:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:20:45 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:20:45 INFO - Contents: 02:20:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/195227afe9983bf759bbc1673463ae2ac7490e8555f820e779b0829ac2c09e3a1f0735132d81b7c1be22c1a05158c9f5979eb61b28593be1426c68707cac2ee9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b2f882fb02a7c4f982d22f225beee862c379d43dcc8b5934257e2f3bda05036905fd8c75e85d079be894ab2db57d3d36624a901b8c3621d79f628d78777463d"} 02:20:45 INFO - Copying logs to upload dir... 02:20:45 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1278.957259 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-09 02:20:45.196562) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-09 02:20:45.200503) ========= 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=8887e36bb8e381bfd44124ac000001a8-1452323779.353320-645972442 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/195227afe9983bf759bbc1673463ae2ac7490e8555f820e779b0829ac2c09e3a1f0735132d81b7c1be22c1a05158c9f5979eb61b28593be1426c68707cac2ee9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b2f882fb02a7c4f982d22f225beee862c379d43dcc8b5934257e2f3bda05036905fd8c75e85d079be894ab2db57d3d36624a901b8c3621d79f628d78777463d"} build_url:https://queue.taskcluster.net/v1/task/BF6NwFNPQJqRIXGbGCgosQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011353 build_url: 'https://queue.taskcluster.net/v1/task/BF6NwFNPQJqRIXGbGCgosQ/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/195227afe9983bf759bbc1673463ae2ac7490e8555f820e779b0829ac2c09e3a1f0735132d81b7c1be22c1a05158c9f5979eb61b28593be1426c68707cac2ee9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b2f882fb02a7c4f982d22f225beee862c379d43dcc8b5934257e2f3bda05036905fd8c75e85d079be894ab2db57d3d36624a901b8c3621d79f628d78777463d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-09 02:20:45.233263) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 02:20:45.233936) ========= 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=8887e36bb8e381bfd44124ac000001a8-1452323779.353320-645972442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 02:20:45.314514) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-09 02:20:45.314958) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-09 02:20:45.315308) ========= ========= Total master_lag: 0.33 =========