builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-042 starttime: 1451405187.08 results: success (0) buildid: 20151229053002 builduid: 7e09d7ae42ec418bbb83db038f024940 revision: 6dbba51c24d2386624557368feaed125e5a32a63 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 08:06:27.076681) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 08:06:27.077140) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 08:06:27.077446) ========= 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=c402a24d74c70935940d60dd000001de-1451404187.464945-957839501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006283 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 08:06:27.101915) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 08:06:27.102209) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 08:06:27.120765) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 08:06:27.121127) ========= 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=c402a24d74c70935940d60dd000001de-1451404187.464945-957839501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004636 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 08:06:27.172333) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 08:06:27.172748) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 08:06:27.173375) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 08:06:27.173663) ========= 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=c402a24d74c70935940d60dd000001de-1451404187.464945-957839501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-29 08:06:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2015-12-29 08:06:27 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163975 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 08:06:27.353387) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 08:06:27.353720) ========= 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=c402a24d74c70935940d60dd000001de-1451404187.464945-957839501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018859 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 08:06:27.403041) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 08:06:27.403400) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6dbba51c24d2386624557368feaed125e5a32a63 --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 6dbba51c24d2386624557368feaed125e5a32a63 --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=c402a24d74c70935940d60dd000001de-1451404187.464945-957839501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-29 08:06:28,061 truncating revision to first 12 chars 2015-12-29 08:06:28,061 Setting DEBUG logging. 2015-12-29 08:06:28,061 attempt 1/10 2015-12-29 08:06:28,061 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6dbba51c24d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-29 08:06:28,291 unpacking tar archive at: fx-team-6dbba51c24d2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.553907 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 08:06:27.970164) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 08:06:27.970468) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 08:06:28.226696) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 08:06:28.227077) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 08:06:28.227524) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-29 08:06:28.227813) ========= /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=c402a24d74c70935940d60dd000001de-1451404187.464945-957839501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:06:28 INFO - MultiFileLogger online at 20151229 08:06:28 in /builds/slave/test-pgo 08:06:28 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 08:06:28 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:06:28 INFO - {'append_to_log': False, 08:06:28 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:06:28 INFO - 'blob_upload_branch': 'Fx-Team', 08:06:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:06:28 INFO - 'branch': 'Fx-Team', 08:06:28 INFO - 'buildbot_json_path': 'buildprops.json', 08:06:28 INFO - 'config_files': ('talos/linux_config.py',), 08:06:28 INFO - 'default_actions': ('clobber', 08:06:28 INFO - 'read-buildbot-config', 08:06:28 INFO - 'download-and-extract', 08:06:28 INFO - 'populate-webroot', 08:06:28 INFO - 'create-virtualenv', 08:06:28 INFO - 'install', 08:06:28 INFO - 'run-tests'), 08:06:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:06:28 INFO - 'download_minidump_stackwalk': True, 08:06:28 INFO - 'download_symbols': 'ondemand', 08:06:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:06:28 INFO - 'tooltool.py': '/tools/tooltool.py', 08:06:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:06:28 INFO - '/tools/misc-python/virtualenv.py')}, 08:06:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:06:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:06:28 INFO - 'installer_path': 'installer.exe', 08:06:28 INFO - 'log_level': 'info', 08:06:28 INFO - 'log_name': 'talos', 08:06:28 INFO - 'log_to_console': True, 08:06:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:06:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:06:28 INFO - 'opt_config_files': (), 08:06:28 INFO - 'pip_index': False, 08:06:28 INFO - 'sps_profile': False, 08:06:28 INFO - 'sps_profile_interval': 0, 08:06:28 INFO - 'suite': 'dromaeojs-e10s', 08:06:28 INFO - 'system_bits': '32', 08:06:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:06:28 INFO - 'title': 'talos-linux64-ix-042', 08:06:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:06:28 INFO - 'use_talos_json': True, 08:06:28 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:06:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:06:28 INFO - 'work_dir': 'build'} 08:06:28 INFO - ##### 08:06:28 INFO - ##### Running clobber step. 08:06:28 INFO - ##### 08:06:28 INFO - Running pre-action listener: _resource_record_pre_action 08:06:28 INFO - Running main action method: clobber 08:06:28 INFO - rmtree: /builds/slave/test-pgo/build 08:06:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:06:29 INFO - Running post-action listener: _resource_record_post_action 08:06:29 INFO - ##### 08:06:29 INFO - ##### Running read-buildbot-config step. 08:06:29 INFO - ##### 08:06:29 INFO - Running pre-action listener: _resource_record_pre_action 08:06:29 INFO - Running main action method: read_buildbot_config 08:06:29 INFO - Using buildbot properties: 08:06:29 INFO - { 08:06:29 INFO - "project": "", 08:06:29 INFO - "product": "firefox", 08:06:29 INFO - "script_repo_revision": "production", 08:06:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:06:29 INFO - "repository": "", 08:06:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:06:29 INFO - "buildid": "20151229053002", 08:06:29 INFO - "pgo_build": "True", 08:06:29 INFO - "basedir": "/builds/slave/test-pgo", 08:06:29 INFO - "buildnumber": 411, 08:06:29 INFO - "slavename": "talos-linux64-ix-042", 08:06:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:06:29 INFO - "platform": "ubuntu64_hw", 08:06:29 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:06:29 INFO - "branch": "fx-team", 08:06:29 INFO - "repo_path": "integration/fx-team", 08:06:29 INFO - "revision": "6dbba51c24d2386624557368feaed125e5a32a63", 08:06:29 INFO - "stage_platform": "linux64-pgo", 08:06:29 INFO - "builduid": "7e09d7ae42ec418bbb83db038f024940", 08:06:29 INFO - "slavebuilddir": "test" 08:06:29 INFO - } 08:06:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/AV-VpCeaRW2-bmk2vBRtcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:06:29 INFO - Running post-action listener: _resource_record_post_action 08:06:29 INFO - ##### 08:06:29 INFO - ##### Running download-and-extract step. 08:06:29 INFO - ##### 08:06:29 INFO - Running pre-action listener: _resource_record_pre_action 08:06:29 INFO - Running main action method: download_and_extract 08:06:29 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:06: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')]} 08:06:29 INFO - https://queue.taskcluster.net/v1/task/AV-VpCeaRW2-bmk2vBRtcw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:06:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AV-VpCeaRW2-bmk2vBRtcw/artifacts/public/build/test_packages.json 08:06:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AV-VpCeaRW2-bmk2vBRtcw/artifacts/public/build/test_packages.json 08:06:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AV-VpCeaRW2-bmk2vBRtcw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:06:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AV-VpCeaRW2-bmk2vBRtcw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:06:30 INFO - Downloaded 1302 bytes. 08:06:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:06:30 INFO - Using the following test package requirements: 08:06:30 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:06:30 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:06:30 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:30 INFO - u'jsshell-linux-x86_64.zip'], 08:06:30 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:06:30 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:06:30 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:06:30 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:06:30 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:06:30 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:06:30 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:06:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:30 INFO - https://queue.taskcluster.net/v1/task/AV-VpCeaRW2-bmk2vBRtcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:06:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AV-VpCeaRW2-bmk2vBRtcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:06:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AV-VpCeaRW2-bmk2vBRtcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:06:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AV-VpCeaRW2-bmk2vBRtcw/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 08:06:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AV-VpCeaRW2-bmk2vBRtcw/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 08:06:32 INFO - Downloaded 23193496 bytes. 08:06:32 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 08:06:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:06:32 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 08:06:33 INFO - Return code: 0 08:06:33 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 08:06: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')]} 08:06:33 INFO - https://queue.taskcluster.net/v1/task/AV-VpCeaRW2-bmk2vBRtcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:06:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AV-VpCeaRW2-bmk2vBRtcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:06:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AV-VpCeaRW2-bmk2vBRtcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:06:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AV-VpCeaRW2-bmk2vBRtcw/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 08:06:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AV-VpCeaRW2-bmk2vBRtcw/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 08:06:34 INFO - Downloaded 23193496 bytes. 08:06:34 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 08:06:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:06:34 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 08:06:35 INFO - Return code: 0 08:06:35 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')]} 08:06:35 INFO - https://queue.taskcluster.net/v1/task/AV-VpCeaRW2-bmk2vBRtcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:06:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AV-VpCeaRW2-bmk2vBRtcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:06:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AV-VpCeaRW2-bmk2vBRtcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:06:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AV-VpCeaRW2-bmk2vBRtcw/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 08:06:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AV-VpCeaRW2-bmk2vBRtcw/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 08:06:37 INFO - Downloaded 11132270 bytes. 08:06:37 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 08:06:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:06:37 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 08:06:37 INFO - Return code: 0 08:06: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')]} 08:06:37 INFO - https://queue.taskcluster.net/v1/task/AV-VpCeaRW2-bmk2vBRtcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:06:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AV-VpCeaRW2-bmk2vBRtcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:06:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AV-VpCeaRW2-bmk2vBRtcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:06:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AV-VpCeaRW2-bmk2vBRtcw/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 08:06:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AV-VpCeaRW2-bmk2vBRtcw/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 08:06:40 INFO - Downloaded 54902913 bytes. 08:06:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AV-VpCeaRW2-bmk2vBRtcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:06:40 INFO - mkdir: /builds/slave/test-pgo/properties 08:06:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:06:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:06:40 INFO - Contents: 08:06:40 INFO - build_url:https://queue.taskcluster.net/v1/task/AV-VpCeaRW2-bmk2vBRtcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:06:40 INFO - Running post-action listener: _resource_record_post_action 08:06:40 INFO - Running post-action listener: set_extra_try_arguments 08:06:40 INFO - ##### 08:06:40 INFO - ##### Running populate-webroot step. 08:06:40 INFO - ##### 08:06:40 INFO - Running pre-action listener: _resource_record_pre_action 08:06:40 INFO - Running main action method: populate_webroot 08:06:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:06:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:06:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:06:40 INFO - '--tppagecycles', 08:06:40 INFO - '7'], 08:06:40 INFO - 'tests': ['tsvgm']}}, 08:06:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:06:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:06:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:06:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:06:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:06:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:06:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:06:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:40 INFO - 'talos_options': ['--e10s'], 08:06:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:06:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:40 INFO - 'tests': ['damp', 'tps']}, 08:06:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:40 INFO - 'talos_options': ['--e10s'], 08:06:40 INFO - 'tests': ['damp', 'tps']}, 08:06:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:06:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:06:40 INFO - 'other': {'tests': ['a11yr', 08:06:40 INFO - 'ts_paint', 08:06:40 INFO - 'tpaint', 08:06:40 INFO - 'sessionrestore', 08:06:40 INFO - 'sessionrestore_no_auto_restore']}, 08:06:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:06:40 INFO - 'tests': ['a11yr', 08:06:40 INFO - 'ts_paint', 08:06:40 INFO - 'tpaint', 08:06:40 INFO - 'sessionrestore', 08:06:40 INFO - 'sessionrestore_no_auto_restore']}, 08:06:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:06:40 INFO - 'tests': ['a11yr', 08:06:40 INFO - 'ts_paint', 08:06:40 INFO - 'tpaint', 08:06:40 INFO - 'sessionrestore', 08:06:40 INFO - 'sessionrestore_no_auto_restore']}, 08:06:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:06:40 INFO - 'tests': ['a11yr', 08:06:40 INFO - 'ts_paint', 08:06:40 INFO - 'tpaint', 08:06:40 INFO - 'sessionrestore', 08:06:40 INFO - 'sessionrestore_no_auto_restore']}, 08:06:40 INFO - 'other_l64': {'tests': ['a11yr', 08:06:40 INFO - 'ts_paint', 08:06:40 INFO - 'tpaint', 08:06:40 INFO - 'sessionrestore', 08:06:40 INFO - 'sessionrestore_no_auto_restore']}, 08:06:40 INFO - 'other_nol64': {'tests': ['a11yr', 08:06:40 INFO - 'ts_paint', 08:06:40 INFO - 'tpaint', 08:06:40 INFO - 'sessionrestore', 08:06:40 INFO - 'sessionrestore_no_auto_restore']}, 08:06:40 INFO - 'svgr': {'tests': ['tsvgx', 08:06:40 INFO - 'tsvgr_opacity', 08:06:40 INFO - 'tart', 08:06:40 INFO - 'tscrollx', 08:06:40 INFO - 'cart']}, 08:06:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:06:40 INFO - 'tests': ['tsvgx', 08:06:40 INFO - 'tsvgr_opacity', 08:06:40 INFO - 'tart', 08:06:40 INFO - 'tscrollx', 08:06:40 INFO - 'cart']}, 08:06:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:40 INFO - 'tests': ['tp5o']}, 08:06:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:40 INFO - 'talos_options': ['--e10s'], 08:06:40 INFO - 'tests': ['tp5o']}, 08:06:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:40 INFO - 'talos_options': ['--xperf_path', 08:06:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:06:40 INFO - 'tests': ['tp5n']}, 08:06:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:40 INFO - 'talos_options': ['--e10s', 08:06:40 INFO - '--xperf_path', 08:06:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:06:40 INFO - 'tests': ['tp5n']}}, 08:06:40 INFO - 'talos.zip': {'path': '', 08:06:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:06:40 INFO - Running post-action listener: _resource_record_post_action 08:06:40 INFO - ##### 08:06:40 INFO - ##### Running create-virtualenv step. 08:06:40 INFO - ##### 08:06:40 INFO - Running pre-action listener: _resource_record_pre_action 08:06:40 INFO - Running main action method: create_virtualenv 08:06:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:06:40 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 08:06:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:06:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:06:41 INFO - Using real prefix '/usr' 08:06:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:06:41 INFO - Installing distribute.............................................................................................................................................................................................done. 08:06:43 INFO - Installing pip.................done. 08:06:43 INFO - Return code: 0 08:06:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:06:43 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')]} 08:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:43 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')]} 08:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:43 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 0x7f9b0e65bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2459480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e8660>, '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 0x24e9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e9a10>, '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': 'c402a24d74c70935940d60dd000001de-1451404187.464945-957839501', '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 08:06:43 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 08:06:43 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 08:06:43 INFO - Using env: {'DISPLAY': ':0', 08:06:43 INFO - 'HOME': '/home/cltbld', 08:06:43 INFO - 'LANG': 'en_US.UTF-8', 08:06:43 INFO - 'LANGUAGE': 'en_US:en', 08:06:43 INFO - 'LOGNAME': 'cltbld', 08:06:43 INFO - 'MAIL': '/var/mail/cltbld', 08:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:43 INFO - 'MOZ_NO_REMOTE': '1', 08:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:43 INFO - 'NO_EM_RESTART': '1', 08:06:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:06:43 INFO - 'PWD': '/builds/slave/test-pgo', 08:06:43 INFO - 'SHELL': '/bin/bash', 08:06:43 INFO - 'SHLVL': '1', 08:06:43 INFO - 'TERM': 'linux', 08:06:43 INFO - 'TMOUT': '86400', 08:06:43 INFO - 'USER': 'cltbld', 08:06:43 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1451404187.464945-957839501', 08:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:43 INFO - '_': '/tools/buildbot/bin/python'} 08:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:43 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 08:06:43 INFO - Cleaning up... 08:06:43 INFO - Return code: 0 08:06:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:06:43 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')]} 08:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:43 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')]} 08:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:43 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 0x7f9b0e65bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2459480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e8660>, '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 0x24e9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e9a10>, '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': 'c402a24d74c70935940d60dd000001de-1451404187.464945-957839501', '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 08:06:43 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 08:06:43 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 08:06:43 INFO - Using env: {'DISPLAY': ':0', 08:06:43 INFO - 'HOME': '/home/cltbld', 08:06:43 INFO - 'LANG': 'en_US.UTF-8', 08:06:43 INFO - 'LANGUAGE': 'en_US:en', 08:06:43 INFO - 'LOGNAME': 'cltbld', 08:06:43 INFO - 'MAIL': '/var/mail/cltbld', 08:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:43 INFO - 'MOZ_NO_REMOTE': '1', 08:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:43 INFO - 'NO_EM_RESTART': '1', 08:06:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:06:43 INFO - 'PWD': '/builds/slave/test-pgo', 08:06:43 INFO - 'SHELL': '/bin/bash', 08:06:43 INFO - 'SHLVL': '1', 08:06:43 INFO - 'TERM': 'linux', 08:06:43 INFO - 'TMOUT': '86400', 08:06:43 INFO - 'USER': 'cltbld', 08:06:43 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1451404187.464945-957839501', 08:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:43 INFO - '_': '/tools/buildbot/bin/python'} 08:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:43 INFO - Downloading/unpacking psutil>=0.7.1 08:06: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 08:06: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 08:06: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 08:06: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 08:06: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 08:06: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 08:06:45 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 08:06:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:06:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:06:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:06:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:06:45 INFO - Installing collected packages: psutil 08:06:45 INFO - Running setup.py install for psutil 08:06:45 INFO - building 'psutil._psutil_linux' extension 08:06:45 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 08:06:45 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 08:06:45 INFO - building 'psutil._psutil_posix' extension 08:06:45 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 08:06:46 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 08:06:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:06:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:06:46 INFO - Successfully installed psutil 08:06:46 INFO - Cleaning up... 08:06:46 INFO - Return code: 0 08:06:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:06: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')]} 08:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06: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')]} 08:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:46 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 0x7f9b0e65bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2459480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e8660>, '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 0x24e9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e9a10>, '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': 'c402a24d74c70935940d60dd000001de-1451404187.464945-957839501', '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 08:06:46 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 08:06:46 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 08:06:46 INFO - Using env: {'DISPLAY': ':0', 08:06:46 INFO - 'HOME': '/home/cltbld', 08:06:46 INFO - 'LANG': 'en_US.UTF-8', 08:06:46 INFO - 'LANGUAGE': 'en_US:en', 08:06:46 INFO - 'LOGNAME': 'cltbld', 08:06:46 INFO - 'MAIL': '/var/mail/cltbld', 08:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:46 INFO - 'MOZ_NO_REMOTE': '1', 08:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:46 INFO - 'NO_EM_RESTART': '1', 08:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:06:46 INFO - 'PWD': '/builds/slave/test-pgo', 08:06:46 INFO - 'SHELL': '/bin/bash', 08:06:46 INFO - 'SHLVL': '1', 08:06:46 INFO - 'TERM': 'linux', 08:06:46 INFO - 'TMOUT': '86400', 08:06:46 INFO - 'USER': 'cltbld', 08:06:46 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1451404187.464945-957839501', 08:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:46 INFO - '_': '/tools/buildbot/bin/python'} 08:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:06:46 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 08:06:46 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 08:06:46 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 08:06:46 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 08:06:46 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 08:06:46 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 08:06:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:06:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:06:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:06:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:06:48 INFO - Installing collected packages: mozsystemmonitor 08:06:48 INFO - Running setup.py install for mozsystemmonitor 08:06:48 INFO - Successfully installed mozsystemmonitor 08:06:48 INFO - Cleaning up... 08:06:48 INFO - Return code: 0 08:06:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:06:48 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')]} 08:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:48 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')]} 08:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:48 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 0x7f9b0e65bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2459480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e8660>, '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 0x24e9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e9a10>, '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': 'c402a24d74c70935940d60dd000001de-1451404187.464945-957839501', '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 08:06:48 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 08:06:48 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 08:06:48 INFO - Using env: {'DISPLAY': ':0', 08:06:48 INFO - 'HOME': '/home/cltbld', 08:06:48 INFO - 'LANG': 'en_US.UTF-8', 08:06:48 INFO - 'LANGUAGE': 'en_US:en', 08:06:48 INFO - 'LOGNAME': 'cltbld', 08:06:48 INFO - 'MAIL': '/var/mail/cltbld', 08:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:48 INFO - 'MOZ_NO_REMOTE': '1', 08:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:48 INFO - 'NO_EM_RESTART': '1', 08:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:06:48 INFO - 'PWD': '/builds/slave/test-pgo', 08:06:48 INFO - 'SHELL': '/bin/bash', 08:06:48 INFO - 'SHLVL': '1', 08:06:48 INFO - 'TERM': 'linux', 08:06:48 INFO - 'TMOUT': '86400', 08:06:48 INFO - 'USER': 'cltbld', 08:06:48 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1451404187.464945-957839501', 08:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:48 INFO - '_': '/tools/buildbot/bin/python'} 08:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:48 INFO - Downloading/unpacking blobuploader==1.2.4 08:06:48 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 08:06:48 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 08:06:48 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 08:06:48 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 08:06:48 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 08:06:48 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 08:06:50 INFO - Downloading blobuploader-1.2.4.tar.gz 08:06:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:06:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:06:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:06: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 08:06: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 08:06: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 08:06: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 08:06: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 08:06: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 08:06:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:06:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:06:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:06: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 08:06: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 08:06: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 08:06: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 08:06: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 08:06: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 08:06:50 INFO - Downloading docopt-0.6.1.tar.gz 08:06:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:06:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:06:50 INFO - Installing collected packages: blobuploader, requests, docopt 08:06:50 INFO - Running setup.py install for blobuploader 08:06:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:06:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:06:51 INFO - Running setup.py install for requests 08:06:51 INFO - Running setup.py install for docopt 08:06:51 INFO - Successfully installed blobuploader requests docopt 08:06:51 INFO - Cleaning up... 08:06:51 INFO - Return code: 0 08:06:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:51 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 0x7f9b0e65bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2459480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e8660>, '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 0x24e9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e9a10>, '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': 'c402a24d74c70935940d60dd000001de-1451404187.464945-957839501', '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 08:06:51 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 08:06:51 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 08:06:51 INFO - Using env: {'DISPLAY': ':0', 08:06:51 INFO - 'HOME': '/home/cltbld', 08:06:51 INFO - 'LANG': 'en_US.UTF-8', 08:06:51 INFO - 'LANGUAGE': 'en_US:en', 08:06:51 INFO - 'LOGNAME': 'cltbld', 08:06:51 INFO - 'MAIL': '/var/mail/cltbld', 08:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:51 INFO - 'MOZ_NO_REMOTE': '1', 08:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:51 INFO - 'NO_EM_RESTART': '1', 08:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:06:51 INFO - 'PWD': '/builds/slave/test-pgo', 08:06:51 INFO - 'SHELL': '/bin/bash', 08:06:51 INFO - 'SHLVL': '1', 08:06:51 INFO - 'TERM': 'linux', 08:06:51 INFO - 'TMOUT': '86400', 08:06:51 INFO - 'USER': 'cltbld', 08:06:51 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1451404187.464945-957839501', 08:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:51 INFO - '_': '/tools/buildbot/bin/python'} 08:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:06:51 INFO - Running setup.py (path:/tmp/pip-OqPh7X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:06:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:06:51 INFO - Running setup.py (path:/tmp/pip-V6AdhW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:06:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:06:51 INFO - Running setup.py (path:/tmp/pip-10BFeo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:06:52 INFO - Running setup.py (path:/tmp/pip-HaUuS0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:06:52 INFO - Running setup.py (path:/tmp/pip-du3dQV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:06:52 INFO - Running setup.py (path:/tmp/pip-XKxzaT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:06:52 INFO - Running setup.py (path:/tmp/pip-KQuSga-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:06:52 INFO - Running setup.py (path:/tmp/pip-t2DJcc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:06:52 INFO - Running setup.py (path:/tmp/pip-jbiGb0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:06:52 INFO - Running setup.py (path:/tmp/pip-HxGfmk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:06:52 INFO - Running setup.py (path:/tmp/pip-cZnexQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:06:52 INFO - Running setup.py (path:/tmp/pip-19hzP7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:06:52 INFO - Running setup.py (path:/tmp/pip-CTFEQd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:06:52 INFO - Running setup.py (path:/tmp/pip-ZXWI0i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:06:52 INFO - Running setup.py (path:/tmp/pip-oPanId-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:06:52 INFO - Running setup.py (path:/tmp/pip-V50N9c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:06:52 INFO - Running setup.py (path:/tmp/pip-l6p8Lr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:06:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:06:53 INFO - Running setup.py install for manifestparser 08:06:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:06:53 INFO - Running setup.py install for mozcrash 08:06:53 INFO - Running setup.py install for mozdebug 08:06:53 INFO - Running setup.py install for mozdevice 08:06:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:06:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:06:53 INFO - Running setup.py install for mozfile 08:06:53 INFO - Running setup.py install for mozhttpd 08:06:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:06:53 INFO - Running setup.py install for mozinfo 08:06:53 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:06:53 INFO - Running setup.py install for mozInstall 08:06:53 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:06:53 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:06:53 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:06:53 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:06:53 INFO - Running setup.py install for mozleak 08:06:53 INFO - Running setup.py install for mozlog 08:06:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:06:54 INFO - Running setup.py install for moznetwork 08:06:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:06:54 INFO - Running setup.py install for mozprocess 08:06:54 INFO - Running setup.py install for mozprofile 08:06:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:06:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:06:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:06:54 INFO - Running setup.py install for mozrunner 08:06:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:06:54 INFO - Running setup.py install for mozscreenshot 08:06:54 INFO - Running setup.py install for moztest 08:06:54 INFO - Running setup.py install for mozversion 08:06:54 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:06:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:06:54 INFO - Cleaning up... 08:06:54 INFO - Return code: 0 08:06:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f9b0e65bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2459480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e8660>, '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 0x24e9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e9a10>, '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': 'c402a24d74c70935940d60dd000001de-1451404187.464945-957839501', '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 08:06:54 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 08:06:54 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 08:06:54 INFO - Using env: {'DISPLAY': ':0', 08:06:54 INFO - 'HOME': '/home/cltbld', 08:06:54 INFO - 'LANG': 'en_US.UTF-8', 08:06:54 INFO - 'LANGUAGE': 'en_US:en', 08:06:54 INFO - 'LOGNAME': 'cltbld', 08:06:54 INFO - 'MAIL': '/var/mail/cltbld', 08:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:54 INFO - 'MOZ_NO_REMOTE': '1', 08:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:54 INFO - 'NO_EM_RESTART': '1', 08:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:06:54 INFO - 'PWD': '/builds/slave/test-pgo', 08:06:54 INFO - 'SHELL': '/bin/bash', 08:06:54 INFO - 'SHLVL': '1', 08:06:54 INFO - 'TERM': 'linux', 08:06:54 INFO - 'TMOUT': '86400', 08:06:54 INFO - 'USER': 'cltbld', 08:06:54 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1451404187.464945-957839501', 08:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:54 INFO - '_': '/tools/buildbot/bin/python'} 08:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:06:54 INFO - Running setup.py (path:/tmp/pip-GN2F0C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:06:55 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)) 08:06:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:06:55 INFO - Running setup.py (path:/tmp/pip-kvFxeF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:06:55 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)) 08:06:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:06:55 INFO - Running setup.py (path:/tmp/pip-yULOaA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:06:55 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)) 08:06:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:06:55 INFO - Running setup.py (path:/tmp/pip-R4tl0z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:06:55 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)) 08:06:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:06:55 INFO - Running setup.py (path:/tmp/pip-RrjWak-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:06:55 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)) 08:06:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:06:55 INFO - Running setup.py (path:/tmp/pip-9PIqPs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:06:55 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)) 08:06:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:06:55 INFO - Running setup.py (path:/tmp/pip-cN6tCb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:06:55 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)) 08:06:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:06:55 INFO - Running setup.py (path:/tmp/pip-4Vq34o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:06:55 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)) 08:06:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:06:55 INFO - Running setup.py (path:/tmp/pip-TkHDYn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:06:55 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)) 08:06:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:06:55 INFO - Running setup.py (path:/tmp/pip-7zrR15-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:06:55 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)) 08:06:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:06:55 INFO - Running setup.py (path:/tmp/pip-MaUPxK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:06:55 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)) 08:06:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:06:55 INFO - Running setup.py (path:/tmp/pip-OuF6vv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:06:55 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)) 08:06:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:06:55 INFO - Running setup.py (path:/tmp/pip-MX1EoC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:06:55 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)) 08:06:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:06:55 INFO - Running setup.py (path:/tmp/pip-osT8Nt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:06:56 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)) 08:06:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:06:56 INFO - Running setup.py (path:/tmp/pip-h0uHJU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:06:56 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)) 08:06:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:06:56 INFO - Running setup.py (path:/tmp/pip-xPh99E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:06:56 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)) 08:06:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:06:56 INFO - Running setup.py (path:/tmp/pip-NJ0VWY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:06:56 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)) 08:06:56 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)) 08:06:56 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)) 08:06:56 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)) 08:06:56 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)) 08:06:56 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)) 08:06:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:57 INFO - Downloading blessings-1.5.1.tar.gz 08:06:57 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 08:06:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:06:57 INFO - Installing collected packages: blessings 08:06:57 INFO - Running setup.py install for blessings 08:06:58 INFO - Successfully installed blessings 08:06:58 INFO - Cleaning up... 08:06:58 INFO - Return code: 0 08:06:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:06:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:06:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:06:58 INFO - Reading from file tmpfile_stdout 08:06:58 INFO - Current package versions: 08:06:58 INFO - argparse == 1.2.1 08:06:58 INFO - blessings == 1.5.1 08:06:58 INFO - blobuploader == 1.2.4 08:06:58 INFO - docopt == 0.6.1 08:06:58 INFO - manifestparser == 1.1 08:06:58 INFO - mozInstall == 1.12 08:06:58 INFO - mozcrash == 0.16 08:06:58 INFO - mozdebug == 0.1 08:06:58 INFO - mozdevice == 0.47 08:06:58 INFO - mozfile == 1.2 08:06:58 INFO - mozhttpd == 0.7 08:06:58 INFO - mozinfo == 0.9 08:06:58 INFO - mozleak == 0.1 08:06:58 INFO - mozlog == 3.1 08:06:58 INFO - moznetwork == 0.27 08:06:58 INFO - mozprocess == 0.22 08:06:58 INFO - mozprofile == 0.28 08:06:58 INFO - mozrunner == 6.11 08:06:58 INFO - mozscreenshot == 0.1 08:06:58 INFO - mozsystemmonitor == 0.0 08:06:58 INFO - moztest == 0.7 08:06:58 INFO - mozversion == 1.4 08:06:58 INFO - psutil == 3.1.1 08:06:58 INFO - requests == 1.2.3 08:06:58 INFO - wsgiref == 0.1.2 08:06:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f9b0e65bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2459480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e8660>, '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 0x24e9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e9a10>, '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': 'c402a24d74c70935940d60dd000001de-1451404187.464945-957839501', '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 08:06:58 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 08:06:58 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 08:06:58 INFO - Using env: {'DISPLAY': ':0', 08:06:58 INFO - 'HOME': '/home/cltbld', 08:06:58 INFO - 'LANG': 'en_US.UTF-8', 08:06:58 INFO - 'LANGUAGE': 'en_US:en', 08:06:58 INFO - 'LOGNAME': 'cltbld', 08:06:58 INFO - 'MAIL': '/var/mail/cltbld', 08:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:58 INFO - 'MOZ_NO_REMOTE': '1', 08:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:58 INFO - 'NO_EM_RESTART': '1', 08:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:06:58 INFO - 'PWD': '/builds/slave/test-pgo', 08:06:58 INFO - 'SHELL': '/bin/bash', 08:06:58 INFO - 'SHLVL': '1', 08:06:58 INFO - 'TERM': 'linux', 08:06:58 INFO - 'TMOUT': '86400', 08:06:58 INFO - 'USER': 'cltbld', 08:06:58 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1451404187.464945-957839501', 08:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:58 INFO - '_': '/tools/buildbot/bin/python'} 08:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:58 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)) 08:06:58 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)) 08:06:58 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)) 08:06:58 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)) 08:06:58 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)) 08:06:58 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)) 08:06:58 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)) 08:06:58 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)) 08:06:58 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)) 08:06:58 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)) 08:06:58 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)) 08:06:58 INFO - Cleaning up... 08:06:58 INFO - Return code: 0 08:06:58 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b0e65bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2459480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e8660>, '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 0x24e9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e9a10>, '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': 'c402a24d74c70935940d60dd000001de-1451404187.464945-957839501', '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 08:06:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 08:06:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:06:58 INFO - Using env: {'DISPLAY': ':0', 08:06:58 INFO - 'HOME': '/home/cltbld', 08:06:58 INFO - 'LANG': 'en_US.UTF-8', 08:06:58 INFO - 'LANGUAGE': 'en_US:en', 08:06:58 INFO - 'LOGNAME': 'cltbld', 08:06:58 INFO - 'MAIL': '/var/mail/cltbld', 08:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:58 INFO - 'MOZ_NO_REMOTE': '1', 08:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:58 INFO - 'NO_EM_RESTART': '1', 08:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:06:58 INFO - 'PWD': '/builds/slave/test-pgo', 08:06:58 INFO - 'SHELL': '/bin/bash', 08:06:58 INFO - 'SHLVL': '1', 08:06:58 INFO - 'TERM': 'linux', 08:06:58 INFO - 'TMOUT': '86400', 08:06:58 INFO - 'USER': 'cltbld', 08:06:58 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1451404187.464945-957839501', 08:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:58 INFO - '_': '/tools/buildbot/bin/python'} 08:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:58 INFO - Downloading/unpacking jsonschema 08:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:07:00 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 08:07:00 INFO - Downloading/unpacking functools32 (from jsonschema) 08:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:00 INFO - Downloading functools32-3.2.3-2.tar.gz 08:07:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:07:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:07:00 INFO - warning: no files found matching '*.txt' 08:07:00 INFO - no previously-included directories found matching 'build' 08:07:00 INFO - no previously-included directories found matching 'dist' 08:07:00 INFO - no previously-included directories found matching '.git*' 08:07:00 INFO - Installing collected packages: jsonschema, functools32 08:07:00 INFO - Running setup.py install for functools32 08:07:00 INFO - warning: no files found matching '*.txt' 08:07:00 INFO - no previously-included directories found matching 'build' 08:07:00 INFO - no previously-included directories found matching 'dist' 08:07:00 INFO - no previously-included directories found matching '.git*' 08:07:00 INFO - Successfully installed jsonschema functools32 08:07:00 INFO - Cleaning up... 08:07:00 INFO - Return code: 0 08:07:00 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b0e65bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2459480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e8660>, '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 0x24e9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e9a10>, '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': 'c402a24d74c70935940d60dd000001de-1451404187.464945-957839501', '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 08:07:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 08:07:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:07:00 INFO - Using env: {'DISPLAY': ':0', 08:07:00 INFO - 'HOME': '/home/cltbld', 08:07:00 INFO - 'LANG': 'en_US.UTF-8', 08:07:00 INFO - 'LANGUAGE': 'en_US:en', 08:07:00 INFO - 'LOGNAME': 'cltbld', 08:07:00 INFO - 'MAIL': '/var/mail/cltbld', 08:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:00 INFO - 'MOZ_NO_REMOTE': '1', 08:07:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:00 INFO - 'NO_EM_RESTART': '1', 08:07:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:07:00 INFO - 'PWD': '/builds/slave/test-pgo', 08:07:00 INFO - 'SHELL': '/bin/bash', 08:07:00 INFO - 'SHLVL': '1', 08:07:00 INFO - 'TERM': 'linux', 08:07:00 INFO - 'TMOUT': '86400', 08:07:00 INFO - 'USER': 'cltbld', 08:07:00 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1451404187.464945-957839501', 08:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:00 INFO - '_': '/tools/buildbot/bin/python'} 08:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:01 INFO - Downloading/unpacking flake8 08:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:07:02 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 08:07:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:07:03 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 08:07:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:07:03 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 08:07:03 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 08:07:03 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 08:07:03 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 08:07:03 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 08:07:03 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 08:07:03 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 08:07:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:07:03 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 08:07:03 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 08:07:03 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 08:07:03 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 08:07:03 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 08:07:03 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 08:07:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:07:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:07:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:07:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:07:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:07:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:07:03 INFO - no previously-included directories found matching 'docs/_build' 08:07:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:07:03 INFO - Running setup.py install for pep8 08:07:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:07:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:07:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:07:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:07:03 INFO - no previously-included directories found matching 'docs/_build' 08:07:03 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:07:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:07:03 INFO - Cleaning up... 08:07:03 INFO - Return code: 0 08:07:03 INFO - Running post-action listener: _resource_record_post_action 08:07:03 INFO - Running post-action listener: _start_resource_monitoring 08:07:03 INFO - Starting resource monitoring. 08:07:03 INFO - ##### 08:07:03 INFO - ##### Running install step. 08:07:03 INFO - ##### 08:07:03 INFO - Running pre-action listener: _resource_record_pre_action 08:07:03 INFO - Running main action method: install 08:07:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:07:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:07:03 INFO - Reading from file tmpfile_stdout 08:07:03 INFO - Detecting whether we're running mozinstall >=1.0... 08:07:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:07:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:07:04 INFO - Reading from file tmpfile_stdout 08:07:04 INFO - Output received: 08:07:04 INFO - Usage: mozinstall [options] installer 08:07:04 INFO - Options: 08:07:04 INFO - -h, --help show this help message and exit 08:07:04 INFO - -d DEST, --destination=DEST 08:07:04 INFO - Directory to install application into. [default: 08:07:04 INFO - "/builds/slave/test-pgo"] 08:07:04 INFO - --app=APP Application being installed. [default: firefox] 08:07:04 INFO - mkdir: /builds/slave/test-pgo/build/application 08:07:04 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'] 08:07:04 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 08:07:19 INFO - Reading from file tmpfile_stdout 08:07:19 INFO - Output received: 08:07:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:07:19 INFO - Running post-action listener: _resource_record_post_action 08:07:19 INFO - ##### 08:07:19 INFO - ##### Running run-tests step. 08:07:19 INFO - ##### 08:07:19 INFO - Running pre-action listener: _resource_record_pre_action 08:07:19 INFO - Running main action method: run_tests 08:07:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:07:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:07:19 INFO - Python 2.7.3 08:07:19 INFO - Return code: 0 08:07:19 INFO - grabbing minidump binary from tooltool 08:07:19 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')]} 08:07:19 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 0x24e8660>, '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 0x24e9560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e9a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:07:19 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 08:07:19 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 08:07:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:07:19 INFO - Return code: 0 08:07:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:07:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:07:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:07:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:07:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:07:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:07:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:07:20 INFO - Return code: 0 08:07:20 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/AV-VpCeaRW2-bmk2vBRtcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 08:07:20 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/AV-VpCeaRW2-bmk2vBRtcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 08:07:20 INFO - Using env: {'DISPLAY': ':0', 08:07:20 INFO - 'HOME': '/home/cltbld', 08:07:20 INFO - 'LANG': 'en_US.UTF-8', 08:07:20 INFO - 'LANGUAGE': 'en_US:en', 08:07:20 INFO - 'LOGNAME': 'cltbld', 08:07:20 INFO - 'MAIL': '/var/mail/cltbld', 08:07:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:07:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:20 INFO - 'MOZ_NO_REMOTE': '1', 08:07:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:20 INFO - 'NO_EM_RESTART': '1', 08:07:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:07:20 INFO - 'PWD': '/builds/slave/test-pgo', 08:07:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:07:20 INFO - 'SHELL': '/bin/bash', 08:07:20 INFO - 'SHLVL': '1', 08:07:20 INFO - 'TERM': 'linux', 08:07:20 INFO - 'TMOUT': '86400', 08:07:20 INFO - 'USER': 'cltbld', 08:07:20 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1451404187.464945-957839501', 08:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:20 INFO - '_': '/tools/buildbot/bin/python'} 08:07:20 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/AV-VpCeaRW2-bmk2vBRtcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 08:07:21 INFO - mozversion application_buildid: 20151229053002 08:07:21 INFO - mozversion application_changeset: 6dbba51c24d2386624557368feaed125e5a32a63 08:07:21 INFO - mozversion application_display_name: Nightly 08:07:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:07:21 INFO - mozversion application_name: Firefox 08:07:21 INFO - mozversion application_remotingname: firefox 08:07:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:07:21 INFO - mozversion application_vendor: Mozilla 08:07:21 INFO - mozversion application_version: 46.0a1 08:07:21 INFO - mozversion platform_buildid: 20151229053002 08:07:21 INFO - mozversion platform_changeset: 6dbba51c24d2386624557368feaed125e5a32a63 08:07:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:07:21 INFO - mozversion platform_version: 46.0a1 08:07:21 INFO - using testdate: 1451405241 08:07:21 INFO - actual date: 1451405241 08:07:21 INFO - starting webserver on 'localhost:59664' 08:07:21 INFO - SUITE-START | Running 3 tests 08:07:21 INFO - TEST-START | dromaeo_css 08:07:21 INFO - operating with platform_type : linux_ 08:07:21 INFO - Initialising browser for dromaeo_css test... 08:07:21 INFO - TEST-INFO | started process 32327 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYkalew/profile http://localhost:59664/getInfo.html) 08:07:25 INFO - PROCESS | 32327 | __metrics Screen width/height:1600/1200 08:07:25 INFO - PROCESS | 32327 | colorDepth:24 08:07:25 INFO - PROCESS | 32327 | Browser inner width/height: 1024/697 08:07:25 INFO - PROCESS | 32327 | __metrics 08:07:25 INFO - PROCESS | 32327 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:07:26 INFO - TEST-INFO | 32327: exit 0 08:07:26 INFO - Browser initialized. 08:07:26 INFO - Running cycle 1/1 for dromaeo_css test... 08:07:26 INFO - TEST-INFO | started process 32461 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYkalew/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:07:38 INFO - PROCESS | 32461 | RSS: Main: 149286912 08:07:38 INFO - PROCESS | 32461 | 08:08:28 INFO - PROCESS | 32461 | 1451405308141 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] 08:10:37 INFO - PROCESS | 32461 | Cycle 1(1): loaded http://localhost:59664/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59664/tests/dromaeo/cssquery-ext.html) 08:10:38 INFO - PROCESS | 32461 | RSS: Main: 158068736 08:10:38 INFO - PROCESS | 32461 | 08:13:40 INFO - PROCESS | 32461 | Cycle 1(1): loaded http://localhost:59664/tests/dromaeo/cssquery-ext.html (next: http://localhost:59664/tests/dromaeo/cssquery-jquery.html) 08:13:41 INFO - PROCESS | 32461 | RSS: Main: 153501696 08:13:41 INFO - PROCESS | 32461 | 08:16:42 INFO - PROCESS | 32461 | Cycle 1(1): loaded http://localhost:59664/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59664/tests/dromaeo/cssquery-mootools.html) 08:16:43 INFO - PROCESS | 32461 | RSS: Main: 154906624 08:16:43 INFO - PROCESS | 32461 | 08:19:45 INFO - PROCESS | 32461 | Cycle 1(1): loaded http://localhost:59664/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59664/tests/dromaeo/cssquery-prototype.html) 08:19:45 INFO - PROCESS | 32461 | RSS: Main: 152907776 08:19:45 INFO - PROCESS | 32461 | 08:22:48 INFO - PROCESS | 32461 | Cycle 1(1): loaded http://localhost:59664/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59664/tests/dromaeo/cssquery-yui.html) 08:22:48 INFO - PROCESS | 32461 | RSS: Main: 153255936 08:22:48 INFO - PROCESS | 32461 | 08:25:51 INFO - PROCESS | 32461 | Cycle 1(1): loaded http://localhost:59664/tests/dromaeo/cssquery-yui.html (next: http://localhost:59664/tests/dromaeo/cssquery-dojo.html) 08:25:51 INFO - PROCESS | 32461 | RSS: Main: 155070464 08:25:51 INFO - PROCESS | 32461 | 08:25:51 INFO - PROCESS | 32461 | __start_tp_report 08:25:51 INFO - PROCESS | 32461 | _x_x_mozilla_page_load 08:25:51 INFO - PROCESS | 32461 | _x_x_mozilla_page_load_details 08:25:51 INFO - PROCESS | 32461 | |i|pagename|runs| 08:25:51 INFO - PROCESS | 32461 | |0;dojo.html;3168.6533223380056;3199.85600647971;3228.0315905228426;3258.120307516971;3263.967360326396;5233.816816411417;5315.495027972342;5334.653247538917;5340.519353258211;5368.651037682553;5300.893982120355;5305.098133317336;5316.149416093426;5320.17537281722;5325.627206095575;4783.067301876135;4805.870620404202;4831.565159135677;4987.950120498803;5008.123578373788;4876;4904.75476226189;4926.187179115442;4961.8511444656715;4975.925361119586;4731.503192164808;4910.435299940516;4913.385826771653;4915.16442204826;4927.605791536686;4799.928001079987;4877.317175595384;4885.755712214375;4947.876303092416;4989.251612258154;4845.4185497740145;4876.195427754416;4896.6572339935865;4897.9143139822045;4922.556969872693;5014.749262536859;5140.74296285188;5208.869778255574;5210.426853046162;5220.321358223445;5682.857928551778;5787.681677507735;5803.042497987827;5825;5876.853078673067;5749.741261643194;5757.596968212227;5761.539076873882;5761.683107429089;5765.048766953448;5318.468153184651;5363.436839131835;5376.784928602851;5383.192521121824;5410.107332290128;5813.069908814569;5824.796132135355;5840;5842.152887831241;5880.647161170344;5628.859278517988;5634.32388113429;5635.098384258499;5641.2384328116;5642.294713160855;5648.717564121777;5716.142578613241;5718.628289161191;5775.5090817281;5830.766769329264;5765.798197063083;5773.278340207474;5774.826755197267;5778.5377169826315;5812.157237200667;5703.74333155009;5710.5146062585145;5760.135979603009;5767.826965191051;5780.364159942403;4406.074724307931;4429.313456414261;4466;4483.977580112144;4526.592606665416;3950.3481925482547;3971.4638523798917;3984.2230765000545;4001.0597509585223;4019.336809426412;5274.525292723673;5282.683039017671;5297.973510132425;5305.230741542455;5315.893682126413;5534.114541673393;5638;5742.3396309424115;5794.739236734357;5811.360750317462;5249.133892907704;5252.317198764136;5260.132078207053;5275.235090911796;5314.123169677037;4919.729414882216;5017.8606866441605;5037.722925239147;5040.672356296829;5080.085584594734;5811.186433899257;5814.040683287295;5868.67722275279;5878.412158784087;5945.375735547792;5686.601937864475;5728.914066288926;5756.021476349115;5757.424257574209;5764.798232062026;5702.315722113373;5718.399568045462;5777.711114444345;5780.94219057804;5825.533957283323;5646.378898321099;5715.142728590745;5768.971155144198;5801.622894511843;5809.622374545641;5756.251687280626;5797.333306669787;5808.5643576732755;5812.622179558484;5815.4184581543195;5465.9726701366235;5626.690532020614;5658.17956396312;5666.263385759825;5672.03575392176;5524.585656075891;5557.444255574572;5594.664320140804;5641.605087643826;5691.402402747652;5575.749091290821;5611.466910643482;5621.803236886853;5639.069553523623;5645.49190572834;5551.333839939233;5638.774449021993;5677.74450149736;5742.569307302053;5768.423157684198;5397.514223719884;5473.370562385377;5557.249771280825;5579.358373787067;5585.162225666182 08:25:51 INFO - PROCESS | 32461 | |1;ext.html;530.5834919588123;544.4854612391292;554.0581012279126;555.1783360626273;569.9116636921274;35150.824245878764;36123;36126.8193659032;36138.45792313114;36296.81851590745;38413.423798643045;38691.61308386915;38971.41542876859;38975;39065;8375.91624083759;8544.060153383123;8544.70093546726;8548.529830859301;8603;8294.682127149159;8418;8456.83086338276;8471.661133554651;8472.27985621223;8534.1039190885;8579.957100214522;8595.312375010015;8613.483191008529;8688.131186881294;8529.658813647447;8570.742877713647;8589.184027517376;8596.226339629464;8648.610812513452;8450.366222533334;8583.656653733844;8612.224899759052;8649.52957997142;8667.479951202886;38546.421803672965;38590.42114368287;38907.22185556301;39024.414633780514;39058;3257.6742325767473;3259.6251431085493;3402.0814380117477;3527.2592755521373;3565.9108522286892;29670.85164574185;29769;29803.70196298031;30025.099247022623;30181.698183018107;3865.8646947356706;3881.4954055972544;3928.823202955874;4004.4516087175593;4021.4369988201674;253648.99999999817;255492;255930;256600;257048;49896;50737.44837861388;54590;54789.726051369486;55851.441485585434;50982.74508627433;51289.487105129214;51468;51544.22683659748;51839;14102;14326.57020289393;14348.354324055234;14358.856411435961;14386.424543018162;10769.730756731144;10891.509882055327;10894.509747061402;10925.453727313761;10926.890731092746;18105.818941810678;18307.63384732298;19158.61682766337;19179.61640767177;19208.327708530134;7471.70113195477;7567.962160189164;7659.119201291811;7689.115751688516;7800.063992320957;962.855571664256;969.8593703912893;1083.1172594335749;1111.111111111108;1135.4152611405134;27988.86005569959;28056;28157.155285341472;28274.85862570674;28322.433551328857;1075.7471994081384;1079.1798233342715;1087.0922779479065;1144.3362849547243;1231.2735486063266;14697.706045879237;14716.264186790617;14752.40990360395;14883.181425021729;14926;293929;299507;300795;300915.9908400888;301374;49695;50257.74871125621;50460;50502.49497505051;50741.23888141681;1294.0682708449901;1298.9740205195844;1308.8822006019504;1316.9341532923506;1325.2975922760952;26737.866310668323;27596.862015689792;27607.171784846487;28069.298267542657;28149.859250704434;44305.33541996808;44878.55121448874;44923.77538112288;45039;45130.77434612806;274136;277439;277497;278895;279236;31769.364612707155;31810.52284215785;31963.840180798947;32312.515312269865;32349;36138;36757.63242367649;36869.81565092158;36997.260054798215;37095.629043710294;31965.36069278648;33468.49797252994;34138.82930585331;34552.82723586366;34649.82675086709;34729.479057813645;34985.82507087448;35291.29417411689;35881.46177807387;36009.639903601674;31779.20551986219;32178.67821321757;32205.677943220267;32210.83894580512;32228.19429514187;27234.72765272401;29883.70116298896;31894.362112758077;32821.343573128885;32908.83545582257;22778.544429111655;23679.1712290069;23725.16961906325;24135;24228.39429014289 08:25:51 INFO - PROCESS | 32461 | |2;jquery.html;346.59621540904845;347.7548328428458;350.5652990292037;353.133058341771;353.80717508957616;11270.380129092897;11678.47446864891;16249.512514624565;16405.83594164058;17326.65346693067;17892.64214715705;17927.91036044818;17984.10079496023;18310.725339119923;18320.175592098356;6044.546659000571;6230.657313847737;6231.688415579226;6239.750409983618;6241.563090583661;6169.352218017111;6259.687015649222;6261.592996455239;6369.299377068519;6574.506911981596;6195.721192546323;6443.452306553949;6451.419372256496;6526.118973938505;6537.607743535403;6370;6373.872522549523;6462.0306953956815;6467.288598254188;6762.289959554225;6455.193100862392;6468.935310646881;6471.611703297817;6473.255575608819;6480.287168411471;20123.89938050315;20960.685589716166;21212.363629091153;21403.357899263046;21675.783242167534;2243.7980581747556;2252.2454977582365;2253.5605556916407;2399.3042017814814;2425.672534207877;14332;14373.353199106064;14615.707685846224;14978.70042599142;14995.250237488191;1971.2016633263408;2003.2587942461237;2005.7492813398326;2045.4784030072237;2064.112431654388;62470;66261;67671;68549.31450685479;68890.3110968889;14805.629859253604;15321.23393830304;15346.462873799363;15379.384824607114;15402.845971540366;23646.64530032051;23826.88086559556;23874.7612523876;24101.879490602434;24130.638040429407;8702.260307873901;8756.912430875736;8790.472571645594;8806.427582207265;8807.955960220286;7370.189279179286;7380.557166570023;7407.111146662435;7415.3326200642205;7438.1446133694235;7550.546967181876;7628.732994345282;7679.769606911802;7680.078390593053;7697.461177717506;1766.6025144342677;2938.676745557987;2975.375171214026;3004.7145521175453;3030.257586891226;428.4087958617088;433.559936664286;442.71887351532007;859.2266959736287;978.3542861711236;10027.598896044077;10579.576816927236;10925.617603384002;11028.944855275833;11157.832632510519;899.3558936726005;949.7815502434479;1003.9196864250843;1012.8885822559513;1022.1873610479687;9261.120193581599;9402;9411.482368469662;9465.90534094664;9587.952060239653;519231;537884;547154;548023;558733;67802;69584;70844.64577677079;77285.2271477278;78067;1154.9538018479334;1163.4648061891626;1168.8363629091934;1170.414792603698;1172.5720112159001;14659.853401466275;14692.779608305671;14700.632484187981;14819.555413337617;15069.773953390928;31026.74219206951;31077.223069423446;31535.21161970969;31542.526862096627;31551.684483154873;40134.598654014255;41030.58969410268;41114;46325.76837115793;46951.29573056475;9256.213221875947;9404.106609872051;9508.572114255014;9515.143637072697;9527.333086683866;11245.606403775828;16142.435014774426;16542.42101526441;17238.224279907183;17377.47867563975;14202.786958195842;14287.64280892986;14361.138331700131;14384.42462301538;14473.203973781543;13909.791353129913;13933.715424869175;13985.510507132201;14185.858141418454;14567.781483277548;14369.13785172893;14426.927865360605;14517;14700.77948830747;14912.552623421314;9109.453432794053;9441.811163776823;9465.810683786423;9631.614735410505;9925.602975881173;14157.009009369245;14199.858001419854;14725.410983560538;14806.963512554017;15202.847971520143 08:25:51 INFO - PROCESS | 32461 | |3;mootools.html;1422.822147231596;1441.7621092519735;1553.4951140879218;1709.2821015173627;1761.735739639054;7347.853042939145;7415.258474152595;7503.662335194916;7516.5865877376655;7531.623418829064;7390.482666213367;7417.851642967137;7482.812929676761;7484.663190156442;7512;2204.790544898236;2232.6427771556555;2233;2237.1722462688745;2242.8093612042994;2190.507135894427;2199.6920431139574;2206.6910632511463;2210.3148024112497;2224.9555008899893;2159.600473912323;2187.1688758271835;2204.4048107011176;2208.2712704807454;2234.72065991751;2183.5742030304095;2185.366243789299;2219.911203551856;2240.529488807352;2245.191730976847;2233.832462565314;2235.519363336874;2250.189931624614;2254.1546919905036;2259.6723475096182;7386.446016548781;7439;7511.6244187790935;7526.774196774106;7546.245375462465;4507.729536227836;4587.9541204588195;4595.448546174447;4622.19111655459;4628.884277893046;2890.4508143452676;2976.241058530061;3016.441958237733;3027.0918724382595;3036.6356037275445;910.8724778531011;923.6628630549801;928.6239073175375;955.7753927826955;990.6631745206664;10038.64864729731;10038.799224015478;10062.496875156286;10064.748381290454;10107.191424686007;3985.661218796377;4037.37420699792;4052.209819085309;4061.7766022868436;4085;8214.301784348278;8267.958660206781;8339.166083391612;8352.206540378655;8359.665613375519;4546.090781843644;4547.772611369418;4548.818047278071;4551.40831691878;4552.886177845514;4151.294279972412;4194.958050419456;4198.181354635817;4208.810603522848;4233.364995250676;3314.419976504102;3323.6011678598725;3340.9832950835576;3352.860027590631;3366.4781958796425;971.1599466461602;973.454865275448;975.4488713876636;982.8673129127476;995.576879826071;890.0876601483532;939.990600094004;1082.0748260237542;1111.6387174168428;1305.106002388367;6732.225794033651;6745.0556922030955;6761.628110453874;6784.287649796799;6796.76211332601;586.5366360575098;601.4226342711046;604.4982664388547;639.2329204954074;743.598456833304;5174.43081261061;5267.868303292448;5275.60432967529;5276.815311464157;5301.867453313698;8219.794505137299;8222.917770822334;8372.330213582898;8401.70594029206;8459.788505287293;8300.916990830014;8302.211289927447;8304.211099945496;8344.874826877602;8409.621567029499;6773.72905083801;6852.6231057292325;6922.41159501438;6958.8956165657555;7039.36645701879;6944.4444444445335;7012.474064445289;7017.508774385744;7020.929790702232;7023.929760702532;7715.716794380659;7861.135275119618;8009.399295053011;8059.6776128956535;8117.797055073434;8072.071711752988;8104.594770261581;8205.343572514064;8250.257476827115;8353.415260931919;6602.7689030883685;6654.301298363602;6664.666766661744;6697.229818570927;6764.492663050192;6982.860342793218;7023.981522679285;7046.013558101972;7085.574865508086;7103.289671032855;6440.4525615321345;6857.657117144223;6900.378965893094;7022.508424410446;7040.331168538981;6432.2602900667025;6451.1936007999;6541.378569035934;6595.142631457879;6598.241202261609;6317.115603815561;6333.429991300805;6604.504662150454;6740.595564266159;6763.357481039294;6242.157308763259;6248.0003199487865;6252.562320637512;6265.968670156803;6299;6057.57596968208;6061.302950160788;6065.120557519223;6078.90881636767;6208.875822483435 08:25:51 INFO - PROCESS | 32461 | |4;prototype.html;329.98845040423583;338.6985582831279;345.12166536165455;346.96604119723224;347.572485842414;6216.84457888553;6223.066540018999;6237.781677641284;6284.057391391294;6385.393387628168;6155.692215389224;6281.523841897162;6298.590591611542;6303.684815759205;6316.27362853272;4745.406824146981;4755.881102972436;4757.619390448773;4760.214564596846;4764;4762.809487620491;4763.833265835697;4772.976135119319;4774.594159496447;4774.880627984294;4632.0967411354795;4708.458527269374;4722.433308003045;4724.574788269072;4731.361266229067;4661.557152070548;4695.225287827504;4697.506761790014;4699.342092107107;4705.294205869112;4045.0696339841707;4057.69567282455;4059.451973983504;4069.6337329640473;4078.490188726409;5951.732172052225;5972.820815375546;5980.192673989;5980.8504787380225;5988.820335389945;5378.704171270579;5384.976854397652;5390.110631745796;5399.865003374908;5400.702961337125;6618.172728408949;6629.900551491732;6646.069550262919;6647.567908085959;6676.031975363545;4371.431713877208;4376.212281789277;4377;4382.189294980439;4383.254846676041;6752.8311792205095;6814.250432452426;6824.488163387716;6833.555818871758;6847.623380714059;4577.702449340783;4584.747838868894;4592.816287348535;4593.402857628487;4594.494605593382;4627.768611569408;4635.420572428447;4646.930296045562;4664.346991421204;4668;5406.864828379322;5412.377576578665;5413.917216556704;5418.91871621926;5424.945750542444;6471.255805582324;6559.114519539897;6570.178727659043;6573.737050517926;6581.83545411359;1620.3437607768872;1635.7709920611123;1635.8118816336037;1639.524537884024;1647.6869394814946;1091.737982884118;1098.9285696429706;1103.9889601103887;1105.6075093341908;1121.5233525751523;6021.157038014681;6021.5182785377065;6029.276486821609;6076.997295446202;6095.969520152371;6716.832079197961;6734.6632668367365;6771.356721111487;6777.1189745332795;6781.050652908597;5906.173135760997;6062.454379105901;6079.270487541523;6081.270247570232;6094.329623741385;3697.1681371691157;3704.203596226824;3707.981460092736;3708;3716.0709822544363;6862.828429289308;6922.926946323328;6926.861462770717;6927.445804335641;6944.201416837027;6863.588184708933;6960.269171736996;6986.615736134459;7020.7542736004;7035;6851.109355783717;6854.417374523221;6866.176058873067;6901.447884169254;6905.447564194852;6744.0558321834005;6755.459563234831;6769.796906092825;6773.153355830521;6785.660716964231;6607.00894865774;6685.097511836035;6724.831879203059;6725.461963042847;6753.459723222032;6848.280930502425;6874.075258927508;6880;6882.449404047764;6899;4559.316102584638;4633.698809577367;4639.930401043919;4651.651126165619;4653.60444362233;6722.899156512558;6731.966340168267;6773.153355830521;6807;6842.623655698785;6711.127553418024;6748.763793267409;6749.392554670103;6750.8649827004165;6768.4585233182215;6700.262971073275;6701.1623547056615;6736.157980252468;6746.426553742791;6748.561343512656;6427.807165785034;6608.240052393844;6610.636414997221;6618.602883826986;6626.304238055128;6759.932400675931;6771.119754431892;6772.814757417334;6779.559328643622;6779.864402712017;6555.868882622416;6572.638504882278;6593.109930159367;6614.966925165536;6622.668866556556 08:25:51 INFO - PROCESS | 32461 | |5;yui.html;731.7585196885028;836.2515548584014;836.4855613797514;836.5482639374738;841.5834162089767;13240;13439.462421503129;13449.596512104628;13516.310461192352;13543.525976590821;12734.80897786534;12793.23240605562;12795;12814.67963300918;12817.807732883992;641.4868105515592;654.2933631677801;785.8231897822986;794.253401802304;807.475141158246;795.4034474144391;800.047942947893;813.4509206285734;814.3322475570035;814.8492528882147;846.3821410370433;856.1695155698962;862.7886167888876;862.9439086459391;863.2662237098478;854.8760429737715;855.285836326668;856.3406177243488;856.9957150214241;857.3784006595231;624.3631495874229;625.1903784598956;628.7390732845863;629.5844742469993;629.6348118091496;13330.800037999437;13447.596572102853;13515.864841351657;13519.594412167651;13530.86469135306;11769.41152942358;12306.138570300083;12652.114351995364;12794.104412691115;13055;10256.282060255786;10386.428746418944;10590;10961.616343427942;11011.119110471143;3621.1977423705002;3640.2173532690335;3646.74472786905;3684.3736564783785;3744.475773391727;43843.56156438427;45828.312575311065;46590.06819863584;46642.76678616619;46777.532224677656;10137.087662110445;10180.541875615616;10237;10263.178945684327;10592.735181620366;17647.823521764876;17756.289748410178;17775.377861774778;17835.10824458772;17883.642327153386;7099.935009748579;7154.391876690435;7479.626018699152;7492.925070749332;7567.545947243183;4328.28583283761;4343.956560434355;4403.581659742319;4421.801018954155;4436.068425630654;2992.8054676445963;3000.324926891432;3012.201766531871;3024.380002099564;3030.075826872825;520.9062368773581;542.3871025740888;542.8371488553419;554.3680204566797;554.5425024354923;475.70030880545033;589.775885163635;605.0500713879168;612.8406614280319;614.3948211012149;8445.704400346081;8720.65117395297;9177.403468774508;9248.352615316997;9328.860067098998;477.96415268854975;575.5424437572141;586.8415527807468;628.1049504456132;651.7686221391338;3823.3118038752737;4036.091879327128;4052.9594704052583;4080.489938757655;4222.113356195234;51053;51488;51506.742466287425;51877.481225187264;51915.740421297654;46755;46931.530684693396;47113.5288647116;47473.5252647476;47491.5250847494;43745.12509749851;43828.78085609616;43895.56104438979;44121.11757764827;44192.55807441884;8077.192280771876;8216.507009579444;8261.669533218605;8314.501129932223;8331.291840193651;32067.518987215677;32713.18217044593;32917;34116.31767364589;34191.65808341885;37906.43140352842;40572;41771;41918;42588.36117458303;9209.401388909699;9236.676716314896;9322.394044387092;9334.113259240361;9586.95206523963;10315.381077135096;10358.844617330897;10471.162307015573;10632.627858024933;10821.134309255083;9926.962144040219;10002.24983126254;10106.949465252626;10117.898821011695;10326.896731032593;9925;10176.491175441346;10218.489075546342;10278.023587759151;10461.738456538647;9319.673811416567;9404.247660187306;9596.712098637052;9649.807003860024;9666.903330966881;8338.874251975905;8557.358198135289;8620.5258710769;8959.955200223958;9011.324150688593;8974.910250897408;9014.143656352637;9024.232940199894;9074.954625226832;9120.67750176234 08:25:51 INFO - PROCESS | 32461 | __end_tp_report 08:25:51 INFO - PROCESS | 32461 | __start_cc_report 08:25:51 INFO - PROCESS | 32461 | _x_x_mozilla_cycle_collect,309 08:25:51 INFO - PROCESS | 32461 | __end_cc_report 08:25:51 INFO - PROCESS | 32461 | __startTimestamp1451406351437__endTimestamp 08:25:51 INFO - PROCESS | 32461 | 08:25:51 INFO - PROCESS | 32461 | ------- Summary: start ------- 08:25:51 INFO - PROCESS | 32461 | Number of tests: 6 08:25:51 INFO - PROCESS | 32461 | 08:25:51 INFO - PROCESS | 32461 | [#0] dojo.html Cycles:165 Average:5328.42 Median:5557.44 stddev:579.77 (10.4%) stddev-sans-first:556.24 08:25:51 INFO - PROCESS | 32461 | Values: 3168.7 3199.9 3228.0 3258.1 3264.0 5233.8 5315.5 5334.7 5340.5 5368.7 5300.9 5305.1 5316.1 5320.2 5325.6 4783.1 4805.9 4831.6 4988.0 5008.1 4876.0 4904.8 4926.2 4961.9 4975.9 4731.5 4910.4 4913.4 4915.2 4927.6 4799.9 4877.3 4885.8 4947.9 4989.3 4845.4 4876.2 4896.7 4897.9 4922.6 5014.7 5140.7 5208.9 5210.4 5220.3 5682.9 5787.7 5803.0 5825.0 5876.9 5749.7 5757.6 5761.5 5761.7 5765.0 5318.5 5363.4 5376.8 5383.2 5410.1 5813.1 5824.8 5840.0 5842.2 5880.6 5628.9 5634.3 5635.1 5641.2 5642.3 5648.7 5716.1 5718.6 5775.5 5830.8 5765.8 5773.3 5774.8 5778.5 5812.2 5703.7 5710.5 5760.1 5767.8 5780.4 4406.1 4429.3 4466.0 4484.0 4526.6 3950.3 3971.5 3984.2 4001.1 4019.3 5274.5 5282.7 5298.0 5305.2 5315.9 5534.1 5638.0 5742.3 5794.7 5811.4 5249.1 5252.3 5260.1 5275.2 5314.1 4919.7 5017.9 5037.7 5040.7 5080.1 5811.2 5814.0 5868.7 5878.4 5945.4 5686.6 5728.9 5756.0 5757.4 5764.8 5702.3 5718.4 5777.7 5780.9 5825.5 5646.4 5715.1 5769.0 5801.6 5809.6 5756.3 5797.3 5808.6 5812.6 5815.4 5466.0 5626.7 5658.2 5666.3 5672.0 5524.6 5557.4 5594.7 5641.6 5691.4 5575.7 5611.5 5621.8 5639.1 5645.5 5551.3 5638.8 5677.7 5742.6 5768.4 5397.5 5473.4 5557.2 5579.4 5585.2 08:25:51 INFO - PROCESS | 32461 | 08:25:51 INFO - PROCESS | 32461 | [#1] ext.html Cycles:180 Average:43800.38 Median:34689.65 stddev:72537.51 (209.1%) stddev-sans-first:72668.25 08:25:51 INFO - PROCESS | 32461 | Values: 530.6 544.5 554.1 555.2 569.9 35150.8 36123.0 36126.8 36138.5 36296.8 38413.4 38691.6 38971.4 38975.0 39065.0 8375.9 8544.1 8544.7 8548.5 8603.0 8294.7 8418.0 8456.8 8471.7 8472.3 8534.1 8580.0 8595.3 8613.5 8688.1 8529.7 8570.7 8589.2 8596.2 8648.6 8450.4 8583.7 8612.2 8649.5 8667.5 38546.4 38590.4 38907.2 39024.4 39058.0 3257.7 3259.6 3402.1 3527.3 3565.9 29670.9 29769.0 29803.7 30025.1 30181.7 3865.9 3881.5 3928.8 4004.5 4021.4 253649.0 255492.0 255930.0 256600.0 257048.0 49896.0 50737.4 54590.0 54789.7 55851.4 50982.7 51289.5 51468.0 51544.2 51839.0 14102.0 14326.6 14348.4 14358.9 14386.4 10769.7 10891.5 10894.5 10925.5 10926.9 18105.8 18307.6 19158.6 19179.6 19208.3 7471.7 7568.0 7659.1 7689.1 7800.1 962.9 969.9 1083.1 1111.1 1135.4 27988.9 28056.0 28157.2 28274.9 28322.4 1075.7 1079.2 1087.1 1144.3 1231.3 14697.7 14716.3 14752.4 14883.2 14926.0 293929.0 299507.0 300795.0 300916.0 301374.0 49695.0 50257.7 50460.0 50502.5 50741.2 1294.1 1299.0 1308.9 1316.9 1325.3 26737.9 27596.9 27607.2 28069.3 28149.9 44305.3 44878.6 44923.8 45039.0 45130.8 274136.0 277439.0 277497.0 278895.0 279236.0 31769.4 31810.5 31963.8 32312.5 32349.0 36138.0 36757.6 36869.8 36997.3 37095.6 31965.4 33468.5 34138.8 34552.8 34649.8 34729.5 34985.8 35291.3 35881.5 36009.6 31779.2 32178.7 32205.7 32210.8 32228.2 27234.7 29883.7 31894.4 32821.3 32908.8 22778.5 23679.2 23725.2 24135.0 24228.4 08:25:51 INFO - PROCESS | 32461 | 08:25:51 INFO - PROCESS | 32461 | [#2] jquery.html Cycles:180 Average:29359.51 Median:31538.87 stddev:88415.62 (280.3%) stddev-sans-first:88636.81 08:25:51 INFO - PROCESS | 32461 | Values: 346.6 347.8 350.6 353.1 353.8 11270.4 11678.5 16249.5 16405.8 17326.7 17892.6 17927.9 17984.1 18310.7 18320.2 6044.5 6230.7 6231.7 6239.8 6241.6 6169.4 6259.7 6261.6 6369.3 6574.5 6195.7 6443.5 6451.4 6526.1 6537.6 6370.0 6373.9 6462.0 6467.3 6762.3 6455.2 6468.9 6471.6 6473.3 6480.3 20123.9 20960.7 21212.4 21403.4 21675.8 2243.8 2252.2 2253.6 2399.3 2425.7 14332.0 14373.4 14615.7 14978.7 14995.3 1971.2 2003.3 2005.7 2045.5 2064.1 62470.0 66261.0 67671.0 68549.3 68890.3 14805.6 15321.2 15346.5 15379.4 15402.8 23646.6 23826.9 23874.8 24101.9 24130.6 8702.3 8756.9 8790.5 8806.4 8808.0 7370.2 7380.6 7407.1 7415.3 7438.1 7550.5 7628.7 7679.8 7680.1 7697.5 1766.6 2938.7 2975.4 3004.7 3030.3 428.4 433.6 442.7 859.2 978.4 10027.6 10579.6 10925.6 11028.9 11157.8 899.4 949.8 1003.9 1012.9 1022.2 9261.1 9402.0 9411.5 9465.9 9588.0 519231.0 537884.0 547154.0 548023.0 558733.0 67802.0 69584.0 70844.6 77285.2 78067.0 1155.0 1163.5 1168.8 1170.4 1172.6 14659.9 14692.8 14700.6 14819.6 15069.8 31026.7 31077.2 31535.2 31542.5 31551.7 40134.6 41030.6 41114.0 46325.8 46951.3 9256.2 9404.1 9508.6 9515.1 9527.3 11245.6 16142.4 16542.4 17238.2 17377.5 14202.8 14287.6 14361.1 14384.4 14473.2 13909.8 13933.7 13985.5 14185.9 14567.8 14369.1 14426.9 14517.0 14700.8 14912.6 9109.5 9441.8 9465.8 9631.6 9925.6 14157.0 14199.9 14725.4 14807.0 15202.8 08:25:51 INFO - PROCESS | 32461 | 08:25:51 INFO - PROCESS | 32461 | [#3] mootools.html Cycles:180 Average:5153.89 Median:6445.82 stddev:2644.82 (41.0%) stddev-sans-first:2637.37 08:25:51 INFO - PROCESS | 32461 | Values: 1422.8 1441.8 1553.5 1709.3 1761.7 7347.9 7415.3 7503.7 7516.6 7531.6 7390.5 7417.9 7482.8 7484.7 7512.0 2204.8 2232.6 2233.0 2237.2 2242.8 2190.5 2199.7 2206.7 2210.3 2225.0 2159.6 2187.2 2204.4 2208.3 2234.7 2183.6 2185.4 2219.9 2240.5 2245.2 2233.8 2235.5 2250.2 2254.2 2259.7 7386.4 7439.0 7511.6 7526.8 7546.2 4507.7 4588.0 4595.4 4622.2 4628.9 2890.5 2976.2 3016.4 3027.1 3036.6 910.9 923.7 928.6 955.8 990.7 10038.6 10038.8 10062.5 10064.7 10107.2 3985.7 4037.4 4052.2 4061.8 4085.0 8214.3 8268.0 8339.2 8352.2 8359.7 4546.1 4547.8 4548.8 4551.4 4552.9 4151.3 4195.0 4198.2 4208.8 4233.4 3314.4 3323.6 3341.0 3352.9 3366.5 971.2 973.5 975.4 982.9 995.6 890.1 940.0 1082.1 1111.6 1305.1 6732.2 6745.1 6761.6 6784.3 6796.8 586.5 601.4 604.5 639.2 743.6 5174.4 5267.9 5275.6 5276.8 5301.9 8219.8 8222.9 8372.3 8401.7 8459.8 8300.9 8302.2 8304.2 8344.9 8409.6 6773.7 6852.6 6922.4 6958.9 7039.4 6944.4 7012.5 7017.5 7020.9 7023.9 7715.7 7861.1 8009.4 8059.7 8117.8 8072.1 8104.6 8205.3 8250.3 8353.4 6602.8 6654.3 6664.7 6697.2 6764.5 6982.9 7024.0 7046.0 7085.6 7103.3 6440.5 6857.7 6900.4 7022.5 7040.3 6432.3 6451.2 6541.4 6595.1 6598.2 6317.1 6333.4 6604.5 6740.6 6763.4 6242.2 6248.0 6252.6 6266.0 6299.0 6057.6 6061.3 6065.1 6078.9 6208.9 08:25:51 INFO - PROCESS | 32461 | 08:25:51 INFO - PROCESS | 32461 | [#4] prototype.html Cycles:180 Average:5485.95 Median:6186.27 stddev:1667.44 (27.0%) stddev-sans-first:1626.59 08:25:51 INFO - PROCESS | 32461 | Values: 330.0 338.7 345.1 347.0 347.6 6216.8 6223.1 6237.8 6284.1 6385.4 6155.7 6281.5 6298.6 6303.7 6316.3 4745.4 4755.9 4757.6 4760.2 4764.0 4762.8 4763.8 4773.0 4774.6 4774.9 4632.1 4708.5 4722.4 4724.6 4731.4 4661.6 4695.2 4697.5 4699.3 4705.3 4045.1 4057.7 4059.5 4069.6 4078.5 5951.7 5972.8 5980.2 5980.9 5988.8 5378.7 5385.0 5390.1 5399.9 5400.7 6618.2 6629.9 6646.1 6647.6 6676.0 4371.4 4376.2 4377.0 4382.2 4383.3 6752.8 6814.3 6824.5 6833.6 6847.6 4577.7 4584.7 4592.8 4593.4 4594.5 4627.8 4635.4 4646.9 4664.3 4668.0 5406.9 5412.4 5413.9 5418.9 5424.9 6471.3 6559.1 6570.2 6573.7 6581.8 1620.3 1635.8 1635.8 1639.5 1647.7 1091.7 1098.9 1104.0 1105.6 1121.5 6021.2 6021.5 6029.3 6077.0 6096.0 6716.8 6734.7 6771.4 6777.1 6781.1 5906.2 6062.5 6079.3 6081.3 6094.3 3697.2 3704.2 3708.0 3708.0 3716.1 6862.8 6922.9 6926.9 6927.4 6944.2 6863.6 6960.3 6986.6 7020.8 7035.0 6851.1 6854.4 6866.2 6901.4 6905.4 6744.1 6755.5 6769.8 6773.2 6785.7 6607.0 6685.1 6724.8 6725.5 6753.5 6848.3 6874.1 6880.0 6882.4 6899.0 4559.3 4633.7 4639.9 4651.7 4653.6 6722.9 6732.0 6773.2 6807.0 6842.6 6711.1 6748.8 6749.4 6750.9 6768.5 6700.3 6701.2 6736.2 6746.4 6748.6 6427.8 6608.2 6610.6 6618.6 6626.3 6759.9 6771.1 6772.8 6779.6 6779.9 6555.9 6572.6 6593.1 6615.0 6622.7 08:25:51 INFO - PROCESS | 32461 | 08:25:51 INFO - PROCESS | 32461 | [#5] yui.html Cycles:180 Average:12978.25 Median:47293.53 stddev:14743.03 (31.2%) stddev-sans-first:14755.71 08:25:51 INFO - PROCESS | 32461 | Values: 731.8 836.3 836.5 836.5 841.6 13240.0 13439.5 13449.6 13516.3 13543.5 12734.8 12793.2 12795.0 12814.7 12817.8 641.5 654.3 785.8 794.3 807.5 795.4 800.0 813.5 814.3 814.8 846.4 856.2 862.8 862.9 863.3 854.9 855.3 856.3 857.0 857.4 624.4 625.2 628.7 629.6 629.6 13330.8 13447.6 13515.9 13519.6 13530.9 11769.4 12306.1 12652.1 12794.1 13055.0 10256.3 10386.4 10590.0 10961.6 11011.1 3621.2 3640.2 3646.7 3684.4 3744.5 43843.6 45828.3 46590.1 46642.8 46777.5 10137.1 10180.5 10237.0 10263.2 10592.7 17647.8 17756.3 17775.4 17835.1 17883.6 7099.9 7154.4 7479.6 7492.9 7567.5 4328.3 4344.0 4403.6 4421.8 4436.1 2992.8 3000.3 3012.2 3024.4 3030.1 520.9 542.4 542.8 554.4 554.5 475.7 589.8 605.1 612.8 614.4 8445.7 8720.7 9177.4 9248.4 9328.9 478.0 575.5 586.8 628.1 651.8 3823.3 4036.1 4053.0 4080.5 4222.1 51053.0 51488.0 51506.7 51877.5 51915.7 46755.0 46931.5 47113.5 47473.5 47491.5 43745.1 43828.8 43895.6 44121.1 44192.6 8077.2 8216.5 8261.7 8314.5 8331.3 32067.5 32713.2 32917.0 34116.3 34191.7 37906.4 40572.0 41771.0 41918.0 42588.4 9209.4 9236.7 9322.4 9334.1 9587.0 10315.4 10358.8 10471.2 10632.6 10821.1 9927.0 10002.2 10106.9 10117.9 10326.9 9925.0 10176.5 10218.5 10278.0 10461.7 9319.7 9404.2 9596.7 9649.8 9666.9 8338.9 8557.4 8620.5 8960.0 9011.3 8974.9 9014.1 9024.2 9075.0 9120.7 08:25:51 INFO - PROCESS | 32461 | -------- Summary: end -------- 08:25:51 INFO - PROCESS | 32461 | 08:25:52 INFO - TEST-INFO | 32461: exit 0 08:25:52 INFO - TEST-OK | dromaeo_css | took 1111052ms 08:25:52 INFO - TEST-START | kraken 08:25:52 INFO - operating with platform_type : linux_ 08:25:52 INFO - Initialising browser for kraken test... 08:25:52 INFO - TEST-INFO | started process 32706 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpN1RWp8/profile http://localhost:59664/getInfo.html) 08:25:56 INFO - PROCESS | 32706 | __metrics Screen width/height:1600/1200 08:25:56 INFO - PROCESS | 32706 | colorDepth:24 08:25:56 INFO - PROCESS | 32706 | Browser inner width/height: 1024/697 08:25:56 INFO - PROCESS | 32706 | __metrics 08:25:56 INFO - PROCESS | 32706 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:25:57 INFO - TEST-INFO | 32706: exit 0 08:25:57 INFO - Browser initialized. 08:25:57 INFO - Running cycle 1/1 for kraken test... 08:25:57 INFO - TEST-INFO | started process 363 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpN1RWp8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:26:09 INFO - PROCESS | 363 | RSS: Main: 149651456 08:26:09 INFO - PROCESS | 363 | 08:26:11 INFO - PROCESS | 363 | Cycle 1(1): loaded http://localhost:59664/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59664/tests/kraken/driver.html?testName=audio-beat-detection) 08:26:12 INFO - PROCESS | 363 | RSS: Main: 150818816 08:26:12 INFO - PROCESS | 363 | 08:26:15 INFO - PROCESS | 363 | Cycle 1(1): loaded http://localhost:59664/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59664/tests/kraken/driver.html?testName=audio-dft) 08:26:15 INFO - PROCESS | 363 | RSS: Main: 151396352 08:26:15 INFO - PROCESS | 363 | 08:26:18 INFO - PROCESS | 363 | Cycle 1(1): loaded http://localhost:59664/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59664/tests/kraken/driver.html?testName=audio-fft) 08:26:19 INFO - PROCESS | 363 | RSS: Main: 146022400 08:26:19 INFO - PROCESS | 363 | 08:26:21 INFO - PROCESS | 363 | Cycle 1(1): loaded http://localhost:59664/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59664/tests/kraken/driver.html?testName=audio-oscillator) 08:26:21 INFO - PROCESS | 363 | RSS: Main: 146477056 08:26:21 INFO - PROCESS | 363 | 08:26:24 INFO - PROCESS | 363 | Cycle 1(1): loaded http://localhost:59664/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59664/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:26:24 INFO - PROCESS | 363 | RSS: Main: 146345984 08:26:24 INFO - PROCESS | 363 | 08:26:27 INFO - PROCESS | 363 | Cycle 1(1): loaded http://localhost:59664/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59664/tests/kraken/driver.html?testName=imaging-darkroom) 08:26:28 INFO - PROCESS | 363 | RSS: Main: 147492864 08:26:28 INFO - PROCESS | 363 | 08:26:31 INFO - PROCESS | 363 | Cycle 1(1): loaded http://localhost:59664/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59664/tests/kraken/driver.html?testName=imaging-desaturate) 08:26:32 INFO - PROCESS | 363 | RSS: Main: 148455424 08:26:32 INFO - PROCESS | 363 | 08:26:35 INFO - PROCESS | 363 | Cycle 1(1): loaded http://localhost:59664/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59664/tests/kraken/driver.html?testName=json-parse-financial) 08:26:35 INFO - PROCESS | 363 | RSS: Main: 148692992 08:26:35 INFO - PROCESS | 363 | 08:26:37 INFO - PROCESS | 363 | Cycle 1(1): loaded http://localhost:59664/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59664/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:26:37 INFO - PROCESS | 363 | RSS: Main: 148385792 08:26:37 INFO - PROCESS | 363 | 08:26:39 INFO - PROCESS | 363 | Cycle 1(1): loaded http://localhost:59664/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59664/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:26:40 INFO - PROCESS | 363 | RSS: Main: 149069824 08:26:40 INFO - PROCESS | 363 | 08:26:42 INFO - PROCESS | 363 | Cycle 1(1): loaded http://localhost:59664/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59664/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:26:43 INFO - PROCESS | 363 | RSS: Main: 148934656 08:26:43 INFO - PROCESS | 363 | 08:26:45 INFO - PROCESS | 363 | Cycle 1(1): loaded http://localhost:59664/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59664/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:26:46 INFO - PROCESS | 363 | RSS: Main: 148807680 08:26:46 INFO - PROCESS | 363 | 08:26:48 INFO - PROCESS | 363 | Cycle 1(1): loaded http://localhost:59664/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59664/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:26:49 INFO - PROCESS | 363 | RSS: Main: 149192704 08:26:49 INFO - PROCESS | 363 | 08:26:51 INFO - PROCESS | 363 | Cycle 1(1): loaded http://localhost:59664/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59664/tests/kraken/driver.html?testName=ai-astar) 08:26:51 INFO - PROCESS | 363 | RSS: Main: 149962752 08:26:51 INFO - PROCESS | 363 | 08:26:51 INFO - PROCESS | 363 | __start_tp_report 08:26:51 INFO - PROCESS | 363 | _x_x_mozilla_page_load 08:26:51 INFO - PROCESS | 363 | _x_x_mozilla_page_load_details 08:26:51 INFO - PROCESS | 363 | |i|pagename|runs| 08:26:51 INFO - PROCESS | 363 | |0;ai-astar;111;107;111;112;110;123;112;121;114;112 08:26:51 INFO - PROCESS | 363 | |1;audio-beat-detection;155;129;149;170;126;158;153;126;162;128 08:26:51 INFO - PROCESS | 363 | |2;audio-dft;162;164;161;163;161;162;163;166;171;167 08:26:51 INFO - PROCESS | 363 | |3;audio-fft;71;75;72;74;72;72;136;74;71;75 08:26:51 INFO - PROCESS | 363 | |4;audio-oscillator;97;97;139;98;96;97;141;97;97;139 08:26:51 INFO - PROCESS | 363 | |5;imaging-gaussian-blur;110;110;111;110;110;109;109;110;110;110 08:26:51 INFO - PROCESS | 363 | |6;imaging-darkroom;147;146;147;147;147;147;147;147;148;146 08:26:51 INFO - PROCESS | 363 | |7;imaging-desaturate;96;97;97;98;97;98;97;96;96;96 08:26:51 INFO - PROCESS | 363 | |8;json-parse-financial;59;59;61;61;59;66;59;60;55;59 08:26:51 INFO - PROCESS | 363 | |9;json-stringify-tinderbox;67;68;67;68;68;68;68;68;68;68 08:26:51 INFO - PROCESS | 363 | |10;stanford-crypto-aes;85;94;85;87;87;96;87;86;86;86 08:26:51 INFO - PROCESS | 363 | |11;stanford-crypto-ccm;128;124;127;128;118;129;123;121;121;126 08:26:51 INFO - PROCESS | 363 | |12;stanford-crypto-pbkdf2;145;162;155;159;166;147;163;154;154;155 08:26:51 INFO - PROCESS | 363 | |13;stanford-crypto-sha256-iterative;68;69;71;68;71;69;68;69;73;68 08:26:51 INFO - PROCESS | 363 | __end_tp_report 08:26:51 INFO - PROCESS | 363 | __start_cc_report 08:26:51 INFO - PROCESS | 363 | _x_x_mozilla_cycle_collect,749 08:26:51 INFO - PROCESS | 363 | __end_cc_report 08:26:51 INFO - PROCESS | 363 | __startTimestamp1451406411327__endTimestamp 08:26:51 INFO - PROCESS | 363 | 08:26:51 INFO - PROCESS | 363 | ------- Summary: start ------- 08:26:51 INFO - PROCESS | 363 | Number of tests: 14 08:26:51 INFO - PROCESS | 363 | 08:26:51 INFO - PROCESS | 363 | [#0] ai-astar Cycles:10 Average:113.30 Median:112.00 stddev:4.95 (4.4%) stddev-sans-first:5.17 08:26:51 INFO - PROCESS | 363 | Values: 111.0 107.0 111.0 112.0 110.0 123.0 112.0 121.0 114.0 112.0 08:26:51 INFO - PROCESS | 363 | 08:26:51 INFO - PROCESS | 363 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:154.00 stddev:16.75 (10.9%) stddev-sans-first:17.42 08:26:51 INFO - PROCESS | 363 | Values: 155.0 129.0 149.0 170.0 126.0 158.0 153.0 126.0 162.0 128.0 08:26:51 INFO - PROCESS | 363 | 08:26:51 INFO - PROCESS | 363 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:3.16 (1.9%) stddev-sans-first:3.27 08:26:51 INFO - PROCESS | 363 | Values: 162.0 164.0 161.0 163.0 161.0 162.0 163.0 166.0 171.0 167.0 08:26:51 INFO - PROCESS | 363 | 08:26:51 INFO - PROCESS | 363 | [#3] audio-fft Cycles:10 Average:79.20 Median:73.00 stddev:20.02 (27.4%) stddev-sans-first:21.01 08:26:51 INFO - PROCESS | 363 | Values: 71.0 75.0 72.0 74.0 72.0 72.0 136.0 74.0 71.0 75.0 08:26:51 INFO - PROCESS | 363 | 08:26:51 INFO - PROCESS | 363 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:97.00 stddev:20.62 (21.3%) stddev-sans-first:21.35 08:26:51 INFO - PROCESS | 363 | Values: 97.0 97.0 139.0 98.0 96.0 97.0 141.0 97.0 97.0 139.0 08:26:51 INFO - PROCESS | 363 | 08:26:51 INFO - PROCESS | 363 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 08:26:51 INFO - PROCESS | 363 | Values: 110.0 110.0 111.0 110.0 110.0 109.0 109.0 110.0 110.0 110.0 08:26:51 INFO - PROCESS | 363 | 08:26:51 INFO - PROCESS | 363 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 08:26:51 INFO - PROCESS | 363 | Values: 147.0 146.0 147.0 147.0 147.0 147.0 147.0 147.0 148.0 146.0 08:26:51 INFO - PROCESS | 363 | 08:26:51 INFO - PROCESS | 363 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:97.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 08:26:51 INFO - PROCESS | 363 | Values: 96.0 97.0 97.0 98.0 97.0 98.0 97.0 96.0 96.0 96.0 08:26:51 INFO - PROCESS | 363 | 08:26:51 INFO - PROCESS | 363 | [#8] json-parse-financial Cycles:10 Average:59.80 Median:59.50 stddev:2.74 (4.6%) stddev-sans-first:2.89 08:26:51 INFO - PROCESS | 363 | Values: 59.0 59.0 61.0 61.0 59.0 66.0 59.0 60.0 55.0 59.0 08:26:51 INFO - PROCESS | 363 | 08:26:51 INFO - PROCESS | 363 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 08:26:51 INFO - PROCESS | 363 | Values: 67.0 68.0 67.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 08:26:51 INFO - PROCESS | 363 | 08:26:51 INFO - PROCESS | 363 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:87.00 stddev:3.84 (4.4%) stddev-sans-first:3.93 08:26:51 INFO - PROCESS | 363 | Values: 85.0 94.0 85.0 87.0 87.0 96.0 87.0 86.0 86.0 86.0 08:26:51 INFO - PROCESS | 363 | 08:26:51 INFO - PROCESS | 363 | [#11] stanford-crypto-ccm Cycles:10 Average:124.50 Median:126.50 stddev:3.69 (2.9%) stddev-sans-first:3.69 08:26:51 INFO - PROCESS | 363 | Values: 128.0 124.0 127.0 128.0 118.0 129.0 123.0 121.0 121.0 126.0 08:26:51 INFO - PROCESS | 363 | 08:26:51 INFO - PROCESS | 363 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.00 Median:157.00 stddev:6.72 (4.3%) stddev-sans-first:5.83 08:26:51 INFO - PROCESS | 363 | Values: 145.0 162.0 155.0 159.0 166.0 147.0 163.0 154.0 154.0 155.0 08:26:51 INFO - PROCESS | 363 | 08:26:51 INFO - PROCESS | 363 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.00 stddev:1.71 (2.5%) stddev-sans-first:1.74 08:26:51 INFO - PROCESS | 363 | Values: 68.0 69.0 71.0 68.0 71.0 69.0 68.0 69.0 73.0 68.0 08:26:51 INFO - PROCESS | 363 | -------- Summary: end -------- 08:26:51 INFO - PROCESS | 363 | 08:26:52 INFO - TEST-INFO | 363: exit 0 08:26:52 INFO - TEST-OK | kraken | took 60114ms 08:26:52 INFO - TEST-START | v8_7 08:26:52 INFO - operating with platform_type : linux_ 08:26:52 INFO - Initialising browser for v8_7 test... 08:26:52 INFO - TEST-INFO | started process 657 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIZxJcY/profile http://localhost:59664/getInfo.html) 08:26:56 INFO - PROCESS | 657 | __metrics Screen width/height:1600/1200 08:26:56 INFO - PROCESS | 657 | colorDepth:24 08:26:56 INFO - PROCESS | 657 | Browser inner width/height: 1024/697 08:26:56 INFO - PROCESS | 657 | __metrics 08:26:56 INFO - PROCESS | 657 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:26:57 INFO - TEST-INFO | 657: exit 0 08:26:57 INFO - Browser initialized. 08:26:57 INFO - Running cycle 1/1 for v8_7 test... 08:26:57 INFO - TEST-INFO | started process 785 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIZxJcY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:27:09 INFO - PROCESS | 785 | RSS: Main: 148639744 08:27:09 INFO - PROCESS | 785 | 08:27:30 INFO - PROCESS | 785 | Cycle 1(1): loaded http://localhost:59664/tests/v8_7/run.html (next: http://localhost:59664/tests/v8_7/run.html) 08:27:31 INFO - PROCESS | 785 | RSS: Main: 145879040 08:27:31 INFO - PROCESS | 785 | 08:27:31 INFO - PROCESS | 785 | __start_tp_report 08:27:31 INFO - PROCESS | 785 | _x_x_mozilla_page_load 08:27:31 INFO - PROCESS | 785 | _x_x_mozilla_page_load_details 08:27:31 INFO - PROCESS | 785 | |i|pagename|runs| 08:27:31 INFO - PROCESS | 785 | |0;Richards;168.66250632484397 08:27:31 INFO - PROCESS | 785 | |1;DeltaBlue;190.5850962454736 08:27:31 INFO - PROCESS | 785 | |2;Encrypt;280.1120448179272 08:27:31 INFO - PROCESS | 785 | |3;Decrypt;5246.073298429319 08:27:31 INFO - PROCESS | 785 | |4;RayTrace;1094.0919037199126 08:27:31 INFO - PROCESS | 785 | |5;Earley;704.9295774647887 08:27:31 INFO - PROCESS | 785 | |6;Boyer;12256.09756097561 08:27:31 INFO - PROCESS | 785 | |7;RegExp;25075 08:27:31 INFO - PROCESS | 785 | |8;Splay;689.3939393939394 08:27:31 INFO - PROCESS | 785 | |9;NavierStokes;4840.579710144928 08:27:31 INFO - PROCESS | 785 | __end_tp_report 08:27:31 INFO - PROCESS | 785 | __startTimestamp1451406451244__endTimestamp 08:27:31 INFO - PROCESS | 785 | 08:27:31 INFO - PROCESS | 785 | ------- Summary: start ------- 08:27:31 INFO - PROCESS | 785 | Number of tests: 10 08:27:31 INFO - PROCESS | 785 | 08:27:31 INFO - PROCESS | 785 | [#0] Richards Cycles:1 Average:168.66 Median:168.66 stddev:0.00 (0.0%) 08:27:31 INFO - PROCESS | 785 | Values: 168.7 08:27:31 INFO - PROCESS | 785 | 08:27:31 INFO - PROCESS | 785 | [#1] DeltaBlue Cycles:1 Average:190.59 Median:190.59 stddev:0.00 (0.0%) 08:27:31 INFO - PROCESS | 785 | Values: 190.6 08:27:31 INFO - PROCESS | 785 | 08:27:31 INFO - PROCESS | 785 | [#2] Encrypt Cycles:1 Average:280.11 Median:280.11 stddev:0.00 (0.0%) 08:27:31 INFO - PROCESS | 785 | Values: 280.1 08:27:31 INFO - PROCESS | 785 | 08:27:31 INFO - PROCESS | 785 | [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 08:27:31 INFO - PROCESS | 785 | Values: 5246.1 08:27:31 INFO - PROCESS | 785 | 08:27:31 INFO - PROCESS | 785 | [#4] RayTrace Cycles:1 Average:1094.09 Median:1094.09 stddev:0.00 (0.0%) 08:27:31 INFO - PROCESS | 785 | Values: 1094.1 08:27:31 INFO - PROCESS | 785 | 08:27:31 INFO - PROCESS | 785 | [#5] Earley Cycles:1 Average:704.93 Median:704.93 stddev:0.00 (0.0%) 08:27:31 INFO - PROCESS | 785 | Values: 704.9 08:27:31 INFO - PROCESS | 785 | 08:27:31 INFO - PROCESS | 785 | [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 08:27:31 INFO - PROCESS | 785 | Values: 12256.1 08:27:31 INFO - PROCESS | 785 | 08:27:31 INFO - PROCESS | 785 | [#7] RegExp Cycles:1 Average:25075.00 Median:25075.00 stddev:0.00 (0.0%) 08:27:31 INFO - PROCESS | 785 | Values: 25075.0 08:27:31 INFO - PROCESS | 785 | 08:27:31 INFO - PROCESS | 785 | [#8] Splay Cycles:1 Average:689.39 Median:689.39 stddev:0.00 (0.0%) 08:27:31 INFO - PROCESS | 785 | Values: 689.4 08:27:31 INFO - PROCESS | 785 | 08:27:31 INFO - PROCESS | 785 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 08:27:31 INFO - PROCESS | 785 | Values: 4840.6 08:27:31 INFO - PROCESS | 785 | -------- Summary: end -------- 08:27:31 INFO - PROCESS | 785 | 08:27:32 INFO - TEST-INFO | 785: exit 0 08:27:32 INFO - TEST-OK | v8_7 | took 39879ms 08:27:32 INFO - SUITE-END | took 1211s 08:27:32 INFO - Completed test suite (00:20:11) 08:27:32 INFO - Working with test: dromaeo_css 08:27:32 INFO - Generating results file: dromaeo_css 08:27:32 INFO - Working with test: kraken 08:27:32 INFO - Generating results file: kraken 08:27:32 INFO - javascript benchmark 08:27:32 INFO - Working with test: v8_7 08:27:32 INFO - Generating results file: v8_7 08:27:32 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:27:32 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 08:27:32 INFO - process_Request line: dromaeo_css 6941.25 graph.html#tests=[[72,64,43]] 08:27:32 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:27:32 INFO - process_Request line: kraken 1530.90 graph.html#tests=[[232,64,43]] 08:27:32 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:27:32 INFO - process_Request line: v8_7 21000.89 graph.html#tests=[[230,64,43]] 08:27:32 INFO - RETURN: dromaeo_css: 6941.25 08:27:32 INFO - RETURN: kraken: 1530.90 08:27:32 INFO - RETURN: v8_7: 21000.89 08:27:32 INFO - javascript benchmark 08:27:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3168.6533223380056, 3199.85600647971, 3228.0315905228426, 3258.120307516971, 3263.967360326396, 5233.816816411417, 5315.495027972342, 5334.653247538917, 5340.519353258211, 5368.651037682553, 5300.893982120355, 5305.098133317336, 5316.149416093426, 5320.17537281722, 5325.627206095575, 4783.067301876135, 4805.870620404202, 4831.565159135677, 4987.950120498803, 5008.123578373788, 4876.0, 4904.75476226189, 4926.187179115442, 4961.8511444656715, 4975.925361119586, 4731.503192164808, 4910.435299940516, 4913.385826771653, 4915.16442204826, 4927.605791536686, 4799.928001079987, 4877.317175595384, 4885.755712214375, 4947.876303092416, 4989.251612258154, 4845.4185497740145, 4876.195427754416, 4896.6572339935865, 4897.9143139822045, 4922.556969872693, 5014.749262536859, 5140.74296285188, 5208.869778255574, 5210.426853046162, 5220.321358223445, 5682.857928551778, 5787.681677507735, 5803.042497987827, 5825.0, 5876.853078673067, 5749.741261643194, 5757.596968212227, 5761.539076873882, 5761.683107429089, 5765.048766953448, 5318.468153184651, 5363.436839131835, 5376.784928602851, 5383.192521121824, 5410.107332290128, 5813.069908814569, 5824.796132135355, 5840.0, 5842.152887831241, 5880.647161170344, 5628.859278517988, 5634.32388113429, 5635.098384258499, 5641.2384328116, 5642.294713160855, 5648.717564121777, 5716.142578613241, 5718.628289161191, 5775.5090817281, 5830.766769329264, 5765.798197063083, 5773.278340207474, 5774.826755197267, 5778.5377169826315, 5812.157237200667, 5703.74333155009, 5710.5146062585145, 5760.135979603009, 5767.826965191051, 5780.364159942403, 4406.074724307931, 4429.313456414261, 4466.0, 4483.977580112144, 4526.592606665416, 3950.3481925482547, 3971.4638523798917, 3984.2230765000545, 4001.0597509585223, 4019.336809426412, 5274.525292723673, 5282.683039017671, 5297.973510132425, 5305.230741542455, 5315.893682126413, 5534.114541673393, 5638.0, 5742.3396309424115, 5794.739236734357, 5811.360750317462, 5249.133892907704, 5252.317198764136, 5260.132078207053, 5275.235090911796, 5314.123169677037, 4919.729414882216, 5017.8606866441605, 5037.722925239147, 5040.672356296829, 5080.085584594734, 5811.186433899257, 5814.040683287295, 5868.67722275279, 5878.412158784087, 5945.375735547792, 5686.601937864475, 5728.914066288926, 5756.021476349115, 5757.424257574209, 5764.798232062026, 5702.315722113373, 5718.399568045462, 5777.711114444345, 5780.94219057804, 5825.533957283323, 5646.378898321099, 5715.142728590745, 5768.971155144198, 5801.622894511843, 5809.622374545641, 5756.251687280626, 5797.333306669787, 5808.5643576732755, 5812.622179558484, 5815.4184581543195, 5465.9726701366235, 5626.690532020614, 5658.17956396312, 5666.263385759825, 5672.03575392176, 5524.585656075891, 5557.444255574572, 5594.664320140804, 5641.605087643826, 5691.402402747652, 5575.749091290821, 5611.466910643482, 5621.803236886853, 5639.069553523623, 5645.49190572834, 5551.333839939233, 5638.774449021993, 5677.74450149736, 5742.569307302053, 5768.423157684198, 5397.514223719884, 5473.370562385377, 5557.249771280825, 5579.358373787067, 5585.162225666182], "unit": "score", "name": "dojo.html", "value": 5291.6119811108465}, {"lowerIsBetter": false, "replicates": [530.5834919588123, 544.4854612391292, 554.0581012279126, 555.1783360626273, 569.9116636921274, 35150.824245878764, 36123.0, 36126.8193659032, 36138.45792313114, 36296.81851590745, 38413.423798643045, 38691.61308386915, 38971.41542876859, 38975.0, 39065.0, 8375.91624083759, 8544.060153383123, 8544.70093546726, 8548.529830859301, 8603.0, 8294.682127149159, 8418.0, 8456.83086338276, 8471.661133554651, 8472.27985621223, 8534.1039190885, 8579.957100214522, 8595.312375010015, 8613.483191008529, 8688.131186881294, 8529.658813647447, 8570.742877713647, 8589.184027517376, 8596.226339629464, 8648.610812513452, 8450.366222533334, 8583.656653733844, 8612.224899759052, 8649.52957997142, 8667.479951202886, 38546.421803672965, 38590.42114368287, 38907.22185556301, 39024.414633780514, 39058.0, 3257.6742325767473, 3259.6251431085493, 3402.0814380117477, 3527.2592755521373, 3565.9108522286892, 29670.85164574185, 29769.0, 29803.70196298031, 30025.099247022623, 30181.698183018107, 3865.8646947356706, 3881.4954055972544, 3928.823202955874, 4004.4516087175593, 4021.4369988201674, 253648.99999999817, 255492.0, 255930.0, 256600.0, 257048.0, 49896.0, 50737.44837861388, 54590.0, 54789.726051369486, 55851.441485585434, 50982.74508627433, 51289.487105129214, 51468.0, 51544.22683659748, 51839.0, 14102.0, 14326.57020289393, 14348.354324055234, 14358.856411435961, 14386.424543018162, 10769.730756731144, 10891.509882055327, 10894.509747061402, 10925.453727313761, 10926.890731092746, 18105.818941810678, 18307.63384732298, 19158.61682766337, 19179.61640767177, 19208.327708530134, 7471.70113195477, 7567.962160189164, 7659.119201291811, 7689.115751688516, 7800.063992320957, 962.855571664256, 969.8593703912893, 1083.1172594335749, 1111.111111111108, 1135.4152611405134, 27988.86005569959, 28056.0, 28157.155285341472, 28274.85862570674, 28322.433551328857, 1075.7471994081384, 1079.1798233342715, 1087.0922779479065, 1144.3362849547243, 1231.2735486063266, 14697.706045879237, 14716.264186790617, 14752.40990360395, 14883.181425021729, 14926.0, 293929.0, 299507.0, 300795.0, 300915.9908400888, 301374.0, 49695.0, 50257.74871125621, 50460.0, 50502.49497505051, 50741.23888141681, 1294.0682708449901, 1298.9740205195844, 1308.8822006019504, 1316.9341532923506, 1325.2975922760952, 26737.866310668323, 27596.862015689792, 27607.171784846487, 28069.298267542657, 28149.859250704434, 44305.33541996808, 44878.55121448874, 44923.77538112288, 45039.0, 45130.77434612806, 274136.0, 277439.0, 277497.0, 278895.0, 279236.0, 31769.364612707155, 31810.52284215785, 31963.840180798947, 32312.515312269865, 32349.0, 36138.0, 36757.63242367649, 36869.81565092158, 36997.260054798215, 37095.629043710294, 31965.36069278648, 33468.49797252994, 34138.82930585331, 34552.82723586366, 34649.82675086709, 34729.479057813645, 34985.82507087448, 35291.29417411689, 35881.46177807387, 36009.639903601674, 31779.20551986219, 32178.67821321757, 32205.677943220267, 32210.83894580512, 32228.19429514187, 27234.72765272401, 29883.70116298896, 31894.362112758077, 32821.343573128885, 32908.83545582257, 22778.544429111655, 23679.1712290069, 23725.16961906325, 24135.0, 24228.39429014289], "unit": "score", "name": "ext.html", "value": 17756.37517584968}, {"lowerIsBetter": false, "replicates": [346.59621540904845, 347.7548328428458, 350.5652990292037, 353.133058341771, 353.80717508957616, 11270.380129092897, 11678.47446864891, 16249.512514624565, 16405.83594164058, 17326.65346693067, 17892.64214715705, 17927.91036044818, 17984.10079496023, 18310.725339119923, 18320.175592098356, 6044.546659000571, 6230.657313847737, 6231.688415579226, 6239.750409983618, 6241.563090583661, 6169.352218017111, 6259.687015649222, 6261.592996455239, 6369.299377068519, 6574.506911981596, 6195.721192546323, 6443.452306553949, 6451.419372256496, 6526.118973938505, 6537.607743535403, 6370.0, 6373.872522549523, 6462.0306953956815, 6467.288598254188, 6762.289959554225, 6455.193100862392, 6468.935310646881, 6471.611703297817, 6473.255575608819, 6480.287168411471, 20123.89938050315, 20960.685589716166, 21212.363629091153, 21403.357899263046, 21675.783242167534, 2243.7980581747556, 2252.2454977582365, 2253.5605556916407, 2399.3042017814814, 2425.672534207877, 14332.0, 14373.353199106064, 14615.707685846224, 14978.70042599142, 14995.250237488191, 1971.2016633263408, 2003.2587942461237, 2005.7492813398326, 2045.4784030072237, 2064.112431654388, 62470.0, 66261.0, 67671.0, 68549.31450685479, 68890.3110968889, 14805.629859253604, 15321.23393830304, 15346.462873799363, 15379.384824607114, 15402.845971540366, 23646.64530032051, 23826.88086559556, 23874.7612523876, 24101.879490602434, 24130.638040429407, 8702.260307873901, 8756.912430875736, 8790.472571645594, 8806.427582207265, 8807.955960220286, 7370.189279179286, 7380.557166570023, 7407.111146662435, 7415.3326200642205, 7438.1446133694235, 7550.546967181876, 7628.732994345282, 7679.769606911802, 7680.078390593053, 7697.461177717506, 1766.6025144342677, 2938.676745557987, 2975.375171214026, 3004.7145521175453, 3030.257586891226, 428.4087958617088, 433.559936664286, 442.71887351532007, 859.2266959736287, 978.3542861711236, 10027.598896044077, 10579.576816927236, 10925.617603384002, 11028.944855275833, 11157.832632510519, 899.3558936726005, 949.7815502434479, 1003.9196864250843, 1012.8885822559513, 1022.1873610479687, 9261.120193581599, 9402.0, 9411.482368469662, 9465.90534094664, 9587.952060239653, 519231.0, 537884.0, 547154.0, 548023.0, 558733.0, 67802.0, 69584.0, 70844.64577677079, 77285.2271477278, 78067.0, 1154.9538018479334, 1163.4648061891626, 1168.8363629091934, 1170.414792603698, 1172.5720112159001, 14659.853401466275, 14692.779608305671, 14700.632484187981, 14819.555413337617, 15069.773953390928, 31026.74219206951, 31077.223069423446, 31535.21161970969, 31542.526862096627, 31551.684483154873, 40134.598654014255, 41030.58969410268, 41114.0, 46325.76837115793, 46951.29573056475, 9256.213221875947, 9404.106609872051, 9508.572114255014, 9515.143637072697, 9527.333086683866, 11245.606403775828, 16142.435014774426, 16542.42101526441, 17238.224279907183, 17377.47867563975, 14202.786958195842, 14287.64280892986, 14361.138331700131, 14384.42462301538, 14473.203973781543, 13909.791353129913, 13933.715424869175, 13985.510507132201, 14185.858141418454, 14567.781483277548, 14369.13785172893, 14426.927865360605, 14517.0, 14700.77948830747, 14912.552623421314, 9109.453432794053, 9441.811163776823, 9465.810683786423, 9631.614735410505, 9925.602975881173, 14157.009009369245, 14199.858001419854, 14725.410983560538, 14806.963512554017, 15202.847971520143], "unit": "score", "name": "jquery.html", "value": 9510.457391893406}, {"lowerIsBetter": false, "replicates": [1422.822147231596, 1441.7621092519735, 1553.4951140879218, 1709.2821015173627, 1761.735739639054, 7347.853042939145, 7415.258474152595, 7503.662335194916, 7516.5865877376655, 7531.623418829064, 7390.482666213367, 7417.851642967137, 7482.812929676761, 7484.663190156442, 7512.0, 2204.790544898236, 2232.6427771556555, 2233.0, 2237.1722462688745, 2242.8093612042994, 2190.507135894427, 2199.6920431139574, 2206.6910632511463, 2210.3148024112497, 2224.9555008899893, 2159.600473912323, 2187.1688758271835, 2204.4048107011176, 2208.2712704807454, 2234.72065991751, 2183.5742030304095, 2185.366243789299, 2219.911203551856, 2240.529488807352, 2245.191730976847, 2233.832462565314, 2235.519363336874, 2250.189931624614, 2254.1546919905036, 2259.6723475096182, 7386.446016548781, 7439.0, 7511.6244187790935, 7526.774196774106, 7546.245375462465, 4507.729536227836, 4587.9541204588195, 4595.448546174447, 4622.19111655459, 4628.884277893046, 2890.4508143452676, 2976.241058530061, 3016.441958237733, 3027.0918724382595, 3036.6356037275445, 910.8724778531011, 923.6628630549801, 928.6239073175375, 955.7753927826955, 990.6631745206664, 10038.64864729731, 10038.799224015478, 10062.496875156286, 10064.748381290454, 10107.191424686007, 3985.661218796377, 4037.37420699792, 4052.209819085309, 4061.7766022868436, 4085.0, 8214.301784348278, 8267.958660206781, 8339.166083391612, 8352.206540378655, 8359.665613375519, 4546.090781843644, 4547.772611369418, 4548.818047278071, 4551.40831691878, 4552.886177845514, 4151.294279972412, 4194.958050419456, 4198.181354635817, 4208.810603522848, 4233.364995250676, 3314.419976504102, 3323.6011678598725, 3340.9832950835576, 3352.860027590631, 3366.4781958796425, 971.1599466461602, 973.454865275448, 975.4488713876636, 982.8673129127476, 995.576879826071, 890.0876601483532, 939.990600094004, 1082.0748260237542, 1111.6387174168428, 1305.106002388367, 6732.225794033651, 6745.0556922030955, 6761.628110453874, 6784.287649796799, 6796.76211332601, 586.5366360575098, 601.4226342711046, 604.4982664388547, 639.2329204954074, 743.598456833304, 5174.43081261061, 5267.868303292448, 5275.60432967529, 5276.815311464157, 5301.867453313698, 8219.794505137299, 8222.917770822334, 8372.330213582898, 8401.70594029206, 8459.788505287293, 8300.916990830014, 8302.211289927447, 8304.211099945496, 8344.874826877602, 8409.621567029499, 6773.72905083801, 6852.6231057292325, 6922.41159501438, 6958.8956165657555, 7039.36645701879, 6944.4444444445335, 7012.474064445289, 7017.508774385744, 7020.929790702232, 7023.929760702532, 7715.716794380659, 7861.135275119618, 8009.399295053011, 8059.6776128956535, 8117.797055073434, 8072.071711752988, 8104.594770261581, 8205.343572514064, 8250.257476827115, 8353.415260931919, 6602.7689030883685, 6654.301298363602, 6664.666766661744, 6697.229818570927, 6764.492663050192, 6982.860342793218, 7023.981522679285, 7046.013558101972, 7085.574865508086, 7103.289671032855, 6440.4525615321345, 6857.657117144223, 6900.378965893094, 7022.508424410446, 7040.331168538981, 6432.2602900667025, 6451.1936007999, 6541.378569035934, 6595.142631457879, 6598.241202261609, 6317.115603815561, 6333.429991300805, 6604.504662150454, 6740.595564266159, 6763.357481039294, 6242.157308763259, 6248.0003199487865, 6252.562320637512, 6265.968670156803, 6299.0, 6057.57596968208, 6061.302950160788, 6065.120557519223, 6078.90881636767, 6208.875822483435], "unit": "score", "name": "mootools.html", "value": 4197.930944328345}, {"lowerIsBetter": false, "replicates": [329.98845040423583, 338.6985582831279, 345.12166536165455, 346.96604119723224, 347.572485842414, 6216.84457888553, 6223.066540018999, 6237.781677641284, 6284.057391391294, 6385.393387628168, 6155.692215389224, 6281.523841897162, 6298.590591611542, 6303.684815759205, 6316.27362853272, 4745.406824146981, 4755.881102972436, 4757.619390448773, 4760.214564596846, 4764.0, 4762.809487620491, 4763.833265835697, 4772.976135119319, 4774.594159496447, 4774.880627984294, 4632.0967411354795, 4708.458527269374, 4722.433308003045, 4724.574788269072, 4731.361266229067, 4661.557152070548, 4695.225287827504, 4697.506761790014, 4699.342092107107, 4705.294205869112, 4045.0696339841707, 4057.69567282455, 4059.451973983504, 4069.6337329640473, 4078.490188726409, 5951.732172052225, 5972.820815375546, 5980.192673989, 5980.8504787380225, 5988.820335389945, 5378.704171270579, 5384.976854397652, 5390.110631745796, 5399.865003374908, 5400.702961337125, 6618.172728408949, 6629.900551491732, 6646.069550262919, 6647.567908085959, 6676.031975363545, 4371.431713877208, 4376.212281789277, 4377.0, 4382.189294980439, 4383.254846676041, 6752.8311792205095, 6814.250432452426, 6824.488163387716, 6833.555818871758, 6847.623380714059, 4577.702449340783, 4584.747838868894, 4592.816287348535, 4593.402857628487, 4594.494605593382, 4627.768611569408, 4635.420572428447, 4646.930296045562, 4664.346991421204, 4668.0, 5406.864828379322, 5412.377576578665, 5413.917216556704, 5418.91871621926, 5424.945750542444, 6471.255805582324, 6559.114519539897, 6570.178727659043, 6573.737050517926, 6581.83545411359, 1620.3437607768872, 1635.7709920611123, 1635.8118816336037, 1639.524537884024, 1647.6869394814946, 1091.737982884118, 1098.9285696429706, 1103.9889601103887, 1105.6075093341908, 1121.5233525751523, 6021.157038014681, 6021.5182785377065, 6029.276486821609, 6076.997295446202, 6095.969520152371, 6716.832079197961, 6734.6632668367365, 6771.356721111487, 6777.1189745332795, 6781.050652908597, 5906.173135760997, 6062.454379105901, 6079.270487541523, 6081.270247570232, 6094.329623741385, 3697.1681371691157, 3704.203596226824, 3707.981460092736, 3708.0, 3716.0709822544363, 6862.828429289308, 6922.926946323328, 6926.861462770717, 6927.445804335641, 6944.201416837027, 6863.588184708933, 6960.269171736996, 6986.615736134459, 7020.7542736004, 7035.0, 6851.109355783717, 6854.417374523221, 6866.176058873067, 6901.447884169254, 6905.447564194852, 6744.0558321834005, 6755.459563234831, 6769.796906092825, 6773.153355830521, 6785.660716964231, 6607.00894865774, 6685.097511836035, 6724.831879203059, 6725.461963042847, 6753.459723222032, 6848.280930502425, 6874.075258927508, 6880.0, 6882.449404047764, 6899.0, 4559.316102584638, 4633.698809577367, 4639.930401043919, 4651.651126165619, 4653.60444362233, 6722.899156512558, 6731.966340168267, 6773.153355830521, 6807.0, 6842.623655698785, 6711.127553418024, 6748.763793267409, 6749.392554670103, 6750.8649827004165, 6768.4585233182215, 6700.262971073275, 6701.1623547056615, 6736.157980252468, 6746.426553742791, 6748.561343512656, 6427.807165785034, 6608.240052393844, 6610.636414997221, 6618.602883826986, 6626.304238055128, 6759.932400675931, 6771.119754431892, 6772.814757417334, 6779.559328643622, 6779.864402712017, 6555.868882622416, 6572.638504882278, 6593.109930159367, 6614.966925165536, 6622.668866556556], "unit": "score", "name": "prototype.html", "value": 4940.520559972565}, {"lowerIsBetter": false, "replicates": [731.7585196885028, 836.2515548584014, 836.4855613797514, 836.5482639374738, 841.5834162089767, 13240.0, 13439.462421503129, 13449.596512104628, 13516.310461192352, 13543.525976590821, 12734.80897786534, 12793.23240605562, 12795.0, 12814.67963300918, 12817.807732883992, 641.4868105515592, 654.2933631677801, 785.8231897822986, 794.253401802304, 807.475141158246, 795.4034474144391, 800.047942947893, 813.4509206285734, 814.3322475570035, 814.8492528882147, 846.3821410370433, 856.1695155698962, 862.7886167888876, 862.9439086459391, 863.2662237098478, 854.8760429737715, 855.285836326668, 856.3406177243488, 856.9957150214241, 857.3784006595231, 624.3631495874229, 625.1903784598956, 628.7390732845863, 629.5844742469993, 629.6348118091496, 13330.800037999437, 13447.596572102853, 13515.864841351657, 13519.594412167651, 13530.86469135306, 11769.41152942358, 12306.138570300083, 12652.114351995364, 12794.104412691115, 13055.0, 10256.282060255786, 10386.428746418944, 10590.0, 10961.616343427942, 11011.119110471143, 3621.1977423705002, 3640.2173532690335, 3646.74472786905, 3684.3736564783785, 3744.475773391727, 43843.56156438427, 45828.312575311065, 46590.06819863584, 46642.76678616619, 46777.532224677656, 10137.087662110445, 10180.541875615616, 10237.0, 10263.178945684327, 10592.735181620366, 17647.823521764876, 17756.289748410178, 17775.377861774778, 17835.10824458772, 17883.642327153386, 7099.935009748579, 7154.391876690435, 7479.626018699152, 7492.925070749332, 7567.545947243183, 4328.28583283761, 4343.956560434355, 4403.581659742319, 4421.801018954155, 4436.068425630654, 2992.8054676445963, 3000.324926891432, 3012.201766531871, 3024.380002099564, 3030.075826872825, 520.9062368773581, 542.3871025740888, 542.8371488553419, 554.3680204566797, 554.5425024354923, 475.70030880545033, 589.775885163635, 605.0500713879168, 612.8406614280319, 614.3948211012149, 8445.704400346081, 8720.65117395297, 9177.403468774508, 9248.352615316997, 9328.860067098998, 477.96415268854975, 575.5424437572141, 586.8415527807468, 628.1049504456132, 651.7686221391338, 3823.3118038752737, 4036.091879327128, 4052.9594704052583, 4080.489938757655, 4222.113356195234, 51053.0, 51488.0, 51506.742466287425, 51877.481225187264, 51915.740421297654, 46755.0, 46931.530684693396, 47113.5288647116, 47473.5252647476, 47491.5250847494, 43745.12509749851, 43828.78085609616, 43895.56104438979, 44121.11757764827, 44192.55807441884, 8077.192280771876, 8216.507009579444, 8261.669533218605, 8314.501129932223, 8331.291840193651, 32067.518987215677, 32713.18217044593, 32917.0, 34116.31767364589, 34191.65808341885, 37906.43140352842, 40572.0, 41771.0, 41918.0, 42588.36117458303, 9209.401388909699, 9236.676716314896, 9322.394044387092, 9334.113259240361, 9586.95206523963, 10315.381077135096, 10358.844617330897, 10471.162307015573, 10632.627858024933, 10821.134309255083, 9926.962144040219, 10002.24983126254, 10106.949465252626, 10117.898821011695, 10326.896731032593, 9925.0, 10176.491175441346, 10218.489075546342, 10278.023587759151, 10461.738456538647, 9319.673811416567, 9404.247660187306, 9596.712098637052, 9649.807003860024, 9666.903330966881, 8338.874251975905, 8557.358198135289, 8620.5258710769, 8959.955200223958, 9011.324150688593, 8974.910250897408, 9014.143656352637, 9024.232940199894, 9074.954625226832, 9120.67750176234], "unit": "score", "name": "yui.html", "value": 6034.411578609673}], "name": "dromaeo_css", "value": 6941.251674554148}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 111.0, 112.0, 110.0, 123.0, 112.0, 121.0, 114.0, 112.0], "unit": "score", "name": "ai-astar", "value": 113.3}, {"lowerIsBetter": true, "replicates": [155.0, 129.0, 149.0, 170.0, 126.0, 158.0, 153.0, 126.0, 162.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 145.6}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 161.0, 163.0, 161.0, 162.0, 163.0, 166.0, 171.0, 167.0], "unit": "score", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [71.0, 75.0, 72.0, 74.0, 72.0, 72.0, 136.0, 74.0, 71.0, 75.0], "unit": "score", "name": "audio-fft", "value": 79.2}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 139.0, 98.0, 96.0, 97.0, 141.0, 97.0, 97.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 111.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 98.0, 97.0, 98.0, 97.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 61.0, 61.0, 59.0, 66.0, 59.0, 60.0, 55.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 59.8}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [85.0, 94.0, 85.0, 87.0, 87.0, 96.0, 87.0, 86.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.9}, {"lowerIsBetter": true, "replicates": [128.0, 124.0, 127.0, 128.0, 118.0, 129.0, 123.0, 121.0, 121.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.5}, {"lowerIsBetter": true, "replicates": [145.0, 162.0, 155.0, 159.0, 166.0, 147.0, 163.0, 154.0, 154.0, 155.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 156.0}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 71.0, 68.0, 71.0, 69.0, 68.0, 69.0, 73.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1530.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.66250632484397], "unit": "score", "name": "Richards", "value": 209.30555800000002}, {"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": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [1094.0919037199126], "unit": "score", "name": "RayTrace", "value": 676.3499459999998}, {"lowerIsBetter": false, "replicates": [704.9295774647887], "unit": "score", "name": "Earley", "value": 945.432027972028}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [25075.0], "unit": "score", "name": "RegExp", "value": 36.33040877367896}, {"lowerIsBetter": false, "replicates": [689.3939393939394], "unit": "score", "name": "Splay", "value": 118.20672527472524}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21000.887163411815}]} 08:27:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21000.89"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1530.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6941.25"}}} 08:27:32 INFO - Return code: 0 08:27:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:27:32 INFO - # TBPL SUCCESS # 08:27:32 INFO - Running post-action listener: _resource_record_post_action 08:27:32 INFO - Running post-run listener: _resource_record_post_run 08:27:33 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 8192; Write bytes: 568537088; Read time: 44; Write time: 505800 08:27:33 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 249450496; Read time: 0; Write time: 337960 08:27:33 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 8192; Write bytes: 319086592; Read time: 44; Write time: 167840 08:27:33 INFO - Running post-run listener: _upload_blobber_files 08:27:33 INFO - Blob upload gear active. 08:27:33 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:27:33 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:27:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 08:27:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 08:27:34 INFO - (blobuploader) - INFO - Open directory for files ... 08:27:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:27:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:27:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:27:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:27:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:27:34 INFO - (blobuploader) - INFO - Done attempting. 08:27:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:27:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:27:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:27:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:27:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:27:35 INFO - (blobuploader) - INFO - Done attempting. 08:27:35 INFO - (blobuploader) - INFO - Iteration through files over. 08:27:35 INFO - Return code: 0 08:27:35 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:27:35 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:27:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d910b4954926ac574f8c0baca241067c6942fdb4a18592d93fba7a3f92c601ef1331a82b195f549cda082ddf0f9ca8a352dbb9910fe667dd9caea6c2b5c1ea2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d97d9bcdfcae12c3f2c1effd6b4eca544c4397f6d679d2df0ae75f8eec701d2dba2dc9b5f62cd025f468caaf988105686403fbd65e952361207f0f276e5fd824"} 08:27:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:27:35 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:27:35 INFO - Contents: 08:27:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d910b4954926ac574f8c0baca241067c6942fdb4a18592d93fba7a3f92c601ef1331a82b195f549cda082ddf0f9ca8a352dbb9910fe667dd9caea6c2b5c1ea2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d97d9bcdfcae12c3f2c1effd6b4eca544c4397f6d679d2df0ae75f8eec701d2dba2dc9b5f62cd025f468caaf988105686403fbd65e952361207f0f276e5fd824"} 08:27:35 INFO - Copying logs to upload dir... 08:27:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.843896 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-29 08:27:35.080812) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 08:27:35.084423) ========= 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=c402a24d74c70935940d60dd000001de-1451404187.464945-957839501 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/4d910b4954926ac574f8c0baca241067c6942fdb4a18592d93fba7a3f92c601ef1331a82b195f549cda082ddf0f9ca8a352dbb9910fe667dd9caea6c2b5c1ea2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d97d9bcdfcae12c3f2c1effd6b4eca544c4397f6d679d2df0ae75f8eec701d2dba2dc9b5f62cd025f468caaf988105686403fbd65e952361207f0f276e5fd824"} build_url:https://queue.taskcluster.net/v1/task/AV-VpCeaRW2-bmk2vBRtcw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011520 build_url: 'https://queue.taskcluster.net/v1/task/AV-VpCeaRW2-bmk2vBRtcw/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/4d910b4954926ac574f8c0baca241067c6942fdb4a18592d93fba7a3f92c601ef1331a82b195f549cda082ddf0f9ca8a352dbb9910fe667dd9caea6c2b5c1ea2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d97d9bcdfcae12c3f2c1effd6b4eca544c4397f6d679d2df0ae75f8eec701d2dba2dc9b5f62cd025f468caaf988105686403fbd65e952361207f0f276e5fd824"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 08:27:35.109054) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 08:27:35.109399) ========= 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=c402a24d74c70935940d60dd000001de-1451404187.464945-957839501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 08:27:35.193343) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 08:27:35.193650) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 08:27:35.193958) ========= ========= Total master_lag: 0.23 =========