builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1452851521.02 results: success (0) buildid: 20160114233009 builduid: 15ee8dc665a14911b0c547f620d4cb75 revision: 0ae26b71481ae676e540a0a2841837fbb939cb88 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:01.025069) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:01.025440) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:01.025734) ========= 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=aa52b8aba932b19cc50b5275000001de-1452850538.205059-1830841570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004953 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:01.084914) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:01.085192) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:01.126233) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:01.126519) ========= 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=aa52b8aba932b19cc50b5275000001de-1452850538.205059-1830841570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.041077 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:01.178370) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:01.181770) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:01.182219) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:01.182540) ========= 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=aa52b8aba932b19cc50b5275000001de-1452850538.205059-1830841570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-15 01:52:01-- 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% 84.6M=0s 2016-01-15 01:52:01 (84.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.231849 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:01.447426) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:01.447758) ========= 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=aa52b8aba932b19cc50b5275000001de-1452850538.205059-1830841570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.073359 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:01.532601) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:01.532960) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0ae26b71481ae676e540a0a2841837fbb939cb88 --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 0ae26b71481ae676e540a0a2841837fbb939cb88 --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=aa52b8aba932b19cc50b5275000001de-1452850538.205059-1830841570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-15 01:52:01,519 truncating revision to first 12 chars 2016-01-15 01:52:01,519 Setting DEBUG logging. 2016-01-15 01:52:01,520 attempt 1/10 2016-01-15 01:52:01,520 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0ae26b71481a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-15 01:52:01,782 unpacking tar archive at: fx-team-0ae26b71481a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.596313 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:02.141374) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:02.141723) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:02.149856) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:02.150267) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:02.150751) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-01-15 01:52:02.151057) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa52b8aba932b19cc50b5275000001de-1452850538.205059-1830841570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:52:02 INFO - MultiFileLogger online at 20160115 01:52:02 in /builds/slave/test-pgo 01:52:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 01:52:02 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:52:02 INFO - {'append_to_log': False, 01:52:02 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:52:02 INFO - 'blob_upload_branch': 'Fx-Team', 01:52:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:52:02 INFO - 'branch': 'Fx-Team', 01:52:02 INFO - 'buildbot_json_path': 'buildprops.json', 01:52:02 INFO - 'config_files': ('talos/linux_config.py',), 01:52:02 INFO - 'default_actions': ('clobber', 01:52:02 INFO - 'read-buildbot-config', 01:52:02 INFO - 'download-and-extract', 01:52:02 INFO - 'populate-webroot', 01:52:02 INFO - 'create-virtualenv', 01:52:02 INFO - 'install', 01:52:02 INFO - 'run-tests'), 01:52:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:52:02 INFO - 'download_minidump_stackwalk': True, 01:52:02 INFO - 'download_symbols': 'ondemand', 01:52:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:52:02 INFO - 'tooltool.py': '/tools/tooltool.py', 01:52:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:52:02 INFO - '/tools/misc-python/virtualenv.py')}, 01:52:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:52:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:52:02 INFO - 'installer_path': 'installer.exe', 01:52:02 INFO - 'log_level': 'info', 01:52:02 INFO - 'log_name': 'talos', 01:52:02 INFO - 'log_to_console': True, 01:52:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:52:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:52:02 INFO - 'opt_config_files': (), 01:52:02 INFO - 'pip_index': False, 01:52:02 INFO - 'sps_profile': False, 01:52:02 INFO - 'sps_profile_interval': 0, 01:52:02 INFO - 'suite': 'dromaeojs', 01:52:02 INFO - 'system_bits': '32', 01:52:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:52:02 INFO - 'title': 'talos-linux64-ix-009', 01:52:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:52:02 INFO - 'use_talos_json': True, 01:52:02 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:52:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:52:02 INFO - 'work_dir': 'build'} 01:52:02 INFO - ##### 01:52:02 INFO - ##### Running clobber step. 01:52:02 INFO - ##### 01:52:02 INFO - Running pre-action listener: _resource_record_pre_action 01:52:02 INFO - Running main action method: clobber 01:52:02 INFO - rmtree: /builds/slave/test-pgo/build 01:52:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:52:03 INFO - Running post-action listener: _resource_record_post_action 01:52:03 INFO - ##### 01:52:03 INFO - ##### Running read-buildbot-config step. 01:52:03 INFO - ##### 01:52:03 INFO - Running pre-action listener: _resource_record_pre_action 01:52:03 INFO - Running main action method: read_buildbot_config 01:52:03 INFO - Using buildbot properties: 01:52:03 INFO - { 01:52:03 INFO - "project": "", 01:52:03 INFO - "product": "firefox", 01:52:03 INFO - "script_repo_revision": "production", 01:52:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:52:03 INFO - "repository": "", 01:52:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 01:52:03 INFO - "buildid": "20160114233009", 01:52:03 INFO - "pgo_build": "True", 01:52:03 INFO - "basedir": "/builds/slave/test-pgo", 01:52:03 INFO - "buildnumber": 582, 01:52:03 INFO - "slavename": "talos-linux64-ix-009", 01:52:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:52:03 INFO - "platform": "ubuntu64_hw", 01:52:03 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 01:52:03 INFO - "branch": "fx-team", 01:52:03 INFO - "repo_path": "integration/fx-team", 01:52:03 INFO - "revision": "0ae26b71481ae676e540a0a2841837fbb939cb88", 01:52:03 INFO - "stage_platform": "linux64-pgo", 01:52:03 INFO - "builduid": "15ee8dc665a14911b0c547f620d4cb75", 01:52:03 INFO - "slavebuilddir": "test" 01:52:03 INFO - } 01:52:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 01:52:03 INFO - Running post-action listener: _resource_record_post_action 01:52:03 INFO - ##### 01:52:03 INFO - ##### Running download-and-extract step. 01:52:03 INFO - ##### 01:52:03 INFO - Running pre-action listener: _resource_record_pre_action 01:52:03 INFO - Running main action method: download_and_extract 01:52:03 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:03 INFO - https://queue.taskcluster.net/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:52:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/test_packages.json 01:52:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/test_packages.json 01:52:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:52:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:52:04 INFO - Downloaded 1448 bytes. 01:52:04 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:52:04 INFO - Using the following test package requirements: 01:52:04 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:52:04 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:04 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:52:04 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:04 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:52:04 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:04 INFO - u'jsshell-linux-x86_64.zip'], 01:52:04 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:04 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:52:04 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:52:04 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:04 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:52:04 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:04 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:52:04 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:04 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:52:04 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:52:04 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:04 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:52:04 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:04 INFO - https://queue.taskcluster.net/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:52:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:52:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:52:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:52:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:52:06 INFO - Downloaded 22439149 bytes. 01:52:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 01:52:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 01:52:07 INFO - Return code: 0 01:52:07 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:07 INFO - https://queue.taskcluster.net/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:52:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:52:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:52:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:52:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:52:14 INFO - Downloaded 22439149 bytes. 01:52:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 01:52:14 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 01:52:15 INFO - Return code: 0 01:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:15 INFO - https://queue.taskcluster.net/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:52:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:52:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:52:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:52:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:52:17 INFO - Downloaded 11132144 bytes. 01:52:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 01:52:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 01:52:18 INFO - Return code: 0 01:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:18 INFO - https://queue.taskcluster.net/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:52:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:52:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:52:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:52:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:52:21 INFO - Downloaded 55958686 bytes. 01:52:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:52:21 INFO - mkdir: /builds/slave/test-pgo/properties 01:52:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:52:21 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:52:21 INFO - Contents: 01:52:21 INFO - build_url:https://queue.taskcluster.net/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:52:21 INFO - Running post-action listener: _resource_record_post_action 01:52:21 INFO - Running post-action listener: set_extra_try_arguments 01:52:21 INFO - ##### 01:52:21 INFO - ##### Running populate-webroot step. 01:52:21 INFO - ##### 01:52:21 INFO - Running pre-action listener: _resource_record_pre_action 01:52:21 INFO - Running main action method: populate_webroot 01:52:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:52:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:52:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:52:21 INFO - '--tppagecycles', 01:52:21 INFO - '7'], 01:52:21 INFO - 'tests': ['tsvgm']}}, 01:52:21 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:52:21 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:52:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:52:21 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:52:21 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:52:21 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:52:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:52:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:21 INFO - 'talos_options': ['--e10s'], 01:52:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:52:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:21 INFO - 'tests': ['damp', 'tps']}, 01:52:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:21 INFO - 'talos_options': ['--e10s'], 01:52:21 INFO - 'tests': ['damp', 'tps']}, 01:52:21 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:52:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:52:21 INFO - 'other': {'tests': ['a11yr', 01:52:21 INFO - 'ts_paint', 01:52:21 INFO - 'tpaint', 01:52:21 INFO - 'sessionrestore', 01:52:21 INFO - 'sessionrestore_no_auto_restore']}, 01:52:21 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:52:21 INFO - 'tests': ['a11yr', 01:52:21 INFO - 'ts_paint', 01:52:21 INFO - 'tpaint', 01:52:21 INFO - 'sessionrestore', 01:52:21 INFO - 'sessionrestore_no_auto_restore']}, 01:52:21 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:52:21 INFO - 'tests': ['a11yr', 01:52:21 INFO - 'ts_paint', 01:52:21 INFO - 'tpaint', 01:52:21 INFO - 'sessionrestore', 01:52:21 INFO - 'sessionrestore_no_auto_restore']}, 01:52:21 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:52:21 INFO - 'tests': ['a11yr', 01:52:21 INFO - 'ts_paint', 01:52:21 INFO - 'tpaint', 01:52:21 INFO - 'sessionrestore', 01:52:21 INFO - 'sessionrestore_no_auto_restore']}, 01:52:21 INFO - 'other_l64': {'tests': ['a11yr', 01:52:21 INFO - 'ts_paint', 01:52:21 INFO - 'tpaint', 01:52:21 INFO - 'sessionrestore', 01:52:21 INFO - 'sessionrestore_no_auto_restore']}, 01:52:21 INFO - 'other_nol64': {'tests': ['a11yr', 01:52:21 INFO - 'ts_paint', 01:52:21 INFO - 'tpaint', 01:52:21 INFO - 'sessionrestore', 01:52:21 INFO - 'sessionrestore_no_auto_restore']}, 01:52:21 INFO - 'svgr': {'tests': ['tsvgx', 01:52:21 INFO - 'tsvgr_opacity', 01:52:21 INFO - 'tart', 01:52:21 INFO - 'tscrollx', 01:52:21 INFO - 'cart']}, 01:52:21 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:52:21 INFO - 'tests': ['tsvgx', 01:52:21 INFO - 'tsvgr_opacity', 01:52:21 INFO - 'tart', 01:52:21 INFO - 'tscrollx', 01:52:21 INFO - 'cart']}, 01:52:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:21 INFO - 'tests': ['tp5o']}, 01:52:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:21 INFO - 'talos_options': ['--e10s'], 01:52:21 INFO - 'tests': ['tp5o']}, 01:52:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:21 INFO - 'talos_options': ['--xperf_path', 01:52:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:52:21 INFO - 'tests': ['tp5n']}, 01:52:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:21 INFO - 'talos_options': ['--e10s', 01:52:21 INFO - '--xperf_path', 01:52:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:52:21 INFO - 'tests': ['tp5n']}}, 01:52:21 INFO - 'talos.zip': {'path': '', 01:52:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:52:21 INFO - Running post-action listener: _resource_record_post_action 01:52:21 INFO - ##### 01:52:21 INFO - ##### Running create-virtualenv step. 01:52:21 INFO - ##### 01:52:21 INFO - Running pre-action listener: _resource_record_pre_action 01:52:21 INFO - Running main action method: create_virtualenv 01:52:21 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:52:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 01:52:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:52:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:52:21 INFO - Using real prefix '/usr' 01:52:21 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:52:21 INFO - Installing distribute.............................................................................................................................................................................................done. 01:52:23 INFO - Installing pip.................done. 01:52:23 INFO - Return code: 0 01:52:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:23 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 0x7f57cfdc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf82630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013840>, '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 0xf806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80b60>, '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': 'aa52b8aba932b19cc50b5275000001de-1452850538.205059-1830841570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:52:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 01:52:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:52:23 INFO - Using env: {'DISPLAY': ':0', 01:52:23 INFO - 'HOME': '/home/cltbld', 01:52:23 INFO - 'LANG': 'en_US.UTF-8', 01:52:23 INFO - 'LANGUAGE': 'en_US:en', 01:52:23 INFO - 'LOGNAME': 'cltbld', 01:52:23 INFO - 'MAIL': '/var/mail/cltbld', 01:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:23 INFO - 'MOZ_NO_REMOTE': '1', 01:52:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:23 INFO - 'NO_EM_RESTART': '1', 01:52:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:52:23 INFO - 'PWD': '/builds/slave/test-pgo', 01:52:23 INFO - 'SHELL': '/bin/bash', 01:52:23 INFO - 'SHLVL': '1', 01:52:23 INFO - 'TERM': 'linux', 01:52:23 INFO - 'TMOUT': '86400', 01:52:23 INFO - 'USER': 'cltbld', 01:52:23 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452850538.205059-1830841570', 01:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:23 INFO - '_': '/tools/buildbot/bin/python'} 01:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:52:24 INFO - Cleaning up... 01:52:24 INFO - Return code: 0 01:52:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:24 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 0x7f57cfdc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf82630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013840>, '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 0xf806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80b60>, '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': 'aa52b8aba932b19cc50b5275000001de-1452850538.205059-1830841570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:52:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 01:52:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:52:24 INFO - Using env: {'DISPLAY': ':0', 01:52:24 INFO - 'HOME': '/home/cltbld', 01:52:24 INFO - 'LANG': 'en_US.UTF-8', 01:52:24 INFO - 'LANGUAGE': 'en_US:en', 01:52:24 INFO - 'LOGNAME': 'cltbld', 01:52:24 INFO - 'MAIL': '/var/mail/cltbld', 01:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:24 INFO - 'MOZ_NO_REMOTE': '1', 01:52:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:24 INFO - 'NO_EM_RESTART': '1', 01:52:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:52:24 INFO - 'PWD': '/builds/slave/test-pgo', 01:52:24 INFO - 'SHELL': '/bin/bash', 01:52:24 INFO - 'SHLVL': '1', 01:52:24 INFO - 'TERM': 'linux', 01:52:24 INFO - 'TMOUT': '86400', 01:52:24 INFO - 'USER': 'cltbld', 01:52:24 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452850538.205059-1830841570', 01:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:24 INFO - '_': '/tools/buildbot/bin/python'} 01:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:24 INFO - Downloading/unpacking psutil>=0.7.1 01:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:26 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 01:52:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:52:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:52:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:52:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:52:26 INFO - Installing collected packages: psutil 01:52:26 INFO - Running setup.py install for psutil 01:52:26 INFO - building 'psutil._psutil_linux' extension 01:52:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:52:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:52:27 INFO - building 'psutil._psutil_posix' extension 01:52:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:52:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:52:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:52:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:52:27 INFO - Successfully installed psutil 01:52:27 INFO - Cleaning up... 01:52:28 INFO - Return code: 0 01:52:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:28 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 0x7f57cfdc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf82630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013840>, '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 0xf806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80b60>, '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': 'aa52b8aba932b19cc50b5275000001de-1452850538.205059-1830841570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:52:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 01:52:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:52:28 INFO - Using env: {'DISPLAY': ':0', 01:52:28 INFO - 'HOME': '/home/cltbld', 01:52:28 INFO - 'LANG': 'en_US.UTF-8', 01:52:28 INFO - 'LANGUAGE': 'en_US:en', 01:52:28 INFO - 'LOGNAME': 'cltbld', 01:52:28 INFO - 'MAIL': '/var/mail/cltbld', 01:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:28 INFO - 'MOZ_NO_REMOTE': '1', 01:52:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:28 INFO - 'NO_EM_RESTART': '1', 01:52:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:52:28 INFO - 'PWD': '/builds/slave/test-pgo', 01:52:28 INFO - 'SHELL': '/bin/bash', 01:52:28 INFO - 'SHLVL': '1', 01:52:28 INFO - 'TERM': 'linux', 01:52:28 INFO - 'TMOUT': '86400', 01:52:28 INFO - 'USER': 'cltbld', 01:52:28 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452850538.205059-1830841570', 01:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:28 INFO - '_': '/tools/buildbot/bin/python'} 01:52:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:52:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:52:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:52:29 INFO - Installing collected packages: mozsystemmonitor 01:52:29 INFO - Running setup.py install for mozsystemmonitor 01:52:30 INFO - Successfully installed mozsystemmonitor 01:52:30 INFO - Cleaning up... 01:52:30 INFO - Return code: 0 01:52:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:52: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')]} 01:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52: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')]} 01:52:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:30 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 0x7f57cfdc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf82630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013840>, '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 0xf806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80b60>, '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': 'aa52b8aba932b19cc50b5275000001de-1452850538.205059-1830841570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:52:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 01:52:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:52:30 INFO - Using env: {'DISPLAY': ':0', 01:52:30 INFO - 'HOME': '/home/cltbld', 01:52:30 INFO - 'LANG': 'en_US.UTF-8', 01:52:30 INFO - 'LANGUAGE': 'en_US:en', 01:52:30 INFO - 'LOGNAME': 'cltbld', 01:52:30 INFO - 'MAIL': '/var/mail/cltbld', 01:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:30 INFO - 'MOZ_NO_REMOTE': '1', 01:52:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:30 INFO - 'NO_EM_RESTART': '1', 01:52:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:52:30 INFO - 'PWD': '/builds/slave/test-pgo', 01:52:30 INFO - 'SHELL': '/bin/bash', 01:52:30 INFO - 'SHLVL': '1', 01:52:30 INFO - 'TERM': 'linux', 01:52:30 INFO - 'TMOUT': '86400', 01:52:30 INFO - 'USER': 'cltbld', 01:52:30 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452850538.205059-1830841570', 01:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:30 INFO - '_': '/tools/buildbot/bin/python'} 01:52:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:30 INFO - Downloading/unpacking blobuploader==1.2.4 01:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:32 INFO - Downloading blobuploader-1.2.4.tar.gz 01:52:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:52:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:52:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:52:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:52:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:32 INFO - Downloading docopt-0.6.1.tar.gz 01:52:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:52:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:52:33 INFO - Installing collected packages: blobuploader, requests, docopt 01:52:33 INFO - Running setup.py install for blobuploader 01:52:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:52:33 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:52:33 INFO - Running setup.py install for requests 01:52:33 INFO - Running setup.py install for docopt 01:52:33 INFO - Successfully installed blobuploader requests docopt 01:52:33 INFO - Cleaning up... 01:52:33 INFO - Return code: 0 01:52:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:52: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')]} 01:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52: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')]} 01:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:33 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 0x7f57cfdc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf82630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013840>, '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 0xf806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80b60>, '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': 'aa52b8aba932b19cc50b5275000001de-1452850538.205059-1830841570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:52:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 01:52:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:52:33 INFO - Using env: {'DISPLAY': ':0', 01:52:33 INFO - 'HOME': '/home/cltbld', 01:52:33 INFO - 'LANG': 'en_US.UTF-8', 01:52:33 INFO - 'LANGUAGE': 'en_US:en', 01:52:33 INFO - 'LOGNAME': 'cltbld', 01:52:33 INFO - 'MAIL': '/var/mail/cltbld', 01:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:33 INFO - 'MOZ_NO_REMOTE': '1', 01:52:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:33 INFO - 'NO_EM_RESTART': '1', 01:52:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:52:33 INFO - 'PWD': '/builds/slave/test-pgo', 01:52:33 INFO - 'SHELL': '/bin/bash', 01:52:33 INFO - 'SHLVL': '1', 01:52:33 INFO - 'TERM': 'linux', 01:52:33 INFO - 'TMOUT': '86400', 01:52:33 INFO - 'USER': 'cltbld', 01:52:33 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452850538.205059-1830841570', 01:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:33 INFO - '_': '/tools/buildbot/bin/python'} 01:52:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:52:33 INFO - Running setup.py (path:/tmp/pip-ymwNdZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:52:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:52:33 INFO - Running setup.py (path:/tmp/pip-A4qs4Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:52:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:52:33 INFO - Running setup.py (path:/tmp/pip-X_OaS3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:52:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:52:34 INFO - Running setup.py (path:/tmp/pip-p5z1Jt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:52:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:52:34 INFO - Running setup.py (path:/tmp/pip-AnXAWs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:52:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:52:34 INFO - Running setup.py (path:/tmp/pip-oXLT1o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:52:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:52:34 INFO - Running setup.py (path:/tmp/pip-bWTdPv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:52:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:52:34 INFO - Running setup.py (path:/tmp/pip-1oZhk7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:52:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:52:34 INFO - Running setup.py (path:/tmp/pip-cOosHk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:52:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:52:34 INFO - Running setup.py (path:/tmp/pip-D7YLTK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:52:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:52:34 INFO - Running setup.py (path:/tmp/pip-ZHEcPw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:52:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:52:34 INFO - Running setup.py (path:/tmp/pip-dkHtDb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:52:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:52:34 INFO - Running setup.py (path:/tmp/pip-OyZHnD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:52:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:52:34 INFO - Running setup.py (path:/tmp/pip-oFQQ8U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:52:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:52:34 INFO - Running setup.py (path:/tmp/pip-qZXl9O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:52:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:52:34 INFO - Running setup.py (path:/tmp/pip-DldAE9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:52:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:52:34 INFO - Running setup.py (path:/tmp/pip-ydthZ9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:52:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:52:35 INFO - Running setup.py install for manifestparser 01:52:35 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:52:35 INFO - Running setup.py install for mozcrash 01:52:35 INFO - Running setup.py install for mozdebug 01:52:35 INFO - Running setup.py install for mozdevice 01:52:35 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:52:35 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:52:35 INFO - Running setup.py install for mozfile 01:52:35 INFO - Running setup.py install for mozhttpd 01:52:35 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:52:35 INFO - Running setup.py install for mozinfo 01:52:35 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:52:35 INFO - Running setup.py install for mozInstall 01:52:35 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:52:35 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:52:35 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:52:35 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:52:35 INFO - Running setup.py install for mozleak 01:52:35 INFO - Running setup.py install for mozlog 01:52:36 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:52:36 INFO - Running setup.py install for moznetwork 01:52:36 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:52:36 INFO - Running setup.py install for mozprocess 01:52:36 INFO - Running setup.py install for mozprofile 01:52:36 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:52:36 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:52:36 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:52:36 INFO - Running setup.py install for mozrunner 01:52:36 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:52:36 INFO - Running setup.py install for mozscreenshot 01:52:36 INFO - Running setup.py install for moztest 01:52:36 INFO - Running setup.py install for mozversion 01:52:36 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:52:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:52:36 INFO - Cleaning up... 01:52:36 INFO - Return code: 0 01:52:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:36 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 0x7f57cfdc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf82630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013840>, '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 0xf806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80b60>, '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': 'aa52b8aba932b19cc50b5275000001de-1452850538.205059-1830841570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:52:36 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 01:52:36 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 01:52:36 INFO - Using env: {'DISPLAY': ':0', 01:52:36 INFO - 'HOME': '/home/cltbld', 01:52:36 INFO - 'LANG': 'en_US.UTF-8', 01:52:36 INFO - 'LANGUAGE': 'en_US:en', 01:52:36 INFO - 'LOGNAME': 'cltbld', 01:52:36 INFO - 'MAIL': '/var/mail/cltbld', 01:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:36 INFO - 'MOZ_NO_REMOTE': '1', 01:52:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:36 INFO - 'NO_EM_RESTART': '1', 01:52:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:52:36 INFO - 'PWD': '/builds/slave/test-pgo', 01:52:36 INFO - 'SHELL': '/bin/bash', 01:52:36 INFO - 'SHLVL': '1', 01:52:36 INFO - 'TERM': 'linux', 01:52:36 INFO - 'TMOUT': '86400', 01:52:36 INFO - 'USER': 'cltbld', 01:52:36 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452850538.205059-1830841570', 01:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:36 INFO - '_': '/tools/buildbot/bin/python'} 01:52:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:52:37 INFO - Running setup.py (path:/tmp/pip-N5f8M3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:52:37 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)) 01:52:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:52:37 INFO - Running setup.py (path:/tmp/pip-PwXtal-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:52:37 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)) 01:52:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:52:37 INFO - Running setup.py (path:/tmp/pip-Po3m2R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:52:37 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)) 01:52:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:52:37 INFO - Running setup.py (path:/tmp/pip-LybkO9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 01:52:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:52:37 INFO - Running setup.py (path:/tmp/pip-8E9okI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:52:37 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)) 01:52:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:52:37 INFO - Running setup.py (path:/tmp/pip-0YOI_u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:52:37 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)) 01:52:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:52:37 INFO - Running setup.py (path:/tmp/pip-Gqu36j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:52:37 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)) 01:52:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:52:37 INFO - Running setup.py (path:/tmp/pip-zpPHEU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:52:37 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)) 01:52:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:52:37 INFO - Running setup.py (path:/tmp/pip-CDymB2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:52:37 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)) 01:52:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:52:37 INFO - Running setup.py (path:/tmp/pip-HOjOQm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:52:37 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)) 01:52:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:52:37 INFO - Running setup.py (path:/tmp/pip-UTEYCl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:52:37 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)) 01:52:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:52:37 INFO - Running setup.py (path:/tmp/pip-oI7YTd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:52:37 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)) 01:52:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:52:37 INFO - Running setup.py (path:/tmp/pip-GXQE4g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:52:38 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)) 01:52:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:52:38 INFO - Running setup.py (path:/tmp/pip-hG0KcM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:52:38 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)) 01:52:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:52:38 INFO - Running setup.py (path:/tmp/pip-enzgix-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:52:38 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)) 01:52:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:52:38 INFO - Running setup.py (path:/tmp/pip-uIINlp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:52:38 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)) 01:52:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:52:38 INFO - Running setup.py (path:/tmp/pip-NduItT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:52:38 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)) 01:52:38 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)) 01:52:38 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)) 01:52:38 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)) 01:52:38 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 01:52:38 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 01:52:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:39 INFO - Downloading blessings-1.5.1.tar.gz 01:52:40 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 01:52:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:52:40 INFO - Installing collected packages: blessings 01:52:40 INFO - Running setup.py install for blessings 01:52:40 INFO - Successfully installed blessings 01:52:40 INFO - Cleaning up... 01:52:40 INFO - Return code: 0 01:52:40 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:52:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:52:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:52:40 INFO - Reading from file tmpfile_stdout 01:52:40 INFO - Current package versions: 01:52:40 INFO - argparse == 1.2.1 01:52:40 INFO - blessings == 1.5.1 01:52:40 INFO - blobuploader == 1.2.4 01:52:40 INFO - docopt == 0.6.1 01:52:40 INFO - manifestparser == 1.1 01:52:40 INFO - mozInstall == 1.12 01:52:40 INFO - mozcrash == 0.16 01:52:40 INFO - mozdebug == 0.1 01:52:40 INFO - mozdevice == 0.48 01:52:40 INFO - mozfile == 1.2 01:52:40 INFO - mozhttpd == 0.7 01:52:40 INFO - mozinfo == 0.9 01:52:40 INFO - mozleak == 0.1 01:52:40 INFO - mozlog == 3.1 01:52:40 INFO - moznetwork == 0.27 01:52:40 INFO - mozprocess == 0.22 01:52:40 INFO - mozprofile == 0.28 01:52:40 INFO - mozrunner == 6.11 01:52:40 INFO - mozscreenshot == 0.1 01:52:40 INFO - mozsystemmonitor == 0.0 01:52:40 INFO - moztest == 0.7 01:52:40 INFO - mozversion == 1.4 01:52:40 INFO - psutil == 3.1.1 01:52:40 INFO - requests == 1.2.3 01:52:40 INFO - wsgiref == 0.1.2 01:52:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f57cfdc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf82630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013840>, '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 0xf806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80b60>, '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': 'aa52b8aba932b19cc50b5275000001de-1452850538.205059-1830841570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:52:40 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 01:52:40 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 01:52:40 INFO - Using env: {'DISPLAY': ':0', 01:52:40 INFO - 'HOME': '/home/cltbld', 01:52:40 INFO - 'LANG': 'en_US.UTF-8', 01:52:40 INFO - 'LANGUAGE': 'en_US:en', 01:52:40 INFO - 'LOGNAME': 'cltbld', 01:52:40 INFO - 'MAIL': '/var/mail/cltbld', 01:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:40 INFO - 'MOZ_NO_REMOTE': '1', 01:52:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:40 INFO - 'NO_EM_RESTART': '1', 01:52:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:52:40 INFO - 'PWD': '/builds/slave/test-pgo', 01:52:40 INFO - 'SHELL': '/bin/bash', 01:52:40 INFO - 'SHLVL': '1', 01:52:40 INFO - 'TERM': 'linux', 01:52:40 INFO - 'TMOUT': '86400', 01:52:40 INFO - 'USER': 'cltbld', 01:52:40 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452850538.205059-1830841570', 01:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:40 INFO - '_': '/tools/buildbot/bin/python'} 01:52:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:40 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)) 01:52:40 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)) 01:52:40 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)) 01:52:40 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)) 01:52:40 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)) 01:52:40 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)) 01:52:40 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)) 01:52:40 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)) 01:52:40 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)) 01:52:40 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)) 01:52:40 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)) 01:52:40 INFO - Cleaning up... 01:52:40 INFO - Return code: 0 01:52:40 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 01:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f57cfdc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf82630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013840>, '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 0xf806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80b60>, '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': 'aa52b8aba932b19cc50b5275000001de-1452850538.205059-1830841570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:52:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 01:52:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:52:40 INFO - Using env: {'DISPLAY': ':0', 01:52:40 INFO - 'HOME': '/home/cltbld', 01:52:40 INFO - 'LANG': 'en_US.UTF-8', 01:52:40 INFO - 'LANGUAGE': 'en_US:en', 01:52:40 INFO - 'LOGNAME': 'cltbld', 01:52:40 INFO - 'MAIL': '/var/mail/cltbld', 01:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:40 INFO - 'MOZ_NO_REMOTE': '1', 01:52:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:40 INFO - 'NO_EM_RESTART': '1', 01:52:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:52:40 INFO - 'PWD': '/builds/slave/test-pgo', 01:52:40 INFO - 'SHELL': '/bin/bash', 01:52:40 INFO - 'SHLVL': '1', 01:52:40 INFO - 'TERM': 'linux', 01:52:40 INFO - 'TMOUT': '86400', 01:52:40 INFO - 'USER': 'cltbld', 01:52:40 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452850538.205059-1830841570', 01:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:40 INFO - '_': '/tools/buildbot/bin/python'} 01:52:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:40 INFO - Downloading/unpacking jsonschema 01:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:52:42 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 01:52:42 INFO - Downloading/unpacking functools32 (from jsonschema) 01:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:42 INFO - Downloading functools32-3.2.3-2.tar.gz 01:52:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 01:52:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 01:52:42 INFO - warning: no files found matching '*.txt' 01:52:42 INFO - no previously-included directories found matching 'build' 01:52:42 INFO - no previously-included directories found matching 'dist' 01:52:42 INFO - no previously-included directories found matching '.git*' 01:52:42 INFO - Installing collected packages: jsonschema, functools32 01:52:42 INFO - Running setup.py install for functools32 01:52:43 INFO - warning: no files found matching '*.txt' 01:52:43 INFO - no previously-included directories found matching 'build' 01:52:43 INFO - no previously-included directories found matching 'dist' 01:52:43 INFO - no previously-included directories found matching '.git*' 01:52:43 INFO - Successfully installed jsonschema functools32 01:52:43 INFO - Cleaning up... 01:52:43 INFO - Return code: 0 01:52:43 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 01:52: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')]} 01:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52: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')]} 01:52:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f57cfdc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf82630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013840>, '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 0xf806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80b60>, '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': 'aa52b8aba932b19cc50b5275000001de-1452850538.205059-1830841570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:52: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', 'flake8'] in /builds/slave/test-pgo/build 01:52: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 flake8 01:52:43 INFO - Using env: {'DISPLAY': ':0', 01:52:43 INFO - 'HOME': '/home/cltbld', 01:52:43 INFO - 'LANG': 'en_US.UTF-8', 01:52:43 INFO - 'LANGUAGE': 'en_US:en', 01:52:43 INFO - 'LOGNAME': 'cltbld', 01:52:43 INFO - 'MAIL': '/var/mail/cltbld', 01:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:43 INFO - 'MOZ_NO_REMOTE': '1', 01:52:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:43 INFO - 'NO_EM_RESTART': '1', 01:52:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:52:43 INFO - 'PWD': '/builds/slave/test-pgo', 01:52:43 INFO - 'SHELL': '/bin/bash', 01:52:43 INFO - 'SHLVL': '1', 01:52:43 INFO - 'TERM': 'linux', 01:52:43 INFO - 'TMOUT': '86400', 01:52:43 INFO - 'USER': 'cltbld', 01:52:43 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452850538.205059-1830841570', 01:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:43 INFO - '_': '/tools/buildbot/bin/python'} 01:52:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:43 INFO - Downloading/unpacking flake8 01:52: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 01:52: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 01:52: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 01:52: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 01:52: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 01:52: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 01:52:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:52:45 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 01:52:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:52:45 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 01:52:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:45 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 01:52:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 01:52:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 01:52:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:52:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:52:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:52:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:52:45 INFO - no previously-included directories found matching 'docs/_build' 01:52:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:52:45 INFO - Running setup.py install for pep8 01:52:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:52:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:52:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:52:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:52:45 INFO - no previously-included directories found matching 'docs/_build' 01:52:45 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 01:52:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:52:45 INFO - Cleaning up... 01:52:45 INFO - Return code: 0 01:52:45 INFO - Running post-action listener: _resource_record_post_action 01:52:45 INFO - Running post-action listener: _start_resource_monitoring 01:52:45 INFO - Starting resource monitoring. 01:52:45 INFO - ##### 01:52:45 INFO - ##### Running install step. 01:52:45 INFO - ##### 01:52:45 INFO - Running pre-action listener: _resource_record_pre_action 01:52:45 INFO - Running main action method: install 01:52:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:52:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:52:46 INFO - Reading from file tmpfile_stdout 01:52:46 INFO - Detecting whether we're running mozinstall >=1.0... 01:52:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:52:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:52:46 INFO - Reading from file tmpfile_stdout 01:52:46 INFO - Output received: 01:52:46 INFO - Usage: mozinstall [options] installer 01:52:46 INFO - Options: 01:52:46 INFO - -h, --help show this help message and exit 01:52:46 INFO - -d DEST, --destination=DEST 01:52:46 INFO - Directory to install application into. [default: 01:52:46 INFO - "/builds/slave/test-pgo"] 01:52:46 INFO - --app=APP Application being installed. [default: firefox] 01:52:46 INFO - mkdir: /builds/slave/test-pgo/build/application 01:52:46 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'] 01:52:46 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 01:53:02 INFO - Reading from file tmpfile_stdout 01:53:02 INFO - Output received: 01:53:02 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:53:02 INFO - Running post-action listener: _resource_record_post_action 01:53:02 INFO - ##### 01:53:02 INFO - ##### Running run-tests step. 01:53:02 INFO - ##### 01:53:02 INFO - Running pre-action listener: _resource_record_pre_action 01:53:02 INFO - Running main action method: run_tests 01:53:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:53:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:53:02 INFO - Python 2.7.3 01:53:02 INFO - Return code: 0 01:53:02 INFO - grabbing minidump binary from tooltool 01:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:53:02 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 0x1013840>, '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 0xf806b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf80b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:53:02 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 01:53:02 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 01:53:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:53:02 INFO - Return code: 0 01:53:02 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:53:02 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:53:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:53:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:53:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:53:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 01:53:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 01:53:03 INFO - Return code: 0 01:53:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 01:53:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 01:53:03 INFO - Using env: {'DISPLAY': ':0', 01:53:03 INFO - 'HOME': '/home/cltbld', 01:53:03 INFO - 'LANG': 'en_US.UTF-8', 01:53:03 INFO - 'LANGUAGE': 'en_US:en', 01:53:03 INFO - 'LOGNAME': 'cltbld', 01:53:03 INFO - 'MAIL': '/var/mail/cltbld', 01:53:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:53:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:03 INFO - 'MOZ_NO_REMOTE': '1', 01:53:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:53:03 INFO - 'NO_EM_RESTART': '1', 01:53:03 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:53:03 INFO - 'PWD': '/builds/slave/test-pgo', 01:53:03 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:53:03 INFO - 'SHELL': '/bin/bash', 01:53:03 INFO - 'SHLVL': '1', 01:53:03 INFO - 'TERM': 'linux', 01:53:03 INFO - 'TMOUT': '86400', 01:53:03 INFO - 'USER': 'cltbld', 01:53:03 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1452850538.205059-1830841570', 01:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:03 INFO - '_': '/tools/buildbot/bin/python'} 01:53:03 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:53:03 INFO - mozversion application_buildid: 20160114233009 01:53:03 INFO - mozversion application_changeset: 0ae26b71481ae676e540a0a2841837fbb939cb88 01:53:03 INFO - mozversion application_display_name: Nightly 01:53:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:53:03 INFO - mozversion application_name: Firefox 01:53:03 INFO - mozversion application_remotingname: firefox 01:53:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:53:03 INFO - mozversion application_vendor: Mozilla 01:53:03 INFO - mozversion application_version: 46.0a1 01:53:03 INFO - mozversion platform_buildid: 20160114233009 01:53:03 INFO - mozversion platform_changeset: 0ae26b71481ae676e540a0a2841837fbb939cb88 01:53:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:53:03 INFO - mozversion platform_version: 46.0a1 01:53:03 INFO - using testdate: 1452851583 01:53:03 INFO - actual date: 1452851583 01:53:03 INFO - starting webserver on 'localhost:54156' 01:53:03 INFO - SUITE-START | Running 3 tests 01:53:03 INFO - TEST-START | dromaeo_css 01:53:03 INFO - operating with platform_type : linux_ 01:53:03 INFO - Initialising browser for dromaeo_css test... 01:53:03 INFO - TEST-INFO | started process 3432 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpP5gq9J/profile http://localhost:54156/getInfo.html) 01:53:09 INFO - PROCESS | 3432 | __metrics Screen width/height:1600/1200 01:53:09 INFO - PROCESS | 3432 | colorDepth:24 01:53:09 INFO - PROCESS | 3432 | Browser inner width/height: 1024/697 01:53:09 INFO - PROCESS | 3432 | __metrics 01:53:09 INFO - PROCESS | 3432 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:53:09 INFO - PROCESS | 3432 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:53:10 INFO - TEST-INFO | 3432: exit 0 01:53:10 INFO - Browser initialized. 01:53:10 INFO - Running cycle 1/1 for dromaeo_css test... 01:53:10 INFO - TEST-INFO | started process 3527 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpP5gq9J/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:53:22 INFO - PROCESS | 3527 | RSS: Main: 149884928 01:53:22 INFO - PROCESS | 3527 | 01:54:13 INFO - PROCESS | 3527 | 1452851653463 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] 01:56:22 INFO - PROCESS | 3527 | Cycle 1(1): loaded http://localhost:54156/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54156/tests/dromaeo/cssquery-ext.html) 01:56:23 INFO - PROCESS | 3527 | RSS: Main: 272830464 01:56:23 INFO - PROCESS | 3527 | 01:59:26 INFO - PROCESS | 3527 | Cycle 1(1): loaded http://localhost:54156/tests/dromaeo/cssquery-ext.html (next: http://localhost:54156/tests/dromaeo/cssquery-jquery.html) 01:59:27 INFO - PROCESS | 3527 | RSS: Main: 234860544 01:59:27 INFO - PROCESS | 3527 | 02:02:29 INFO - PROCESS | 3527 | Cycle 1(1): loaded http://localhost:54156/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54156/tests/dromaeo/cssquery-mootools.html) 02:02:29 INFO - PROCESS | 3527 | RSS: Main: 241057792 02:02:29 INFO - PROCESS | 3527 | 02:05:31 INFO - PROCESS | 3527 | Cycle 1(1): loaded http://localhost:54156/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54156/tests/dromaeo/cssquery-prototype.html) 02:05:32 INFO - PROCESS | 3527 | RSS: Main: 214061056 02:05:32 INFO - PROCESS | 3527 | 02:08:34 INFO - PROCESS | 3527 | Cycle 1(1): loaded http://localhost:54156/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54156/tests/dromaeo/cssquery-yui.html) 02:08:35 INFO - PROCESS | 3527 | RSS: Main: 216055808 02:08:35 INFO - PROCESS | 3527 | 02:11:38 INFO - PROCESS | 3527 | Cycle 1(1): loaded http://localhost:54156/tests/dromaeo/cssquery-yui.html (next: http://localhost:54156/tests/dromaeo/cssquery-dojo.html) 02:11:38 INFO - PROCESS | 3527 | RSS: Main: 290304000 02:11:38 INFO - PROCESS | 3527 | 02:11:38 INFO - PROCESS | 3527 | __start_tp_report 02:11:38 INFO - PROCESS | 3527 | _x_x_mozilla_page_load 02:11:38 INFO - PROCESS | 3527 | _x_x_mozilla_page_load_details 02:11:38 INFO - PROCESS | 3527 | |i|pagename|runs| 02:11:38 INFO - PROCESS | 3527 | |0;dojo.html;3029.7727670424715;3110.704483074109;3111.875524979001;3145.9842700786494;3168.413843438964;5041.571466425358;5113.360829896263;5147.794088236471;5161.922571161431;5201.297824793652;5125.28246045553;5127.794888204477;5170.4312525622245;5186.455422180673;5225.059489291926;4643.8839029024375;4664.1371346300875;4670.25275955848;4793.880152996168;4802.495737947517;4747.287906813971;4756.714597124166;4817.864841507156;4826.227803551433;4837.371141751567;4646.326282689025;4657.208274593328;4731.2430011198385;4735.999999999965;4776.164171270014;4657.4876763555985;4660.067986402733;4660.906781864343;4685.953140468586;4715.3869996900185;4658.068386322715;4658.604018658418;4677.18149323867;4688.367070445481;4691.413573303337;4918.360613120271;4967.7019378837385;5010.62420318474;5028.874278143039;5069.797208111708;5507.256520369739;5536.640118392292;5538.280023596906;5540.972295138539;5544.445555444464;5432.619716619838;5536.750846211889;5554.86112847178;5556.055470570012;5558.833235002957;5103.999999999963;5137.8201762938115;5144.691318520863;5176.223566464985;5196.584273258168;5644.774209031675;5658.490735833712;5659.660420374791;5660.688662123623;5662.122371032497;5209.088409528393;5341.65279256847;5458.126699728104;5466.590005749585;5476.3702174250475;5502.422245664147;5508.7521061552325;5520.337559492807;5526.944730552643;5584.5811564132855;5403.8108666196495;5439.292891924025;5454.12733962572;5463.7814487420055;5469.15228139639;5412.242286079952;5443.183522471661;5471.917921231185;5498.615096943176;5520.834374968757;4251;4283.2932566126865;4289.206496798102;4305.84929527465;4319.3952846601505;3823.445600387928;3857.209272099269;3875.9418608720894;3896.9610303896598;3904.355781296111;5017.071841709222;5081.8729531762;5104.872378190501;5111.821086261963;5113.795448182105;5426.810061647823;5443.700596467153;5454;5454.127339625641;5504.119340905436;5002.974985125051;5069.619778516626;5073.949260507421;5076.18780995039;5124.052050370693;4599.931001034987;4675.7895894684825;4693.7653117344;4700.529947005272;4765.475797662254;5659.26429564154;5661.745221465044;5679.403662615448;5679.8864022720145;5683.687397193112;5468.3711373191;5470.64440811346;5486.1222204447095;5489.4236105209975;5523.25436066142;5609.158626206102;5701.372848986525;5709.0865461525955;5755.1942728017275;5773.8556536086935;5394.757235924314;5422.322209723785;5427.185922111715;5428.70142142186;5450.754716037709;5449.291592093003;5517.889642207214;5524.944750552443;5527.5577953762795;5532.775627419153;5305.283786688748;5393.649412788156;5416.079266524779;5424.159255315432;5495.258140151188;5363.168708850135;5368.114261146867;5379;5380.354357476971;5386.649867758583;5294.49702278283;5304.795233516118;5306.761195746123;5321.441248668834;5354.143337066051;5366.2487251784005;5385.973070134624;5394.190871369326;5422.349318081855;5440.510354068153;5203.323567936144;5212.791488340576;5215.217717342429;5216.347956505437;5261.500157485033 02:11:38 INFO - PROCESS | 3527 | |1;ext.html;523.7800123947942;525.3013492055566;527.2144504688016;542.7801740295181;554.5702080887314;28512.714872851266;29479.852600736995;29600;29636.110916672507;36883.631163688355;40911.59088409115;41454.79272603633;41501.37747933776;41539.79230103853;41570.58429415705;8624.698135565272;8929.821403571925;8931.464112153291;8933.508657023862;8933.642654293853;8594.613242404075;8685.956570217171;8752.037275899645;8753.299736021136;8766.912330876674;8774.429662071976;8857;8861.291096712279;8864;8864.423812452202;8712.738617841474;8803.163699448542;8808.955955220246;8810.867836982483;8814.955925220396;8665.653373865038;8772.736817895473;8804.119588041145;8806.075362087016;8806.603702833389;39964.800175998935;40298.194036119115;40370.394444083366;40413.191736165405;40438;3244.1727359523406;3407.8296085195643;3831.425286207091;4056.7565946043333;4112.444819949298;28580.714192858013;30440;30506.694933050607;30622;31983.52024719631;3904.8047597620007;4030.435738996543;4044.898877528056;4063.349864021742;4094.996725802168;268765;269361;269804;269923.999999998;270644;53620.73189634105;54018.189727154124;54032.189517157276;54071.45928540664;54074.72962635162;57891.71054144702;58852.7057364719;62489;64572;65831;15335.769963450557;15684.451044213398;15729.68540629181;15785.921070394805;15792.289346979414;10257;10298.17614590831;10328.535215915303;10332;10437.373757574569;17327.133643317782;20038.298659546846;20692;20736.792632073786;20807.68788468174;7033.296670332926;7178.037303815291;7247.673854676552;7278.854422911512;7316.341529262286;978.4911845840265;982.3958265666564;1061.5488417422564;1094.9671509854718;1106.5739690219164;28037.01870434525;28959.710402896122;29059.709402906123;29372.559411608843;29477.410451790845;1000.9890011088708;1014.6600888702368;1058.5025038232018;1080.713610893114;1122.9775404491863;14902.105873647615;15166.165860877538;15168.165750883587;15352.155631440379;15379.769303460456;316793;319858;320647;320946;321083;52222.47777522252;52307.215391769154;52362.21456678153;52418.73790631023;52759.736201318745;1311.7048664050703;1328;1333.8466076401144;1334.4728832111261;1338.2438922009228;26784;28318.008869689464;28392.148235552966;28462.715372846837;29580.408391831614;43422;43447;43819.56180438155;43820.78089609532;43848.34227486654;247807;248753;248954;250924;251065;28423.43153136967;28980.42039159163;28984;30871.2282192947;32038.35923281568;31812.84093579517;32498.350032999682;35414.46878296879;41532.792336038125;42064.78967605265;34810.680072559975;37248.25503489861;37503.249935000604;37922.2415551693;38138.809305954404;36860.81569592242;37168.44247336346;37455.62573333044;37700.62299376971;37795.05512362213;31291;31625.525617116222;31866;36569;37249.81375093215;25522.744772552036;27634.447311053264;33027.504587430725;33904.49143262902;35751.28497430089;24258.272251832474;24491.38771530726;24533.50932981366;24920;24946.62580061264 02:11:38 INFO - PROCESS | 3527 | |2;jquery.html;363.7163012849977;364.7209884438405;365.64532403568535;365.6471504997677;369.64144779563816;13675.726485470284;13938.16371017737;15758.763618545716;16177.272022758974;16930.153492325397;15117.244137793094;15365.692686146298;15773.369065237377;15899.443519476821;15918.76121858173;5160.174372100474;5299.8410047698435;5306.204069389584;5315.495027972336;5322.787088516455;3944.447777311179;4099.057216840129;5166;5250.527452529272;5545.251391062216;5762.106873434604;5857.853553661172;5873.70631468427;5910.438508341722;5914.88170236595;5872.148538461921;6025.668588227668;6031.065184896304;6050.727717252734;6053.788117415891;5328.280682107905;5347.545458635982;5899.233099697055;6139.1712118863825;6153.661548614825;21894.781052189435;22005;22285.220017299478;22812.77187228123;22824.885875570682;2202.7136472258503;2217.756046834847;2239.787220214077;2252.628316327804;2316.490372118148;13758.793618095737;13946.651333716636;14110;14413.567592972227;14464.349104290228;1823.2524664887333;1932.7777305609754;1937.893415862127;1955.9022048897498;1979.7525309336334;54604.45395546033;61344.38655613431;62966;64978;65725;14304.785428218585;14590.41638334476;14638.780418293734;14670.193139377438;14685.265736713121;23570;23703.525929481315;23839;24277;24375.512489750105;9037;9078.409903356262;9128.817423651622;9360.90639093614;9371.578278977326;7773.922260777433;7834.294913457816;8050.5572193529915;8069.31410830086;8216;7636.274553917369;7772;7785.688572457151;7794.181610930771;7909.6836126555445;2633.6839579250613;2977.8064425812254;2993.925151871221;2996.8801247949837;3034.575159477675;444.2048732768373;459.2468351902882;484.40176382167994;485.85667228167773;839.9034111077182;10250.333728307636;10489.423081730425;10501.789964200672;10593.788124237471;10778;468.5384895877558;473.62820186153704;482.96136309095186;489.39315249091584;897.5018864530249;7812.375009999187;8626.525541095174;9026.368154229272;9868;10254.846177307347;502383;513766;515916;528451.0816580633;528858;56468.152977705366;71495.64252178706;72205.27794721986;74091;74905.62547187338;1015.1777060580953;1050;1089.929154604948;1130.7681925205313;1132.5016992523263;14342.211178384872;14542.563723088324;14562.708745824812;14872.182029988022;15035.849641503883;31112.844435777675;31158.22104447407;31451.84274078615;32966.67033329636;33328.83335583306;41898.58101418947;42143.789281053396;42799.57200427956;43305;43493.91265218395;7307.744228951961;7498.662560184695;7542.981697470771;7600.657970391235;7638.656260468403;9487.525623718924;11128.777424451628;11159.665210043711;11376.772464550828;11477.598284060352;9311.534423278945;9712.757181070247;9745.366551174435;9895.307328486937;10042.69871903844;9992.900070999198;10036.949815250877;10099.293049486465;10180.643677471253;10365.792684146125;3421.418358878947;5364.839054828361;9357.672481463116;9781.902180978099;9861.654842080492;7362.153352364547;7383.335499805044;7513.624318784148;7577.962110189414;7638.923610763822;9522.52387380642;9935.403875767477;10212;10351.378917264989;10404.11565016982 02:11:38 INFO - PROCESS | 3527 | |3;mootools.html;1345.9461621535127;1363.073110285006;1364.8498665146835;1476.520130957439;1699.473163319371;6716.865662686743;7229.132504099509;7418.072740907393;7419.961205431244;7425.7400990965325;7271.345578897898;7460.813479663011;7461.328480436773;7500.5874676892745;7516.699332026712;1957.9902100489478;2001.9399418017483;2002.939911802641;2284.7486776454575;2314.733805612351;2273.022600281878;2329.860208387494;2331.988340058297;2333.8833058347013;2334.311378143443;2238.541099074694;2240.204727321802;2309.191782875997;2309.284121922201;2312.9653055204185;2257.582347265745;2287.3824067501764;2292.32376448948;2292.426893276681;2294.4493321602777;2231.6875637410776;2244.4837687332006;2253.7182852143483;2258.6499092640665;2267.648514480258;7520.6991720331125;7540.773776786705;7544.924550754477;7546.20764819697;7555.357794587467;4571.9542804571865;4689.648276379286;4705.200115980291;4706.341112244254;4707.6233901287815;3093.133922501703;3152.984235078833;3170.3500782339565;3173.7461003119924;3204.198950262434;1010.368519675203;1037.7146284771748;1049.8582691336649;1053.1837825685154;1108.772701596171;10259.538320775582;10291.073803357735;10361.948190259076;10371.844422333672;10376.066154046172;4229.661627069889;4285.785710714452;4319.848805291863;4348.130373925228;4348.630181492819;8738.344624153215;8861.601227944759;8870.334724895658;8876.156765107304;8878.067802880734;4728.929066064012;4770.856874293777;4773.307870358779;4775.808967641325;4776.593989510861;4313.503947046067;4360.978195109004;4362.8691139265875;4365.847195348148;4366.3013917773005;3403.2172600301574;3484.9477257841154;3560.572731272264;3684.797336146538;3791.6208379161862;1159.4840296068169;1161.4773351991637;1167.0838391862517;1169.4328250798355;1174.6887074925153;1257.3964497041472;1271;1274.184521905981;1276.2789024201481;1293.7865252233275;6983.022376867242;6996.370326670624;7071.25751796054;7085.362317391357;7098.254683258287;1087.2335003822445;1090.7818436312612;1091.317926296065;1101.719061639293;1123.2698745815285;5351.86620334487;5387.784488620411;5421.5391691706645;5424.538914192259;5432.70120143388;9039;9114.179723824887;9208.079192080739;9239;9373.390729602554;9227.630894764268;9241.3531052827;9263.120003599648;9272.165505104573;9280.886293644806;7066.75266365685;7251.637418129072;7259.201487836333;7259.310365515374;7358.816029599196;6695.799126026227;6731.024001519654;6736.393724564813;6748.358905903931;6756.155480564929;8171.591420428836;8197.269573464542;8267.338612911073;8428.873566896378;8433.114522975;8353.916460835313;8403.159684031549;8601.698940537051;8668.30653547702;8699.13008699125;6542.771003014872;6752.662366881735;6782.864342713019;6857.759978400732;6905.585664860125;6532.804015879341;6642.070110184674;7020.087388639648;7130.42956563484;7229.240929702516;6662.933370666426;6717.16035495563;6819.624920629214;6860.3139686031;6902.068220790129;6567.080608714879;6642.83392915181;6655.900161497485;6778.42383397397;6803.7618683345845;6511.479081673549;6548.7884741323005;6561.80314590563;6567.638779867153;6573.408393244631;6174.135621012972;6319.178506794087;6350.523710721806;6365.2361716594305;6365.8726825464155;6429.164208652845;6467.126937863328;6477.935220647733;6483.870322593616;6485.837854053686 02:11:38 INFO - PROCESS | 3527 | |4;prototype.html;338.9711874490668;345.17330992273503;351.3500024953836;351.790684542697;353.8779121203184;5812.651240925542;5867.1492633568105;5888.234529511163;5911.379305172959;5934.584579079461;5565.1374037024325;5621.213030175779;5714.399968008954;5769.913451298234;5800.303963524372;4483.50681425043;4500.662450316223;4503.324501324795;4517.954820451786;4526.932096018562;4352.521222665504;4512.503624601291;4514.593686568208;4515.887102822439;4530.569595888385;4383;4399.2521271383785;4446.3108218226225;4449.243628583133;4468.776561171945;4422.358757980091;4424.3142312941545;4453.5323791001965;4489.169503641804;4489.595936365743;3978.5822488638855;3981.7610943343493;3986.8405263789414;3995.081131339779;3999.440078389028;5453.291072160633;5533.280673512418;5539.279893613804;5555.416681248451;5558.749856256478;5222.242774797671;5230.738463076831;5234.110201265794;5239.895202095937;5254.448282930275;6148.569600127993;6149.96925015372;6162.506999440034;6164.075388691687;6168.136460895478;4389;4429.557044295577;4437.977810110961;4439.400680908068;4440.4893437254805;6271.466925311354;6394.968025159891;6398.232212134527;6443.967780161116;6458.903116453257;4528.0943811237885;4533.569310915458;4547.090581883636;4547.090581883636;4551.203539380595;4567.246404343313;4574.176648203355;4574.313852922021;4576.931346029813;4577.1074640444795;5229.738513074331;5231.267622532849;5238.895222095537;5247.685138891678;5248.553872920845;6053.51571874249;6197.349278325711;6203.720832562545;6212.751489940351;6220.066989951543;1616.9676606467806;1638.3937942961181;1638.4019832760957;1640.0323808952537;1640.1225344440907;1115.8214685650257;1115.8884111588777;1118.3345909184022;1118.972025699364;1145.5818626201544;5828.213191219131;5845.1003423887405;5848.795292164754;5851.502622277154;5859.384764599741;6363.936360636427;6366.649834259068;6368.10846481493;6373.267074286424;6373.267074286424;5655.462731040545;5728;5803.448672376117;5879.794207202813;5909.8227053188475;3423.863045478203;3446.672566106216;3447.5518182636597;3454.3954807908517;3455.0844026333043;6660.700268487833;6666.166729158856;6670;6677.3656502632175;6678.4991125665765;6392.7123279452535;6548.443382312462;6556.868862622721;6564.343565643493;6597.109390232257;6674.9666251669405;6680.732770689118;6684.86630267392;6685.632290223987;6689.632070236184;6402.535024015694;6405.854038897021;6412.070249813658;6414.711337989708;6417.807465776034;6106.5114790817515;6306.779262725782;6335.65153916539;6340.334264902119;6345.8730825384155;6657.1345725055435;6681.933180668131;6682.599044057372;6685.431738302299;6694.464442844658;4456.5766252205985;4480.260756975063;4494.303382975644;4497.640188784955;4500.594946454835;6302.527310451643;6432.2281326241155;6441.194850643669;6447.323031081669;6451.54839161273;6273.905891411541;6279.654618995816;6280.371962803683;6280.403361680633;6284.183056202847;6250.218722659668;6293;6293.244810622755;6329.177206963065;6333.524985626189;6040.365761595145;6136.20229370179;6141.955867502625;6156.168917196122;6157.599756015845;6258.718357673824;6288.6855657217875;6291.087792270004;6292.18201633803;6292.653904035322;6097.695115244132;6121.928662484136;6143.416375444325;6148.047052706837;6156 02:11:38 INFO - PROCESS | 3527 | |5;yui.html;759.6088014672443;838.6561509780987;843.7899240390996;851.6550796927247;863.1756672377879;13509.32453377332;13634.181949083062;13643;13671.384787684554;13704.314784260772;11490.540378384876;12735.235885846856;12784;12793.424295906683;12810.67973300668;661.6361001449196;794.1343935110729;809.3646487507308;809.9834707442152;810.3881569415113;800.9879851802227;802.3340627279373;802.6989878795451;807.6648191000728;809.6316176139842;839.6851180807197;846.9237768600825;847.6524624903791;848.1815048478218;848.8132610825639;686.8866637004888;840.6007146605344;841.1252297610478;841.5455653946862;841.7727213652311;520.1885059307492;607.104520831774;621.353792056261;622.0637939900421;622.1445512420422;13238.27189504577;13266.535671251557;13289.13620614657;13350.666233344147;13357.732845343038;12301.446434910451;12688.175268607603;12742.235465871985;13082.411291491906;13181.60455186346;10336.173106151566;10347.793044139074;10464.21518386124;10640.94679526605;11066;3616.674499295076;3694.501242332278;3719.7210209234418;3723.1809002019513;3797.2785170817456;48894;48937.26594101091;48938;48947.75526122382;48995;10028.097471227624;10172.237082218864;10400.843987340197;10489;10595.046445819913;18999.240030398905;19028.429147125607;19037.238510459705;19061.90469047646;19062;7568.062319366827;7676.577788221702;7847.568383738949;7856;7902;4291.420658211164;4484.798184081724;4488.9102217956115;4500.774961251925;4511.616512596401;3022.2897619059504;3029.636443626779;3048.5731997520365;3057.1287183152695;3060.877564897379;523.2935537024986;526.9156934890399;532.0609124894564;543.3099963046988;545.7080461952836;615.3938370704852;634.5938599296454;653.6013032050446;661.6956200147986;669.9330066993261;7853.842923141505;8524.22962537178;9189.540522973824;9224.077592240856;9301.860472092923;546.6200990311695;554.4538629449988;668.5148357724856;694.1531331775226;696.5820507695342;3803.581606023335;3902.824372903226;3975.264576053439;3998.6001399859783;4035.435039094529;54099.45900541023;54356.728216358664;54458.45541544613;54804.72597636986;54836.45163548393;49313.75343123333;51798.741006294724;51966.70083247873;52012;52071;44947.32579011317;45054.32418513725;45206;45419.09161816679;45815.77092114518;8056.1138274788555;8096.149904259968;8101.716439924574;8144.511329320259;8325.791855203426;33489.83255083709;33579.3284134311;34160.48759268563;34602.65397345994;34882.779102731285;42624.360634591125;42930.35604465873;42963.140737184454;43324.35013474737;43372.783136084116;10990;11182;11343.716407089889;11600.245984011011;11621.88378116208;11768.52925882955;11871.52513899469;11932.522699091938;12102.45538950767;12373.257604543756;10648.467576621293;10674.46627668598;10799;11353.716157096138;11497.770044598894;10889.237753357189;11187.608433704781;11233.887661123284;11362.375069370933;11604.129690273094;10768.676939691823;10899.346039237671;10923.126149908147;11037.282576632493;11037.83443248368;8957.328200385127;9505.097015783489;9525.380850244712;9540.95229523848;9751.609935602497;8596;8616.741497755078;8865.911340886509;8883.289336852908;8978.595963181542 02:11:38 INFO - PROCESS | 3527 | __end_tp_report 02:11:38 INFO - PROCESS | 3527 | __start_cc_report 02:11:38 INFO - PROCESS | 3527 | _x_x_mozilla_cycle_collect,1033 02:11:38 INFO - PROCESS | 3527 | __end_cc_report 02:11:38 INFO - PROCESS | 3527 | __startTimestamp1452852698375__endTimestamp 02:11:38 INFO - PROCESS | 3527 | 02:11:38 INFO - PROCESS | 3527 | ------- Summary: start ------- 02:11:38 INFO - PROCESS | 3527 | Number of tests: 6 02:11:38 INFO - PROCESS | 3527 | 02:11:38 INFO - PROCESS | 3527 | [#0] dojo.html Cycles:165 Average:5111.43 Median:5304.80 stddev:548.96 (10.3%) stddev-sans-first:525.79 02:11:38 INFO - PROCESS | 3527 | Values: 3029.8 3110.7 3111.9 3146.0 3168.4 5041.6 5113.4 5147.8 5161.9 5201.3 5125.3 5127.8 5170.4 5186.5 5225.1 4643.9 4664.1 4670.3 4793.9 4802.5 4747.3 4756.7 4817.9 4826.2 4837.4 4646.3 4657.2 4731.2 4736.0 4776.2 4657.5 4660.1 4660.9 4686.0 4715.4 4658.1 4658.6 4677.2 4688.4 4691.4 4918.4 4967.7 5010.6 5028.9 5069.8 5507.3 5536.6 5538.3 5541.0 5544.4 5432.6 5536.8 5554.9 5556.1 5558.8 5104.0 5137.8 5144.7 5176.2 5196.6 5644.8 5658.5 5659.7 5660.7 5662.1 5209.1 5341.7 5458.1 5466.6 5476.4 5502.4 5508.8 5520.3 5526.9 5584.6 5403.8 5439.3 5454.1 5463.8 5469.2 5412.2 5443.2 5471.9 5498.6 5520.8 4251.0 4283.3 4289.2 4305.8 4319.4 3823.4 3857.2 3875.9 3897.0 3904.4 5017.1 5081.9 5104.9 5111.8 5113.8 5426.8 5443.7 5454.0 5454.1 5504.1 5003.0 5069.6 5073.9 5076.2 5124.1 4599.9 4675.8 4693.8 4700.5 4765.5 5659.3 5661.7 5679.4 5679.9 5683.7 5468.4 5470.6 5486.1 5489.4 5523.3 5609.2 5701.4 5709.1 5755.2 5773.9 5394.8 5422.3 5427.2 5428.7 5450.8 5449.3 5517.9 5524.9 5527.6 5532.8 5305.3 5393.6 5416.1 5424.2 5495.3 5363.2 5368.1 5379.0 5380.4 5386.6 5294.5 5304.8 5306.8 5321.4 5354.1 5366.2 5386.0 5394.2 5422.3 5440.5 5203.3 5212.8 5215.2 5216.3 5261.5 02:11:38 INFO - PROCESS | 3527 | 02:11:38 INFO - PROCESS | 3527 | [#1] ext.html Cycles:180 Average:44607.38 Median:36160.14 stddev:73457.77 (203.1%) stddev-sans-first:73589.26 02:11:38 INFO - PROCESS | 3527 | Values: 523.8 525.3 527.2 542.8 554.6 28512.7 29479.9 29600.0 29636.1 36883.6 40911.6 41454.8 41501.4 41539.8 41570.6 8624.7 8929.8 8931.5 8933.5 8933.6 8594.6 8686.0 8752.0 8753.3 8766.9 8774.4 8857.0 8861.3 8864.0 8864.4 8712.7 8803.2 8809.0 8810.9 8815.0 8665.7 8772.7 8804.1 8806.1 8806.6 39964.8 40298.2 40370.4 40413.2 40438.0 3244.2 3407.8 3831.4 4056.8 4112.4 28580.7 30440.0 30506.7 30622.0 31983.5 3904.8 4030.4 4044.9 4063.3 4095.0 268765.0 269361.0 269804.0 269924.0 270644.0 53620.7 54018.2 54032.2 54071.5 54074.7 57891.7 58852.7 62489.0 64572.0 65831.0 15335.8 15684.5 15729.7 15785.9 15792.3 10257.0 10298.2 10328.5 10332.0 10437.4 17327.1 20038.3 20692.0 20736.8 20807.7 7033.3 7178.0 7247.7 7278.9 7316.3 978.5 982.4 1061.5 1095.0 1106.6 28037.0 28959.7 29059.7 29372.6 29477.4 1001.0 1014.7 1058.5 1080.7 1123.0 14902.1 15166.2 15168.2 15352.2 15379.8 316793.0 319858.0 320647.0 320946.0 321083.0 52222.5 52307.2 52362.2 52418.7 52759.7 1311.7 1328.0 1333.8 1334.5 1338.2 26784.0 28318.0 28392.1 28462.7 29580.4 43422.0 43447.0 43819.6 43820.8 43848.3 247807.0 248753.0 248954.0 250924.0 251065.0 28423.4 28980.4 28984.0 30871.2 32038.4 31812.8 32498.4 35414.5 41532.8 42064.8 34810.7 37248.3 37503.2 37922.2 38138.8 36860.8 37168.4 37455.6 37700.6 37795.1 31291.0 31625.5 31866.0 36569.0 37249.8 25522.7 27634.4 33027.5 33904.5 35751.3 24258.3 24491.4 24533.5 24920.0 24946.6 02:11:38 INFO - PROCESS | 3527 | 02:11:38 INFO - PROCESS | 3527 | [#2] jquery.html Cycles:180 Average:27511.71 Median:21969.06 stddev:84566.79 (384.9%) stddev-sans-first:84779.45 02:11:38 INFO - PROCESS | 3527 | Values: 363.7 364.7 365.6 365.6 369.6 13675.7 13938.2 15758.8 16177.3 16930.2 15117.2 15365.7 15773.4 15899.4 15918.8 5160.2 5299.8 5306.2 5315.5 5322.8 3944.4 4099.1 5166.0 5250.5 5545.3 5762.1 5857.9 5873.7 5910.4 5914.9 5872.1 6025.7 6031.1 6050.7 6053.8 5328.3 5347.5 5899.2 6139.2 6153.7 21894.8 22005.0 22285.2 22812.8 22824.9 2202.7 2217.8 2239.8 2252.6 2316.5 13758.8 13946.7 14110.0 14413.6 14464.3 1823.3 1932.8 1937.9 1955.9 1979.8 54604.5 61344.4 62966.0 64978.0 65725.0 14304.8 14590.4 14638.8 14670.2 14685.3 23570.0 23703.5 23839.0 24277.0 24375.5 9037.0 9078.4 9128.8 9360.9 9371.6 7773.9 7834.3 8050.6 8069.3 8216.0 7636.3 7772.0 7785.7 7794.2 7909.7 2633.7 2977.8 2993.9 2996.9 3034.6 444.2 459.2 484.4 485.9 839.9 10250.3 10489.4 10501.8 10593.8 10778.0 468.5 473.6 483.0 489.4 897.5 7812.4 8626.5 9026.4 9868.0 10254.8 502383.0 513766.0 515916.0 528451.1 528858.0 56468.2 71495.6 72205.3 74091.0 74905.6 1015.2 1050.0 1089.9 1130.8 1132.5 14342.2 14542.6 14562.7 14872.2 15035.8 31112.8 31158.2 31451.8 32966.7 33328.8 41898.6 42143.8 42799.6 43305.0 43493.9 7307.7 7498.7 7543.0 7600.7 7638.7 9487.5 11128.8 11159.7 11376.8 11477.6 9311.5 9712.8 9745.4 9895.3 10042.7 9992.9 10036.9 10099.3 10180.6 10365.8 3421.4 5364.8 9357.7 9781.9 9861.7 7362.2 7383.3 7513.6 7578.0 7638.9 9522.5 9935.4 10212.0 10351.4 10404.1 02:11:38 INFO - PROCESS | 3527 | 02:11:38 INFO - PROCESS | 3527 | [#3] mootools.html Cycles:180 Average:5326.63 Median:6246.66 stddev:2716.13 (43.5%) stddev-sans-first:2707.26 02:11:38 INFO - PROCESS | 3527 | Values: 1345.9 1363.1 1364.8 1476.5 1699.5 6716.9 7229.1 7418.1 7420.0 7425.7 7271.3 7460.8 7461.3 7500.6 7516.7 1958.0 2001.9 2002.9 2284.7 2314.7 2273.0 2329.9 2332.0 2333.9 2334.3 2238.5 2240.2 2309.2 2309.3 2313.0 2257.6 2287.4 2292.3 2292.4 2294.4 2231.7 2244.5 2253.7 2258.6 2267.6 7520.7 7540.8 7544.9 7546.2 7555.4 4572.0 4689.6 4705.2 4706.3 4707.6 3093.1 3153.0 3170.4 3173.7 3204.2 1010.4 1037.7 1049.9 1053.2 1108.8 10259.5 10291.1 10361.9 10371.8 10376.1 4229.7 4285.8 4319.8 4348.1 4348.6 8738.3 8861.6 8870.3 8876.2 8878.1 4728.9 4770.9 4773.3 4775.8 4776.6 4313.5 4361.0 4362.9 4365.8 4366.3 3403.2 3484.9 3560.6 3684.8 3791.6 1159.5 1161.5 1167.1 1169.4 1174.7 1257.4 1271.0 1274.2 1276.3 1293.8 6983.0 6996.4 7071.3 7085.4 7098.3 1087.2 1090.8 1091.3 1101.7 1123.3 5351.9 5387.8 5421.5 5424.5 5432.7 9039.0 9114.2 9208.1 9239.0 9373.4 9227.6 9241.4 9263.1 9272.2 9280.9 7066.8 7251.6 7259.2 7259.3 7358.8 6695.8 6731.0 6736.4 6748.4 6756.2 8171.6 8197.3 8267.3 8428.9 8433.1 8353.9 8403.2 8601.7 8668.3 8699.1 6542.8 6752.7 6782.9 6857.8 6905.6 6532.8 6642.1 7020.1 7130.4 7229.2 6662.9 6717.2 6819.6 6860.3 6902.1 6567.1 6642.8 6655.9 6778.4 6803.8 6511.5 6548.8 6561.8 6567.6 6573.4 6174.1 6319.2 6350.5 6365.2 6365.9 6429.2 6467.1 6477.9 6483.9 6485.8 02:11:38 INFO - PROCESS | 3527 | 02:11:38 INFO - PROCESS | 3527 | [#4] prototype.html Cycles:180 Average:5210.24 Median:5846.95 stddev:1545.73 (26.4%) stddev-sans-first:1506.20 02:11:38 INFO - PROCESS | 3527 | Values: 339.0 345.2 351.4 351.8 353.9 5812.7 5867.1 5888.2 5911.4 5934.6 5565.1 5621.2 5714.4 5769.9 5800.3 4483.5 4500.7 4503.3 4518.0 4526.9 4352.5 4512.5 4514.6 4515.9 4530.6 4383.0 4399.3 4446.3 4449.2 4468.8 4422.4 4424.3 4453.5 4489.2 4489.6 3978.6 3981.8 3986.8 3995.1 3999.4 5453.3 5533.3 5539.3 5555.4 5558.7 5222.2 5230.7 5234.1 5239.9 5254.4 6148.6 6150.0 6162.5 6164.1 6168.1 4389.0 4429.6 4438.0 4439.4 4440.5 6271.5 6395.0 6398.2 6444.0 6458.9 4528.1 4533.6 4547.1 4547.1 4551.2 4567.2 4574.2 4574.3 4576.9 4577.1 5229.7 5231.3 5238.9 5247.7 5248.6 6053.5 6197.3 6203.7 6212.8 6220.1 1617.0 1638.4 1638.4 1640.0 1640.1 1115.8 1115.9 1118.3 1119.0 1145.6 5828.2 5845.1 5848.8 5851.5 5859.4 6363.9 6366.6 6368.1 6373.3 6373.3 5655.5 5728.0 5803.4 5879.8 5909.8 3423.9 3446.7 3447.6 3454.4 3455.1 6660.7 6666.2 6670.0 6677.4 6678.5 6392.7 6548.4 6556.9 6564.3 6597.1 6675.0 6680.7 6684.9 6685.6 6689.6 6402.5 6405.9 6412.1 6414.7 6417.8 6106.5 6306.8 6335.7 6340.3 6345.9 6657.1 6681.9 6682.6 6685.4 6694.5 4456.6 4480.3 4494.3 4497.6 4500.6 6302.5 6432.2 6441.2 6447.3 6451.5 6273.9 6279.7 6280.4 6280.4 6284.2 6250.2 6293.0 6293.2 6329.2 6333.5 6040.4 6136.2 6142.0 6156.2 6157.6 6258.7 6288.7 6291.1 6292.2 6292.7 6097.7 6121.9 6143.4 6148.0 6156.0 02:11:38 INFO - PROCESS | 3527 | 02:11:38 INFO - PROCESS | 3527 | [#5] yui.html Cycles:180 Average:13630.94 Median:24782.97 stddev:15619.88 (63.0%) stddev-sans-first:15633.79 02:11:38 INFO - PROCESS | 3527 | Values: 759.6 838.7 843.8 851.7 863.2 13509.3 13634.2 13643.0 13671.4 13704.3 11490.5 12735.2 12784.0 12793.4 12810.7 661.6 794.1 809.4 810.0 810.4 801.0 802.3 802.7 807.7 809.6 839.7 846.9 847.7 848.2 848.8 686.9 840.6 841.1 841.5 841.8 520.2 607.1 621.4 622.1 622.1 13238.3 13266.5 13289.1 13350.7 13357.7 12301.4 12688.2 12742.2 13082.4 13181.6 10336.2 10347.8 10464.2 10640.9 11066.0 3616.7 3694.5 3719.7 3723.2 3797.3 48894.0 48937.3 48938.0 48947.8 48995.0 10028.1 10172.2 10400.8 10489.0 10595.0 18999.2 19028.4 19037.2 19061.9 19062.0 7568.1 7676.6 7847.6 7856.0 7902.0 4291.4 4484.8 4488.9 4500.8 4511.6 3022.3 3029.6 3048.6 3057.1 3060.9 523.3 526.9 532.1 543.3 545.7 615.4 634.6 653.6 661.7 669.9 7853.8 8524.2 9189.5 9224.1 9301.9 546.6 554.5 668.5 694.2 696.6 3803.6 3902.8 3975.3 3998.6 4035.4 54099.5 54356.7 54458.5 54804.7 54836.5 49313.8 51798.7 51966.7 52012.0 52071.0 44947.3 45054.3 45206.0 45419.1 45815.8 8056.1 8096.1 8101.7 8144.5 8325.8 33489.8 33579.3 34160.5 34602.7 34882.8 42624.4 42930.4 42963.1 43324.4 43372.8 10990.0 11182.0 11343.7 11600.2 11621.9 11768.5 11871.5 11932.5 12102.5 12373.3 10648.5 10674.5 10799.0 11353.7 11497.8 10889.2 11187.6 11233.9 11362.4 11604.1 10768.7 10899.3 10923.1 11037.3 11037.8 8957.3 9505.1 9525.4 9541.0 9751.6 8596.0 8616.7 8865.9 8883.3 8978.6 02:11:38 INFO - PROCESS | 3527 | -------- Summary: end -------- 02:11:38 INFO - PROCESS | 3527 | 02:11:39 INFO - TEST-INFO | 3527: exit 0 02:11:39 INFO - TEST-OK | dromaeo_css | took 1115418ms 02:11:39 INFO - TEST-START | kraken 02:11:39 INFO - operating with platform_type : linux_ 02:11:39 INFO - Initialising browser for kraken test... 02:11:39 INFO - TEST-INFO | started process 3718 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1YqB2W/profile http://localhost:54156/getInfo.html) 02:11:43 INFO - PROCESS | 3718 | __metrics Screen width/height:1600/1200 02:11:43 INFO - PROCESS | 3718 | colorDepth:24 02:11:43 INFO - PROCESS | 3718 | Browser inner width/height: 1024/697 02:11:43 INFO - PROCESS | 3718 | __metrics 02:11:43 INFO - PROCESS | 3718 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:11:43 INFO - PROCESS | 3718 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:11:44 INFO - TEST-INFO | 3718: exit 0 02:11:44 INFO - Browser initialized. 02:11:44 INFO - Running cycle 1/1 for kraken test... 02:11:44 INFO - TEST-INFO | started process 3804 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1YqB2W/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:11:56 INFO - PROCESS | 3804 | RSS: Main: 150110208 02:11:56 INFO - PROCESS | 3804 | 02:11:59 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:54156/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54156/tests/kraken/driver.html?testName=audio-beat-detection) 02:11:59 INFO - PROCESS | 3804 | RSS: Main: 188174336 02:11:59 INFO - PROCESS | 3804 | 02:12:02 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:54156/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54156/tests/kraken/driver.html?testName=audio-dft) 02:12:02 INFO - PROCESS | 3804 | RSS: Main: 177864704 02:12:02 INFO - PROCESS | 3804 | 02:12:05 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:54156/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54156/tests/kraken/driver.html?testName=audio-fft) 02:12:06 INFO - PROCESS | 3804 | RSS: Main: 161529856 02:12:06 INFO - PROCESS | 3804 | 02:12:08 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:54156/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54156/tests/kraken/driver.html?testName=audio-oscillator) 02:12:08 INFO - PROCESS | 3804 | RSS: Main: 164999168 02:12:08 INFO - PROCESS | 3804 | 02:12:11 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:54156/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54156/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:12:11 INFO - PROCESS | 3804 | RSS: Main: 165842944 02:12:11 INFO - PROCESS | 3804 | 02:12:14 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:54156/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54156/tests/kraken/driver.html?testName=imaging-darkroom) 02:12:15 INFO - PROCESS | 3804 | RSS: Main: 165736448 02:12:15 INFO - PROCESS | 3804 | 02:12:18 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:54156/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54156/tests/kraken/driver.html?testName=imaging-desaturate) 02:12:19 INFO - PROCESS | 3804 | RSS: Main: 165810176 02:12:19 INFO - PROCESS | 3804 | 02:12:21 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:54156/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54156/tests/kraken/driver.html?testName=json-parse-financial) 02:12:22 INFO - PROCESS | 3804 | RSS: Main: 168505344 02:12:22 INFO - PROCESS | 3804 | 02:12:24 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:54156/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54156/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:12:24 INFO - PROCESS | 3804 | RSS: Main: 175378432 02:12:24 INFO - PROCESS | 3804 | 02:12:26 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:54156/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54156/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:12:26 INFO - PROCESS | 3804 | RSS: Main: 171364352 02:12:26 INFO - PROCESS | 3804 | 02:12:29 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:54156/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54156/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:12:29 INFO - PROCESS | 3804 | RSS: Main: 181366784 02:12:29 INFO - PROCESS | 3804 | 02:12:31 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:54156/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54156/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:12:32 INFO - PROCESS | 3804 | RSS: Main: 190234624 02:12:32 INFO - PROCESS | 3804 | 02:12:35 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:54156/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54156/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:12:35 INFO - PROCESS | 3804 | RSS: Main: 189612032 02:12:35 INFO - PROCESS | 3804 | 02:12:37 INFO - PROCESS | 3804 | Cycle 1(1): loaded http://localhost:54156/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54156/tests/kraken/driver.html?testName=ai-astar) 02:12:37 INFO - PROCESS | 3804 | RSS: Main: 247107584 02:12:37 INFO - PROCESS | 3804 | 02:12:37 INFO - PROCESS | 3804 | __start_tp_report 02:12:37 INFO - PROCESS | 3804 | _x_x_mozilla_page_load 02:12:37 INFO - PROCESS | 3804 | _x_x_mozilla_page_load_details 02:12:37 INFO - PROCESS | 3804 | |i|pagename|runs| 02:12:37 INFO - PROCESS | 3804 | |0;ai-astar;110;111;106;110;111;111;100;110;111;112 02:12:37 INFO - PROCESS | 3804 | |1;audio-beat-detection;149;127;157;170;125;157;146;125;167;126 02:12:37 INFO - PROCESS | 3804 | |2;audio-dft;162;162;161;160;161;161;160;165;162;163 02:12:37 INFO - PROCESS | 3804 | |3;audio-fft;72;74;97;96;72;71;71;128;95;71 02:12:37 INFO - PROCESS | 3804 | |4;audio-oscillator;97;96;151;96;96;95;138;96;97;136 02:12:37 INFO - PROCESS | 3804 | |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;110;109 02:12:37 INFO - PROCESS | 3804 | |6;imaging-darkroom;146;145;146;145;145;144;146;146;145;146 02:12:37 INFO - PROCESS | 3804 | |7;imaging-desaturate;96;96;95;96;96;96;96;96;96;96 02:12:37 INFO - PROCESS | 3804 | |8;json-parse-financial;55;54;55;55;55;56;55;68;54;54 02:12:37 INFO - PROCESS | 3804 | |9;json-stringify-tinderbox;67;67;67;68;68;67;68;67;68;68 02:12:37 INFO - PROCESS | 3804 | |10;stanford-crypto-aes;82;82;82;89;82;82;83;83;82;89 02:12:37 INFO - PROCESS | 3804 | |11;stanford-crypto-ccm;112;113;113;119;117;131;121;132;114;114 02:12:37 INFO - PROCESS | 3804 | |12;stanford-crypto-pbkdf2;144;134;141;144;143;132;144;144;146;145 02:12:37 INFO - PROCESS | 3804 | |13;stanford-crypto-sha256-iterative;70;69;67;66;65;66;67;65;68;68 02:12:37 INFO - PROCESS | 3804 | __end_tp_report 02:12:37 INFO - PROCESS | 3804 | __start_cc_report 02:12:37 INFO - PROCESS | 3804 | _x_x_mozilla_cycle_collect,929 02:12:37 INFO - PROCESS | 3804 | __end_cc_report 02:12:37 INFO - PROCESS | 3804 | __startTimestamp1452852757589__endTimestamp 02:12:37 INFO - PROCESS | 3804 | 02:12:37 INFO - PROCESS | 3804 | ------- Summary: start ------- 02:12:37 INFO - PROCESS | 3804 | Number of tests: 14 02:12:37 INFO - PROCESS | 3804 | 02:12:37 INFO - PROCESS | 3804 | [#0] ai-astar Cycles:10 Average:109.20 Median:111.00 stddev:3.61 (3.3%) stddev-sans-first:3.82 02:12:37 INFO - PROCESS | 3804 | Values: 110.0 111.0 106.0 110.0 111.0 111.0 100.0 110.0 111.0 112.0 02:12:37 INFO - PROCESS | 3804 | 02:12:37 INFO - PROCESS | 3804 | [#1] audio-beat-detection Cycles:10 Average:144.90 Median:153.00 stddev:17.95 (11.7%) stddev-sans-first:18.97 02:12:37 INFO - PROCESS | 3804 | Values: 149.0 127.0 157.0 170.0 125.0 157.0 146.0 125.0 167.0 126.0 02:12:37 INFO - PROCESS | 3804 | 02:12:37 INFO - PROCESS | 3804 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.49 (0.9%) stddev-sans-first:1.58 02:12:37 INFO - PROCESS | 3804 | Values: 162.0 162.0 161.0 160.0 161.0 161.0 160.0 165.0 162.0 163.0 02:12:37 INFO - PROCESS | 3804 | 02:12:37 INFO - PROCESS | 3804 | [#3] audio-fft Cycles:10 Average:84.70 Median:73.00 stddev:19.03 (26.1%) stddev-sans-first:19.62 02:12:37 INFO - PROCESS | 3804 | Values: 72.0 74.0 97.0 96.0 72.0 71.0 71.0 128.0 95.0 71.0 02:12:37 INFO - PROCESS | 3804 | 02:12:37 INFO - PROCESS | 3804 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:96.00 stddev:22.33 (23.3%) stddev-sans-first:23.20 02:12:37 INFO - PROCESS | 3804 | Values: 97.0 96.0 151.0 96.0 96.0 95.0 138.0 96.0 97.0 136.0 02:12:37 INFO - PROCESS | 3804 | 02:12:37 INFO - PROCESS | 3804 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:12:37 INFO - PROCESS | 3804 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 02:12:37 INFO - PROCESS | 3804 | 02:12:37 INFO - PROCESS | 3804 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 02:12:37 INFO - PROCESS | 3804 | Values: 146.0 145.0 146.0 145.0 145.0 144.0 146.0 146.0 145.0 146.0 02:12:37 INFO - PROCESS | 3804 | 02:12:37 INFO - PROCESS | 3804 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:12:37 INFO - PROCESS | 3804 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 02:12:37 INFO - PROCESS | 3804 | 02:12:37 INFO - PROCESS | 3804 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:55.00 stddev:4.23 (7.7%) stddev-sans-first:4.47 02:12:37 INFO - PROCESS | 3804 | Values: 55.0 54.0 55.0 55.0 55.0 56.0 55.0 68.0 54.0 54.0 02:12:37 INFO - PROCESS | 3804 | 02:12:37 INFO - PROCESS | 3804 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:68.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 02:12:37 INFO - PROCESS | 3804 | Values: 67.0 67.0 67.0 68.0 68.0 67.0 68.0 67.0 68.0 68.0 02:12:37 INFO - PROCESS | 3804 | 02:12:37 INFO - PROCESS | 3804 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:82.50 stddev:2.88 (3.5%) stddev-sans-first:2.99 02:12:37 INFO - PROCESS | 3804 | Values: 82.0 82.0 82.0 89.0 82.0 82.0 83.0 83.0 82.0 89.0 02:12:37 INFO - PROCESS | 3804 | 02:12:37 INFO - PROCESS | 3804 | [#11] stanford-crypto-ccm Cycles:10 Average:118.60 Median:118.00 stddev:7.38 (6.3%) stddev-sans-first:7.43 02:12:37 INFO - PROCESS | 3804 | Values: 112.0 113.0 113.0 119.0 117.0 131.0 121.0 132.0 114.0 114.0 02:12:37 INFO - PROCESS | 3804 | 02:12:37 INFO - PROCESS | 3804 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.70 Median:144.00 stddev:4.79 (3.3%) stddev-sans-first:5.00 02:12:37 INFO - PROCESS | 3804 | Values: 144.0 134.0 141.0 144.0 143.0 132.0 144.0 144.0 146.0 145.0 02:12:37 INFO - PROCESS | 3804 | 02:12:37 INFO - PROCESS | 3804 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:1.66 (2.5%) stddev-sans-first:1.39 02:12:37 INFO - PROCESS | 3804 | Values: 70.0 69.0 67.0 66.0 65.0 66.0 67.0 65.0 68.0 68.0 02:12:37 INFO - PROCESS | 3804 | -------- Summary: end -------- 02:12:37 INFO - PROCESS | 3804 | 02:12:38 INFO - TEST-INFO | 3804: exit 0 02:12:38 INFO - TEST-OK | kraken | took 59344ms 02:12:38 INFO - TEST-START | v8_7 02:12:38 INFO - operating with platform_type : linux_ 02:12:38 INFO - Initialising browser for v8_7 test... 02:12:38 INFO - TEST-INFO | started process 4050 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKOrKQ9/profile http://localhost:54156/getInfo.html) 02:12:42 INFO - PROCESS | 4050 | __metrics Screen width/height:1600/1200 02:12:42 INFO - PROCESS | 4050 | colorDepth:24 02:12:42 INFO - PROCESS | 4050 | Browser inner width/height: 1024/697 02:12:42 INFO - PROCESS | 4050 | __metrics 02:12:42 INFO - PROCESS | 4050 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:12:42 INFO - PROCESS | 4050 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:12:44 INFO - TEST-INFO | 4050: exit 0 02:12:44 INFO - Browser initialized. 02:12:44 INFO - Running cycle 1/1 for v8_7 test... 02:12:44 INFO - TEST-INFO | started process 4135 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKOrKQ9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:12:55 INFO - PROCESS | 4135 | RSS: Main: 150159360 02:12:55 INFO - PROCESS | 4135 | 02:13:18 INFO - PROCESS | 4135 | Cycle 1(1): loaded http://localhost:54156/tests/v8_7/run.html (next: http://localhost:54156/tests/v8_7/run.html) 02:13:18 INFO - PROCESS | 4135 | RSS: Main: 551362560 02:13:18 INFO - PROCESS | 4135 | 02:13:18 INFO - PROCESS | 4135 | __start_tp_report 02:13:18 INFO - PROCESS | 4135 | _x_x_mozilla_page_load 02:13:18 INFO - PROCESS | 4135 | _x_x_mozilla_page_load_details 02:13:18 INFO - PROCESS | 4135 | |i|pagename|runs| 02:13:18 INFO - PROCESS | 4135 | |0;Richards;169.23337282112033 02:13:18 INFO - PROCESS | 4135 | |1;DeltaBlue;188.5014137606032 02:13:18 INFO - PROCESS | 4135 | |2;Encrypt;279.17364600781684 02:13:18 INFO - PROCESS | 4135 | |3;Decrypt;5213.541666666667 02:13:18 INFO - PROCESS | 4135 | |4;RayTrace;1937.984496124031 02:13:18 INFO - PROCESS | 4135 | |5;Earley;783.0853563038371 02:13:18 INFO - PROCESS | 4135 | |6;Boyer;12358.024691358025 02:13:18 INFO - PROCESS | 4135 | |7;RegExp;43062.5 02:13:18 INFO - PROCESS | 4135 | |8;Splay;590.9090909090909 02:13:18 INFO - PROCESS | 4135 | |9;NavierStokes;4826.923076923077 02:13:18 INFO - PROCESS | 4135 | __end_tp_report 02:13:18 INFO - PROCESS | 4135 | __startTimestamp1452852798559__endTimestamp 02:13:18 INFO - PROCESS | 4135 | 02:13:18 INFO - PROCESS | 4135 | ------- Summary: start ------- 02:13:18 INFO - PROCESS | 4135 | Number of tests: 10 02:13:18 INFO - PROCESS | 4135 | 02:13:18 INFO - PROCESS | 4135 | [#0] Richards Cycles:1 Average:169.23 Median:169.23 stddev:0.00 (0.0%) 02:13:18 INFO - PROCESS | 4135 | Values: 169.2 02:13:18 INFO - PROCESS | 4135 | 02:13:18 INFO - PROCESS | 4135 | [#1] DeltaBlue Cycles:1 Average:188.50 Median:188.50 stddev:0.00 (0.0%) 02:13:18 INFO - PROCESS | 4135 | Values: 188.5 02:13:18 INFO - PROCESS | 4135 | 02:13:18 INFO - PROCESS | 4135 | [#2] Encrypt Cycles:1 Average:279.17 Median:279.17 stddev:0.00 (0.0%) 02:13:18 INFO - PROCESS | 4135 | Values: 279.2 02:13:18 INFO - PROCESS | 4135 | 02:13:18 INFO - PROCESS | 4135 | [#3] Decrypt Cycles:1 Average:5213.54 Median:5213.54 stddev:0.00 (0.0%) 02:13:18 INFO - PROCESS | 4135 | Values: 5213.5 02:13:18 INFO - PROCESS | 4135 | 02:13:18 INFO - PROCESS | 4135 | [#4] RayTrace Cycles:1 Average:1937.98 Median:1937.98 stddev:0.00 (0.0%) 02:13:18 INFO - PROCESS | 4135 | Values: 1938.0 02:13:18 INFO - PROCESS | 4135 | 02:13:18 INFO - PROCESS | 4135 | [#5] Earley Cycles:1 Average:783.09 Median:783.09 stddev:0.00 (0.0%) 02:13:18 INFO - PROCESS | 4135 | Values: 783.1 02:13:18 INFO - PROCESS | 4135 | 02:13:18 INFO - PROCESS | 4135 | [#6] Boyer Cycles:1 Average:12358.02 Median:12358.02 stddev:0.00 (0.0%) 02:13:18 INFO - PROCESS | 4135 | Values: 12358.0 02:13:18 INFO - PROCESS | 4135 | 02:13:18 INFO - PROCESS | 4135 | [#7] RegExp Cycles:1 Average:43062.50 Median:43062.50 stddev:0.00 (0.0%) 02:13:18 INFO - PROCESS | 4135 | Values: 43062.5 02:13:18 INFO - PROCESS | 4135 | 02:13:18 INFO - PROCESS | 4135 | [#8] Splay Cycles:1 Average:590.91 Median:590.91 stddev:0.00 (0.0%) 02:13:18 INFO - PROCESS | 4135 | Values: 590.9 02:13:18 INFO - PROCESS | 4135 | 02:13:18 INFO - PROCESS | 4135 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 02:13:18 INFO - PROCESS | 4135 | Values: 4826.9 02:13:18 INFO - PROCESS | 4135 | -------- Summary: end -------- 02:13:18 INFO - PROCESS | 4135 | 02:13:19 INFO - TEST-INFO | 4135: exit 0 02:13:19 INFO - TEST-OK | v8_7 | took 41088ms 02:13:19 INFO - SUITE-END | took 1215s 02:13:20 INFO - Completed test suite (00:20:16) 02:13:20 INFO - Working with test: dromaeo_css 02:13:20 INFO - Generating results file: dromaeo_css 02:13:20 INFO - Working with test: kraken 02:13:20 INFO - Generating results file: kraken 02:13:20 INFO - javascript benchmark 02:13:20 INFO - Working with test: v8_7 02:13:20 INFO - Generating results file: v8_7 02:13:20 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:13:20 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 02:13:20 INFO - process_Request line: dromaeo_css 6824.27 graph.html#tests=[[72,64,35]] 02:13:20 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:13:20 INFO - process_Request line: kraken 1495.30 graph.html#tests=[[232,64,35]] 02:13:20 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:13:20 INFO - process_Request line: v8_7 18930.59 graph.html#tests=[[230,64,35]] 02:13:20 INFO - RETURN: dromaeo_css: 6824.27 02:13:20 INFO - RETURN: kraken: 1495.30 02:13:20 INFO - RETURN: v8_7: 18930.59 02:13:20 INFO - javascript benchmark 02:13:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3029.7727670424715, 3110.704483074109, 3111.875524979001, 3145.9842700786494, 3168.413843438964, 5041.571466425358, 5113.360829896263, 5147.794088236471, 5161.922571161431, 5201.297824793652, 5125.28246045553, 5127.794888204477, 5170.4312525622245, 5186.455422180673, 5225.059489291926, 4643.8839029024375, 4664.1371346300875, 4670.25275955848, 4793.880152996168, 4802.495737947517, 4747.287906813971, 4756.714597124166, 4817.864841507156, 4826.227803551433, 4837.371141751567, 4646.326282689025, 4657.208274593328, 4731.2430011198385, 4735.999999999965, 4776.164171270014, 4657.4876763555985, 4660.067986402733, 4660.906781864343, 4685.953140468586, 4715.3869996900185, 4658.068386322715, 4658.604018658418, 4677.18149323867, 4688.367070445481, 4691.413573303337, 4918.360613120271, 4967.7019378837385, 5010.62420318474, 5028.874278143039, 5069.797208111708, 5507.256520369739, 5536.640118392292, 5538.280023596906, 5540.972295138539, 5544.445555444464, 5432.619716619838, 5536.750846211889, 5554.86112847178, 5556.055470570012, 5558.833235002957, 5103.999999999963, 5137.8201762938115, 5144.691318520863, 5176.223566464985, 5196.584273258168, 5644.774209031675, 5658.490735833712, 5659.660420374791, 5660.688662123623, 5662.122371032497, 5209.088409528393, 5341.65279256847, 5458.126699728104, 5466.590005749585, 5476.3702174250475, 5502.422245664147, 5508.7521061552325, 5520.337559492807, 5526.944730552643, 5584.5811564132855, 5403.8108666196495, 5439.292891924025, 5454.12733962572, 5463.7814487420055, 5469.15228139639, 5412.242286079952, 5443.183522471661, 5471.917921231185, 5498.615096943176, 5520.834374968757, 4251.0, 4283.2932566126865, 4289.206496798102, 4305.84929527465, 4319.3952846601505, 3823.445600387928, 3857.209272099269, 3875.9418608720894, 3896.9610303896598, 3904.355781296111, 5017.071841709222, 5081.8729531762, 5104.872378190501, 5111.821086261963, 5113.795448182105, 5426.810061647823, 5443.700596467153, 5454.0, 5454.127339625641, 5504.119340905436, 5002.974985125051, 5069.619778516626, 5073.949260507421, 5076.18780995039, 5124.052050370693, 4599.931001034987, 4675.7895894684825, 4693.7653117344, 4700.529947005272, 4765.475797662254, 5659.26429564154, 5661.745221465044, 5679.403662615448, 5679.8864022720145, 5683.687397193112, 5468.3711373191, 5470.64440811346, 5486.1222204447095, 5489.4236105209975, 5523.25436066142, 5609.158626206102, 5701.372848986525, 5709.0865461525955, 5755.1942728017275, 5773.8556536086935, 5394.757235924314, 5422.322209723785, 5427.185922111715, 5428.70142142186, 5450.754716037709, 5449.291592093003, 5517.889642207214, 5524.944750552443, 5527.5577953762795, 5532.775627419153, 5305.283786688748, 5393.649412788156, 5416.079266524779, 5424.159255315432, 5495.258140151188, 5363.168708850135, 5368.114261146867, 5379.0, 5380.354357476971, 5386.649867758583, 5294.49702278283, 5304.795233516118, 5306.761195746123, 5321.441248668834, 5354.143337066051, 5366.2487251784005, 5385.973070134624, 5394.190871369326, 5422.349318081855, 5440.510354068153, 5203.323567936144, 5212.791488340576, 5215.217717342429, 5216.347956505437, 5261.500157485033], "unit": "score", "name": "dojo.html", "value": 5077.109190354692}, {"lowerIsBetter": false, "replicates": [523.7800123947942, 525.3013492055566, 527.2144504688016, 542.7801740295181, 554.5702080887314, 28512.714872851266, 29479.852600736995, 29600.0, 29636.110916672507, 36883.631163688355, 40911.59088409115, 41454.79272603633, 41501.37747933776, 41539.79230103853, 41570.58429415705, 8624.698135565272, 8929.821403571925, 8931.464112153291, 8933.508657023862, 8933.642654293853, 8594.613242404075, 8685.956570217171, 8752.037275899645, 8753.299736021136, 8766.912330876674, 8774.429662071976, 8857.0, 8861.291096712279, 8864.0, 8864.423812452202, 8712.738617841474, 8803.163699448542, 8808.955955220246, 8810.867836982483, 8814.955925220396, 8665.653373865038, 8772.736817895473, 8804.119588041145, 8806.075362087016, 8806.603702833389, 39964.800175998935, 40298.194036119115, 40370.394444083366, 40413.191736165405, 40438.0, 3244.1727359523406, 3407.8296085195643, 3831.425286207091, 4056.7565946043333, 4112.444819949298, 28580.714192858013, 30440.0, 30506.694933050607, 30622.0, 31983.52024719631, 3904.8047597620007, 4030.435738996543, 4044.898877528056, 4063.349864021742, 4094.996725802168, 268765.0, 269361.0, 269804.0, 269923.999999998, 270644.0, 53620.73189634105, 54018.189727154124, 54032.189517157276, 54071.45928540664, 54074.72962635162, 57891.71054144702, 58852.7057364719, 62489.0, 64572.0, 65831.0, 15335.769963450557, 15684.451044213398, 15729.68540629181, 15785.921070394805, 15792.289346979414, 10257.0, 10298.17614590831, 10328.535215915303, 10332.0, 10437.373757574569, 17327.133643317782, 20038.298659546846, 20692.0, 20736.792632073786, 20807.68788468174, 7033.296670332926, 7178.037303815291, 7247.673854676552, 7278.854422911512, 7316.341529262286, 978.4911845840265, 982.3958265666564, 1061.5488417422564, 1094.9671509854718, 1106.5739690219164, 28037.01870434525, 28959.710402896122, 29059.709402906123, 29372.559411608843, 29477.410451790845, 1000.9890011088708, 1014.6600888702368, 1058.5025038232018, 1080.713610893114, 1122.9775404491863, 14902.105873647615, 15166.165860877538, 15168.165750883587, 15352.155631440379, 15379.769303460456, 316793.0, 319858.0, 320647.0, 320946.0, 321083.0, 52222.47777522252, 52307.215391769154, 52362.21456678153, 52418.73790631023, 52759.736201318745, 1311.7048664050703, 1328.0, 1333.8466076401144, 1334.4728832111261, 1338.2438922009228, 26784.0, 28318.008869689464, 28392.148235552966, 28462.715372846837, 29580.408391831614, 43422.0, 43447.0, 43819.56180438155, 43820.78089609532, 43848.34227486654, 247807.0, 248753.0, 248954.0, 250924.0, 251065.0, 28423.43153136967, 28980.42039159163, 28984.0, 30871.2282192947, 32038.35923281568, 31812.84093579517, 32498.350032999682, 35414.46878296879, 41532.792336038125, 42064.78967605265, 34810.680072559975, 37248.25503489861, 37503.249935000604, 37922.2415551693, 38138.809305954404, 36860.81569592242, 37168.44247336346, 37455.62573333044, 37700.62299376971, 37795.05512362213, 31291.0, 31625.525617116222, 31866.0, 36569.0, 37249.81375093215, 25522.744772552036, 27634.447311053264, 33027.504587430725, 33904.49143262902, 35751.28497430089, 24258.272251832474, 24491.38771530726, 24533.50932981366, 24920.0, 24946.62580061264], "unit": "score", "name": "ext.html", "value": 18083.967423950035}, {"lowerIsBetter": false, "replicates": [363.7163012849977, 364.7209884438405, 365.64532403568535, 365.6471504997677, 369.64144779563816, 13675.726485470284, 13938.16371017737, 15758.763618545716, 16177.272022758974, 16930.153492325397, 15117.244137793094, 15365.692686146298, 15773.369065237377, 15899.443519476821, 15918.76121858173, 5160.174372100474, 5299.8410047698435, 5306.204069389584, 5315.495027972336, 5322.787088516455, 3944.447777311179, 4099.057216840129, 5166.0, 5250.527452529272, 5545.251391062216, 5762.106873434604, 5857.853553661172, 5873.70631468427, 5910.438508341722, 5914.88170236595, 5872.148538461921, 6025.668588227668, 6031.065184896304, 6050.727717252734, 6053.788117415891, 5328.280682107905, 5347.545458635982, 5899.233099697055, 6139.1712118863825, 6153.661548614825, 21894.781052189435, 22005.0, 22285.220017299478, 22812.77187228123, 22824.885875570682, 2202.7136472258503, 2217.756046834847, 2239.787220214077, 2252.628316327804, 2316.490372118148, 13758.793618095737, 13946.651333716636, 14110.0, 14413.567592972227, 14464.349104290228, 1823.2524664887333, 1932.7777305609754, 1937.893415862127, 1955.9022048897498, 1979.7525309336334, 54604.45395546033, 61344.38655613431, 62966.0, 64978.0, 65725.0, 14304.785428218585, 14590.41638334476, 14638.780418293734, 14670.193139377438, 14685.265736713121, 23570.0, 23703.525929481315, 23839.0, 24277.0, 24375.512489750105, 9037.0, 9078.409903356262, 9128.817423651622, 9360.90639093614, 9371.578278977326, 7773.922260777433, 7834.294913457816, 8050.5572193529915, 8069.31410830086, 8216.0, 7636.274553917369, 7772.0, 7785.688572457151, 7794.181610930771, 7909.6836126555445, 2633.6839579250613, 2977.8064425812254, 2993.925151871221, 2996.8801247949837, 3034.575159477675, 444.2048732768373, 459.2468351902882, 484.40176382167994, 485.85667228167773, 839.9034111077182, 10250.333728307636, 10489.423081730425, 10501.789964200672, 10593.788124237471, 10778.0, 468.5384895877558, 473.62820186153704, 482.96136309095186, 489.39315249091584, 897.5018864530249, 7812.375009999187, 8626.525541095174, 9026.368154229272, 9868.0, 10254.846177307347, 502383.0, 513766.0, 515916.0, 528451.0816580633, 528858.0, 56468.152977705366, 71495.64252178706, 72205.27794721986, 74091.0, 74905.62547187338, 1015.1777060580953, 1050.0, 1089.929154604948, 1130.7681925205313, 1132.5016992523263, 14342.211178384872, 14542.563723088324, 14562.708745824812, 14872.182029988022, 15035.849641503883, 31112.844435777675, 31158.22104447407, 31451.84274078615, 32966.67033329636, 33328.83335583306, 41898.58101418947, 42143.789281053396, 42799.57200427956, 43305.0, 43493.91265218395, 7307.744228951961, 7498.662560184695, 7542.981697470771, 7600.657970391235, 7638.656260468403, 9487.525623718924, 11128.777424451628, 11159.665210043711, 11376.772464550828, 11477.598284060352, 9311.534423278945, 9712.757181070247, 9745.366551174435, 9895.307328486937, 10042.69871903844, 9992.900070999198, 10036.949815250877, 10099.293049486465, 10180.643677471253, 10365.792684146125, 3421.418358878947, 5364.839054828361, 9357.672481463116, 9781.902180978099, 9861.654842080492, 7362.153352364547, 7383.335499805044, 7513.624318784148, 7577.962110189414, 7638.923610763822, 9522.52387380642, 9935.403875767477, 10212.0, 10351.378917264989, 10404.11565016982], "unit": "score", "name": "jquery.html", "value": 8456.716951345446}, {"lowerIsBetter": false, "replicates": [1345.9461621535127, 1363.073110285006, 1364.8498665146835, 1476.520130957439, 1699.473163319371, 6716.865662686743, 7229.132504099509, 7418.072740907393, 7419.961205431244, 7425.7400990965325, 7271.345578897898, 7460.813479663011, 7461.328480436773, 7500.5874676892745, 7516.699332026712, 1957.9902100489478, 2001.9399418017483, 2002.939911802641, 2284.7486776454575, 2314.733805612351, 2273.022600281878, 2329.860208387494, 2331.988340058297, 2333.8833058347013, 2334.311378143443, 2238.541099074694, 2240.204727321802, 2309.191782875997, 2309.284121922201, 2312.9653055204185, 2257.582347265745, 2287.3824067501764, 2292.32376448948, 2292.426893276681, 2294.4493321602777, 2231.6875637410776, 2244.4837687332006, 2253.7182852143483, 2258.6499092640665, 2267.648514480258, 7520.6991720331125, 7540.773776786705, 7544.924550754477, 7546.20764819697, 7555.357794587467, 4571.9542804571865, 4689.648276379286, 4705.200115980291, 4706.341112244254, 4707.6233901287815, 3093.133922501703, 3152.984235078833, 3170.3500782339565, 3173.7461003119924, 3204.198950262434, 1010.368519675203, 1037.7146284771748, 1049.8582691336649, 1053.1837825685154, 1108.772701596171, 10259.538320775582, 10291.073803357735, 10361.948190259076, 10371.844422333672, 10376.066154046172, 4229.661627069889, 4285.785710714452, 4319.848805291863, 4348.130373925228, 4348.630181492819, 8738.344624153215, 8861.601227944759, 8870.334724895658, 8876.156765107304, 8878.067802880734, 4728.929066064012, 4770.856874293777, 4773.307870358779, 4775.808967641325, 4776.593989510861, 4313.503947046067, 4360.978195109004, 4362.8691139265875, 4365.847195348148, 4366.3013917773005, 3403.2172600301574, 3484.9477257841154, 3560.572731272264, 3684.797336146538, 3791.6208379161862, 1159.4840296068169, 1161.4773351991637, 1167.0838391862517, 1169.4328250798355, 1174.6887074925153, 1257.3964497041472, 1271.0, 1274.184521905981, 1276.2789024201481, 1293.7865252233275, 6983.022376867242, 6996.370326670624, 7071.25751796054, 7085.362317391357, 7098.254683258287, 1087.2335003822445, 1090.7818436312612, 1091.317926296065, 1101.719061639293, 1123.2698745815285, 5351.86620334487, 5387.784488620411, 5421.5391691706645, 5424.538914192259, 5432.70120143388, 9039.0, 9114.179723824887, 9208.079192080739, 9239.0, 9373.390729602554, 9227.630894764268, 9241.3531052827, 9263.120003599648, 9272.165505104573, 9280.886293644806, 7066.75266365685, 7251.637418129072, 7259.201487836333, 7259.310365515374, 7358.816029599196, 6695.799126026227, 6731.024001519654, 6736.393724564813, 6748.358905903931, 6756.155480564929, 8171.591420428836, 8197.269573464542, 8267.338612911073, 8428.873566896378, 8433.114522975, 8353.916460835313, 8403.159684031549, 8601.698940537051, 8668.30653547702, 8699.13008699125, 6542.771003014872, 6752.662366881735, 6782.864342713019, 6857.759978400732, 6905.585664860125, 6532.804015879341, 6642.070110184674, 7020.087388639648, 7130.42956563484, 7229.240929702516, 6662.933370666426, 6717.16035495563, 6819.624920629214, 6860.3139686031, 6902.068220790129, 6567.080608714879, 6642.83392915181, 6655.900161497485, 6778.42383397397, 6803.7618683345845, 6511.479081673549, 6548.7884741323005, 6561.80314590563, 6567.638779867153, 6573.408393244631, 6174.135621012972, 6319.178506794087, 6350.523710721806, 6365.2361716594305, 6365.8726825464155, 6429.164208652845, 6467.126937863328, 6477.935220647733, 6483.870322593616, 6485.837854053686], "unit": "score", "name": "mootools.html", "value": 4412.0149146989625}, {"lowerIsBetter": false, "replicates": [338.9711874490668, 345.17330992273503, 351.3500024953836, 351.790684542697, 353.8779121203184, 5812.651240925542, 5867.1492633568105, 5888.234529511163, 5911.379305172959, 5934.584579079461, 5565.1374037024325, 5621.213030175779, 5714.399968008954, 5769.913451298234, 5800.303963524372, 4483.50681425043, 4500.662450316223, 4503.324501324795, 4517.954820451786, 4526.932096018562, 4352.521222665504, 4512.503624601291, 4514.593686568208, 4515.887102822439, 4530.569595888385, 4383.0, 4399.2521271383785, 4446.3108218226225, 4449.243628583133, 4468.776561171945, 4422.358757980091, 4424.3142312941545, 4453.5323791001965, 4489.169503641804, 4489.595936365743, 3978.5822488638855, 3981.7610943343493, 3986.8405263789414, 3995.081131339779, 3999.440078389028, 5453.291072160633, 5533.280673512418, 5539.279893613804, 5555.416681248451, 5558.749856256478, 5222.242774797671, 5230.738463076831, 5234.110201265794, 5239.895202095937, 5254.448282930275, 6148.569600127993, 6149.96925015372, 6162.506999440034, 6164.075388691687, 6168.136460895478, 4389.0, 4429.557044295577, 4437.977810110961, 4439.400680908068, 4440.4893437254805, 6271.466925311354, 6394.968025159891, 6398.232212134527, 6443.967780161116, 6458.903116453257, 4528.0943811237885, 4533.569310915458, 4547.090581883636, 4547.090581883636, 4551.203539380595, 4567.246404343313, 4574.176648203355, 4574.313852922021, 4576.931346029813, 4577.1074640444795, 5229.738513074331, 5231.267622532849, 5238.895222095537, 5247.685138891678, 5248.553872920845, 6053.51571874249, 6197.349278325711, 6203.720832562545, 6212.751489940351, 6220.066989951543, 1616.9676606467806, 1638.3937942961181, 1638.4019832760957, 1640.0323808952537, 1640.1225344440907, 1115.8214685650257, 1115.8884111588777, 1118.3345909184022, 1118.972025699364, 1145.5818626201544, 5828.213191219131, 5845.1003423887405, 5848.795292164754, 5851.502622277154, 5859.384764599741, 6363.936360636427, 6366.649834259068, 6368.10846481493, 6373.267074286424, 6373.267074286424, 5655.462731040545, 5728.0, 5803.448672376117, 5879.794207202813, 5909.8227053188475, 3423.863045478203, 3446.672566106216, 3447.5518182636597, 3454.3954807908517, 3455.0844026333043, 6660.700268487833, 6666.166729158856, 6670.0, 6677.3656502632175, 6678.4991125665765, 6392.7123279452535, 6548.443382312462, 6556.868862622721, 6564.343565643493, 6597.109390232257, 6674.9666251669405, 6680.732770689118, 6684.86630267392, 6685.632290223987, 6689.632070236184, 6402.535024015694, 6405.854038897021, 6412.070249813658, 6414.711337989708, 6417.807465776034, 6106.5114790817515, 6306.779262725782, 6335.65153916539, 6340.334264902119, 6345.8730825384155, 6657.1345725055435, 6681.933180668131, 6682.599044057372, 6685.431738302299, 6694.464442844658, 4456.5766252205985, 4480.260756975063, 4494.303382975644, 4497.640188784955, 4500.594946454835, 6302.527310451643, 6432.2281326241155, 6441.194850643669, 6447.323031081669, 6451.54839161273, 6273.905891411541, 6279.654618995816, 6280.371962803683, 6280.403361680633, 6284.183056202847, 6250.218722659668, 6293.0, 6293.244810622755, 6329.177206963065, 6333.524985626189, 6040.365761595145, 6136.20229370179, 6141.955867502625, 6156.168917196122, 6157.599756015845, 6258.718357673824, 6288.6855657217875, 6291.087792270004, 6292.18201633803, 6292.653904035322, 6097.695115244132, 6121.928662484136, 6143.416375444325, 6148.047052706837, 6156.0], "unit": "score", "name": "prototype.html", "value": 4719.196253847686}, {"lowerIsBetter": false, "replicates": [759.6088014672443, 838.6561509780987, 843.7899240390996, 851.6550796927247, 863.1756672377879, 13509.32453377332, 13634.181949083062, 13643.0, 13671.384787684554, 13704.314784260772, 11490.540378384876, 12735.235885846856, 12784.0, 12793.424295906683, 12810.67973300668, 661.6361001449196, 794.1343935110729, 809.3646487507308, 809.9834707442152, 810.3881569415113, 800.9879851802227, 802.3340627279373, 802.6989878795451, 807.6648191000728, 809.6316176139842, 839.6851180807197, 846.9237768600825, 847.6524624903791, 848.1815048478218, 848.8132610825639, 686.8866637004888, 840.6007146605344, 841.1252297610478, 841.5455653946862, 841.7727213652311, 520.1885059307492, 607.104520831774, 621.353792056261, 622.0637939900421, 622.1445512420422, 13238.27189504577, 13266.535671251557, 13289.13620614657, 13350.666233344147, 13357.732845343038, 12301.446434910451, 12688.175268607603, 12742.235465871985, 13082.411291491906, 13181.60455186346, 10336.173106151566, 10347.793044139074, 10464.21518386124, 10640.94679526605, 11066.0, 3616.674499295076, 3694.501242332278, 3719.7210209234418, 3723.1809002019513, 3797.2785170817456, 48894.0, 48937.26594101091, 48938.0, 48947.75526122382, 48995.0, 10028.097471227624, 10172.237082218864, 10400.843987340197, 10489.0, 10595.046445819913, 18999.240030398905, 19028.429147125607, 19037.238510459705, 19061.90469047646, 19062.0, 7568.062319366827, 7676.577788221702, 7847.568383738949, 7856.0, 7902.0, 4291.420658211164, 4484.798184081724, 4488.9102217956115, 4500.774961251925, 4511.616512596401, 3022.2897619059504, 3029.636443626779, 3048.5731997520365, 3057.1287183152695, 3060.877564897379, 523.2935537024986, 526.9156934890399, 532.0609124894564, 543.3099963046988, 545.7080461952836, 615.3938370704852, 634.5938599296454, 653.6013032050446, 661.6956200147986, 669.9330066993261, 7853.842923141505, 8524.22962537178, 9189.540522973824, 9224.077592240856, 9301.860472092923, 546.6200990311695, 554.4538629449988, 668.5148357724856, 694.1531331775226, 696.5820507695342, 3803.581606023335, 3902.824372903226, 3975.264576053439, 3998.6001399859783, 4035.435039094529, 54099.45900541023, 54356.728216358664, 54458.45541544613, 54804.72597636986, 54836.45163548393, 49313.75343123333, 51798.741006294724, 51966.70083247873, 52012.0, 52071.0, 44947.32579011317, 45054.32418513725, 45206.0, 45419.09161816679, 45815.77092114518, 8056.1138274788555, 8096.149904259968, 8101.716439924574, 8144.511329320259, 8325.791855203426, 33489.83255083709, 33579.3284134311, 34160.48759268563, 34602.65397345994, 34882.779102731285, 42624.360634591125, 42930.35604465873, 42963.140737184454, 43324.35013474737, 43372.783136084116, 10990.0, 11182.0, 11343.716407089889, 11600.245984011011, 11621.88378116208, 11768.52925882955, 11871.52513899469, 11932.522699091938, 12102.45538950767, 12373.257604543756, 10648.467576621293, 10674.46627668598, 10799.0, 11353.716157096138, 11497.770044598894, 10889.237753357189, 11187.608433704781, 11233.887661123284, 11362.375069370933, 11604.129690273094, 10768.676939691823, 10899.346039237671, 10923.126149908147, 11037.282576632493, 11037.83443248368, 8957.328200385127, 9505.097015783489, 9525.380850244712, 9540.95229523848, 9751.609935602497, 8596.0, 8616.741497755078, 8865.911340886509, 8883.289336852908, 8978.595963181542], "unit": "score", "name": "yui.html", "value": 6247.153894024265}], "name": "dromaeo_css", "value": 6824.272786792579}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 106.0, 110.0, 111.0, 111.0, 100.0, 110.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 109.2}, {"lowerIsBetter": true, "replicates": [149.0, 127.0, 157.0, 170.0, 125.0, 157.0, 146.0, 125.0, 167.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 144.9}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 160.0, 161.0, 161.0, 160.0, 165.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 97.0, 96.0, 72.0, 71.0, 71.0, 128.0, 95.0, 71.0], "unit": "score", "name": "audio-fft", "value": 84.7}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 151.0, 96.0, 96.0, 95.0, 138.0, 96.0, 97.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 145.0, 145.0, 144.0, 146.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [55.0, 54.0, 55.0, 55.0, 55.0, 56.0, 55.0, 68.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.1}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 68.0, 68.0, 67.0, 68.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 82.0, 89.0, 82.0, 82.0, 83.0, 83.0, 82.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [112.0, 113.0, 113.0, 119.0, 117.0, 131.0, 121.0, 132.0, 114.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.6}, {"lowerIsBetter": true, "replicates": [144.0, 134.0, 141.0, 144.0, 143.0, 132.0, 144.0, 144.0, 146.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.7}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 67.0, 66.0, 65.0, 66.0, 67.0, 65.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1495.2999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.23337282112033], "unit": "score", "name": "Richards", "value": 208.59951800000007}, {"lowerIsBetter": false, "replicates": [188.5014137606032], "unit": "score", "name": "DeltaBlue", "value": 350.7559900000001}, {"lowerIsBetter": false, "replicates": [279.17364600781684], "unit": "score", "name": "Encrypt", "value": 953.4603419999996}, {"lowerIsBetter": false, "replicates": [5213.541666666667], "unit": "score", "name": "Decrypt", "value": 51.05569630369634}, {"lowerIsBetter": false, "replicates": [1937.984496124031], "unit": "score", "name": "RayTrace", "value": 381.83432400000015}, {"lowerIsBetter": false, "replicates": [783.0853563038371], "unit": "score", "name": "Earley", "value": 851.0732510000003}, {"lowerIsBetter": false, "replicates": [12358.024691358025], "unit": "score", "name": "Boyer", "value": 53.929573426573455}, {"lowerIsBetter": false, "replicates": [43062.5], "unit": "score", "name": "RegExp", "value": 21.154949201741648}, {"lowerIsBetter": false, "replicates": [590.9090909090909], "unit": "score", "name": "Splay", "value": 137.9078461538462}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 18930.593505698365}]} 02:13:20 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "18930.59"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1495.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6824.27"}}} 02:13:20 INFO - Return code: 0 02:13:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:13:20 INFO - # TBPL SUCCESS # 02:13:20 INFO - Running post-action listener: _resource_record_post_action 02:13:20 INFO - Running post-run listener: _resource_record_post_run 02:13:21 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 10252288; Write bytes: 438198272; Read time: 2428; Write time: 392440 02:13:21 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 138407936; Read time: 0; Write time: 155900 02:13:21 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 8491008; Write bytes: 299790336; Read time: 2336; Write time: 236540 02:13:21 INFO - Running post-run listener: _upload_blobber_files 02:13:21 INFO - Blob upload gear active. 02:13:21 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:13:21 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:13:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 02:13:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 02:13:21 INFO - (blobuploader) - INFO - Open directory for files ... 02:13:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:13:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:13:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:13:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:13:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:13:22 INFO - (blobuploader) - INFO - Done attempting. 02:13:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 02:13:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:13:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:13:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:13:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:13:23 INFO - (blobuploader) - INFO - Done attempting. 02:13:23 INFO - (blobuploader) - INFO - Iteration through files over. 02:13:23 INFO - Return code: 0 02:13:23 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:13:23 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:13:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/078b019af65f37e4223fdd8c8b2c93eb45dd6a7c1965f1e91de35e82513017ee00bc0623c03a6ff4489b2fb313d4da535475691de69f83d347a5a0944588a132", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9301ed84da72bfc97eb71a790282fc865f8eca44a4dc0b10eb2c07de5cd118af60cb6ee2091091305e3b3befceebc9b4d6ca937ef95544cef9163f235954a9ee"} 02:13:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:13:23 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:13:23 INFO - Contents: 02:13:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/078b019af65f37e4223fdd8c8b2c93eb45dd6a7c1965f1e91de35e82513017ee00bc0623c03a6ff4489b2fb313d4da535475691de69f83d347a5a0944588a132", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9301ed84da72bfc97eb71a790282fc865f8eca44a4dc0b10eb2c07de5cd118af60cb6ee2091091305e3b3befceebc9b4d6ca937ef95544cef9163f235954a9ee"} 02:13:23 INFO - Copying logs to upload dir... 02:13:23 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1281.671531 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-01-15 02:13:23.846166) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 02:13:23.850349) ========= 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=aa52b8aba932b19cc50b5275000001de-1452850538.205059-1830841570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/078b019af65f37e4223fdd8c8b2c93eb45dd6a7c1965f1e91de35e82513017ee00bc0623c03a6ff4489b2fb313d4da535475691de69f83d347a5a0944588a132", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9301ed84da72bfc97eb71a790282fc865f8eca44a4dc0b10eb2c07de5cd118af60cb6ee2091091305e3b3befceebc9b4d6ca937ef95544cef9163f235954a9ee"} build_url:https://queue.taskcluster.net/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011310 build_url: 'https://queue.taskcluster.net/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/078b019af65f37e4223fdd8c8b2c93eb45dd6a7c1965f1e91de35e82513017ee00bc0623c03a6ff4489b2fb313d4da535475691de69f83d347a5a0944588a132", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9301ed84da72bfc97eb71a790282fc865f8eca44a4dc0b10eb2c07de5cd118af60cb6ee2091091305e3b3befceebc9b4d6ca937ef95544cef9163f235954a9ee"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 02:13:23.877281) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 02:13:23.877750) ========= 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=aa52b8aba932b19cc50b5275000001de-1452850538.205059-1830841570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 02:13:23.959343) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 02:13:23.959827) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 02:13:23.960212) ========= ========= Total master_lag: 0.24 =========