builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1452387329.19 results: success (0) buildid: 20160109143001 builduid: 92a088a86a25443e8f10128a244ffe81 revision: af1d9d9f34ecb6d4ae168d2329ea6479b50c3e4c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-09 16:55:29.194696) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-09 16:55:29.195237) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-09 16:55:29.195550) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1452386086.182034-1746839971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004617 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-09 16:55:29.243419) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-09 16:55:29.243752) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-09 16:55:29.312937) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 16:55:29.313530) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1452386086.182034-1746839971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.025574 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 16:55:29.367459) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-09 16:55:29.367765) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-09 16:55:29.368126) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 16:55:29.368404) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1452386086.182034-1746839971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-09 16:55:29-- 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% 75.1M=0s 2016-01-09 16:55:29 (75.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.236381 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 16:55:29.620235) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 16:55:29.620571) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1452386086.182034-1746839971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.113051 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 16:55:29.747514) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 16:55:29.748076) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev af1d9d9f34ecb6d4ae168d2329ea6479b50c3e4c --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 af1d9d9f34ecb6d4ae168d2329ea6479b50c3e4c --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=e0e61f6f900f4dc42e3e8956000001ad-1452386086.182034-1746839971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-09 16:55:29,828 truncating revision to first 12 chars 2016-01-09 16:55:29,828 Setting DEBUG logging. 2016-01-09 16:55:29,828 attempt 1/10 2016-01-09 16:55:29,828 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/af1d9d9f34ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-09 16:55:30,196 unpacking tar archive at: fx-team-af1d9d9f34ec/testing/mozharness/ program finished with exit code 0 elapsedTime=0.701172 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 16:55:30.470852) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-09 16:55:30.471336) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-09 16:55:30.483955) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-09 16:55:30.484311) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-09 16:55:30.484788) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-09 16:55:30.485080) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1452386086.182034-1746839971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:55:30 INFO - MultiFileLogger online at 20160109 16:55:30 in /builds/slave/test-pgo 16:55:30 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 16:55:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:55:30 INFO - {'append_to_log': False, 16:55:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:55:30 INFO - 'blob_upload_branch': 'Fx-Team', 16:55:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:55:30 INFO - 'branch': 'Fx-Team', 16:55:30 INFO - 'buildbot_json_path': 'buildprops.json', 16:55:30 INFO - 'config_files': ('talos/linux_config.py',), 16:55:30 INFO - 'default_actions': ('clobber', 16:55:30 INFO - 'read-buildbot-config', 16:55:30 INFO - 'download-and-extract', 16:55:30 INFO - 'populate-webroot', 16:55:30 INFO - 'create-virtualenv', 16:55:30 INFO - 'install', 16:55:30 INFO - 'run-tests'), 16:55:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:55:30 INFO - 'download_minidump_stackwalk': True, 16:55:30 INFO - 'download_symbols': 'ondemand', 16:55:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:55:30 INFO - 'tooltool.py': '/tools/tooltool.py', 16:55:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:55:30 INFO - '/tools/misc-python/virtualenv.py')}, 16:55:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:55:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:55:30 INFO - 'installer_path': 'installer.exe', 16:55:30 INFO - 'log_level': 'info', 16:55:30 INFO - 'log_name': 'talos', 16:55:30 INFO - 'log_to_console': True, 16:55:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:55:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:55:30 INFO - 'opt_config_files': (), 16:55:30 INFO - 'pip_index': False, 16:55:30 INFO - 'sps_profile': False, 16:55:30 INFO - 'sps_profile_interval': 0, 16:55:30 INFO - 'suite': 'dromaeojs', 16:55:30 INFO - 'system_bits': '32', 16:55:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:55:30 INFO - 'title': 'talos-linux64-ix-067', 16:55:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:55:30 INFO - 'use_talos_json': True, 16:55:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:55:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:55:30 INFO - 'work_dir': 'build'} 16:55:30 INFO - ##### 16:55:30 INFO - ##### Running clobber step. 16:55:30 INFO - ##### 16:55:30 INFO - Running pre-action listener: _resource_record_pre_action 16:55:30 INFO - Running main action method: clobber 16:55:30 INFO - rmtree: /builds/slave/test-pgo/build 16:55:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:55:34 INFO - Running post-action listener: _resource_record_post_action 16:55:34 INFO - ##### 16:55:34 INFO - ##### Running read-buildbot-config step. 16:55:34 INFO - ##### 16:55:34 INFO - Running pre-action listener: _resource_record_pre_action 16:55:34 INFO - Running main action method: read_buildbot_config 16:55:34 INFO - Using buildbot properties: 16:55:34 INFO - { 16:55:34 INFO - "project": "", 16:55:34 INFO - "product": "firefox", 16:55:34 INFO - "script_repo_revision": "production", 16:55:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:55:34 INFO - "repository": "", 16:55:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 16:55:34 INFO - "buildid": "20160109143001", 16:55:34 INFO - "pgo_build": "True", 16:55:34 INFO - "basedir": "/builds/slave/test-pgo", 16:55:34 INFO - "buildnumber": 408, 16:55:34 INFO - "slavename": "talos-linux64-ix-067", 16:55:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:55:34 INFO - "platform": "ubuntu64_hw", 16:55:34 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:55:34 INFO - "branch": "fx-team", 16:55:34 INFO - "repo_path": "integration/fx-team", 16:55:34 INFO - "revision": "af1d9d9f34ecb6d4ae168d2329ea6479b50c3e4c", 16:55:34 INFO - "stage_platform": "linux64-pgo", 16:55:34 INFO - "builduid": "92a088a86a25443e8f10128a244ffe81", 16:55:34 INFO - "slavebuilddir": "test" 16:55:34 INFO - } 16:55:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/PsQNoNh0SWas6PtN1MHBzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:55:34 INFO - Running post-action listener: _resource_record_post_action 16:55:34 INFO - ##### 16:55:34 INFO - ##### Running download-and-extract step. 16:55:34 INFO - ##### 16:55:34 INFO - Running pre-action listener: _resource_record_pre_action 16:55:34 INFO - Running main action method: download_and_extract 16:55:34 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:55:34 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')]} 16:55:34 INFO - https://queue.taskcluster.net/v1/task/PsQNoNh0SWas6PtN1MHBzA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:55:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsQNoNh0SWas6PtN1MHBzA/artifacts/public/build/test_packages.json 16:55:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsQNoNh0SWas6PtN1MHBzA/artifacts/public/build/test_packages.json 16:55:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsQNoNh0SWas6PtN1MHBzA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:55:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsQNoNh0SWas6PtN1MHBzA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:55:35 INFO - Downloaded 1302 bytes. 16:55:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:55:35 INFO - Using the following test package requirements: 16:55:35 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:55:35 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:55:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:55:35 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:55:35 INFO - u'jsshell-linux-x86_64.zip'], 16:55:35 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:55:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:55:35 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:55:35 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:55:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:55:35 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:55:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:55:35 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:55:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:55:35 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:55:35 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:55:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:55:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:55:35 INFO - https://queue.taskcluster.net/v1/task/PsQNoNh0SWas6PtN1MHBzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:55:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsQNoNh0SWas6PtN1MHBzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:55:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsQNoNh0SWas6PtN1MHBzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:55:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsQNoNh0SWas6PtN1MHBzA/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 16:55:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsQNoNh0SWas6PtN1MHBzA/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 16:55:37 INFO - Downloaded 24028408 bytes. 16:55:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:55:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:55:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:55:38 INFO - Return code: 0 16:55:38 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 16:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:55:38 INFO - https://queue.taskcluster.net/v1/task/PsQNoNh0SWas6PtN1MHBzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:55:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsQNoNh0SWas6PtN1MHBzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:55:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsQNoNh0SWas6PtN1MHBzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:55:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsQNoNh0SWas6PtN1MHBzA/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 16:55:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsQNoNh0SWas6PtN1MHBzA/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 16:55:42 INFO - Downloaded 24028408 bytes. 16:55:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:55:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:55:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:55:44 INFO - Return code: 0 16:55:44 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')]} 16:55:44 INFO - https://queue.taskcluster.net/v1/task/PsQNoNh0SWas6PtN1MHBzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:55:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsQNoNh0SWas6PtN1MHBzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:55:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsQNoNh0SWas6PtN1MHBzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:55:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsQNoNh0SWas6PtN1MHBzA/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 16:55:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsQNoNh0SWas6PtN1MHBzA/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 16:55:45 INFO - Downloaded 11132285 bytes. 16:55:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 16:55:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:55:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 16:55:45 INFO - Return code: 0 16:55:45 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')]} 16:55:45 INFO - https://queue.taskcluster.net/v1/task/PsQNoNh0SWas6PtN1MHBzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:55:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsQNoNh0SWas6PtN1MHBzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:55:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsQNoNh0SWas6PtN1MHBzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:55:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsQNoNh0SWas6PtN1MHBzA/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 16:55:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PsQNoNh0SWas6PtN1MHBzA/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 16:55:46 INFO - Downloaded 55921883 bytes. 16:55:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PsQNoNh0SWas6PtN1MHBzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:55:46 INFO - mkdir: /builds/slave/test-pgo/properties 16:55:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:55:46 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:55:46 INFO - Contents: 16:55:46 INFO - build_url:https://queue.taskcluster.net/v1/task/PsQNoNh0SWas6PtN1MHBzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:55:46 INFO - Running post-action listener: _resource_record_post_action 16:55:46 INFO - Running post-action listener: set_extra_try_arguments 16:55:46 INFO - ##### 16:55:46 INFO - ##### Running populate-webroot step. 16:55:46 INFO - ##### 16:55:46 INFO - Running pre-action listener: _resource_record_pre_action 16:55:46 INFO - Running main action method: populate_webroot 16:55:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:55:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:55:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:55:46 INFO - '--tppagecycles', 16:55:46 INFO - '7'], 16:55:46 INFO - 'tests': ['tsvgm']}}, 16:55:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:55:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:55:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:55:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:55:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:55:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:55:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:55:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:55:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:55:46 INFO - 'talos_options': ['--e10s'], 16:55:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:55:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:55:46 INFO - 'tests': ['damp', 'tps']}, 16:55:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:55:46 INFO - 'talos_options': ['--e10s'], 16:55:46 INFO - 'tests': ['damp', 'tps']}, 16:55:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:55:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:55:46 INFO - 'other': {'tests': ['a11yr', 16:55:46 INFO - 'ts_paint', 16:55:46 INFO - 'tpaint', 16:55:46 INFO - 'sessionrestore', 16:55:46 INFO - 'sessionrestore_no_auto_restore']}, 16:55:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:55:46 INFO - 'tests': ['a11yr', 16:55:46 INFO - 'ts_paint', 16:55:46 INFO - 'tpaint', 16:55:46 INFO - 'sessionrestore', 16:55:46 INFO - 'sessionrestore_no_auto_restore']}, 16:55:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:55:46 INFO - 'tests': ['a11yr', 16:55:46 INFO - 'ts_paint', 16:55:46 INFO - 'tpaint', 16:55:46 INFO - 'sessionrestore', 16:55:46 INFO - 'sessionrestore_no_auto_restore']}, 16:55:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:55:46 INFO - 'tests': ['a11yr', 16:55:46 INFO - 'ts_paint', 16:55:46 INFO - 'tpaint', 16:55:46 INFO - 'sessionrestore', 16:55:46 INFO - 'sessionrestore_no_auto_restore']}, 16:55:46 INFO - 'other_l64': {'tests': ['a11yr', 16:55:46 INFO - 'ts_paint', 16:55:46 INFO - 'tpaint', 16:55:46 INFO - 'sessionrestore', 16:55:46 INFO - 'sessionrestore_no_auto_restore']}, 16:55:46 INFO - 'other_nol64': {'tests': ['a11yr', 16:55:46 INFO - 'ts_paint', 16:55:46 INFO - 'tpaint', 16:55:46 INFO - 'sessionrestore', 16:55:46 INFO - 'sessionrestore_no_auto_restore']}, 16:55:46 INFO - 'svgr': {'tests': ['tsvgx', 16:55:46 INFO - 'tsvgr_opacity', 16:55:46 INFO - 'tart', 16:55:46 INFO - 'tscrollx', 16:55:46 INFO - 'cart']}, 16:55:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:55:46 INFO - 'tests': ['tsvgx', 16:55:46 INFO - 'tsvgr_opacity', 16:55:46 INFO - 'tart', 16:55:46 INFO - 'tscrollx', 16:55:46 INFO - 'cart']}, 16:55:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:55:46 INFO - 'tests': ['tp5o']}, 16:55:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:55:46 INFO - 'talos_options': ['--e10s'], 16:55:46 INFO - 'tests': ['tp5o']}, 16:55:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:55:46 INFO - 'talos_options': ['--xperf_path', 16:55:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:55:46 INFO - 'tests': ['tp5n']}, 16:55:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:55:46 INFO - 'talos_options': ['--e10s', 16:55:46 INFO - '--xperf_path', 16:55:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:55:46 INFO - 'tests': ['tp5n']}}, 16:55:46 INFO - 'talos.zip': {'path': '', 16:55:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:55:46 INFO - Running post-action listener: _resource_record_post_action 16:55:46 INFO - ##### 16:55:46 INFO - ##### Running create-virtualenv step. 16:55:46 INFO - ##### 16:55:46 INFO - Running pre-action listener: _resource_record_pre_action 16:55:46 INFO - Running main action method: create_virtualenv 16:55:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:55:46 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 16:55:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:55:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:55:46 INFO - Using real prefix '/usr' 16:55:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:55:47 INFO - Installing distribute.............................................................................................................................................................................................done. 16:55:49 INFO - Installing pip.................done. 16:55:49 INFO - Return code: 0 16:55:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fef42634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2333840>, '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 0x22a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0b60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1452386086.182034-1746839971', '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 16:55:49 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 16:55:49 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 16:55:49 INFO - Using env: {'DISPLAY': ':0', 16:55:49 INFO - 'HOME': '/home/cltbld', 16:55:49 INFO - 'LANG': 'en_US.UTF-8', 16:55:49 INFO - 'LANGUAGE': 'en_US:en', 16:55:49 INFO - 'LOGNAME': 'cltbld', 16:55:49 INFO - 'MAIL': '/var/mail/cltbld', 16:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:49 INFO - 'MOZ_NO_REMOTE': '1', 16:55:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:49 INFO - 'NO_EM_RESTART': '1', 16:55:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:55:49 INFO - 'PWD': '/builds/slave/test-pgo', 16:55:49 INFO - 'SHELL': '/bin/bash', 16:55:49 INFO - 'SHLVL': '1', 16:55:49 INFO - 'TERM': 'linux', 16:55:49 INFO - 'TMOUT': '86400', 16:55:49 INFO - 'USER': 'cltbld', 16:55:49 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452386086.182034-1746839971', 16:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:49 INFO - '_': '/tools/buildbot/bin/python'} 16:55:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:49 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 16:55:49 INFO - Cleaning up... 16:55:49 INFO - Return code: 0 16:55:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fef42634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2333840>, '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 0x22a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0b60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1452386086.182034-1746839971', '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 16:55:49 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 16:55:49 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 16:55:49 INFO - Using env: {'DISPLAY': ':0', 16:55:49 INFO - 'HOME': '/home/cltbld', 16:55:49 INFO - 'LANG': 'en_US.UTF-8', 16:55:49 INFO - 'LANGUAGE': 'en_US:en', 16:55:49 INFO - 'LOGNAME': 'cltbld', 16:55:49 INFO - 'MAIL': '/var/mail/cltbld', 16:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:49 INFO - 'MOZ_NO_REMOTE': '1', 16:55:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:49 INFO - 'NO_EM_RESTART': '1', 16:55:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:55:49 INFO - 'PWD': '/builds/slave/test-pgo', 16:55:49 INFO - 'SHELL': '/bin/bash', 16:55:49 INFO - 'SHLVL': '1', 16:55:49 INFO - 'TERM': 'linux', 16:55:49 INFO - 'TMOUT': '86400', 16:55:49 INFO - 'USER': 'cltbld', 16:55:49 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452386086.182034-1746839971', 16:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:49 INFO - '_': '/tools/buildbot/bin/python'} 16:55:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:49 INFO - Downloading/unpacking psutil>=0.7.1 16:55:49 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 16:55:49 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 16:55:49 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 16:55:49 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 16:55:49 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 16:55:49 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 16:55:51 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 16:55:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:55:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:55:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:55:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:55:51 INFO - Installing collected packages: psutil 16:55:51 INFO - Running setup.py install for psutil 16:55:51 INFO - building 'psutil._psutil_linux' extension 16:55:51 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 16:55:52 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 16:55:52 INFO - building 'psutil._psutil_posix' extension 16:55:52 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 16:55:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:55:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:55:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:55:53 INFO - Successfully installed psutil 16:55:53 INFO - Cleaning up... 16:55:53 INFO - Return code: 0 16:55:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fef42634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2333840>, '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 0x22a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0b60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1452386086.182034-1746839971', '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 16:55:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 16:55:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:55:53 INFO - Using env: {'DISPLAY': ':0', 16:55:53 INFO - 'HOME': '/home/cltbld', 16:55:53 INFO - 'LANG': 'en_US.UTF-8', 16:55:53 INFO - 'LANGUAGE': 'en_US:en', 16:55:53 INFO - 'LOGNAME': 'cltbld', 16:55:53 INFO - 'MAIL': '/var/mail/cltbld', 16:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:53 INFO - 'MOZ_NO_REMOTE': '1', 16:55:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:53 INFO - 'NO_EM_RESTART': '1', 16:55:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:55:53 INFO - 'PWD': '/builds/slave/test-pgo', 16:55:53 INFO - 'SHELL': '/bin/bash', 16:55:53 INFO - 'SHLVL': '1', 16:55:53 INFO - 'TERM': 'linux', 16:55:53 INFO - 'TMOUT': '86400', 16:55:53 INFO - 'USER': 'cltbld', 16:55:53 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452386086.182034-1746839971', 16:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:53 INFO - '_': '/tools/buildbot/bin/python'} 16:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:55:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:55:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:55:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:55:55 INFO - Installing collected packages: mozsystemmonitor 16:55:55 INFO - Running setup.py install for mozsystemmonitor 16:55:55 INFO - Successfully installed mozsystemmonitor 16:55:55 INFO - Cleaning up... 16:55:55 INFO - Return code: 0 16:55:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fef42634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2333840>, '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 0x22a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0b60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1452386086.182034-1746839971', '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 16:55:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 16:55:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:55:55 INFO - Using env: {'DISPLAY': ':0', 16:55:55 INFO - 'HOME': '/home/cltbld', 16:55:55 INFO - 'LANG': 'en_US.UTF-8', 16:55:55 INFO - 'LANGUAGE': 'en_US:en', 16:55:55 INFO - 'LOGNAME': 'cltbld', 16:55:55 INFO - 'MAIL': '/var/mail/cltbld', 16:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:55 INFO - 'MOZ_NO_REMOTE': '1', 16:55:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:55 INFO - 'NO_EM_RESTART': '1', 16:55:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:55:55 INFO - 'PWD': '/builds/slave/test-pgo', 16:55:55 INFO - 'SHELL': '/bin/bash', 16:55:55 INFO - 'SHLVL': '1', 16:55:55 INFO - 'TERM': 'linux', 16:55:55 INFO - 'TMOUT': '86400', 16:55:55 INFO - 'USER': 'cltbld', 16:55:55 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452386086.182034-1746839971', 16:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:55 INFO - '_': '/tools/buildbot/bin/python'} 16:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:55 INFO - Downloading/unpacking blobuploader==1.2.4 16:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:55:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:57 INFO - Downloading blobuploader-1.2.4.tar.gz 16:55:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:55:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:55:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:55:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:55:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:55:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:55:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:58 INFO - Downloading docopt-0.6.1.tar.gz 16:55:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:55:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:55:58 INFO - Installing collected packages: blobuploader, requests, docopt 16:55:58 INFO - Running setup.py install for blobuploader 16:55:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:55:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:55:58 INFO - Running setup.py install for requests 16:55:58 INFO - Running setup.py install for docopt 16:55:58 INFO - Successfully installed blobuploader requests docopt 16:55:58 INFO - Cleaning up... 16:55:58 INFO - Return code: 0 16:55:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:58 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 0x7fef42634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2333840>, '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 0x22a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0b60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1452386086.182034-1746839971', '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 16:55:58 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 16:55:58 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 16:55:58 INFO - Using env: {'DISPLAY': ':0', 16:55:58 INFO - 'HOME': '/home/cltbld', 16:55:58 INFO - 'LANG': 'en_US.UTF-8', 16:55:58 INFO - 'LANGUAGE': 'en_US:en', 16:55:58 INFO - 'LOGNAME': 'cltbld', 16:55:58 INFO - 'MAIL': '/var/mail/cltbld', 16:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:58 INFO - 'MOZ_NO_REMOTE': '1', 16:55:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:58 INFO - 'NO_EM_RESTART': '1', 16:55:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:55:58 INFO - 'PWD': '/builds/slave/test-pgo', 16:55:58 INFO - 'SHELL': '/bin/bash', 16:55:58 INFO - 'SHLVL': '1', 16:55:58 INFO - 'TERM': 'linux', 16:55:58 INFO - 'TMOUT': '86400', 16:55:58 INFO - 'USER': 'cltbld', 16:55:58 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452386086.182034-1746839971', 16:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:58 INFO - '_': '/tools/buildbot/bin/python'} 16:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:55:58 INFO - Running setup.py (path:/tmp/pip-HGkxPA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:55:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:55:59 INFO - Running setup.py (path:/tmp/pip-ZCWtOq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:55:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:55:59 INFO - Running setup.py (path:/tmp/pip-FFbx2M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:55:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:55:59 INFO - Running setup.py (path:/tmp/pip-LJ3WvQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:55:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:55:59 INFO - Running setup.py (path:/tmp/pip-ekHo44-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:55:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:55:59 INFO - Running setup.py (path:/tmp/pip-CTMMdy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:55:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:55:59 INFO - Running setup.py (path:/tmp/pip-a6usA8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:55:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:55:59 INFO - Running setup.py (path:/tmp/pip-MaoHQx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:55:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:55:59 INFO - Running setup.py (path:/tmp/pip-T64Y6w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:55:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:55:59 INFO - Running setup.py (path:/tmp/pip-1Vn7O0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:55:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:55:59 INFO - Running setup.py (path:/tmp/pip-HPENhd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:55:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:55:59 INFO - Running setup.py (path:/tmp/pip-UYLWm5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:55:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:55:59 INFO - Running setup.py (path:/tmp/pip-Abo5sc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:55:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:55:59 INFO - Running setup.py (path:/tmp/pip-0Rfwu5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:55:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:55:59 INFO - Running setup.py (path:/tmp/pip-8EyCnX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:56:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:56:00 INFO - Running setup.py (path:/tmp/pip-tOjgD5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:56:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:56:00 INFO - Running setup.py (path:/tmp/pip-fLdXTl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:56:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:56:00 INFO - Running setup.py install for manifestparser 16:56:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:56:00 INFO - Running setup.py install for mozcrash 16:56:00 INFO - Running setup.py install for mozdebug 16:56:00 INFO - Running setup.py install for mozdevice 16:56:00 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:56:00 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:56:00 INFO - Running setup.py install for mozfile 16:56:00 INFO - Running setup.py install for mozhttpd 16:56:00 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:56:00 INFO - Running setup.py install for mozinfo 16:56:00 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:56:00 INFO - Running setup.py install for mozInstall 16:56:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:56:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:56:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:56:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:56:00 INFO - Running setup.py install for mozleak 16:56:01 INFO - Running setup.py install for mozlog 16:56:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:56:01 INFO - Running setup.py install for moznetwork 16:56:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:56:01 INFO - Running setup.py install for mozprocess 16:56:01 INFO - Running setup.py install for mozprofile 16:56:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:56:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:56:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:56:01 INFO - Running setup.py install for mozrunner 16:56:01 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:56:01 INFO - Running setup.py install for mozscreenshot 16:56:01 INFO - Running setup.py install for moztest 16:56:01 INFO - Running setup.py install for mozversion 16:56:01 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:56:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:56:01 INFO - Cleaning up... 16:56:01 INFO - Return code: 0 16:56:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:56:01 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')]} 16:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:01 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')]} 16:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:01 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 0x7fef42634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2333840>, '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 0x22a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0b60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1452386086.182034-1746839971', '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 16:56:01 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 16:56:01 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 16:56:01 INFO - Using env: {'DISPLAY': ':0', 16:56:01 INFO - 'HOME': '/home/cltbld', 16:56:01 INFO - 'LANG': 'en_US.UTF-8', 16:56:01 INFO - 'LANGUAGE': 'en_US:en', 16:56:01 INFO - 'LOGNAME': 'cltbld', 16:56:01 INFO - 'MAIL': '/var/mail/cltbld', 16:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:01 INFO - 'MOZ_NO_REMOTE': '1', 16:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:01 INFO - 'NO_EM_RESTART': '1', 16:56:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:56:01 INFO - 'PWD': '/builds/slave/test-pgo', 16:56:01 INFO - 'SHELL': '/bin/bash', 16:56:01 INFO - 'SHLVL': '1', 16:56:01 INFO - 'TERM': 'linux', 16:56:01 INFO - 'TMOUT': '86400', 16:56:01 INFO - 'USER': 'cltbld', 16:56:01 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452386086.182034-1746839971', 16:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:01 INFO - '_': '/tools/buildbot/bin/python'} 16:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:56:02 INFO - Running setup.py (path:/tmp/pip-LfyYKY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:56:02 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)) 16:56:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:56:02 INFO - Running setup.py (path:/tmp/pip-plFusP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:56:02 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)) 16:56:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:56:02 INFO - Running setup.py (path:/tmp/pip-5LPkA8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:56:02 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)) 16:56:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:56:02 INFO - Running setup.py (path:/tmp/pip-aTuaid-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:56:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:56:02 INFO - Running setup.py (path:/tmp/pip-8p6VWl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:56:02 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)) 16:56:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:56:02 INFO - Running setup.py (path:/tmp/pip-h13Bb1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:56:02 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)) 16:56:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:56:02 INFO - Running setup.py (path:/tmp/pip-_RQLwh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:56:02 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)) 16:56:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:56:02 INFO - Running setup.py (path:/tmp/pip-r82BOb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:56:02 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)) 16:56:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:56:02 INFO - Running setup.py (path:/tmp/pip-eesJ3c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:56:02 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)) 16:56:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:56:02 INFO - Running setup.py (path:/tmp/pip-_L6X75-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:56:02 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)) 16:56:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:56:02 INFO - Running setup.py (path:/tmp/pip-z5Uu2c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:56:02 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)) 16:56:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:56:02 INFO - Running setup.py (path:/tmp/pip-oaulPj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:56:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 16:56:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:56:03 INFO - Running setup.py (path:/tmp/pip-vva1HQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:56:03 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)) 16:56:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:56:03 INFO - Running setup.py (path:/tmp/pip-ubgWk3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:56:03 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)) 16:56:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:56:03 INFO - Running setup.py (path:/tmp/pip-Txbzim-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:56:03 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)) 16:56:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:56:03 INFO - Running setup.py (path:/tmp/pip-qB_lne-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:56:03 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)) 16:56:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:56:03 INFO - Running setup.py (path:/tmp/pip-Jb1lzY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:56:03 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)) 16:56:03 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)) 16:56:03 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)) 16:56:03 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)) 16:56:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:56:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:56:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:05 INFO - Downloading blessings-1.5.1.tar.gz 16:56:05 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 16:56:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:56:05 INFO - Installing collected packages: blessings 16:56:05 INFO - Running setup.py install for blessings 16:56:05 INFO - Successfully installed blessings 16:56:05 INFO - Cleaning up... 16:56:05 INFO - Return code: 0 16:56:05 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:56:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:56:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:56:05 INFO - Reading from file tmpfile_stdout 16:56:05 INFO - Current package versions: 16:56:05 INFO - argparse == 1.2.1 16:56:05 INFO - blessings == 1.5.1 16:56:05 INFO - blobuploader == 1.2.4 16:56:05 INFO - docopt == 0.6.1 16:56:05 INFO - manifestparser == 1.1 16:56:05 INFO - mozInstall == 1.12 16:56:05 INFO - mozcrash == 0.16 16:56:05 INFO - mozdebug == 0.1 16:56:05 INFO - mozdevice == 0.47 16:56:05 INFO - mozfile == 1.2 16:56:05 INFO - mozhttpd == 0.7 16:56:05 INFO - mozinfo == 0.9 16:56:05 INFO - mozleak == 0.1 16:56:05 INFO - mozlog == 3.1 16:56:05 INFO - moznetwork == 0.27 16:56:05 INFO - mozprocess == 0.22 16:56:05 INFO - mozprofile == 0.28 16:56:05 INFO - mozrunner == 6.11 16:56:05 INFO - mozscreenshot == 0.1 16:56:05 INFO - mozsystemmonitor == 0.0 16:56:05 INFO - moztest == 0.7 16:56:05 INFO - mozversion == 1.4 16:56:05 INFO - psutil == 3.1.1 16:56:05 INFO - requests == 1.2.3 16:56:05 INFO - wsgiref == 0.1.2 16:56:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:56:05 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')]} 16:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:05 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')]} 16:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:05 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 0x7fef42634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2333840>, '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 0x22a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0b60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1452386086.182034-1746839971', '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 16:56:05 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 16:56:05 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 16:56:05 INFO - Using env: {'DISPLAY': ':0', 16:56:05 INFO - 'HOME': '/home/cltbld', 16:56:05 INFO - 'LANG': 'en_US.UTF-8', 16:56:05 INFO - 'LANGUAGE': 'en_US:en', 16:56:05 INFO - 'LOGNAME': 'cltbld', 16:56:05 INFO - 'MAIL': '/var/mail/cltbld', 16:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:05 INFO - 'MOZ_NO_REMOTE': '1', 16:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:05 INFO - 'NO_EM_RESTART': '1', 16:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:56:05 INFO - 'PWD': '/builds/slave/test-pgo', 16:56:05 INFO - 'SHELL': '/bin/bash', 16:56:05 INFO - 'SHLVL': '1', 16:56:05 INFO - 'TERM': 'linux', 16:56:05 INFO - 'TMOUT': '86400', 16:56:05 INFO - 'USER': 'cltbld', 16:56:05 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452386086.182034-1746839971', 16:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:05 INFO - '_': '/tools/buildbot/bin/python'} 16:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:05 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)) 16:56:05 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)) 16:56:05 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)) 16:56:05 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)) 16:56:05 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)) 16:56:05 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)) 16:56:05 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)) 16:56:05 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)) 16:56:05 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)) 16:56:05 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)) 16:56:05 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)) 16:56:05 INFO - Cleaning up... 16:56:05 INFO - Return code: 0 16:56:05 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:56:05 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')]} 16:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:05 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')]} 16:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:05 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 0x7fef42634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2333840>, '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 0x22a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0b60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1452386086.182034-1746839971', '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 16:56:05 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 16:56:05 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 16:56:05 INFO - Using env: {'DISPLAY': ':0', 16:56:05 INFO - 'HOME': '/home/cltbld', 16:56:05 INFO - 'LANG': 'en_US.UTF-8', 16:56:05 INFO - 'LANGUAGE': 'en_US:en', 16:56:05 INFO - 'LOGNAME': 'cltbld', 16:56:05 INFO - 'MAIL': '/var/mail/cltbld', 16:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:05 INFO - 'MOZ_NO_REMOTE': '1', 16:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:05 INFO - 'NO_EM_RESTART': '1', 16:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:56:05 INFO - 'PWD': '/builds/slave/test-pgo', 16:56:05 INFO - 'SHELL': '/bin/bash', 16:56:05 INFO - 'SHLVL': '1', 16:56:05 INFO - 'TERM': 'linux', 16:56:05 INFO - 'TMOUT': '86400', 16:56:05 INFO - 'USER': 'cltbld', 16:56:05 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452386086.182034-1746839971', 16:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:05 INFO - '_': '/tools/buildbot/bin/python'} 16:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:05 INFO - Downloading/unpacking jsonschema 16:56:05 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 16:56:05 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 16:56:05 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 16:56:05 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 16:56:05 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 16:56:05 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 16:56:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:56:07 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 16:56:07 INFO - Downloading/unpacking functools32 (from jsonschema) 16:56:07 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 16:56:07 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 16:56:07 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 16:56:07 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 16:56:07 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 16:56:07 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 16:56:07 INFO - Downloading functools32-3.2.3-2.tar.gz 16:56:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 16:56:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:56:07 INFO - warning: no files found matching '*.txt' 16:56:07 INFO - no previously-included directories found matching 'build' 16:56:07 INFO - no previously-included directories found matching 'dist' 16:56:07 INFO - no previously-included directories found matching '.git*' 16:56:07 INFO - Installing collected packages: jsonschema, functools32 16:56:08 INFO - Running setup.py install for functools32 16:56:08 INFO - warning: no files found matching '*.txt' 16:56:08 INFO - no previously-included directories found matching 'build' 16:56:08 INFO - no previously-included directories found matching 'dist' 16:56:08 INFO - no previously-included directories found matching '.git*' 16:56:08 INFO - Successfully installed jsonschema functools32 16:56:08 INFO - Cleaning up... 16:56:08 INFO - Return code: 0 16:56:08 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:56:08 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')]} 16:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:08 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')]} 16:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:08 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 0x7fef42634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2333840>, '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 0x22a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0b60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1452386086.182034-1746839971', '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 16:56:08 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 16:56:08 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 16:56:08 INFO - Using env: {'DISPLAY': ':0', 16:56:08 INFO - 'HOME': '/home/cltbld', 16:56:08 INFO - 'LANG': 'en_US.UTF-8', 16:56:08 INFO - 'LANGUAGE': 'en_US:en', 16:56:08 INFO - 'LOGNAME': 'cltbld', 16:56:08 INFO - 'MAIL': '/var/mail/cltbld', 16:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:08 INFO - 'MOZ_NO_REMOTE': '1', 16:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:08 INFO - 'NO_EM_RESTART': '1', 16:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:56:08 INFO - 'PWD': '/builds/slave/test-pgo', 16:56:08 INFO - 'SHELL': '/bin/bash', 16:56:08 INFO - 'SHLVL': '1', 16:56:08 INFO - 'TERM': 'linux', 16:56:08 INFO - 'TMOUT': '86400', 16:56:08 INFO - 'USER': 'cltbld', 16:56:08 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452386086.182034-1746839971', 16:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:08 INFO - '_': '/tools/buildbot/bin/python'} 16:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:08 INFO - Downloading/unpacking flake8 16:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:56:10 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 16:56:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:56:10 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 16:56:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:10 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 16:56:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:56:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:56:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:56:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:56:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:56:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:56:10 INFO - no previously-included directories found matching 'docs/_build' 16:56:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:56:10 INFO - Running setup.py install for pep8 16:56:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:56:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:56:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:56:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:56:10 INFO - no previously-included directories found matching 'docs/_build' 16:56:10 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:56:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:56:10 INFO - Cleaning up... 16:56:11 INFO - Return code: 0 16:56:11 INFO - Running post-action listener: _resource_record_post_action 16:56:11 INFO - Running post-action listener: _start_resource_monitoring 16:56:11 INFO - Starting resource monitoring. 16:56:11 INFO - ##### 16:56:11 INFO - ##### Running install step. 16:56:11 INFO - ##### 16:56:11 INFO - Running pre-action listener: _resource_record_pre_action 16:56:11 INFO - Running main action method: install 16:56:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:56:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:56:11 INFO - Reading from file tmpfile_stdout 16:56:11 INFO - Detecting whether we're running mozinstall >=1.0... 16:56:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:56:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:56:11 INFO - Reading from file tmpfile_stdout 16:56:11 INFO - Output received: 16:56:11 INFO - Usage: mozinstall [options] installer 16:56:11 INFO - Options: 16:56:11 INFO - -h, --help show this help message and exit 16:56:11 INFO - -d DEST, --destination=DEST 16:56:11 INFO - Directory to install application into. [default: 16:56:11 INFO - "/builds/slave/test-pgo"] 16:56:11 INFO - --app=APP Application being installed. [default: firefox] 16:56:11 INFO - mkdir: /builds/slave/test-pgo/build/application 16:56:11 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'] 16:56:11 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 16:56:27 INFO - Reading from file tmpfile_stdout 16:56:27 INFO - Output received: 16:56:27 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:56:27 INFO - Running post-action listener: _resource_record_post_action 16:56:27 INFO - ##### 16:56:27 INFO - ##### Running run-tests step. 16:56:27 INFO - ##### 16:56:27 INFO - Running pre-action listener: _resource_record_pre_action 16:56:27 INFO - Running main action method: run_tests 16:56:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:56:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:56:27 INFO - Python 2.7.3 16:56:27 INFO - Return code: 0 16:56:27 INFO - grabbing minidump binary from tooltool 16:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:27 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 0x2333840>, '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 0x22a06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:56:27 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 16:56:27 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 16:56:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:56:27 INFO - Return code: 0 16:56:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:56:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:56:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:56:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:56:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:56:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:56:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:56:28 INFO - Return code: 0 16:56:28 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/PsQNoNh0SWas6PtN1MHBzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 16:56:28 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/PsQNoNh0SWas6PtN1MHBzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 16:56:28 INFO - Using env: {'DISPLAY': ':0', 16:56:28 INFO - 'HOME': '/home/cltbld', 16:56:28 INFO - 'LANG': 'en_US.UTF-8', 16:56:28 INFO - 'LANGUAGE': 'en_US:en', 16:56:28 INFO - 'LOGNAME': 'cltbld', 16:56:28 INFO - 'MAIL': '/var/mail/cltbld', 16:56:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:56:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:56:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:28 INFO - 'MOZ_NO_REMOTE': '1', 16:56:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:56:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:28 INFO - 'NO_EM_RESTART': '1', 16:56:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:56:28 INFO - 'PWD': '/builds/slave/test-pgo', 16:56:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:56:28 INFO - 'SHELL': '/bin/bash', 16:56:28 INFO - 'SHLVL': '1', 16:56:28 INFO - 'TERM': 'linux', 16:56:28 INFO - 'TMOUT': '86400', 16:56:28 INFO - 'USER': 'cltbld', 16:56:28 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1452386086.182034-1746839971', 16:56:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:28 INFO - '_': '/tools/buildbot/bin/python'} 16:56:28 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/PsQNoNh0SWas6PtN1MHBzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 16:56:28 INFO - mozversion application_buildid: 20160109143001 16:56:28 INFO - mozversion application_changeset: af1d9d9f34ecb6d4ae168d2329ea6479b50c3e4c 16:56:28 INFO - mozversion application_display_name: Nightly 16:56:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:56:28 INFO - mozversion application_name: Firefox 16:56:28 INFO - mozversion application_remotingname: firefox 16:56:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:56:28 INFO - mozversion application_vendor: Mozilla 16:56:28 INFO - mozversion application_version: 46.0a1 16:56:28 INFO - mozversion platform_buildid: 20160109143001 16:56:28 INFO - mozversion platform_changeset: af1d9d9f34ecb6d4ae168d2329ea6479b50c3e4c 16:56:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:56:28 INFO - mozversion platform_version: 46.0a1 16:56:28 INFO - using testdate: 1452387388 16:56:28 INFO - actual date: 1452387388 16:56:28 INFO - starting webserver on 'localhost:37316' 16:56:28 INFO - SUITE-START | Running 3 tests 16:56:28 INFO - TEST-START | dromaeo_css 16:56:28 INFO - operating with platform_type : linux_ 16:56:28 INFO - Initialising browser for dromaeo_css test... 16:56:29 INFO - TEST-INFO | started process 3317 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9HzaXp/profile http://localhost:37316/getInfo.html) 16:56:34 INFO - PROCESS | 3317 | __metrics Screen width/height:1600/1200 16:56:34 INFO - PROCESS | 3317 | colorDepth:24 16:56:34 INFO - PROCESS | 3317 | Browser inner width/height: 1024/697 16:56:34 INFO - PROCESS | 3317 | __metrics 16:56:34 INFO - PROCESS | 3317 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:56:34 INFO - PROCESS | 3317 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:56:35 INFO - TEST-INFO | 3317: exit 0 16:56:35 INFO - Browser initialized. 16:56:35 INFO - Running cycle 1/1 for dromaeo_css test... 16:56:35 INFO - TEST-INFO | started process 3412 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9HzaXp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:56:47 INFO - PROCESS | 3412 | RSS: Main: 148463616 16:56:47 INFO - PROCESS | 3412 | 16:57:38 INFO - PROCESS | 3412 | 1452387458721 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] 16:59:47 INFO - PROCESS | 3412 | Cycle 1(1): loaded http://localhost:37316/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37316/tests/dromaeo/cssquery-ext.html) 16:59:48 INFO - PROCESS | 3412 | RSS: Main: 265871360 16:59:48 INFO - PROCESS | 3412 | 17:02:50 INFO - PROCESS | 3412 | Cycle 1(1): loaded http://localhost:37316/tests/dromaeo/cssquery-ext.html (next: http://localhost:37316/tests/dromaeo/cssquery-jquery.html) 17:02:51 INFO - PROCESS | 3412 | RSS: Main: 240926720 17:02:51 INFO - PROCESS | 3412 | 17:05:53 INFO - PROCESS | 3412 | Cycle 1(1): loaded http://localhost:37316/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37316/tests/dromaeo/cssquery-mootools.html) 17:05:54 INFO - PROCESS | 3412 | RSS: Main: 242982912 17:05:54 INFO - PROCESS | 3412 | 17:08:55 INFO - PROCESS | 3412 | Cycle 1(1): loaded http://localhost:37316/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37316/tests/dromaeo/cssquery-prototype.html) 17:08:56 INFO - PROCESS | 3412 | RSS: Main: 218705920 17:08:56 INFO - PROCESS | 3412 | 17:11:58 INFO - PROCESS | 3412 | Cycle 1(1): loaded http://localhost:37316/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37316/tests/dromaeo/cssquery-yui.html) 17:11:59 INFO - PROCESS | 3412 | RSS: Main: 217796608 17:11:59 INFO - PROCESS | 3412 | 17:15:02 INFO - PROCESS | 3412 | Cycle 1(1): loaded http://localhost:37316/tests/dromaeo/cssquery-yui.html (next: http://localhost:37316/tests/dromaeo/cssquery-dojo.html) 17:15:02 INFO - PROCESS | 3412 | RSS: Main: 298037248 17:15:02 INFO - PROCESS | 3412 | 17:15:02 INFO - PROCESS | 3412 | __start_tp_report 17:15:02 INFO - PROCESS | 3412 | _x_x_mozilla_page_load 17:15:02 INFO - PROCESS | 3412 | _x_x_mozilla_page_load_details 17:15:02 INFO - PROCESS | 3412 | |i|pagename|runs| 17:15:02 INFO - PROCESS | 3412 | |0;dojo.html;3031.1361262040296;3043.4065357255336;3071.0326247232133;3071.6928307169287;3087.2281929517612;4779.283107533863;4916.99201663659;4975.378077740283;4998.725070121137;5018.397792264925;4938.2345736410825;4967.925481117786;4980.352554167962;4995.925061124086;5069.3156423882765;4468.151051300242;4483.551644835515;4510.165619360412;4535.070310586322;4549.704269222507;4512.842050528232;4572.062727140945;4593.885152871188;4598.172328980782;4615.261558150696;4433.9113217735785;4457.442819647544;4458.1306645204195;4546.47715512717;4552.590266875964;4496.505384407713;4506.301523263899;4518.096380723836;4520.615747661453;4553.817847286137;4498.370228168026;4503.932441013388;4506.8873278167985;4533.569310915458;4541.545845415465;4731.787069581877;4820.783064762094;4822.590079843218;4825.662203645747;4843.24929635907;5210.895782084375;5211.114110601206;5310.6813591184655;5395.541378982791;5407.188921661743;5318.361796584396;5328.840134795923;5329.147336426192;5331.893362132774;5373.838784836461;4977.278294647292;4977.875553111201;4980.526849949249;4992.975035124838;5024.321716568253;5231.084560201949;5319.680819150786;5339.519443250126;5405.243265942771;5429.891402171935;5211.374635043819;5215.687058776485;5219.712915789592;5222.060029194706;5256.842294731164;5202.71385073817;5286.735663216824;5295.073362161606;5312.282841816383;5315.946840531546;5139.100657384943;5228.7908483660985;5269.314989051475;5273.6572122811895;5286;5253.106971814801;5261.447548007481;5266.183741519994;5266.8419947401635;5277.815276465305;4120.21715873983;4170.895727606834;4173.8956526087095;4195.97902010488;4221.873343799691;3717.423799311111;3724.962750372516;3786.280606684776;3799.2781371539318;3801.486799282117;4947.35684361038;4963.057019166346;4967.602591792648;4968.130577148984;5014.2979982802435;5182.300389447376;5271.393789714155;5308.938212357544;5313.256144139824;5314.813981510629;4866.659333846667;4895.657303988686;4910.852674419773;4915.09070821892;4959.231319145538;4562.68061235717;4563.429571303587;4563.840265590688;4590.88522786933;4602.677812553089;5342.198670199424;5369.6509726867625;5473.0969390051;5495;5499.037668408013;5326.334208223972;5348.625596208228;5365.704886231295;5367.865803354791;5368.436314186954;5536.501714845684;5539.944600553943;5541.722913854211;5550.361708403585;5610.326760788732;5081.593472522263;5117.5394214520875;5168.922466162935;5192;5287.920681189708;5253.185756207794;5262.97368513155;5265.973670131625;5271.868203294948;5280.339957505312;5130.076586214517;5164.922526162036;5166.2508936203285;5167.509086636764;5207.270982062439;5063.392392912727;5150.819721309736;5155.9742201290255;5166.45752196029;5209.609279303992;4992.825251116194;4999.9750051240135;5007.799688012585;5009.198528235464;5034.748262586929;5066.493350664904;5089.389273287229;5090.160123579716;5101.489851014869;5142.562882155059;4955.900881982412;5072.087024335655;5079.898402031865;5134.922976155286;5179.48205179479 17:15:02 INFO - PROCESS | 3412 | |1;ext.html;519.1822878965629;523.102878563264;523.403320214955;543.9176039681034;555.6610467614752;27866.30334241645;28536.28659283519;28580;28628.85685571572;28665.283367915814;36223.4566481503;36734.26531469376;37045.44431833525;37181.070473238186;37208;8463.322934165251;8606.354523410739;8607.526586037766;8614.612342444574;8617.267532259766;7384.963075184616;7587.848243035136;8351.457155284887;8359.498430094183;8460.703875364363;10015;10221.795564088714;10237.232207584424;10290.794184116314;10318.380897146159;9806.068423499755;10018.549165287579;10021.248406369552;10024.699259022242;10033.297669163161;7493.625318734042;7689.538627682301;10037.146842518394;10039;10292.691219263434;38425.80787096074;38720.031999199964;38890.80554597237;38929.22141557181;38960.22079558393;3076.292452735861;3198.4722520784044;3443.7933723976644;3653;3881.359575670011;29999.550006749916;30276.54585181224;30302;30452.08643740669;30976.53535196974;3707.518022657064;3721.497597824286;3746.3631182699005;3823.330917089498;3886.9028274293087;263482;265963;266231;266513;266772;39287.60712392897;40008.199836003114;58436.12345814816;58865;58888;62245;63483.6825815868;63484;63687.6815615919;63746.36253637497;14456.85543144555;14657.926710366593;14702.779458308134;14718.411263549553;14761.114333140045;10572.947135264274;10573.577056917637;10582.841257381146;10586.99423554761;10594.523246453928;19208.106063622105;19590.510237244183;19616.60766784656;19647.901760491106;19657.901710491642;7726.266004729542;7941.285284324438;7967.163447838009;7968.12350641429;8008.7597372078935;847.7541512961295;908.8046070094829;942.665353799405;942.6983365323031;1075.9784804304027;27583.31041723973;27937.580936285973;28273.293167670974;28336.43327133446;28582.857085714437;1005.5525291245326;1005.9346142500714;1049.0453687144661;1083.1551389915878;1100.3452945497415;14553.19957402353;14851.851481485046;14957.382458070011;16074.276657550205;16339.101349425895;354171;361316;361747;361791;362705;52719.20921186185;53275.733621331645;53312.73343633334;53326.7333663337;53374;1225.40567824605;1235.3390935849277;1243.1484433163312;1256.1646505074207;1257.3587470390166;28923.132306030853;29400.411991760473;29606;29932.55101173528;30040.248993774458;44851.551484486045;45361.773191133834;45381.54618453773;45418.54581454143;45445.318320224564;305502;306997;307250;307583;307735;28052.158435246976;28780;30896.227594310323;31325.68674313319;31360.05919822409;38503;38686.226275474895;38704;38734.2253154941;39104.2179156421;33220.169994267824;33311.50032749462;33682.494762579074;33798.831005845794;33901.32197356089;33509.497357540145;34312.313753725284;34377.312453751285;34551;34637.13407164841;31374;31987.520187196744;33734.32531349408;34540.13649658678;35093.29813403769;26830.463390732468;29649.555256670737;30573.54139687862;31070.844645776626;31243.218919527193;23482.53034939326;23675.171369002;23725.525489490457;23737.52524949526;23902 17:15:02 INFO - PROCESS | 3412 | |2;jquery.html;334.800793527851;352.75131032622005;357.11969993964874;357.96599323064316;360.9945850812238;13867.375968081435;14357.641058973531;15961.361545538164;16302.592435189126;17756.20097095632;14461.421543138289;15597.532074037768;16120.113393763368;16172.595685107879;16187.109708966002;4987.077390682726;5153.2270159476;5157.329547158883;5191.688498690071;5194.168932970725;3801.277757226132;3925.823337949799;5122.92315615266;5190.558802501773;5461.836144915659;5618.690971996539;5630.127330263816;5655.830325090254;5657.547396208293;5667;5469.56243500519;5689.089745640698;5708.942910570882;5715.571332150105;5755.194272801811;4564.954350456486;4729.574338309534;5040.546350828443;5048.1670524363435;5056.292119103328;11581.594644187497;11808.173427860052;11900.404979751065;14788.852111478855;17314.220860061327;2004.4187185716125;2017.3040301096098;2120.533482633818;2217.5010622609943;2263.219189379661;8923.910760892439;9623.807523849484;11721.060861078231;12234.449449774693;12273.815892761615;1737.2703464544923;1785.8839175453554;1791.8208179182109;1798.8920664760155;1824.1793180192296;48980.51019489831;50723.23915141276;51194.74402628;51361.229581555934;52013.47986520124;9547.093026162504;9810.969848165983;9894.158996485236;9912.900870991198;9975.401475911469;12934.223946563236;12949.54676586315;12963.675908102374;12981;12981.221126732426;6903.654817259217;6922.238553759083;6951.7219311228;7052.929470705228;7224.602646854369;6748.628825414649;6770.966145169243;6785.219699734495;6793.320667933167;6836.623985680835;4085.305498065336;4113.465249517543;4297.763623000703;4317.266064768997;4361.323994780814;1630.2419374990686;1729.5762538178226;1765.2497688482345;1766.7703198584102;1775.902325372117;776.8679324514846;785.8899754034439;853.4537895746727;972.5331840716354;973.4208146153169;14828.184449855145;15360.48277515779;15573.922130389275;15674.216289185495;15684.372625095097;843.5739951324665;861.7328628125176;870.7997160652959;875.1205038935956;896.9775755606031;8592.828143437097;8901.955490222508;9034.954825225963;9042.86435703465;9172.403793753385;392573;396018;398108;524339;531104;69695.65152174207;74049.25950740423;74703.25296746963;75348;75396.24603753892;1067.530286673861;1092.3118435385816;1098.181854518389;1105.160078340467;1105.1766434006715;14632.70734585281;14727.337269822669;14905.776413353591;15139.318730656927;15219.847801522286;31525.684743152276;32683.673163268064;32761.67238327586;32872.50691239681;33078.338433231685;43304;43542.56457435512;43586.34620480759;44258.33612495751;45195.0960980772;6708.295628958889;6795.592264464148;7009.352802091403;7200.639968001474;7222.541116573868;8278.627461764114;10393;10549.630762923261;10625.521851516545;10922.726931826768;7575;8895.243904268209;9321.39410938314;9335.584467176537;9441.952790236004;9517.476538790434;9713.465759383302;9777.315587908779;9841.803163936538;10027.649032283834;7184.46116541251;8920.420172688755;9111.726648200565;9126.269898407978;9996.550155242887;5760.366359700513;6637.800865974028;6784.6946887389195;6888.207856096613;7055.788326350218;7640.770776876702;9350;9538.332316737762;9983.700488985342;10034.69895903124 17:15:02 INFO - PROCESS | 3412 | |3;mootools.html;1067.647676266832;1437.899347045707;1447.9276036198194;1576.3753350671134;1752.0714021568574;6432.356764323566;7108.573485590861;7141.928580714191;7182;7193.784186474414;7089.007538944552;7272.345488905998;7272.709091636329;7281.526700764447;7281.817954551138;2199.406160336712;2227.487677834091;2228.520868013377;2229.253200177934;2229.5095079082575;2173.9347819565437;2211.3918672365066;2214.4574579228033;2223.588636102318;2229.3200573825056;2140.357892632212;2159.0715992123382;2162.3188695560925;2166.42589713726;2167.9132834686593;2206.3270702435752;2214.645656694921;2214.82281417487;2222.144474377368;2225.7996780289773;2193.5722534105857;2228.4428892776805;2230.2863083813186;2232.9330120096424;2236.418531181904;7409.110906691231;7418.851622967564;7452.515586486861;7454.627268636601;7474.177840437547;4401.119776044804;4443.911121777579;4462.44219472566;4467.3299005149165;4498.122866041123;2862.5164936880847;2987.626546681665;2989.0285657161508;3001.9549706754415;3019.381026889482;977.819103465854;1010.7018429563296;1020.0207800511517;1042.030911252535;1071.4803320389606;9795.412275263507;9807.950960245153;9810.607575696964;9818.607255709763;9824.607015719363;4018.9397159042637;4033.092554175346;4071.063655359225;4116.629503344713;4129.628333450004;8637.136286371313;8640.481571105754;8641.740747777576;8646.610902509403;8652.091530389345;4465.955340446619;4473.977630111829;4506.842260520866;4508.075844451945;4511.075229577928;3497;3575.2491976685187;3961.4057891315956;4077.44954431148;4111.9177616447505;3604;3606.2246616977477;3633.5094762206763;3644.9817750911075;3678.668919797231;1186.7270527778487;1210.745743393897;1211.8424604801319;1213.0659392267905;1219.1709637446622;903.3766700976305;923.0215971070686;923.4274749655123;948.9525523723786;1254.0719867298133;6728.596284222865;6817.352351526597;6833.863322733518;6834.692438840264;6855.245922948472;471.8702356851825;475.11628371229483;1147.2600172888608;1161.9477123529462;1186.1341220908785;5436.864078397993;5529.502344788988;5535.169724541271;5537.7784888604;5542.140968149944;8502.702405415781;8503.659853605786;8774.956125219333;8816.691415800544;8945.284377249804;8839.911600883908;8846.071162527842;8856.778580535538;8857.955710221537;8908.331875109392;6931.856243719831;7077.150741911004;7086.39765619928;7097.751578694824;7102.680379382837;6777.8983315249325;6778.0510728497065;6801.353871382211;6802.693878775368;6809.319068093151;7999.244604137771;8140.83718325642;8158.184181581794;8160.428769986282;8310.459820111673;8263.504189748634;8369.958150209453;8371.121032291765;8491.617877195418;8571.699990500303;5326.786928522971;5829.5336373090895;6150.661713605795;6190.102435146969;6291.591046581958;7012.193597736122;7045.647717613996;7049.718011279697;7071.575705457689;7074.045003924404;6465.579737317059;6548.279689234085;6572.047053177358;6683.264840867598;6763.086983257197;6495.253045899782;6509;6597.173917363935;6624.105745724458;6770.763023294161;6713.060171575886;6752.7298908045095;6771.52599318043;6773;6780.38976492118;6145.84635384119;6231.594946328474;6231.844203894939;6243.8126856194385;6250.656213908279;6248.468880145057;6294.496440284858;6301.905471418024;6302.747890084529;6308.0853276273765 17:15:02 INFO - PROCESS | 3412 | |4;prototype.html;321.4214414054701;321.4631565285972;322.3745932890193;327.54961927349893;330.53889823695954;5815.360310365867;5819.388964158766;5855.297364316282;5877.9412205877925;5943.3462319144855;5815.47660710536;5825.533957283418;5827.504662103726;5834.416558344164;5842.2989241291;4494.707843990146;4497.460304763433;4498.932516012263;4502.392177056088;4505;4412.602865742098;4471.955280447202;4491.146682130385;4496.145732310867;4511.8646440606835;4446.7776611169475;4459.353393757903;4463.397441345425;4463.68754187207;4477.932831007537;4441.422615060053;4443.666724995622;4449.42157519522;4464.15181115587;4470.083632855273;3713.8885833425043;3765.661090501868;3771.528558930134;3777.6788972937334;3838.6353296436796;5503.7798488060425;5508.20131080995;5553.9725150847225;5592.0773072443;5616.354119276254;5147.536721695065;5154.355705536808;5162.174052151675;5164.586833053347;5170.508801663836;5809.331926828384;5927.081302398135;5940.70296485174;6062.636241825505;6065.2418447694035;4317.654587633013;4331.155424692186;4332.415123958288;4338.327559228324;4345.478542574911;6357.459615932605;6369.6496692681885;6391.201099862517;6402.807915762534;6408.134901788246;4338.284183109751;4399.670024748093;4419.977900110479;4431.224535706238;4431.800568974404;4488.708233964782;4503.774811259424;4505.864824055284;4506.121306345297;4511.030128522383;5144.4855514449;5166.664166829144;5170.663906846043;5172.043172013189;5174.068667639861;6083.270007599116;6147.84630384244;6149.61633632438;6184.979478386016;6189.412005859436;1558.586974451771;1561.1803803003288;1591.0294720220656;1591.5623203619098;1592.4506045414314;1063.4948399510326;1075.4353964168718;1079.3200283821143;1082.4046774274275;1092.8852470490642;5814.883702325929;5821.039528477839;5822.388649191774;5823.708814559255;5823.94176058234;6317.6209427434505;6329.715162817684;6332.841678958063;6333.1766870306565;6333.619982801047;5809.535237181015;5825.126231065374;5825.271841019872;5826.475617194388;5832.125181222766;3328.816915069646;3400.2179498715436;3403.2512847173584;3424.7260219182403;3425.794452332868;6568.80293591193;6573.638449885302;6577.934220657828;6578.440832529289;6587.242467116343;6451.774187903401;6472.385123413268;6472.935270647327;6476.870462590816;6477.125588045554;6304.18045654062;6431.710573024132;6449.742010319628;6452.935470645328;6475.384838440341;6261.499080073674;6297.370262973666;6371.649559274099;6406.487481001602;6413.390727880844;6323.019931910561;6334.90497642545;6341.334159913327;6342.904856427065;6347.90478142819;6459.61242325462;6591.571547849375;6633.535652504278;6638.137042184485;6653.500987425866;4287.871363859089;4309.59058889405;4310.870673879788;4330.047389574289;4348.978255108705;6411.358864113551;6418.550701450854;6423.132877061536;6423.4861211103935;6428.935710642833;6165.72254248551;6211.223597050369;6249.531285153541;6255;6260.373962603703;6011.27864656244;6228.4705800005695;6232.18981532416;6239.906401403891;6245.6252624842655;6094.54290928191;6094.634321940698;6094.8171554853425;6098.817035488765;6102.298235702773;6242.500599952084;6242.906356404748;6253.937460625518;6273.811785646438;6278.46633036197;5890.352061273171;6118.969405152946;6119.541034422525;6121.296050954197;6129.233845769279 17:15:02 INFO - PROCESS | 3412 | |5;yui.html;656.8719099775545;701.4458577723599;749.9550026998379;765.506248469737;814.3973459639868;12935;13099.607011789662;13104.606861794138;13108;13111.147775394604;12368.38158092094;12402.193857399263;14082.225477598728;14184.078034927748;14192.716145677081;626.495670984857;641.5893827950092;774.9263819937097;785.4070177016345;786.1902240692096;767.6890859202032;769.1116760142045;772.0233904111303;780.9843803123935;782.718221440281;816.542736067804;816.7386436340373;816.8693009118542;817.726061769308;817.9938675429225;673.4006734006738;683.0846665468272;686.993130068703;806.7821688144227;812.1472453923386;601.6179725874058;602.7649216805405;603.9063945088518;605.3432026251522;606.0999415867433;12177.878221217763;12274.75450490994;12338.81491777624;12374.133810633259;12441.315727634976;11966.102542309362;12122.999999999913;12222.877771222264;12467.376631168496;12765.489380424771;10069.496525173712;10170.745731356701;10228.386296822215;10268.537915793808;10355.689329320132;3507.2985402919517;3539.929201415983;3621.384364657988;3691.8523259069607;3692.298463291993;44733.32900006502;45201;45294.32058519125;45599.54400455986;45716.54283457156;9450.385724927857;9505.382150160218;9566.66516671913;9581.185599224005;9635.710928672152;18766.343177988703;18932.43202703921;18977.33579324717;18988.715169272473;18997.810021899604;7532.585707786015;7593.544387336778;7603;7750.341220996165;7780.183080776437;4336.132773445323;4338.8047537860875;4340.717853339523;4363.170997510463;4493.977530112394;2914.6799127984905;2921.109061736191;2951;2963.9110826675233;2975.4644164050246;552.8341497550718;556.4602335734331;556.6493109341089;574.7787101965773;579.1313030454319;507.9187330027178;522.8039485193052;567.9148127780784;615.2248167309223;656.389557711333;8040.597970101471;8118.959405203054;8319.958400208081;8421.789455263544;8478.152184781473;535.9115745901961;555.3280530557989;614.7387360371913;619.3806193806194;666.4601672645173;3634.055145662147;3854.7879866607045;3956.8812935611977;3967.6032396760093;4020.0954785173103;53008;54233.45766542363;54330.72834635802;54498.72750636301;54768.72615636896;47646.28530572044;47864.04271914542;52679.20981185285;54470.72764636151;54858.45141548613;42472.150556989305;42759.7862010688;43011.139777204284;43671.56328436675;43803;8073.19268073188;8303.086660467223;8405;8487.702930397407;8868.822623547363;32010.839945801054;32058.35883282368;32585;32848.671513284564;33075.338493229516;39280.410793837545;41332.1733565321;46474.30288545742;46667;46886.76556617195;10127.189824814144;10469.895301046892;10486.737831554272;10490.842637360292;11060.336379817236;11362.772744545227;11417.143714221633;11490.88509114898;11583.536658533565;11775.764484710087;11283.605073822377;11300.208985371273;11401.543938242377;11675.474603642686;11759.000484958533;11121.888781112086;11216.551337946717;11251.943740281245;11368.658940231806;11373.260738052331;10334.689959300933;10673.89326106729;10691.411972341595;10963.945180274048;11148.721281968015;9056.412850999115;9464.384814987005;9469.952650236704;9488.240940724863;9530.666426675032;9433.811323773349;9943;10193.796124077626;10232.23258255619;10232.64185753495 17:15:02 INFO - PROCESS | 3412 | __end_tp_report 17:15:02 INFO - PROCESS | 3412 | __start_cc_report 17:15:02 INFO - PROCESS | 3412 | _x_x_mozilla_cycle_collect,923 17:15:02 INFO - PROCESS | 3412 | __end_cc_report 17:15:02 INFO - PROCESS | 3412 | __startTimestamp1452388502592__endTimestamp 17:15:02 INFO - PROCESS | 3412 | 17:15:02 INFO - PROCESS | 3412 | ------- Summary: start ------- 17:15:02 INFO - PROCESS | 3412 | Number of tests: 6 17:15:02 INFO - PROCESS | 3412 | 17:15:02 INFO - PROCESS | 3412 | [#0] dojo.html Cycles:165 Average:4920.39 Median:5069.32 stddev:513.23 (10.1%) stddev-sans-first:492.94 17:15:02 INFO - PROCESS | 3412 | Values: 3031.1 3043.4 3071.0 3071.7 3087.2 4779.3 4917.0 4975.4 4998.7 5018.4 4938.2 4967.9 4980.4 4995.9 5069.3 4468.2 4483.6 4510.2 4535.1 4549.7 4512.8 4572.1 4593.9 4598.2 4615.3 4433.9 4457.4 4458.1 4546.5 4552.6 4496.5 4506.3 4518.1 4520.6 4553.8 4498.4 4503.9 4506.9 4533.6 4541.5 4731.8 4820.8 4822.6 4825.7 4843.2 5210.9 5211.1 5310.7 5395.5 5407.2 5318.4 5328.8 5329.1 5331.9 5373.8 4977.3 4977.9 4980.5 4993.0 5024.3 5231.1 5319.7 5339.5 5405.2 5429.9 5211.4 5215.7 5219.7 5222.1 5256.8 5202.7 5286.7 5295.1 5312.3 5315.9 5139.1 5228.8 5269.3 5273.7 5286.0 5253.1 5261.4 5266.2 5266.8 5277.8 4120.2 4170.9 4173.9 4196.0 4221.9 3717.4 3725.0 3786.3 3799.3 3801.5 4947.4 4963.1 4967.6 4968.1 5014.3 5182.3 5271.4 5308.9 5313.3 5314.8 4866.7 4895.7 4910.9 4915.1 4959.2 4562.7 4563.4 4563.8 4590.9 4602.7 5342.2 5369.7 5473.1 5495.0 5499.0 5326.3 5348.6 5365.7 5367.9 5368.4 5536.5 5539.9 5541.7 5550.4 5610.3 5081.6 5117.5 5168.9 5192.0 5287.9 5253.2 5263.0 5266.0 5271.9 5280.3 5130.1 5164.9 5166.3 5167.5 5207.3 5063.4 5150.8 5156.0 5166.5 5209.6 4992.8 5000.0 5007.8 5009.2 5034.7 5066.5 5089.4 5090.2 5101.5 5142.6 4955.9 5072.1 5079.9 5134.9 5179.5 17:15:02 INFO - PROCESS | 3412 | 17:15:02 INFO - PROCESS | 3412 | [#1] ext.html Cycles:180 Average:46858.52 Median:17593.00 stddev:82272.54 (467.6%) stddev-sans-first:82429.77 17:15:02 INFO - PROCESS | 3412 | Values: 519.2 523.1 523.4 543.9 555.7 27866.3 28536.3 28580.0 28628.9 28665.3 36223.5 36734.3 37045.4 37181.1 37208.0 8463.3 8606.4 8607.5 8614.6 8617.3 7385.0 7587.8 8351.5 8359.5 8460.7 10015.0 10221.8 10237.2 10290.8 10318.4 9806.1 10018.5 10021.2 10024.7 10033.3 7493.6 7689.5 10037.1 10039.0 10292.7 38425.8 38720.0 38890.8 38929.2 38960.2 3076.3 3198.5 3443.8 3653.0 3881.4 29999.6 30276.5 30302.0 30452.1 30976.5 3707.5 3721.5 3746.4 3823.3 3886.9 263482.0 265963.0 266231.0 266513.0 266772.0 39287.6 40008.2 58436.1 58865.0 58888.0 62245.0 63483.7 63484.0 63687.7 63746.4 14456.9 14657.9 14702.8 14718.4 14761.1 10572.9 10573.6 10582.8 10587.0 10594.5 19208.1 19590.5 19616.6 19647.9 19657.9 7726.3 7941.3 7967.2 7968.1 8008.8 847.8 908.8 942.7 942.7 1076.0 27583.3 27937.6 28273.3 28336.4 28582.9 1005.6 1005.9 1049.0 1083.2 1100.3 14553.2 14851.9 14957.4 16074.3 16339.1 354171.0 361316.0 361747.0 361791.0 362705.0 52719.2 53275.7 53312.7 53326.7 53374.0 1225.4 1235.3 1243.1 1256.2 1257.4 28923.1 29400.4 29606.0 29932.6 30040.2 44851.6 45361.8 45381.5 45418.5 45445.3 305502.0 306997.0 307250.0 307583.0 307735.0 28052.2 28780.0 30896.2 31325.7 31360.1 38503.0 38686.2 38704.0 38734.2 39104.2 33220.2 33311.5 33682.5 33798.8 33901.3 33509.5 34312.3 34377.3 34551.0 34637.1 31374.0 31987.5 33734.3 34540.1 35093.3 26830.5 29649.6 30573.5 31070.8 31243.2 23482.5 23675.2 23725.5 23737.5 23902.0 17:15:02 INFO - PROCESS | 3412 | 17:15:02 INFO - PROCESS | 3412 | [#2] jquery.html Cycles:180 Average:24475.04 Median:27889.77 stddev:74213.60 (266.1%) stddev-sans-first:74399.65 17:15:02 INFO - PROCESS | 3412 | Values: 334.8 352.8 357.1 358.0 361.0 13867.4 14357.6 15961.4 16302.6 17756.2 14461.4 15597.5 16120.1 16172.6 16187.1 4987.1 5153.2 5157.3 5191.7 5194.2 3801.3 3925.8 5122.9 5190.6 5461.8 5618.7 5630.1 5655.8 5657.5 5667.0 5469.6 5689.1 5708.9 5715.6 5755.2 4565.0 4729.6 5040.5 5048.2 5056.3 11581.6 11808.2 11900.4 14788.9 17314.2 2004.4 2017.3 2120.5 2217.5 2263.2 8923.9 9623.8 11721.1 12234.4 12273.8 1737.3 1785.9 1791.8 1798.9 1824.2 48980.5 50723.2 51194.7 51361.2 52013.5 9547.1 9811.0 9894.2 9912.9 9975.4 12934.2 12949.5 12963.7 12981.0 12981.2 6903.7 6922.2 6951.7 7052.9 7224.6 6748.6 6771.0 6785.2 6793.3 6836.6 4085.3 4113.5 4297.8 4317.3 4361.3 1630.2 1729.6 1765.2 1766.8 1775.9 776.9 785.9 853.5 972.5 973.4 14828.2 15360.5 15573.9 15674.2 15684.4 843.6 861.7 870.8 875.1 897.0 8592.8 8902.0 9035.0 9042.9 9172.4 392573.0 396018.0 398108.0 524339.0 531104.0 69695.7 74049.3 74703.3 75348.0 75396.2 1067.5 1092.3 1098.2 1105.2 1105.2 14632.7 14727.3 14905.8 15139.3 15219.8 31525.7 32683.7 32761.7 32872.5 33078.3 43304.0 43542.6 43586.3 44258.3 45195.1 6708.3 6795.6 7009.4 7200.6 7222.5 8278.6 10393.0 10549.6 10625.5 10922.7 7575.0 8895.2 9321.4 9335.6 9442.0 9517.5 9713.5 9777.3 9841.8 10027.6 7184.5 8920.4 9111.7 9126.3 9996.6 5760.4 6637.8 6784.7 6888.2 7055.8 7640.8 9350.0 9538.3 9983.7 10034.7 17:15:02 INFO - PROCESS | 3412 | 17:15:02 INFO - PROCESS | 3412 | [#3] mootools.html Cycles:180 Average:5167.42 Median:6293.04 stddev:2654.46 (42.2%) stddev-sans-first:2644.01 17:15:02 INFO - PROCESS | 3412 | Values: 1067.6 1437.9 1447.9 1576.4 1752.1 6432.4 7108.6 7141.9 7182.0 7193.8 7089.0 7272.3 7272.7 7281.5 7281.8 2199.4 2227.5 2228.5 2229.3 2229.5 2173.9 2211.4 2214.5 2223.6 2229.3 2140.4 2159.1 2162.3 2166.4 2167.9 2206.3 2214.6 2214.8 2222.1 2225.8 2193.6 2228.4 2230.3 2232.9 2236.4 7409.1 7418.9 7452.5 7454.6 7474.2 4401.1 4443.9 4462.4 4467.3 4498.1 2862.5 2987.6 2989.0 3002.0 3019.4 977.8 1010.7 1020.0 1042.0 1071.5 9795.4 9808.0 9810.6 9818.6 9824.6 4018.9 4033.1 4071.1 4116.6 4129.6 8637.1 8640.5 8641.7 8646.6 8652.1 4466.0 4474.0 4506.8 4508.1 4511.1 3497.0 3575.2 3961.4 4077.4 4111.9 3604.0 3606.2 3633.5 3645.0 3678.7 1186.7 1210.7 1211.8 1213.1 1219.2 903.4 923.0 923.4 949.0 1254.1 6728.6 6817.4 6833.9 6834.7 6855.2 471.9 475.1 1147.3 1161.9 1186.1 5436.9 5529.5 5535.2 5537.8 5542.1 8502.7 8503.7 8775.0 8816.7 8945.3 8839.9 8846.1 8856.8 8858.0 8908.3 6931.9 7077.2 7086.4 7097.8 7102.7 6777.9 6778.1 6801.4 6802.7 6809.3 7999.2 8140.8 8158.2 8160.4 8310.5 8263.5 8370.0 8371.1 8491.6 8571.7 5326.8 5829.5 6150.7 6190.1 6291.6 7012.2 7045.6 7049.7 7071.6 7074.0 6465.6 6548.3 6572.0 6683.3 6763.1 6495.3 6509.0 6597.2 6624.1 6770.8 6713.1 6752.7 6771.5 6773.0 6780.4 6145.8 6231.6 6231.8 6243.8 6250.7 6248.5 6294.5 6301.9 6302.7 6308.1 17:15:02 INFO - PROCESS | 3412 | 17:15:02 INFO - PROCESS | 3412 | [#4] prototype.html Cycles:180 Average:5157.56 Median:5825.20 stddev:1546.32 (26.5%) stddev-sans-first:1507.46 17:15:02 INFO - PROCESS | 3412 | Values: 321.4 321.5 322.4 327.5 330.5 5815.4 5819.4 5855.3 5877.9 5943.3 5815.5 5825.5 5827.5 5834.4 5842.3 4494.7 4497.5 4498.9 4502.4 4505.0 4412.6 4472.0 4491.1 4496.1 4511.9 4446.8 4459.4 4463.4 4463.7 4477.9 4441.4 4443.7 4449.4 4464.2 4470.1 3713.9 3765.7 3771.5 3777.7 3838.6 5503.8 5508.2 5554.0 5592.1 5616.4 5147.5 5154.4 5162.2 5164.6 5170.5 5809.3 5927.1 5940.7 6062.6 6065.2 4317.7 4331.2 4332.4 4338.3 4345.5 6357.5 6369.6 6391.2 6402.8 6408.1 4338.3 4399.7 4420.0 4431.2 4431.8 4488.7 4503.8 4505.9 4506.1 4511.0 5144.5 5166.7 5170.7 5172.0 5174.1 6083.3 6147.8 6149.6 6185.0 6189.4 1558.6 1561.2 1591.0 1591.6 1592.5 1063.5 1075.4 1079.3 1082.4 1092.9 5814.9 5821.0 5822.4 5823.7 5823.9 6317.6 6329.7 6332.8 6333.2 6333.6 5809.5 5825.1 5825.3 5826.5 5832.1 3328.8 3400.2 3403.3 3424.7 3425.8 6568.8 6573.6 6577.9 6578.4 6587.2 6451.8 6472.4 6472.9 6476.9 6477.1 6304.2 6431.7 6449.7 6452.9 6475.4 6261.5 6297.4 6371.6 6406.5 6413.4 6323.0 6334.9 6341.3 6342.9 6347.9 6459.6 6591.6 6633.5 6638.1 6653.5 4287.9 4309.6 4310.9 4330.0 4349.0 6411.4 6418.6 6423.1 6423.5 6428.9 6165.7 6211.2 6249.5 6255.0 6260.4 6011.3 6228.5 6232.2 6239.9 6245.6 6094.5 6094.6 6094.8 6098.8 6102.3 6242.5 6242.9 6253.9 6273.8 6278.5 5890.4 6119.0 6119.5 6121.3 6129.2 17:15:02 INFO - PROCESS | 3412 | 17:15:02 INFO - PROCESS | 3412 | [#5] yui.html Cycles:180 Average:13357.98 Median:24847.49 stddev:15298.21 (61.6%) stddev-sans-first:15311.39 17:15:02 INFO - PROCESS | 3412 | Values: 656.9 701.4 750.0 765.5 814.4 12935.0 13099.6 13104.6 13108.0 13111.1 12368.4 12402.2 14082.2 14184.1 14192.7 626.5 641.6 774.9 785.4 786.2 767.7 769.1 772.0 781.0 782.7 816.5 816.7 816.9 817.7 818.0 673.4 683.1 687.0 806.8 812.1 601.6 602.8 603.9 605.3 606.1 12177.9 12274.8 12338.8 12374.1 12441.3 11966.1 12123.0 12222.9 12467.4 12765.5 10069.5 10170.7 10228.4 10268.5 10355.7 3507.3 3539.9 3621.4 3691.9 3692.3 44733.3 45201.0 45294.3 45599.5 45716.5 9450.4 9505.4 9566.7 9581.2 9635.7 18766.3 18932.4 18977.3 18988.7 18997.8 7532.6 7593.5 7603.0 7750.3 7780.2 4336.1 4338.8 4340.7 4363.2 4494.0 2914.7 2921.1 2951.0 2963.9 2975.5 552.8 556.5 556.6 574.8 579.1 507.9 522.8 567.9 615.2 656.4 8040.6 8119.0 8320.0 8421.8 8478.2 535.9 555.3 614.7 619.4 666.5 3634.1 3854.8 3956.9 3967.6 4020.1 53008.0 54233.5 54330.7 54498.7 54768.7 47646.3 47864.0 52679.2 54470.7 54858.5 42472.2 42759.8 43011.1 43671.6 43803.0 8073.2 8303.1 8405.0 8487.7 8868.8 32010.8 32058.4 32585.0 32848.7 33075.3 39280.4 41332.2 46474.3 46667.0 46886.8 10127.2 10469.9 10486.7 10490.8 11060.3 11362.8 11417.1 11490.9 11583.5 11775.8 11283.6 11300.2 11401.5 11675.5 11759.0 11121.9 11216.6 11251.9 11368.7 11373.3 10334.7 10673.9 10691.4 10963.9 11148.7 9056.4 9464.4 9470.0 9488.2 9530.7 9433.8 9943.0 10193.8 10232.2 10232.6 17:15:02 INFO - PROCESS | 3412 | -------- Summary: end -------- 17:15:02 INFO - PROCESS | 3412 | 17:15:03 INFO - TEST-INFO | 3412: exit 0 17:15:03 INFO - TEST-OK | dromaeo_css | took 1114395ms 17:15:03 INFO - TEST-START | kraken 17:15:03 INFO - operating with platform_type : linux_ 17:15:03 INFO - Initialising browser for kraken test... 17:15:03 INFO - TEST-INFO | started process 3604 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptM2C9J/profile http://localhost:37316/getInfo.html) 17:15:06 INFO - PROCESS | 3604 | __metrics Screen width/height:1600/1200 17:15:06 INFO - PROCESS | 3604 | colorDepth:24 17:15:06 INFO - PROCESS | 3604 | Browser inner width/height: 1024/697 17:15:06 INFO - PROCESS | 3604 | __metrics 17:15:06 INFO - PROCESS | 3604 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:15:06 INFO - PROCESS | 3604 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:15:07 INFO - TEST-INFO | 3604: exit 0 17:15:07 INFO - Browser initialized. 17:15:07 INFO - Running cycle 1/1 for kraken test... 17:15:07 INFO - TEST-INFO | started process 3684 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptM2C9J/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:15:19 INFO - PROCESS | 3684 | RSS: Main: 148869120 17:15:19 INFO - PROCESS | 3684 | 17:15:22 INFO - PROCESS | 3684 | Cycle 1(1): loaded http://localhost:37316/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37316/tests/kraken/driver.html?testName=audio-beat-detection) 17:15:22 INFO - PROCESS | 3684 | RSS: Main: 185987072 17:15:22 INFO - PROCESS | 3684 | 17:15:25 INFO - PROCESS | 3684 | Cycle 1(1): loaded http://localhost:37316/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37316/tests/kraken/driver.html?testName=audio-dft) 17:15:25 INFO - PROCESS | 3684 | RSS: Main: 176394240 17:15:25 INFO - PROCESS | 3684 | 17:15:28 INFO - PROCESS | 3684 | Cycle 1(1): loaded http://localhost:37316/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37316/tests/kraken/driver.html?testName=audio-fft) 17:15:29 INFO - PROCESS | 3684 | RSS: Main: 160997376 17:15:29 INFO - PROCESS | 3684 | 17:15:31 INFO - PROCESS | 3684 | Cycle 1(1): loaded http://localhost:37316/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37316/tests/kraken/driver.html?testName=audio-oscillator) 17:15:31 INFO - PROCESS | 3684 | RSS: Main: 162430976 17:15:31 INFO - PROCESS | 3684 | 17:15:34 INFO - PROCESS | 3684 | Cycle 1(1): loaded http://localhost:37316/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37316/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:15:34 INFO - PROCESS | 3684 | RSS: Main: 164458496 17:15:34 INFO - PROCESS | 3684 | 17:15:37 INFO - PROCESS | 3684 | Cycle 1(1): loaded http://localhost:37316/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37316/tests/kraken/driver.html?testName=imaging-darkroom) 17:15:38 INFO - PROCESS | 3684 | RSS: Main: 164974592 17:15:38 INFO - PROCESS | 3684 | 17:15:41 INFO - PROCESS | 3684 | Cycle 1(1): loaded http://localhost:37316/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37316/tests/kraken/driver.html?testName=imaging-desaturate) 17:15:42 INFO - PROCESS | 3684 | RSS: Main: 166924288 17:15:42 INFO - PROCESS | 3684 | 17:15:44 INFO - PROCESS | 3684 | Cycle 1(1): loaded http://localhost:37316/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37316/tests/kraken/driver.html?testName=json-parse-financial) 17:15:45 INFO - PROCESS | 3684 | RSS: Main: 166858752 17:15:45 INFO - PROCESS | 3684 | 17:15:46 INFO - PROCESS | 3684 | Cycle 1(1): loaded http://localhost:37316/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37316/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:15:47 INFO - PROCESS | 3684 | RSS: Main: 177160192 17:15:47 INFO - PROCESS | 3684 | 17:15:49 INFO - PROCESS | 3684 | Cycle 1(1): loaded http://localhost:37316/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37316/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:15:49 INFO - PROCESS | 3684 | RSS: Main: 174522368 17:15:49 INFO - PROCESS | 3684 | 17:15:51 INFO - PROCESS | 3684 | Cycle 1(1): loaded http://localhost:37316/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37316/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:15:52 INFO - PROCESS | 3684 | RSS: Main: 182890496 17:15:52 INFO - PROCESS | 3684 | 17:15:55 INFO - PROCESS | 3684 | Cycle 1(1): loaded http://localhost:37316/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37316/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:15:56 INFO - PROCESS | 3684 | RSS: Main: 189337600 17:15:56 INFO - PROCESS | 3684 | 17:15:58 INFO - PROCESS | 3684 | Cycle 1(1): loaded http://localhost:37316/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37316/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:15:59 INFO - PROCESS | 3684 | RSS: Main: 189935616 17:15:59 INFO - PROCESS | 3684 | 17:16:00 INFO - PROCESS | 3684 | Cycle 1(1): loaded http://localhost:37316/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37316/tests/kraken/driver.html?testName=ai-astar) 17:16:01 INFO - PROCESS | 3684 | RSS: Main: 246943744 17:16:01 INFO - PROCESS | 3684 | 17:16:01 INFO - PROCESS | 3684 | __start_tp_report 17:16:01 INFO - PROCESS | 3684 | _x_x_mozilla_page_load 17:16:01 INFO - PROCESS | 3684 | _x_x_mozilla_page_load_details 17:16:01 INFO - PROCESS | 3684 | |i|pagename|runs| 17:16:01 INFO - PROCESS | 3684 | |0;ai-astar;110;111;108;111;112;112;99;111;111;111 17:16:01 INFO - PROCESS | 3684 | |1;audio-beat-detection;147;126;149;163;122;153;144;127;162;127 17:16:01 INFO - PROCESS | 3684 | |2;audio-dft;161;160;159;160;161;160;160;159;160;162 17:16:01 INFO - PROCESS | 3684 | |3;audio-fft;73;73;84;96;73;72;71;110;90;71 17:16:01 INFO - PROCESS | 3684 | |4;audio-oscillator;97;96;136;96;96;95;136;97;96;141 17:16:01 INFO - PROCESS | 3684 | |5;imaging-gaussian-blur;108;109;109;109;109;108;108;109;109;108 17:16:01 INFO - PROCESS | 3684 | |6;imaging-darkroom;148;145;145;145;146;146;145;145;145;146 17:16:01 INFO - PROCESS | 3684 | |7;imaging-desaturate;95;96;95;95;95;95;95;96;96;96 17:16:01 INFO - PROCESS | 3684 | |8;json-parse-financial;55;56;56;56;55;56;55;63;54;54 17:16:01 INFO - PROCESS | 3684 | |9;json-stringify-tinderbox;66;67;67;67;67;67;67;66;67;67 17:16:01 INFO - PROCESS | 3684 | |10;stanford-crypto-aes;84;87;85;84;85;84;85;85;84;86 17:16:01 INFO - PROCESS | 3684 | |11;stanford-crypto-ccm;119;125;126;116;128;119;115;117;123;118 17:16:01 INFO - PROCESS | 3684 | |12;stanford-crypto-pbkdf2;139;142;147;148;155;140;152;154;154;139 17:16:01 INFO - PROCESS | 3684 | |13;stanford-crypto-sha256-iterative;70;69;67;68;70;66;66;68;66;70 17:16:01 INFO - PROCESS | 3684 | __end_tp_report 17:16:01 INFO - PROCESS | 3684 | __start_cc_report 17:16:01 INFO - PROCESS | 3684 | _x_x_mozilla_cycle_collect,940 17:16:01 INFO - PROCESS | 3684 | __end_cc_report 17:16:01 INFO - PROCESS | 3684 | __startTimestamp1452388561208__endTimestamp 17:16:01 INFO - PROCESS | 3684 | 17:16:01 INFO - PROCESS | 3684 | ------- Summary: start ------- 17:16:01 INFO - PROCESS | 3684 | Number of tests: 14 17:16:01 INFO - PROCESS | 3684 | 17:16:01 INFO - PROCESS | 3684 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.89 (3.5%) stddev-sans-first:4.13 17:16:01 INFO - PROCESS | 3684 | Values: 110.0 111.0 108.0 111.0 112.0 112.0 99.0 111.0 111.0 111.0 17:16:01 INFO - PROCESS | 3684 | 17:16:01 INFO - PROCESS | 3684 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:148.00 stddev:15.44 (10.4%) stddev-sans-first:16.27 17:16:01 INFO - PROCESS | 3684 | Values: 147.0 126.0 149.0 163.0 122.0 153.0 144.0 127.0 162.0 127.0 17:16:01 INFO - PROCESS | 3684 | 17:16:01 INFO - PROCESS | 3684 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 17:16:01 INFO - PROCESS | 3684 | Values: 161.0 160.0 159.0 160.0 161.0 160.0 160.0 159.0 160.0 162.0 17:16:01 INFO - PROCESS | 3684 | 17:16:01 INFO - PROCESS | 3684 | [#3] audio-fft Cycles:10 Average:81.30 Median:73.00 stddev:13.45 (18.4%) stddev-sans-first:13.93 17:16:01 INFO - PROCESS | 3684 | Values: 73.0 73.0 84.0 96.0 73.0 72.0 71.0 110.0 90.0 71.0 17:16:01 INFO - PROCESS | 3684 | 17:16:01 INFO - PROCESS | 3684 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:96.00 stddev:20.11 (20.9%) stddev-sans-first:20.89 17:16:01 INFO - PROCESS | 3684 | Values: 97.0 96.0 136.0 96.0 96.0 95.0 136.0 97.0 96.0 141.0 17:16:01 INFO - PROCESS | 3684 | 17:16:01 INFO - PROCESS | 3684 | [#5] imaging-gaussian-blur Cycles:10 Average:108.60 Median:109.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 17:16:01 INFO - PROCESS | 3684 | Values: 108.0 109.0 109.0 109.0 109.0 108.0 108.0 109.0 109.0 108.0 17:16:01 INFO - PROCESS | 3684 | 17:16:01 INFO - PROCESS | 3684 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:145.50 stddev:0.97 (0.7%) stddev-sans-first:0.50 17:16:01 INFO - PROCESS | 3684 | Values: 148.0 145.0 145.0 145.0 146.0 146.0 145.0 145.0 145.0 146.0 17:16:01 INFO - PROCESS | 3684 | 17:16:01 INFO - PROCESS | 3684 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:16:01 INFO - PROCESS | 3684 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 17:16:01 INFO - PROCESS | 3684 | 17:16:01 INFO - PROCESS | 3684 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:2.58 (4.6%) stddev-sans-first:2.71 17:16:01 INFO - PROCESS | 3684 | Values: 55.0 56.0 56.0 56.0 55.0 56.0 55.0 63.0 54.0 54.0 17:16:01 INFO - PROCESS | 3684 | 17:16:01 INFO - PROCESS | 3684 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 17:16:01 INFO - PROCESS | 3684 | Values: 66.0 67.0 67.0 67.0 67.0 67.0 67.0 66.0 67.0 67.0 17:16:01 INFO - PROCESS | 3684 | 17:16:01 INFO - PROCESS | 3684 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:85.00 stddev:0.99 (1.2%) stddev-sans-first:1.00 17:16:01 INFO - PROCESS | 3684 | Values: 84.0 87.0 85.0 84.0 85.0 84.0 85.0 85.0 84.0 86.0 17:16:01 INFO - PROCESS | 3684 | 17:16:01 INFO - PROCESS | 3684 | [#11] stanford-crypto-ccm Cycles:10 Average:120.60 Median:121.00 stddev:4.55 (3.8%) stddev-sans-first:4.79 17:16:01 INFO - PROCESS | 3684 | Values: 119.0 125.0 126.0 116.0 128.0 119.0 115.0 117.0 123.0 118.0 17:16:01 INFO - PROCESS | 3684 | 17:16:01 INFO - PROCESS | 3684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.00 Median:150.00 stddev:6.58 (4.4%) stddev-sans-first:6.31 17:16:01 INFO - PROCESS | 3684 | Values: 139.0 142.0 147.0 148.0 155.0 140.0 152.0 154.0 154.0 139.0 17:16:01 INFO - PROCESS | 3684 | 17:16:01 INFO - PROCESS | 3684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:1.70 (2.5%) stddev-sans-first:1.64 17:16:01 INFO - PROCESS | 3684 | Values: 70.0 69.0 67.0 68.0 70.0 66.0 66.0 68.0 66.0 70.0 17:16:01 INFO - PROCESS | 3684 | -------- Summary: end -------- 17:16:01 INFO - PROCESS | 3684 | 17:16:01 INFO - TEST-INFO | 3684: exit 0 17:16:02 INFO - TEST-OK | kraken | took 58671ms 17:16:02 INFO - TEST-START | v8_7 17:16:02 INFO - operating with platform_type : linux_ 17:16:02 INFO - Initialising browser for v8_7 test... 17:16:02 INFO - TEST-INFO | started process 3934 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFByxzV/profile http://localhost:37316/getInfo.html) 17:16:05 INFO - PROCESS | 3934 | __metrics Screen width/height:1600/1200 17:16:05 INFO - PROCESS | 3934 | colorDepth:24 17:16:05 INFO - PROCESS | 3934 | Browser inner width/height: 1024/697 17:16:05 INFO - PROCESS | 3934 | __metrics 17:16:05 INFO - PROCESS | 3934 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:16:05 INFO - PROCESS | 3934 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:16:06 INFO - TEST-INFO | 3934: exit 0 17:16:06 INFO - Browser initialized. 17:16:06 INFO - Running cycle 1/1 for v8_7 test... 17:16:06 INFO - TEST-INFO | started process 4016 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFByxzV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:16:18 INFO - PROCESS | 4016 | RSS: Main: 149676032 17:16:18 INFO - PROCESS | 4016 | 17:16:40 INFO - PROCESS | 4016 | Cycle 1(1): loaded http://localhost:37316/tests/v8_7/run.html (next: http://localhost:37316/tests/v8_7/run.html) 17:16:40 INFO - PROCESS | 4016 | RSS: Main: 554348544 17:16:40 INFO - PROCESS | 4016 | 17:16:40 INFO - PROCESS | 4016 | __start_tp_report 17:16:40 INFO - PROCESS | 4016 | _x_x_mozilla_page_load 17:16:40 INFO - PROCESS | 4016 | _x_x_mozilla_page_load_details 17:16:40 INFO - PROCESS | 4016 | |i|pagename|runs| 17:16:40 INFO - PROCESS | 4016 | |0;Richards;170.2127659574468 17:16:40 INFO - PROCESS | 4016 | |1;DeltaBlue;189.17896329928112 17:16:40 INFO - PROCESS | 4016 | |2;Encrypt;280.2690582959641 17:16:40 INFO - PROCESS | 4016 | |3;Decrypt;5159.79381443299 17:16:40 INFO - PROCESS | 4016 | |4;RayTrace;1131.2217194570135 17:16:40 INFO - PROCESS | 4016 | |5;Earley;784.3137254901961 17:16:40 INFO - PROCESS | 4016 | |6;Boyer;12265.060240963856 17:16:40 INFO - PROCESS | 4016 | |7;RegExp;42936.17021276596 17:16:40 INFO - PROCESS | 4016 | |8;Splay;574.3825387708214 17:16:40 INFO - PROCESS | 4016 | |9;NavierStokes;4835.748792270531 17:16:40 INFO - PROCESS | 4016 | __end_tp_report 17:16:40 INFO - PROCESS | 4016 | __startTimestamp1452388600782__endTimestamp 17:16:40 INFO - PROCESS | 4016 | 17:16:40 INFO - PROCESS | 4016 | ------- Summary: start ------- 17:16:40 INFO - PROCESS | 4016 | Number of tests: 10 17:16:40 INFO - PROCESS | 4016 | 17:16:40 INFO - PROCESS | 4016 | [#0] Richards Cycles:1 Average:170.21 Median:170.21 stddev:0.00 (0.0%) 17:16:40 INFO - PROCESS | 4016 | Values: 170.2 17:16:40 INFO - PROCESS | 4016 | 17:16:40 INFO - PROCESS | 4016 | [#1] DeltaBlue Cycles:1 Average:189.18 Median:189.18 stddev:0.00 (0.0%) 17:16:40 INFO - PROCESS | 4016 | Values: 189.2 17:16:40 INFO - PROCESS | 4016 | 17:16:40 INFO - PROCESS | 4016 | [#2] Encrypt Cycles:1 Average:280.27 Median:280.27 stddev:0.00 (0.0%) 17:16:40 INFO - PROCESS | 4016 | Values: 280.3 17:16:40 INFO - PROCESS | 4016 | 17:16:40 INFO - PROCESS | 4016 | [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 17:16:40 INFO - PROCESS | 4016 | Values: 5159.8 17:16:40 INFO - PROCESS | 4016 | 17:16:40 INFO - PROCESS | 4016 | [#4] RayTrace Cycles:1 Average:1131.22 Median:1131.22 stddev:0.00 (0.0%) 17:16:40 INFO - PROCESS | 4016 | Values: 1131.2 17:16:40 INFO - PROCESS | 4016 | 17:16:40 INFO - PROCESS | 4016 | [#5] Earley Cycles:1 Average:784.31 Median:784.31 stddev:0.00 (0.0%) 17:16:40 INFO - PROCESS | 4016 | Values: 784.3 17:16:40 INFO - PROCESS | 4016 | 17:16:40 INFO - PROCESS | 4016 | [#6] Boyer Cycles:1 Average:12265.06 Median:12265.06 stddev:0.00 (0.0%) 17:16:40 INFO - PROCESS | 4016 | Values: 12265.1 17:16:40 INFO - PROCESS | 4016 | 17:16:40 INFO - PROCESS | 4016 | [#7] RegExp Cycles:1 Average:42936.17 Median:42936.17 stddev:0.00 (0.0%) 17:16:40 INFO - PROCESS | 4016 | Values: 42936.2 17:16:40 INFO - PROCESS | 4016 | 17:16:40 INFO - PROCESS | 4016 | [#8] Splay Cycles:1 Average:574.38 Median:574.38 stddev:0.00 (0.0%) 17:16:40 INFO - PROCESS | 4016 | Values: 574.4 17:16:40 INFO - PROCESS | 4016 | 17:16:40 INFO - PROCESS | 4016 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 17:16:40 INFO - PROCESS | 4016 | Values: 4835.7 17:16:40 INFO - PROCESS | 4016 | -------- Summary: end -------- 17:16:40 INFO - PROCESS | 4016 | 17:16:41 INFO - TEST-INFO | 4016: exit 0 17:16:41 INFO - TEST-OK | v8_7 | took 39587ms 17:16:41 INFO - SUITE-END | took 1212s 17:16:41 INFO - Completed test suite (00:20:12) 17:16:41 INFO - Working with test: dromaeo_css 17:16:41 INFO - Generating results file: dromaeo_css 17:16:41 INFO - Working with test: kraken 17:16:41 INFO - Generating results file: kraken 17:16:41 INFO - javascript benchmark 17:16:41 INFO - Working with test: v8_7 17:16:41 INFO - Generating results file: v8_7 17:16:41 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:16:41 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 17:16:41 INFO - process_Request line: dromaeo_css 6595.81 graph.html#tests=[[72,64,35]] 17:16:41 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:16:41 INFO - process_Request line: kraken 1494.60 graph.html#tests=[[232,64,35]] 17:16:41 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:16:41 INFO - process_Request line: v8_7 20045.22 graph.html#tests=[[230,64,35]] 17:16:41 INFO - RETURN: dromaeo_css: 6595.81 17:16:41 INFO - RETURN: kraken: 1494.60 17:16:41 INFO - RETURN: v8_7: 20045.22 17:16:41 INFO - javascript benchmark 17:16:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3031.1361262040296, 3043.4065357255336, 3071.0326247232133, 3071.6928307169287, 3087.2281929517612, 4779.283107533863, 4916.99201663659, 4975.378077740283, 4998.725070121137, 5018.397792264925, 4938.2345736410825, 4967.925481117786, 4980.352554167962, 4995.925061124086, 5069.3156423882765, 4468.151051300242, 4483.551644835515, 4510.165619360412, 4535.070310586322, 4549.704269222507, 4512.842050528232, 4572.062727140945, 4593.885152871188, 4598.172328980782, 4615.261558150696, 4433.9113217735785, 4457.442819647544, 4458.1306645204195, 4546.47715512717, 4552.590266875964, 4496.505384407713, 4506.301523263899, 4518.096380723836, 4520.615747661453, 4553.817847286137, 4498.370228168026, 4503.932441013388, 4506.8873278167985, 4533.569310915458, 4541.545845415465, 4731.787069581877, 4820.783064762094, 4822.590079843218, 4825.662203645747, 4843.24929635907, 5210.895782084375, 5211.114110601206, 5310.6813591184655, 5395.541378982791, 5407.188921661743, 5318.361796584396, 5328.840134795923, 5329.147336426192, 5331.893362132774, 5373.838784836461, 4977.278294647292, 4977.875553111201, 4980.526849949249, 4992.975035124838, 5024.321716568253, 5231.084560201949, 5319.680819150786, 5339.519443250126, 5405.243265942771, 5429.891402171935, 5211.374635043819, 5215.687058776485, 5219.712915789592, 5222.060029194706, 5256.842294731164, 5202.71385073817, 5286.735663216824, 5295.073362161606, 5312.282841816383, 5315.946840531546, 5139.100657384943, 5228.7908483660985, 5269.314989051475, 5273.6572122811895, 5286.0, 5253.106971814801, 5261.447548007481, 5266.183741519994, 5266.8419947401635, 5277.815276465305, 4120.21715873983, 4170.895727606834, 4173.8956526087095, 4195.97902010488, 4221.873343799691, 3717.423799311111, 3724.962750372516, 3786.280606684776, 3799.2781371539318, 3801.486799282117, 4947.35684361038, 4963.057019166346, 4967.602591792648, 4968.130577148984, 5014.2979982802435, 5182.300389447376, 5271.393789714155, 5308.938212357544, 5313.256144139824, 5314.813981510629, 4866.659333846667, 4895.657303988686, 4910.852674419773, 4915.09070821892, 4959.231319145538, 4562.68061235717, 4563.429571303587, 4563.840265590688, 4590.88522786933, 4602.677812553089, 5342.198670199424, 5369.6509726867625, 5473.0969390051, 5495.0, 5499.037668408013, 5326.334208223972, 5348.625596208228, 5365.704886231295, 5367.865803354791, 5368.436314186954, 5536.501714845684, 5539.944600553943, 5541.722913854211, 5550.361708403585, 5610.326760788732, 5081.593472522263, 5117.5394214520875, 5168.922466162935, 5192.0, 5287.920681189708, 5253.185756207794, 5262.97368513155, 5265.973670131625, 5271.868203294948, 5280.339957505312, 5130.076586214517, 5164.922526162036, 5166.2508936203285, 5167.509086636764, 5207.270982062439, 5063.392392912727, 5150.819721309736, 5155.9742201290255, 5166.45752196029, 5209.609279303992, 4992.825251116194, 4999.9750051240135, 5007.799688012585, 5009.198528235464, 5034.748262586929, 5066.493350664904, 5089.389273287229, 5090.160123579716, 5101.489851014869, 5142.562882155059, 4955.900881982412, 5072.087024335655, 5079.898402031865, 5134.922976155286, 5179.48205179479], "unit": "score", "name": "dojo.html", "value": 4889.537019473925}, {"lowerIsBetter": false, "replicates": [519.1822878965629, 523.102878563264, 523.403320214955, 543.9176039681034, 555.6610467614752, 27866.30334241645, 28536.28659283519, 28580.0, 28628.85685571572, 28665.283367915814, 36223.4566481503, 36734.26531469376, 37045.44431833525, 37181.070473238186, 37208.0, 8463.322934165251, 8606.354523410739, 8607.526586037766, 8614.612342444574, 8617.267532259766, 7384.963075184616, 7587.848243035136, 8351.457155284887, 8359.498430094183, 8460.703875364363, 10015.0, 10221.795564088714, 10237.232207584424, 10290.794184116314, 10318.380897146159, 9806.068423499755, 10018.549165287579, 10021.248406369552, 10024.699259022242, 10033.297669163161, 7493.625318734042, 7689.538627682301, 10037.146842518394, 10039.0, 10292.691219263434, 38425.80787096074, 38720.031999199964, 38890.80554597237, 38929.22141557181, 38960.22079558393, 3076.292452735861, 3198.4722520784044, 3443.7933723976644, 3653.0, 3881.359575670011, 29999.550006749916, 30276.54585181224, 30302.0, 30452.08643740669, 30976.53535196974, 3707.518022657064, 3721.497597824286, 3746.3631182699005, 3823.330917089498, 3886.9028274293087, 263482.0, 265963.0, 266231.0, 266513.0, 266772.0, 39287.60712392897, 40008.199836003114, 58436.12345814816, 58865.0, 58888.0, 62245.0, 63483.6825815868, 63484.0, 63687.6815615919, 63746.36253637497, 14456.85543144555, 14657.926710366593, 14702.779458308134, 14718.411263549553, 14761.114333140045, 10572.947135264274, 10573.577056917637, 10582.841257381146, 10586.99423554761, 10594.523246453928, 19208.106063622105, 19590.510237244183, 19616.60766784656, 19647.901760491106, 19657.901710491642, 7726.266004729542, 7941.285284324438, 7967.163447838009, 7968.12350641429, 8008.7597372078935, 847.7541512961295, 908.8046070094829, 942.665353799405, 942.6983365323031, 1075.9784804304027, 27583.31041723973, 27937.580936285973, 28273.293167670974, 28336.43327133446, 28582.857085714437, 1005.5525291245326, 1005.9346142500714, 1049.0453687144661, 1083.1551389915878, 1100.3452945497415, 14553.19957402353, 14851.851481485046, 14957.382458070011, 16074.276657550205, 16339.101349425895, 354171.0, 361316.0, 361747.0, 361791.0, 362705.0, 52719.20921186185, 53275.733621331645, 53312.73343633334, 53326.7333663337, 53374.0, 1225.40567824605, 1235.3390935849277, 1243.1484433163312, 1256.1646505074207, 1257.3587470390166, 28923.132306030853, 29400.411991760473, 29606.0, 29932.55101173528, 30040.248993774458, 44851.551484486045, 45361.773191133834, 45381.54618453773, 45418.54581454143, 45445.318320224564, 305502.0, 306997.0, 307250.0, 307583.0, 307735.0, 28052.158435246976, 28780.0, 30896.227594310323, 31325.68674313319, 31360.05919822409, 38503.0, 38686.226275474895, 38704.0, 38734.2253154941, 39104.2179156421, 33220.169994267824, 33311.50032749462, 33682.494762579074, 33798.831005845794, 33901.32197356089, 33509.497357540145, 34312.313753725284, 34377.312453751285, 34551.0, 34637.13407164841, 31374.0, 31987.520187196744, 33734.32531349408, 34540.13649658678, 35093.29813403769, 26830.463390732468, 29649.555256670737, 30573.54139687862, 31070.844645776626, 31243.218919527193, 23482.53034939326, 23675.171369002, 23725.525489490457, 23737.52524949526, 23902.0], "unit": "score", "name": "ext.html", "value": 17989.981480931296}, {"lowerIsBetter": false, "replicates": [334.800793527851, 352.75131032622005, 357.11969993964874, 357.96599323064316, 360.9945850812238, 13867.375968081435, 14357.641058973531, 15961.361545538164, 16302.592435189126, 17756.20097095632, 14461.421543138289, 15597.532074037768, 16120.113393763368, 16172.595685107879, 16187.109708966002, 4987.077390682726, 5153.2270159476, 5157.329547158883, 5191.688498690071, 5194.168932970725, 3801.277757226132, 3925.823337949799, 5122.92315615266, 5190.558802501773, 5461.836144915659, 5618.690971996539, 5630.127330263816, 5655.830325090254, 5657.547396208293, 5667.0, 5469.56243500519, 5689.089745640698, 5708.942910570882, 5715.571332150105, 5755.194272801811, 4564.954350456486, 4729.574338309534, 5040.546350828443, 5048.1670524363435, 5056.292119103328, 11581.594644187497, 11808.173427860052, 11900.404979751065, 14788.852111478855, 17314.220860061327, 2004.4187185716125, 2017.3040301096098, 2120.533482633818, 2217.5010622609943, 2263.219189379661, 8923.910760892439, 9623.807523849484, 11721.060861078231, 12234.449449774693, 12273.815892761615, 1737.2703464544923, 1785.8839175453554, 1791.8208179182109, 1798.8920664760155, 1824.1793180192296, 48980.51019489831, 50723.23915141276, 51194.74402628, 51361.229581555934, 52013.47986520124, 9547.093026162504, 9810.969848165983, 9894.158996485236, 9912.900870991198, 9975.401475911469, 12934.223946563236, 12949.54676586315, 12963.675908102374, 12981.0, 12981.221126732426, 6903.654817259217, 6922.238553759083, 6951.7219311228, 7052.929470705228, 7224.602646854369, 6748.628825414649, 6770.966145169243, 6785.219699734495, 6793.320667933167, 6836.623985680835, 4085.305498065336, 4113.465249517543, 4297.763623000703, 4317.266064768997, 4361.323994780814, 1630.2419374990686, 1729.5762538178226, 1765.2497688482345, 1766.7703198584102, 1775.902325372117, 776.8679324514846, 785.8899754034439, 853.4537895746727, 972.5331840716354, 973.4208146153169, 14828.184449855145, 15360.48277515779, 15573.922130389275, 15674.216289185495, 15684.372625095097, 843.5739951324665, 861.7328628125176, 870.7997160652959, 875.1205038935956, 896.9775755606031, 8592.828143437097, 8901.955490222508, 9034.954825225963, 9042.86435703465, 9172.403793753385, 392573.0, 396018.0, 398108.0, 524339.0, 531104.0, 69695.65152174207, 74049.25950740423, 74703.25296746963, 75348.0, 75396.24603753892, 1067.530286673861, 1092.3118435385816, 1098.181854518389, 1105.160078340467, 1105.1766434006715, 14632.70734585281, 14727.337269822669, 14905.776413353591, 15139.318730656927, 15219.847801522286, 31525.684743152276, 32683.673163268064, 32761.67238327586, 32872.50691239681, 33078.338433231685, 43304.0, 43542.56457435512, 43586.34620480759, 44258.33612495751, 45195.0960980772, 6708.295628958889, 6795.592264464148, 7009.352802091403, 7200.639968001474, 7222.541116573868, 8278.627461764114, 10393.0, 10549.630762923261, 10625.521851516545, 10922.726931826768, 7575.0, 8895.243904268209, 9321.39410938314, 9335.584467176537, 9441.952790236004, 9517.476538790434, 9713.465759383302, 9777.315587908779, 9841.803163936538, 10027.649032283834, 7184.46116541251, 8920.420172688755, 9111.726648200565, 9126.269898407978, 9996.550155242887, 5760.366359700513, 6637.800865974028, 6784.6946887389195, 6888.207856096613, 7055.788326350218, 7640.770776876702, 9350.0, 9538.332316737762, 9983.700488985342, 10034.69895903124], "unit": "score", "name": "jquery.html", "value": 7772.158425026268}, {"lowerIsBetter": false, "replicates": [1067.647676266832, 1437.899347045707, 1447.9276036198194, 1576.3753350671134, 1752.0714021568574, 6432.356764323566, 7108.573485590861, 7141.928580714191, 7182.0, 7193.784186474414, 7089.007538944552, 7272.345488905998, 7272.709091636329, 7281.526700764447, 7281.817954551138, 2199.406160336712, 2227.487677834091, 2228.520868013377, 2229.253200177934, 2229.5095079082575, 2173.9347819565437, 2211.3918672365066, 2214.4574579228033, 2223.588636102318, 2229.3200573825056, 2140.357892632212, 2159.0715992123382, 2162.3188695560925, 2166.42589713726, 2167.9132834686593, 2206.3270702435752, 2214.645656694921, 2214.82281417487, 2222.144474377368, 2225.7996780289773, 2193.5722534105857, 2228.4428892776805, 2230.2863083813186, 2232.9330120096424, 2236.418531181904, 7409.110906691231, 7418.851622967564, 7452.515586486861, 7454.627268636601, 7474.177840437547, 4401.119776044804, 4443.911121777579, 4462.44219472566, 4467.3299005149165, 4498.122866041123, 2862.5164936880847, 2987.626546681665, 2989.0285657161508, 3001.9549706754415, 3019.381026889482, 977.819103465854, 1010.7018429563296, 1020.0207800511517, 1042.030911252535, 1071.4803320389606, 9795.412275263507, 9807.950960245153, 9810.607575696964, 9818.607255709763, 9824.607015719363, 4018.9397159042637, 4033.092554175346, 4071.063655359225, 4116.629503344713, 4129.628333450004, 8637.136286371313, 8640.481571105754, 8641.740747777576, 8646.610902509403, 8652.091530389345, 4465.955340446619, 4473.977630111829, 4506.842260520866, 4508.075844451945, 4511.075229577928, 3497.0, 3575.2491976685187, 3961.4057891315956, 4077.44954431148, 4111.9177616447505, 3604.0, 3606.2246616977477, 3633.5094762206763, 3644.9817750911075, 3678.668919797231, 1186.7270527778487, 1210.745743393897, 1211.8424604801319, 1213.0659392267905, 1219.1709637446622, 903.3766700976305, 923.0215971070686, 923.4274749655123, 948.9525523723786, 1254.0719867298133, 6728.596284222865, 6817.352351526597, 6833.863322733518, 6834.692438840264, 6855.245922948472, 471.8702356851825, 475.11628371229483, 1147.2600172888608, 1161.9477123529462, 1186.1341220908785, 5436.864078397993, 5529.502344788988, 5535.169724541271, 5537.7784888604, 5542.140968149944, 8502.702405415781, 8503.659853605786, 8774.956125219333, 8816.691415800544, 8945.284377249804, 8839.911600883908, 8846.071162527842, 8856.778580535538, 8857.955710221537, 8908.331875109392, 6931.856243719831, 7077.150741911004, 7086.39765619928, 7097.751578694824, 7102.680379382837, 6777.8983315249325, 6778.0510728497065, 6801.353871382211, 6802.693878775368, 6809.319068093151, 7999.244604137771, 8140.83718325642, 8158.184181581794, 8160.428769986282, 8310.459820111673, 8263.504189748634, 8369.958150209453, 8371.121032291765, 8491.617877195418, 8571.699990500303, 5326.786928522971, 5829.5336373090895, 6150.661713605795, 6190.102435146969, 6291.591046581958, 7012.193597736122, 7045.647717613996, 7049.718011279697, 7071.575705457689, 7074.045003924404, 6465.579737317059, 6548.279689234085, 6572.047053177358, 6683.264840867598, 6763.086983257197, 6495.253045899782, 6509.0, 6597.173917363935, 6624.105745724458, 6770.763023294161, 6713.060171575886, 6752.7298908045095, 6771.52599318043, 6773.0, 6780.38976492118, 6145.84635384119, 6231.594946328474, 6231.844203894939, 6243.8126856194385, 6250.656213908279, 6248.468880145057, 6294.496440284858, 6301.905471418024, 6302.747890084529, 6308.0853276273765], "unit": "score", "name": "mootools.html", "value": 4249.57369453459}, {"lowerIsBetter": false, "replicates": [321.4214414054701, 321.4631565285972, 322.3745932890193, 327.54961927349893, 330.53889823695954, 5815.360310365867, 5819.388964158766, 5855.297364316282, 5877.9412205877925, 5943.3462319144855, 5815.47660710536, 5825.533957283418, 5827.504662103726, 5834.416558344164, 5842.2989241291, 4494.707843990146, 4497.460304763433, 4498.932516012263, 4502.392177056088, 4505.0, 4412.602865742098, 4471.955280447202, 4491.146682130385, 4496.145732310867, 4511.8646440606835, 4446.7776611169475, 4459.353393757903, 4463.397441345425, 4463.68754187207, 4477.932831007537, 4441.422615060053, 4443.666724995622, 4449.42157519522, 4464.15181115587, 4470.083632855273, 3713.8885833425043, 3765.661090501868, 3771.528558930134, 3777.6788972937334, 3838.6353296436796, 5503.7798488060425, 5508.20131080995, 5553.9725150847225, 5592.0773072443, 5616.354119276254, 5147.536721695065, 5154.355705536808, 5162.174052151675, 5164.586833053347, 5170.508801663836, 5809.331926828384, 5927.081302398135, 5940.70296485174, 6062.636241825505, 6065.2418447694035, 4317.654587633013, 4331.155424692186, 4332.415123958288, 4338.327559228324, 4345.478542574911, 6357.459615932605, 6369.6496692681885, 6391.201099862517, 6402.807915762534, 6408.134901788246, 4338.284183109751, 4399.670024748093, 4419.977900110479, 4431.224535706238, 4431.800568974404, 4488.708233964782, 4503.774811259424, 4505.864824055284, 4506.121306345297, 4511.030128522383, 5144.4855514449, 5166.664166829144, 5170.663906846043, 5172.043172013189, 5174.068667639861, 6083.270007599116, 6147.84630384244, 6149.61633632438, 6184.979478386016, 6189.412005859436, 1558.586974451771, 1561.1803803003288, 1591.0294720220656, 1591.5623203619098, 1592.4506045414314, 1063.4948399510326, 1075.4353964168718, 1079.3200283821143, 1082.4046774274275, 1092.8852470490642, 5814.883702325929, 5821.039528477839, 5822.388649191774, 5823.708814559255, 5823.94176058234, 6317.6209427434505, 6329.715162817684, 6332.841678958063, 6333.1766870306565, 6333.619982801047, 5809.535237181015, 5825.126231065374, 5825.271841019872, 5826.475617194388, 5832.125181222766, 3328.816915069646, 3400.2179498715436, 3403.2512847173584, 3424.7260219182403, 3425.794452332868, 6568.80293591193, 6573.638449885302, 6577.934220657828, 6578.440832529289, 6587.242467116343, 6451.774187903401, 6472.385123413268, 6472.935270647327, 6476.870462590816, 6477.125588045554, 6304.18045654062, 6431.710573024132, 6449.742010319628, 6452.935470645328, 6475.384838440341, 6261.499080073674, 6297.370262973666, 6371.649559274099, 6406.487481001602, 6413.390727880844, 6323.019931910561, 6334.90497642545, 6341.334159913327, 6342.904856427065, 6347.90478142819, 6459.61242325462, 6591.571547849375, 6633.535652504278, 6638.137042184485, 6653.500987425866, 4287.871363859089, 4309.59058889405, 4310.870673879788, 4330.047389574289, 4348.978255108705, 6411.358864113551, 6418.550701450854, 6423.132877061536, 6423.4861211103935, 6428.935710642833, 6165.72254248551, 6211.223597050369, 6249.531285153541, 6255.0, 6260.373962603703, 6011.27864656244, 6228.4705800005695, 6232.18981532416, 6239.906401403891, 6245.6252624842655, 6094.54290928191, 6094.634321940698, 6094.8171554853425, 6098.817035488765, 6102.298235702773, 6242.500599952084, 6242.906356404748, 6253.937460625518, 6273.811785646438, 6278.46633036197, 5890.352061273171, 6118.969405152946, 6119.541034422525, 6121.296050954197, 6129.233845769279], "unit": "score", "name": "prototype.html", "value": 4655.983901163258}, {"lowerIsBetter": false, "replicates": [656.8719099775545, 701.4458577723599, 749.9550026998379, 765.506248469737, 814.3973459639868, 12935.0, 13099.607011789662, 13104.606861794138, 13108.0, 13111.147775394604, 12368.38158092094, 12402.193857399263, 14082.225477598728, 14184.078034927748, 14192.716145677081, 626.495670984857, 641.5893827950092, 774.9263819937097, 785.4070177016345, 786.1902240692096, 767.6890859202032, 769.1116760142045, 772.0233904111303, 780.9843803123935, 782.718221440281, 816.542736067804, 816.7386436340373, 816.8693009118542, 817.726061769308, 817.9938675429225, 673.4006734006738, 683.0846665468272, 686.993130068703, 806.7821688144227, 812.1472453923386, 601.6179725874058, 602.7649216805405, 603.9063945088518, 605.3432026251522, 606.0999415867433, 12177.878221217763, 12274.75450490994, 12338.81491777624, 12374.133810633259, 12441.315727634976, 11966.102542309362, 12122.999999999913, 12222.877771222264, 12467.376631168496, 12765.489380424771, 10069.496525173712, 10170.745731356701, 10228.386296822215, 10268.537915793808, 10355.689329320132, 3507.2985402919517, 3539.929201415983, 3621.384364657988, 3691.8523259069607, 3692.298463291993, 44733.32900006502, 45201.0, 45294.32058519125, 45599.54400455986, 45716.54283457156, 9450.385724927857, 9505.382150160218, 9566.66516671913, 9581.185599224005, 9635.710928672152, 18766.343177988703, 18932.43202703921, 18977.33579324717, 18988.715169272473, 18997.810021899604, 7532.585707786015, 7593.544387336778, 7603.0, 7750.341220996165, 7780.183080776437, 4336.132773445323, 4338.8047537860875, 4340.717853339523, 4363.170997510463, 4493.977530112394, 2914.6799127984905, 2921.109061736191, 2951.0, 2963.9110826675233, 2975.4644164050246, 552.8341497550718, 556.4602335734331, 556.6493109341089, 574.7787101965773, 579.1313030454319, 507.9187330027178, 522.8039485193052, 567.9148127780784, 615.2248167309223, 656.389557711333, 8040.597970101471, 8118.959405203054, 8319.958400208081, 8421.789455263544, 8478.152184781473, 535.9115745901961, 555.3280530557989, 614.7387360371913, 619.3806193806194, 666.4601672645173, 3634.055145662147, 3854.7879866607045, 3956.8812935611977, 3967.6032396760093, 4020.0954785173103, 53008.0, 54233.45766542363, 54330.72834635802, 54498.72750636301, 54768.72615636896, 47646.28530572044, 47864.04271914542, 52679.20981185285, 54470.72764636151, 54858.45141548613, 42472.150556989305, 42759.7862010688, 43011.139777204284, 43671.56328436675, 43803.0, 8073.19268073188, 8303.086660467223, 8405.0, 8487.702930397407, 8868.822623547363, 32010.839945801054, 32058.35883282368, 32585.0, 32848.671513284564, 33075.338493229516, 39280.410793837545, 41332.1733565321, 46474.30288545742, 46667.0, 46886.76556617195, 10127.189824814144, 10469.895301046892, 10486.737831554272, 10490.842637360292, 11060.336379817236, 11362.772744545227, 11417.143714221633, 11490.88509114898, 11583.536658533565, 11775.764484710087, 11283.605073822377, 11300.208985371273, 11401.543938242377, 11675.474603642686, 11759.000484958533, 11121.888781112086, 11216.551337946717, 11251.943740281245, 11368.658940231806, 11373.260738052331, 10334.689959300933, 10673.89326106729, 10691.411972341595, 10963.945180274048, 11148.721281968015, 9056.412850999115, 9464.384814987005, 9469.952650236704, 9488.240940724863, 9530.666426675032, 9433.811323773349, 9943.0, 10193.796124077626, 10232.23258255619, 10232.64185753495], "unit": "score", "name": "yui.html", "value": 6086.540008820553}], "name": "dromaeo_css", "value": 6595.807941560593}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 108.0, 111.0, 112.0, 112.0, 99.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 126.0, 149.0, 163.0, 122.0, 153.0, 144.0, 127.0, 162.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 142.0}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 159.0, 160.0, 161.0, 160.0, 160.0, 159.0, 160.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.2}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 84.0, 96.0, 73.0, 72.0, 71.0, 110.0, 90.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.3}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 136.0, 96.0, 96.0, 95.0, 136.0, 97.0, 96.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 108.6}, {"lowerIsBetter": true, "replicates": [108.0, 109.0, 109.0, 109.0, 109.0, 108.0, 108.0, 109.0, 109.0, 108.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.6}, {"lowerIsBetter": true, "replicates": [148.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 56.0, 56.0, 55.0, 56.0, 55.0, 63.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.8}, {"lowerIsBetter": true, "replicates": [84.0, 87.0, 85.0, 84.0, 85.0, 84.0, 85.0, 85.0, 84.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.9}, {"lowerIsBetter": true, "replicates": [119.0, 125.0, 126.0, 116.0, 128.0, 119.0, 115.0, 117.0, 123.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.6}, {"lowerIsBetter": true, "replicates": [139.0, 142.0, 147.0, 148.0, 155.0, 140.0, 152.0, 154.0, 154.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.0}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 67.0, 68.0, 70.0, 66.0, 66.0, 68.0, 66.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1494.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.2127659574468], "unit": "score", "name": "Richards", "value": 207.39925000000005}, {"lowerIsBetter": false, "replicates": [189.17896329928112], "unit": "score", "name": "DeltaBlue", "value": 349.49974799999995}, {"lowerIsBetter": false, "replicates": [280.2690582959641], "unit": "score", "name": "Encrypt", "value": 949.7338080000005}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [1131.2217194570135], "unit": "score", "name": "RayTrace", "value": 654.1502760000003}, {"lowerIsBetter": false, "replicates": [784.3137254901961], "unit": "score", "name": "Earley", "value": 849.7403250000002}, {"lowerIsBetter": false, "replicates": [12265.060240963856], "unit": "score", "name": "Boyer", "value": 54.338338899803546}, {"lowerIsBetter": false, "replicates": [42936.17021276596], "unit": "score", "name": "RegExp", "value": 21.21719276511396}, {"lowerIsBetter": false, "replicates": [574.3825387708214], "unit": "score", "name": "Splay", "value": 141.87583100000003}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20045.222189610155}]} 17:16:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20045.22"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1494.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6595.81"}}} 17:16:42 INFO - Return code: 0 17:16:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:16:42 INFO - # TBPL SUCCESS # 17:16:42 INFO - Running post-action listener: _resource_record_post_action 17:16:42 INFO - Running post-run listener: _resource_record_post_run 17:16:43 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 10354688; Write bytes: 519888896; Read time: 1856; Write time: 435624 17:16:43 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 157720576; Read time: 0; Write time: 139876 17:16:43 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 8593408; Write bytes: 358645760; Read time: 1808; Write time: 290904 17:16:43 INFO - Running post-run listener: _upload_blobber_files 17:16:43 INFO - Blob upload gear active. 17:16:43 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:16:43 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:16:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:16:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:16:43 INFO - (blobuploader) - INFO - Open directory for files ... 17:16:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:16:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:16:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:44 INFO - (blobuploader) - INFO - Done attempting. 17:16:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:16:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:16:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:45 INFO - (blobuploader) - INFO - Done attempting. 17:16:45 INFO - (blobuploader) - INFO - Iteration through files over. 17:16:45 INFO - Return code: 0 17:16:45 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:16:45 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:16:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ddf2473b232aab06e15bbb771d2e1a25516f43ca5e7a899a4df7e87e086b42121b626d832404ff5a483bec5837532082a77d04227471906c9861c2fda53d5ce2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9388d4bcf64895011d8370440a53d151a5870b529e95fbedd70ccaef6696b765377d54e895e48900b1cc1205263f68bc8b3c67e0460dffb8a0ab347f895dd9d5"} 17:16:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:16:45 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:16:45 INFO - Contents: 17:16:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ddf2473b232aab06e15bbb771d2e1a25516f43ca5e7a899a4df7e87e086b42121b626d832404ff5a483bec5837532082a77d04227471906c9861c2fda53d5ce2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9388d4bcf64895011d8370440a53d151a5870b529e95fbedd70ccaef6696b765377d54e895e48900b1cc1205263f68bc8b3c67e0460dffb8a0ab347f895dd9d5"} 17:16:45 INFO - Copying logs to upload dir... 17:16:45 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1274.699207 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-09 17:16:45.182228) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-09 17:16:45.185885) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1452386086.182034-1746839971 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/ddf2473b232aab06e15bbb771d2e1a25516f43ca5e7a899a4df7e87e086b42121b626d832404ff5a483bec5837532082a77d04227471906c9861c2fda53d5ce2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9388d4bcf64895011d8370440a53d151a5870b529e95fbedd70ccaef6696b765377d54e895e48900b1cc1205263f68bc8b3c67e0460dffb8a0ab347f895dd9d5"} build_url:https://queue.taskcluster.net/v1/task/PsQNoNh0SWas6PtN1MHBzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011173 build_url: 'https://queue.taskcluster.net/v1/task/PsQNoNh0SWas6PtN1MHBzA/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/ddf2473b232aab06e15bbb771d2e1a25516f43ca5e7a899a4df7e87e086b42121b626d832404ff5a483bec5837532082a77d04227471906c9861c2fda53d5ce2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9388d4bcf64895011d8370440a53d151a5870b529e95fbedd70ccaef6696b765377d54e895e48900b1cc1205263f68bc8b3c67e0460dffb8a0ab347f895dd9d5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-09 17:16:45.209984) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 17:16:45.210283) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1452386086.182034-1746839971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004418 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 17:16:45.296214) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-09 17:16:45.296524) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-09 17:16:45.296802) ========= ========= Total master_lag: 0.21 =========