builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-049 starttime: 1452009329.95 results: success (0) buildid: 20160105053004 builduid: 394c1f2316f344b084d0e58f30611fc9 revision: 892c469f9513cb053876991b2794feea21502601 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 07:55:29.953453) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 07:55:29.954510) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 07:55:29.954976) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1452007357.472743-1028703830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006367 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 07:55:29.984431) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 07:55:29.984984) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 07:55:30.002123) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 07:55:30.002657) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1452007357.472743-1028703830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004638 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 07:55:30.066856) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 07:55:30.067361) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 07:55:30.067958) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 07:55:30.068427) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1452007357.472743-1028703830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-05 07:55:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-01-05 07:55:30 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097724 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 07:55:30.189528) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 07:55:30.190048) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1452007357.472743-1028703830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019411 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 07:55:30.248390) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 07:55:30.248944) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 892c469f9513cb053876991b2794feea21502601 --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 892c469f9513cb053876991b2794feea21502601 --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=8c719f637fb0c43bc4e5671e000001d0-1452007357.472743-1028703830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-05 07:55:30,611 truncating revision to first 12 chars 2016-01-05 07:55:30,611 Setting DEBUG logging. 2016-01-05 07:55:30,611 attempt 1/10 2016-01-05 07:55:30,611 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/892c469f9513?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-05 07:55:30,825 unpacking tar archive at: fx-team-892c469f9513/testing/mozharness/ program finished with exit code 0 elapsedTime=0.515166 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 07:55:30.778169) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 07:55:30.778527) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 07:55:30.786583) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 07:55:30.786938) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 07:55:30.787457) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-05 07:55:30.787743) ========= /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=8c719f637fb0c43bc4e5671e000001d0-1452007357.472743-1028703830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:55:31 INFO - MultiFileLogger online at 20160105 07:55:31 in /builds/slave/test-pgo 07:55:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 07:55:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:55:31 INFO - {'append_to_log': False, 07:55:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:55:31 INFO - 'blob_upload_branch': 'Fx-Team', 07:55:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:55:31 INFO - 'branch': 'Fx-Team', 07:55:31 INFO - 'buildbot_json_path': 'buildprops.json', 07:55:31 INFO - 'config_files': ('talos/linux_config.py',), 07:55:31 INFO - 'default_actions': ('clobber', 07:55:31 INFO - 'read-buildbot-config', 07:55:31 INFO - 'download-and-extract', 07:55:31 INFO - 'populate-webroot', 07:55:31 INFO - 'create-virtualenv', 07:55:31 INFO - 'install', 07:55:31 INFO - 'run-tests'), 07:55:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:55:31 INFO - 'download_minidump_stackwalk': True, 07:55:31 INFO - 'download_symbols': 'ondemand', 07:55:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:55:31 INFO - 'tooltool.py': '/tools/tooltool.py', 07:55:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:55:31 INFO - '/tools/misc-python/virtualenv.py')}, 07:55:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:55:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:55:31 INFO - 'installer_path': 'installer.exe', 07:55:31 INFO - 'log_level': 'info', 07:55:31 INFO - 'log_name': 'talos', 07:55:31 INFO - 'log_to_console': True, 07:55:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:55:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:55:31 INFO - 'opt_config_files': (), 07:55:31 INFO - 'pip_index': False, 07:55:31 INFO - 'sps_profile': False, 07:55:31 INFO - 'sps_profile_interval': 0, 07:55:31 INFO - 'suite': 'dromaeojs', 07:55:31 INFO - 'system_bits': '32', 07:55:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:55:31 INFO - 'title': 'talos-linux64-ix-049', 07:55:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:55:31 INFO - 'use_talos_json': True, 07:55:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:55:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:55:31 INFO - 'work_dir': 'build'} 07:55:31 INFO - ##### 07:55:31 INFO - ##### Running clobber step. 07:55:31 INFO - ##### 07:55:31 INFO - Running pre-action listener: _resource_record_pre_action 07:55:31 INFO - Running main action method: clobber 07:55:31 INFO - rmtree: /builds/slave/test-pgo/build 07:55:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:55:32 INFO - Running post-action listener: _resource_record_post_action 07:55:32 INFO - ##### 07:55:32 INFO - ##### Running read-buildbot-config step. 07:55:32 INFO - ##### 07:55:32 INFO - Running pre-action listener: _resource_record_pre_action 07:55:32 INFO - Running main action method: read_buildbot_config 07:55:32 INFO - Using buildbot properties: 07:55:32 INFO - { 07:55:32 INFO - "project": "", 07:55:32 INFO - "product": "firefox", 07:55:32 INFO - "script_repo_revision": "production", 07:55:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:55:32 INFO - "repository": "", 07:55:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 07:55:32 INFO - "buildid": "20160105053004", 07:55:32 INFO - "pgo_build": "True", 07:55:32 INFO - "basedir": "/builds/slave/test-pgo", 07:55:32 INFO - "buildnumber": 399, 07:55:32 INFO - "slavename": "talos-linux64-ix-049", 07:55:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:55:32 INFO - "platform": "ubuntu64_hw", 07:55:32 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 07:55:32 INFO - "branch": "fx-team", 07:55:32 INFO - "repo_path": "integration/fx-team", 07:55:32 INFO - "revision": "892c469f9513cb053876991b2794feea21502601", 07:55:32 INFO - "stage_platform": "linux64-pgo", 07:55:32 INFO - "builduid": "394c1f2316f344b084d0e58f30611fc9", 07:55:32 INFO - "slavebuilddir": "test" 07:55:32 INFO - } 07:55:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/djpLSnQuQZmtbnNcSyESGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:55:32 INFO - Running post-action listener: _resource_record_post_action 07:55:32 INFO - ##### 07:55:32 INFO - ##### Running download-and-extract step. 07:55:32 INFO - ##### 07:55:32 INFO - Running pre-action listener: _resource_record_pre_action 07:55:32 INFO - Running main action method: download_and_extract 07:55:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:32 INFO - https://queue.taskcluster.net/v1/task/djpLSnQuQZmtbnNcSyESGw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:55:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djpLSnQuQZmtbnNcSyESGw/artifacts/public/build/test_packages.json 07:55:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djpLSnQuQZmtbnNcSyESGw/artifacts/public/build/test_packages.json 07:55:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djpLSnQuQZmtbnNcSyESGw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:55:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djpLSnQuQZmtbnNcSyESGw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:55:37 INFO - Downloaded 1302 bytes. 07:55:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:55:37 INFO - Using the following test package requirements: 07:55:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:55:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:55:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:55:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:55:37 INFO - u'jsshell-linux-x86_64.zip'], 07:55:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:55:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:55:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:55:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:55:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:55:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:55:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:55:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:55:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:55:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:55:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:55:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:55:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:37 INFO - https://queue.taskcluster.net/v1/task/djpLSnQuQZmtbnNcSyESGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:55:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djpLSnQuQZmtbnNcSyESGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:55:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djpLSnQuQZmtbnNcSyESGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:55:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djpLSnQuQZmtbnNcSyESGw/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 07:55:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djpLSnQuQZmtbnNcSyESGw/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 07:55:39 INFO - Downloaded 24051354 bytes. 07:55:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 07:55:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:55:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:55:40 INFO - Return code: 0 07:55:40 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:55:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:40 INFO - https://queue.taskcluster.net/v1/task/djpLSnQuQZmtbnNcSyESGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:55:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djpLSnQuQZmtbnNcSyESGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:55:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djpLSnQuQZmtbnNcSyESGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:55:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djpLSnQuQZmtbnNcSyESGw/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 07:55:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djpLSnQuQZmtbnNcSyESGw/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 07:55:47 INFO - Downloaded 24051354 bytes. 07:55:47 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 07:55:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:55:47 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 07:55:49 INFO - Return code: 0 07:55:49 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')]} 07:55:49 INFO - https://queue.taskcluster.net/v1/task/djpLSnQuQZmtbnNcSyESGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:55:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djpLSnQuQZmtbnNcSyESGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:55:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djpLSnQuQZmtbnNcSyESGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:55:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djpLSnQuQZmtbnNcSyESGw/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 07:55:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djpLSnQuQZmtbnNcSyESGw/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 07:55:50 INFO - Downloaded 11132285 bytes. 07:55:50 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 07:55:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:55:50 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 07:55:51 INFO - Return code: 0 07:55: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')]} 07:55:51 INFO - https://queue.taskcluster.net/v1/task/djpLSnQuQZmtbnNcSyESGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:55:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djpLSnQuQZmtbnNcSyESGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:55:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djpLSnQuQZmtbnNcSyESGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:55:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djpLSnQuQZmtbnNcSyESGw/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 07:55:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/djpLSnQuQZmtbnNcSyESGw/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 07:55:52 INFO - Downloaded 54993881 bytes. 07:55:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/djpLSnQuQZmtbnNcSyESGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:55:52 INFO - mkdir: /builds/slave/test-pgo/properties 07:55:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:55:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:55:52 INFO - Contents: 07:55:52 INFO - build_url:https://queue.taskcluster.net/v1/task/djpLSnQuQZmtbnNcSyESGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:55:52 INFO - Running post-action listener: _resource_record_post_action 07:55:52 INFO - Running post-action listener: set_extra_try_arguments 07:55:52 INFO - ##### 07:55:52 INFO - ##### Running populate-webroot step. 07:55:52 INFO - ##### 07:55:52 INFO - Running pre-action listener: _resource_record_pre_action 07:55:52 INFO - Running main action method: populate_webroot 07:55:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:55:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:55:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:55:52 INFO - '--tppagecycles', 07:55:52 INFO - '7'], 07:55:52 INFO - 'tests': ['tsvgm']}}, 07:55:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:55:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:55:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:55:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:55:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:55:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:55:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:55:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:52 INFO - 'talos_options': ['--e10s'], 07:55:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:55:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:52 INFO - 'tests': ['damp', 'tps']}, 07:55:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:52 INFO - 'talos_options': ['--e10s'], 07:55:52 INFO - 'tests': ['damp', 'tps']}, 07:55:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:55:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:55:52 INFO - 'other': {'tests': ['a11yr', 07:55:52 INFO - 'ts_paint', 07:55:52 INFO - 'tpaint', 07:55:52 INFO - 'sessionrestore', 07:55:52 INFO - 'sessionrestore_no_auto_restore']}, 07:55:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:55:52 INFO - 'tests': ['a11yr', 07:55:52 INFO - 'ts_paint', 07:55:52 INFO - 'tpaint', 07:55:52 INFO - 'sessionrestore', 07:55:52 INFO - 'sessionrestore_no_auto_restore']}, 07:55:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:55:52 INFO - 'tests': ['a11yr', 07:55:52 INFO - 'ts_paint', 07:55:52 INFO - 'tpaint', 07:55:52 INFO - 'sessionrestore', 07:55:52 INFO - 'sessionrestore_no_auto_restore']}, 07:55:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:55:52 INFO - 'tests': ['a11yr', 07:55:52 INFO - 'ts_paint', 07:55:52 INFO - 'tpaint', 07:55:52 INFO - 'sessionrestore', 07:55:52 INFO - 'sessionrestore_no_auto_restore']}, 07:55:52 INFO - 'other_l64': {'tests': ['a11yr', 07:55:52 INFO - 'ts_paint', 07:55:52 INFO - 'tpaint', 07:55:52 INFO - 'sessionrestore', 07:55:52 INFO - 'sessionrestore_no_auto_restore']}, 07:55:52 INFO - 'other_nol64': {'tests': ['a11yr', 07:55:52 INFO - 'ts_paint', 07:55:52 INFO - 'tpaint', 07:55:52 INFO - 'sessionrestore', 07:55:52 INFO - 'sessionrestore_no_auto_restore']}, 07:55:52 INFO - 'svgr': {'tests': ['tsvgx', 07:55:52 INFO - 'tsvgr_opacity', 07:55:52 INFO - 'tart', 07:55:52 INFO - 'tscrollx', 07:55:52 INFO - 'cart']}, 07:55:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:55:52 INFO - 'tests': ['tsvgx', 07:55:52 INFO - 'tsvgr_opacity', 07:55:52 INFO - 'tart', 07:55:52 INFO - 'tscrollx', 07:55:52 INFO - 'cart']}, 07:55:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:52 INFO - 'tests': ['tp5o']}, 07:55:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:52 INFO - 'talos_options': ['--e10s'], 07:55:52 INFO - 'tests': ['tp5o']}, 07:55:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:52 INFO - 'talos_options': ['--xperf_path', 07:55:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:55:52 INFO - 'tests': ['tp5n']}, 07:55:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:52 INFO - 'talos_options': ['--e10s', 07:55:52 INFO - '--xperf_path', 07:55:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:55:52 INFO - 'tests': ['tp5n']}}, 07:55:52 INFO - 'talos.zip': {'path': '', 07:55:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:55:52 INFO - Running post-action listener: _resource_record_post_action 07:55:52 INFO - ##### 07:55:52 INFO - ##### Running create-virtualenv step. 07:55:52 INFO - ##### 07:55:52 INFO - Running pre-action listener: _resource_record_pre_action 07:55:52 INFO - Running main action method: create_virtualenv 07:55:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:55:52 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 07:55:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:55:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:55:53 INFO - Using real prefix '/usr' 07:55:53 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:55:53 INFO - Installing distribute.............................................................................................................................................................................................done. 07:55:55 INFO - Installing pip.................done. 07:55:55 INFO - Return code: 0 07:55:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:55:55 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')]} 07:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:55 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')]} 07:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:55 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 0x7faa11013f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe840>, '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 0x246b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246bb60>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452007357.472743-1028703830', '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 07:55:55 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 07:55:55 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 07:55:55 INFO - Using env: {'DISPLAY': ':0', 07:55:55 INFO - 'HOME': '/home/cltbld', 07:55:55 INFO - 'LANG': 'en_US.UTF-8', 07:55:55 INFO - 'LANGUAGE': 'en_US:en', 07:55:55 INFO - 'LOGNAME': 'cltbld', 07:55:55 INFO - 'MAIL': '/var/mail/cltbld', 07:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:55 INFO - 'MOZ_NO_REMOTE': '1', 07:55:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:55 INFO - 'NO_EM_RESTART': '1', 07:55:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:55:55 INFO - 'PWD': '/builds/slave/test-pgo', 07:55:55 INFO - 'SHELL': '/bin/bash', 07:55:55 INFO - 'SHLVL': '1', 07:55:55 INFO - 'TERM': 'linux', 07:55:55 INFO - 'TMOUT': '86400', 07:55:55 INFO - 'USER': 'cltbld', 07:55:55 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452007357.472743-1028703830', 07:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:55 INFO - '_': '/tools/buildbot/bin/python'} 07:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:55 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 07:55:55 INFO - Cleaning up... 07:55:55 INFO - Return code: 0 07:55:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:55:55 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')]} 07:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:55 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')]} 07:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:55 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 0x7faa11013f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe840>, '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 0x246b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246bb60>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452007357.472743-1028703830', '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 07:55:55 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 07:55:55 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 07:55:55 INFO - Using env: {'DISPLAY': ':0', 07:55:55 INFO - 'HOME': '/home/cltbld', 07:55:55 INFO - 'LANG': 'en_US.UTF-8', 07:55:55 INFO - 'LANGUAGE': 'en_US:en', 07:55:55 INFO - 'LOGNAME': 'cltbld', 07:55:55 INFO - 'MAIL': '/var/mail/cltbld', 07:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:55 INFO - 'MOZ_NO_REMOTE': '1', 07:55:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:55 INFO - 'NO_EM_RESTART': '1', 07:55:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:55:55 INFO - 'PWD': '/builds/slave/test-pgo', 07:55:55 INFO - 'SHELL': '/bin/bash', 07:55:55 INFO - 'SHLVL': '1', 07:55:55 INFO - 'TERM': 'linux', 07:55:55 INFO - 'TMOUT': '86400', 07:55:55 INFO - 'USER': 'cltbld', 07:55:55 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452007357.472743-1028703830', 07:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:55 INFO - '_': '/tools/buildbot/bin/python'} 07:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:55 INFO - Downloading/unpacking psutil>=0.7.1 07:55:55 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 07:55:55 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 07:55:55 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 07:55:55 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 07:55:55 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 07:55:55 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 07:55:57 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:55:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:55:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:55:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:55:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:55:57 INFO - Installing collected packages: psutil 07:55:57 INFO - Running setup.py install for psutil 07:55:57 INFO - building 'psutil._psutil_linux' extension 07:55:57 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 07:55:58 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 07:55:58 INFO - building 'psutil._psutil_posix' extension 07:55:58 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 07:55:58 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 07:55:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:55:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:55:58 INFO - Successfully installed psutil 07:55:58 INFO - Cleaning up... 07:55:58 INFO - Return code: 0 07:55:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7faa11013f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe840>, '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 0x246b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246bb60>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452007357.472743-1028703830', '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 07:55:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 07:55:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:55:58 INFO - Using env: {'DISPLAY': ':0', 07:55:58 INFO - 'HOME': '/home/cltbld', 07:55:58 INFO - 'LANG': 'en_US.UTF-8', 07:55:58 INFO - 'LANGUAGE': 'en_US:en', 07:55:58 INFO - 'LOGNAME': 'cltbld', 07:55:58 INFO - 'MAIL': '/var/mail/cltbld', 07:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:58 INFO - 'MOZ_NO_REMOTE': '1', 07:55:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:55:58 INFO - 'NO_EM_RESTART': '1', 07:55:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:55:58 INFO - 'PWD': '/builds/slave/test-pgo', 07:55:58 INFO - 'SHELL': '/bin/bash', 07:55:58 INFO - 'SHLVL': '1', 07:55:58 INFO - 'TERM': 'linux', 07:55:58 INFO - 'TMOUT': '86400', 07:55:58 INFO - 'USER': 'cltbld', 07:55:58 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452007357.472743-1028703830', 07:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:58 INFO - '_': '/tools/buildbot/bin/python'} 07:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:55: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 07:55: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 07:55: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 07:55: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 07:55: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 07:55: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 07:56:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:56:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:56:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:56:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:56:00 INFO - Installing collected packages: mozsystemmonitor 07:56:00 INFO - Running setup.py install for mozsystemmonitor 07:56:00 INFO - Successfully installed mozsystemmonitor 07:56:00 INFO - Cleaning up... 07:56:00 INFO - Return code: 0 07:56:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:00 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 0x7faa11013f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe840>, '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 0x246b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246bb60>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452007357.472743-1028703830', '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 07:56:00 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 07:56:00 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 07:56:00 INFO - Using env: {'DISPLAY': ':0', 07:56:00 INFO - 'HOME': '/home/cltbld', 07:56:00 INFO - 'LANG': 'en_US.UTF-8', 07:56:00 INFO - 'LANGUAGE': 'en_US:en', 07:56:00 INFO - 'LOGNAME': 'cltbld', 07:56:00 INFO - 'MAIL': '/var/mail/cltbld', 07:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:00 INFO - 'MOZ_NO_REMOTE': '1', 07:56:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:00 INFO - 'NO_EM_RESTART': '1', 07:56:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:00 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:00 INFO - 'SHELL': '/bin/bash', 07:56:00 INFO - 'SHLVL': '1', 07:56:00 INFO - 'TERM': 'linux', 07:56:00 INFO - 'TMOUT': '86400', 07:56:00 INFO - 'USER': 'cltbld', 07:56:00 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452007357.472743-1028703830', 07:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:00 INFO - '_': '/tools/buildbot/bin/python'} 07:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:00 INFO - Downloading/unpacking blobuploader==1.2.4 07:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:02 INFO - Downloading blobuploader-1.2.4.tar.gz 07:56:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:56:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:56:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:56:02 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 07:56:02 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 07:56:02 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 07:56:02 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 07:56:02 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 07:56:02 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 07:56:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:56:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:56:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:56:02 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 07:56:02 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 07:56:02 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 07:56:02 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 07:56:02 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 07:56:02 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 07:56:02 INFO - Downloading docopt-0.6.1.tar.gz 07:56:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:56:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:56:03 INFO - Installing collected packages: blobuploader, requests, docopt 07:56:03 INFO - Running setup.py install for blobuploader 07:56:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:56:03 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:56:03 INFO - Running setup.py install for requests 07:56:03 INFO - Running setup.py install for docopt 07:56:03 INFO - Successfully installed blobuploader requests docopt 07:56:03 INFO - Cleaning up... 07:56:03 INFO - Return code: 0 07:56:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:03 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 0x7faa11013f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe840>, '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 0x246b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246bb60>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452007357.472743-1028703830', '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 07:56:03 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 07:56:03 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 07:56:03 INFO - Using env: {'DISPLAY': ':0', 07:56:03 INFO - 'HOME': '/home/cltbld', 07:56:03 INFO - 'LANG': 'en_US.UTF-8', 07:56:03 INFO - 'LANGUAGE': 'en_US:en', 07:56:03 INFO - 'LOGNAME': 'cltbld', 07:56:03 INFO - 'MAIL': '/var/mail/cltbld', 07:56:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:03 INFO - 'MOZ_NO_REMOTE': '1', 07:56:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:03 INFO - 'NO_EM_RESTART': '1', 07:56:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:03 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:03 INFO - 'SHELL': '/bin/bash', 07:56:03 INFO - 'SHLVL': '1', 07:56:03 INFO - 'TERM': 'linux', 07:56:03 INFO - 'TMOUT': '86400', 07:56:03 INFO - 'USER': 'cltbld', 07:56:03 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452007357.472743-1028703830', 07:56:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:03 INFO - '_': '/tools/buildbot/bin/python'} 07:56:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:56:03 INFO - Running setup.py (path:/tmp/pip-P93iEl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:56:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:56:03 INFO - Running setup.py (path:/tmp/pip-oVwZoY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:56:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:56:04 INFO - Running setup.py (path:/tmp/pip-RsnXKj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:56:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:56:04 INFO - Running setup.py (path:/tmp/pip-wvSZGC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:56:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:56:04 INFO - Running setup.py (path:/tmp/pip-W9GVSr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:56:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:56:04 INFO - Running setup.py (path:/tmp/pip-dfty7P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:56:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:56:04 INFO - Running setup.py (path:/tmp/pip-gNdnUA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:56:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:56:04 INFO - Running setup.py (path:/tmp/pip-l7yW6r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:56:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:56:04 INFO - Running setup.py (path:/tmp/pip-UzyZml-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:56:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:56:04 INFO - Running setup.py (path:/tmp/pip-CdTS3i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:56:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:56:04 INFO - Running setup.py (path:/tmp/pip-ut33SP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:56:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:56:04 INFO - Running setup.py (path:/tmp/pip-IUQEsi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:56:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:56:04 INFO - Running setup.py (path:/tmp/pip-OMfMFy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:56:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:56:04 INFO - Running setup.py (path:/tmp/pip-R8BMgK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:56:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:56:04 INFO - Running setup.py (path:/tmp/pip-jdUYl6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:56:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:56:04 INFO - Running setup.py (path:/tmp/pip-6O63y8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:56:05 INFO - Running setup.py (path:/tmp/pip-9z8HUI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:56:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:56:05 INFO - Running setup.py install for manifestparser 07:56:05 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:56:05 INFO - Running setup.py install for mozcrash 07:56:05 INFO - Running setup.py install for mozdebug 07:56:05 INFO - Running setup.py install for mozdevice 07:56:05 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:56:05 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:56:05 INFO - Running setup.py install for mozfile 07:56:05 INFO - Running setup.py install for mozhttpd 07:56:05 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:56:05 INFO - Running setup.py install for mozinfo 07:56:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:56:05 INFO - Running setup.py install for mozInstall 07:56:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:56:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:56:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:56:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:56:05 INFO - Running setup.py install for mozleak 07:56:05 INFO - Running setup.py install for mozlog 07:56:06 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:56:06 INFO - Running setup.py install for moznetwork 07:56:06 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:56:06 INFO - Running setup.py install for mozprocess 07:56:06 INFO - Running setup.py install for mozprofile 07:56:06 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:56:06 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:56:06 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:56:06 INFO - Running setup.py install for mozrunner 07:56:06 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:56:06 INFO - Running setup.py install for mozscreenshot 07:56:06 INFO - Running setup.py install for moztest 07:56:06 INFO - Running setup.py install for mozversion 07:56:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:56:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:56:06 INFO - Cleaning up... 07:56:06 INFO - Return code: 0 07:56:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:56: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')]} 07:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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')]} 07:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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/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 0x7faa11013f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe840>, '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 0x246b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246bb60>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452007357.472743-1028703830', '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 07:56: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/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 07:56: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/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 07:56:06 INFO - Using env: {'DISPLAY': ':0', 07:56:06 INFO - 'HOME': '/home/cltbld', 07:56:06 INFO - 'LANG': 'en_US.UTF-8', 07:56:06 INFO - 'LANGUAGE': 'en_US:en', 07:56:06 INFO - 'LOGNAME': 'cltbld', 07:56:06 INFO - 'MAIL': '/var/mail/cltbld', 07:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:06 INFO - 'MOZ_NO_REMOTE': '1', 07:56:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:06 INFO - 'NO_EM_RESTART': '1', 07:56:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:06 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:06 INFO - 'SHELL': '/bin/bash', 07:56:06 INFO - 'SHLVL': '1', 07:56:06 INFO - 'TERM': 'linux', 07:56:06 INFO - 'TMOUT': '86400', 07:56:06 INFO - 'USER': 'cltbld', 07:56:06 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452007357.472743-1028703830', 07:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:06 INFO - '_': '/tools/buildbot/bin/python'} 07:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:56:07 INFO - Running setup.py (path:/tmp/pip-sB7wlP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:56:07 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)) 07:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:56:07 INFO - Running setup.py (path:/tmp/pip-Xkkvyb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:56:07 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)) 07:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:56:07 INFO - Running setup.py (path:/tmp/pip-XgS9YE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:56:07 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)) 07:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:56:07 INFO - Running setup.py (path:/tmp/pip-MvlHo7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:56:07 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)) 07:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:56:07 INFO - Running setup.py (path:/tmp/pip-y2dIYj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:56:07 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)) 07:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:56:07 INFO - Running setup.py (path:/tmp/pip-ayN0ye-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:56:07 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)) 07:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:56:07 INFO - Running setup.py (path:/tmp/pip-ZEqtdA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:56:07 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)) 07:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:56:07 INFO - Running setup.py (path:/tmp/pip-TcNtsE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:56:07 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)) 07:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:56:07 INFO - Running setup.py (path:/tmp/pip-NOZHOo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:56:07 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)) 07:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:56:07 INFO - Running setup.py (path:/tmp/pip-KxYPQz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:56:07 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)) 07:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:56:07 INFO - Running setup.py (path:/tmp/pip-BeJEmN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:56:07 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)) 07:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:56:07 INFO - Running setup.py (path:/tmp/pip-6frBbX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:56:07 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)) 07:56:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:56:07 INFO - Running setup.py (path:/tmp/pip-ChzehV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:56:08 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)) 07:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:56:08 INFO - Running setup.py (path:/tmp/pip-YC2wNG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:56:08 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)) 07:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:56:08 INFO - Running setup.py (path:/tmp/pip-JVMf6x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:56:08 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)) 07:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:56:08 INFO - Running setup.py (path:/tmp/pip-exqdvi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:56:08 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)) 07:56:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:56:08 INFO - Running setup.py (path:/tmp/pip-Nuaysg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:56:08 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)) 07:56:08 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)) 07:56:08 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)) 07:56:08 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)) 07:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:56:08 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)) 07:56:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56:09 INFO - Downloading blessings-1.5.1.tar.gz 07:56:09 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 07:56:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:56:10 INFO - Installing collected packages: blessings 07:56:10 INFO - Running setup.py install for blessings 07:56:10 INFO - Successfully installed blessings 07:56:10 INFO - Cleaning up... 07:56:10 INFO - Return code: 0 07:56:10 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:56:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:56:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:56:10 INFO - Reading from file tmpfile_stdout 07:56:10 INFO - Current package versions: 07:56:10 INFO - argparse == 1.2.1 07:56:10 INFO - blessings == 1.5.1 07:56:10 INFO - blobuploader == 1.2.4 07:56:10 INFO - docopt == 0.6.1 07:56:10 INFO - manifestparser == 1.1 07:56:10 INFO - mozInstall == 1.12 07:56:10 INFO - mozcrash == 0.16 07:56:10 INFO - mozdebug == 0.1 07:56:10 INFO - mozdevice == 0.47 07:56:10 INFO - mozfile == 1.2 07:56:10 INFO - mozhttpd == 0.7 07:56:10 INFO - mozinfo == 0.9 07:56:10 INFO - mozleak == 0.1 07:56:10 INFO - mozlog == 3.1 07:56:10 INFO - moznetwork == 0.27 07:56:10 INFO - mozprocess == 0.22 07:56:10 INFO - mozprofile == 0.28 07:56:10 INFO - mozrunner == 6.11 07:56:10 INFO - mozscreenshot == 0.1 07:56:10 INFO - mozsystemmonitor == 0.0 07:56:10 INFO - moztest == 0.7 07:56:10 INFO - mozversion == 1.4 07:56:10 INFO - psutil == 3.1.1 07:56:10 INFO - requests == 1.2.3 07:56:10 INFO - wsgiref == 0.1.2 07:56:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:56:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7faa11013f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe840>, '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 0x246b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246bb60>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452007357.472743-1028703830', '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 07:56:10 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 07:56:10 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 07:56:10 INFO - Using env: {'DISPLAY': ':0', 07:56:10 INFO - 'HOME': '/home/cltbld', 07:56:10 INFO - 'LANG': 'en_US.UTF-8', 07:56:10 INFO - 'LANGUAGE': 'en_US:en', 07:56:10 INFO - 'LOGNAME': 'cltbld', 07:56:10 INFO - 'MAIL': '/var/mail/cltbld', 07:56:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:10 INFO - 'MOZ_NO_REMOTE': '1', 07:56:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:10 INFO - 'NO_EM_RESTART': '1', 07:56:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:10 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:10 INFO - 'SHELL': '/bin/bash', 07:56:10 INFO - 'SHLVL': '1', 07:56:10 INFO - 'TERM': 'linux', 07:56:10 INFO - 'TMOUT': '86400', 07:56:10 INFO - 'USER': 'cltbld', 07:56:10 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452007357.472743-1028703830', 07:56:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:10 INFO - '_': '/tools/buildbot/bin/python'} 07:56:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:10 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)) 07:56:10 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)) 07:56:10 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)) 07:56:10 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)) 07:56:10 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)) 07:56:10 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)) 07:56:10 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)) 07:56:10 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)) 07:56:10 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)) 07:56:10 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)) 07:56:10 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)) 07:56:10 INFO - Cleaning up... 07:56:10 INFO - Return code: 0 07:56:10 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:56:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa11013f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe840>, '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 0x246b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246bb60>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452007357.472743-1028703830', '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 07:56:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 07:56:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:56:10 INFO - Using env: {'DISPLAY': ':0', 07:56:10 INFO - 'HOME': '/home/cltbld', 07:56:10 INFO - 'LANG': 'en_US.UTF-8', 07:56:10 INFO - 'LANGUAGE': 'en_US:en', 07:56:10 INFO - 'LOGNAME': 'cltbld', 07:56:10 INFO - 'MAIL': '/var/mail/cltbld', 07:56:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:10 INFO - 'MOZ_NO_REMOTE': '1', 07:56:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:10 INFO - 'NO_EM_RESTART': '1', 07:56:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:10 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:10 INFO - 'SHELL': '/bin/bash', 07:56:10 INFO - 'SHLVL': '1', 07:56:10 INFO - 'TERM': 'linux', 07:56:10 INFO - 'TMOUT': '86400', 07:56:10 INFO - 'USER': 'cltbld', 07:56:10 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452007357.472743-1028703830', 07:56:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:10 INFO - '_': '/tools/buildbot/bin/python'} 07:56:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:10 INFO - Downloading/unpacking jsonschema 07:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:56:12 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 07:56:12 INFO - Downloading/unpacking functools32 (from jsonschema) 07:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:12 INFO - Downloading functools32-3.2.3-2.tar.gz 07:56:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:56:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:56:12 INFO - warning: no files found matching '*.txt' 07:56:12 INFO - no previously-included directories found matching 'build' 07:56:12 INFO - no previously-included directories found matching 'dist' 07:56:12 INFO - no previously-included directories found matching '.git*' 07:56:12 INFO - Installing collected packages: jsonschema, functools32 07:56:12 INFO - Running setup.py install for functools32 07:56:12 INFO - warning: no files found matching '*.txt' 07:56:12 INFO - no previously-included directories found matching 'build' 07:56:12 INFO - no previously-included directories found matching 'dist' 07:56:12 INFO - no previously-included directories found matching '.git*' 07:56:13 INFO - Successfully installed jsonschema functools32 07:56:13 INFO - Cleaning up... 07:56:13 INFO - Return code: 0 07:56:13 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa11013f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x246d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fe840>, '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 0x246b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246bb60>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452007357.472743-1028703830', '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 07:56:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 07:56:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:56:13 INFO - Using env: {'DISPLAY': ':0', 07:56:13 INFO - 'HOME': '/home/cltbld', 07:56:13 INFO - 'LANG': 'en_US.UTF-8', 07:56:13 INFO - 'LANGUAGE': 'en_US:en', 07:56:13 INFO - 'LOGNAME': 'cltbld', 07:56:13 INFO - 'MAIL': '/var/mail/cltbld', 07:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:13 INFO - 'MOZ_NO_REMOTE': '1', 07:56:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:13 INFO - 'NO_EM_RESTART': '1', 07:56:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:13 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:13 INFO - 'SHELL': '/bin/bash', 07:56:13 INFO - 'SHLVL': '1', 07:56:13 INFO - 'TERM': 'linux', 07:56:13 INFO - 'TMOUT': '86400', 07:56:13 INFO - 'USER': 'cltbld', 07:56:13 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452007357.472743-1028703830', 07:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:13 INFO - '_': '/tools/buildbot/bin/python'} 07:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:13 INFO - Downloading/unpacking flake8 07:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:56:14 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 07:56:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:56:15 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 07:56:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:15 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 07:56:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:56:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:56:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:56:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:56:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:56:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:56:15 INFO - no previously-included directories found matching 'docs/_build' 07:56:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:56:15 INFO - Running setup.py install for pep8 07:56:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:56:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:56:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:56:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:56:15 INFO - no previously-included directories found matching 'docs/_build' 07:56:15 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:56:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:56:15 INFO - Cleaning up... 07:56:15 INFO - Return code: 0 07:56:15 INFO - Running post-action listener: _resource_record_post_action 07:56:15 INFO - Running post-action listener: _start_resource_monitoring 07:56:15 INFO - Starting resource monitoring. 07:56:15 INFO - ##### 07:56:15 INFO - ##### Running install step. 07:56:15 INFO - ##### 07:56:15 INFO - Running pre-action listener: _resource_record_pre_action 07:56:15 INFO - Running main action method: install 07:56:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:56:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:56:16 INFO - Reading from file tmpfile_stdout 07:56:16 INFO - Detecting whether we're running mozinstall >=1.0... 07:56:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:56:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:56:16 INFO - Reading from file tmpfile_stdout 07:56:16 INFO - Output received: 07:56:16 INFO - Usage: mozinstall [options] installer 07:56:16 INFO - Options: 07:56:16 INFO - -h, --help show this help message and exit 07:56:16 INFO - -d DEST, --destination=DEST 07:56:16 INFO - Directory to install application into. [default: 07:56:16 INFO - "/builds/slave/test-pgo"] 07:56:16 INFO - --app=APP Application being installed. [default: firefox] 07:56:16 INFO - mkdir: /builds/slave/test-pgo/build/application 07:56:16 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'] 07:56:16 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 07:56:32 INFO - Reading from file tmpfile_stdout 07:56:32 INFO - Output received: 07:56:32 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:56:32 INFO - Running post-action listener: _resource_record_post_action 07:56:32 INFO - ##### 07:56:32 INFO - ##### Running run-tests step. 07:56:32 INFO - ##### 07:56:32 INFO - Running pre-action listener: _resource_record_pre_action 07:56:32 INFO - Running main action method: run_tests 07:56:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:56:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:56:32 INFO - Python 2.7.3 07:56:32 INFO - Return code: 0 07:56:32 INFO - grabbing minidump binary from tooltool 07:56:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:32 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 0x24fe840>, '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 0x246b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246bb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:56:32 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 07:56:32 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 07:56:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:56:32 INFO - Return code: 0 07:56:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:56:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:56:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:56:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:56:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:56:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:56:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:56:33 INFO - Return code: 0 07:56:33 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/djpLSnQuQZmtbnNcSyESGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 07:56:33 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/djpLSnQuQZmtbnNcSyESGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 07:56:33 INFO - Using env: {'DISPLAY': ':0', 07:56:33 INFO - 'HOME': '/home/cltbld', 07:56:33 INFO - 'LANG': 'en_US.UTF-8', 07:56:33 INFO - 'LANGUAGE': 'en_US:en', 07:56:33 INFO - 'LOGNAME': 'cltbld', 07:56:33 INFO - 'MAIL': '/var/mail/cltbld', 07:56:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:56:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:56:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:33 INFO - 'MOZ_NO_REMOTE': '1', 07:56:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:56:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:56:33 INFO - 'NO_EM_RESTART': '1', 07:56:33 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:56:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:56:33 INFO - 'PWD': '/builds/slave/test-pgo', 07:56:33 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:56:33 INFO - 'SHELL': '/bin/bash', 07:56:33 INFO - 'SHLVL': '1', 07:56:33 INFO - 'TERM': 'linux', 07:56:33 INFO - 'TMOUT': '86400', 07:56:33 INFO - 'USER': 'cltbld', 07:56:33 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452007357.472743-1028703830', 07:56:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:33 INFO - '_': '/tools/buildbot/bin/python'} 07:56:33 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/djpLSnQuQZmtbnNcSyESGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 07:56:33 INFO - mozversion application_buildid: 20160105053004 07:56:33 INFO - mozversion application_changeset: 892c469f9513cb053876991b2794feea21502601 07:56:33 INFO - mozversion application_display_name: Nightly 07:56:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:56:33 INFO - mozversion application_name: Firefox 07:56:33 INFO - mozversion application_remotingname: firefox 07:56:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:56:33 INFO - mozversion application_vendor: Mozilla 07:56:33 INFO - mozversion application_version: 46.0a1 07:56:33 INFO - mozversion platform_buildid: 20160105053004 07:56:33 INFO - mozversion platform_changeset: 892c469f9513cb053876991b2794feea21502601 07:56:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:56:33 INFO - mozversion platform_version: 46.0a1 07:56:33 INFO - using testdate: 1452009393 07:56:33 INFO - actual date: 1452009393 07:56:33 INFO - starting webserver on 'localhost:33158' 07:56:33 INFO - SUITE-START | Running 3 tests 07:56:33 INFO - TEST-START | dromaeo_css 07:56:33 INFO - operating with platform_type : linux_ 07:56:33 INFO - Initialising browser for dromaeo_css test... 07:56:33 INFO - TEST-INFO | started process 31482 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwXiXJh/profile http://localhost:33158/getInfo.html) 07:56:37 INFO - PROCESS | 31482 | __metrics Screen width/height:1600/1200 07:56:37 INFO - PROCESS | 31482 | colorDepth:24 07:56:37 INFO - PROCESS | 31482 | Browser inner width/height: 1024/697 07:56:37 INFO - PROCESS | 31482 | __metrics 07:56:37 INFO - PROCESS | 31482 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:56:37 INFO - PROCESS | 31482 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:56:38 INFO - TEST-INFO | 31482: exit 0 07:56:38 INFO - Browser initialized. 07:56:38 INFO - Running cycle 1/1 for dromaeo_css test... 07:56:38 INFO - TEST-INFO | started process 31578 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwXiXJh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:56:50 INFO - PROCESS | 31578 | RSS: Main: 150056960 07:56:50 INFO - PROCESS | 31578 | 07:57:40 INFO - PROCESS | 31578 | 1452009460988 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] 07:59:50 INFO - PROCESS | 31578 | Cycle 1(1): loaded http://localhost:33158/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33158/tests/dromaeo/cssquery-ext.html) 07:59:51 INFO - PROCESS | 31578 | RSS: Main: 253968384 07:59:51 INFO - PROCESS | 31578 | 08:02:54 INFO - PROCESS | 31578 | Cycle 1(1): loaded http://localhost:33158/tests/dromaeo/cssquery-ext.html (next: http://localhost:33158/tests/dromaeo/cssquery-jquery.html) 08:02:55 INFO - PROCESS | 31578 | RSS: Main: 231862272 08:02:55 INFO - PROCESS | 31578 | 08:05:57 INFO - PROCESS | 31578 | Cycle 1(1): loaded http://localhost:33158/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33158/tests/dromaeo/cssquery-mootools.html) 08:05:57 INFO - PROCESS | 31578 | RSS: Main: 222699520 08:05:57 INFO - PROCESS | 31578 | 08:08:59 INFO - PROCESS | 31578 | Cycle 1(1): loaded http://localhost:33158/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33158/tests/dromaeo/cssquery-prototype.html) 08:08:59 INFO - PROCESS | 31578 | RSS: Main: 217272320 08:08:59 INFO - PROCESS | 31578 | 08:12:02 INFO - PROCESS | 31578 | Cycle 1(1): loaded http://localhost:33158/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33158/tests/dromaeo/cssquery-yui.html) 08:12:03 INFO - PROCESS | 31578 | RSS: Main: 218193920 08:12:03 INFO - PROCESS | 31578 | 08:15:05 INFO - PROCESS | 31578 | Cycle 1(1): loaded http://localhost:33158/tests/dromaeo/cssquery-yui.html (next: http://localhost:33158/tests/dromaeo/cssquery-dojo.html) 08:15:05 INFO - PROCESS | 31578 | RSS: Main: 262520832 08:15:05 INFO - PROCESS | 31578 | 08:15:05 INFO - PROCESS | 31578 | __start_tp_report 08:15:05 INFO - PROCESS | 31578 | _x_x_mozilla_page_load 08:15:05 INFO - PROCESS | 31578 | _x_x_mozilla_page_load_details 08:15:05 INFO - PROCESS | 31578 | |i|pagename|runs| 08:15:05 INFO - PROCESS | 31578 | |0;dojo.html;3076.769242306827;3133.9216519586994;3176;3177.285110850059;3212.518122281658;5151.304573882525;5270.762815673294;5285.948932357776;5291.2327712481665;5339.706316152615;5245.763940622672;5266.552343050846;5324.866878328034;5372.167314066316;5380.569554435646;4856.708597484154;4869.732164730938;4887.926681099769;4899.265110233458;4940.703557786526;4948.653594248404;4950.331705219785;4989.525995030466;4991.376077990251;5014.247862820588;4766.666333356667;4784.736839473828;4857.1742803723455;4934.851954441355;4937.679050861682;4884.633652476078;4889.046635906;4893.7063776173545;4899.853004409873;4901.1177987962155;4790.305405716152;4832.73419961902;4855.781489832931;4855.951440485621;4892.168331383673;5017.899642007176;5116;5137.588992880561;5179.22311653255;5242.659227150261;5523.7238138093335;5582.86042848928;5643.294588176478;5648.209250704905;5695.971520142372;5781.335146458169;5784.913226301609;5804.65172089676;5804.738786754606;5806.825795226107;5205.7397130143345;5325.334333208349;5369.892602147975;5387.434319396485;5392.110301800199;5814.94185058144;5831.096180092008;5896.439838215449;5913.940860591339;5925.792597259161;5613.438656134354;5615.494605485526;5619.325680918316;5620.044592419216;5623.550115990711;5543.833684989376;5636.689982050944;5643.209950606918;5657.9434205658235;5706.201131841545;5647.068233741386;5726.885462290731;5735.7418916148035;5743.2246646703;5761.423857614205;5678.290213723285;5679.829605111853;5681.318241811009;5687;5688.687122208318;4344.348347747863;4406.20688276107;4411.073674528321;4435.046465010038;4468.195724769507;3908.4332771747936;3913.8238779254434;3915.9608403915595;3920.0395903003946;3938.901527461779;5351.063563876306;5366.2755528004;5367.651102678314;5369.27514785499;5412.675239485643;5559.24950131727;5690.459406356389;5697.829065127969;5738.5982981191755;5752.223449834302;5256.842294731164;5274.92087618686;5298.09932311508;5307.203919412119;5353.277307563507;4897.3878265216845;4897.755112244374;4901.411830580282;4909.803607855646;4952.5542701157065;5803.738831752581;5956.761729530857;5964.910526342108;5968.373320801254;5986.580939334205;5640.971795140998;5657.688827114548;5765.106408506688;5769.68266745333;5800.187973683772;5737.56968227393;5746.9712651436475;5759;5800.651960882361;5802.854928626649;5640.041192997282;5644.463775941279;5645.745941432563;5646.7458964347525;5651.745671444713;5571.60998730085;5601.719914004365;5635.295588051494;5698;5738.598298119092;5529.364123125892;5529.502344788988;5530.695811730394;5540.279763630702;5541.224228607917;5516.862078447911;5520.66875987442;5521.171824226398;5522.861928451821;5573.219749235192;5267.394249661338;5324.041672498987;5369.3019907413345;5388.595855310946;5474.5894057945015;5660.094384898396;5682.886342273214;5683.5737319700365;5688.914666280092;5694.658320500783;5526.032944234823;5533.916991245054;5535.750891209825;5538.418466061005;5540.33515978069 08:15:05 INFO - PROCESS | 31578 | |1;ext.html;538.5718353908642;539.3743257820926;558.5866458820474;561.8960492308926;572.1789232451432;25388.74611253887;25901.35246618833;39292.80353598235;39895.41464195015;39953;42279.57720422795;42382;42535.78732106343;42650.786746066224;42723.57276427235;7449.590272535009;8614.353923455734;8771.56142192891;8783.560821958876;8788.956055219747;7491.66287517063;10129.797404051915;10316.484175791218;10324;10326;10007.599696012187;10102.343347682377;10107.848382274235;10110.090091891729;10116.14012808912;7639.579823109727;7788.337991270749;10072.09351158392;10168.949155254213;10390.844137337946;9890.258230632731;10031.097201251923;10036.397816131055;10038.799224015478;10041.347312424741;35815.4627680585;36111;36194.09514762126;36213.00828454434;36259.09352266188;3079.676633953425;3254.2027203335097;3701.648343407399;3753.8686145985034;3839.731218814684;29730.108096757132;29870.85064574685;30006.439150032267;30096.8495157525;30357.848210758806;3449.6550344965553;3457.619661837196;3502.387082260594;3547.8580856765698;3676.2647470506004;178970;180010;180223;180632;180699;53518.46481535135;57479.712601436724;57864.421355785904;57929.71035144882;57987;48440.27339589909;65924.34075659278;66775.66612167006;67004.6649766748;67088;13088.08383413171;13125.278109704059;13171.47314107444;13215.471381144838;13222.471101156038;9549.427034377959;9559.091886270793;9566.091221333962;9569.234461243084;9569.904300956901;19357.353845231053;19637.901810490857;19660.803391965896;19690.70463943042;20325.2886148987;7691.884621730678;7887.290143886963;7894.881576776353;8022.2779949803635;8046.798830029179;917.0829170829038;940.7601061729353;945.5555888732284;1051.4059556350637;1068.6633710381204;27965.16104516868;27990.440191196063;28123.859380702965;28372.290692732433;28422.289442763682;998.9600415983425;1013.1236480444362;1020.2705065877933;1062.4793851012948;1096.8080585897435;14224.359903804354;14482.131072135706;14514.044481259954;14766.597173268523;14864.925675371554;302780;307823;308475;308922;310062;50478.74760626247;51163.232551511755;51198.23202651963;51206.74396628067;51275.23087153696;1301.8372703412074;1323.8874695650784;1331.9200847949155;1332.5069724201912;1338;25800.354991125372;26245;27707;27763.44473110567;30043;44912.550874492146;45440.31839522344;45491.54508454873;45538;45562.77218614018;239430;241422;243772;244860;245484;27633.447331052863;28201.717982819908;28576.857115714287;31903.36193276168;32129.67870321267;36027.27945441129;39565.2086958265;40030.39954400628;40275.79862100671;40572.537020927084;34244.31511369808;34652.30695386028;34691.47962780611;34809.47785783266;39838.80080599579;31636.36727265488;34617.30765384628;35008.29983400369;35649.46525802063;36170;33152;33215.169620759676;33478.16304592307;33511.497327540594;35033.29933401267;31238.21904452407;33022.83488582542;33141.337173256885;33165.17087072746;33343.333133337685;24504;24882;24997.024045710976;25129.371765706004;25266.494670106862 08:15:05 INFO - PROCESS | 31578 | |2;jquery.html;363.19008610797937;364.35691005375514;364.7574363048571;365.1728834190558;365.8244042859426;13100;13216.481308318243;16060.518184454471;16404.753928691065;17221.22504487298;15082.3212955417;16276.186190690447;16481.587960301;16813.91593042033;16911.57721056971;5269.077911365505;5395.271638328814;5397.4062853086125;5397.514223719864;5399.649022813524;4096.262672718909;4168.353905144708;5375.650582712131;5408.702521361323;5773.364929857712;5792.275965504312;5818.1854540364175;5843.094320380348;5846.941530584703;5853.356130825627;5667.064934285838;5787.710614469302;5814.127880817869;5832.212651292085;5836.474717275466;5121.487851214886;5149.45930677281;5169.767360468788;5171.612129090296;5172.612054095958;19148.712769308473;19316.517087072796;19630.50923726904;19633.410997670093;19643.80356196434;2230.721159855018;2297.1270917051415;2297.8965946532444;2320.2227253869974;2328.860268383902;12935.547255846;13055.673608159777;13064.150830196008;13124.803127953088;13603.727925441535;1884.660761063008;1908.456090014353;1952.2386269354963;1957.9510512237166;1966.252823926913;59711.40288597145;62310.37689623091;63522.682386587774;67388;69268.30731692669;15361.308741106677;15395.538133856002;15425.228738563026;15430.768538471932;15507.302171402314;23912.282631520735;24011.51976960451;24039.27882163538;24180.51638967211;24191.39521511941;8321.958390208132;8327.541985190752;8369.414141010071;8381.036180839159;8707.564621769014;6917.169939607279;6929.341712537301;6950.235474097845;6992.930070699228;6996.370326670522;7662.578558179353;7787;7797.532148071134;7832.647530861125;7872.803179920434;2706.7699245563954;2982.164993801739;2985.776066794999;3020.6828283030404;3072.4162409142637;828.7348048624502;888.9111088891059;889.91971809254;987.4075554667143;987.9308448408686;16365.509034728977;16530.173491325386;16545.66908661844;16825.747613785803;16897.831021689624;816.1512027491461;848.9830203395898;874.6894852327332;921.3642586615348;954.346272803132;7804.297613214838;8903;9118.270538356915;9494.762630934281;10054.145397641283;453337;523423;528828;534560;576080;63249;68678.65660671664;69681.3031869685;72269.63865180641;75497.62251188818;1055.8152323343384;1099.5766629847567;1102.9724256893642;1103.9944800275948;1117.7038084907506;14255.392125185504;15069.849301506845;15628.374865005273;15693.686126277182;15777.290021948811;34671.13264349893;35417.468737969466;35651.75218867327;35760.821195893855;36154.27691446209;46317.768411157725;47199.76400117978;47572.28641570448;48398.27402589034;49109.50890491192;9328.440293582407;9700.126988571063;9794.804103917739;9918.752031199278;9949.452780097165;11436.199466037298;11437.714057148305;11526.308421494738;11540.365279909685;13152.342382880626;13450.932745336211;13922.303884805922;14194.503192388629;14262.643433914234;14422.278886055445;12637.304948227937;12673.239605623692;14152.22162781057;14303.141811491343;14508.782368264696;14032.22822744759;14062.718745625234;14395.712085758436;14515.129092254498;14541.709165816836;8303.252707256375;8588;9393.85909211376;9829.213662906806;9921.355111917703;9932.404055756677;10039.799204016024;10080.092791648787;11874.406279685809;14628.561143165722 08:15:05 INFO - PROCESS | 31578 | |3;mootools.html;1269.4858582274182;1425.8645428684279;1439.5753252790425;1570.1599644190353;1747.729101989192;6767.695453704583;7422.6288685565705;7525.698972041126;7528.171901090889;7536.4724469287175;7311.597862117582;7430.442716796235;7505;7520.511166774169;7554.848903021936;2289.599320118981;2310.7689231076843;2311.861288322706;2328.313147621447;2335.019291897407;2304.896279667419;2335.5912715274844;2363.3382652857226;2368.1948137633203;2372.9406764830846;2231.631780756173;2232.3414592695194;2239.3505883293824;2322.6399908014287;2343.086196383412;2192.397090800027;2272.9545409091807;2297.322289924476;2299.9885000574973;2300.574393737156;2312.9421764455856;2342.8828558572172;2343.7304709958403;2346.21401830387;2347.8708671023087;7536.359409450203;7607.80980475487;7639.274268944441;7645.732399366051;7654.387648988068;4553.977230113861;4632.884177895546;4660.976695116503;4663.650226233012;4667.929981050287;2949.542820862748;2963.5702823090533;3037.2558723112757;3040.452718510667;3061.8009829361245;928.9442633441947;954.6420092465326;980.5146452505984;993.5513268813635;995.512199022481;10490.947545262225;10498.632547860865;10507.579696812118;10510.737231569196;10519.368837869675;4040.9797951010055;4068.4914385701786;4106.2198182345255;4113.547509773923;4135.60711732385;8981.730548083568;9007.189352958265;9007.369484136048;9011.188992990663;9029.729108126767;4552.499225085238;4574.268117101248;4586.701864378805;4592.10453961481;4595.770211489412;3797.6771974381936;3873.6320049595242;4149.502059752788;4181.665466762652;4272.145570885836;3512.1746389598425;3517.82410879455;3547.75165738401;3571.499990001402;3574.5174401455993;1162.6686394377562;1170.239344426113;1201.8617858946159;1205.6322821539516;1209.7217639942687;1237.6101528018646;1247.7379750252367;1252.9373531323579;1268.835051443325;1270.1299609767154;6950.235474097845;7018.75434359795;7034.5427547209265;7042.929570704227;7046.436285097282;466.6523440037194;467.3200493282266;477.93308936748883;484.80365451992;485.1824675421925;5261;5262.868428289324;5301.814436494704;5302.310699609026;5310.8141215057285;8789.69236076747;8933.46399216049;9096.8635470468;9098.135677110664;9224.446533208029;8947.552622368856;8968.730938071869;9037.322200834964;9060.456372617664;9103.180713735796;6909.032735417046;7151.89272160918;7170;7170.677319520634;7186.604736739425;6640.83397915056;6682.69927853238;6705.597664140168;6715.261321254756;6716.865662686621;7832.255935686101;8132.227438393344;8137.837243254983;8256.215659512336;8271.710490132817;8180.877286840821;8356.164383561596;8398.454100483448;8459.95770021146;8476.27951624119;5909.674967876808;6230.719617617127;6441.613503189824;6605.339466053356;6639.867202655823;7095.574265544084;7123.643817809192;7127.8574428512175;7158.3915367192285;7173.067501225016;6524.412802847766;6695.933040669531;6704.229013663491;6786.253512113763;6865.347791959756;6365.427111559797;6401.423871851555;6582.934170658232;6670.866582668416;6693.966530167318;6774.8645027100165;6797.864042719019;6804.727810887509;6806.455483561403;6810.8637827244165;5908.734106965111;6193.752249910133;6206.937930620817;6207.81376558704;6219.440250377488;6029.246344206974;6052;6072.05883088122;6074;6075.27096748393 08:15:05 INFO - PROCESS | 31578 | |4;prototype.html;339.8912348048624;343.7250199840129;347.4666387095808;348.6809569244141;350.3798277049624;5745;5799.217105690731;5821.476067153955;5849.09339052447;5853.5902486825935;5670.4896559309655;5844.2402487676645;5846.327672317685;5849.064149736043;5867.589268751189;4550.612063320686;4580.725156490605;4584.793684284207;4589.082183563284;4590.059037897223;4361.869143925687;4423.800928958204;4501.437320334958;4575.290829921368;4630.236011058171;4569.109023740372;4570.360149579062;4571.4971353151295;4577.015941572561;4596.4254468191475;4566.40636717228;4567.38340324057;4570.291604801245;4579.748113853737;4591.977040114812;4058.228936502055;4064.7357921734992;4069.267531844267;4074.8370065197355;4075.735077219971;5514.889702205934;5642.746076426571;5659.886802263932;5670.68811215383;5673.631213971079;5275.630705850592;5278.049951008817;5279.208118782175;5280.9207861882105;5286.524212820865;5832.650040997553;6264.6241225526155;6265.248170219557;6278.591891527036;6279.49764018882;4226.661867050629;4273.957260427387;4394.956050439487;4396.384506169139;4397.098594788093;6466.805995820133;6521.11964884744;6545;6547.410733034098;6564;4482.551744825491;4487.910241795146;4489.034857505652;4493.0339976905125;4495.730256184639;4467.15124126415;4543.5002149763495;4548.840790572314;4563.133004729091;4578.862634120982;5251.658642188322;5256.2115682647145;5256.710880901511;5260.395054568774;5268.315119034578;6280.623162610258;6302.180716506917;6319.368063193644;6321.778737744157;6335.049742538564;1588.237645929937;1608.4852847089053;1610.4443966831425;1610.5329454458076;1611.2668735725217;1072.983905241422;1082.4749996251812;1088.1077516436446;1098.0337303173158;1116.385987706758;5910.763569457259;5913;5915.940840591625;5922.466977972003;5922.49658779;6430.549861509649;6445.291017988017;6453.838654033687;6477.060826180177;6484.870302593922;5897.997340452133;5900.586958912835;5906.025505791582;5914.053751399755;5917.792877249276;3411.2665776858094;3484.8083355415697;3485.7385696072897;3489.0405138586584;3491.301739652029;6700.698468568926;6722.731090756315;6772.051912732221;6782.152230971129;6784.457243420515;6653.367930046637;6673.866522669519;6676.098726671934;6677.1319728435965;6679.398854103057;6553.737850485927;6746.797596072126;6751.628660423724;6756.966215168893;6810.148731408574;6217.906731399123;6348;6522.021696745336;6525.412712855866;6532.608043517404;6285.685715714105;6365.649889256136;6446.967765161145;6451.645159516272;6474.5791523550815;6661.933380666132;6691.130153080068;6710.4631629470505;6763.7632682855865;6776.796696099125;4345.261305578122;4471.552844715502;4502.977485112553;4513.1650644630845;4515.961328894438;6388.137601423934;6397.936020639921;6401.295857455583;6451.612903225821;6466.4503517201565;6321.96839015802;6326.3041065483685;6331.493480521455;6332.683365831782;6348.365163483615;6211.3478084800445;6286.497080233662;6325.746970121328;6334.3665633436285;6334.968325158345;6066.4540191382985;6085;6085.726142323695;6089.086637004485;6090.604110732788;6339.207599050119;6347.39699728525;6353.332900045429;6356.491480681442;6357.4596159326975;6036.486898613667;6140;6153.600015998945;6155.446009859134;6168.691565421801 08:15:05 INFO - PROCESS | 31578 | |5;yui.html;696.6656005117543;709.3509438863437;726.7674344209852;727.0947670150663;753.5403403923606;15335.23323833808;15441.305141268642;15515.534533963972;15521.223938803058;15532.301046452909;14616.853831461682;14717.705645887076;14719.92640036801;14733.189674567895;14763;669.9296573859748;675.7398401615388;795.1333046978777;796.0884786919004;807.9555624440653;795.6061749434009;799.8440304140695;800.339719731224;805.7864665863551;806.4757907360204;818.1981657975158;823.9823817585308;825.8100636853497;826.5990994367727;827.0530242871909;689.0972825598482;696.7561353526276;826.5619221812449;837.9874301885477;838.8699751538521;620.10394979255;620.4416025576971;620.695859029077;620.9565330426872;621.1521273461692;13941;14066.507672231524;14079.577612671636;14099.436022559188;14101.435942562286;11871.347075910822;12063.819042714365;12111.201489074012;12145.696357591043;12184.756304873941;9947.801043979152;10045.899541004643;10117.190624750003;10143.442110683909;10921.399323037309;3551.9112022199392;3645.5989841117457;3662.34077865984;3701.167237371597;3707.2214834884708;46273.305900411186;46833.29750053752;46885.53114468846;46919.5308046922;46954.530454695356;9683.080107389927;9918.206543476505;10151.898481015096;10310.432926188982;10331.070203681706;17663.55841103957;17720.734188987175;17787;17801.910990445223;17852.01813900248;7363.337299643058;7416.22129676387;7703.537787732754;7736.226377362332;7738.071431428265;4250.553691862372;4262.66995985807;4279.529251782302;4307.440032795716;4386.0789234261165;3063.6629970703207;3097.7212050915527;3102.053873568538;3105.9223519412194;3108.5026395776567;558.6731761919242;562.5471495446205;570.6319423971515;585.6047168161474;592.6414519215898;511.48340176422084;516.8139469790872;540.3488796000888;657.9769708060195;697.7614733847462;7634.122075961224;7773.5724535149975;8018.358531317481;8064.233897779702;8100.513969161869;516.5299577384562;546.5818648733722;575.5395683453221;586.5747333183408;625.3558834400575;3710.979480642845;3804.3152232597845;3889.86385476507;3922.529296484383;4031.657309128698;50881.23678144831;50989.49010509848;51176;51446;51520;48681.02637947221;48805.75597122063;49222.261666075035;49266;50021.749891250314;43582.56417435785;44221.55778442239;44482.55517444849;45558.772206138754;46305.536944630796;8484.957575212084;8489.235968762594;8519.403641745019;8534.274586659954;8711.869321960303;34573;35016;35927.28145437129;36927.81536092302;37303;42150.36774448447;42680.14639707251;42702;42809;43492.34761478517;10079.445630490394;10139.106631827797;10810.51352689115;10917.890821091687;11117.83323250168;10346.750582564951;10501.474926253504;10677.893221068001;10843.078338341014;10986.835197472205;10541.736456588647;10658.840117398091;10867.239293249713;10986.285891417032;11009.119270458184;11020.118390528898;11268.83096753533;11271.323720576791;11536.365499897585;11932.64934470423;10745.946270268598;10822.350658960488;10917.072048875934;11484.712882178012;11604;9502.762430939281;9530.618775248913;9814;9980.800383992424;10069.647562335284;8466.619002145042;8766.386352955487;8775.473471591726;9435.811283774148;9662.75843103928 08:15:05 INFO - PROCESS | 31578 | __end_tp_report 08:15:05 INFO - PROCESS | 31578 | __start_cc_report 08:15:05 INFO - PROCESS | 31578 | _x_x_mozilla_cycle_collect,857 08:15:05 INFO - PROCESS | 31578 | __end_cc_report 08:15:05 INFO - PROCESS | 31578 | __startTimestamp1452010505932__endTimestamp 08:15:05 INFO - PROCESS | 31578 | 08:15:05 INFO - PROCESS | 31578 | ------- Summary: start ------- 08:15:05 INFO - PROCESS | 31578 | Number of tests: 6 08:15:05 INFO - PROCESS | 31578 | 08:15:05 INFO - PROCESS | 31578 | [#0] dojo.html Cycles:165 Average:5291.26 Median:5521.17 stddev:582.04 (10.5%) stddev-sans-first:557.30 08:15:05 INFO - PROCESS | 31578 | Values: 3076.8 3133.9 3176.0 3177.3 3212.5 5151.3 5270.8 5285.9 5291.2 5339.7 5245.8 5266.6 5324.9 5372.2 5380.6 4856.7 4869.7 4887.9 4899.3 4940.7 4948.7 4950.3 4989.5 4991.4 5014.2 4766.7 4784.7 4857.2 4934.9 4937.7 4884.6 4889.0 4893.7 4899.9 4901.1 4790.3 4832.7 4855.8 4856.0 4892.2 5017.9 5116.0 5137.6 5179.2 5242.7 5523.7 5582.9 5643.3 5648.2 5696.0 5781.3 5784.9 5804.7 5804.7 5806.8 5205.7 5325.3 5369.9 5387.4 5392.1 5814.9 5831.1 5896.4 5913.9 5925.8 5613.4 5615.5 5619.3 5620.0 5623.6 5543.8 5636.7 5643.2 5657.9 5706.2 5647.1 5726.9 5735.7 5743.2 5761.4 5678.3 5679.8 5681.3 5687.0 5688.7 4344.3 4406.2 4411.1 4435.0 4468.2 3908.4 3913.8 3916.0 3920.0 3938.9 5351.1 5366.3 5367.7 5369.3 5412.7 5559.2 5690.5 5697.8 5738.6 5752.2 5256.8 5274.9 5298.1 5307.2 5353.3 4897.4 4897.8 4901.4 4909.8 4952.6 5803.7 5956.8 5964.9 5968.4 5986.6 5641.0 5657.7 5765.1 5769.7 5800.2 5737.6 5747.0 5759.0 5800.7 5802.9 5640.0 5644.5 5645.7 5646.7 5651.7 5571.6 5601.7 5635.3 5698.0 5738.6 5529.4 5529.5 5530.7 5540.3 5541.2 5516.9 5520.7 5521.2 5522.9 5573.2 5267.4 5324.0 5369.3 5388.6 5474.6 5660.1 5682.9 5683.6 5688.9 5694.7 5526.0 5533.9 5535.8 5538.4 5540.3 08:15:05 INFO - PROCESS | 31578 | 08:15:05 INFO - PROCESS | 31578 | [#1] ext.html Cycles:180 Average:41657.04 Median:33158.59 stddev:65057.82 (196.2%) stddev-sans-first:65167.06 08:15:05 INFO - PROCESS | 31578 | Values: 538.6 539.4 558.6 561.9 572.2 25388.7 25901.4 39292.8 39895.4 39953.0 42279.6 42382.0 42535.8 42650.8 42723.6 7449.6 8614.4 8771.6 8783.6 8789.0 7491.7 10129.8 10316.5 10324.0 10326.0 10007.6 10102.3 10107.8 10110.1 10116.1 7639.6 7788.3 10072.1 10168.9 10390.8 9890.3 10031.1 10036.4 10038.8 10041.3 35815.5 36111.0 36194.1 36213.0 36259.1 3079.7 3254.2 3701.6 3753.9 3839.7 29730.1 29870.9 30006.4 30096.8 30357.8 3449.7 3457.6 3502.4 3547.9 3676.3 178970.0 180010.0 180223.0 180632.0 180699.0 53518.5 57479.7 57864.4 57929.7 57987.0 48440.3 65924.3 66775.7 67004.7 67088.0 13088.1 13125.3 13171.5 13215.5 13222.5 9549.4 9559.1 9566.1 9569.2 9569.9 19357.4 19637.9 19660.8 19690.7 20325.3 7691.9 7887.3 7894.9 8022.3 8046.8 917.1 940.8 945.6 1051.4 1068.7 27965.2 27990.4 28123.9 28372.3 28422.3 999.0 1013.1 1020.3 1062.5 1096.8 14224.4 14482.1 14514.0 14766.6 14864.9 302780.0 307823.0 308475.0 308922.0 310062.0 50478.7 51163.2 51198.2 51206.7 51275.2 1301.8 1323.9 1331.9 1332.5 1338.0 25800.4 26245.0 27707.0 27763.4 30043.0 44912.6 45440.3 45491.5 45538.0 45562.8 239430.0 241422.0 243772.0 244860.0 245484.0 27633.4 28201.7 28576.9 31903.4 32129.7 36027.3 39565.2 40030.4 40275.8 40572.5 34244.3 34652.3 34691.5 34809.5 39838.8 31636.4 34617.3 35008.3 35649.5 36170.0 33152.0 33215.2 33478.2 33511.5 35033.3 31238.2 33022.8 33141.3 33165.2 33343.3 24504.0 24882.0 24997.0 25129.4 25266.5 08:15:05 INFO - PROCESS | 31578 | 08:15:05 INFO - PROCESS | 31578 | [#2] jquery.html Cycles:180 Average:28618.17 Median:363.77 stddev:85601.28 (23531.5%) stddev-sans-first:85815.12 08:15:05 INFO - PROCESS | 31578 | Values: 363.2 364.4 364.8 365.2 365.8 13100.0 13216.5 16060.5 16404.8 17221.2 15082.3 16276.2 16481.6 16813.9 16911.6 5269.1 5395.3 5397.4 5397.5 5399.6 4096.3 4168.4 5375.7 5408.7 5773.4 5792.3 5818.2 5843.1 5846.9 5853.4 5667.1 5787.7 5814.1 5832.2 5836.5 5121.5 5149.5 5169.8 5171.6 5172.6 19148.7 19316.5 19630.5 19633.4 19643.8 2230.7 2297.1 2297.9 2320.2 2328.9 12935.5 13055.7 13064.2 13124.8 13603.7 1884.7 1908.5 1952.2 1958.0 1966.3 59711.4 62310.4 63522.7 67388.0 69268.3 15361.3 15395.5 15425.2 15430.8 15507.3 23912.3 24011.5 24039.3 24180.5 24191.4 8322.0 8327.5 8369.4 8381.0 8707.6 6917.2 6929.3 6950.2 6992.9 6996.4 7662.6 7787.0 7797.5 7832.6 7872.8 2706.8 2982.2 2985.8 3020.7 3072.4 828.7 888.9 889.9 987.4 987.9 16365.5 16530.2 16545.7 16825.7 16897.8 816.2 849.0 874.7 921.4 954.3 7804.3 8903.0 9118.3 9494.8 10054.1 453337.0 523423.0 528828.0 534560.0 576080.0 63249.0 68678.7 69681.3 72269.6 75497.6 1055.8 1099.6 1103.0 1104.0 1117.7 14255.4 15069.8 15628.4 15693.7 15777.3 34671.1 35417.5 35651.8 35760.8 36154.3 46317.8 47199.8 47572.3 48398.3 49109.5 9328.4 9700.1 9794.8 9918.8 9949.5 11436.2 11437.7 11526.3 11540.4 13152.3 13450.9 13922.3 14194.5 14262.6 14422.3 12637.3 12673.2 14152.2 14303.1 14508.8 14032.2 14062.7 14395.7 14515.1 14541.7 8303.3 8588.0 9393.9 9829.2 9921.4 9932.4 10039.8 10080.1 11874.4 14628.6 08:15:05 INFO - PROCESS | 31578 | 08:15:05 INFO - PROCESS | 31578 | [#3] mootools.html Cycles:180 Average:5256.57 Median:6074.64 stddev:2731.91 (45.0%) stddev-sans-first:2723.13 08:15:05 INFO - PROCESS | 31578 | Values: 1269.5 1425.9 1439.6 1570.2 1747.7 6767.7 7422.6 7525.7 7528.2 7536.5 7311.6 7430.4 7505.0 7520.5 7554.8 2289.6 2310.8 2311.9 2328.3 2335.0 2304.9 2335.6 2363.3 2368.2 2372.9 2231.6 2232.3 2239.4 2322.6 2343.1 2192.4 2273.0 2297.3 2300.0 2300.6 2312.9 2342.9 2343.7 2346.2 2347.9 7536.4 7607.8 7639.3 7645.7 7654.4 4554.0 4632.9 4661.0 4663.7 4667.9 2949.5 2963.6 3037.3 3040.5 3061.8 928.9 954.6 980.5 993.6 995.5 10490.9 10498.6 10507.6 10510.7 10519.4 4041.0 4068.5 4106.2 4113.5 4135.6 8981.7 9007.2 9007.4 9011.2 9029.7 4552.5 4574.3 4586.7 4592.1 4595.8 3797.7 3873.6 4149.5 4181.7 4272.1 3512.2 3517.8 3547.8 3571.5 3574.5 1162.7 1170.2 1201.9 1205.6 1209.7 1237.6 1247.7 1252.9 1268.8 1270.1 6950.2 7018.8 7034.5 7042.9 7046.4 466.7 467.3 477.9 484.8 485.2 5261.0 5262.9 5301.8 5302.3 5310.8 8789.7 8933.5 9096.9 9098.1 9224.4 8947.6 8968.7 9037.3 9060.5 9103.2 6909.0 7151.9 7170.0 7170.7 7186.6 6640.8 6682.7 6705.6 6715.3 6716.9 7832.3 8132.2 8137.8 8256.2 8271.7 8180.9 8356.2 8398.5 8460.0 8476.3 5909.7 6230.7 6441.6 6605.3 6639.9 7095.6 7123.6 7127.9 7158.4 7173.1 6524.4 6695.9 6704.2 6786.3 6865.3 6365.4 6401.4 6582.9 6670.9 6694.0 6774.9 6797.9 6804.7 6806.5 6810.9 5908.7 6193.8 6206.9 6207.8 6219.4 6029.2 6052.0 6072.1 6074.0 6075.3 08:15:05 INFO - PROCESS | 31578 | 08:15:05 INFO - PROCESS | 31578 | [#4] prototype.html Cycles:180 Average:5252.20 Median:5882.79 stddev:1569.14 (26.7%) stddev-sans-first:1529.61 08:15:05 INFO - PROCESS | 31578 | Values: 339.9 343.7 347.5 348.7 350.4 5745.0 5799.2 5821.5 5849.1 5853.6 5670.5 5844.2 5846.3 5849.1 5867.6 4550.6 4580.7 4584.8 4589.1 4590.1 4361.9 4423.8 4501.4 4575.3 4630.2 4569.1 4570.4 4571.5 4577.0 4596.4 4566.4 4567.4 4570.3 4579.7 4592.0 4058.2 4064.7 4069.3 4074.8 4075.7 5514.9 5642.7 5659.9 5670.7 5673.6 5275.6 5278.0 5279.2 5280.9 5286.5 5832.7 6264.6 6265.2 6278.6 6279.5 4226.7 4274.0 4395.0 4396.4 4397.1 6466.8 6521.1 6545.0 6547.4 6564.0 4482.6 4487.9 4489.0 4493.0 4495.7 4467.2 4543.5 4548.8 4563.1 4578.9 5251.7 5256.2 5256.7 5260.4 5268.3 6280.6 6302.2 6319.4 6321.8 6335.0 1588.2 1608.5 1610.4 1610.5 1611.3 1073.0 1082.5 1088.1 1098.0 1116.4 5910.8 5913.0 5915.9 5922.5 5922.5 6430.5 6445.3 6453.8 6477.1 6484.9 5898.0 5900.6 5906.0 5914.1 5917.8 3411.3 3484.8 3485.7 3489.0 3491.3 6700.7 6722.7 6772.1 6782.2 6784.5 6653.4 6673.9 6676.1 6677.1 6679.4 6553.7 6746.8 6751.6 6757.0 6810.1 6217.9 6348.0 6522.0 6525.4 6532.6 6285.7 6365.6 6447.0 6451.6 6474.6 6661.9 6691.1 6710.5 6763.8 6776.8 4345.3 4471.6 4503.0 4513.2 4516.0 6388.1 6397.9 6401.3 6451.6 6466.5 6322.0 6326.3 6331.5 6332.7 6348.4 6211.3 6286.5 6325.7 6334.4 6335.0 6066.5 6085.0 6085.7 6089.1 6090.6 6339.2 6347.4 6353.3 6356.5 6357.5 6036.5 6140.0 6153.6 6155.4 6168.7 08:15:05 INFO - PROCESS | 31578 | 08:15:05 INFO - PROCESS | 31578 | [#5] yui.html Cycles:180 Average:13437.01 Median:45020.66 stddev:15147.47 (33.6%) stddev-sans-first:15159.75 08:15:05 INFO - PROCESS | 31578 | Values: 696.7 709.4 726.8 727.1 753.5 15335.2 15441.3 15515.5 15521.2 15532.3 14616.9 14717.7 14719.9 14733.2 14763.0 669.9 675.7 795.1 796.1 808.0 795.6 799.8 800.3 805.8 806.5 818.2 824.0 825.8 826.6 827.1 689.1 696.8 826.6 838.0 838.9 620.1 620.4 620.7 621.0 621.2 13941.0 14066.5 14079.6 14099.4 14101.4 11871.3 12063.8 12111.2 12145.7 12184.8 9947.8 10045.9 10117.2 10143.4 10921.4 3551.9 3645.6 3662.3 3701.2 3707.2 46273.3 46833.3 46885.5 46919.5 46954.5 9683.1 9918.2 10151.9 10310.4 10331.1 17663.6 17720.7 17787.0 17801.9 17852.0 7363.3 7416.2 7703.5 7736.2 7738.1 4250.6 4262.7 4279.5 4307.4 4386.1 3063.7 3097.7 3102.1 3105.9 3108.5 558.7 562.5 570.6 585.6 592.6 511.5 516.8 540.3 658.0 697.8 7634.1 7773.6 8018.4 8064.2 8100.5 516.5 546.6 575.5 586.6 625.4 3711.0 3804.3 3889.9 3922.5 4031.7 50881.2 50989.5 51176.0 51446.0 51520.0 48681.0 48805.8 49222.3 49266.0 50021.7 43582.6 44221.6 44482.6 45558.8 46305.5 8485.0 8489.2 8519.4 8534.3 8711.9 34573.0 35016.0 35927.3 36927.8 37303.0 42150.4 42680.1 42702.0 42809.0 43492.3 10079.4 10139.1 10810.5 10917.9 11117.8 10346.8 10501.5 10677.9 10843.1 10986.8 10541.7 10658.8 10867.2 10986.3 11009.1 11020.1 11268.8 11271.3 11536.4 11932.6 10745.9 10822.4 10917.1 11484.7 11604.0 9502.8 9530.6 9814.0 9980.8 10069.6 8466.6 8766.4 8775.5 9435.8 9662.8 08:15:05 INFO - PROCESS | 31578 | -------- Summary: end -------- 08:15:05 INFO - PROCESS | 31578 | 08:15:06 INFO - TEST-INFO | 31578: exit 0 08:15:06 INFO - TEST-OK | dromaeo_css | took 1113331ms 08:15:06 INFO - TEST-START | kraken 08:15:06 INFO - operating with platform_type : linux_ 08:15:06 INFO - Initialising browser for kraken test... 08:15:06 INFO - TEST-INFO | started process 31767 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPLj6IM/profile http://localhost:33158/getInfo.html) 08:15:10 INFO - PROCESS | 31767 | __metrics Screen width/height:1600/1200 08:15:10 INFO - PROCESS | 31767 | colorDepth:24 08:15:10 INFO - PROCESS | 31767 | Browser inner width/height: 1024/697 08:15:10 INFO - PROCESS | 31767 | __metrics 08:15:10 INFO - PROCESS | 31767 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:15:10 INFO - PROCESS | 31767 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:15:11 INFO - TEST-INFO | 31767: exit 0 08:15:11 INFO - Browser initialized. 08:15:11 INFO - Running cycle 1/1 for kraken test... 08:15:11 INFO - TEST-INFO | started process 31847 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPLj6IM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:15:23 INFO - PROCESS | 31847 | RSS: Main: 149901312 08:15:23 INFO - PROCESS | 31847 | 08:15:25 INFO - PROCESS | 31847 | Cycle 1(1): loaded http://localhost:33158/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33158/tests/kraken/driver.html?testName=audio-beat-detection) 08:15:26 INFO - PROCESS | 31847 | RSS: Main: 184074240 08:15:26 INFO - PROCESS | 31847 | 08:15:28 INFO - PROCESS | 31847 | Cycle 1(1): loaded http://localhost:33158/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33158/tests/kraken/driver.html?testName=audio-dft) 08:15:29 INFO - PROCESS | 31847 | RSS: Main: 174059520 08:15:29 INFO - PROCESS | 31847 | 08:15:32 INFO - PROCESS | 31847 | Cycle 1(1): loaded http://localhost:33158/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33158/tests/kraken/driver.html?testName=audio-fft) 08:15:32 INFO - PROCESS | 31847 | RSS: Main: 160284672 08:15:32 INFO - PROCESS | 31847 | 08:15:34 INFO - PROCESS | 31847 | Cycle 1(1): loaded http://localhost:33158/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33158/tests/kraken/driver.html?testName=audio-oscillator) 08:15:35 INFO - PROCESS | 31847 | RSS: Main: 161763328 08:15:35 INFO - PROCESS | 31847 | 08:15:37 INFO - PROCESS | 31847 | Cycle 1(1): loaded http://localhost:33158/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33158/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:15:38 INFO - PROCESS | 31847 | RSS: Main: 165146624 08:15:38 INFO - PROCESS | 31847 | 08:15:41 INFO - PROCESS | 31847 | Cycle 1(1): loaded http://localhost:33158/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33158/tests/kraken/driver.html?testName=imaging-darkroom) 08:15:41 INFO - PROCESS | 31847 | RSS: Main: 165543936 08:15:41 INFO - PROCESS | 31847 | 08:15:45 INFO - PROCESS | 31847 | Cycle 1(1): loaded http://localhost:33158/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33158/tests/kraken/driver.html?testName=imaging-desaturate) 08:15:45 INFO - PROCESS | 31847 | RSS: Main: 166813696 08:15:45 INFO - PROCESS | 31847 | 08:15:48 INFO - PROCESS | 31847 | Cycle 1(1): loaded http://localhost:33158/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33158/tests/kraken/driver.html?testName=json-parse-financial) 08:15:49 INFO - PROCESS | 31847 | RSS: Main: 166105088 08:15:49 INFO - PROCESS | 31847 | 08:15:50 INFO - PROCESS | 31847 | Cycle 1(1): loaded http://localhost:33158/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33158/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:15:51 INFO - PROCESS | 31847 | RSS: Main: 176820224 08:15:51 INFO - PROCESS | 31847 | 08:15:52 INFO - PROCESS | 31847 | Cycle 1(1): loaded http://localhost:33158/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33158/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:15:53 INFO - PROCESS | 31847 | RSS: Main: 175652864 08:15:53 INFO - PROCESS | 31847 | 08:15:55 INFO - PROCESS | 31847 | Cycle 1(1): loaded http://localhost:33158/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33158/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:15:56 INFO - PROCESS | 31847 | RSS: Main: 183922688 08:15:56 INFO - PROCESS | 31847 | 08:15:58 INFO - PROCESS | 31847 | Cycle 1(1): loaded http://localhost:33158/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33158/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:15:59 INFO - PROCESS | 31847 | RSS: Main: 194322432 08:15:59 INFO - PROCESS | 31847 | 08:16:01 INFO - PROCESS | 31847 | Cycle 1(1): loaded http://localhost:33158/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33158/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:16:02 INFO - PROCESS | 31847 | RSS: Main: 191696896 08:16:02 INFO - PROCESS | 31847 | 08:16:04 INFO - PROCESS | 31847 | Cycle 1(1): loaded http://localhost:33158/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33158/tests/kraken/driver.html?testName=ai-astar) 08:16:04 INFO - PROCESS | 31847 | RSS: Main: 249638912 08:16:04 INFO - PROCESS | 31847 | 08:16:04 INFO - PROCESS | 31847 | __start_tp_report 08:16:04 INFO - PROCESS | 31847 | _x_x_mozilla_page_load 08:16:04 INFO - PROCESS | 31847 | _x_x_mozilla_page_load_details 08:16:04 INFO - PROCESS | 31847 | |i|pagename|runs| 08:16:04 INFO - PROCESS | 31847 | |0;ai-astar;110;109;102;109;111;109;100;109;108;110 08:16:04 INFO - PROCESS | 31847 | |1;audio-beat-detection;151;127;149;164;127;161;151;134;164;135 08:16:04 INFO - PROCESS | 31847 | |2;audio-dft;162;160;160;160;160;161;160;162;161;162 08:16:04 INFO - PROCESS | 31847 | |3;audio-fft;72;71;87;92;71;71;72;106;92;72 08:16:04 INFO - PROCESS | 31847 | |4;audio-oscillator;96;96;137;95;96;96;139;95;96;135 08:16:04 INFO - PROCESS | 31847 | |5;imaging-gaussian-blur;109;109;109;109;108;109;110;110;109;109 08:16:04 INFO - PROCESS | 31847 | |6;imaging-darkroom;146;145;146;146;145;146;145;146;145;145 08:16:04 INFO - PROCESS | 31847 | |7;imaging-desaturate;95;96;97;96;95;96;95;96;95;96 08:16:04 INFO - PROCESS | 31847 | |8;json-parse-financial;57;57;58;56;56;57;56;58;58;55 08:16:04 INFO - PROCESS | 31847 | |9;json-stringify-tinderbox;68;69;68;68;68;69;69;67;67;69 08:16:04 INFO - PROCESS | 31847 | |10;stanford-crypto-aes;83;87;86;85;93;85;86;87;88;100 08:16:04 INFO - PROCESS | 31847 | |11;stanford-crypto-ccm;120;127;119;132;116;116;116;124;125;117 08:16:04 INFO - PROCESS | 31847 | |12;stanford-crypto-pbkdf2;156;145;150;152;149;142;152;154;149;146 08:16:04 INFO - PROCESS | 31847 | |13;stanford-crypto-sha256-iterative;67;67;68;68;70;69;69;70;69;69 08:16:04 INFO - PROCESS | 31847 | __end_tp_report 08:16:04 INFO - PROCESS | 31847 | __start_cc_report 08:16:04 INFO - PROCESS | 31847 | _x_x_mozilla_cycle_collect,941 08:16:04 INFO - PROCESS | 31847 | __end_cc_report 08:16:04 INFO - PROCESS | 31847 | __startTimestamp1452010564345__endTimestamp 08:16:04 INFO - PROCESS | 31847 | 08:16:04 INFO - PROCESS | 31847 | ------- Summary: start ------- 08:16:04 INFO - PROCESS | 31847 | Number of tests: 14 08:16:04 INFO - PROCESS | 31847 | 08:16:04 INFO - PROCESS | 31847 | [#0] ai-astar Cycles:10 Average:107.70 Median:109.00 stddev:3.65 (3.4%) stddev-sans-first:3.78 08:16:04 INFO - PROCESS | 31847 | Values: 110.0 109.0 102.0 109.0 111.0 109.0 100.0 109.0 108.0 110.0 08:16:04 INFO - PROCESS | 31847 | 08:16:04 INFO - PROCESS | 31847 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:151.00 stddev:14.60 (9.7%) stddev-sans-first:15.38 08:16:04 INFO - PROCESS | 31847 | Values: 151.0 127.0 149.0 164.0 127.0 161.0 151.0 134.0 164.0 135.0 08:16:04 INFO - PROCESS | 31847 | 08:16:04 INFO - PROCESS | 31847 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 08:16:04 INFO - PROCESS | 31847 | Values: 162.0 160.0 160.0 160.0 160.0 161.0 160.0 162.0 161.0 162.0 08:16:04 INFO - PROCESS | 31847 | 08:16:04 INFO - PROCESS | 31847 | [#3] audio-fft Cycles:10 Average:80.60 Median:72.00 stddev:12.67 (17.6%) stddev-sans-first:13.05 08:16:04 INFO - PROCESS | 31847 | Values: 72.0 71.0 87.0 92.0 71.0 71.0 72.0 106.0 92.0 72.0 08:16:04 INFO - PROCESS | 31847 | 08:16:04 INFO - PROCESS | 31847 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:96.00 stddev:19.97 (20.8%) stddev-sans-first:20.69 08:16:04 INFO - PROCESS | 31847 | Values: 96.0 96.0 137.0 95.0 96.0 96.0 139.0 95.0 96.0 135.0 08:16:04 INFO - PROCESS | 31847 | 08:16:04 INFO - PROCESS | 31847 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 08:16:04 INFO - PROCESS | 31847 | Values: 109.0 109.0 109.0 109.0 108.0 109.0 110.0 110.0 109.0 109.0 08:16:04 INFO - PROCESS | 31847 | 08:16:04 INFO - PROCESS | 31847 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 08:16:04 INFO - PROCESS | 31847 | Values: 146.0 145.0 146.0 146.0 145.0 146.0 145.0 146.0 145.0 145.0 08:16:04 INFO - PROCESS | 31847 | 08:16:04 INFO - PROCESS | 31847 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 08:16:04 INFO - PROCESS | 31847 | Values: 95.0 96.0 97.0 96.0 95.0 96.0 95.0 96.0 95.0 96.0 08:16:04 INFO - PROCESS | 31847 | 08:16:04 INFO - PROCESS | 31847 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:57.00 stddev:1.03 (1.8%) stddev-sans-first:1.09 08:16:04 INFO - PROCESS | 31847 | Values: 57.0 57.0 58.0 56.0 56.0 57.0 56.0 58.0 58.0 55.0 08:16:04 INFO - PROCESS | 31847 | 08:16:04 INFO - PROCESS | 31847 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.50 stddev:0.79 (1.2%) stddev-sans-first:0.83 08:16:04 INFO - PROCESS | 31847 | Values: 68.0 69.0 68.0 68.0 68.0 69.0 69.0 67.0 67.0 69.0 08:16:04 INFO - PROCESS | 31847 | 08:16:04 INFO - PROCESS | 31847 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:86.50 stddev:4.97 (5.7%) stddev-sans-first:4.93 08:16:04 INFO - PROCESS | 31847 | Values: 83.0 87.0 86.0 85.0 93.0 85.0 86.0 87.0 88.0 100.0 08:16:04 INFO - PROCESS | 31847 | 08:16:04 INFO - PROCESS | 31847 | [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:122.00 stddev:5.55 (4.6%) stddev-sans-first:5.87 08:16:04 INFO - PROCESS | 31847 | Values: 120.0 127.0 119.0 132.0 116.0 116.0 116.0 124.0 125.0 117.0 08:16:04 INFO - PROCESS | 31847 | 08:16:04 INFO - PROCESS | 31847 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.50 Median:151.00 stddev:4.28 (2.8%) stddev-sans-first:3.83 08:16:04 INFO - PROCESS | 31847 | Values: 156.0 145.0 150.0 152.0 149.0 142.0 152.0 154.0 149.0 146.0 08:16:04 INFO - PROCESS | 31847 | 08:16:04 INFO - PROCESS | 31847 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.07 (1.6%) stddev-sans-first:0.97 08:16:04 INFO - PROCESS | 31847 | Values: 67.0 67.0 68.0 68.0 70.0 69.0 69.0 70.0 69.0 69.0 08:16:04 INFO - PROCESS | 31847 | -------- Summary: end -------- 08:16:04 INFO - PROCESS | 31847 | 08:16:05 INFO - TEST-INFO | 31847: exit 0 08:16:05 INFO - TEST-OK | kraken | took 58651ms 08:16:05 INFO - TEST-START | v8_7 08:16:05 INFO - operating with platform_type : linux_ 08:16:05 INFO - Initialising browser for v8_7 test... 08:16:05 INFO - TEST-INFO | started process 32095 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp60X0sj/profile http://localhost:33158/getInfo.html) 08:16:09 INFO - PROCESS | 32095 | __metrics Screen width/height:1600/1200 08:16:09 INFO - PROCESS | 32095 | colorDepth:24 08:16:09 INFO - PROCESS | 32095 | Browser inner width/height: 1024/697 08:16:09 INFO - PROCESS | 32095 | __metrics 08:16:09 INFO - PROCESS | 32095 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:16:09 INFO - PROCESS | 32095 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:16:10 INFO - TEST-INFO | 32095: exit 0 08:16:10 INFO - Browser initialized. 08:16:10 INFO - Running cycle 1/1 for v8_7 test... 08:16:10 INFO - TEST-INFO | started process 32178 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp60X0sj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:16:21 INFO - PROCESS | 32178 | RSS: Main: 149856256 08:16:21 INFO - PROCESS | 32178 | 08:16:43 INFO - PROCESS | 32178 | Cycle 1(1): loaded http://localhost:33158/tests/v8_7/run.html (next: http://localhost:33158/tests/v8_7/run.html) 08:16:43 INFO - PROCESS | 32178 | RSS: Main: 543748096 08:16:43 INFO - PROCESS | 32178 | 08:16:43 INFO - PROCESS | 32178 | __start_tp_report 08:16:43 INFO - PROCESS | 32178 | _x_x_mozilla_page_load 08:16:43 INFO - PROCESS | 32178 | _x_x_mozilla_page_load_details 08:16:43 INFO - PROCESS | 32178 | |i|pagename|runs| 08:16:43 INFO - PROCESS | 32178 | |0;Richards;166.16816218012627 08:16:43 INFO - PROCESS | 32178 | |1;DeltaBlue;191.16803670426305 08:16:43 INFO - PROCESS | 32178 | |2;Encrypt;281.29395218002816 08:16:43 INFO - PROCESS | 32178 | |3;Decrypt;5235.602094240838 08:16:43 INFO - PROCESS | 32178 | |4;RayTrace;1103.7527593818984 08:16:43 INFO - PROCESS | 32178 | |5;Earley;794.912559618442 08:16:43 INFO - PROCESS | 32178 | |6;Boyer;12530.864197530864 08:16:43 INFO - PROCESS | 32178 | |7;RegExp;26421.052631578947 08:16:43 INFO - PROCESS | 32178 | |8;Splay;593.1198102016607 08:16:43 INFO - PROCESS | 32178 | |9;NavierStokes;4830.917874396136 08:16:43 INFO - PROCESS | 32178 | __end_tp_report 08:16:43 INFO - PROCESS | 32178 | __startTimestamp1452010603423__endTimestamp 08:16:43 INFO - PROCESS | 32178 | 08:16:43 INFO - PROCESS | 32178 | ------- Summary: start ------- 08:16:43 INFO - PROCESS | 32178 | Number of tests: 10 08:16:43 INFO - PROCESS | 32178 | 08:16:43 INFO - PROCESS | 32178 | [#0] Richards Cycles:1 Average:166.17 Median:166.17 stddev:0.00 (0.0%) 08:16:43 INFO - PROCESS | 32178 | Values: 166.2 08:16:43 INFO - PROCESS | 32178 | 08:16:43 INFO - PROCESS | 32178 | [#1] DeltaBlue Cycles:1 Average:191.17 Median:191.17 stddev:0.00 (0.0%) 08:16:43 INFO - PROCESS | 32178 | Values: 191.2 08:16:43 INFO - PROCESS | 32178 | 08:16:43 INFO - PROCESS | 32178 | [#2] Encrypt Cycles:1 Average:281.29 Median:281.29 stddev:0.00 (0.0%) 08:16:43 INFO - PROCESS | 32178 | Values: 281.3 08:16:43 INFO - PROCESS | 32178 | 08:16:43 INFO - PROCESS | 32178 | [#3] Decrypt Cycles:1 Average:5235.60 Median:5235.60 stddev:0.00 (0.0%) 08:16:43 INFO - PROCESS | 32178 | Values: 5235.6 08:16:43 INFO - PROCESS | 32178 | 08:16:43 INFO - PROCESS | 32178 | [#4] RayTrace Cycles:1 Average:1103.75 Median:1103.75 stddev:0.00 (0.0%) 08:16:43 INFO - PROCESS | 32178 | Values: 1103.8 08:16:43 INFO - PROCESS | 32178 | 08:16:43 INFO - PROCESS | 32178 | [#5] Earley Cycles:1 Average:794.91 Median:794.91 stddev:0.00 (0.0%) 08:16:43 INFO - PROCESS | 32178 | Values: 794.9 08:16:43 INFO - PROCESS | 32178 | 08:16:43 INFO - PROCESS | 32178 | [#6] Boyer Cycles:1 Average:12530.86 Median:12530.86 stddev:0.00 (0.0%) 08:16:43 INFO - PROCESS | 32178 | Values: 12530.9 08:16:43 INFO - PROCESS | 32178 | 08:16:43 INFO - PROCESS | 32178 | [#7] RegExp Cycles:1 Average:26421.05 Median:26421.05 stddev:0.00 (0.0%) 08:16:43 INFO - PROCESS | 32178 | Values: 26421.1 08:16:43 INFO - PROCESS | 32178 | 08:16:43 INFO - PROCESS | 32178 | [#8] Splay Cycles:1 Average:593.12 Median:593.12 stddev:0.00 (0.0%) 08:16:43 INFO - PROCESS | 32178 | Values: 593.1 08:16:43 INFO - PROCESS | 32178 | 08:16:43 INFO - PROCESS | 32178 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 08:16:43 INFO - PROCESS | 32178 | Values: 4830.9 08:16:43 INFO - PROCESS | 32178 | -------- Summary: end -------- 08:16:43 INFO - PROCESS | 32178 | 08:16:44 INFO - TEST-INFO | 32178: exit 0 08:16:44 INFO - TEST-OK | v8_7 | took 39012ms 08:16:44 INFO - SUITE-END | took 1210s 08:16:44 INFO - Completed test suite (00:20:11) 08:16:44 INFO - Working with test: dromaeo_css 08:16:44 INFO - Generating results file: dromaeo_css 08:16:44 INFO - Working with test: kraken 08:16:44 INFO - Generating results file: kraken 08:16:44 INFO - javascript benchmark 08:16:44 INFO - Working with test: v8_7 08:16:44 INFO - Generating results file: v8_7 08:16:44 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:16:44 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 08:16:44 INFO - process_Request line: dromaeo_css 6904.70 graph.html#tests=[[72,64,35]] 08:16:44 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:16:44 INFO - process_Request line: kraken 1506.10 graph.html#tests=[[232,64,35]] 08:16:44 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:16:44 INFO - process_Request line: v8_7 20915.34 graph.html#tests=[[230,64,35]] 08:16:44 INFO - RETURN: dromaeo_css: 6904.70 08:16:44 INFO - RETURN: kraken: 1506.10 08:16:44 INFO - RETURN: v8_7: 20915.34 08:16:44 INFO - javascript benchmark 08:16:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3076.769242306827, 3133.9216519586994, 3176.0, 3177.285110850059, 3212.518122281658, 5151.304573882525, 5270.762815673294, 5285.948932357776, 5291.2327712481665, 5339.706316152615, 5245.763940622672, 5266.552343050846, 5324.866878328034, 5372.167314066316, 5380.569554435646, 4856.708597484154, 4869.732164730938, 4887.926681099769, 4899.265110233458, 4940.703557786526, 4948.653594248404, 4950.331705219785, 4989.525995030466, 4991.376077990251, 5014.247862820588, 4766.666333356667, 4784.736839473828, 4857.1742803723455, 4934.851954441355, 4937.679050861682, 4884.633652476078, 4889.046635906, 4893.7063776173545, 4899.853004409873, 4901.1177987962155, 4790.305405716152, 4832.73419961902, 4855.781489832931, 4855.951440485621, 4892.168331383673, 5017.899642007176, 5116.0, 5137.588992880561, 5179.22311653255, 5242.659227150261, 5523.7238138093335, 5582.86042848928, 5643.294588176478, 5648.209250704905, 5695.971520142372, 5781.335146458169, 5784.913226301609, 5804.65172089676, 5804.738786754606, 5806.825795226107, 5205.7397130143345, 5325.334333208349, 5369.892602147975, 5387.434319396485, 5392.110301800199, 5814.94185058144, 5831.096180092008, 5896.439838215449, 5913.940860591339, 5925.792597259161, 5613.438656134354, 5615.494605485526, 5619.325680918316, 5620.044592419216, 5623.550115990711, 5543.833684989376, 5636.689982050944, 5643.209950606918, 5657.9434205658235, 5706.201131841545, 5647.068233741386, 5726.885462290731, 5735.7418916148035, 5743.2246646703, 5761.423857614205, 5678.290213723285, 5679.829605111853, 5681.318241811009, 5687.0, 5688.687122208318, 4344.348347747863, 4406.20688276107, 4411.073674528321, 4435.046465010038, 4468.195724769507, 3908.4332771747936, 3913.8238779254434, 3915.9608403915595, 3920.0395903003946, 3938.901527461779, 5351.063563876306, 5366.2755528004, 5367.651102678314, 5369.27514785499, 5412.675239485643, 5559.24950131727, 5690.459406356389, 5697.829065127969, 5738.5982981191755, 5752.223449834302, 5256.842294731164, 5274.92087618686, 5298.09932311508, 5307.203919412119, 5353.277307563507, 4897.3878265216845, 4897.755112244374, 4901.411830580282, 4909.803607855646, 4952.5542701157065, 5803.738831752581, 5956.761729530857, 5964.910526342108, 5968.373320801254, 5986.580939334205, 5640.971795140998, 5657.688827114548, 5765.106408506688, 5769.68266745333, 5800.187973683772, 5737.56968227393, 5746.9712651436475, 5759.0, 5800.651960882361, 5802.854928626649, 5640.041192997282, 5644.463775941279, 5645.745941432563, 5646.7458964347525, 5651.745671444713, 5571.60998730085, 5601.719914004365, 5635.295588051494, 5698.0, 5738.598298119092, 5529.364123125892, 5529.502344788988, 5530.695811730394, 5540.279763630702, 5541.224228607917, 5516.862078447911, 5520.66875987442, 5521.171824226398, 5522.861928451821, 5573.219749235192, 5267.394249661338, 5324.041672498987, 5369.3019907413345, 5388.595855310946, 5474.5894057945015, 5660.094384898396, 5682.886342273214, 5683.5737319700365, 5688.914666280092, 5694.658320500783, 5526.032944234823, 5533.916991245054, 5535.750891209825, 5538.418466061005, 5540.33515978069], "unit": "score", "name": "dojo.html", "value": 5253.518501308142}, {"lowerIsBetter": false, "replicates": [538.5718353908642, 539.3743257820926, 558.5866458820474, 561.8960492308926, 572.1789232451432, 25388.74611253887, 25901.35246618833, 39292.80353598235, 39895.41464195015, 39953.0, 42279.57720422795, 42382.0, 42535.78732106343, 42650.786746066224, 42723.57276427235, 7449.590272535009, 8614.353923455734, 8771.56142192891, 8783.560821958876, 8788.956055219747, 7491.66287517063, 10129.797404051915, 10316.484175791218, 10324.0, 10326.0, 10007.599696012187, 10102.343347682377, 10107.848382274235, 10110.090091891729, 10116.14012808912, 7639.579823109727, 7788.337991270749, 10072.09351158392, 10168.949155254213, 10390.844137337946, 9890.258230632731, 10031.097201251923, 10036.397816131055, 10038.799224015478, 10041.347312424741, 35815.4627680585, 36111.0, 36194.09514762126, 36213.00828454434, 36259.09352266188, 3079.676633953425, 3254.2027203335097, 3701.648343407399, 3753.8686145985034, 3839.731218814684, 29730.108096757132, 29870.85064574685, 30006.439150032267, 30096.8495157525, 30357.848210758806, 3449.6550344965553, 3457.619661837196, 3502.387082260594, 3547.8580856765698, 3676.2647470506004, 178970.0, 180010.0, 180223.0, 180632.0, 180699.0, 53518.46481535135, 57479.712601436724, 57864.421355785904, 57929.71035144882, 57987.0, 48440.27339589909, 65924.34075659278, 66775.66612167006, 67004.6649766748, 67088.0, 13088.08383413171, 13125.278109704059, 13171.47314107444, 13215.471381144838, 13222.471101156038, 9549.427034377959, 9559.091886270793, 9566.091221333962, 9569.234461243084, 9569.904300956901, 19357.353845231053, 19637.901810490857, 19660.803391965896, 19690.70463943042, 20325.2886148987, 7691.884621730678, 7887.290143886963, 7894.881576776353, 8022.2779949803635, 8046.798830029179, 917.0829170829038, 940.7601061729353, 945.5555888732284, 1051.4059556350637, 1068.6633710381204, 27965.16104516868, 27990.440191196063, 28123.859380702965, 28372.290692732433, 28422.289442763682, 998.9600415983425, 1013.1236480444362, 1020.2705065877933, 1062.4793851012948, 1096.8080585897435, 14224.359903804354, 14482.131072135706, 14514.044481259954, 14766.597173268523, 14864.925675371554, 302780.0, 307823.0, 308475.0, 308922.0, 310062.0, 50478.74760626247, 51163.232551511755, 51198.23202651963, 51206.74396628067, 51275.23087153696, 1301.8372703412074, 1323.8874695650784, 1331.9200847949155, 1332.5069724201912, 1338.0, 25800.354991125372, 26245.0, 27707.0, 27763.44473110567, 30043.0, 44912.550874492146, 45440.31839522344, 45491.54508454873, 45538.0, 45562.77218614018, 239430.0, 241422.0, 243772.0, 244860.0, 245484.0, 27633.447331052863, 28201.717982819908, 28576.857115714287, 31903.36193276168, 32129.67870321267, 36027.27945441129, 39565.2086958265, 40030.39954400628, 40275.79862100671, 40572.537020927084, 34244.31511369808, 34652.30695386028, 34691.47962780611, 34809.47785783266, 39838.80080599579, 31636.36727265488, 34617.30765384628, 35008.29983400369, 35649.46525802063, 36170.0, 33152.0, 33215.169620759676, 33478.16304592307, 33511.497327540594, 35033.29933401267, 31238.21904452407, 33022.83488582542, 33141.337173256885, 33165.17087072746, 33343.333133337685, 24504.0, 24882.0, 24997.024045710976, 25129.371765706004, 25266.494670106862], "unit": "score", "name": "ext.html", "value": 17836.24150996614}, {"lowerIsBetter": false, "replicates": [363.19008610797937, 364.35691005375514, 364.7574363048571, 365.1728834190558, 365.8244042859426, 13100.0, 13216.481308318243, 16060.518184454471, 16404.753928691065, 17221.22504487298, 15082.3212955417, 16276.186190690447, 16481.587960301, 16813.91593042033, 16911.57721056971, 5269.077911365505, 5395.271638328814, 5397.4062853086125, 5397.514223719864, 5399.649022813524, 4096.262672718909, 4168.353905144708, 5375.650582712131, 5408.702521361323, 5773.364929857712, 5792.275965504312, 5818.1854540364175, 5843.094320380348, 5846.941530584703, 5853.356130825627, 5667.064934285838, 5787.710614469302, 5814.127880817869, 5832.212651292085, 5836.474717275466, 5121.487851214886, 5149.45930677281, 5169.767360468788, 5171.612129090296, 5172.612054095958, 19148.712769308473, 19316.517087072796, 19630.50923726904, 19633.410997670093, 19643.80356196434, 2230.721159855018, 2297.1270917051415, 2297.8965946532444, 2320.2227253869974, 2328.860268383902, 12935.547255846, 13055.673608159777, 13064.150830196008, 13124.803127953088, 13603.727925441535, 1884.660761063008, 1908.456090014353, 1952.2386269354963, 1957.9510512237166, 1966.252823926913, 59711.40288597145, 62310.37689623091, 63522.682386587774, 67388.0, 69268.30731692669, 15361.308741106677, 15395.538133856002, 15425.228738563026, 15430.768538471932, 15507.302171402314, 23912.282631520735, 24011.51976960451, 24039.27882163538, 24180.51638967211, 24191.39521511941, 8321.958390208132, 8327.541985190752, 8369.414141010071, 8381.036180839159, 8707.564621769014, 6917.169939607279, 6929.341712537301, 6950.235474097845, 6992.930070699228, 6996.370326670522, 7662.578558179353, 7787.0, 7797.532148071134, 7832.647530861125, 7872.803179920434, 2706.7699245563954, 2982.164993801739, 2985.776066794999, 3020.6828283030404, 3072.4162409142637, 828.7348048624502, 888.9111088891059, 889.91971809254, 987.4075554667143, 987.9308448408686, 16365.509034728977, 16530.173491325386, 16545.66908661844, 16825.747613785803, 16897.831021689624, 816.1512027491461, 848.9830203395898, 874.6894852327332, 921.3642586615348, 954.346272803132, 7804.297613214838, 8903.0, 9118.270538356915, 9494.762630934281, 10054.145397641283, 453337.0, 523423.0, 528828.0, 534560.0, 576080.0, 63249.0, 68678.65660671664, 69681.3031869685, 72269.63865180641, 75497.62251188818, 1055.8152323343384, 1099.5766629847567, 1102.9724256893642, 1103.9944800275948, 1117.7038084907506, 14255.392125185504, 15069.849301506845, 15628.374865005273, 15693.686126277182, 15777.290021948811, 34671.13264349893, 35417.468737969466, 35651.75218867327, 35760.821195893855, 36154.27691446209, 46317.768411157725, 47199.76400117978, 47572.28641570448, 48398.27402589034, 49109.50890491192, 9328.440293582407, 9700.126988571063, 9794.804103917739, 9918.752031199278, 9949.452780097165, 11436.199466037298, 11437.714057148305, 11526.308421494738, 11540.365279909685, 13152.342382880626, 13450.932745336211, 13922.303884805922, 14194.503192388629, 14262.643433914234, 14422.278886055445, 12637.304948227937, 12673.239605623692, 14152.22162781057, 14303.141811491343, 14508.782368264696, 14032.22822744759, 14062.718745625234, 14395.712085758436, 14515.129092254498, 14541.709165816836, 8303.252707256375, 8588.0, 9393.85909211376, 9829.213662906806, 9921.355111917703, 9932.404055756677, 10039.799204016024, 10080.092791648787, 11874.406279685809, 14628.561143165722], "unit": "score", "name": "jquery.html", "value": 9267.395847549278}, {"lowerIsBetter": false, "replicates": [1269.4858582274182, 1425.8645428684279, 1439.5753252790425, 1570.1599644190353, 1747.729101989192, 6767.695453704583, 7422.6288685565705, 7525.698972041126, 7528.171901090889, 7536.4724469287175, 7311.597862117582, 7430.442716796235, 7505.0, 7520.511166774169, 7554.848903021936, 2289.599320118981, 2310.7689231076843, 2311.861288322706, 2328.313147621447, 2335.019291897407, 2304.896279667419, 2335.5912715274844, 2363.3382652857226, 2368.1948137633203, 2372.9406764830846, 2231.631780756173, 2232.3414592695194, 2239.3505883293824, 2322.6399908014287, 2343.086196383412, 2192.397090800027, 2272.9545409091807, 2297.322289924476, 2299.9885000574973, 2300.574393737156, 2312.9421764455856, 2342.8828558572172, 2343.7304709958403, 2346.21401830387, 2347.8708671023087, 7536.359409450203, 7607.80980475487, 7639.274268944441, 7645.732399366051, 7654.387648988068, 4553.977230113861, 4632.884177895546, 4660.976695116503, 4663.650226233012, 4667.929981050287, 2949.542820862748, 2963.5702823090533, 3037.2558723112757, 3040.452718510667, 3061.8009829361245, 928.9442633441947, 954.6420092465326, 980.5146452505984, 993.5513268813635, 995.512199022481, 10490.947545262225, 10498.632547860865, 10507.579696812118, 10510.737231569196, 10519.368837869675, 4040.9797951010055, 4068.4914385701786, 4106.2198182345255, 4113.547509773923, 4135.60711732385, 8981.730548083568, 9007.189352958265, 9007.369484136048, 9011.188992990663, 9029.729108126767, 4552.499225085238, 4574.268117101248, 4586.701864378805, 4592.10453961481, 4595.770211489412, 3797.6771974381936, 3873.6320049595242, 4149.502059752788, 4181.665466762652, 4272.145570885836, 3512.1746389598425, 3517.82410879455, 3547.75165738401, 3571.499990001402, 3574.5174401455993, 1162.6686394377562, 1170.239344426113, 1201.8617858946159, 1205.6322821539516, 1209.7217639942687, 1237.6101528018646, 1247.7379750252367, 1252.9373531323579, 1268.835051443325, 1270.1299609767154, 6950.235474097845, 7018.75434359795, 7034.5427547209265, 7042.929570704227, 7046.436285097282, 466.6523440037194, 467.3200493282266, 477.93308936748883, 484.80365451992, 485.1824675421925, 5261.0, 5262.868428289324, 5301.814436494704, 5302.310699609026, 5310.8141215057285, 8789.69236076747, 8933.46399216049, 9096.8635470468, 9098.135677110664, 9224.446533208029, 8947.552622368856, 8968.730938071869, 9037.322200834964, 9060.456372617664, 9103.180713735796, 6909.032735417046, 7151.89272160918, 7170.0, 7170.677319520634, 7186.604736739425, 6640.83397915056, 6682.69927853238, 6705.597664140168, 6715.261321254756, 6716.865662686621, 7832.255935686101, 8132.227438393344, 8137.837243254983, 8256.215659512336, 8271.710490132817, 8180.877286840821, 8356.164383561596, 8398.454100483448, 8459.95770021146, 8476.27951624119, 5909.674967876808, 6230.719617617127, 6441.613503189824, 6605.339466053356, 6639.867202655823, 7095.574265544084, 7123.643817809192, 7127.8574428512175, 7158.3915367192285, 7173.067501225016, 6524.412802847766, 6695.933040669531, 6704.229013663491, 6786.253512113763, 6865.347791959756, 6365.427111559797, 6401.423871851555, 6582.934170658232, 6670.866582668416, 6693.966530167318, 6774.8645027100165, 6797.864042719019, 6804.727810887509, 6806.455483561403, 6810.8637827244165, 5908.734106965111, 6193.752249910133, 6206.937930620817, 6207.81376558704, 6219.440250377488, 6029.246344206974, 6052.0, 6072.05883088122, 6074.0, 6075.27096748393], "unit": "score", "name": "mootools.html", "value": 4271.155641041407}, {"lowerIsBetter": false, "replicates": [339.8912348048624, 343.7250199840129, 347.4666387095808, 348.6809569244141, 350.3798277049624, 5745.0, 5799.217105690731, 5821.476067153955, 5849.09339052447, 5853.5902486825935, 5670.4896559309655, 5844.2402487676645, 5846.327672317685, 5849.064149736043, 5867.589268751189, 4550.612063320686, 4580.725156490605, 4584.793684284207, 4589.082183563284, 4590.059037897223, 4361.869143925687, 4423.800928958204, 4501.437320334958, 4575.290829921368, 4630.236011058171, 4569.109023740372, 4570.360149579062, 4571.4971353151295, 4577.015941572561, 4596.4254468191475, 4566.40636717228, 4567.38340324057, 4570.291604801245, 4579.748113853737, 4591.977040114812, 4058.228936502055, 4064.7357921734992, 4069.267531844267, 4074.8370065197355, 4075.735077219971, 5514.889702205934, 5642.746076426571, 5659.886802263932, 5670.68811215383, 5673.631213971079, 5275.630705850592, 5278.049951008817, 5279.208118782175, 5280.9207861882105, 5286.524212820865, 5832.650040997553, 6264.6241225526155, 6265.248170219557, 6278.591891527036, 6279.49764018882, 4226.661867050629, 4273.957260427387, 4394.956050439487, 4396.384506169139, 4397.098594788093, 6466.805995820133, 6521.11964884744, 6545.0, 6547.410733034098, 6564.0, 4482.551744825491, 4487.910241795146, 4489.034857505652, 4493.0339976905125, 4495.730256184639, 4467.15124126415, 4543.5002149763495, 4548.840790572314, 4563.133004729091, 4578.862634120982, 5251.658642188322, 5256.2115682647145, 5256.710880901511, 5260.395054568774, 5268.315119034578, 6280.623162610258, 6302.180716506917, 6319.368063193644, 6321.778737744157, 6335.049742538564, 1588.237645929937, 1608.4852847089053, 1610.4443966831425, 1610.5329454458076, 1611.2668735725217, 1072.983905241422, 1082.4749996251812, 1088.1077516436446, 1098.0337303173158, 1116.385987706758, 5910.763569457259, 5913.0, 5915.940840591625, 5922.466977972003, 5922.49658779, 6430.549861509649, 6445.291017988017, 6453.838654033687, 6477.060826180177, 6484.870302593922, 5897.997340452133, 5900.586958912835, 5906.025505791582, 5914.053751399755, 5917.792877249276, 3411.2665776858094, 3484.8083355415697, 3485.7385696072897, 3489.0405138586584, 3491.301739652029, 6700.698468568926, 6722.731090756315, 6772.051912732221, 6782.152230971129, 6784.457243420515, 6653.367930046637, 6673.866522669519, 6676.098726671934, 6677.1319728435965, 6679.398854103057, 6553.737850485927, 6746.797596072126, 6751.628660423724, 6756.966215168893, 6810.148731408574, 6217.906731399123, 6348.0, 6522.021696745336, 6525.412712855866, 6532.608043517404, 6285.685715714105, 6365.649889256136, 6446.967765161145, 6451.645159516272, 6474.5791523550815, 6661.933380666132, 6691.130153080068, 6710.4631629470505, 6763.7632682855865, 6776.796696099125, 4345.261305578122, 4471.552844715502, 4502.977485112553, 4513.1650644630845, 4515.961328894438, 6388.137601423934, 6397.936020639921, 6401.295857455583, 6451.612903225821, 6466.4503517201565, 6321.96839015802, 6326.3041065483685, 6331.493480521455, 6332.683365831782, 6348.365163483615, 6211.3478084800445, 6286.497080233662, 6325.746970121328, 6334.3665633436285, 6334.968325158345, 6066.4540191382985, 6085.0, 6085.726142323695, 6089.086637004485, 6090.604110732788, 6339.207599050119, 6347.39699728525, 6353.332900045429, 6356.491480681442, 6357.4596159326975, 6036.486898613667, 6140.0, 6153.600015998945, 6155.446009859134, 6168.691565421801], "unit": "score", "name": "prototype.html", "value": 4748.279575260935}, {"lowerIsBetter": false, "replicates": [696.6656005117543, 709.3509438863437, 726.7674344209852, 727.0947670150663, 753.5403403923606, 15335.23323833808, 15441.305141268642, 15515.534533963972, 15521.223938803058, 15532.301046452909, 14616.853831461682, 14717.705645887076, 14719.92640036801, 14733.189674567895, 14763.0, 669.9296573859748, 675.7398401615388, 795.1333046978777, 796.0884786919004, 807.9555624440653, 795.6061749434009, 799.8440304140695, 800.339719731224, 805.7864665863551, 806.4757907360204, 818.1981657975158, 823.9823817585308, 825.8100636853497, 826.5990994367727, 827.0530242871909, 689.0972825598482, 696.7561353526276, 826.5619221812449, 837.9874301885477, 838.8699751538521, 620.10394979255, 620.4416025576971, 620.695859029077, 620.9565330426872, 621.1521273461692, 13941.0, 14066.507672231524, 14079.577612671636, 14099.436022559188, 14101.435942562286, 11871.347075910822, 12063.819042714365, 12111.201489074012, 12145.696357591043, 12184.756304873941, 9947.801043979152, 10045.899541004643, 10117.190624750003, 10143.442110683909, 10921.399323037309, 3551.9112022199392, 3645.5989841117457, 3662.34077865984, 3701.167237371597, 3707.2214834884708, 46273.305900411186, 46833.29750053752, 46885.53114468846, 46919.5308046922, 46954.530454695356, 9683.080107389927, 9918.206543476505, 10151.898481015096, 10310.432926188982, 10331.070203681706, 17663.55841103957, 17720.734188987175, 17787.0, 17801.910990445223, 17852.01813900248, 7363.337299643058, 7416.22129676387, 7703.537787732754, 7736.226377362332, 7738.071431428265, 4250.553691862372, 4262.66995985807, 4279.529251782302, 4307.440032795716, 4386.0789234261165, 3063.6629970703207, 3097.7212050915527, 3102.053873568538, 3105.9223519412194, 3108.5026395776567, 558.6731761919242, 562.5471495446205, 570.6319423971515, 585.6047168161474, 592.6414519215898, 511.48340176422084, 516.8139469790872, 540.3488796000888, 657.9769708060195, 697.7614733847462, 7634.122075961224, 7773.5724535149975, 8018.358531317481, 8064.233897779702, 8100.513969161869, 516.5299577384562, 546.5818648733722, 575.5395683453221, 586.5747333183408, 625.3558834400575, 3710.979480642845, 3804.3152232597845, 3889.86385476507, 3922.529296484383, 4031.657309128698, 50881.23678144831, 50989.49010509848, 51176.0, 51446.0, 51520.0, 48681.02637947221, 48805.75597122063, 49222.261666075035, 49266.0, 50021.749891250314, 43582.56417435785, 44221.55778442239, 44482.55517444849, 45558.772206138754, 46305.536944630796, 8484.957575212084, 8489.235968762594, 8519.403641745019, 8534.274586659954, 8711.869321960303, 34573.0, 35016.0, 35927.28145437129, 36927.81536092302, 37303.0, 42150.36774448447, 42680.14639707251, 42702.0, 42809.0, 43492.34761478517, 10079.445630490394, 10139.106631827797, 10810.51352689115, 10917.890821091687, 11117.83323250168, 10346.750582564951, 10501.474926253504, 10677.893221068001, 10843.078338341014, 10986.835197472205, 10541.736456588647, 10658.840117398091, 10867.239293249713, 10986.285891417032, 11009.119270458184, 11020.118390528898, 11268.83096753533, 11271.323720576791, 11536.365499897585, 11932.64934470423, 10745.946270268598, 10822.350658960488, 10917.072048875934, 11484.712882178012, 11604.0, 9502.762430939281, 9530.618775248913, 9814.0, 9980.800383992424, 10069.647562335284, 8466.619002145042, 8766.386352955487, 8775.473471591726, 9435.811283774148, 9662.75843103928], "unit": "score", "name": "yui.html", "value": 6152.247452674284}], "name": "dromaeo_css", "value": 6904.695041548281}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 109.0, 102.0, 109.0, 111.0, 109.0, 100.0, 109.0, 108.0, 110.0], "unit": "score", "name": "ai-astar", "value": 107.7}, {"lowerIsBetter": true, "replicates": [151.0, 127.0, 149.0, 164.0, 127.0, 161.0, 151.0, 134.0, 164.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 146.3}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 160.0, 160.0, 160.0, 161.0, 160.0, 162.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 87.0, 92.0, 71.0, 71.0, 72.0, 106.0, 92.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 137.0, 95.0, 96.0, 96.0, 139.0, 95.0, 96.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 108.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 108.0, 109.0, 110.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 97.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 58.0, 56.0, 56.0, 57.0, 56.0, 58.0, 58.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 68.0, 69.0, 69.0, 67.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [83.0, 87.0, 86.0, 85.0, 93.0, 85.0, 86.0, 87.0, 88.0, 100.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.0}, {"lowerIsBetter": true, "replicates": [120.0, 127.0, 119.0, 132.0, 116.0, 116.0, 116.0, 124.0, 125.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.2}, {"lowerIsBetter": true, "replicates": [156.0, 145.0, 150.0, 152.0, 149.0, 142.0, 152.0, 154.0, 149.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.5}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 68.0, 70.0, 69.0, 69.0, 70.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1506.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.16816218012627], "unit": "score", "name": "Richards", "value": 212.4474360000001}, {"lowerIsBetter": false, "replicates": [191.16803670426305], "unit": "score", "name": "DeltaBlue", "value": 345.8632580000001}, {"lowerIsBetter": false, "replicates": [281.29395218002816], "unit": "score", "name": "Encrypt", "value": 946.2734550000002}, {"lowerIsBetter": false, "replicates": [5235.602094240838], "unit": "score", "name": "Decrypt", "value": 50.84057100000005}, {"lowerIsBetter": false, "replicates": [1103.7527593818984], "unit": "score", "name": "RayTrace", "value": 670.4300340000001}, {"lowerIsBetter": false, "replicates": [794.912559618442], "unit": "score", "name": "Earley", "value": 838.4104539999996}, {"lowerIsBetter": false, "replicates": [12530.864197530864], "unit": "score", "name": "Boyer", "value": 53.185717241379315}, {"lowerIsBetter": false, "replicates": [26421.052631578947], "unit": "score", "name": "RegExp", "value": 34.47951195219122}, {"lowerIsBetter": false, "replicates": [593.1198102016607], "unit": "score", "name": "Splay", "value": 137.39382600000002}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20915.34106261989}]} 08:16:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20915.34"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1506.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6904.70"}}} 08:16:44 INFO - Return code: 0 08:16:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:16:44 INFO - # TBPL SUCCESS # 08:16:44 INFO - Running post-action listener: _resource_record_post_action 08:16:44 INFO - Running post-run listener: _resource_record_post_run 08:16:45 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 547221504; Read time: 0; Write time: 506676 08:16:45 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 238628864; Read time: 0; Write time: 291964 08:16:45 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 308592640; Read time: 0; Write time: 214712 08:16:45 INFO - Running post-run listener: _upload_blobber_files 08:16:45 INFO - Blob upload gear active. 08:16:45 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:16:45 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:16:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 08:16:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 08:16:46 INFO - (blobuploader) - INFO - Open directory for files ... 08:16:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:16:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:16:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:16:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:16:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:16:47 INFO - (blobuploader) - INFO - Done attempting. 08:16:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:16:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:16:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:16:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:16:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:16:48 INFO - (blobuploader) - INFO - Done attempting. 08:16:48 INFO - (blobuploader) - INFO - Iteration through files over. 08:16:48 INFO - Return code: 0 08:16:48 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:16:48 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:16:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6979d1becc3d001db180abd9caa8aa2acb208759a48d083bf24991eeb9014ee40b6c2a27aef8ce8a038387ab47f3db4815d6c4ad1785b5e19b370578347a1651", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e32a4c149b75ec5d4b8b56a1db1d7a4cdad27c6411660e080aad0f6522106dfec6d18e74d910228424ca45fcb454a8bc015a20dcee032cc713cce651dc59dfef"} 08:16:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:16:48 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:16:48 INFO - Contents: 08:16:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6979d1becc3d001db180abd9caa8aa2acb208759a48d083bf24991eeb9014ee40b6c2a27aef8ce8a038387ab47f3db4815d6c4ad1785b5e19b370578347a1651", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e32a4c149b75ec5d4b8b56a1db1d7a4cdad27c6411660e080aad0f6522106dfec6d18e74d910228424ca45fcb454a8bc015a20dcee032cc713cce651dc59dfef"} 08:16:48 INFO - Copying logs to upload dir... 08:16:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1277.531570 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-05 08:16:48.327944) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 08:16:48.331721) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1452007357.472743-1028703830 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/6979d1becc3d001db180abd9caa8aa2acb208759a48d083bf24991eeb9014ee40b6c2a27aef8ce8a038387ab47f3db4815d6c4ad1785b5e19b370578347a1651", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e32a4c149b75ec5d4b8b56a1db1d7a4cdad27c6411660e080aad0f6522106dfec6d18e74d910228424ca45fcb454a8bc015a20dcee032cc713cce651dc59dfef"} build_url:https://queue.taskcluster.net/v1/task/djpLSnQuQZmtbnNcSyESGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011507 build_url: 'https://queue.taskcluster.net/v1/task/djpLSnQuQZmtbnNcSyESGw/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/6979d1becc3d001db180abd9caa8aa2acb208759a48d083bf24991eeb9014ee40b6c2a27aef8ce8a038387ab47f3db4815d6c4ad1785b5e19b370578347a1651", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e32a4c149b75ec5d4b8b56a1db1d7a4cdad27c6411660e080aad0f6522106dfec6d18e74d910228424ca45fcb454a8bc015a20dcee032cc713cce651dc59dfef"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 08:16:48.356775) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 08:16:48.357117) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1452007357.472743-1028703830 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004588 ========= master_lag: 0.15 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 08:16:48.507741) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 08:16:48.508042) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 08:16:48.508346) ========= ========= Total master_lag: 0.33 =========