builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-039 starttime: 1452117863.63 results: success (0) buildid: 20160106113008 builduid: 020a9163bc894e9fbe17de485b53fa3d revision: 5a6b63cd300eb05f28b54e4f5266406a29e13b7a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 14:04:23.629032) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 14:04:23.629586) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 14:04:23.629924) ========= 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=5bd038846534b2fdfa68eeae000001e2-1452117863.174334-484082236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006171 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 14:04:23.652611) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 14:04:23.652919) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 14:04:23.675364) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 14:04:23.675669) ========= 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=5bd038846534b2fdfa68eeae000001e2-1452117863.174334-484082236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022027 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 14:04:23.723431) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 14:04:23.723728) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 14:04:23.724140) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 14:04:23.724461) ========= 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=5bd038846534b2fdfa68eeae000001e2-1452117863.174334-484082236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-06 14:04:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 83.5M=0s 2016-01-06 14:04:24 (83.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150842 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 14:04:23.892097) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 14:04:23.892853) ========= 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=5bd038846534b2fdfa68eeae000001e2-1452117863.174334-484082236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.043919 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 14:04:23.953348) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-06 14:04:23.954168) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5a6b63cd300eb05f28b54e4f5266406a29e13b7a --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 5a6b63cd300eb05f28b54e4f5266406a29e13b7a --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=5bd038846534b2fdfa68eeae000001e2-1452117863.174334-484082236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-06 14:04:24,277 truncating revision to first 12 chars 2016-01-06 14:04:24,277 Setting DEBUG logging. 2016-01-06 14:04:24,277 attempt 1/10 2016-01-06 14:04:24,278 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5a6b63cd300e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-06 14:04:25,447 unpacking tar archive at: fx-team-5a6b63cd300e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.462083 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-06 14:04:25.431202) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 14:04:25.431578) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 14:04:25.440557) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 14:04:25.440860) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 14:04:25.441312) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-01-06 14:04:25.441640) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1452117863.174334-484082236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:04:25 INFO - MultiFileLogger online at 20160106 14:04:25 in /builds/slave/test-pgo 14:04:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:04:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:04:25 INFO - {'append_to_log': False, 14:04:25 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:04:25 INFO - 'blob_upload_branch': 'Fx-Team', 14:04:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:04:25 INFO - 'branch': 'Fx-Team', 14:04:25 INFO - 'buildbot_json_path': 'buildprops.json', 14:04:25 INFO - 'config_files': ('talos/linux_config.py',), 14:04:25 INFO - 'default_actions': ('clobber', 14:04:25 INFO - 'read-buildbot-config', 14:04:25 INFO - 'download-and-extract', 14:04:25 INFO - 'populate-webroot', 14:04:25 INFO - 'create-virtualenv', 14:04:25 INFO - 'install', 14:04:25 INFO - 'run-tests'), 14:04:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:04:25 INFO - 'download_minidump_stackwalk': True, 14:04:25 INFO - 'download_symbols': 'ondemand', 14:04:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:04:25 INFO - 'tooltool.py': '/tools/tooltool.py', 14:04:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:04:25 INFO - '/tools/misc-python/virtualenv.py')}, 14:04:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:04:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:04:25 INFO - 'installer_path': 'installer.exe', 14:04:25 INFO - 'log_level': 'info', 14:04:25 INFO - 'log_name': 'talos', 14:04:25 INFO - 'log_to_console': True, 14:04:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:04:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:04:25 INFO - 'opt_config_files': (), 14:04:25 INFO - 'pip_index': False, 14:04:25 INFO - 'sps_profile': False, 14:04:25 INFO - 'sps_profile_interval': 0, 14:04:25 INFO - 'suite': 'dromaeojs-e10s', 14:04:25 INFO - 'system_bits': '32', 14:04:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:04:25 INFO - 'title': 'talos-linux64-ix-039', 14:04:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:04:25 INFO - 'use_talos_json': True, 14:04:25 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:04:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:04:25 INFO - 'work_dir': 'build'} 14:04:25 INFO - ##### 14:04:25 INFO - ##### Running clobber step. 14:04:25 INFO - ##### 14:04:25 INFO - Running pre-action listener: _resource_record_pre_action 14:04:25 INFO - Running main action method: clobber 14:04:25 INFO - rmtree: /builds/slave/test-pgo/build 14:04:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:04:27 INFO - Running post-action listener: _resource_record_post_action 14:04:27 INFO - ##### 14:04:27 INFO - ##### Running read-buildbot-config step. 14:04:27 INFO - ##### 14:04:27 INFO - Running pre-action listener: _resource_record_pre_action 14:04:27 INFO - Running main action method: read_buildbot_config 14:04:27 INFO - Using buildbot properties: 14:04:27 INFO - { 14:04:27 INFO - "project": "", 14:04:27 INFO - "product": "firefox", 14:04:27 INFO - "script_repo_revision": "production", 14:04:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:04:27 INFO - "repository": "", 14:04:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:04:27 INFO - "buildid": "20160106113008", 14:04:27 INFO - "pgo_build": "True", 14:04:27 INFO - "basedir": "/builds/slave/test-pgo", 14:04:27 INFO - "buildnumber": 185, 14:04:27 INFO - "slavename": "talos-linux64-ix-039", 14:04:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:04:27 INFO - "platform": "ubuntu64_hw", 14:04:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:04:27 INFO - "branch": "fx-team", 14:04:27 INFO - "repo_path": "integration/fx-team", 14:04:27 INFO - "revision": "5a6b63cd300eb05f28b54e4f5266406a29e13b7a", 14:04:27 INFO - "stage_platform": "linux64-pgo", 14:04:27 INFO - "builduid": "020a9163bc894e9fbe17de485b53fa3d", 14:04:27 INFO - "slavebuilddir": "test" 14:04:27 INFO - } 14:04:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 14:04:27 INFO - Running post-action listener: _resource_record_post_action 14:04:27 INFO - ##### 14:04:27 INFO - ##### Running download-and-extract step. 14:04:27 INFO - ##### 14:04:27 INFO - Running pre-action listener: _resource_record_pre_action 14:04:27 INFO - Running main action method: download_and_extract 14:04:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:04:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:27 INFO - https://queue.taskcluster.net/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:04:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/test_packages.json 14:04:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/test_packages.json 14:04:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:04:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:04:27 INFO - Downloaded 1302 bytes. 14:04:27 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:04:27 INFO - Using the following test package requirements: 14:04:27 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:04:27 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:04:27 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:27 INFO - u'jsshell-linux-x86_64.zip'], 14:04:27 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:04:27 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:04:27 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:04:27 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:04:27 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:04:27 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:04:27 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:04:27 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:04:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:27 INFO - https://queue.taskcluster.net/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:04:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:04:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:04:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/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 14:04:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/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 14:04:28 INFO - Downloaded 24101983 bytes. 14:04:28 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 14:04:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:04:28 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 14:04:29 INFO - Return code: 0 14:04:29 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 14:04:29 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')]} 14:04:29 INFO - https://queue.taskcluster.net/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:04:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:04:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:04:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/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 14:04:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/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 14:04:31 INFO - Downloaded 24101983 bytes. 14:04:31 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 14:04:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:04:31 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 14:04:32 INFO - Return code: 0 14:04: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')]} 14:04:32 INFO - https://queue.taskcluster.net/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:04:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:04:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:04:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/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 14:04:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/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 14:04:33 INFO - Downloaded 11132285 bytes. 14:04:33 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 14:04:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:04:33 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 14:04:33 INFO - Return code: 0 14:04:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:33 INFO - https://queue.taskcluster.net/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:04:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:04:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:04:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/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 14:04:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XyuEttQdQ4WZvqepU4Slzg/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 14:04:35 INFO - Downloaded 55045913 bytes. 14:04:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:04:35 INFO - mkdir: /builds/slave/test-pgo/properties 14:04:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:04:35 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:04:35 INFO - Contents: 14:04:35 INFO - build_url:https://queue.taskcluster.net/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:04:35 INFO - Running post-action listener: _resource_record_post_action 14:04:35 INFO - Running post-action listener: set_extra_try_arguments 14:04:35 INFO - ##### 14:04:35 INFO - ##### Running populate-webroot step. 14:04:35 INFO - ##### 14:04:35 INFO - Running pre-action listener: _resource_record_pre_action 14:04:35 INFO - Running main action method: populate_webroot 14:04:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:04:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:04:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:04:35 INFO - '--tppagecycles', 14:04:35 INFO - '7'], 14:04:35 INFO - 'tests': ['tsvgm']}}, 14:04:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:04:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:04:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:04:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:04:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:04:35 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:04:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:04:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:35 INFO - 'talos_options': ['--e10s'], 14:04:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:04:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:35 INFO - 'tests': ['damp', 'tps']}, 14:04:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:35 INFO - 'talos_options': ['--e10s'], 14:04:35 INFO - 'tests': ['damp', 'tps']}, 14:04:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:04:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:04:35 INFO - 'other': {'tests': ['a11yr', 14:04:35 INFO - 'ts_paint', 14:04:35 INFO - 'tpaint', 14:04:35 INFO - 'sessionrestore', 14:04:35 INFO - 'sessionrestore_no_auto_restore']}, 14:04:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:04:35 INFO - 'tests': ['a11yr', 14:04:35 INFO - 'ts_paint', 14:04:35 INFO - 'tpaint', 14:04:35 INFO - 'sessionrestore', 14:04:35 INFO - 'sessionrestore_no_auto_restore']}, 14:04:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:04:35 INFO - 'tests': ['a11yr', 14:04:35 INFO - 'ts_paint', 14:04:35 INFO - 'tpaint', 14:04:35 INFO - 'sessionrestore', 14:04:35 INFO - 'sessionrestore_no_auto_restore']}, 14:04:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:04:35 INFO - 'tests': ['a11yr', 14:04:35 INFO - 'ts_paint', 14:04:35 INFO - 'tpaint', 14:04:35 INFO - 'sessionrestore', 14:04:35 INFO - 'sessionrestore_no_auto_restore']}, 14:04:35 INFO - 'other_l64': {'tests': ['a11yr', 14:04:35 INFO - 'ts_paint', 14:04:35 INFO - 'tpaint', 14:04:35 INFO - 'sessionrestore', 14:04:35 INFO - 'sessionrestore_no_auto_restore']}, 14:04:35 INFO - 'other_nol64': {'tests': ['a11yr', 14:04:35 INFO - 'ts_paint', 14:04:35 INFO - 'tpaint', 14:04:35 INFO - 'sessionrestore', 14:04:35 INFO - 'sessionrestore_no_auto_restore']}, 14:04:35 INFO - 'svgr': {'tests': ['tsvgx', 14:04:35 INFO - 'tsvgr_opacity', 14:04:35 INFO - 'tart', 14:04:35 INFO - 'tscrollx', 14:04:35 INFO - 'cart']}, 14:04:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:04:35 INFO - 'tests': ['tsvgx', 14:04:35 INFO - 'tsvgr_opacity', 14:04:35 INFO - 'tart', 14:04:35 INFO - 'tscrollx', 14:04:35 INFO - 'cart']}, 14:04:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:35 INFO - 'tests': ['tp5o']}, 14:04:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:35 INFO - 'talos_options': ['--e10s'], 14:04:35 INFO - 'tests': ['tp5o']}, 14:04:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:35 INFO - 'talos_options': ['--xperf_path', 14:04:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:04:35 INFO - 'tests': ['tp5n']}, 14:04:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:35 INFO - 'talos_options': ['--e10s', 14:04:35 INFO - '--xperf_path', 14:04:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:04:35 INFO - 'tests': ['tp5n']}}, 14:04:35 INFO - 'talos.zip': {'path': '', 14:04:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:04:35 INFO - Running post-action listener: _resource_record_post_action 14:04:35 INFO - ##### 14:04:35 INFO - ##### Running create-virtualenv step. 14:04:35 INFO - ##### 14:04:35 INFO - Running pre-action listener: _resource_record_pre_action 14:04:35 INFO - Running main action method: create_virtualenv 14:04:35 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:04:35 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 14:04:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:04:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:04:35 INFO - Using real prefix '/usr' 14:04:35 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:04:35 INFO - Installing distribute.............................................................................................................................................................................................done. 14:04:37 INFO - Installing pip.................done. 14:04:37 INFO - Return code: 0 14:04:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:04: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')]} 14:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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')]} 14:04:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:37 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 0x7f53d17f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b13f0>, '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 0x2143560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2143a10>, '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': '5bd038846534b2fdfa68eeae000001e2-1452117863.174334-484082236', '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 14:04:37 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 14:04:37 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 14:04:37 INFO - Using env: {'DISPLAY': ':0', 14:04:37 INFO - 'HOME': '/home/cltbld', 14:04:37 INFO - 'LANG': 'en_US.UTF-8', 14:04:37 INFO - 'LANGUAGE': 'en_US:en', 14:04:37 INFO - 'LOGNAME': 'cltbld', 14:04:37 INFO - 'MAIL': '/var/mail/cltbld', 14:04:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:37 INFO - 'MOZ_NO_REMOTE': '1', 14:04:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:37 INFO - 'NO_EM_RESTART': '1', 14:04:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:04:37 INFO - 'PWD': '/builds/slave/test-pgo', 14:04:37 INFO - 'SHELL': '/bin/bash', 14:04:37 INFO - 'SHLVL': '1', 14:04:37 INFO - 'TERM': 'linux', 14:04:37 INFO - 'TMOUT': '86400', 14:04:37 INFO - 'USER': 'cltbld', 14:04:37 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452117863.174334-484082236', 14:04:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:37 INFO - '_': '/tools/buildbot/bin/python'} 14:04:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:38 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 14:04:38 INFO - Cleaning up... 14:04:38 INFO - Return code: 0 14:04:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:04:38 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')]} 14:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:38 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')]} 14:04:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:38 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 0x7f53d17f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b13f0>, '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 0x2143560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2143a10>, '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': '5bd038846534b2fdfa68eeae000001e2-1452117863.174334-484082236', '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 14:04:38 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 14:04:38 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 14:04:38 INFO - Using env: {'DISPLAY': ':0', 14:04:38 INFO - 'HOME': '/home/cltbld', 14:04:38 INFO - 'LANG': 'en_US.UTF-8', 14:04:38 INFO - 'LANGUAGE': 'en_US:en', 14:04:38 INFO - 'LOGNAME': 'cltbld', 14:04:38 INFO - 'MAIL': '/var/mail/cltbld', 14:04:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:38 INFO - 'MOZ_NO_REMOTE': '1', 14:04:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:38 INFO - 'NO_EM_RESTART': '1', 14:04:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:04:38 INFO - 'PWD': '/builds/slave/test-pgo', 14:04:38 INFO - 'SHELL': '/bin/bash', 14:04:38 INFO - 'SHLVL': '1', 14:04:38 INFO - 'TERM': 'linux', 14:04:38 INFO - 'TMOUT': '86400', 14:04:38 INFO - 'USER': 'cltbld', 14:04:38 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452117863.174334-484082236', 14:04:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:38 INFO - '_': '/tools/buildbot/bin/python'} 14:04:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:38 INFO - Downloading/unpacking psutil>=0.7.1 14:04:38 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 14:04:38 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 14:04:38 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 14:04:38 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 14:04:38 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 14:04:38 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 14:04:40 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 14:04:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:04:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:04:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:04:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:04:40 INFO - Installing collected packages: psutil 14:04:40 INFO - Running setup.py install for psutil 14:04:40 INFO - building 'psutil._psutil_linux' extension 14:04:40 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 14:04:40 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 14:04:40 INFO - building 'psutil._psutil_posix' extension 14:04:40 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 14:04:40 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 14:04:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:04:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:04:40 INFO - Successfully installed psutil 14:04:40 INFO - Cleaning up... 14:04:40 INFO - Return code: 0 14:04:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:04: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')]} 14:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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')]} 14:04:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:40 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 0x7f53d17f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b13f0>, '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 0x2143560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2143a10>, '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': '5bd038846534b2fdfa68eeae000001e2-1452117863.174334-484082236', '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 14:04:40 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 14:04:40 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 14:04:40 INFO - Using env: {'DISPLAY': ':0', 14:04:40 INFO - 'HOME': '/home/cltbld', 14:04:40 INFO - 'LANG': 'en_US.UTF-8', 14:04:40 INFO - 'LANGUAGE': 'en_US:en', 14:04:40 INFO - 'LOGNAME': 'cltbld', 14:04:40 INFO - 'MAIL': '/var/mail/cltbld', 14:04:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:40 INFO - 'MOZ_NO_REMOTE': '1', 14:04:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:40 INFO - 'NO_EM_RESTART': '1', 14:04:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:04:40 INFO - 'PWD': '/builds/slave/test-pgo', 14:04:40 INFO - 'SHELL': '/bin/bash', 14:04:40 INFO - 'SHLVL': '1', 14:04:40 INFO - 'TERM': 'linux', 14:04:40 INFO - 'TMOUT': '86400', 14:04:40 INFO - 'USER': 'cltbld', 14:04:40 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452117863.174334-484082236', 14:04:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:40 INFO - '_': '/tools/buildbot/bin/python'} 14:04:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:04:40 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 14:04:40 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 14:04:40 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 14:04:40 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 14:04:40 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 14:04:40 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 14:04:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:04:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:04:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:04:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:04:42 INFO - Installing collected packages: mozsystemmonitor 14:04:42 INFO - Running setup.py install for mozsystemmonitor 14:04:42 INFO - Successfully installed mozsystemmonitor 14:04:42 INFO - Cleaning up... 14:04:42 INFO - Return code: 0 14:04:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:42 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 0x7f53d17f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b13f0>, '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 0x2143560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2143a10>, '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': '5bd038846534b2fdfa68eeae000001e2-1452117863.174334-484082236', '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 14:04:42 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 14:04:42 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 14:04:42 INFO - Using env: {'DISPLAY': ':0', 14:04:42 INFO - 'HOME': '/home/cltbld', 14:04:42 INFO - 'LANG': 'en_US.UTF-8', 14:04:42 INFO - 'LANGUAGE': 'en_US:en', 14:04:42 INFO - 'LOGNAME': 'cltbld', 14:04:42 INFO - 'MAIL': '/var/mail/cltbld', 14:04:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:42 INFO - 'MOZ_NO_REMOTE': '1', 14:04:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:42 INFO - 'NO_EM_RESTART': '1', 14:04:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:04:42 INFO - 'PWD': '/builds/slave/test-pgo', 14:04:42 INFO - 'SHELL': '/bin/bash', 14:04:42 INFO - 'SHLVL': '1', 14:04:42 INFO - 'TERM': 'linux', 14:04:42 INFO - 'TMOUT': '86400', 14:04:42 INFO - 'USER': 'cltbld', 14:04:42 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452117863.174334-484082236', 14:04:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:42 INFO - '_': '/tools/buildbot/bin/python'} 14:04:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:43 INFO - Downloading/unpacking blobuploader==1.2.4 14:04:43 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 14:04:43 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 14:04:43 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 14:04:43 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 14:04:43 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 14:04:43 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 14:04:44 INFO - Downloading blobuploader-1.2.4.tar.gz 14:04:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:04:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:04:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:04:44 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 14:04:44 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 14:04:44 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 14:04:44 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 14:04:44 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 14:04:44 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 14:04:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:04:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:04:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:04:45 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 14:04:45 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 14:04:45 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 14:04:45 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 14:04:45 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 14:04:45 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 14:04:45 INFO - Downloading docopt-0.6.1.tar.gz 14:04:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:04:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:04:45 INFO - Installing collected packages: blobuploader, requests, docopt 14:04:45 INFO - Running setup.py install for blobuploader 14:04:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:04:45 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:04:45 INFO - Running setup.py install for requests 14:04:45 INFO - Running setup.py install for docopt 14:04:46 INFO - Successfully installed blobuploader requests docopt 14:04:46 INFO - Cleaning up... 14:04:46 INFO - Return code: 0 14:04:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:04:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:46 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 0x7f53d17f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b13f0>, '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 0x2143560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2143a10>, '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': '5bd038846534b2fdfa68eeae000001e2-1452117863.174334-484082236', '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 14:04:46 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 14:04:46 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 14:04:46 INFO - Using env: {'DISPLAY': ':0', 14:04:46 INFO - 'HOME': '/home/cltbld', 14:04:46 INFO - 'LANG': 'en_US.UTF-8', 14:04:46 INFO - 'LANGUAGE': 'en_US:en', 14:04:46 INFO - 'LOGNAME': 'cltbld', 14:04:46 INFO - 'MAIL': '/var/mail/cltbld', 14:04:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:46 INFO - 'MOZ_NO_REMOTE': '1', 14:04:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:46 INFO - 'NO_EM_RESTART': '1', 14:04:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:04:46 INFO - 'PWD': '/builds/slave/test-pgo', 14:04:46 INFO - 'SHELL': '/bin/bash', 14:04:46 INFO - 'SHLVL': '1', 14:04:46 INFO - 'TERM': 'linux', 14:04:46 INFO - 'TMOUT': '86400', 14:04:46 INFO - 'USER': 'cltbld', 14:04:46 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452117863.174334-484082236', 14:04:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:46 INFO - '_': '/tools/buildbot/bin/python'} 14:04:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:04:46 INFO - Running setup.py (path:/tmp/pip-3XaFeu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:04:46 INFO - Running setup.py (path:/tmp/pip-how4Rd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:04:46 INFO - Running setup.py (path:/tmp/pip-yq49IG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:04:46 INFO - Running setup.py (path:/tmp/pip-Vo3Ahs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:04:46 INFO - Running setup.py (path:/tmp/pip-DalJUb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:04:46 INFO - Running setup.py (path:/tmp/pip-KH4ajs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:04:46 INFO - Running setup.py (path:/tmp/pip-6zTN__-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:04:46 INFO - Running setup.py (path:/tmp/pip-QXPiNw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:04:46 INFO - Running setup.py (path:/tmp/pip-bM1i5f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:04:46 INFO - Running setup.py (path:/tmp/pip-NtwzZY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:04:47 INFO - Running setup.py (path:/tmp/pip-TzeUDW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:04:47 INFO - Running setup.py (path:/tmp/pip-cGVbMu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:04:47 INFO - Running setup.py (path:/tmp/pip-e9bE_1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:04:47 INFO - Running setup.py (path:/tmp/pip-iv5YhY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:04:47 INFO - Running setup.py (path:/tmp/pip-RLWSvz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:04:47 INFO - Running setup.py (path:/tmp/pip-MWajg1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:04:47 INFO - Running setup.py (path:/tmp/pip-dZVcEX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:04:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:04:47 INFO - Running setup.py install for manifestparser 14:04:47 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:04:47 INFO - Running setup.py install for mozcrash 14:04:47 INFO - Running setup.py install for mozdebug 14:04:47 INFO - Running setup.py install for mozdevice 14:04:47 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:04:47 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:04:47 INFO - Running setup.py install for mozfile 14:04:48 INFO - Running setup.py install for mozhttpd 14:04:48 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:04:48 INFO - Running setup.py install for mozinfo 14:04:48 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:04:48 INFO - Running setup.py install for mozInstall 14:04:48 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:04:48 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:04:48 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:04:48 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:04:48 INFO - Running setup.py install for mozleak 14:04:48 INFO - Running setup.py install for mozlog 14:04:48 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:04:48 INFO - Running setup.py install for moznetwork 14:04:48 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:04:48 INFO - Running setup.py install for mozprocess 14:04:48 INFO - Running setup.py install for mozprofile 14:04:48 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:04:48 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:04:48 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:04:48 INFO - Running setup.py install for mozrunner 14:04:48 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:04:48 INFO - Running setup.py install for mozscreenshot 14:04:49 INFO - Running setup.py install for moztest 14:04:49 INFO - Running setup.py install for mozversion 14:04:49 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:04:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:04:49 INFO - Cleaning up... 14:04:49 INFO - Return code: 0 14:04:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:04: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')]} 14:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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')]} 14:04:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:49 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 0x7f53d17f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b13f0>, '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 0x2143560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2143a10>, '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': '5bd038846534b2fdfa68eeae000001e2-1452117863.174334-484082236', '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 14:04:49 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 14:04:49 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 14:04:49 INFO - Using env: {'DISPLAY': ':0', 14:04:49 INFO - 'HOME': '/home/cltbld', 14:04:49 INFO - 'LANG': 'en_US.UTF-8', 14:04:49 INFO - 'LANGUAGE': 'en_US:en', 14:04:49 INFO - 'LOGNAME': 'cltbld', 14:04:49 INFO - 'MAIL': '/var/mail/cltbld', 14:04:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:49 INFO - 'MOZ_NO_REMOTE': '1', 14:04:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:49 INFO - 'NO_EM_RESTART': '1', 14:04:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:04:49 INFO - 'PWD': '/builds/slave/test-pgo', 14:04:49 INFO - 'SHELL': '/bin/bash', 14:04:49 INFO - 'SHLVL': '1', 14:04:49 INFO - 'TERM': 'linux', 14:04:49 INFO - 'TMOUT': '86400', 14:04:49 INFO - 'USER': 'cltbld', 14:04:49 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452117863.174334-484082236', 14:04:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:49 INFO - '_': '/tools/buildbot/bin/python'} 14:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:04:49 INFO - Running setup.py (path:/tmp/pip-CGEmWs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:04:49 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)) 14:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:04:49 INFO - Running setup.py (path:/tmp/pip-CMUyqH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:04:49 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)) 14:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:04:49 INFO - Running setup.py (path:/tmp/pip-rSTsUR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:04:49 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)) 14:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:04:49 INFO - Running setup.py (path:/tmp/pip-sxzUtn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:04:49 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)) 14:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:04:49 INFO - Running setup.py (path:/tmp/pip-lgeNK8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:04:49 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)) 14:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:04:49 INFO - Running setup.py (path:/tmp/pip-lBqJUr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:04:49 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)) 14:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:04:49 INFO - Running setup.py (path:/tmp/pip-rUwtQm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:04:49 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)) 14:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:04:49 INFO - Running setup.py (path:/tmp/pip-JmH5AU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:04:50 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)) 14:04:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:04:50 INFO - Running setup.py (path:/tmp/pip-L8SIjJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:04:50 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)) 14:04:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:04:50 INFO - Running setup.py (path:/tmp/pip-ypUAjw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:04:50 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)) 14:04:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:04:50 INFO - Running setup.py (path:/tmp/pip-WJR7_q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:04:50 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)) 14:04:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:04:50 INFO - Running setup.py (path:/tmp/pip-1ChVNF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:04:50 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)) 14:04:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:04:50 INFO - Running setup.py (path:/tmp/pip-g4uTqR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:04:50 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)) 14:04:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:04:50 INFO - Running setup.py (path:/tmp/pip-AXl1pt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:04:50 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)) 14:04:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:04:50 INFO - Running setup.py (path:/tmp/pip-0Nzxqc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:04:50 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)) 14:04:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:04:50 INFO - Running setup.py (path:/tmp/pip-CpFNyx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:04:50 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)) 14:04:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:04:50 INFO - Running setup.py (path:/tmp/pip-AIbkyg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:04:50 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)) 14:04:50 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)) 14:04:50 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)) 14:04:50 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)) 14:04:50 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)) 14:04:50 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)) 14:04:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:04:50 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 14:04:50 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 14:04:50 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 14:04:50 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 14:04:50 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 14:04:50 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 14:04:52 INFO - Downloading blessings-1.5.1.tar.gz 14:04:52 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 14:04:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:04:52 INFO - Installing collected packages: blessings 14:04:52 INFO - Running setup.py install for blessings 14:04:52 INFO - Successfully installed blessings 14:04:52 INFO - Cleaning up... 14:04:52 INFO - Return code: 0 14:04:52 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:04:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:04:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:04:52 INFO - Reading from file tmpfile_stdout 14:04:52 INFO - Current package versions: 14:04:52 INFO - argparse == 1.2.1 14:04:52 INFO - blessings == 1.5.1 14:04:52 INFO - blobuploader == 1.2.4 14:04:52 INFO - docopt == 0.6.1 14:04:52 INFO - manifestparser == 1.1 14:04:52 INFO - mozInstall == 1.12 14:04:52 INFO - mozcrash == 0.16 14:04:52 INFO - mozdebug == 0.1 14:04:52 INFO - mozdevice == 0.47 14:04:52 INFO - mozfile == 1.2 14:04:52 INFO - mozhttpd == 0.7 14:04:52 INFO - mozinfo == 0.9 14:04:52 INFO - mozleak == 0.1 14:04:52 INFO - mozlog == 3.1 14:04:52 INFO - moznetwork == 0.27 14:04:52 INFO - mozprocess == 0.22 14:04:52 INFO - mozprofile == 0.28 14:04:52 INFO - mozrunner == 6.11 14:04:52 INFO - mozscreenshot == 0.1 14:04:52 INFO - mozsystemmonitor == 0.0 14:04:52 INFO - moztest == 0.7 14:04:52 INFO - mozversion == 1.4 14:04:52 INFO - psutil == 3.1.1 14:04:52 INFO - requests == 1.2.3 14:04:52 INFO - wsgiref == 0.1.2 14:04:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:04:52 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')]} 14:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:52 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')]} 14:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:52 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 0x7f53d17f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b13f0>, '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 0x2143560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2143a10>, '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': '5bd038846534b2fdfa68eeae000001e2-1452117863.174334-484082236', '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 14:04:52 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 14:04:52 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 14:04:52 INFO - Using env: {'DISPLAY': ':0', 14:04:52 INFO - 'HOME': '/home/cltbld', 14:04:52 INFO - 'LANG': 'en_US.UTF-8', 14:04:52 INFO - 'LANGUAGE': 'en_US:en', 14:04:52 INFO - 'LOGNAME': 'cltbld', 14:04:52 INFO - 'MAIL': '/var/mail/cltbld', 14:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:52 INFO - 'MOZ_NO_REMOTE': '1', 14:04:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:52 INFO - 'NO_EM_RESTART': '1', 14:04:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:04:52 INFO - 'PWD': '/builds/slave/test-pgo', 14:04:52 INFO - 'SHELL': '/bin/bash', 14:04:52 INFO - 'SHLVL': '1', 14:04:52 INFO - 'TERM': 'linux', 14:04:52 INFO - 'TMOUT': '86400', 14:04:52 INFO - 'USER': 'cltbld', 14:04:52 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452117863.174334-484082236', 14:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:52 INFO - '_': '/tools/buildbot/bin/python'} 14:04:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:53 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)) 14:04:53 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)) 14:04:53 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)) 14:04:53 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)) 14:04:53 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)) 14:04:53 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)) 14:04:53 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)) 14:04:53 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)) 14:04:53 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)) 14:04:53 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)) 14:04:53 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)) 14:04:53 INFO - Cleaning up... 14:04:53 INFO - Return code: 0 14:04:53 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53d17f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b13f0>, '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 0x2143560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2143a10>, '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': '5bd038846534b2fdfa68eeae000001e2-1452117863.174334-484082236', '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 14:04:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 14:04:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:04:53 INFO - Using env: {'DISPLAY': ':0', 14:04:53 INFO - 'HOME': '/home/cltbld', 14:04:53 INFO - 'LANG': 'en_US.UTF-8', 14:04:53 INFO - 'LANGUAGE': 'en_US:en', 14:04:53 INFO - 'LOGNAME': 'cltbld', 14:04:53 INFO - 'MAIL': '/var/mail/cltbld', 14:04:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:53 INFO - 'MOZ_NO_REMOTE': '1', 14:04:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:53 INFO - 'NO_EM_RESTART': '1', 14:04:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:04:53 INFO - 'PWD': '/builds/slave/test-pgo', 14:04:53 INFO - 'SHELL': '/bin/bash', 14:04:53 INFO - 'SHLVL': '1', 14:04:53 INFO - 'TERM': 'linux', 14:04:53 INFO - 'TMOUT': '86400', 14:04:53 INFO - 'USER': 'cltbld', 14:04:53 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452117863.174334-484082236', 14:04:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:53 INFO - '_': '/tools/buildbot/bin/python'} 14:04:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:53 INFO - Downloading/unpacking jsonschema 14:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:04:55 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 14:04:55 INFO - Downloading/unpacking functools32 (from jsonschema) 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04:55 INFO - Downloading functools32-3.2.3-2.tar.gz 14:04:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:04:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:04:55 INFO - warning: no files found matching '*.txt' 14:04:55 INFO - no previously-included directories found matching 'build' 14:04:55 INFO - no previously-included directories found matching 'dist' 14:04:55 INFO - no previously-included directories found matching '.git*' 14:04:55 INFO - Installing collected packages: jsonschema, functools32 14:04:55 INFO - Running setup.py install for functools32 14:04:55 INFO - warning: no files found matching '*.txt' 14:04:55 INFO - no previously-included directories found matching 'build' 14:04:55 INFO - no previously-included directories found matching 'dist' 14:04:55 INFO - no previously-included directories found matching '.git*' 14:04:55 INFO - Successfully installed jsonschema functools32 14:04:55 INFO - Cleaning up... 14:04:55 INFO - Return code: 0 14:04:55 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:04: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')]} 14:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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')]} 14:04:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53d17f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b13f0>, '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 0x2143560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2143a10>, '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': '5bd038846534b2fdfa68eeae000001e2-1452117863.174334-484082236', '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 14:04: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', 'flake8'] in /builds/slave/test-pgo/build 14:04: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 flake8 14:04:55 INFO - Using env: {'DISPLAY': ':0', 14:04:55 INFO - 'HOME': '/home/cltbld', 14:04:55 INFO - 'LANG': 'en_US.UTF-8', 14:04:55 INFO - 'LANGUAGE': 'en_US:en', 14:04:55 INFO - 'LOGNAME': 'cltbld', 14:04:55 INFO - 'MAIL': '/var/mail/cltbld', 14:04:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:55 INFO - 'MOZ_NO_REMOTE': '1', 14:04:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:55 INFO - 'NO_EM_RESTART': '1', 14:04:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:04:55 INFO - 'PWD': '/builds/slave/test-pgo', 14:04:55 INFO - 'SHELL': '/bin/bash', 14:04:55 INFO - 'SHLVL': '1', 14:04:55 INFO - 'TERM': 'linux', 14:04:55 INFO - 'TMOUT': '86400', 14:04:55 INFO - 'USER': 'cltbld', 14:04:55 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452117863.174334-484082236', 14:04:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:55 INFO - '_': '/tools/buildbot/bin/python'} 14:04:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:55 INFO - Downloading/unpacking flake8 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:04:57 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 14:04:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:04:57 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 14:04:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:57 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 14:04:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:04:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:04:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:04:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:04:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:04:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:04:58 INFO - no previously-included directories found matching 'docs/_build' 14:04:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:04:58 INFO - Running setup.py install for pep8 14:04:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:04:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:04:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:04:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:04:58 INFO - no previously-included directories found matching 'docs/_build' 14:04:58 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:04:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:04:58 INFO - Cleaning up... 14:04:58 INFO - Return code: 0 14:04:58 INFO - Running post-action listener: _resource_record_post_action 14:04:58 INFO - Running post-action listener: _start_resource_monitoring 14:04:58 INFO - Starting resource monitoring. 14:04:58 INFO - ##### 14:04:58 INFO - ##### Running install step. 14:04:58 INFO - ##### 14:04:58 INFO - Running pre-action listener: _resource_record_pre_action 14:04:58 INFO - Running main action method: install 14:04:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:04:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:04:58 INFO - Reading from file tmpfile_stdout 14:04:58 INFO - Detecting whether we're running mozinstall >=1.0... 14:04:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:04:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:04:58 INFO - Reading from file tmpfile_stdout 14:04:58 INFO - Output received: 14:04:58 INFO - Usage: mozinstall [options] installer 14:04:58 INFO - Options: 14:04:58 INFO - -h, --help show this help message and exit 14:04:58 INFO - -d DEST, --destination=DEST 14:04:58 INFO - Directory to install application into. [default: 14:04:58 INFO - "/builds/slave/test-pgo"] 14:04:58 INFO - --app=APP Application being installed. [default: firefox] 14:04:58 INFO - mkdir: /builds/slave/test-pgo/build/application 14:04:58 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'] 14:04:58 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 14:05:14 INFO - Reading from file tmpfile_stdout 14:05:14 INFO - Output received: 14:05:14 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:05:14 INFO - Running post-action listener: _resource_record_post_action 14:05:14 INFO - ##### 14:05:14 INFO - ##### Running run-tests step. 14:05:14 INFO - ##### 14:05:14 INFO - Running pre-action listener: _resource_record_pre_action 14:05:14 INFO - Running main action method: run_tests 14:05:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:05:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:05:14 INFO - Python 2.7.3 14:05:14 INFO - Return code: 0 14:05:14 INFO - grabbing minidump binary from tooltool 14:05:14 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')]} 14:05:14 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 0x20b13f0>, '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 0x2143560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2143a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:05:14 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 14:05:14 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 14:05:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:05:14 INFO - Return code: 0 14:05:14 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:05:14 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:05:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:05:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:05:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:05:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:05:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:05:15 INFO - Return code: 0 14:05:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 14:05:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:05:15 INFO - Using env: {'DISPLAY': ':0', 14:05:15 INFO - 'HOME': '/home/cltbld', 14:05:15 INFO - 'LANG': 'en_US.UTF-8', 14:05:15 INFO - 'LANGUAGE': 'en_US:en', 14:05:15 INFO - 'LOGNAME': 'cltbld', 14:05:15 INFO - 'MAIL': '/var/mail/cltbld', 14:05:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:05:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:15 INFO - 'MOZ_NO_REMOTE': '1', 14:05:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:05:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:15 INFO - 'NO_EM_RESTART': '1', 14:05:15 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:15 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:15 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:05:15 INFO - 'SHELL': '/bin/bash', 14:05:15 INFO - 'SHLVL': '1', 14:05:15 INFO - 'TERM': 'linux', 14:05:15 INFO - 'TMOUT': '86400', 14:05:15 INFO - 'USER': 'cltbld', 14:05:15 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452117863.174334-484082236', 14:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:15 INFO - '_': '/tools/buildbot/bin/python'} 14:05:15 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:05:15 INFO - mozversion application_buildid: 20160106113008 14:05:15 INFO - mozversion application_changeset: 5a6b63cd300eb05f28b54e4f5266406a29e13b7a 14:05:15 INFO - mozversion application_display_name: Nightly 14:05:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:05:15 INFO - mozversion application_name: Firefox 14:05:15 INFO - mozversion application_remotingname: firefox 14:05:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:05:15 INFO - mozversion application_vendor: Mozilla 14:05:15 INFO - mozversion application_version: 46.0a1 14:05:15 INFO - mozversion platform_buildid: 20160106113008 14:05:15 INFO - mozversion platform_changeset: 5a6b63cd300eb05f28b54e4f5266406a29e13b7a 14:05:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:05:15 INFO - mozversion platform_version: 46.0a1 14:05:15 INFO - using testdate: 1452117915 14:05:15 INFO - actual date: 1452117915 14:05:15 INFO - starting webserver on 'localhost:36233' 14:05:15 INFO - SUITE-START | Running 3 tests 14:05:15 INFO - TEST-START | dromaeo_css 14:05:15 INFO - operating with platform_type : linux_ 14:05:15 INFO - Initialising browser for dromaeo_css test... 14:05:15 INFO - TEST-INFO | started process 23366 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIFxNsx/profile http://localhost:36233/getInfo.html) 14:05:19 INFO - PROCESS | 23366 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 14:05:20 INFO - PROCESS | 23366 | __metrics Screen width/height:1600/1200 14:05:20 INFO - PROCESS | 23366 | colorDepth:24 14:05:20 INFO - PROCESS | 23366 | Browser inner width/height: 1024/697 14:05:20 INFO - PROCESS | 23366 | __metrics 14:05:20 INFO - PROCESS | 23366 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:05:21 INFO - TEST-INFO | 23366: exit 0 14:05:21 INFO - Browser initialized. 14:05:21 INFO - Running cycle 1/1 for dromaeo_css test... 14:05:21 INFO - TEST-INFO | started process 23497 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIFxNsx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:05:33 INFO - PROCESS | 23497 | RSS: Main: 150319104 14:05:33 INFO - PROCESS | 23497 | 14:06:22 INFO - PROCESS | 23497 | 1452117982794 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] 14:08:32 INFO - PROCESS | 23497 | Cycle 1(1): loaded http://localhost:36233/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36233/tests/dromaeo/cssquery-ext.html) 14:08:33 INFO - PROCESS | 23497 | RSS: Main: 157995008 14:08:33 INFO - PROCESS | 23497 | 14:11:35 INFO - PROCESS | 23497 | Cycle 1(1): loaded http://localhost:36233/tests/dromaeo/cssquery-ext.html (next: http://localhost:36233/tests/dromaeo/cssquery-jquery.html) 14:11:36 INFO - PROCESS | 23497 | RSS: Main: 152125440 14:11:36 INFO - PROCESS | 23497 | 14:14:37 INFO - PROCESS | 23497 | Cycle 1(1): loaded http://localhost:36233/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36233/tests/dromaeo/cssquery-mootools.html) 14:14:38 INFO - PROCESS | 23497 | RSS: Main: 153616384 14:14:38 INFO - PROCESS | 23497 | 14:17:39 INFO - PROCESS | 23497 | Cycle 1(1): loaded http://localhost:36233/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36233/tests/dromaeo/cssquery-prototype.html) 14:17:40 INFO - PROCESS | 23497 | RSS: Main: 151089152 14:17:40 INFO - PROCESS | 23497 | 14:20:42 INFO - PROCESS | 23497 | Cycle 1(1): loaded http://localhost:36233/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36233/tests/dromaeo/cssquery-yui.html) 14:20:43 INFO - PROCESS | 23497 | RSS: Main: 153030656 14:20:43 INFO - PROCESS | 23497 | 14:23:45 INFO - PROCESS | 23497 | Cycle 1(1): loaded http://localhost:36233/tests/dromaeo/cssquery-yui.html (next: http://localhost:36233/tests/dromaeo/cssquery-dojo.html) 14:23:45 INFO - PROCESS | 23497 | RSS: Main: 156344320 14:23:45 INFO - PROCESS | 23497 | 14:23:45 INFO - PROCESS | 23497 | __start_tp_report 14:23:45 INFO - PROCESS | 23497 | _x_x_mozilla_page_load 14:23:45 INFO - PROCESS | 23497 | _x_x_mozilla_page_load_details 14:23:45 INFO - PROCESS | 23497 | |i|pagename|runs| 14:23:45 INFO - PROCESS | 23497 | |0;dojo.html;3232.935341293174;3300.8019518828887;3308.685674860888;3320.4687250039997;3351.798892066476;5267.920981185285;5451.91822122668;5466.34403871535;5472.5621950243985;5479.452054794524;5389.164679474688;5410.188471729242;5417;5528.806491772789;5550.666959982404;4965.826196083147;5000.674956127858;5090.770915308802;5114.360704911886;5117.539421452068;4928.97535512322;4980.875478113058;5024.422191447994;5056.317397151374;5107;4901.705897646153;4996.500349964975;5003.824866129668;5008.3238762767105;5095.235714642796;4951.405831300231;5014.774335154927;5030.748462576857;5048.268001139851;5054.039732450822;4919.065377578248;4945.505449455061;4953.90092198154;4964.751762411901;4980.850574482735;5084.949150508484;5153.948460515385;5206.167013277895;5225.738713064332;5262.0791361511965;5898.616589921684;5904.675242861641;5905;5914.467697907209;5936.168936348915;5949.6430214187285;5951.642901425928;5951.970240148815;5952.315483719384;5955.404459554054;5375.3280839895015;5498.092814685612;5503.11950087984;5505.697186654773;5540.085885828834;6025.0661147522205;6032.125341825498;6089.056196289582;6118.265808103056;6140.938590614126;5855.765769369263;5862.443067908542;5865.530757539386;5874.295084589791;5880.617759845596;5769.9711501442225;5880.588358814927;5899.17411562373;5936.821895343147;5950.196723442366;5819.272590926134;5883.852903677443;5912.024515954819;5914.083317085859;5915.645061296336;5888.205092312483;5922.111683247547;5936.079907614327;5938.851528711731;5949.553783466257;4433.889152771207;4503.729776213438;4535.183666939983;4580.65645076614;4594.954050459452;4055.5538890721996;4073.981504623844;4095.692823038284;4103.815328310233;4118.855840045644;5432.348118225838;5511.862203444946;5516.255305533701;5541.445855414507;5546.278983732089;5670.319561652628;5784.074548072288;5863.29640443141;5942.138389933435;6028.0355143176885;5456.48163424474;5457.2359869618285;5470.070088085035;5471.835844924579;5485.533729632946;4925.21196608541;4972.254161875748;4978;4996.875078123004;5030.572401345927;5987.371326010793;6077.453029227391;6106.72519736613;6192.040233763774;6207.410296021961;5774.2782152230975;5792.073268277056;5794.594378393472;5795.33353664334;5864.67744274052;5878.29460464747;5890.558208134493;5890.823275301748;5900.085486749561;6009.188759517584;5531.972340138434;5622.690752008679;5785.103308987113;5872.823815285548;5877.647341159544;5830.387809279964;5945.91081133792;5954.702264886825;5956.523478121827;5965.373635768182;5603.495685388335;5787.929233091892;5792.855178620568;5803.274590676166;5806.477417032487;5639.661620302795;5718.656880587178;5765.250517432707;5796.246487956539;5823.912641310469;5567.331920169606;5582.776688932559;5583.302087239095;5592.720363981866;5593.888122237614;5539.390667026543;5629;5655.321361436654;5684.545236381162;5684.7441865117;5583.8883222336135;5690;5703.486686198262;5709.429057094258;5728.198052272768 14:23:45 INFO - PROCESS | 23497 | |1;ext.html;532.7070111438708;540.4136511884604;563.5885803363542;570.7488704969813;573.2519062623278;35802.641973580256;36701.44947825778;36905.44641830371;36912;37048.25903481929;38639.80680096603;39049.804750976204;39053.80473097638;39058.41412378816;39337.21325573487;8572.485650860937;8661.870071948926;8702.042775294713;8723.432976856484;8737.25733312666;8385.119562445916;8570.74287771368;8578.699745508908;8756.562171891412;8767.430117042371;8782.956085219565;8784.51685157316;8832.779180520507;8855;8887.066857979917;8457.915420845775;8509.234168924795;8512.106228845974;8835.646574137027;8846.911530884674;8681.218690317839;8812;8812.647494100229;8815.823683526358;8819.823603527893;39642.40536391956;39836.80081599573;39904.201915961516;39915.201695965916;40002;3271.1331497153037;3379.9493007604906;3381.5773028371455;3472.930541389158;3893.3186692329014;25798;26278.60582091251;26386.86806565955;26519.602205966927;27263.86368068147;3614.8373323200517;3625.8368373422995;3627.7460577759566;3727.1613886875507;3764.2283331917165;183905;184487;185010.99999999866;185726;186279;42044.579554204676;42450.78774606107;61070;61240.387596123466;61609.383906160365;40819.795901020305;40997.385039224435;41077.91915606282;41116.58883411127;41167.1766564673;13429;13632.522861699794;13699.45202191921;13719.382627781573;13745.931270343584;11220.831687524693;11227.550897964153;11284.266522676;11285.379304138187;11290.322580645188;14115.929420353037;14142.151470911778;14460.710785784437;14466.493672721404;14525.128492290285;5736.196932429463;5758.654480731169;5844.912326315109;5854.765809367577;5889.941100589025;947.6446332625266;979.7599588100961;1018.5772904244803;1029.5161274201114;1039.5010395010286;28210;28501.42997140087;28630.852686048212;28684.713152868622;28842;1043.894414118008;1048.984265236022;1114.3035602748282;1122.5958654884234;1133.3766428464312;14790.556283311518;14806.111633302036;14917.850821491864;14964.494829948922;15029.84830214519;303396;308097;308547;309829;310549;52013.47986520162;52547;52547.47452525502;52692.73653631784;52876.735616321675;1326.7014921642747;1341.7990898146104;1342.5569562044698;1357.6130802721177;1478.9942838869672;27431.17706468809;28173.71826281711;28227.71772282251;28670;28994.56508152337;47305.7634711838;47598.76200618975;47689.76155119341;47877.5212247887;47909.28136078031;317396;318719;318748;318988;319032;32994;42990.57009429991;43078.78460607677;43471.565284346754;43486.56513434952;38360.50181789111;39338.2132357357;39463.80268098756;39510.604893950695;39933.20133597254;32945.176370590925;33554.16114597155;33760.81837135689;33835.83082084574;34211.31577368489;33207.833960831005;34521.82739086288;34550.481742774384;34565.135871602404;34631.65368346284;37587;37697.43453848139;38150.80924595359;38591.6140838588;38814.4177837327;28738.281542961595;30476.27595285111;33259.66740332566;33304.1673958153;33319.50020749642;25035.374115647253;25308.49383012366;25426.364340891625;25437.364065898502;25706.742932570436 14:23:45 INFO - PROCESS | 23497 | |2;jquery.html;355.1494171459355;367.15554225281863;367.8307978329967;368.81374905672635;372.270350113777;16734.581635459104;17069.31722731091;17438.128093595333;17742.645147097068;18218.726719099224;9963.750906227348;10268.435236062014;15833.60415989601;15966.441174558893;15991.760123598126;4782.7847746851385;5163.690178589297;5320.7073610951575;5322.201669749549;5327.893442131174;4539.546045395467;5303.496167864047;5318.1225097858805;5323.8136665216725;5326.3075800145925;5299.708516031616;5310.123829568117;6458.644774537399;6724.361185687352;6734.93265067348;6487.83780405489;6560.048792925047;6562.310957349481;6564.376384243489;6598.769043083493;6463.903041454382;6472.223333200046;6485.7405703772265;6495.935040649628;6509.121268628722;21559.461013474633;22548.774512254997;22653.660195096923;22735.090596376125;23294.48585841915;2265.501589650291;2267.9319620411416;2282.657601359793;2379.298107058422;2381.868997205153;14165.858341416557;14266.64333391663;14302.725982673599;14667.63330916725;14841.257937103102;1882.7740671119416;1902.391234804863;1993.601279744057;2004.9699254511195;2006.147387360366;67246;71660.99999999948;72697;73485;74266.25733742648;15303.311350989232;15324.693506130037;15412.46056388021;15435.61410964735;15498.457553985556;23731.644025339632;23731.881340593533;23949.521009579712;24010.15964441236;24044.87977560101;8547.188017138362;8620.741377758552;8658.87011694825;8673.91326086731;8728.519931403835;7390.667419966115;7415.4798266355265;7458.85082298351;7459.589722565311;7525.887111693329;7640.312371886445;7699.692012319444;7715.228477152352;7738.148803631596;7759.224077592308;2994.2215024093894;3047.481928072233;3049.35963447674;3068.4586811519075;3086.336437665868;397.9303621866162;403.42914775592794;416.5813357575617;449.9100179963955;458.21068726622593;9941.40351578893;10456.850256025977;10563.183801988862;10563.943605639375;10776.245662803685;388.60556535116876;395.9529233860946;400.66744601980287;403.47749664184363;410.13870871170303;5521.254630624814;9468.289878259158;10133.594656213669;10137.847932281022;10156.796864062677;571517;586115;586535;606438;607597;69635;76507.23492765112;77147;77166.22833771702;80006.59996700096;1085.8154113800515;1112.6662001399548;1116.8715597706205;1118.6811758648746;1124.932504049776;14621.63445913818;14779.704405911607;14869.330880110205;14974.700505990037;15248.847511525186;24236.51526969486;28303;34154.316913662085;34335.828320858236;34439;44150;44901.77549112234;45514.544854552354;45554.54445455636;46487.76756116198;8970.102989700978;9125.817483650157;9572.856407154037;9605.855912161463;9637.9036209637;11199.66401007971;11403.201775875608;15577.68844623124;16922.576935576708;16995.83004169992;13558.661033474242;13851.515196968057;13934.163950163023;14084.788728169291;14583.19792411385;14721.631959200677;14729.92635036818;14897;15144.54566363011;15591.922040389725;14609.123452592878;14697.485588004369;14748.188849612945;15353.385864565293;15694.607634809221;9506.144446999802;9653.613855445703;9812;9861.457619830979;9871.851922221316;10408;12158.635240942785;14090.436382544583;14539.781903271249;14845.851541484446 14:23:46 INFO - PROCESS | 23497 | |3;mootools.html;1472.602397352715;1487.4793822162244;1645.3994292083385;1744.127936031984;1786.633740083283;6658.201015878101;6678.8664226715555;7512.887306690404;7725.9613701931485;7731.420143489239;7187;7277.235890231515;7340.449466290036;7342.375898048672;7349.853002939938;2205.878676672782;2236.8434209605334;2239.540894116702;2250.9887450562724;2252.1779550464125;2244.6408574628063;2275.3856458756127;2292.6790249365104;2296.575133600281;2306.942326441844;2266.1048885690143;2268.943276418086;2279.122537822942;2287.176616418088;2312.3756585721844;2223.655333423322;2257.9887100564556;2281.824860197;2285.2801367569245;2286.9542609147807;2226.799588037068;2245.9326220213256;2254.4701995031155;2262.1064679451524;2264.0377839418347;7447.702091916317;7566.243375662445;7570.848583028309;7571.318581327707;7590.8102297443;4491.7304961702075;4548.977255113737;4559.612432943204;4600.470945841238;4601.976990115028;3026.8940587079564;3032.0903728881467;3095.349976504937;3119.641241257239;3137.325475022881;941.1717688434203;956.6890760502795;981.3572110267786;993.3493561717015;995.8506224066448;10262.384256944608;10282.434466104361;10285.228607854366;10286.588536458532;10288.794224115476;4068.4914385701786;4137.937930931039;4143.129942712064;4164.042270277792;4226;8802.955985220033;8868.911310886937;8902.109789021046;8903.688370906988;8916;4637.489876113625;4641.976790116028;4647.488776234612;4661.324108004321;4692.788824502905;4135.77253251074;4233.238017156879;4235;4253.80857861397;4288.635465985364;3392.6946574807894;3421.9486707699402;3431.553897993245;3478.7564870458823;3514.1741690702665;1065.893410658928;1069.812782763029;1069.9090577301017;1074.414444127952;1079.4710591809956;1283.8010108433207;1291.3156027305542;1303.178997231757;1315.8420989481324;1320.4322141479256;7032.859342813115;7083.256258092929;7103.82240443993;7111.928880711127;7166.068411106523;457.11091926203216;461.30573486902;465.28578631800025;468.69534802378047;474.03297273562237;5253.23828044939;5302.522772950453;5314.813981510629;5336.519713225828;5374.623776335698;8802.955985220033;8821.2060914518;9041.954790226138;9061.229795467327;9062.184403403593;8957.820843583091;9005.549722513848;9036.502992335354;9051.728448146567;9074.637014519345;7061.258567850302;7104.183018952784;7132.8944013677965;7133.964330178316;7162.570245785166;6826.351496607815;6834.692438840363;6841.418479429105;6894.103766510321;6903.309669033057;7885.44801863864;8084.474509156886;8092;8093.473924194908;8149.266566009088;8200.138985406686;8283.213094755989;8335.666573337;8390.706325278587;8464.788380290542;5716.171155182558;6218.751249949952;6315.873682526416;6415;6478.125453063964;6831.077804496329;6910.06714093611;6925.411340035952;6941.895871562032;6960.721571137098;6639.40245377899;6810.080639113854;6841.555298905555;6848.280930502226;6867.484938629523;6706.731730730716;6754.729810807513;6803.897941530782;6893;6938.653067346511;6569.671516424255;6655.800325990228;6781.050652908695;6785.491088168308;6785.558938668971;6272.09054687077;6309.589876658002;6347;6350.650714210763;6365.981442969102;6331.3352098029045;6339.429451349401;6362.300146983735;6390.968045159744;6392.3927226913365 14:23:46 INFO - PROCESS | 23497 | |4;prototype.html;322.3359878649981;331.57723902024907;334.1995919772147;334.8794434003758;338.11245480613405;6222.2533296004485;6228.377162283775;6239.376062393764;6249.187605611264;6433.5174861885425;6143.600665956709;6237;6253.405926436993;6270.059491076341;6308.495320374371;4674.415698037746;4690.718556886581;4690.812367505313;4694.0142570060325;4696.53034696531;4688.859334219979;4695.483496815347;4701.059788042388;4710.528947105279;4713.505081966378;4515.977420112911;4553.521880202581;4617.5382461753725;4650.97674511627;4658.301254811789;4598.378924013314;4625.676202665832;4629.051044535879;4642.628589712815;4686.554777296152;4027.2750904837117;4033.495813023372;4049.514058312992;4061.472008638858;4068.206699693561;5901.085331773582;5916.112583112525;5961.672108034057;5980.461758441761;5987.251593550806;5333.280007199056;5390.110631745757;5465.617406781527;5472.425395333473;5485.314335708036;6558.573692709959;6568.376004279586;6578.572392794501;6578.901316480256;6610.7109113722845;4431.9778401108115;4480.910381792379;4482.977585112086;4492.438445194351;4492.550744925514;6768.153980752406;6870.587764734132;6895.310468953065;6939.20199177096;6944.72221111155;4563.475200351935;4564.8402305919135;4564.954350456519;4565.977170114194;4576.771161441915;4624.329472226508;4626.236670949323;4632.143053535106;4637.211674015425;4638.605718513897;5421.512063914267;5427.45725427462;5429.158480435539;5435.701036443033;5436.130219164994;6541.901871471931;6673.899891501631;6695.230048544382;6702.832429189211;6708.698108585126;1620.23848791068;1670.4571014420362;1670.7493875918467;1671.8411750883647;1674.9246283917253;1073.120041565924;1073.726199819041;1080.3247970018738;1082.2153938394758;1095.59462998691;6211.223597050369;6219.502439804804;6225.097360882647;6225.875482490324;6228.688565571703;6826.965865170642;6856.6228857413325;6858.382745552824;6871.072405225231;6887.7244910203035;6100.908486372708;6220.129181914535;6222.0355844844125;6227.875442491125;6242.968785156136;3721.330160571069;3743.981280093582;3746.9437958430644;3750.962490375116;3767.2277183177384;7125.82185445368;7156.785296441011;7167;7187.173475050332;7204.819879502949;7015.8596828063155;7064.364207221375;7073.964630176816;7127.679254433563;7135;7114.786556403316;7152.499325047301;7157.1769246537315;7166.749163779347;7167.247439018828;6842.726290948306;6895.172579290517;6899.931000689929;6908.1364829396325;6908.412784913137;6692.063111164343;6812.4890633203695;6813.625250611264;6833.043373927555;6859.725610975505;7160.248173941661;7162.391196748126;7175.964120179366;7182.3535881770895;7186.748463803742;4560.361549383023;4560.703554268962;4580.885477862947;4589.2657174851865;4593.494715581217;6797.830054248683;6906.896396553955;6909;6910.896336554855;6926;6695.230048544479;6701.698423570853;6707.0945422369305;6714.362135597111;6717.865642687021;6668.299828517936;6676.699548520425;6678.198616166092;6684.4318232950745;6688.765893193715;6432.421082102634;6556.246031706415;6563.671816409065;6579.901301480386;6593.142891424084;6688.565243259172;6713.932860671526;6722.932770672231;6746.021826834984;6761.797146085625;6347.650879201688;6468.191476065492;6489.772857949949;6495.0582165586675;6524.380183882524 14:23:46 INFO - PROCESS | 23497 | |5;yui.html;756.43267549338;842.8693552499365;845.6870957745633;855.4183155454289;904.1862323908482;13493.055486115976;13717.725645487084;13739.381727822247;13750.381232844533;13785.379657915393;11481.425928703553;11520.423978801047;11525.884741152586;11617.244879082853;11783.882161178386;681.1213534540437;807.0920214758412;819.9139090395512;824.3116997307226;824.7031068815222;677.3531277629852;800.9839803203932;812.3460614205562;812.8333691593209;814.0434988888062;857.618359829876;857.7726902370877;863.8315528471951;864.3301441382947;868.3227082875368;854.150120629974;854.9102344253826;855.2174760094506;855.5978690015683;859.3812455032398;622.710439645567;627.1877918096031;632.3360471504901;632.3739497897095;633.2243002322165;12160.148789584733;12213.511459541607;12262;12287.877121228763;12312.076594255466;11957.581484648083;12198.207116537396;12707.301098439582;12978.870211297955;13012.831377553537;10217.131543818785;10228.284020118595;10236.539355728935;10800;10860.619878304222;3590;3675.981620091909;3718.2749363874054;3770.057485628593;3780.3573392523335;42634.360484592755;42645.78677106595;42792;43249.78375108104;43258.56741432577;9697.321187516805;9779.217662586976;9891.851622225673;10065;10393;17167.227474763666;17190.570235744206;17272.877262977865;17310.221040052977;17314.047727374862;7710.421718371144;7830.451868369273;7883;7960.522368657899;7970.681172753141;4397.714148580332;4438.489573699001;4476.26141686618;4479.664025198123;4508.18852606534;3153.921151971219;3162.177833763238;3166.904992850218;3166.936661266762;3178.618565772122;578.6990764802364;597.3667912013193;598.5929567893787;638.3616383616384;657.7960832142052;587.5681374189967;604.7973928733835;620.9037599172135;640.6828619833212;679.1748026148254;7182.748603798842;7244.746433874894;7252.2747725227055;7279.781606551812;7303.561786292839;513.5557742552666;587.4008511318517;661.8974059020859;673.4679603113583;676.668432468097;3548.3790336690977;3741.1956429367815;3862.9806850965565;3949.8420063197723;3985.940210896839;46759.29861052087;47029;47298;47384;47532.76233618879;43560.3465948011;43579.346309805376;43707.12585748267;45123.54876451259;45233.77383113129;44006.55993440089;46024.76987615041;46130.53869461329;46540.301895471595;47349.28976065362;7762.650680719494;7817.335526480313;7843.960780196063;7892.210778922062;7938.603069846369;35306.470402943465;35737.463938041474;36157.27685446224;36246;36256.456153157196;42356.788216058725;42395.94010149771;44062;45864.54135458603;45864.77067614641;10555.68332949982;10661.253712240068;10692;10885.339623395948;11133.888661113286;11712.180147389601;12005;12010.219335743148;12032.578859739868;12153.817692734792;9669.226461883172;10116.494175291353;10232.130268926927;10323.587056517956;10324.328918620266;9657.75528905542;10229.386236825814;10418.583256669648;10454.163666906477;10459;10459.790804184026;10545.10366618846;10569.947150264199;10570.947145264225;10757.838632420364;9329.813403732023;9592.23262139041;9963.601455941971;10072.244581656552;10083.445410502492;8094.676212951416;8450.408471406943;8731.345149113715;9029.142231487998;9085.682001130193 14:23:46 INFO - PROCESS | 23497 | __end_tp_report 14:23:46 INFO - PROCESS | 23497 | __start_cc_report 14:23:46 INFO - PROCESS | 23497 | _x_x_mozilla_cycle_collect,307 14:23:46 INFO - PROCESS | 23497 | __end_cc_report 14:23:46 INFO - PROCESS | 23497 | __startTimestamp1452119025990__endTimestamp 14:23:46 INFO - PROCESS | 23497 | 14:23:46 INFO - PROCESS | 23497 | ------- Summary: start ------- 14:23:46 INFO - PROCESS | 23497 | Number of tests: 6 14:23:46 INFO - PROCESS | 23497 | 14:23:46 INFO - PROCESS | 23497 | [#0] dojo.html Cycles:165 Average:5447.80 Median:5593.89 stddev:602.08 (10.8%) stddev-sans-first:578.31 14:23:46 INFO - PROCESS | 23497 | Values: 3232.9 3300.8 3308.7 3320.5 3351.8 5267.9 5451.9 5466.3 5472.6 5479.5 5389.2 5410.2 5417.0 5528.8 5550.7 4965.8 5000.7 5090.8 5114.4 5117.5 4929.0 4980.9 5024.4 5056.3 5107.0 4901.7 4996.5 5003.8 5008.3 5095.2 4951.4 5014.8 5030.7 5048.3 5054.0 4919.1 4945.5 4953.9 4964.8 4980.9 5084.9 5153.9 5206.2 5225.7 5262.1 5898.6 5904.7 5905.0 5914.5 5936.2 5949.6 5951.6 5952.0 5952.3 5955.4 5375.3 5498.1 5503.1 5505.7 5540.1 6025.1 6032.1 6089.1 6118.3 6140.9 5855.8 5862.4 5865.5 5874.3 5880.6 5770.0 5880.6 5899.2 5936.8 5950.2 5819.3 5883.9 5912.0 5914.1 5915.6 5888.2 5922.1 5936.1 5938.9 5949.6 4433.9 4503.7 4535.2 4580.7 4595.0 4055.6 4074.0 4095.7 4103.8 4118.9 5432.3 5511.9 5516.3 5541.4 5546.3 5670.3 5784.1 5863.3 5942.1 6028.0 5456.5 5457.2 5470.1 5471.8 5485.5 4925.2 4972.3 4978.0 4996.9 5030.6 5987.4 6077.5 6106.7 6192.0 6207.4 5774.3 5792.1 5794.6 5795.3 5864.7 5878.3 5890.6 5890.8 5900.1 6009.2 5532.0 5622.7 5785.1 5872.8 5877.6 5830.4 5945.9 5954.7 5956.5 5965.4 5603.5 5787.9 5792.9 5803.3 5806.5 5639.7 5718.7 5765.3 5796.2 5823.9 5567.3 5582.8 5583.3 5592.7 5593.9 5539.4 5629.0 5655.3 5684.5 5684.7 5583.9 5690.0 5703.5 5709.4 5728.2 14:23:46 INFO - PROCESS | 23497 | 14:23:46 INFO - PROCESS | 23497 | [#1] ext.html Cycles:180 Average:43446.97 Median:3626.79 stddev:72668.06 (2003.6%) stddev-sans-first:72800.48 14:23:46 INFO - PROCESS | 23497 | Values: 532.7 540.4 563.6 570.7 573.3 35802.6 36701.4 36905.4 36912.0 37048.3 38639.8 39049.8 39053.8 39058.4 39337.2 8572.5 8661.9 8702.0 8723.4 8737.3 8385.1 8570.7 8578.7 8756.6 8767.4 8783.0 8784.5 8832.8 8855.0 8887.1 8457.9 8509.2 8512.1 8835.6 8846.9 8681.2 8812.0 8812.6 8815.8 8819.8 39642.4 39836.8 39904.2 39915.2 40002.0 3271.1 3379.9 3381.6 3472.9 3893.3 25798.0 26278.6 26386.9 26519.6 27263.9 3614.8 3625.8 3627.7 3727.2 3764.2 183905.0 184487.0 185011.0 185726.0 186279.0 42044.6 42450.8 61070.0 61240.4 61609.4 40819.8 40997.4 41077.9 41116.6 41167.2 13429.0 13632.5 13699.5 13719.4 13745.9 11220.8 11227.6 11284.3 11285.4 11290.3 14115.9 14142.2 14460.7 14466.5 14525.1 5736.2 5758.7 5844.9 5854.8 5889.9 947.6 979.8 1018.6 1029.5 1039.5 28210.0 28501.4 28630.9 28684.7 28842.0 1043.9 1049.0 1114.3 1122.6 1133.4 14790.6 14806.1 14917.9 14964.5 15029.8 303396.0 308097.0 308547.0 309829.0 310549.0 52013.5 52547.0 52547.5 52692.7 52876.7 1326.7 1341.8 1342.6 1357.6 1479.0 27431.2 28173.7 28227.7 28670.0 28994.6 47305.8 47598.8 47689.8 47877.5 47909.3 317396.0 318719.0 318748.0 318988.0 319032.0 32994.0 42990.6 43078.8 43471.6 43486.6 38360.5 39338.2 39463.8 39510.6 39933.2 32945.2 33554.2 33760.8 33835.8 34211.3 33207.8 34521.8 34550.5 34565.1 34631.7 37587.0 37697.4 38150.8 38591.6 38814.4 28738.3 30476.3 33259.7 33304.2 33319.5 25035.4 25308.5 25426.4 25437.4 25706.7 14:23:46 INFO - PROCESS | 23497 | 14:23:46 INFO - PROCESS | 23497 | [#2] jquery.html Cycles:180 Average:30875.51 Median:17397.07 stddev:96585.36 (555.2%) stddev-sans-first:96829.12 14:23:46 INFO - PROCESS | 23497 | Values: 355.1 367.2 367.8 368.8 372.3 16734.6 17069.3 17438.1 17742.6 18218.7 9963.8 10268.4 15833.6 15966.4 15991.8 4782.8 5163.7 5320.7 5322.2 5327.9 4539.5 5303.5 5318.1 5323.8 5326.3 5299.7 5310.1 6458.6 6724.4 6734.9 6487.8 6560.0 6562.3 6564.4 6598.8 6463.9 6472.2 6485.7 6495.9 6509.1 21559.5 22548.8 22653.7 22735.1 23294.5 2265.5 2267.9 2282.7 2379.3 2381.9 14165.9 14266.6 14302.7 14667.6 14841.3 1882.8 1902.4 1993.6 2005.0 2006.1 67246.0 71661.0 72697.0 73485.0 74266.3 15303.3 15324.7 15412.5 15435.6 15498.5 23731.6 23731.9 23949.5 24010.2 24044.9 8547.2 8620.7 8658.9 8673.9 8728.5 7390.7 7415.5 7458.9 7459.6 7525.9 7640.3 7699.7 7715.2 7738.1 7759.2 2994.2 3047.5 3049.4 3068.5 3086.3 397.9 403.4 416.6 449.9 458.2 9941.4 10456.9 10563.2 10563.9 10776.2 388.6 396.0 400.7 403.5 410.1 5521.3 9468.3 10133.6 10137.8 10156.8 571517.0 586115.0 586535.0 606438.0 607597.0 69635.0 76507.2 77147.0 77166.2 80006.6 1085.8 1112.7 1116.9 1118.7 1124.9 14621.6 14779.7 14869.3 14974.7 15248.8 24236.5 28303.0 34154.3 34335.8 34439.0 44150.0 44901.8 45514.5 45554.5 46487.8 8970.1 9125.8 9572.9 9605.9 9637.9 11199.7 11403.2 15577.7 16922.6 16995.8 13558.7 13851.5 13934.2 14084.8 14583.2 14721.6 14729.9 14897.0 15144.5 15591.9 14609.1 14697.5 14748.2 15353.4 15694.6 9506.1 9653.6 9812.0 9861.5 9871.9 10408.0 12158.6 14090.4 14539.8 14845.9 14:23:46 INFO - PROCESS | 23497 | 14:23:46 INFO - PROCESS | 23497 | [#3] mootools.html Cycles:180 Average:5252.81 Median:6335.38 stddev:2712.76 (42.8%) stddev-sans-first:2705.49 14:23:46 INFO - PROCESS | 23497 | Values: 1472.6 1487.5 1645.4 1744.1 1786.6 6658.2 6678.9 7512.9 7726.0 7731.4 7187.0 7277.2 7340.4 7342.4 7349.9 2205.9 2236.8 2239.5 2251.0 2252.2 2244.6 2275.4 2292.7 2296.6 2306.9 2266.1 2268.9 2279.1 2287.2 2312.4 2223.7 2258.0 2281.8 2285.3 2287.0 2226.8 2245.9 2254.5 2262.1 2264.0 7447.7 7566.2 7570.8 7571.3 7590.8 4491.7 4549.0 4559.6 4600.5 4602.0 3026.9 3032.1 3095.3 3119.6 3137.3 941.2 956.7 981.4 993.3 995.9 10262.4 10282.4 10285.2 10286.6 10288.8 4068.5 4137.9 4143.1 4164.0 4226.0 8803.0 8868.9 8902.1 8903.7 8916.0 4637.5 4642.0 4647.5 4661.3 4692.8 4135.8 4233.2 4235.0 4253.8 4288.6 3392.7 3421.9 3431.6 3478.8 3514.2 1065.9 1069.8 1069.9 1074.4 1079.5 1283.8 1291.3 1303.2 1315.8 1320.4 7032.9 7083.3 7103.8 7111.9 7166.1 457.1 461.3 465.3 468.7 474.0 5253.2 5302.5 5314.8 5336.5 5374.6 8803.0 8821.2 9042.0 9061.2 9062.2 8957.8 9005.5 9036.5 9051.7 9074.6 7061.3 7104.2 7132.9 7134.0 7162.6 6826.4 6834.7 6841.4 6894.1 6903.3 7885.4 8084.5 8092.0 8093.5 8149.3 8200.1 8283.2 8335.7 8390.7 8464.8 5716.2 6218.8 6315.9 6415.0 6478.1 6831.1 6910.1 6925.4 6941.9 6960.7 6639.4 6810.1 6841.6 6848.3 6867.5 6706.7 6754.7 6803.9 6893.0 6938.7 6569.7 6655.8 6781.1 6785.5 6785.6 6272.1 6309.6 6347.0 6350.7 6366.0 6331.3 6339.4 6362.3 6391.0 6392.4 14:23:46 INFO - PROCESS | 23497 | 14:23:46 INFO - PROCESS | 23497 | [#4] prototype.html Cycles:180 Average:5521.36 Median:6228.53 stddev:1704.25 (27.4%) stddev-sans-first:1663.75 14:23:46 INFO - PROCESS | 23497 | Values: 322.3 331.6 334.2 334.9 338.1 6222.3 6228.4 6239.4 6249.2 6433.5 6143.6 6237.0 6253.4 6270.1 6308.5 4674.4 4690.7 4690.8 4694.0 4696.5 4688.9 4695.5 4701.1 4710.5 4713.5 4516.0 4553.5 4617.5 4651.0 4658.3 4598.4 4625.7 4629.1 4642.6 4686.6 4027.3 4033.5 4049.5 4061.5 4068.2 5901.1 5916.1 5961.7 5980.5 5987.3 5333.3 5390.1 5465.6 5472.4 5485.3 6558.6 6568.4 6578.6 6578.9 6610.7 4432.0 4480.9 4483.0 4492.4 4492.6 6768.2 6870.6 6895.3 6939.2 6944.7 4563.5 4564.8 4565.0 4566.0 4576.8 4624.3 4626.2 4632.1 4637.2 4638.6 5421.5 5427.5 5429.2 5435.7 5436.1 6541.9 6673.9 6695.2 6702.8 6708.7 1620.2 1670.5 1670.7 1671.8 1674.9 1073.1 1073.7 1080.3 1082.2 1095.6 6211.2 6219.5 6225.1 6225.9 6228.7 6827.0 6856.6 6858.4 6871.1 6887.7 6100.9 6220.1 6222.0 6227.9 6243.0 3721.3 3744.0 3746.9 3751.0 3767.2 7125.8 7156.8 7167.0 7187.2 7204.8 7015.9 7064.4 7074.0 7127.7 7135.0 7114.8 7152.5 7157.2 7166.7 7167.2 6842.7 6895.2 6899.9 6908.1 6908.4 6692.1 6812.5 6813.6 6833.0 6859.7 7160.2 7162.4 7176.0 7182.4 7186.7 4560.4 4560.7 4580.9 4589.3 4593.5 6797.8 6906.9 6909.0 6910.9 6926.0 6695.2 6701.7 6707.1 6714.4 6717.9 6668.3 6676.7 6678.2 6684.4 6688.8 6432.4 6556.2 6563.7 6579.9 6593.1 6688.6 6713.9 6722.9 6746.0 6761.8 6347.7 6468.2 6489.8 6495.1 6524.4 14:23:46 INFO - PROCESS | 23497 | 14:23:46 INFO - PROCESS | 23497 | [#5] yui.html Cycles:180 Average:12921.33 Median:4457.38 stddev:14476.70 (324.8%) stddev-sans-first:14488.49 14:23:46 INFO - PROCESS | 23497 | Values: 756.4 842.9 845.7 855.4 904.2 13493.1 13717.7 13739.4 13750.4 13785.4 11481.4 11520.4 11525.9 11617.2 11783.9 681.1 807.1 819.9 824.3 824.7 677.4 801.0 812.3 812.8 814.0 857.6 857.8 863.8 864.3 868.3 854.2 854.9 855.2 855.6 859.4 622.7 627.2 632.3 632.4 633.2 12160.1 12213.5 12262.0 12287.9 12312.1 11957.6 12198.2 12707.3 12978.9 13012.8 10217.1 10228.3 10236.5 10800.0 10860.6 3590.0 3676.0 3718.3 3770.1 3780.4 42634.4 42645.8 42792.0 43249.8 43258.6 9697.3 9779.2 9891.9 10065.0 10393.0 17167.2 17190.6 17272.9 17310.2 17314.0 7710.4 7830.5 7883.0 7960.5 7970.7 4397.7 4438.5 4476.3 4479.7 4508.2 3153.9 3162.2 3166.9 3166.9 3178.6 578.7 597.4 598.6 638.4 657.8 587.6 604.8 620.9 640.7 679.2 7182.7 7244.7 7252.3 7279.8 7303.6 513.6 587.4 661.9 673.5 676.7 3548.4 3741.2 3863.0 3949.8 3985.9 46759.3 47029.0 47298.0 47384.0 47532.8 43560.3 43579.3 43707.1 45123.5 45233.8 44006.6 46024.8 46130.5 46540.3 47349.3 7762.7 7817.3 7844.0 7892.2 7938.6 35306.5 35737.5 36157.3 36246.0 36256.5 42356.8 42395.9 44062.0 45864.5 45864.8 10555.7 10661.3 10692.0 10885.3 11133.9 11712.2 12005.0 12010.2 12032.6 12153.8 9669.2 10116.5 10232.1 10323.6 10324.3 9657.8 10229.4 10418.6 10454.2 10459.0 10459.8 10545.1 10569.9 10570.9 10757.8 9329.8 9592.2 9963.6 10072.2 10083.4 8094.7 8450.4 8731.3 9029.1 9085.7 14:23:46 INFO - PROCESS | 23497 | -------- Summary: end -------- 14:23:46 INFO - PROCESS | 23497 | 14:23:46 INFO - TEST-INFO | 23497: exit 0 14:23:46 INFO - TEST-OK | dromaeo_css | took 1111066ms 14:23:46 INFO - TEST-START | kraken 14:23:46 INFO - operating with platform_type : linux_ 14:23:46 INFO - Initialising browser for kraken test... 14:23:46 INFO - TEST-INFO | started process 23744 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppWDk7z/profile http://localhost:36233/getInfo.html) 14:23:50 INFO - PROCESS | 23744 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 14:23:51 INFO - PROCESS | 23744 | __metrics Screen width/height:1600/1200 14:23:51 INFO - PROCESS | 23744 | colorDepth:24 14:23:51 INFO - PROCESS | 23744 | Browser inner width/height: 1024/697 14:23:51 INFO - PROCESS | 23744 | __metrics 14:23:51 INFO - PROCESS | 23744 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:23:51 INFO - PROCESS | 23744 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 14:23:52 INFO - TEST-INFO | 23744: exit 0 14:23:52 INFO - Browser initialized. 14:23:52 INFO - Running cycle 1/1 for kraken test... 14:23:52 INFO - TEST-INFO | started process 23864 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppWDk7z/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:24:03 INFO - PROCESS | 23864 | RSS: Main: 150540288 14:24:03 INFO - PROCESS | 23864 | 14:24:06 INFO - PROCESS | 23864 | Cycle 1(1): loaded http://localhost:36233/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36233/tests/kraken/driver.html?testName=audio-beat-detection) 14:24:07 INFO - PROCESS | 23864 | RSS: Main: 151216128 14:24:07 INFO - PROCESS | 23864 | 14:24:09 INFO - PROCESS | 23864 | Cycle 1(1): loaded http://localhost:36233/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36233/tests/kraken/driver.html?testName=audio-dft) 14:24:10 INFO - PROCESS | 23864 | RSS: Main: 150134784 14:24:10 INFO - PROCESS | 23864 | 14:24:13 INFO - PROCESS | 23864 | Cycle 1(1): loaded http://localhost:36233/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36233/tests/kraken/driver.html?testName=audio-fft) 14:24:13 INFO - PROCESS | 23864 | RSS: Main: 146231296 14:24:13 INFO - PROCESS | 23864 | 14:24:16 INFO - PROCESS | 23864 | Cycle 1(1): loaded http://localhost:36233/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36233/tests/kraken/driver.html?testName=audio-oscillator) 14:24:16 INFO - PROCESS | 23864 | RSS: Main: 146034688 14:24:16 INFO - PROCESS | 23864 | 14:24:18 INFO - PROCESS | 23864 | Cycle 1(1): loaded http://localhost:36233/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36233/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:24:19 INFO - PROCESS | 23864 | RSS: Main: 146923520 14:24:19 INFO - PROCESS | 23864 | 14:24:22 INFO - PROCESS | 23864 | Cycle 1(1): loaded http://localhost:36233/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36233/tests/kraken/driver.html?testName=imaging-darkroom) 14:24:23 INFO - PROCESS | 23864 | RSS: Main: 147853312 14:24:23 INFO - PROCESS | 23864 | 14:24:26 INFO - PROCESS | 23864 | Cycle 1(1): loaded http://localhost:36233/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36233/tests/kraken/driver.html?testName=imaging-desaturate) 14:24:27 INFO - PROCESS | 23864 | RSS: Main: 148852736 14:24:27 INFO - PROCESS | 23864 | 14:24:29 INFO - PROCESS | 23864 | Cycle 1(1): loaded http://localhost:36233/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36233/tests/kraken/driver.html?testName=json-parse-financial) 14:24:30 INFO - PROCESS | 23864 | RSS: Main: 148938752 14:24:30 INFO - PROCESS | 23864 | 14:24:31 INFO - PROCESS | 23864 | Cycle 1(1): loaded http://localhost:36233/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36233/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:24:32 INFO - PROCESS | 23864 | RSS: Main: 147951616 14:24:32 INFO - PROCESS | 23864 | 14:24:34 INFO - PROCESS | 23864 | Cycle 1(1): loaded http://localhost:36233/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36233/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:24:34 INFO - PROCESS | 23864 | RSS: Main: 148189184 14:24:34 INFO - PROCESS | 23864 | 14:24:37 INFO - PROCESS | 23864 | Cycle 1(1): loaded http://localhost:36233/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36233/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:24:37 INFO - PROCESS | 23864 | RSS: Main: 148414464 14:24:37 INFO - PROCESS | 23864 | 14:24:40 INFO - PROCESS | 23864 | Cycle 1(1): loaded http://localhost:36233/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36233/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:24:40 INFO - PROCESS | 23864 | RSS: Main: 148389888 14:24:40 INFO - PROCESS | 23864 | 14:24:43 INFO - PROCESS | 23864 | Cycle 1(1): loaded http://localhost:36233/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36233/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:24:43 INFO - PROCESS | 23864 | RSS: Main: 148525056 14:24:43 INFO - PROCESS | 23864 | 14:24:45 INFO - PROCESS | 23864 | Cycle 1(1): loaded http://localhost:36233/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36233/tests/kraken/driver.html?testName=ai-astar) 14:24:45 INFO - PROCESS | 23864 | RSS: Main: 149442560 14:24:45 INFO - PROCESS | 23864 | 14:24:45 INFO - PROCESS | 23864 | __start_tp_report 14:24:45 INFO - PROCESS | 23864 | _x_x_mozilla_page_load 14:24:45 INFO - PROCESS | 23864 | _x_x_mozilla_page_load_details 14:24:45 INFO - PROCESS | 23864 | |i|pagename|runs| 14:24:45 INFO - PROCESS | 23864 | |0;ai-astar;113;106;112;112;110;124;112;110;111;110 14:24:45 INFO - PROCESS | 23864 | |1;audio-beat-detection;150;135;164;166;126;155;160;130;165;127 14:24:45 INFO - PROCESS | 23864 | |2;audio-dft;162;160;161;163;164;163;165;164;170;160 14:24:45 INFO - PROCESS | 23864 | |3;audio-fft;73;72;73;75;71;72;74;154;74;73 14:24:45 INFO - PROCESS | 23864 | |4;audio-oscillator;97;97;141;96;96;97;141;97;96;143 14:24:45 INFO - PROCESS | 23864 | |5;imaging-gaussian-blur;110;112;110;109;109;110;110;110;109;110 14:24:45 INFO - PROCESS | 23864 | |6;imaging-darkroom;148;147;147;148;145;146;147;147;146;146 14:24:45 INFO - PROCESS | 23864 | |7;imaging-desaturate;96;97;96;96;96;96;96;96;96;96 14:24:45 INFO - PROCESS | 23864 | |8;json-parse-financial;60;60;63;59;61;60;59;59;56;58 14:24:45 INFO - PROCESS | 23864 | |9;json-stringify-tinderbox;68;69;67;68;68;70;70;68;67;68 14:24:45 INFO - PROCESS | 23864 | |10;stanford-crypto-aes;86;95;87;86;88;90;87;87;94;88 14:24:45 INFO - PROCESS | 23864 | |11;stanford-crypto-ccm;124;123;127;118;122;121;120;121;120;118 14:24:45 INFO - PROCESS | 23864 | |12;stanford-crypto-pbkdf2;147;159;164;158;162;145;153;153;154;143 14:24:45 INFO - PROCESS | 23864 | |13;stanford-crypto-sha256-iterative;71;70;67;72;69;68;69;70;68;68 14:24:45 INFO - PROCESS | 23864 | __end_tp_report 14:24:45 INFO - PROCESS | 23864 | __start_cc_report 14:24:45 INFO - PROCESS | 23864 | _x_x_mozilla_cycle_collect,742 14:24:45 INFO - PROCESS | 23864 | __end_cc_report 14:24:45 INFO - PROCESS | 23864 | __startTimestamp1452119085905__endTimestamp 14:24:45 INFO - PROCESS | 23864 | 14:24:45 INFO - PROCESS | 23864 | ------- Summary: start ------- 14:24:45 INFO - PROCESS | 23864 | Number of tests: 14 14:24:45 INFO - PROCESS | 23864 | 14:24:45 INFO - PROCESS | 23864 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:4.64 (4.1%) stddev-sans-first:4.91 14:24:45 INFO - PROCESS | 23864 | Values: 113.0 106.0 112.0 112.0 110.0 124.0 112.0 110.0 111.0 110.0 14:24:45 INFO - PROCESS | 23864 | 14:24:45 INFO - PROCESS | 23864 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:157.50 stddev:16.61 (10.5%) stddev-sans-first:17.60 14:24:45 INFO - PROCESS | 23864 | Values: 150.0 135.0 164.0 166.0 126.0 155.0 160.0 130.0 165.0 127.0 14:24:45 INFO - PROCESS | 23864 | 14:24:45 INFO - PROCESS | 23864 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:2.94 (1.8%) stddev-sans-first:3.08 14:24:45 INFO - PROCESS | 23864 | Values: 162.0 160.0 161.0 163.0 164.0 163.0 165.0 164.0 170.0 160.0 14:24:45 INFO - PROCESS | 23864 | 14:24:45 INFO - PROCESS | 23864 | [#3] audio-fft Cycles:10 Average:81.10 Median:73.00 stddev:25.64 (35.1%) stddev-sans-first:27.03 14:24:45 INFO - PROCESS | 23864 | Values: 73.0 72.0 73.0 75.0 71.0 72.0 74.0 154.0 74.0 73.0 14:24:45 INFO - PROCESS | 23864 | 14:24:45 INFO - PROCESS | 23864 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:96.50 stddev:21.79 (22.6%) stddev-sans-first:22.59 14:24:45 INFO - PROCESS | 23864 | Values: 97.0 97.0 141.0 96.0 96.0 97.0 141.0 97.0 96.0 143.0 14:24:45 INFO - PROCESS | 23864 | 14:24:45 INFO - PROCESS | 23864 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.88 (0.8%) stddev-sans-first:0.93 14:24:45 INFO - PROCESS | 23864 | Values: 110.0 112.0 110.0 109.0 109.0 110.0 110.0 110.0 109.0 110.0 14:24:45 INFO - PROCESS | 23864 | 14:24:45 INFO - PROCESS | 23864 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.95 (0.6%) stddev-sans-first:0.88 14:24:45 INFO - PROCESS | 23864 | Values: 148.0 147.0 147.0 148.0 145.0 146.0 147.0 147.0 146.0 146.0 14:24:45 INFO - PROCESS | 23864 | 14:24:45 INFO - PROCESS | 23864 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:24:45 INFO - PROCESS | 23864 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 14:24:45 INFO - PROCESS | 23864 | 14:24:45 INFO - PROCESS | 23864 | [#8] json-parse-financial Cycles:10 Average:59.50 Median:60.00 stddev:1.84 (3.1%) stddev-sans-first:1.94 14:24:45 INFO - PROCESS | 23864 | Values: 60.0 60.0 63.0 59.0 61.0 60.0 59.0 59.0 56.0 58.0 14:24:45 INFO - PROCESS | 23864 | 14:24:45 INFO - PROCESS | 23864 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:1.06 (1.6%) stddev-sans-first:1.12 14:24:45 INFO - PROCESS | 23864 | Values: 68.0 69.0 67.0 68.0 68.0 70.0 70.0 68.0 67.0 68.0 14:24:45 INFO - PROCESS | 23864 | 14:24:45 INFO - PROCESS | 23864 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:88.00 stddev:3.22 (3.7%) stddev-sans-first:3.26 14:24:45 INFO - PROCESS | 23864 | Values: 86.0 95.0 87.0 86.0 88.0 90.0 87.0 87.0 94.0 88.0 14:24:45 INFO - PROCESS | 23864 | 14:24:45 INFO - PROCESS | 23864 | [#11] stanford-crypto-ccm Cycles:10 Average:121.40 Median:121.50 stddev:2.76 (2.3%) stddev-sans-first:2.76 14:24:45 INFO - PROCESS | 23864 | Values: 124.0 123.0 127.0 118.0 122.0 121.0 120.0 121.0 120.0 118.0 14:24:45 INFO - PROCESS | 23864 | 14:24:45 INFO - PROCESS | 23864 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.80 Median:156.00 stddev:7.13 (4.6%) stddev-sans-first:7.13 14:24:45 INFO - PROCESS | 23864 | Values: 147.0 159.0 164.0 158.0 162.0 145.0 153.0 153.0 154.0 143.0 14:24:45 INFO - PROCESS | 23864 | 14:24:45 INFO - PROCESS | 23864 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:1.55 (2.2%) stddev-sans-first:1.50 14:24:45 INFO - PROCESS | 23864 | Values: 71.0 70.0 67.0 72.0 69.0 68.0 69.0 70.0 68.0 68.0 14:24:45 INFO - PROCESS | 23864 | -------- Summary: end -------- 14:24:45 INFO - PROCESS | 23864 | 14:24:46 INFO - TEST-INFO | 23864: exit 0 14:24:46 INFO - TEST-OK | kraken | took 60114ms 14:24:46 INFO - TEST-START | v8_7 14:24:46 INFO - operating with platform_type : linux_ 14:24:46 INFO - Initialising browser for v8_7 test... 14:24:46 INFO - TEST-INFO | started process 24149 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRfrmEs/profile http://localhost:36233/getInfo.html) 14:24:50 INFO - PROCESS | 24149 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 14:24:51 INFO - PROCESS | 24149 | __metrics Screen width/height:1600/1200 14:24:51 INFO - PROCESS | 24149 | colorDepth:24 14:24:51 INFO - PROCESS | 24149 | Browser inner width/height: 1024/697 14:24:51 INFO - PROCESS | 24149 | __metrics 14:24:51 INFO - PROCESS | 24149 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:24:52 INFO - TEST-INFO | 24149: exit 0 14:24:52 INFO - Browser initialized. 14:24:52 INFO - Running cycle 1/1 for v8_7 test... 14:24:52 INFO - TEST-INFO | started process 24276 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRfrmEs/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:25:04 INFO - PROCESS | 24276 | RSS: Main: 149737472 14:25:04 INFO - PROCESS | 24276 | 14:25:25 INFO - PROCESS | 24276 | Cycle 1(1): loaded http://localhost:36233/tests/v8_7/run.html (next: http://localhost:36233/tests/v8_7/run.html) 14:25:25 INFO - PROCESS | 24276 | RSS: Main: 146698240 14:25:25 INFO - PROCESS | 24276 | 14:25:25 INFO - PROCESS | 24276 | __start_tp_report 14:25:25 INFO - PROCESS | 24276 | _x_x_mozilla_page_load 14:25:25 INFO - PROCESS | 24276 | _x_x_mozilla_page_load_details 14:25:25 INFO - PROCESS | 24276 | |i|pagename|runs| 14:25:25 INFO - PROCESS | 24276 | |0;Richards;167.2800267648043 14:25:25 INFO - PROCESS | 24276 | |1;DeltaBlue;190.5850962454736 14:25:25 INFO - PROCESS | 24276 | |2;Encrypt;280.1120448179272 14:25:25 INFO - PROCESS | 24276 | |3;Decrypt;5213.541666666667 14:25:25 INFO - PROCESS | 24276 | |4;RayTrace;1058.2010582010582 14:25:25 INFO - PROCESS | 24276 | |5;Earley;716.8458781362007 14:25:25 INFO - PROCESS | 24276 | |6;Boyer;12537.5 14:25:25 INFO - PROCESS | 24276 | |7;RegExp;25550 14:25:25 INFO - PROCESS | 24276 | |8;Splay;668.8963210702341 14:25:25 INFO - PROCESS | 24276 | |9;NavierStokes;4835.748792270531 14:25:25 INFO - PROCESS | 24276 | __end_tp_report 14:25:25 INFO - PROCESS | 24276 | __startTimestamp1452119125662__endTimestamp 14:25:25 INFO - PROCESS | 24276 | 14:25:25 INFO - PROCESS | 24276 | ------- Summary: start ------- 14:25:25 INFO - PROCESS | 24276 | Number of tests: 10 14:25:25 INFO - PROCESS | 24276 | 14:25:25 INFO - PROCESS | 24276 | [#0] Richards Cycles:1 Average:167.28 Median:167.28 stddev:0.00 (0.0%) 14:25:25 INFO - PROCESS | 24276 | Values: 167.3 14:25:25 INFO - PROCESS | 24276 | 14:25:25 INFO - PROCESS | 24276 | [#1] DeltaBlue Cycles:1 Average:190.59 Median:190.59 stddev:0.00 (0.0%) 14:25:25 INFO - PROCESS | 24276 | Values: 190.6 14:25:25 INFO - PROCESS | 24276 | 14:25:25 INFO - PROCESS | 24276 | [#2] Encrypt Cycles:1 Average:280.11 Median:280.11 stddev:0.00 (0.0%) 14:25:25 INFO - PROCESS | 24276 | Values: 280.1 14:25:25 INFO - PROCESS | 24276 | 14:25:25 INFO - PROCESS | 24276 | [#3] Decrypt Cycles:1 Average:5213.54 Median:5213.54 stddev:0.00 (0.0%) 14:25:25 INFO - PROCESS | 24276 | Values: 5213.5 14:25:25 INFO - PROCESS | 24276 | 14:25:25 INFO - PROCESS | 24276 | [#4] RayTrace Cycles:1 Average:1058.20 Median:1058.20 stddev:0.00 (0.0%) 14:25:25 INFO - PROCESS | 24276 | Values: 1058.2 14:25:25 INFO - PROCESS | 24276 | 14:25:25 INFO - PROCESS | 24276 | [#5] Earley Cycles:1 Average:716.85 Median:716.85 stddev:0.00 (0.0%) 14:25:25 INFO - PROCESS | 24276 | Values: 716.8 14:25:25 INFO - PROCESS | 24276 | 14:25:25 INFO - PROCESS | 24276 | [#6] Boyer Cycles:1 Average:12537.50 Median:12537.50 stddev:0.00 (0.0%) 14:25:25 INFO - PROCESS | 24276 | Values: 12537.5 14:25:25 INFO - PROCESS | 24276 | 14:25:25 INFO - PROCESS | 24276 | [#7] RegExp Cycles:1 Average:25550.00 Median:25550.00 stddev:0.00 (0.0%) 14:25:25 INFO - PROCESS | 24276 | Values: 25550.0 14:25:25 INFO - PROCESS | 24276 | 14:25:25 INFO - PROCESS | 24276 | [#8] Splay Cycles:1 Average:668.90 Median:668.90 stddev:0.00 (0.0%) 14:25:25 INFO - PROCESS | 24276 | Values: 668.9 14:25:25 INFO - PROCESS | 24276 | 14:25:25 INFO - PROCESS | 24276 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 14:25:25 INFO - PROCESS | 24276 | Values: 4835.7 14:25:25 INFO - PROCESS | 24276 | -------- Summary: end -------- 14:25:25 INFO - PROCESS | 24276 | 14:25:26 INFO - TEST-INFO | 24276: exit 0 14:25:26 INFO - TEST-OK | v8_7 | took 39680ms 14:25:26 INFO - SUITE-END | took 1210s 14:25:26 INFO - Completed test suite (00:20:11) 14:25:26 INFO - Working with test: dromaeo_css 14:25:26 INFO - Generating results file: dromaeo_css 14:25:26 INFO - Working with test: kraken 14:25:26 INFO - Generating results file: kraken 14:25:26 INFO - javascript benchmark 14:25:26 INFO - Working with test: v8_7 14:25:26 INFO - Generating results file: v8_7 14:25:26 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:25:26 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 14:25:26 INFO - process_Request line: dromaeo_css 6941.91 graph.html#tests=[[72,64,43]] 14:25:26 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:25:26 INFO - process_Request line: kraken 1527.90 graph.html#tests=[[232,64,43]] 14:25:26 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:25:27 INFO - process_Request line: v8_7 21045.75 graph.html#tests=[[230,64,43]] 14:25:27 INFO - RETURN: dromaeo_css: 6941.91 14:25:27 INFO - RETURN: kraken: 1527.90 14:25:27 INFO - RETURN: v8_7: 21045.75 14:25:27 INFO - javascript benchmark 14:25:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3232.935341293174, 3300.8019518828887, 3308.685674860888, 3320.4687250039997, 3351.798892066476, 5267.920981185285, 5451.91822122668, 5466.34403871535, 5472.5621950243985, 5479.452054794524, 5389.164679474688, 5410.188471729242, 5417.0, 5528.806491772789, 5550.666959982404, 4965.826196083147, 5000.674956127858, 5090.770915308802, 5114.360704911886, 5117.539421452068, 4928.97535512322, 4980.875478113058, 5024.422191447994, 5056.317397151374, 5107.0, 4901.705897646153, 4996.500349964975, 5003.824866129668, 5008.3238762767105, 5095.235714642796, 4951.405831300231, 5014.774335154927, 5030.748462576857, 5048.268001139851, 5054.039732450822, 4919.065377578248, 4945.505449455061, 4953.90092198154, 4964.751762411901, 4980.850574482735, 5084.949150508484, 5153.948460515385, 5206.167013277895, 5225.738713064332, 5262.0791361511965, 5898.616589921684, 5904.675242861641, 5905.0, 5914.467697907209, 5936.168936348915, 5949.6430214187285, 5951.642901425928, 5951.970240148815, 5952.315483719384, 5955.404459554054, 5375.3280839895015, 5498.092814685612, 5503.11950087984, 5505.697186654773, 5540.085885828834, 6025.0661147522205, 6032.125341825498, 6089.056196289582, 6118.265808103056, 6140.938590614126, 5855.765769369263, 5862.443067908542, 5865.530757539386, 5874.295084589791, 5880.617759845596, 5769.9711501442225, 5880.588358814927, 5899.17411562373, 5936.821895343147, 5950.196723442366, 5819.272590926134, 5883.852903677443, 5912.024515954819, 5914.083317085859, 5915.645061296336, 5888.205092312483, 5922.111683247547, 5936.079907614327, 5938.851528711731, 5949.553783466257, 4433.889152771207, 4503.729776213438, 4535.183666939983, 4580.65645076614, 4594.954050459452, 4055.5538890721996, 4073.981504623844, 4095.692823038284, 4103.815328310233, 4118.855840045644, 5432.348118225838, 5511.862203444946, 5516.255305533701, 5541.445855414507, 5546.278983732089, 5670.319561652628, 5784.074548072288, 5863.29640443141, 5942.138389933435, 6028.0355143176885, 5456.48163424474, 5457.2359869618285, 5470.070088085035, 5471.835844924579, 5485.533729632946, 4925.21196608541, 4972.254161875748, 4978.0, 4996.875078123004, 5030.572401345927, 5987.371326010793, 6077.453029227391, 6106.72519736613, 6192.040233763774, 6207.410296021961, 5774.2782152230975, 5792.073268277056, 5794.594378393472, 5795.33353664334, 5864.67744274052, 5878.29460464747, 5890.558208134493, 5890.823275301748, 5900.085486749561, 6009.188759517584, 5531.972340138434, 5622.690752008679, 5785.103308987113, 5872.823815285548, 5877.647341159544, 5830.387809279964, 5945.91081133792, 5954.702264886825, 5956.523478121827, 5965.373635768182, 5603.495685388335, 5787.929233091892, 5792.855178620568, 5803.274590676166, 5806.477417032487, 5639.661620302795, 5718.656880587178, 5765.250517432707, 5796.246487956539, 5823.912641310469, 5567.331920169606, 5582.776688932559, 5583.302087239095, 5592.720363981866, 5593.888122237614, 5539.390667026543, 5629.0, 5655.321361436654, 5684.545236381162, 5684.7441865117, 5583.8883222336135, 5690.0, 5703.486686198262, 5709.429057094258, 5728.198052272768], "unit": "score", "name": "dojo.html", "value": 5409.3070543640515}, {"lowerIsBetter": false, "replicates": [532.7070111438708, 540.4136511884604, 563.5885803363542, 570.7488704969813, 573.2519062623278, 35802.641973580256, 36701.44947825778, 36905.44641830371, 36912.0, 37048.25903481929, 38639.80680096603, 39049.804750976204, 39053.80473097638, 39058.41412378816, 39337.21325573487, 8572.485650860937, 8661.870071948926, 8702.042775294713, 8723.432976856484, 8737.25733312666, 8385.119562445916, 8570.74287771368, 8578.699745508908, 8756.562171891412, 8767.430117042371, 8782.956085219565, 8784.51685157316, 8832.779180520507, 8855.0, 8887.066857979917, 8457.915420845775, 8509.234168924795, 8512.106228845974, 8835.646574137027, 8846.911530884674, 8681.218690317839, 8812.0, 8812.647494100229, 8815.823683526358, 8819.823603527893, 39642.40536391956, 39836.80081599573, 39904.201915961516, 39915.201695965916, 40002.0, 3271.1331497153037, 3379.9493007604906, 3381.5773028371455, 3472.930541389158, 3893.3186692329014, 25798.0, 26278.60582091251, 26386.86806565955, 26519.602205966927, 27263.86368068147, 3614.8373323200517, 3625.8368373422995, 3627.7460577759566, 3727.1613886875507, 3764.2283331917165, 183905.0, 184487.0, 185010.99999999866, 185726.0, 186279.0, 42044.579554204676, 42450.78774606107, 61070.0, 61240.387596123466, 61609.383906160365, 40819.795901020305, 40997.385039224435, 41077.91915606282, 41116.58883411127, 41167.1766564673, 13429.0, 13632.522861699794, 13699.45202191921, 13719.382627781573, 13745.931270343584, 11220.831687524693, 11227.550897964153, 11284.266522676, 11285.379304138187, 11290.322580645188, 14115.929420353037, 14142.151470911778, 14460.710785784437, 14466.493672721404, 14525.128492290285, 5736.196932429463, 5758.654480731169, 5844.912326315109, 5854.765809367577, 5889.941100589025, 947.6446332625266, 979.7599588100961, 1018.5772904244803, 1029.5161274201114, 1039.5010395010286, 28210.0, 28501.42997140087, 28630.852686048212, 28684.713152868622, 28842.0, 1043.894414118008, 1048.984265236022, 1114.3035602748282, 1122.5958654884234, 1133.3766428464312, 14790.556283311518, 14806.111633302036, 14917.850821491864, 14964.494829948922, 15029.84830214519, 303396.0, 308097.0, 308547.0, 309829.0, 310549.0, 52013.47986520162, 52547.0, 52547.47452525502, 52692.73653631784, 52876.735616321675, 1326.7014921642747, 1341.7990898146104, 1342.5569562044698, 1357.6130802721177, 1478.9942838869672, 27431.17706468809, 28173.71826281711, 28227.71772282251, 28670.0, 28994.56508152337, 47305.7634711838, 47598.76200618975, 47689.76155119341, 47877.5212247887, 47909.28136078031, 317396.0, 318719.0, 318748.0, 318988.0, 319032.0, 32994.0, 42990.57009429991, 43078.78460607677, 43471.565284346754, 43486.56513434952, 38360.50181789111, 39338.2132357357, 39463.80268098756, 39510.604893950695, 39933.20133597254, 32945.176370590925, 33554.16114597155, 33760.81837135689, 33835.83082084574, 34211.31577368489, 33207.833960831005, 34521.82739086288, 34550.481742774384, 34565.135871602404, 34631.65368346284, 37587.0, 37697.43453848139, 38150.80924595359, 38591.6140838588, 38814.4177837327, 28738.281542961595, 30476.27595285111, 33259.66740332566, 33304.1673958153, 33319.50020749642, 25035.374115647253, 25308.49383012366, 25426.364340891625, 25437.364065898502, 25706.742932570436], "unit": "score", "name": "ext.html", "value": 17622.989147901473}, {"lowerIsBetter": false, "replicates": [355.1494171459355, 367.15554225281863, 367.8307978329967, 368.81374905672635, 372.270350113777, 16734.581635459104, 17069.31722731091, 17438.128093595333, 17742.645147097068, 18218.726719099224, 9963.750906227348, 10268.435236062014, 15833.60415989601, 15966.441174558893, 15991.760123598126, 4782.7847746851385, 5163.690178589297, 5320.7073610951575, 5322.201669749549, 5327.893442131174, 4539.546045395467, 5303.496167864047, 5318.1225097858805, 5323.8136665216725, 5326.3075800145925, 5299.708516031616, 5310.123829568117, 6458.644774537399, 6724.361185687352, 6734.93265067348, 6487.83780405489, 6560.048792925047, 6562.310957349481, 6564.376384243489, 6598.769043083493, 6463.903041454382, 6472.223333200046, 6485.7405703772265, 6495.935040649628, 6509.121268628722, 21559.461013474633, 22548.774512254997, 22653.660195096923, 22735.090596376125, 23294.48585841915, 2265.501589650291, 2267.9319620411416, 2282.657601359793, 2379.298107058422, 2381.868997205153, 14165.858341416557, 14266.64333391663, 14302.725982673599, 14667.63330916725, 14841.257937103102, 1882.7740671119416, 1902.391234804863, 1993.601279744057, 2004.9699254511195, 2006.147387360366, 67246.0, 71660.99999999948, 72697.0, 73485.0, 74266.25733742648, 15303.311350989232, 15324.693506130037, 15412.46056388021, 15435.61410964735, 15498.457553985556, 23731.644025339632, 23731.881340593533, 23949.521009579712, 24010.15964441236, 24044.87977560101, 8547.188017138362, 8620.741377758552, 8658.87011694825, 8673.91326086731, 8728.519931403835, 7390.667419966115, 7415.4798266355265, 7458.85082298351, 7459.589722565311, 7525.887111693329, 7640.312371886445, 7699.692012319444, 7715.228477152352, 7738.148803631596, 7759.224077592308, 2994.2215024093894, 3047.481928072233, 3049.35963447674, 3068.4586811519075, 3086.336437665868, 397.9303621866162, 403.42914775592794, 416.5813357575617, 449.9100179963955, 458.21068726622593, 9941.40351578893, 10456.850256025977, 10563.183801988862, 10563.943605639375, 10776.245662803685, 388.60556535116876, 395.9529233860946, 400.66744601980287, 403.47749664184363, 410.13870871170303, 5521.254630624814, 9468.289878259158, 10133.594656213669, 10137.847932281022, 10156.796864062677, 571517.0, 586115.0, 586535.0, 606438.0, 607597.0, 69635.0, 76507.23492765112, 77147.0, 77166.22833771702, 80006.59996700096, 1085.8154113800515, 1112.6662001399548, 1116.8715597706205, 1118.6811758648746, 1124.932504049776, 14621.63445913818, 14779.704405911607, 14869.330880110205, 14974.700505990037, 15248.847511525186, 24236.51526969486, 28303.0, 34154.316913662085, 34335.828320858236, 34439.0, 44150.0, 44901.77549112234, 45514.544854552354, 45554.54445455636, 46487.76756116198, 8970.102989700978, 9125.817483650157, 9572.856407154037, 9605.855912161463, 9637.9036209637, 11199.66401007971, 11403.201775875608, 15577.68844623124, 16922.576935576708, 16995.83004169992, 13558.661033474242, 13851.515196968057, 13934.163950163023, 14084.788728169291, 14583.19792411385, 14721.631959200677, 14729.92635036818, 14897.0, 15144.54566363011, 15591.922040389725, 14609.123452592878, 14697.485588004369, 14748.188849612945, 15353.385864565293, 15694.607634809221, 9506.144446999802, 9653.613855445703, 9812.0, 9861.457619830979, 9871.851922221316, 10408.0, 12158.635240942785, 14090.436382544583, 14539.781903271249, 14845.851541484446], "unit": "score", "name": "jquery.html", "value": 9100.476217799911}, {"lowerIsBetter": false, "replicates": [1472.602397352715, 1487.4793822162244, 1645.3994292083385, 1744.127936031984, 1786.633740083283, 6658.201015878101, 6678.8664226715555, 7512.887306690404, 7725.9613701931485, 7731.420143489239, 7187.0, 7277.235890231515, 7340.449466290036, 7342.375898048672, 7349.853002939938, 2205.878676672782, 2236.8434209605334, 2239.540894116702, 2250.9887450562724, 2252.1779550464125, 2244.6408574628063, 2275.3856458756127, 2292.6790249365104, 2296.575133600281, 2306.942326441844, 2266.1048885690143, 2268.943276418086, 2279.122537822942, 2287.176616418088, 2312.3756585721844, 2223.655333423322, 2257.9887100564556, 2281.824860197, 2285.2801367569245, 2286.9542609147807, 2226.799588037068, 2245.9326220213256, 2254.4701995031155, 2262.1064679451524, 2264.0377839418347, 7447.702091916317, 7566.243375662445, 7570.848583028309, 7571.318581327707, 7590.8102297443, 4491.7304961702075, 4548.977255113737, 4559.612432943204, 4600.470945841238, 4601.976990115028, 3026.8940587079564, 3032.0903728881467, 3095.349976504937, 3119.641241257239, 3137.325475022881, 941.1717688434203, 956.6890760502795, 981.3572110267786, 993.3493561717015, 995.8506224066448, 10262.384256944608, 10282.434466104361, 10285.228607854366, 10286.588536458532, 10288.794224115476, 4068.4914385701786, 4137.937930931039, 4143.129942712064, 4164.042270277792, 4226.0, 8802.955985220033, 8868.911310886937, 8902.109789021046, 8903.688370906988, 8916.0, 4637.489876113625, 4641.976790116028, 4647.488776234612, 4661.324108004321, 4692.788824502905, 4135.77253251074, 4233.238017156879, 4235.0, 4253.80857861397, 4288.635465985364, 3392.6946574807894, 3421.9486707699402, 3431.553897993245, 3478.7564870458823, 3514.1741690702665, 1065.893410658928, 1069.812782763029, 1069.9090577301017, 1074.414444127952, 1079.4710591809956, 1283.8010108433207, 1291.3156027305542, 1303.178997231757, 1315.8420989481324, 1320.4322141479256, 7032.859342813115, 7083.256258092929, 7103.82240443993, 7111.928880711127, 7166.068411106523, 457.11091926203216, 461.30573486902, 465.28578631800025, 468.69534802378047, 474.03297273562237, 5253.23828044939, 5302.522772950453, 5314.813981510629, 5336.519713225828, 5374.623776335698, 8802.955985220033, 8821.2060914518, 9041.954790226138, 9061.229795467327, 9062.184403403593, 8957.820843583091, 9005.549722513848, 9036.502992335354, 9051.728448146567, 9074.637014519345, 7061.258567850302, 7104.183018952784, 7132.8944013677965, 7133.964330178316, 7162.570245785166, 6826.351496607815, 6834.692438840363, 6841.418479429105, 6894.103766510321, 6903.309669033057, 7885.44801863864, 8084.474509156886, 8092.0, 8093.473924194908, 8149.266566009088, 8200.138985406686, 8283.213094755989, 8335.666573337, 8390.706325278587, 8464.788380290542, 5716.171155182558, 6218.751249949952, 6315.873682526416, 6415.0, 6478.125453063964, 6831.077804496329, 6910.06714093611, 6925.411340035952, 6941.895871562032, 6960.721571137098, 6639.40245377899, 6810.080639113854, 6841.555298905555, 6848.280930502226, 6867.484938629523, 6706.731730730716, 6754.729810807513, 6803.897941530782, 6893.0, 6938.653067346511, 6569.671516424255, 6655.800325990228, 6781.050652908695, 6785.491088168308, 6785.558938668971, 6272.09054687077, 6309.589876658002, 6347.0, 6350.650714210763, 6365.981442969102, 6331.3352098029045, 6339.429451349401, 6362.300146983735, 6390.968045159744, 6392.3927226913365], "unit": "score", "name": "mootools.html", "value": 4266.3304053448865}, {"lowerIsBetter": false, "replicates": [322.3359878649981, 331.57723902024907, 334.1995919772147, 334.8794434003758, 338.11245480613405, 6222.2533296004485, 6228.377162283775, 6239.376062393764, 6249.187605611264, 6433.5174861885425, 6143.600665956709, 6237.0, 6253.405926436993, 6270.059491076341, 6308.495320374371, 4674.415698037746, 4690.718556886581, 4690.812367505313, 4694.0142570060325, 4696.53034696531, 4688.859334219979, 4695.483496815347, 4701.059788042388, 4710.528947105279, 4713.505081966378, 4515.977420112911, 4553.521880202581, 4617.5382461753725, 4650.97674511627, 4658.301254811789, 4598.378924013314, 4625.676202665832, 4629.051044535879, 4642.628589712815, 4686.554777296152, 4027.2750904837117, 4033.495813023372, 4049.514058312992, 4061.472008638858, 4068.206699693561, 5901.085331773582, 5916.112583112525, 5961.672108034057, 5980.461758441761, 5987.251593550806, 5333.280007199056, 5390.110631745757, 5465.617406781527, 5472.425395333473, 5485.314335708036, 6558.573692709959, 6568.376004279586, 6578.572392794501, 6578.901316480256, 6610.7109113722845, 4431.9778401108115, 4480.910381792379, 4482.977585112086, 4492.438445194351, 4492.550744925514, 6768.153980752406, 6870.587764734132, 6895.310468953065, 6939.20199177096, 6944.72221111155, 4563.475200351935, 4564.8402305919135, 4564.954350456519, 4565.977170114194, 4576.771161441915, 4624.329472226508, 4626.236670949323, 4632.143053535106, 4637.211674015425, 4638.605718513897, 5421.512063914267, 5427.45725427462, 5429.158480435539, 5435.701036443033, 5436.130219164994, 6541.901871471931, 6673.899891501631, 6695.230048544382, 6702.832429189211, 6708.698108585126, 1620.23848791068, 1670.4571014420362, 1670.7493875918467, 1671.8411750883647, 1674.9246283917253, 1073.120041565924, 1073.726199819041, 1080.3247970018738, 1082.2153938394758, 1095.59462998691, 6211.223597050369, 6219.502439804804, 6225.097360882647, 6225.875482490324, 6228.688565571703, 6826.965865170642, 6856.6228857413325, 6858.382745552824, 6871.072405225231, 6887.7244910203035, 6100.908486372708, 6220.129181914535, 6222.0355844844125, 6227.875442491125, 6242.968785156136, 3721.330160571069, 3743.981280093582, 3746.9437958430644, 3750.962490375116, 3767.2277183177384, 7125.82185445368, 7156.785296441011, 7167.0, 7187.173475050332, 7204.819879502949, 7015.8596828063155, 7064.364207221375, 7073.964630176816, 7127.679254433563, 7135.0, 7114.786556403316, 7152.499325047301, 7157.1769246537315, 7166.749163779347, 7167.247439018828, 6842.726290948306, 6895.172579290517, 6899.931000689929, 6908.1364829396325, 6908.412784913137, 6692.063111164343, 6812.4890633203695, 6813.625250611264, 6833.043373927555, 6859.725610975505, 7160.248173941661, 7162.391196748126, 7175.964120179366, 7182.3535881770895, 7186.748463803742, 4560.361549383023, 4560.703554268962, 4580.885477862947, 4589.2657174851865, 4593.494715581217, 6797.830054248683, 6906.896396553955, 6909.0, 6910.896336554855, 6926.0, 6695.230048544479, 6701.698423570853, 6707.0945422369305, 6714.362135597111, 6717.865642687021, 6668.299828517936, 6676.699548520425, 6678.198616166092, 6684.4318232950745, 6688.765893193715, 6432.421082102634, 6556.246031706415, 6563.671816409065, 6579.901301480386, 6593.142891424084, 6688.565243259172, 6713.932860671526, 6722.932770672231, 6746.021826834984, 6761.797146085625, 6347.650879201688, 6468.191476065492, 6489.772857949949, 6495.0582165586675, 6524.380183882524], "unit": "score", "name": "prototype.html", "value": 4959.930588528959}, {"lowerIsBetter": false, "replicates": [756.43267549338, 842.8693552499365, 845.6870957745633, 855.4183155454289, 904.1862323908482, 13493.055486115976, 13717.725645487084, 13739.381727822247, 13750.381232844533, 13785.379657915393, 11481.425928703553, 11520.423978801047, 11525.884741152586, 11617.244879082853, 11783.882161178386, 681.1213534540437, 807.0920214758412, 819.9139090395512, 824.3116997307226, 824.7031068815222, 677.3531277629852, 800.9839803203932, 812.3460614205562, 812.8333691593209, 814.0434988888062, 857.618359829876, 857.7726902370877, 863.8315528471951, 864.3301441382947, 868.3227082875368, 854.150120629974, 854.9102344253826, 855.2174760094506, 855.5978690015683, 859.3812455032398, 622.710439645567, 627.1877918096031, 632.3360471504901, 632.3739497897095, 633.2243002322165, 12160.148789584733, 12213.511459541607, 12262.0, 12287.877121228763, 12312.076594255466, 11957.581484648083, 12198.207116537396, 12707.301098439582, 12978.870211297955, 13012.831377553537, 10217.131543818785, 10228.284020118595, 10236.539355728935, 10800.0, 10860.619878304222, 3590.0, 3675.981620091909, 3718.2749363874054, 3770.057485628593, 3780.3573392523335, 42634.360484592755, 42645.78677106595, 42792.0, 43249.78375108104, 43258.56741432577, 9697.321187516805, 9779.217662586976, 9891.851622225673, 10065.0, 10393.0, 17167.227474763666, 17190.570235744206, 17272.877262977865, 17310.221040052977, 17314.047727374862, 7710.421718371144, 7830.451868369273, 7883.0, 7960.522368657899, 7970.681172753141, 4397.714148580332, 4438.489573699001, 4476.26141686618, 4479.664025198123, 4508.18852606534, 3153.921151971219, 3162.177833763238, 3166.904992850218, 3166.936661266762, 3178.618565772122, 578.6990764802364, 597.3667912013193, 598.5929567893787, 638.3616383616384, 657.7960832142052, 587.5681374189967, 604.7973928733835, 620.9037599172135, 640.6828619833212, 679.1748026148254, 7182.748603798842, 7244.746433874894, 7252.2747725227055, 7279.781606551812, 7303.561786292839, 513.5557742552666, 587.4008511318517, 661.8974059020859, 673.4679603113583, 676.668432468097, 3548.3790336690977, 3741.1956429367815, 3862.9806850965565, 3949.8420063197723, 3985.940210896839, 46759.29861052087, 47029.0, 47298.0, 47384.0, 47532.76233618879, 43560.3465948011, 43579.346309805376, 43707.12585748267, 45123.54876451259, 45233.77383113129, 44006.55993440089, 46024.76987615041, 46130.53869461329, 46540.301895471595, 47349.28976065362, 7762.650680719494, 7817.335526480313, 7843.960780196063, 7892.210778922062, 7938.603069846369, 35306.470402943465, 35737.463938041474, 36157.27685446224, 36246.0, 36256.456153157196, 42356.788216058725, 42395.94010149771, 44062.0, 45864.54135458603, 45864.77067614641, 10555.68332949982, 10661.253712240068, 10692.0, 10885.339623395948, 11133.888661113286, 11712.180147389601, 12005.0, 12010.219335743148, 12032.578859739868, 12153.817692734792, 9669.226461883172, 10116.494175291353, 10232.130268926927, 10323.587056517956, 10324.328918620266, 9657.75528905542, 10229.386236825814, 10418.583256669648, 10454.163666906477, 10459.0, 10459.790804184026, 10545.10366618846, 10569.947150264199, 10570.947145264225, 10757.838632420364, 9329.813403732023, 9592.23262139041, 9963.601455941971, 10072.244581656552, 10083.445410502492, 8094.676212951416, 8450.408471406943, 8731.345149113715, 9029.142231487998, 9085.682001130193], "unit": "score", "name": "yui.html", "value": 6095.628621583523}], "name": "dromaeo_css", "value": 6941.904449230722}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 106.0, 112.0, 112.0, 110.0, 124.0, 112.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 112.0}, {"lowerIsBetter": true, "replicates": [150.0, 135.0, 164.0, 166.0, 126.0, 155.0, 160.0, 130.0, 165.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 147.8}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 161.0, 163.0, 164.0, 163.0, 165.0, 164.0, 170.0, 160.0], "unit": "score", "name": "audio-dft", "value": 163.2}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 75.0, 71.0, 72.0, 74.0, 154.0, 74.0, 73.0], "unit": "score", "name": "audio-fft", "value": 81.1}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 141.0, 96.0, 96.0, 97.0, 141.0, 97.0, 96.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [110.0, 112.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 148.0, 145.0, 146.0, 147.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 63.0, 59.0, 61.0, 60.0, 59.0, 59.0, 56.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 59.5}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 67.0, 68.0, 68.0, 70.0, 70.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [86.0, 95.0, 87.0, 86.0, 88.0, 90.0, 87.0, 87.0, 94.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.8}, {"lowerIsBetter": true, "replicates": [124.0, 123.0, 127.0, 118.0, 122.0, 121.0, 120.0, 121.0, 120.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.4}, {"lowerIsBetter": true, "replicates": [147.0, 159.0, 164.0, 158.0, 162.0, 145.0, 153.0, 153.0, 154.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.8}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 67.0, 72.0, 69.0, 68.0, 69.0, 70.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1527.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.2800267648043], "unit": "score", "name": "Richards", "value": 211.03535600000004}, {"lowerIsBetter": false, "replicates": [190.5850962454736], "unit": "score", "name": "DeltaBlue", "value": 346.9211459999999}, {"lowerIsBetter": false, "replicates": [280.1120448179272], "unit": "score", "name": "Encrypt", "value": 950.2661699999999}, {"lowerIsBetter": false, "replicates": [5213.541666666667], "unit": "score", "name": "Decrypt", "value": 51.05569630369634}, {"lowerIsBetter": false, "replicates": [1058.2010582010582], "unit": "score", "name": "RayTrace", "value": 699.2896049999997}, {"lowerIsBetter": false, "replicates": [716.8458781362007], "unit": "score", "name": "Earley", "value": 929.7158849999997}, {"lowerIsBetter": false, "replicates": [12537.5], "unit": "score", "name": "Boyer", "value": 53.15756729810566}, {"lowerIsBetter": false, "replicates": [25550.0], "unit": "score", "name": "RegExp", "value": 35.65499021526421}, {"lowerIsBetter": false, "replicates": [668.8963210702341], "unit": "score", "name": "Splay", "value": 121.82904500000001}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21045.748446158086}]} 14:25:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21045.75"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1527.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6941.91"}}} 14:25:27 INFO - Return code: 0 14:25:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:25:27 INFO - # TBPL SUCCESS # 14:25:27 INFO - Running post-action listener: _resource_record_post_action 14:25:27 INFO - Running post-run listener: _resource_record_post_run 14:25:28 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 20480; Write bytes: 573460480; Read time: 412; Write time: 689140 14:25:28 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 254107648; Read time: 0; Write time: 424772 14:25:28 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 20480; Write bytes: 319102976; Read time: 412; Write time: 264320 14:25:28 INFO - Running post-run listener: _upload_blobber_files 14:25:28 INFO - Blob upload gear active. 14:25:28 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:25:28 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 14:25:28 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'] 14:25:28 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 14:25:28 INFO - (blobuploader) - INFO - Open directory for files ... 14:25:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:25:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:25:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:25:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:25:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:25:29 INFO - (blobuploader) - INFO - Done attempting. 14:25:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:25:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:25:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:25:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:25:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:25:30 INFO - (blobuploader) - INFO - Done attempting. 14:25:30 INFO - (blobuploader) - INFO - Iteration through files over. 14:25:30 INFO - Return code: 0 14:25:30 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:25:30 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:25:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/19b421e19a1947edcaa003fb7954e4f5c501303240de79cb0e2ab72a4c7b9aa6be195b0b1e434d77559f50b5c8bfcdb1ca733a4b44bb58e25106bc69eca5d8c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/89d813bd83558ae891ec26dbcdeafc250b36774bb4194c6a872de1ade3b9662494178e6f52910afb356cb2a19848c16d3c0aecdc9929903dba285ba901f80b1f"} 14:25:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:25:30 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:25:30 INFO - Contents: 14:25:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/19b421e19a1947edcaa003fb7954e4f5c501303240de79cb0e2ab72a4c7b9aa6be195b0b1e434d77559f50b5c8bfcdb1ca733a4b44bb58e25106bc69eca5d8c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/89d813bd83558ae891ec26dbcdeafc250b36774bb4194c6a872de1ade3b9662494178e6f52910afb356cb2a19848c16d3c0aecdc9929903dba285ba901f80b1f"} 14:25:30 INFO - Copying logs to upload dir... 14:25:30 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.766552 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-01-06 14:25:30.215118) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 14:25:30.218432) ========= 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=5bd038846534b2fdfa68eeae000001e2-1452117863.174334-484082236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/19b421e19a1947edcaa003fb7954e4f5c501303240de79cb0e2ab72a4c7b9aa6be195b0b1e434d77559f50b5c8bfcdb1ca733a4b44bb58e25106bc69eca5d8c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/89d813bd83558ae891ec26dbcdeafc250b36774bb4194c6a872de1ade3b9662494178e6f52910afb356cb2a19848c16d3c0aecdc9929903dba285ba901f80b1f"} build_url:https://queue.taskcluster.net/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011341 build_url: 'https://queue.taskcluster.net/v1/task/XyuEttQdQ4WZvqepU4Slzg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/19b421e19a1947edcaa003fb7954e4f5c501303240de79cb0e2ab72a4c7b9aa6be195b0b1e434d77559f50b5c8bfcdb1ca733a4b44bb58e25106bc69eca5d8c4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/89d813bd83558ae891ec26dbcdeafc250b36774bb4194c6a872de1ade3b9662494178e6f52910afb356cb2a19848c16d3c0aecdc9929903dba285ba901f80b1f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 14:25:30.243651) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 14:25:30.243979) ========= 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=5bd038846534b2fdfa68eeae000001e2-1452117863.174334-484082236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 14:25:30.325972) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 14:25:30.326344) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 14:25:30.326670) ========= ========= Total master_lag: 0.19 =========