builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1450983505.96 results: success (0) buildid: 20151224083107 builduid: 8ebe2dd669204f40a2735f0cac6ac1c0 revision: 0f9649cb1feee315d7cc11eee4f4756ec79cd18a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-24 10:58:25.956384) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-24 10:58:25.956861) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-24 10:58:25.957156) ========= 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=0ae9de487587ba4b94dd3100000001b5-1450983507.314307-1134351290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006188 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-24 10:58:25.979887) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-24 10:58:25.980216) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-24 10:58:25.993479) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 10:58:25.993883) ========= 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=0ae9de487587ba4b94dd3100000001b5-1450983507.314307-1134351290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 10:58:26.042932) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-24 10:58:26.043237) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-24 10:58:26.043620) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 10:58:26.043906) ========= 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=0ae9de487587ba4b94dd3100000001b5-1450983507.314307-1134351290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-24 10:58:28-- 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% 43.6M=0s 2015-12-24 10:58:28 (43.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169635 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 10:58:26.225795) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 10:58:26.226106) ========= 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=0ae9de487587ba4b94dd3100000001b5-1450983507.314307-1134351290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014960 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 10:58:26.275464) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 10:58:26.275828) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0f9649cb1feee315d7cc11eee4f4756ec79cd18a --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 0f9649cb1feee315d7cc11eee4f4756ec79cd18a --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=0ae9de487587ba4b94dd3100000001b5-1450983507.314307-1134351290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-24 10:58:28,297 truncating revision to first 12 chars 2015-12-24 10:58:28,297 Setting DEBUG logging. 2015-12-24 10:58:28,297 attempt 1/10 2015-12-24 10:58:28,297 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0f9649cb1fee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-24 10:58:28,637 unpacking tar archive at: fx-team-0f9649cb1fee/testing/mozharness/ program finished with exit code 0 elapsedTime=0.647530 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 10:58:26.936078) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-24 10:58:26.936516) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-24 10:58:26.944473) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-24 10:58:26.944859) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-24 10:58:26.945328) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-24 10:58:26.945614) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --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', '--system-bits', '64', '--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=0ae9de487587ba4b94dd3100000001b5-1450983507.314307-1134351290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:58:29 INFO - MultiFileLogger online at 20151224 10:58:29 in /builds/slave/test-pgo 10:58:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:58:29 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:58:29 INFO - {'append_to_log': False, 10:58:29 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:58:29 INFO - 'blob_upload_branch': 'Fx-Team', 10:58:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:58:29 INFO - 'branch': 'Fx-Team', 10:58:29 INFO - 'buildbot_json_path': 'buildprops.json', 10:58:29 INFO - 'config_files': ('talos/linux_config.py',), 10:58:29 INFO - 'default_actions': ('clobber', 10:58:29 INFO - 'read-buildbot-config', 10:58:29 INFO - 'download-and-extract', 10:58:29 INFO - 'populate-webroot', 10:58:29 INFO - 'create-virtualenv', 10:58:29 INFO - 'install', 10:58:29 INFO - 'run-tests'), 10:58:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:58:29 INFO - 'download_minidump_stackwalk': True, 10:58:29 INFO - 'download_symbols': 'ondemand', 10:58:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:58:29 INFO - 'tooltool.py': '/tools/tooltool.py', 10:58:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:58:29 INFO - '/tools/misc-python/virtualenv.py')}, 10:58:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:58:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:58:29 INFO - 'installer_path': 'installer.exe', 10:58:29 INFO - 'log_level': 'info', 10:58:29 INFO - 'log_name': 'talos', 10:58:29 INFO - 'log_to_console': True, 10:58:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:58:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:58:29 INFO - 'opt_config_files': (), 10:58:29 INFO - 'pip_index': False, 10:58:29 INFO - 'sps_profile': False, 10:58:29 INFO - 'sps_profile_interval': 0, 10:58:29 INFO - 'suite': 'dromaeojs', 10:58:29 INFO - 'system_bits': '64', 10:58:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:58:29 INFO - 'title': 'talos-linux64-ix-056', 10:58:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:58:29 INFO - 'use_talos_json': True, 10:58:29 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:58:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:58:29 INFO - 'work_dir': 'build'} 10:58:29 INFO - ##### 10:58:29 INFO - ##### Running clobber step. 10:58:29 INFO - ##### 10:58:29 INFO - Running pre-action listener: _resource_record_pre_action 10:58:29 INFO - Running main action method: clobber 10:58:29 INFO - rmtree: /builds/slave/test-pgo/build 10:58:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:58:29 INFO - Running post-action listener: _resource_record_post_action 10:58:29 INFO - ##### 10:58:29 INFO - ##### Running read-buildbot-config step. 10:58:29 INFO - ##### 10:58:29 INFO - Running pre-action listener: _resource_record_pre_action 10:58:29 INFO - Running main action method: read_buildbot_config 10:58:29 INFO - Using buildbot properties: 10:58:29 INFO - { 10:58:29 INFO - "project": "", 10:58:29 INFO - "product": "firefox", 10:58:29 INFO - "script_repo_revision": "production", 10:58:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:58:29 INFO - "repository": "", 10:58:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 10:58:29 INFO - "buildid": "20151224083107", 10:58:29 INFO - "pgo_build": "True", 10:58:29 INFO - "basedir": "/builds/slave/test-pgo", 10:58:29 INFO - "buildnumber": 385, 10:58:29 INFO - "slavename": "talos-linux64-ix-056", 10:58:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:58:29 INFO - "platform": "ubuntu64_hw", 10:58:29 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:58:29 INFO - "branch": "fx-team", 10:58:29 INFO - "repo_path": "integration/fx-team", 10:58:29 INFO - "revision": "0f9649cb1feee315d7cc11eee4f4756ec79cd18a", 10:58:29 INFO - "stage_platform": "linux64-pgo", 10:58:29 INFO - "builduid": "8ebe2dd669204f40a2735f0cac6ac1c0", 10:58:29 INFO - "slavebuilddir": "test" 10:58:29 INFO - } 10:58:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:58:29 INFO - Running post-action listener: _resource_record_post_action 10:58:29 INFO - ##### 10:58:29 INFO - ##### Running download-and-extract step. 10:58:29 INFO - ##### 10:58:29 INFO - Running pre-action listener: _resource_record_pre_action 10:58:29 INFO - Running main action method: download_and_extract 10:58:29 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:29 INFO - https://queue.taskcluster.net/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:58:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/test_packages.json 10:58:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/test_packages.json 10:58:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:58:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:58:30 INFO - Downloaded 1302 bytes. 10:58:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:58:30 INFO - Using the following test package requirements: 10:58:30 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:58:30 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:58:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:58:30 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:58:30 INFO - u'jsshell-linux-x86_64.zip'], 10:58:30 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:58:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:58:30 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:58:30 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:58:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:58:30 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:58:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:58:30 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:58:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:58:30 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:58:30 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:58:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:58:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:30 INFO - https://queue.taskcluster.net/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:58:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:58:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:58:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/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 10:58:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/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 10:58:31 INFO - Downloaded 23183082 bytes. 10:58:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:58:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:58:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:58:32 INFO - Return code: 0 10:58:32 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 10:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:32 INFO - https://queue.taskcluster.net/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:58:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:58:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:58:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/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 10:58:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/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 10:58:33 INFO - Downloaded 23183082 bytes. 10:58:33 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 10:58:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:58:33 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 10:58:34 INFO - Return code: 0 10:58: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')]} 10:58:34 INFO - https://queue.taskcluster.net/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:58:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:58:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:58:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/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 10:58:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/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 10:58:35 INFO - Downloaded 11132277 bytes. 10:58:35 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 10:58:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:58:35 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 10:58:35 INFO - Return code: 0 10:58: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')]} 10:58:35 INFO - https://queue.taskcluster.net/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:58:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:58:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:58:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/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 10:58:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/l4l_G2N7TNWe9diKDRxaaA/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 10:58:37 INFO - Downloaded 54882716 bytes. 10:58:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:58:37 INFO - mkdir: /builds/slave/test-pgo/properties 10:58:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:58:37 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:58:37 INFO - Contents: 10:58:37 INFO - build_url:https://queue.taskcluster.net/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:58:37 INFO - Running post-action listener: _resource_record_post_action 10:58:37 INFO - Running post-action listener: set_extra_try_arguments 10:58:37 INFO - ##### 10:58:37 INFO - ##### Running populate-webroot step. 10:58:37 INFO - ##### 10:58:37 INFO - Running pre-action listener: _resource_record_pre_action 10:58:37 INFO - Running main action method: populate_webroot 10:58:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:58:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:58:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:58:37 INFO - '--tppagecycles', 10:58:37 INFO - '7'], 10:58:37 INFO - 'tests': ['tsvgm']}}, 10:58:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:58:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:58:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:58:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:58:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:58:37 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:58:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:58:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:37 INFO - 'talos_options': ['--e10s'], 10:58:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:58:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:37 INFO - 'tests': ['damp', 'tps']}, 10:58:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:37 INFO - 'talos_options': ['--e10s'], 10:58:37 INFO - 'tests': ['damp', 'tps']}, 10:58:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:58:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:58:37 INFO - 'other': {'tests': ['a11yr', 10:58:37 INFO - 'ts_paint', 10:58:37 INFO - 'tpaint', 10:58:37 INFO - 'sessionrestore', 10:58:37 INFO - 'sessionrestore_no_auto_restore']}, 10:58:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:58:37 INFO - 'tests': ['a11yr', 10:58:37 INFO - 'ts_paint', 10:58:37 INFO - 'tpaint', 10:58:37 INFO - 'sessionrestore', 10:58:37 INFO - 'sessionrestore_no_auto_restore']}, 10:58:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:58:37 INFO - 'tests': ['a11yr', 10:58:37 INFO - 'ts_paint', 10:58:37 INFO - 'tpaint', 10:58:37 INFO - 'sessionrestore', 10:58:37 INFO - 'sessionrestore_no_auto_restore']}, 10:58:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:58:37 INFO - 'tests': ['a11yr', 10:58:37 INFO - 'ts_paint', 10:58:37 INFO - 'tpaint', 10:58:37 INFO - 'sessionrestore', 10:58:37 INFO - 'sessionrestore_no_auto_restore']}, 10:58:37 INFO - 'other_l64': {'tests': ['a11yr', 10:58:37 INFO - 'ts_paint', 10:58:37 INFO - 'tpaint', 10:58:37 INFO - 'sessionrestore', 10:58:37 INFO - 'sessionrestore_no_auto_restore']}, 10:58:37 INFO - 'other_nol64': {'tests': ['a11yr', 10:58:37 INFO - 'ts_paint', 10:58:37 INFO - 'tpaint', 10:58:37 INFO - 'sessionrestore', 10:58:37 INFO - 'sessionrestore_no_auto_restore']}, 10:58:37 INFO - 'svgr': {'tests': ['tsvgx', 10:58:37 INFO - 'tsvgr_opacity', 10:58:37 INFO - 'tart', 10:58:37 INFO - 'tscrollx', 10:58:37 INFO - 'cart']}, 10:58:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:58:37 INFO - 'tests': ['tsvgx', 10:58:37 INFO - 'tsvgr_opacity', 10:58:37 INFO - 'tart', 10:58:37 INFO - 'tscrollx', 10:58:37 INFO - 'cart']}, 10:58:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:37 INFO - 'tests': ['tp5o']}, 10:58:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:37 INFO - 'talos_options': ['--e10s'], 10:58:37 INFO - 'tests': ['tp5o']}, 10:58:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:37 INFO - 'talos_options': ['--xperf_path', 10:58:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:58:37 INFO - 'tests': ['tp5n']}, 10:58:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:37 INFO - 'talos_options': ['--e10s', 10:58:37 INFO - '--xperf_path', 10:58:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:58:37 INFO - 'tests': ['tp5n']}}, 10:58:37 INFO - 'talos.zip': {'path': '', 10:58:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:58:37 INFO - Running post-action listener: _resource_record_post_action 10:58:37 INFO - ##### 10:58:37 INFO - ##### Running create-virtualenv step. 10:58:37 INFO - ##### 10:58:37 INFO - Running pre-action listener: _resource_record_pre_action 10:58:37 INFO - Running main action method: create_virtualenv 10:58:37 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:58:37 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 10:58:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:58:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:58:37 INFO - Using real prefix '/usr' 10:58:37 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:58:37 INFO - Installing distribute.............................................................................................................................................................................................done. 10:58:39 INFO - Installing pip.................done. 10:58:39 INFO - Return code: 0 10:58:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:58:39 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')]} 10:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:39 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')]} 10:58:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:39 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 0x7fd462157f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f0840>, '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 0x185d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185db60>, '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': '0ae9de487587ba4b94dd3100000001b5-1450983507.314307-1134351290', '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 10:58:39 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 10:58:39 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 10:58:39 INFO - Using env: {'DISPLAY': ':0', 10:58:39 INFO - 'HOME': '/home/cltbld', 10:58:39 INFO - 'LANG': 'en_US.UTF-8', 10:58:39 INFO - 'LANGUAGE': 'en_US:en', 10:58:39 INFO - 'LOGNAME': 'cltbld', 10:58:39 INFO - 'MAIL': '/var/mail/cltbld', 10:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:39 INFO - 'MOZ_NO_REMOTE': '1', 10:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:39 INFO - 'NO_EM_RESTART': '1', 10:58:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:58:39 INFO - 'PWD': '/builds/slave/test-pgo', 10:58:39 INFO - 'SHELL': '/bin/bash', 10:58:39 INFO - 'SHLVL': '1', 10:58:39 INFO - 'TERM': 'linux', 10:58:39 INFO - 'TMOUT': '86400', 10:58:39 INFO - 'USER': 'cltbld', 10:58:39 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450983507.314307-1134351290', 10:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:39 INFO - '_': '/tools/buildbot/bin/python'} 10:58:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:39 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 10:58:39 INFO - Cleaning up... 10:58:39 INFO - Return code: 0 10:58:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:58:39 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')]} 10:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:39 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')]} 10:58:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:39 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 0x7fd462157f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f0840>, '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 0x185d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185db60>, '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': '0ae9de487587ba4b94dd3100000001b5-1450983507.314307-1134351290', '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 10:58:39 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 10:58:39 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 10:58:39 INFO - Using env: {'DISPLAY': ':0', 10:58:39 INFO - 'HOME': '/home/cltbld', 10:58:39 INFO - 'LANG': 'en_US.UTF-8', 10:58:39 INFO - 'LANGUAGE': 'en_US:en', 10:58:39 INFO - 'LOGNAME': 'cltbld', 10:58:39 INFO - 'MAIL': '/var/mail/cltbld', 10:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:39 INFO - 'MOZ_NO_REMOTE': '1', 10:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:39 INFO - 'NO_EM_RESTART': '1', 10:58:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:58:39 INFO - 'PWD': '/builds/slave/test-pgo', 10:58:39 INFO - 'SHELL': '/bin/bash', 10:58:39 INFO - 'SHLVL': '1', 10:58:39 INFO - 'TERM': 'linux', 10:58:39 INFO - 'TMOUT': '86400', 10:58:39 INFO - 'USER': 'cltbld', 10:58:39 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450983507.314307-1134351290', 10:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:39 INFO - '_': '/tools/buildbot/bin/python'} 10:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:40 INFO - Downloading/unpacking psutil>=0.7.1 10:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:41 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:58:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:58:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:58:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:58:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:58:41 INFO - Installing collected packages: psutil 10:58:41 INFO - Running setup.py install for psutil 10:58:41 INFO - building 'psutil._psutil_linux' extension 10:58:41 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 10:58:42 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 10:58:42 INFO - building 'psutil._psutil_posix' extension 10:58:42 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 10:58:42 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 10:58:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:58:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:58:42 INFO - Successfully installed psutil 10:58:42 INFO - Cleaning up... 10:58:42 INFO - Return code: 0 10:58:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd462157f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f0840>, '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 0x185d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185db60>, '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': '0ae9de487587ba4b94dd3100000001b5-1450983507.314307-1134351290', '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 10:58:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:58:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:58:42 INFO - Using env: {'DISPLAY': ':0', 10:58:42 INFO - 'HOME': '/home/cltbld', 10:58:42 INFO - 'LANG': 'en_US.UTF-8', 10:58:42 INFO - 'LANGUAGE': 'en_US:en', 10:58:42 INFO - 'LOGNAME': 'cltbld', 10:58:42 INFO - 'MAIL': '/var/mail/cltbld', 10:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:42 INFO - 'MOZ_NO_REMOTE': '1', 10:58:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:42 INFO - 'NO_EM_RESTART': '1', 10:58:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:58:42 INFO - 'PWD': '/builds/slave/test-pgo', 10:58:42 INFO - 'SHELL': '/bin/bash', 10:58:42 INFO - 'SHLVL': '1', 10:58:42 INFO - 'TERM': 'linux', 10:58:42 INFO - 'TMOUT': '86400', 10:58:42 INFO - 'USER': 'cltbld', 10:58:42 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450983507.314307-1134351290', 10:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:42 INFO - '_': '/tools/buildbot/bin/python'} 10:58:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:58:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:58:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:58:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:58:44 INFO - Installing collected packages: mozsystemmonitor 10:58:44 INFO - Running setup.py install for mozsystemmonitor 10:58:44 INFO - Successfully installed mozsystemmonitor 10:58:44 INFO - Cleaning up... 10:58:44 INFO - Return code: 0 10:58:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:58: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')]} 10:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58: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')]} 10:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:44 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 0x7fd462157f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f0840>, '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 0x185d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185db60>, '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': '0ae9de487587ba4b94dd3100000001b5-1450983507.314307-1134351290', '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 10:58:44 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 10:58:44 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 10:58:44 INFO - Using env: {'DISPLAY': ':0', 10:58:44 INFO - 'HOME': '/home/cltbld', 10:58:44 INFO - 'LANG': 'en_US.UTF-8', 10:58:44 INFO - 'LANGUAGE': 'en_US:en', 10:58:44 INFO - 'LOGNAME': 'cltbld', 10:58:44 INFO - 'MAIL': '/var/mail/cltbld', 10:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:44 INFO - 'MOZ_NO_REMOTE': '1', 10:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:44 INFO - 'NO_EM_RESTART': '1', 10:58:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:58:44 INFO - 'PWD': '/builds/slave/test-pgo', 10:58:44 INFO - 'SHELL': '/bin/bash', 10:58:44 INFO - 'SHLVL': '1', 10:58:44 INFO - 'TERM': 'linux', 10:58:44 INFO - 'TMOUT': '86400', 10:58:44 INFO - 'USER': 'cltbld', 10:58:44 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450983507.314307-1134351290', 10:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:44 INFO - '_': '/tools/buildbot/bin/python'} 10:58:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:44 INFO - Downloading/unpacking blobuploader==1.2.4 10:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:46 INFO - Downloading blobuploader-1.2.4.tar.gz 10:58:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:58:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:58:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:58:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:58:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:47 INFO - Downloading docopt-0.6.1.tar.gz 10:58:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:58:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:58:47 INFO - Installing collected packages: blobuploader, requests, docopt 10:58:47 INFO - Running setup.py install for blobuploader 10:58:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:58:47 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:58:47 INFO - Running setup.py install for requests 10:58:47 INFO - Running setup.py install for docopt 10:58:47 INFO - Successfully installed blobuploader requests docopt 10:58:47 INFO - Cleaning up... 10:58:47 INFO - Return code: 0 10:58:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:58:47 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')]} 10:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:47 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')]} 10:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:47 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 0x7fd462157f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f0840>, '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 0x185d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185db60>, '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': '0ae9de487587ba4b94dd3100000001b5-1450983507.314307-1134351290', '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 10:58:47 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 10:58:47 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 10:58:47 INFO - Using env: {'DISPLAY': ':0', 10:58:47 INFO - 'HOME': '/home/cltbld', 10:58:47 INFO - 'LANG': 'en_US.UTF-8', 10:58:47 INFO - 'LANGUAGE': 'en_US:en', 10:58:47 INFO - 'LOGNAME': 'cltbld', 10:58:47 INFO - 'MAIL': '/var/mail/cltbld', 10:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:47 INFO - 'MOZ_NO_REMOTE': '1', 10:58:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:47 INFO - 'NO_EM_RESTART': '1', 10:58:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:58:47 INFO - 'PWD': '/builds/slave/test-pgo', 10:58:47 INFO - 'SHELL': '/bin/bash', 10:58:47 INFO - 'SHLVL': '1', 10:58:47 INFO - 'TERM': 'linux', 10:58:47 INFO - 'TMOUT': '86400', 10:58:47 INFO - 'USER': 'cltbld', 10:58:47 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450983507.314307-1134351290', 10:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:47 INFO - '_': '/tools/buildbot/bin/python'} 10:58:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:58:47 INFO - Running setup.py (path:/tmp/pip-gKWD2y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:58:47 INFO - Running setup.py (path:/tmp/pip-_MBIf5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:58:48 INFO - Running setup.py (path:/tmp/pip-yslfG7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:58:48 INFO - Running setup.py (path:/tmp/pip-HhBGhe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:58:48 INFO - Running setup.py (path:/tmp/pip-Omj703-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:58:48 INFO - Running setup.py (path:/tmp/pip-jnkgEn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:58:48 INFO - Running setup.py (path:/tmp/pip-F6Y9bK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:58:48 INFO - Running setup.py (path:/tmp/pip-pzByks-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:58:48 INFO - Running setup.py (path:/tmp/pip-nd3qDp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:58:48 INFO - Running setup.py (path:/tmp/pip-4PbrWm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:58:48 INFO - Running setup.py (path:/tmp/pip-HIvcpp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:58:48 INFO - Running setup.py (path:/tmp/pip-lEWYhS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:58:48 INFO - Running setup.py (path:/tmp/pip-AKvy54-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:58:48 INFO - Running setup.py (path:/tmp/pip-hF328s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:58:48 INFO - Running setup.py (path:/tmp/pip-2DvSJo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:58:48 INFO - Running setup.py (path:/tmp/pip-i4dYSl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:58:49 INFO - Running setup.py (path:/tmp/pip-Fup08Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:58:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:58:49 INFO - Running setup.py install for manifestparser 10:58:49 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:58:49 INFO - Running setup.py install for mozcrash 10:58:49 INFO - Running setup.py install for mozdebug 10:58:49 INFO - Running setup.py install for mozdevice 10:58:49 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:58:49 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:58:49 INFO - Running setup.py install for mozfile 10:58:49 INFO - Running setup.py install for mozhttpd 10:58:49 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:58:49 INFO - Running setup.py install for mozinfo 10:58:49 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:58:49 INFO - Running setup.py install for mozInstall 10:58:49 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:58:49 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:58:49 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:58:49 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:58:49 INFO - Running setup.py install for mozleak 10:58:50 INFO - Running setup.py install for mozlog 10:58:50 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:58:50 INFO - Running setup.py install for moznetwork 10:58:50 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:58:50 INFO - Running setup.py install for mozprocess 10:58:50 INFO - Running setup.py install for mozprofile 10:58:50 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:58:50 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:58:50 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:58:50 INFO - Running setup.py install for mozrunner 10:58:50 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:58:50 INFO - Running setup.py install for mozscreenshot 10:58:50 INFO - Running setup.py install for moztest 10:58:50 INFO - Running setup.py install for mozversion 10:58:50 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:58:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:58:50 INFO - Cleaning up... 10:58:50 INFO - Return code: 0 10:58:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:58:50 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')]} 10:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:50 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')]} 10:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:50 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 0x7fd462157f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f0840>, '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 0x185d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185db60>, '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': '0ae9de487587ba4b94dd3100000001b5-1450983507.314307-1134351290', '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 10:58:50 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 10:58:50 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 10:58:50 INFO - Using env: {'DISPLAY': ':0', 10:58:50 INFO - 'HOME': '/home/cltbld', 10:58:50 INFO - 'LANG': 'en_US.UTF-8', 10:58:50 INFO - 'LANGUAGE': 'en_US:en', 10:58:50 INFO - 'LOGNAME': 'cltbld', 10:58:50 INFO - 'MAIL': '/var/mail/cltbld', 10:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:50 INFO - 'MOZ_NO_REMOTE': '1', 10:58:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:50 INFO - 'NO_EM_RESTART': '1', 10:58:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:58:50 INFO - 'PWD': '/builds/slave/test-pgo', 10:58:50 INFO - 'SHELL': '/bin/bash', 10:58:50 INFO - 'SHLVL': '1', 10:58:50 INFO - 'TERM': 'linux', 10:58:50 INFO - 'TMOUT': '86400', 10:58:50 INFO - 'USER': 'cltbld', 10:58:50 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450983507.314307-1134351290', 10:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:50 INFO - '_': '/tools/buildbot/bin/python'} 10:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:58:51 INFO - Running setup.py (path:/tmp/pip-1RSQz3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:58:51 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)) 10:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:58:51 INFO - Running setup.py (path:/tmp/pip-xGaNYl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:58:51 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)) 10:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:58:51 INFO - Running setup.py (path:/tmp/pip-7aIsvy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:58:51 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)) 10:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:58:51 INFO - Running setup.py (path:/tmp/pip-Xxb8u_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:58:51 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)) 10:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:58:51 INFO - Running setup.py (path:/tmp/pip-7KI7In-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:58:51 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)) 10:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:58:51 INFO - Running setup.py (path:/tmp/pip-14AsRR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:58:51 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)) 10:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:58:51 INFO - Running setup.py (path:/tmp/pip-GApAKq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:58:51 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)) 10:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:58:51 INFO - Running setup.py (path:/tmp/pip-twmvC8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:58:51 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)) 10:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:58:51 INFO - Running setup.py (path:/tmp/pip-GnIClG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:58:51 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)) 10:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:58:51 INFO - Running setup.py (path:/tmp/pip-vjDwqS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:58:51 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)) 10:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:58:51 INFO - Running setup.py (path:/tmp/pip-ZTg8BO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:58:51 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)) 10:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:58:51 INFO - Running setup.py (path:/tmp/pip-pMALC9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:58:52 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)) 10:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:58:52 INFO - Running setup.py (path:/tmp/pip-wREB5Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:58:52 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)) 10:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:58:52 INFO - Running setup.py (path:/tmp/pip-MQwJju-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:58:52 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)) 10:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:58:52 INFO - Running setup.py (path:/tmp/pip-nQxRh1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:58:52 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)) 10:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:58:52 INFO - Running setup.py (path:/tmp/pip-KjKMlH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:58:52 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)) 10:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:58:52 INFO - Running setup.py (path:/tmp/pip-qL89q7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:58:52 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)) 10:58:52 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)) 10:58:52 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)) 10:58:52 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)) 10:58:52 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)) 10:58:52 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)) 10:58:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:58:52 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 10:58:52 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 10:58:52 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 10:58:52 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 10:58:52 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 10:58:52 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 10:58:54 INFO - Downloading blessings-1.5.1.tar.gz 10:58:54 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 10:58:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:58:54 INFO - Installing collected packages: blessings 10:58:54 INFO - Running setup.py install for blessings 10:58:54 INFO - Successfully installed blessings 10:58:54 INFO - Cleaning up... 10:58:54 INFO - Return code: 0 10:58:54 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:58:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:58:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:58:54 INFO - Reading from file tmpfile_stdout 10:58:54 INFO - Current package versions: 10:58:54 INFO - argparse == 1.2.1 10:58:54 INFO - blessings == 1.5.1 10:58:54 INFO - blobuploader == 1.2.4 10:58:54 INFO - docopt == 0.6.1 10:58:54 INFO - manifestparser == 1.1 10:58:54 INFO - mozInstall == 1.12 10:58:54 INFO - mozcrash == 0.16 10:58:54 INFO - mozdebug == 0.1 10:58:54 INFO - mozdevice == 0.47 10:58:54 INFO - mozfile == 1.2 10:58:54 INFO - mozhttpd == 0.7 10:58:54 INFO - mozinfo == 0.9 10:58:54 INFO - mozleak == 0.1 10:58:54 INFO - mozlog == 3.1 10:58:54 INFO - moznetwork == 0.27 10:58:54 INFO - mozprocess == 0.22 10:58:54 INFO - mozprofile == 0.28 10:58:54 INFO - mozrunner == 6.11 10:58:54 INFO - mozscreenshot == 0.1 10:58:54 INFO - mozsystemmonitor == 0.0 10:58:54 INFO - moztest == 0.7 10:58:54 INFO - mozversion == 1.4 10:58:54 INFO - psutil == 3.1.1 10:58:54 INFO - requests == 1.2.3 10:58:54 INFO - wsgiref == 0.1.2 10:58:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fd462157f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f0840>, '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 0x185d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185db60>, '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': '0ae9de487587ba4b94dd3100000001b5-1450983507.314307-1134351290', '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 10:58:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 10:58:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 10:58:54 INFO - Using env: {'DISPLAY': ':0', 10:58:54 INFO - 'HOME': '/home/cltbld', 10:58:54 INFO - 'LANG': 'en_US.UTF-8', 10:58:54 INFO - 'LANGUAGE': 'en_US:en', 10:58:54 INFO - 'LOGNAME': 'cltbld', 10:58:54 INFO - 'MAIL': '/var/mail/cltbld', 10:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:54 INFO - 'MOZ_NO_REMOTE': '1', 10:58:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:54 INFO - 'NO_EM_RESTART': '1', 10:58:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:58:54 INFO - 'PWD': '/builds/slave/test-pgo', 10:58:54 INFO - 'SHELL': '/bin/bash', 10:58:54 INFO - 'SHLVL': '1', 10:58:54 INFO - 'TERM': 'linux', 10:58:54 INFO - 'TMOUT': '86400', 10:58:54 INFO - 'USER': 'cltbld', 10:58:54 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450983507.314307-1134351290', 10:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:54 INFO - '_': '/tools/buildbot/bin/python'} 10:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:54 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)) 10:58:54 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)) 10:58:54 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)) 10:58:54 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)) 10:58:54 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)) 10:58:54 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)) 10:58:54 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)) 10:58:54 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)) 10:58:54 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)) 10:58:54 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)) 10:58:54 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)) 10:58:54 INFO - Cleaning up... 10:58:54 INFO - Return code: 0 10:58:54 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fd462157f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f0840>, '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 0x185d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185db60>, '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': '0ae9de487587ba4b94dd3100000001b5-1450983507.314307-1134351290', '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 10:58:54 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 10:58:54 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 10:58:54 INFO - Using env: {'DISPLAY': ':0', 10:58:54 INFO - 'HOME': '/home/cltbld', 10:58:54 INFO - 'LANG': 'en_US.UTF-8', 10:58:54 INFO - 'LANGUAGE': 'en_US:en', 10:58:54 INFO - 'LOGNAME': 'cltbld', 10:58:54 INFO - 'MAIL': '/var/mail/cltbld', 10:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:54 INFO - 'MOZ_NO_REMOTE': '1', 10:58:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:54 INFO - 'NO_EM_RESTART': '1', 10:58:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:58:54 INFO - 'PWD': '/builds/slave/test-pgo', 10:58:54 INFO - 'SHELL': '/bin/bash', 10:58:54 INFO - 'SHLVL': '1', 10:58:54 INFO - 'TERM': 'linux', 10:58:54 INFO - 'TMOUT': '86400', 10:58:54 INFO - 'USER': 'cltbld', 10:58:54 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450983507.314307-1134351290', 10:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:54 INFO - '_': '/tools/buildbot/bin/python'} 10:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:54 INFO - Downloading/unpacking jsonschema 10:58:54 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 10:58:54 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 10:58:54 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 10:58:54 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 10:58:54 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 10:58:54 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 10:58:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:58:56 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 10:58:56 INFO - Downloading/unpacking functools32 (from jsonschema) 10:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:56 INFO - Downloading functools32-3.2.3-2.tar.gz 10:58:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:58:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:58:56 INFO - warning: no files found matching '*.txt' 10:58:56 INFO - no previously-included directories found matching 'build' 10:58:56 INFO - no previously-included directories found matching 'dist' 10:58:56 INFO - no previously-included directories found matching '.git*' 10:58:56 INFO - Installing collected packages: jsonschema, functools32 10:58:56 INFO - Running setup.py install for functools32 10:58:57 INFO - warning: no files found matching '*.txt' 10:58:57 INFO - no previously-included directories found matching 'build' 10:58:57 INFO - no previously-included directories found matching 'dist' 10:58:57 INFO - no previously-included directories found matching '.git*' 10:58:57 INFO - Successfully installed jsonschema functools32 10:58:57 INFO - Cleaning up... 10:58:57 INFO - Return code: 0 10:58:57 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:58:57 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')]} 10:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:57 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')]} 10:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:57 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 0x7fd462157f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f0840>, '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 0x185d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185db60>, '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': '0ae9de487587ba4b94dd3100000001b5-1450983507.314307-1134351290', '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 10:58:57 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 10:58:57 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 10:58:57 INFO - Using env: {'DISPLAY': ':0', 10:58:57 INFO - 'HOME': '/home/cltbld', 10:58:57 INFO - 'LANG': 'en_US.UTF-8', 10:58:57 INFO - 'LANGUAGE': 'en_US:en', 10:58:57 INFO - 'LOGNAME': 'cltbld', 10:58:57 INFO - 'MAIL': '/var/mail/cltbld', 10:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:57 INFO - 'MOZ_NO_REMOTE': '1', 10:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:57 INFO - 'NO_EM_RESTART': '1', 10:58:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:58:57 INFO - 'PWD': '/builds/slave/test-pgo', 10:58:57 INFO - 'SHELL': '/bin/bash', 10:58:57 INFO - 'SHLVL': '1', 10:58:57 INFO - 'TERM': 'linux', 10:58:57 INFO - 'TMOUT': '86400', 10:58:57 INFO - 'USER': 'cltbld', 10:58:57 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450983507.314307-1134351290', 10:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:57 INFO - '_': '/tools/buildbot/bin/python'} 10:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:57 INFO - Downloading/unpacking flake8 10:58: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 10:58: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 10:58: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 10:58: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 10:58: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 10:58: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 10:58:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:58:58 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 10:58:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:58:59 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 10:58:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:58:59 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 10:58:59 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 10:58:59 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 10:58:59 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 10:58:59 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 10:58:59 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 10:58:59 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 10:58:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:58:59 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 10:58:59 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 10:58:59 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 10:58:59 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 10:58:59 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 10:58:59 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 10:58:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:58:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:58:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:58:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:58:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:58:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:58:59 INFO - no previously-included directories found matching 'docs/_build' 10:58:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:58:59 INFO - Running setup.py install for pep8 10:58:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:58:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:58:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:58:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:58:59 INFO - no previously-included directories found matching 'docs/_build' 10:58:59 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:58:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:58:59 INFO - Cleaning up... 10:58:59 INFO - Return code: 0 10:58:59 INFO - Running post-action listener: _resource_record_post_action 10:58:59 INFO - Running post-action listener: _start_resource_monitoring 10:58:59 INFO - Starting resource monitoring. 10:58:59 INFO - ##### 10:58:59 INFO - ##### Running install step. 10:58:59 INFO - ##### 10:58:59 INFO - Running pre-action listener: _resource_record_pre_action 10:58:59 INFO - Running main action method: install 10:58:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:58:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:59:00 INFO - Reading from file tmpfile_stdout 10:59:00 INFO - Detecting whether we're running mozinstall >=1.0... 10:59:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:59:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:59:00 INFO - Reading from file tmpfile_stdout 10:59:00 INFO - Output received: 10:59:00 INFO - Usage: mozinstall [options] installer 10:59:00 INFO - Options: 10:59:00 INFO - -h, --help show this help message and exit 10:59:00 INFO - -d DEST, --destination=DEST 10:59:00 INFO - Directory to install application into. [default: 10:59:00 INFO - "/builds/slave/test-pgo"] 10:59:00 INFO - --app=APP Application being installed. [default: firefox] 10:59:00 INFO - mkdir: /builds/slave/test-pgo/build/application 10:59:00 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'] 10:59:00 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 10:59:17 INFO - Reading from file tmpfile_stdout 10:59:17 INFO - Output received: 10:59:17 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:59:17 INFO - Running post-action listener: _resource_record_post_action 10:59:17 INFO - ##### 10:59:17 INFO - ##### Running run-tests step. 10:59:17 INFO - ##### 10:59:17 INFO - Running pre-action listener: _resource_record_pre_action 10:59:17 INFO - Running main action method: run_tests 10:59:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:59:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:59:17 INFO - Python 2.7.3 10:59:17 INFO - Return code: 0 10:59:17 INFO - grabbing minidump binary from tooltool 10:59:17 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')]} 10:59:17 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 0x18f0840>, '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 0x185d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185db60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:59:17 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 10:59:17 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 10:59:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:59:17 INFO - Return code: 0 10:59:17 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:59:17 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:59:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:59:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:59:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:59:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:59:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:59:18 INFO - Return code: 0 10:59:18 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/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 10:59:18 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/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 10:59:18 INFO - Using env: {'DISPLAY': ':0', 10:59:18 INFO - 'HOME': '/home/cltbld', 10:59:18 INFO - 'LANG': 'en_US.UTF-8', 10:59:18 INFO - 'LANGUAGE': 'en_US:en', 10:59:18 INFO - 'LOGNAME': 'cltbld', 10:59:18 INFO - 'MAIL': '/var/mail/cltbld', 10:59:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:59:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:18 INFO - 'MOZ_NO_REMOTE': '1', 10:59:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:59:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:18 INFO - 'NO_EM_RESTART': '1', 10:59:18 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:59:18 INFO - 'PWD': '/builds/slave/test-pgo', 10:59:18 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:59:18 INFO - 'SHELL': '/bin/bash', 10:59:18 INFO - 'SHLVL': '1', 10:59:18 INFO - 'TERM': 'linux', 10:59:18 INFO - 'TMOUT': '86400', 10:59:18 INFO - 'USER': 'cltbld', 10:59:18 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450983507.314307-1134351290', 10:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:18 INFO - '_': '/tools/buildbot/bin/python'} 10:59:18 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/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 10:59:18 INFO - mozversion application_buildid: 20151224083107 10:59:18 INFO - mozversion application_changeset: 0f9649cb1feee315d7cc11eee4f4756ec79cd18a 10:59:18 INFO - mozversion application_display_name: Nightly 10:59:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:59:18 INFO - mozversion application_name: Firefox 10:59:18 INFO - mozversion application_remotingname: firefox 10:59:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:59:18 INFO - mozversion application_vendor: Mozilla 10:59:18 INFO - mozversion application_version: 46.0a1 10:59:18 INFO - mozversion platform_buildid: 20151224083107 10:59:18 INFO - mozversion platform_changeset: 0f9649cb1feee315d7cc11eee4f4756ec79cd18a 10:59:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:59:18 INFO - mozversion platform_version: 46.0a1 10:59:18 INFO - using testdate: 1450983558 10:59:18 INFO - actual date: 1450983558 10:59:18 INFO - starting webserver on 'localhost:37106' 10:59:18 INFO - SUITE-START | Running 3 tests 10:59:18 INFO - TEST-START | dromaeo_css 10:59:18 INFO - operating with platform_type : linux_ 10:59:18 INFO - Initialising browser for dromaeo_css test... 10:59:18 INFO - TEST-INFO | started process 22499 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppwWwGI/profile http://localhost:37106/getInfo.html) 10:59:23 INFO - PROCESS | 22499 | __metrics Screen width/height:1600/1200 10:59:23 INFO - PROCESS | 22499 | colorDepth:24 10:59:23 INFO - PROCESS | 22499 | Browser inner width/height: 1024/697 10:59:23 INFO - PROCESS | 22499 | __metrics 10:59:23 INFO - PROCESS | 22499 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:59:23 INFO - PROCESS | 22499 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:59:25 INFO - TEST-INFO | 22499: exit 0 10:59:25 INFO - Browser initialized. 10:59:25 INFO - Running cycle 1/1 for dromaeo_css test... 10:59:25 INFO - TEST-INFO | started process 22592 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppwWwGI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:59:36 INFO - PROCESS | 22592 | RSS: Main: 147959808 10:59:36 INFO - PROCESS | 22592 | 11:00:27 INFO - PROCESS | 22592 | 1450983627737 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] 11:02:37 INFO - PROCESS | 22592 | Cycle 1(1): loaded http://localhost:37106/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37106/tests/dromaeo/cssquery-ext.html) 11:02:38 INFO - PROCESS | 22592 | RSS: Main: 273137664 11:02:38 INFO - PROCESS | 22592 | 11:05:41 INFO - PROCESS | 22592 | Cycle 1(1): loaded http://localhost:37106/tests/dromaeo/cssquery-ext.html (next: http://localhost:37106/tests/dromaeo/cssquery-jquery.html) 11:05:41 INFO - PROCESS | 22592 | RSS: Main: 236584960 11:05:41 INFO - PROCESS | 22592 | 11:08:43 INFO - PROCESS | 22592 | Cycle 1(1): loaded http://localhost:37106/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37106/tests/dromaeo/cssquery-mootools.html) 11:08:44 INFO - PROCESS | 22592 | RSS: Main: 224542720 11:08:44 INFO - PROCESS | 22592 | 11:11:46 INFO - PROCESS | 22592 | Cycle 1(1): loaded http://localhost:37106/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37106/tests/dromaeo/cssquery-prototype.html) 11:11:46 INFO - PROCESS | 22592 | RSS: Main: 210468864 11:11:46 INFO - PROCESS | 22592 | 11:14:49 INFO - PROCESS | 22592 | Cycle 1(1): loaded http://localhost:37106/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37106/tests/dromaeo/cssquery-yui.html) 11:14:49 INFO - PROCESS | 22592 | RSS: Main: 212254720 11:14:49 INFO - PROCESS | 22592 | 11:17:52 INFO - PROCESS | 22592 | Cycle 1(1): loaded http://localhost:37106/tests/dromaeo/cssquery-yui.html (next: http://localhost:37106/tests/dromaeo/cssquery-dojo.html) 11:17:52 INFO - PROCESS | 22592 | RSS: Main: 283004928 11:17:52 INFO - PROCESS | 22592 | 11:17:52 INFO - PROCESS | 22592 | __start_tp_report 11:17:52 INFO - PROCESS | 22592 | _x_x_mozilla_page_load 11:17:52 INFO - PROCESS | 22592 | _x_x_mozilla_page_load_details 11:17:52 INFO - PROCESS | 22592 | |i|pagename|runs| 11:17:52 INFO - PROCESS | 22592 | |0;dojo.html;3178.141901686546;3180.3003339265356;3252.7072563469296;3254.772165948383;3276.8689252429904;5158.613104017204;5265.052290587692;5366.060939335615;5411.891762164754;5460.754266058027;5240.213967904816;5336.9733151334185;5482.095454250054;5485.396606373296;5486.765477767501;4854.781534830932;4919.60643148549;4942;4948.703077815325;5005.924911126336;4953.257011448293;4983.576396006344;5060.898782024357;5112.846614601568;5125;4911.631627627907;5013.448520662724;5050.267711181895;5054.393472783253;5123.666961647481;4837.516248375169;4928.482509336504;4940.7035577865445;4947.332110165117;4951.282064100686;4869.659123861331;4872.317875497433;4893.8776530586665;4899.093667671492;4900.779464924087;5143.331366922276;5227.26818245446;5231.215317702337;5261.631685781997;5300.496452836975;5937.495312898365;5940.46535811779;5950.375210602911;5953.464188223037;5960.880782384372;5985.521158307369;5994.700264986777;5994.760209591611;5998.970005149947;6033.849153771147;5315;5421.26812880264;5443.755031023653;5447.4824891635235;5557.5831812614215;5964.7912323068485;5968.46283834457;6020.096985452217;6063.319157402537;6097.939020609826;5749.252597162425;5754.798582049608;5757.798477053283;5761.48146666802;5791.218185544982;5766.221560089418;5815.098659707667;5871.178035075093;5879.412058794172;5930.436608522184;5783.8554036149435;5817.214676018768;5832.445917637818;5859.677717725566;5878.030125029408;5849.590528663038;5852.7658893643775;5858.47273745365;5863.912041319383;5866.413358664099;4401.977990110029;4451.732896026248;4480.507144214133;4483.932741008887;4488.730676159375;3986.880393588197;3989.6608788252743;4001.2597669431248;4027.3958906163725;4030.294698427822;5367.704776237344;5369.973150134224;5370.91943620846;5390.730463476811;5412.025835349675;5778.191053252548;5817.592768506164;5843.094320380348;5907.438793314628;5970.283565972111;5462.044142275086;5465.726713664301;5468.7539060741565;5476.616636835463;5486.478784515464;5047.192449208109;5052.494750524992;5053.267276244924;5079.161938280216;5097.439281679012;5807.477327040587;5887.764489420375;5906.438888305604;5918.911216331759;6077.088436734437;5848.2689663792025;5857.853553661193;5866.149408335853;5887.3523912370465;5948.583599148191;6022.698865056817;6055.182550355646;6059.091136329585;6069.908951365821;6072.05883088122;5703.344115426613;5752.13717942312;5787.39232380594;5804.100364443518;5810.273715785527;5818.185454036354;5856.092305692625;5856.795012174553;5860.413958604106;5890.558208134321;5701.4298570142655;5703.914441283301;5705;5712.6286791358425;5726.026575482095;5560.193771903132;5694.772209111755;5710.486056254791;5749.425057494217;5867.530597552271;5616.887662246814;5618.044932361427;5620.04459241938;5623.775048997994;5624.578156638187;5720.3421606515785;5740.225069615549;5742.937556552051;5745.023346031101;5795.391483894299;5415.241866138665;5472.343318801769;5531.502164805187;5558.305211848519;5684.63049901755 11:17:52 INFO - PROCESS | 22592 | |1;ext.html;551.236537395707;599.5623195067601;606.620861961274;610.4963405190719;614.1892701633845;38179;39695.801520992354;39740;39797;39810.20379592406;42423.57576424235;42873.14253714932;42898.14203715924;43028.569714302845;43255.78372108143;7443.739469118582;7563.2436756324205;8537.231649151576;8692.869606955868;9898.604055837794;10159.238057145707;10218.744531386701;10239.334443261201;10272;10294.3823370598;10296.588136474533;10325.173986081096;10379.910109438513;10403.323783954056;10426.322289051226;7601.163871974079;7741.8838717419;10166.237532185116;10332.225083118721;10339;9847.803043939153;9958.651447199314;9960.452175130366;9966.252531060127;9980.800383992351;37468.250634987424;37762.43356349657;37842.81078594617;37952.810235948644;38044.23911521754;3195.472746996743;3396.2018925552475;3461.6884480396884;3682.502862113607;3830.1382189007527;30568.69431305703;30813.537796933066;31176.376472470423;31595.21011974696;32200.67799322;3837.712171587142;3845.270776141752;3852.174301942495;3998.5005622891417;4050.979745101285;272074;273896;274131;274139.999999998;274818;53951.46048539543;54761.45238547563;58835;67318;68181.65909170422;60924.390756092755;61222.38777612256;61438.692806535684;61476.6187859672;61493.69253153705;13350.933245333712;13477.797833032513;13490;13498.93250533741;13503.527376541773;10014.649487268056;10019.79960400788;10073.848892266622;10088.293819432716;10150.796984060278;20287.594248114954;20560.58878822415;20600.896995514926;20646.483837904172;20761.480962976046;7595.962020189863;7785.4170616587435;7790.5325680459355;7804.531728096333;7862.410319226081;912.6851236323457;914.5655813488539;945.3854994253653;1012.1649639047815;1100.471773548701;28689.85655071711;28728;28749.425011499654;28934;29193.416131677248;968.3899143539666;989.317371013998;1002.2733518199248;1058.2486434631498;1063.723431907694;14690.26548672562;15328.923355383375;15470;15586.298616562282;16020.67958640844;248634;251605;251981;252008;252152;48356;48499.272510912364;48563.271550926765;48603.27095093577;48606;1208.601161616682;1237.4926280225066;1253.5863165155658;1294.5210272199347;1295.598364507006;28799.712002879704;29414.852925735235;29700.70299297066;29870.551941721325;30135.246618834706;43829.34255986226;44643.776781115885;54572;55476.72261638666;55623.16565251605;246102;246654;248522;248761;249746;27514.724852752017;27894.581581276703;31032;31132;31257.218569535034;42783.14433711371;43096;43206.351904720825;43463.78268108639;44141;33310.66689333173;41532;42058;42306.57693423027;44602.77698611616;36999.260014799016;40072.3989140169;40181.19637607173;40280.59719402769;40401.191976159724;38148.427773582865;39343.40984885286;39704.80147599243;39774;39815.80092099521;37494.81252593829;37921.81039094787;38614.80692596519;39939.201215974936;40175.3973690389;27295.317617059733;27908.720912791425;27949.860250698617;28049.579256310764;28072.719272807826 11:17:52 INFO - PROCESS | 22592 | |2;jquery.html;354.7002782648662;355.6123825030716;358.49094286113734;361.7738913179263;365.6398447529184;14169.079009864352;14190;16457.670846583074;16707.83292167078;16752.246148923296;12115.575954841583;12548.623541293753;14356.425742970294;14382.640433989129;15023.624409389771;5146.45962173971;5225.712585807779;5275.575594589478;5275.841724748264;5278.155495120782;3814.4469051987444;3898.161895192533;5186.7147306898105;5290.497402746733;5323.866903327409;5578.414266501999;5780.9710951445395;5786.305643322786;5821.27234095738;5826.9708651456685;5366.624336296461;5372.7313634318125;5578.693171875545;5757.769689212427;5788.739506722208;5082.237664350377;5175.974120129413;5180.041692286939;5184.688918664892;5185.637005409623;20333.694994575093;20466.897665511577;20685.68971465429;20790.376288711363;20805.16779328825;2132.552164045552;2171.250918433138;2325.5232677301115;2390.306811024801;2557.450148218142;12789.93605031969;13099.34503274842;13162.09149673292;13534.120282181726;13574.86425135746;1492.2538730634683;1655.6109314311127;1661.1113054515897;1672.3143511160365;1693.3903794633923;54641;57376.71311643415;57792.84414311732;58046.419535804525;58048.41951580472;9545.140937315675;9667.70996870095;9774.875889272682;9866.654667086761;9910.256730745223;12598.748025039631;12664.936675316749;12684.619461416172;12693.492260309484;12707.936460317824;7079.469039822034;7147.9285207148305;7165;7240.348368646742;7248.637568121573;6849.280825513349;6863.794086177422;6889.414399776075;6919;6934.687939042654;5781.739821708034;5866.97327967604;5881.264841894763;5885.588008839341;5912.497437717842;1580.6759614279044;1659.402615058578;1720.9760192685333;1727.2054854766698;1731.5584525945803;912.780932576177;939.7556635274877;948.6821914658528;979.8824141103113;1024.2881197567767;16816.822822402315;17178.828211717722;17609.295628174987;17778.46664600064;18042.729359059624;831.1231650608665;902.3769565195744;922.1193759959223;929.5166513413122;930.3719989007393;9773.951130244302;9900;10219.540120694586;10307.123894468905;10322.741931451623;542179;557851;561316;564508;565856;71317.2868271321;78248.60875695584;79322;79409.20590794133;80780.19219807844;1079.1205167788385;1096.6545538155456;1108.6895669212795;1114.1838802751624;1118.2451845004753;15704.76442853381;15857.127857967922;16143;16373.263203156124;16468.258928348012;27663.72336276692;32171.839140804146;32199;32467;33737.493937590465;40760.388594170516;42511.787441062595;43492.13015739731;44476.55523444853;48165.518344816104;9548.85676714836;9737.123658870736;9895.851562226717;9911.851322230028;9932.553035113582;11653.76692466163;11712.180147389601;11733.296002239893;11793.29240245588;11806.527738890349;11915;12407.25556466615;12734;13560.186388816703;13568;13588.320583970959;14206.715865682836;14354.138751674933;14441.927790360982;14602.12387256768;12223.93888030554;12915.612531624067;13494.865051349361;14192.219427931563;14219.289035547974;9505.714828555154;9597.760055998657;9787.706368808947;9816;9833.360831545926;13448.865511344762;13674.52139175164;13770.862291377358;13788.793168102688;13934.721305574034 11:17:52 INFO - PROCESS | 22592 | |3;mootools.html;1197.359412714198;1636.263681343395;1655.9172041397935;1724.1810140183413;1791.2118667786176;6458.9677051614735;6985.580865148095;7106.182788979269;7116.430685545157;7133.357997780199;7181.82045448864;7418.072740907387;7427.108746950374;7434.070741157356;7436.5166264192785;1950.1321911749278;1993.9302124425649;1996.3611644273838;2222.599932012241;2262.2082271205027;1978.4262563856464;2188.4638263625434;2228.2089858100385;2233.1179184222224;2259.3899647095272;2080.490279881431;2127.5319429725437;2211.358705975273;2215.0253888289103;2216.4902072523328;2198.5712786006734;2201.4716468047714;2221.7889300516426;2225.0765932138142;2225.5660146271402;2204.713387259646;2239.361781892153;2253.6506841439605;2254.233560589391;2262.581422436838;7414.851702965964;7479.813004674872;7482.289182527651;7488.213737557532;7491.475596708233;4294.9785251073545;4329.220740266751;4331.740095594243;4358.5205627380965;4374.431323927869;2929.399473108008;2929.9853500732575;2996.925076873074;3014.668386477486;3020.305329774142;940.1303793990531;971.3394891473795;977.8337682593976;1001.1640280365904;1001.9048190421898;9698.36960597566;9749.561269742879;9756.95121524395;9764.804703905953;9773.41359518424;3874.0702231464247;3875.1862108957434;3895.182011777502;3928.3125453045604;3973.8609148679657;8534.231919127309;8543.401961862734;8574.314054875595;8574.485530868167;8574.95712521446;4321.762303073361;4332.718373305725;4344.370066340363;4359.215341238544;4364.585364390377;3989.980050099789;3996.1208534122447;3996.660283875845;3998.6001399859783;4002.8598999034893;3236.6277878043857;3578.302231064917;3593.1196856769734;3601.963980360163;3647.598764135943;1092.4319353936069;1122.5173175534599;1144.2047776795214;1147.3230793831679;1153.7807816514835;1015.9644412445676;1016.9389836609827;1042.6455005298235;1054.9367037977745;1062.7396287909512;7118.537295075804;7146.464015198881;7204.387627051655;7229.963850180716;7236.746713864989;1067.1622776120707;1070.9678709638724;1086.8804431512526;1094.819354806464;1103.4979084516526;5534.976029434568;5589.580781441408;5621.325440947113;5624.690642014729;5632.915506267409;8331.8333633327;8611;8748.606312715943;8795.47227166372;8799.032106468283;8583.613737381833;8638.913610863936;8673.176048275403;8673.609687564074;8698.304135669257;6655;6750.6624668767345;6852.45180385568;6899.655017249117;6952.791416257521;6666.366695163952;6684.4652427804685;6697.09589205451;6714.6978385973725;6721.932780672326;7687.423443241667;7885.684572617031;7891.605419728876;7896.447248692766;7903.802404939923;7818.413618978486;7827.726029588937;7979.082405523439;8086.757397278091;8089.878651820345;6361.745530178741;6457.321981191907;6502.3172566881685;6507.28419873823;6604.306547812411;6402.6158430494315;6561.442277406474;7254.129504459499;7305.525140865827;7318.780436586911;6396.808095757135;6480.870382592416;6715.764948226984;6749.86500269982;6839.487038472035;6592;6617.636030018395;6644.867102657823;6697;6703.463722902254;6372.808815735535;6411.807645770635;6447.194100737408;6452.35476452351;6459.773907913201;5935.614185078129;5970.194023806905;5975.193348897843;5977.326348622392;5982.670953097621;5817.331006934257;5863.325717542537;5868.061110222344;5878.529717622494;5913.822585322448 11:17:52 INFO - PROCESS | 22592 | |4;prototype.html;337.09490019298187;338.43481386085233;346.95663042119736;347.74093300491137;353.8195520284654;6011.639301641904;6037.275526936768;6040;6063.120847477113;6137.87724245516;5728.598998070126;5783.421657834215;5934.703264836762;5980.671063091529;6018.9398106018925;4631.120087183441;4631.884202894921;4636.768161591907;4655.813767449306;4665.926836827532;4447.377367168583;4636.5595268449615;4652.790624421892;4652.97673511632;4653.092646933849;4488.97755511222;4502.909941801162;4628.907421851561;4636.953630463703;4670.182718024349;4578.336141259499;4617.422822147231;4622.58396744293;4626.051659409846;4636.582707556319;4080.326746086892;4083.7141400102005;4083.8570650027104;4084.836606535735;4095.5290141633795;5587.580931430119;5676.290463692038;5745.224394706703;5754.223179870705;5756;5350.946490535084;5363.919541206885;5364.034473794715;5365.03429382711;5382.515573598355;6443.613383197023;6446.419822216023;6447.580907241015;6448.709808058648;6452.257990331125;4456.7548784817145;4462.352958820985;4462.553744625544;4465.910681786346;4479.910401791978;6587.703553340111;6649;6701.262861085325;6706.094677218611;6710.496712746563;4575.359449677047;4575.519570445122;4579.816807327737;4580.061087477059;4585.679002469862;4633.582977532038;4636.374089497875;4642.141203877293;4642.3500709900645;4649.488556258809;5359.062164121263;5362.2224777407055;5366.543843773245;5367.892642147213;5379.515843574097;6309.842253943596;6428.71070801815;6475.32009139043;6486.935130648633;6492.5455218134275;1632.5428879913643;1646.9588260293588;1648.32418708329;1649.150687395992;1649.4556796257207;1093.7101668057971;1095.4960718069617;1098.3355070182583;1101.3446999035561;1119.6361182615683;6108.450239478469;6112.205413296243;6115.541334399849;6116.633002019804;6119.082137679384;6469.159009328757;6585.111010013683;6624;6636.535442518977;6642.236142843538;6012.579119461683;6066.272047354346;6172.043333283348;6187.257529096447;6201.906971395432;3580.838862251205;3629.9637003630155;3631.5823680276576;3633.3823250047553;3635.1093981974586;6664.433523150587;6897.379235868796;6897.55165914214;6899.724011039602;6903.102596662402;6866.485013623998;6868.553544019623;6869.175698916162;6873.415759660485;6879.552829066195;6940.271271516519;6948.478864085214;6949;6949.339812717885;6957.234704182536;6499.7400103995315;6692.063111164343;6710.396064354231;6712.228093769084;6713.899291510729;6582.80251592453;6601;6630.701618427279;6643.56816806906;6661.233958094687;6940.236573976757;6940.9652951734915;6944.618046007518;6948.826279343057;6961.164660240804;4490.618297444754;4499.7975091120325;4500.189965806187;4503.707259028152;4505.662075344297;6550;6724.226713927961;6728;6737.66311684404;6746.392824645805;6504.772332968323;6507.544471886922;6509.153810004669;6517.185351831021;6518.73925042993;6265.624062556261;6488.156539649815;6498.545101842826;6504.804855854332;6506.41442270198;6324.905126423016;6360.77737279193;6372.044193371032;6372.55392122547;6379.170707808141;6509.511786616117;6522.119513865758;6523.804285871432;6528.804135875931;6536.477081833537;6226.968865155645;6380.202474690664;6380.649064301508;6381.266154392304;6387.201599800025 11:17:52 INFO - PROCESS | 22592 | |5;yui.html;718.5042320798652;753.4800987318753;797.5135167547795;856.3192262151589;864.5417928497897;12523.561675341365;12685.492580296801;12778.744425111492;12800.103992720513;12806.615801525957;11164.162687798407;11823.994960428352;12665.303408312539;12841.80737288939;12848.74302513949;803.7990502374391;822.4695071678764;825.9050209225956;826.6197549127409;827.3960009193293;804.2801692485223;808.312934006096;809.7975506123469;810.307187354812;810.9026916769996;833.5540485840077;834.1241696218976;838.3921656798802;840.3613253927028;841.8232171244047;830.6677329068391;831.8960129983752;832.0389949608242;832.7585000349891;833.4915701422127;617.2839506172818;617.9907301390483;618.0636335951037;619.0373968479013;619.8419403052193;11341.489632966537;11463;11499.080073594176;11499.827502587468;11539.423028848523;10358.43028633425;10465.68602941913;10531.84202236967;10620.415877126756;11071.225014249007;9659.178969787576;9694.903050969471;9797.90202097977;9830.705078847646;9970.651027214013;3544.85820567177;3571.4821350904235;3588.2644057968055;3588.569371675416;3592.317459682652;45053.54946450559;45109.3233601493;45113.77443112763;45166.32250516245;45300.3204951926;8742.650293988296;8748;8791.956040219886;8850.336224783166;8954;16098.517044488684;16107.838921610868;16145.838541614668;16147.757783633255;16165.4342098026;7117.92882071183;7154.785356439315;7232.710691572383;7355.448341374418;7566.054243219598;3949;4124.6906482013965;4155.729877557949;4168.979155104205;4241.978790106092;2864.3698386354968;2940.9264768380963;2953.4979053560946;2954.512505436579;2959.097475270063;599.4005994005994;602.1299222623355;604.9969750151309;616.4359610956014;618.7401291457599;646.767163821024;654.2508827392609;670.5842377725744;678.0334053061248;678.9694463749144;8585.941831367842;8606.967163940368;8616.09530999236;8662.783430414163;8711.738647840575;602.8975074237391;617.219217689623;630.0710315927104;651.2543138106842;669.1802541886151;3538.805365704911;4182.707210495297;4291.31338985767;4301.354796780508;4359.280718681445;52117;52649.99825016617;52967.735161323944;53050.73474632602;53089.46910530845;44514.554854451686;46518.767406162755;47108.764456178185;55088.17367739487;55800.72099639476;44834;45116.54883451123;45523.089538209715;45711.08577828491;45910.31134532985;6923.584584924921;8623.568821559022;8757.343199259954;8878.95560522219;9036.23192028685;33477.83261083679;33541.16147096342;33545;33664.66335336615;34092.31815363729;43317.566824331356;43939;44000.779996099816;44058.55941440545;44257;10675.359478431319;10684.412357320422;10727.356358618508;10765.138788897026;10898.07366373867;11565.768684626091;12067.879321206676;12269.447874845475;12300.261984280973;12625.621231363073;11147.442627868411;11311.208215424842;11397.202195846212;11416.486258118572;11865.644030679094;11162.550674586057;11208;11365.204435689422;11497.252678575866;11760.882391176321;10501;10701.518431670438;10853.34879907208;10994.450277485934;11044.558217671203;9054.185123338932;9154.633814647339;9197.816043679222;9664.855027174739;9761.80476390454;8505.031145184395;8659.6103175356;8726.738197854074;9220.723378298662;9246.630134794534 11:17:52 INFO - PROCESS | 22592 | __end_tp_report 11:17:52 INFO - PROCESS | 22592 | __start_cc_report 11:17:52 INFO - PROCESS | 22592 | _x_x_mozilla_cycle_collect,888 11:17:52 INFO - PROCESS | 22592 | __end_cc_report 11:17:52 INFO - PROCESS | 22592 | __startTimestamp1450984672617__endTimestamp 11:17:52 INFO - PROCESS | 22592 | 11:17:52 INFO - PROCESS | 22592 | ------- Summary: start ------- 11:17:52 INFO - PROCESS | 22592 | Number of tests: 6 11:17:52 INFO - PROCESS | 22592 | 11:17:52 INFO - PROCESS | 22592 | [#0] dojo.html Cycles:165 Average:5418.27 Median:5620.04 stddev:614.86 (10.9%) stddev-sans-first:591.09 11:17:52 INFO - PROCESS | 22592 | Values: 3178.1 3180.3 3252.7 3254.8 3276.9 5158.6 5265.1 5366.1 5411.9 5460.8 5240.2 5337.0 5482.1 5485.4 5486.8 4854.8 4919.6 4942.0 4948.7 5005.9 4953.3 4983.6 5060.9 5112.8 5125.0 4911.6 5013.4 5050.3 5054.4 5123.7 4837.5 4928.5 4940.7 4947.3 4951.3 4869.7 4872.3 4893.9 4899.1 4900.8 5143.3 5227.3 5231.2 5261.6 5300.5 5937.5 5940.5 5950.4 5953.5 5960.9 5985.5 5994.7 5994.8 5999.0 6033.8 5315.0 5421.3 5443.8 5447.5 5557.6 5964.8 5968.5 6020.1 6063.3 6097.9 5749.3 5754.8 5757.8 5761.5 5791.2 5766.2 5815.1 5871.2 5879.4 5930.4 5783.9 5817.2 5832.4 5859.7 5878.0 5849.6 5852.8 5858.5 5863.9 5866.4 4402.0 4451.7 4480.5 4483.9 4488.7 3986.9 3989.7 4001.3 4027.4 4030.3 5367.7 5370.0 5370.9 5390.7 5412.0 5778.2 5817.6 5843.1 5907.4 5970.3 5462.0 5465.7 5468.8 5476.6 5486.5 5047.2 5052.5 5053.3 5079.2 5097.4 5807.5 5887.8 5906.4 5918.9 6077.1 5848.3 5857.9 5866.1 5887.4 5948.6 6022.7 6055.2 6059.1 6069.9 6072.1 5703.3 5752.1 5787.4 5804.1 5810.3 5818.2 5856.1 5856.8 5860.4 5890.6 5701.4 5703.9 5705.0 5712.6 5726.0 5560.2 5694.8 5710.5 5749.4 5867.5 5616.9 5618.0 5620.0 5623.8 5624.6 5720.3 5740.2 5742.9 5745.0 5795.4 5415.2 5472.3 5531.5 5558.3 5684.6 11:17:52 INFO - PROCESS | 22592 | 11:17:52 INFO - PROCESS | 22592 | [#1] ext.html Cycles:180 Average:44179.51 Median:37628.62 stddev:66985.40 (178.0%) stddev-sans-first:67093.21 11:17:52 INFO - PROCESS | 22592 | Values: 551.2 599.6 606.6 610.5 614.2 38179.0 39695.8 39740.0 39797.0 39810.2 42423.6 42873.1 42898.1 43028.6 43255.8 7443.7 7563.2 8537.2 8692.9 9898.6 10159.2 10218.7 10239.3 10272.0 10294.4 10296.6 10325.2 10379.9 10403.3 10426.3 7601.2 7741.9 10166.2 10332.2 10339.0 9847.8 9958.7 9960.5 9966.3 9980.8 37468.3 37762.4 37842.8 37952.8 38044.2 3195.5 3396.2 3461.7 3682.5 3830.1 30568.7 30813.5 31176.4 31595.2 32200.7 3837.7 3845.3 3852.2 3998.5 4051.0 272074.0 273896.0 274131.0 274140.0 274818.0 53951.5 54761.5 58835.0 67318.0 68181.7 60924.4 61222.4 61438.7 61476.6 61493.7 13350.9 13477.8 13490.0 13498.9 13503.5 10014.6 10019.8 10073.8 10088.3 10150.8 20287.6 20560.6 20600.9 20646.5 20761.5 7596.0 7785.4 7790.5 7804.5 7862.4 912.7 914.6 945.4 1012.2 1100.5 28689.9 28728.0 28749.4 28934.0 29193.4 968.4 989.3 1002.3 1058.2 1063.7 14690.3 15328.9 15470.0 15586.3 16020.7 248634.0 251605.0 251981.0 252008.0 252152.0 48356.0 48499.3 48563.3 48603.3 48606.0 1208.6 1237.5 1253.6 1294.5 1295.6 28799.7 29414.9 29700.7 29870.6 30135.2 43829.3 44643.8 54572.0 55476.7 55623.2 246102.0 246654.0 248522.0 248761.0 249746.0 27514.7 27894.6 31032.0 31132.0 31257.2 42783.1 43096.0 43206.4 43463.8 44141.0 33310.7 41532.0 42058.0 42306.6 44602.8 36999.3 40072.4 40181.2 40280.6 40401.2 38148.4 39343.4 39704.8 39774.0 39815.8 37494.8 37921.8 38614.8 39939.2 40175.4 27295.3 27908.7 27949.9 28049.6 28072.7 11:17:52 INFO - PROCESS | 22592 | 11:17:52 INFO - PROCESS | 22592 | [#2] jquery.html Cycles:180 Average:28860.31 Median:357.05 stddev:91147.44 (25527.8%) stddev-sans-first:91378.00 11:17:52 INFO - PROCESS | 22592 | Values: 354.7 355.6 358.5 361.8 365.6 14169.1 14190.0 16457.7 16707.8 16752.2 12115.6 12548.6 14356.4 14382.6 15023.6 5146.5 5225.7 5275.6 5275.8 5278.2 3814.4 3898.2 5186.7 5290.5 5323.9 5578.4 5781.0 5786.3 5821.3 5827.0 5366.6 5372.7 5578.7 5757.8 5788.7 5082.2 5176.0 5180.0 5184.7 5185.6 20333.7 20466.9 20685.7 20790.4 20805.2 2132.6 2171.3 2325.5 2390.3 2557.5 12789.9 13099.3 13162.1 13534.1 13574.9 1492.3 1655.6 1661.1 1672.3 1693.4 54641.0 57376.7 57792.8 58046.4 58048.4 9545.1 9667.7 9774.9 9866.7 9910.3 12598.7 12664.9 12684.6 12693.5 12707.9 7079.5 7147.9 7165.0 7240.3 7248.6 6849.3 6863.8 6889.4 6919.0 6934.7 5781.7 5867.0 5881.3 5885.6 5912.5 1580.7 1659.4 1721.0 1727.2 1731.6 912.8 939.8 948.7 979.9 1024.3 16816.8 17178.8 17609.3 17778.5 18042.7 831.1 902.4 922.1 929.5 930.4 9774.0 9900.0 10219.5 10307.1 10322.7 542179.0 557851.0 561316.0 564508.0 565856.0 71317.3 78248.6 79322.0 79409.2 80780.2 1079.1 1096.7 1108.7 1114.2 1118.2 15704.8 15857.1 16143.0 16373.3 16468.3 27663.7 32171.8 32199.0 32467.0 33737.5 40760.4 42511.8 43492.1 44476.6 48165.5 9548.9 9737.1 9895.9 9911.9 9932.6 11653.8 11712.2 11733.3 11793.3 11806.5 11915.0 12407.3 12734.0 13560.2 13568.0 13588.3 14206.7 14354.1 14441.9 14602.1 12223.9 12915.6 13494.9 14192.2 14219.3 9505.7 9597.8 9787.7 9816.0 9833.4 13448.9 13674.5 13770.9 13788.8 13934.7 11:17:52 INFO - PROCESS | 22592 | 11:17:52 INFO - PROCESS | 22592 | [#3] mootools.html Cycles:180 Average:5121.72 Median:5980.00 stddev:2609.57 (43.6%) stddev-sans-first:2600.22 11:17:52 INFO - PROCESS | 22592 | Values: 1197.4 1636.3 1655.9 1724.2 1791.2 6459.0 6985.6 7106.2 7116.4 7133.4 7181.8 7418.1 7427.1 7434.1 7436.5 1950.1 1993.9 1996.4 2222.6 2262.2 1978.4 2188.5 2228.2 2233.1 2259.4 2080.5 2127.5 2211.4 2215.0 2216.5 2198.6 2201.5 2221.8 2225.1 2225.6 2204.7 2239.4 2253.7 2254.2 2262.6 7414.9 7479.8 7482.3 7488.2 7491.5 4295.0 4329.2 4331.7 4358.5 4374.4 2929.4 2930.0 2996.9 3014.7 3020.3 940.1 971.3 977.8 1001.2 1001.9 9698.4 9749.6 9757.0 9764.8 9773.4 3874.1 3875.2 3895.2 3928.3 3973.9 8534.2 8543.4 8574.3 8574.5 8575.0 4321.8 4332.7 4344.4 4359.2 4364.6 3990.0 3996.1 3996.7 3998.6 4002.9 3236.6 3578.3 3593.1 3602.0 3647.6 1092.4 1122.5 1144.2 1147.3 1153.8 1016.0 1016.9 1042.6 1054.9 1062.7 7118.5 7146.5 7204.4 7230.0 7236.7 1067.2 1071.0 1086.9 1094.8 1103.5 5535.0 5589.6 5621.3 5624.7 5632.9 8331.8 8611.0 8748.6 8795.5 8799.0 8583.6 8638.9 8673.2 8673.6 8698.3 6655.0 6750.7 6852.5 6899.7 6952.8 6666.4 6684.5 6697.1 6714.7 6721.9 7687.4 7885.7 7891.6 7896.4 7903.8 7818.4 7827.7 7979.1 8086.8 8089.9 6361.7 6457.3 6502.3 6507.3 6604.3 6402.6 6561.4 7254.1 7305.5 7318.8 6396.8 6480.9 6715.8 6749.9 6839.5 6592.0 6617.6 6644.9 6697.0 6703.5 6372.8 6411.8 6447.2 6452.4 6459.8 5935.6 5970.2 5975.2 5977.3 5982.7 5817.3 5863.3 5868.1 5878.5 5913.8 11:17:52 INFO - PROCESS | 22592 | 11:17:52 INFO - PROCESS | 22592 | [#4] prototype.html Cycles:180 Average:5389.52 Median:6087.36 stddev:1627.38 (26.7%) stddev-sans-first:1587.14 11:17:52 INFO - PROCESS | 22592 | Values: 337.1 338.4 347.0 347.7 353.8 6011.6 6037.3 6040.0 6063.1 6137.9 5728.6 5783.4 5934.7 5980.7 6018.9 4631.1 4631.9 4636.8 4655.8 4665.9 4447.4 4636.6 4652.8 4653.0 4653.1 4489.0 4502.9 4628.9 4637.0 4670.2 4578.3 4617.4 4622.6 4626.1 4636.6 4080.3 4083.7 4083.9 4084.8 4095.5 5587.6 5676.3 5745.2 5754.2 5756.0 5350.9 5363.9 5364.0 5365.0 5382.5 6443.6 6446.4 6447.6 6448.7 6452.3 4456.8 4462.4 4462.6 4465.9 4479.9 6587.7 6649.0 6701.3 6706.1 6710.5 4575.4 4575.5 4579.8 4580.1 4585.7 4633.6 4636.4 4642.1 4642.4 4649.5 5359.1 5362.2 5366.5 5367.9 5379.5 6309.8 6428.7 6475.3 6486.9 6492.5 1632.5 1647.0 1648.3 1649.2 1649.5 1093.7 1095.5 1098.3 1101.3 1119.6 6108.5 6112.2 6115.5 6116.6 6119.1 6469.2 6585.1 6624.0 6636.5 6642.2 6012.6 6066.3 6172.0 6187.3 6201.9 3580.8 3630.0 3631.6 3633.4 3635.1 6664.4 6897.4 6897.6 6899.7 6903.1 6866.5 6868.6 6869.2 6873.4 6879.6 6940.3 6948.5 6949.0 6949.3 6957.2 6499.7 6692.1 6710.4 6712.2 6713.9 6582.8 6601.0 6630.7 6643.6 6661.2 6940.2 6941.0 6944.6 6948.8 6961.2 4490.6 4499.8 4500.2 4503.7 4505.7 6550.0 6724.2 6728.0 6737.7 6746.4 6504.8 6507.5 6509.2 6517.2 6518.7 6265.6 6488.2 6498.5 6504.8 6506.4 6324.9 6360.8 6372.0 6372.6 6379.2 6509.5 6522.1 6523.8 6528.8 6536.5 6227.0 6380.2 6380.6 6381.3 6387.2 11:17:52 INFO - PROCESS | 22592 | 11:17:52 INFO - PROCESS | 22592 | [#5] yui.html Cycles:180 Average:13141.64 Median:46214.54 stddev:15220.07 (32.9%) stddev-sans-first:15234.17 11:17:52 INFO - PROCESS | 22592 | Values: 718.5 753.5 797.5 856.3 864.5 12523.6 12685.5 12778.7 12800.1 12806.6 11164.2 11824.0 12665.3 12841.8 12848.7 803.8 822.5 825.9 826.6 827.4 804.3 808.3 809.8 810.3 810.9 833.6 834.1 838.4 840.4 841.8 830.7 831.9 832.0 832.8 833.5 617.3 618.0 618.1 619.0 619.8 11341.5 11463.0 11499.1 11499.8 11539.4 10358.4 10465.7 10531.8 10620.4 11071.2 9659.2 9694.9 9797.9 9830.7 9970.7 3544.9 3571.5 3588.3 3588.6 3592.3 45053.5 45109.3 45113.8 45166.3 45300.3 8742.7 8748.0 8792.0 8850.3 8954.0 16098.5 16107.8 16145.8 16147.8 16165.4 7117.9 7154.8 7232.7 7355.4 7566.1 3949.0 4124.7 4155.7 4169.0 4242.0 2864.4 2940.9 2953.5 2954.5 2959.1 599.4 602.1 605.0 616.4 618.7 646.8 654.3 670.6 678.0 679.0 8585.9 8607.0 8616.1 8662.8 8711.7 602.9 617.2 630.1 651.3 669.2 3538.8 4182.7 4291.3 4301.4 4359.3 52117.0 52650.0 52967.7 53050.7 53089.5 44514.6 46518.8 47108.8 55088.2 55800.7 44834.0 45116.5 45523.1 45711.1 45910.3 6923.6 8623.6 8757.3 8879.0 9036.2 33477.8 33541.2 33545.0 33664.7 34092.3 43317.6 43939.0 44000.8 44058.6 44257.0 10675.4 10684.4 10727.4 10765.1 10898.1 11565.8 12067.9 12269.4 12300.3 12625.6 11147.4 11311.2 11397.2 11416.5 11865.6 11162.6 11208.0 11365.2 11497.3 11760.9 10501.0 10701.5 10853.3 10994.5 11044.6 9054.2 9154.6 9197.8 9664.9 9761.8 8505.0 8659.6 8726.7 9220.7 9246.6 11:17:52 INFO - PROCESS | 22592 | -------- Summary: end -------- 11:17:52 INFO - PROCESS | 22592 | 11:17:53 INFO - TEST-INFO | 22592: exit 0 11:17:53 INFO - TEST-OK | dromaeo_css | took 1114746ms 11:17:53 INFO - TEST-START | kraken 11:17:53 INFO - operating with platform_type : linux_ 11:17:53 INFO - Initialising browser for kraken test... 11:17:53 INFO - TEST-INFO | started process 22793 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBj1ciO/profile http://localhost:37106/getInfo.html) 11:17:57 INFO - PROCESS | 22793 | __metrics Screen width/height:1600/1200 11:17:57 INFO - PROCESS | 22793 | colorDepth:24 11:17:57 INFO - PROCESS | 22793 | Browser inner width/height: 1024/697 11:17:57 INFO - PROCESS | 22793 | __metrics 11:17:57 INFO - PROCESS | 22793 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:17:57 INFO - PROCESS | 22793 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:17:59 INFO - TEST-INFO | 22793: exit 0 11:17:59 INFO - Browser initialized. 11:17:59 INFO - Running cycle 1/1 for kraken test... 11:17:59 INFO - TEST-INFO | started process 22876 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBj1ciO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:18:10 INFO - PROCESS | 22876 | RSS: Main: 148086784 11:18:10 INFO - PROCESS | 22876 | 11:18:13 INFO - PROCESS | 22876 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37106/tests/kraken/driver.html?testName=audio-beat-detection) 11:18:13 INFO - PROCESS | 22876 | RSS: Main: 187281408 11:18:13 INFO - PROCESS | 22876 | 11:18:16 INFO - PROCESS | 22876 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37106/tests/kraken/driver.html?testName=audio-dft) 11:18:17 INFO - PROCESS | 22876 | RSS: Main: 178499584 11:18:17 INFO - PROCESS | 22876 | 11:18:20 INFO - PROCESS | 22876 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37106/tests/kraken/driver.html?testName=audio-fft) 11:18:20 INFO - PROCESS | 22876 | RSS: Main: 160747520 11:18:20 INFO - PROCESS | 22876 | 11:18:22 INFO - PROCESS | 22876 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37106/tests/kraken/driver.html?testName=audio-oscillator) 11:18:23 INFO - PROCESS | 22876 | RSS: Main: 162250752 11:18:23 INFO - PROCESS | 22876 | 11:18:25 INFO - PROCESS | 22876 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37106/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:18:25 INFO - PROCESS | 22876 | RSS: Main: 163790848 11:18:25 INFO - PROCESS | 22876 | 11:18:28 INFO - PROCESS | 22876 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37106/tests/kraken/driver.html?testName=imaging-darkroom) 11:18:29 INFO - PROCESS | 22876 | RSS: Main: 165310464 11:18:29 INFO - PROCESS | 22876 | 11:18:32 INFO - PROCESS | 22876 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37106/tests/kraken/driver.html?testName=imaging-desaturate) 11:18:33 INFO - PROCESS | 22876 | RSS: Main: 166146048 11:18:33 INFO - PROCESS | 22876 | 11:18:36 INFO - PROCESS | 22876 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37106/tests/kraken/driver.html?testName=json-parse-financial) 11:18:36 INFO - PROCESS | 22876 | RSS: Main: 166240256 11:18:36 INFO - PROCESS | 22876 | 11:18:38 INFO - PROCESS | 22876 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37106/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:18:38 INFO - PROCESS | 22876 | RSS: Main: 179175424 11:18:38 INFO - PROCESS | 22876 | 11:18:40 INFO - PROCESS | 22876 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37106/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:18:41 INFO - PROCESS | 22876 | RSS: Main: 175796224 11:18:41 INFO - PROCESS | 22876 | 11:18:43 INFO - PROCESS | 22876 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37106/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:18:43 INFO - PROCESS | 22876 | RSS: Main: 186372096 11:18:43 INFO - PROCESS | 22876 | 11:18:46 INFO - PROCESS | 22876 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37106/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:18:46 INFO - PROCESS | 22876 | RSS: Main: 192495616 11:18:46 INFO - PROCESS | 22876 | 11:18:49 INFO - PROCESS | 22876 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37106/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:18:49 INFO - PROCESS | 22876 | RSS: Main: 190963712 11:18:49 INFO - PROCESS | 22876 | 11:18:51 INFO - PROCESS | 22876 | Cycle 1(1): loaded http://localhost:37106/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37106/tests/kraken/driver.html?testName=ai-astar) 11:18:51 INFO - PROCESS | 22876 | RSS: Main: 250134528 11:18:51 INFO - PROCESS | 22876 | 11:18:51 INFO - PROCESS | 22876 | __start_tp_report 11:18:51 INFO - PROCESS | 22876 | _x_x_mozilla_page_load 11:18:51 INFO - PROCESS | 22876 | _x_x_mozilla_page_load_details 11:18:51 INFO - PROCESS | 22876 | |i|pagename|runs| 11:18:51 INFO - PROCESS | 22876 | |0;ai-astar;110;113;105;115;110;111;102;113;110;119 11:18:51 INFO - PROCESS | 22876 | |1;audio-beat-detection;151;125;153;163;131;146;152;130;163;125 11:18:51 INFO - PROCESS | 22876 | |2;audio-dft;164;162;162;161;161;163;161;163;163;163 11:18:51 INFO - PROCESS | 22876 | |3;audio-fft;72;72;89;97;73;72;74;102;93;72 11:18:51 INFO - PROCESS | 22876 | |4;audio-oscillator;94;95;138;94;94;94;137;94;95;135 11:18:51 INFO - PROCESS | 22876 | |5;imaging-gaussian-blur;110;109;109;109;109;110;109;110;109;110 11:18:51 INFO - PROCESS | 22876 | |6;imaging-darkroom;148;146;147;147;146;148;146;148;146;146 11:18:51 INFO - PROCESS | 22876 | |7;imaging-desaturate;95;96;96;95;95;95;95;96;95;95 11:18:51 INFO - PROCESS | 22876 | |8;json-parse-financial;58;59;59;59;59;57;59;69;55;57 11:18:51 INFO - PROCESS | 22876 | |9;json-stringify-tinderbox;69;70;69;68;70;69;70;70;69;70 11:18:51 INFO - PROCESS | 22876 | |10;stanford-crypto-aes;83;85;85;85;84;85;85;85;86;85 11:18:51 INFO - PROCESS | 22876 | |11;stanford-crypto-ccm;117;123;123;116;123;121;131;115;122;117 11:18:51 INFO - PROCESS | 22876 | |12;stanford-crypto-pbkdf2;146;143;152;152;155;142;154;151;152;145 11:18:51 INFO - PROCESS | 22876 | |13;stanford-crypto-sha256-iterative;67;68;68;67;69;68;66;69;67;67 11:18:51 INFO - PROCESS | 22876 | __end_tp_report 11:18:51 INFO - PROCESS | 22876 | __start_cc_report 11:18:51 INFO - PROCESS | 22876 | _x_x_mozilla_cycle_collect,919 11:18:51 INFO - PROCESS | 22876 | __end_cc_report 11:18:51 INFO - PROCESS | 22876 | __startTimestamp1450984731889__endTimestamp 11:18:51 INFO - PROCESS | 22876 | 11:18:51 INFO - PROCESS | 22876 | ------- Summary: start ------- 11:18:51 INFO - PROCESS | 22876 | Number of tests: 14 11:18:51 INFO - PROCESS | 22876 | 11:18:51 INFO - PROCESS | 22876 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:4.80 (4.3%) stddev-sans-first:5.09 11:18:51 INFO - PROCESS | 22876 | Values: 110.0 113.0 105.0 115.0 110.0 111.0 102.0 113.0 110.0 119.0 11:18:51 INFO - PROCESS | 22876 | 11:18:51 INFO - PROCESS | 22876 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:151.50 stddev:14.93 (9.9%) stddev-sans-first:15.62 11:18:51 INFO - PROCESS | 22876 | Values: 151.0 125.0 153.0 163.0 131.0 146.0 152.0 130.0 163.0 125.0 11:18:51 INFO - PROCESS | 22876 | 11:18:51 INFO - PROCESS | 22876 | [#2] audio-dft Cycles:10 Average:162.30 Median:163.00 stddev:1.06 (0.6%) stddev-sans-first:0.93 11:18:51 INFO - PROCESS | 22876 | Values: 164.0 162.0 162.0 161.0 161.0 163.0 161.0 163.0 163.0 163.0 11:18:51 INFO - PROCESS | 22876 | 11:18:51 INFO - PROCESS | 22876 | [#3] audio-fft Cycles:10 Average:81.60 Median:73.50 stddev:12.19 (16.6%) stddev-sans-first:12.43 11:18:51 INFO - PROCESS | 22876 | Values: 72.0 72.0 89.0 97.0 73.0 72.0 74.0 102.0 93.0 72.0 11:18:51 INFO - PROCESS | 22876 | 11:18:51 INFO - PROCESS | 22876 | [#4] audio-oscillator Cycles:10 Average:107.00 Median:94.00 stddev:20.49 (21.8%) stddev-sans-first:21.18 11:18:51 INFO - PROCESS | 22876 | Values: 94.0 95.0 138.0 94.0 94.0 94.0 137.0 94.0 95.0 135.0 11:18:51 INFO - PROCESS | 22876 | 11:18:51 INFO - PROCESS | 22876 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 11:18:51 INFO - PROCESS | 22876 | Values: 110.0 109.0 109.0 109.0 109.0 110.0 109.0 110.0 109.0 110.0 11:18:51 INFO - PROCESS | 22876 | 11:18:51 INFO - PROCESS | 22876 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 11:18:51 INFO - PROCESS | 22876 | Values: 148.0 146.0 147.0 147.0 146.0 148.0 146.0 148.0 146.0 146.0 11:18:51 INFO - PROCESS | 22876 | 11:18:51 INFO - PROCESS | 22876 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:18:51 INFO - PROCESS | 22876 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 11:18:51 INFO - PROCESS | 22876 | 11:18:51 INFO - PROCESS | 22876 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:59.00 stddev:3.73 (6.3%) stddev-sans-first:3.93 11:18:51 INFO - PROCESS | 22876 | Values: 58.0 59.0 59.0 59.0 59.0 57.0 59.0 69.0 55.0 57.0 11:18:51 INFO - PROCESS | 22876 | 11:18:51 INFO - PROCESS | 22876 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:70.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 11:18:51 INFO - PROCESS | 22876 | Values: 69.0 70.0 69.0 68.0 70.0 69.0 70.0 70.0 69.0 70.0 11:18:51 INFO - PROCESS | 22876 | 11:18:51 INFO - PROCESS | 22876 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.00 stddev:0.79 (0.9%) stddev-sans-first:0.50 11:18:51 INFO - PROCESS | 22876 | Values: 83.0 85.0 85.0 85.0 84.0 85.0 85.0 85.0 86.0 85.0 11:18:51 INFO - PROCESS | 22876 | 11:18:51 INFO - PROCESS | 22876 | [#11] stanford-crypto-ccm Cycles:10 Average:120.80 Median:122.50 stddev:4.78 (3.9%) stddev-sans-first:4.87 11:18:51 INFO - PROCESS | 22876 | Values: 117.0 123.0 123.0 116.0 123.0 121.0 131.0 115.0 122.0 117.0 11:18:51 INFO - PROCESS | 22876 | 11:18:51 INFO - PROCESS | 22876 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.20 Median:152.00 stddev:4.73 (3.1%) stddev-sans-first:4.88 11:18:51 INFO - PROCESS | 22876 | Values: 146.0 143.0 152.0 152.0 155.0 142.0 154.0 151.0 152.0 145.0 11:18:51 INFO - PROCESS | 22876 | 11:18:51 INFO - PROCESS | 22876 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:0.97 (1.4%) stddev-sans-first:1.00 11:18:51 INFO - PROCESS | 22876 | Values: 67.0 68.0 68.0 67.0 69.0 68.0 66.0 69.0 67.0 67.0 11:18:51 INFO - PROCESS | 22876 | -------- Summary: end -------- 11:18:51 INFO - PROCESS | 22876 | 11:18:52 INFO - TEST-INFO | 22876: exit 0 11:18:52 INFO - TEST-OK | kraken | took 59431ms 11:18:52 INFO - TEST-START | v8_7 11:18:52 INFO - operating with platform_type : linux_ 11:18:52 INFO - Initialising browser for v8_7 test... 11:18:52 INFO - TEST-INFO | started process 23126 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpy3x2P9/profile http://localhost:37106/getInfo.html) 11:18:57 INFO - PROCESS | 23126 | __metrics Screen width/height:1600/1200 11:18:57 INFO - PROCESS | 23126 | colorDepth:24 11:18:57 INFO - PROCESS | 23126 | Browser inner width/height: 1024/697 11:18:57 INFO - PROCESS | 23126 | __metrics 11:18:57 INFO - PROCESS | 23126 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:18:57 INFO - PROCESS | 23126 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:18:58 INFO - TEST-INFO | 23126: exit 0 11:18:58 INFO - Browser initialized. 11:18:58 INFO - Running cycle 1/1 for v8_7 test... 11:18:58 INFO - TEST-INFO | started process 23207 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpy3x2P9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:19:10 INFO - PROCESS | 23207 | RSS: Main: 148107264 11:19:10 INFO - PROCESS | 23207 | 11:19:31 INFO - PROCESS | 23207 | Cycle 1(1): loaded http://localhost:37106/tests/v8_7/run.html (next: http://localhost:37106/tests/v8_7/run.html) 11:19:32 INFO - PROCESS | 23207 | RSS: Main: 572035072 11:19:32 INFO - PROCESS | 23207 | 11:19:32 INFO - PROCESS | 23207 | __start_tp_report 11:19:32 INFO - PROCESS | 23207 | _x_x_mozilla_page_load 11:19:32 INFO - PROCESS | 23207 | _x_x_mozilla_page_load_details 11:19:32 INFO - PROCESS | 23207 | |i|pagename|runs| 11:19:32 INFO - PROCESS | 23207 | |0;Richards;166.63889351774705 11:19:32 INFO - PROCESS | 23207 | |1;DeltaBlue;196.46365422396858 11:19:32 INFO - PROCESS | 23207 | |2;Encrypt;287.85261945883707 11:19:32 INFO - PROCESS | 23207 | |3;Decrypt;5196.891191709845 11:19:32 INFO - PROCESS | 23207 | |4;RayTrace;1992.03187250996 11:19:32 INFO - PROCESS | 23207 | |5;Earley;766.2835249042146 11:19:32 INFO - PROCESS | 23207 | |6;Boyer;12132.530120481928 11:19:32 INFO - PROCESS | 23207 | |7;RegExp;25625 11:19:32 INFO - PROCESS | 23207 | |8;Splay;598.8023952095808 11:19:32 INFO - PROCESS | 23207 | |9;NavierStokes;4892.682926829269 11:19:32 INFO - PROCESS | 23207 | __end_tp_report 11:19:32 INFO - PROCESS | 23207 | __startTimestamp1450984772019__endTimestamp 11:19:32 INFO - PROCESS | 23207 | 11:19:32 INFO - PROCESS | 23207 | ------- Summary: start ------- 11:19:32 INFO - PROCESS | 23207 | Number of tests: 10 11:19:32 INFO - PROCESS | 23207 | 11:19:32 INFO - PROCESS | 23207 | [#0] Richards Cycles:1 Average:166.64 Median:166.64 stddev:0.00 (0.0%) 11:19:32 INFO - PROCESS | 23207 | Values: 166.6 11:19:32 INFO - PROCESS | 23207 | 11:19:32 INFO - PROCESS | 23207 | [#1] DeltaBlue Cycles:1 Average:196.46 Median:196.46 stddev:0.00 (0.0%) 11:19:32 INFO - PROCESS | 23207 | Values: 196.5 11:19:32 INFO - PROCESS | 23207 | 11:19:32 INFO - PROCESS | 23207 | [#2] Encrypt Cycles:1 Average:287.85 Median:287.85 stddev:0.00 (0.0%) 11:19:32 INFO - PROCESS | 23207 | Values: 287.9 11:19:32 INFO - PROCESS | 23207 | 11:19:32 INFO - PROCESS | 23207 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 11:19:32 INFO - PROCESS | 23207 | Values: 5196.9 11:19:32 INFO - PROCESS | 23207 | 11:19:32 INFO - PROCESS | 23207 | [#4] RayTrace Cycles:1 Average:1992.03 Median:1992.03 stddev:0.00 (0.0%) 11:19:32 INFO - PROCESS | 23207 | Values: 1992.0 11:19:32 INFO - PROCESS | 23207 | 11:19:32 INFO - PROCESS | 23207 | [#5] Earley Cycles:1 Average:766.28 Median:766.28 stddev:0.00 (0.0%) 11:19:32 INFO - PROCESS | 23207 | Values: 766.3 11:19:32 INFO - PROCESS | 23207 | 11:19:32 INFO - PROCESS | 23207 | [#6] Boyer Cycles:1 Average:12132.53 Median:12132.53 stddev:0.00 (0.0%) 11:19:32 INFO - PROCESS | 23207 | Values: 12132.5 11:19:32 INFO - PROCESS | 23207 | 11:19:32 INFO - PROCESS | 23207 | [#7] RegExp Cycles:1 Average:25625.00 Median:25625.00 stddev:0.00 (0.0%) 11:19:32 INFO - PROCESS | 23207 | Values: 25625.0 11:19:32 INFO - PROCESS | 23207 | 11:19:32 INFO - PROCESS | 23207 | [#8] Splay Cycles:1 Average:598.80 Median:598.80 stddev:0.00 (0.0%) 11:19:32 INFO - PROCESS | 23207 | Values: 598.8 11:19:32 INFO - PROCESS | 23207 | 11:19:32 INFO - PROCESS | 23207 | [#9] NavierStokes Cycles:1 Average:4892.68 Median:4892.68 stddev:0.00 (0.0%) 11:19:32 INFO - PROCESS | 23207 | Values: 4892.7 11:19:32 INFO - PROCESS | 23207 | -------- Summary: end -------- 11:19:32 INFO - PROCESS | 23207 | 11:19:32 INFO - TEST-INFO | 23207: exit 0 11:19:32 INFO - TEST-OK | v8_7 | took 40053ms 11:19:32 INFO - SUITE-END | took 1214s 11:19:33 INFO - Completed test suite (00:20:14) 11:19:33 INFO - Working with test: dromaeo_css 11:19:33 INFO - Generating results file: dromaeo_css 11:19:33 INFO - Working with test: kraken 11:19:33 INFO - Generating results file: kraken 11:19:33 INFO - javascript benchmark 11:19:33 INFO - Working with test: v8_7 11:19:33 INFO - Generating results file: v8_7 11:19:33 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:19:33 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 11:19:33 INFO - process_Request line: dromaeo_css 6925.32 graph.html#tests=[[72,64,35]] 11:19:33 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:19:33 INFO - process_Request line: kraken 1508.00 graph.html#tests=[[232,64,35]] 11:19:33 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:19:33 INFO - process_Request line: v8_7 19772.66 graph.html#tests=[[230,64,35]] 11:19:33 INFO - RETURN: dromaeo_css: 6925.32 11:19:33 INFO - RETURN: kraken: 1508.00 11:19:33 INFO - RETURN: v8_7: 19772.66 11:19:33 INFO - javascript benchmark 11:19:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3178.141901686546, 3180.3003339265356, 3252.7072563469296, 3254.772165948383, 3276.8689252429904, 5158.613104017204, 5265.052290587692, 5366.060939335615, 5411.891762164754, 5460.754266058027, 5240.213967904816, 5336.9733151334185, 5482.095454250054, 5485.396606373296, 5486.765477767501, 4854.781534830932, 4919.60643148549, 4942.0, 4948.703077815325, 5005.924911126336, 4953.257011448293, 4983.576396006344, 5060.898782024357, 5112.846614601568, 5125.0, 4911.631627627907, 5013.448520662724, 5050.267711181895, 5054.393472783253, 5123.666961647481, 4837.516248375169, 4928.482509336504, 4940.7035577865445, 4947.332110165117, 4951.282064100686, 4869.659123861331, 4872.317875497433, 4893.8776530586665, 4899.093667671492, 4900.779464924087, 5143.331366922276, 5227.26818245446, 5231.215317702337, 5261.631685781997, 5300.496452836975, 5937.495312898365, 5940.46535811779, 5950.375210602911, 5953.464188223037, 5960.880782384372, 5985.521158307369, 5994.700264986777, 5994.760209591611, 5998.970005149947, 6033.849153771147, 5315.0, 5421.26812880264, 5443.755031023653, 5447.4824891635235, 5557.5831812614215, 5964.7912323068485, 5968.46283834457, 6020.096985452217, 6063.319157402537, 6097.939020609826, 5749.252597162425, 5754.798582049608, 5757.798477053283, 5761.48146666802, 5791.218185544982, 5766.221560089418, 5815.098659707667, 5871.178035075093, 5879.412058794172, 5930.436608522184, 5783.8554036149435, 5817.214676018768, 5832.445917637818, 5859.677717725566, 5878.030125029408, 5849.590528663038, 5852.7658893643775, 5858.47273745365, 5863.912041319383, 5866.413358664099, 4401.977990110029, 4451.732896026248, 4480.507144214133, 4483.932741008887, 4488.730676159375, 3986.880393588197, 3989.6608788252743, 4001.2597669431248, 4027.3958906163725, 4030.294698427822, 5367.704776237344, 5369.973150134224, 5370.91943620846, 5390.730463476811, 5412.025835349675, 5778.191053252548, 5817.592768506164, 5843.094320380348, 5907.438793314628, 5970.283565972111, 5462.044142275086, 5465.726713664301, 5468.7539060741565, 5476.616636835463, 5486.478784515464, 5047.192449208109, 5052.494750524992, 5053.267276244924, 5079.161938280216, 5097.439281679012, 5807.477327040587, 5887.764489420375, 5906.438888305604, 5918.911216331759, 6077.088436734437, 5848.2689663792025, 5857.853553661193, 5866.149408335853, 5887.3523912370465, 5948.583599148191, 6022.698865056817, 6055.182550355646, 6059.091136329585, 6069.908951365821, 6072.05883088122, 5703.344115426613, 5752.13717942312, 5787.39232380594, 5804.100364443518, 5810.273715785527, 5818.185454036354, 5856.092305692625, 5856.795012174553, 5860.413958604106, 5890.558208134321, 5701.4298570142655, 5703.914441283301, 5705.0, 5712.6286791358425, 5726.026575482095, 5560.193771903132, 5694.772209111755, 5710.486056254791, 5749.425057494217, 5867.530597552271, 5616.887662246814, 5618.044932361427, 5620.04459241938, 5623.775048997994, 5624.578156638187, 5720.3421606515785, 5740.225069615549, 5742.937556552051, 5745.023346031101, 5795.391483894299, 5415.241866138665, 5472.343318801769, 5531.502164805187, 5558.305211848519, 5684.63049901755], "unit": "score", "name": "dojo.html", "value": 5377.545920417717}, {"lowerIsBetter": false, "replicates": [551.236537395707, 599.5623195067601, 606.620861961274, 610.4963405190719, 614.1892701633845, 38179.0, 39695.801520992354, 39740.0, 39797.0, 39810.20379592406, 42423.57576424235, 42873.14253714932, 42898.14203715924, 43028.569714302845, 43255.78372108143, 7443.739469118582, 7563.2436756324205, 8537.231649151576, 8692.869606955868, 9898.604055837794, 10159.238057145707, 10218.744531386701, 10239.334443261201, 10272.0, 10294.3823370598, 10296.588136474533, 10325.173986081096, 10379.910109438513, 10403.323783954056, 10426.322289051226, 7601.163871974079, 7741.8838717419, 10166.237532185116, 10332.225083118721, 10339.0, 9847.803043939153, 9958.651447199314, 9960.452175130366, 9966.252531060127, 9980.800383992351, 37468.250634987424, 37762.43356349657, 37842.81078594617, 37952.810235948644, 38044.23911521754, 3195.472746996743, 3396.2018925552475, 3461.6884480396884, 3682.502862113607, 3830.1382189007527, 30568.69431305703, 30813.537796933066, 31176.376472470423, 31595.21011974696, 32200.67799322, 3837.712171587142, 3845.270776141752, 3852.174301942495, 3998.5005622891417, 4050.979745101285, 272074.0, 273896.0, 274131.0, 274139.999999998, 274818.0, 53951.46048539543, 54761.45238547563, 58835.0, 67318.0, 68181.65909170422, 60924.390756092755, 61222.38777612256, 61438.692806535684, 61476.6187859672, 61493.69253153705, 13350.933245333712, 13477.797833032513, 13490.0, 13498.93250533741, 13503.527376541773, 10014.649487268056, 10019.79960400788, 10073.848892266622, 10088.293819432716, 10150.796984060278, 20287.594248114954, 20560.58878822415, 20600.896995514926, 20646.483837904172, 20761.480962976046, 7595.962020189863, 7785.4170616587435, 7790.5325680459355, 7804.531728096333, 7862.410319226081, 912.6851236323457, 914.5655813488539, 945.3854994253653, 1012.1649639047815, 1100.471773548701, 28689.85655071711, 28728.0, 28749.425011499654, 28934.0, 29193.416131677248, 968.3899143539666, 989.317371013998, 1002.2733518199248, 1058.2486434631498, 1063.723431907694, 14690.26548672562, 15328.923355383375, 15470.0, 15586.298616562282, 16020.67958640844, 248634.0, 251605.0, 251981.0, 252008.0, 252152.0, 48356.0, 48499.272510912364, 48563.271550926765, 48603.27095093577, 48606.0, 1208.601161616682, 1237.4926280225066, 1253.5863165155658, 1294.5210272199347, 1295.598364507006, 28799.712002879704, 29414.852925735235, 29700.70299297066, 29870.551941721325, 30135.246618834706, 43829.34255986226, 44643.776781115885, 54572.0, 55476.72261638666, 55623.16565251605, 246102.0, 246654.0, 248522.0, 248761.0, 249746.0, 27514.724852752017, 27894.581581276703, 31032.0, 31132.0, 31257.218569535034, 42783.14433711371, 43096.0, 43206.351904720825, 43463.78268108639, 44141.0, 33310.66689333173, 41532.0, 42058.0, 42306.57693423027, 44602.77698611616, 36999.260014799016, 40072.3989140169, 40181.19637607173, 40280.59719402769, 40401.191976159724, 38148.427773582865, 39343.40984885286, 39704.80147599243, 39774.0, 39815.80092099521, 37494.81252593829, 37921.81039094787, 38614.80692596519, 39939.201215974936, 40175.3973690389, 27295.317617059733, 27908.720912791425, 27949.860250698617, 28049.579256310764, 28072.719272807826], "unit": "score", "name": "ext.html", "value": 18746.630643770815}, {"lowerIsBetter": false, "replicates": [354.7002782648662, 355.6123825030716, 358.49094286113734, 361.7738913179263, 365.6398447529184, 14169.079009864352, 14190.0, 16457.670846583074, 16707.83292167078, 16752.246148923296, 12115.575954841583, 12548.623541293753, 14356.425742970294, 14382.640433989129, 15023.624409389771, 5146.45962173971, 5225.712585807779, 5275.575594589478, 5275.841724748264, 5278.155495120782, 3814.4469051987444, 3898.161895192533, 5186.7147306898105, 5290.497402746733, 5323.866903327409, 5578.414266501999, 5780.9710951445395, 5786.305643322786, 5821.27234095738, 5826.9708651456685, 5366.624336296461, 5372.7313634318125, 5578.693171875545, 5757.769689212427, 5788.739506722208, 5082.237664350377, 5175.974120129413, 5180.041692286939, 5184.688918664892, 5185.637005409623, 20333.694994575093, 20466.897665511577, 20685.68971465429, 20790.376288711363, 20805.16779328825, 2132.552164045552, 2171.250918433138, 2325.5232677301115, 2390.306811024801, 2557.450148218142, 12789.93605031969, 13099.34503274842, 13162.09149673292, 13534.120282181726, 13574.86425135746, 1492.2538730634683, 1655.6109314311127, 1661.1113054515897, 1672.3143511160365, 1693.3903794633923, 54641.0, 57376.71311643415, 57792.84414311732, 58046.419535804525, 58048.41951580472, 9545.140937315675, 9667.70996870095, 9774.875889272682, 9866.654667086761, 9910.256730745223, 12598.748025039631, 12664.936675316749, 12684.619461416172, 12693.492260309484, 12707.936460317824, 7079.469039822034, 7147.9285207148305, 7165.0, 7240.348368646742, 7248.637568121573, 6849.280825513349, 6863.794086177422, 6889.414399776075, 6919.0, 6934.687939042654, 5781.739821708034, 5866.97327967604, 5881.264841894763, 5885.588008839341, 5912.497437717842, 1580.6759614279044, 1659.402615058578, 1720.9760192685333, 1727.2054854766698, 1731.5584525945803, 912.780932576177, 939.7556635274877, 948.6821914658528, 979.8824141103113, 1024.2881197567767, 16816.822822402315, 17178.828211717722, 17609.295628174987, 17778.46664600064, 18042.729359059624, 831.1231650608665, 902.3769565195744, 922.1193759959223, 929.5166513413122, 930.3719989007393, 9773.951130244302, 9900.0, 10219.540120694586, 10307.123894468905, 10322.741931451623, 542179.0, 557851.0, 561316.0, 564508.0, 565856.0, 71317.2868271321, 78248.60875695584, 79322.0, 79409.20590794133, 80780.19219807844, 1079.1205167788385, 1096.6545538155456, 1108.6895669212795, 1114.1838802751624, 1118.2451845004753, 15704.76442853381, 15857.127857967922, 16143.0, 16373.263203156124, 16468.258928348012, 27663.72336276692, 32171.839140804146, 32199.0, 32467.0, 33737.493937590465, 40760.388594170516, 42511.787441062595, 43492.13015739731, 44476.55523444853, 48165.518344816104, 9548.85676714836, 9737.123658870736, 9895.851562226717, 9911.851322230028, 9932.553035113582, 11653.76692466163, 11712.180147389601, 11733.296002239893, 11793.29240245588, 11806.527738890349, 11915.0, 12407.25556466615, 12734.0, 13560.186388816703, 13568.0, 13588.320583970959, 14206.715865682836, 14354.138751674933, 14441.927790360982, 14602.12387256768, 12223.93888030554, 12915.612531624067, 13494.865051349361, 14192.219427931563, 14219.289035547974, 9505.714828555154, 9597.760055998657, 9787.706368808947, 9816.0, 9833.360831545926, 13448.865511344762, 13674.52139175164, 13770.862291377358, 13788.793168102688, 13934.721305574034], "unit": "score", "name": "jquery.html", "value": 8711.290655934172}, {"lowerIsBetter": false, "replicates": [1197.359412714198, 1636.263681343395, 1655.9172041397935, 1724.1810140183413, 1791.2118667786176, 6458.9677051614735, 6985.580865148095, 7106.182788979269, 7116.430685545157, 7133.357997780199, 7181.82045448864, 7418.072740907387, 7427.108746950374, 7434.070741157356, 7436.5166264192785, 1950.1321911749278, 1993.9302124425649, 1996.3611644273838, 2222.599932012241, 2262.2082271205027, 1978.4262563856464, 2188.4638263625434, 2228.2089858100385, 2233.1179184222224, 2259.3899647095272, 2080.490279881431, 2127.5319429725437, 2211.358705975273, 2215.0253888289103, 2216.4902072523328, 2198.5712786006734, 2201.4716468047714, 2221.7889300516426, 2225.0765932138142, 2225.5660146271402, 2204.713387259646, 2239.361781892153, 2253.6506841439605, 2254.233560589391, 2262.581422436838, 7414.851702965964, 7479.813004674872, 7482.289182527651, 7488.213737557532, 7491.475596708233, 4294.9785251073545, 4329.220740266751, 4331.740095594243, 4358.5205627380965, 4374.431323927869, 2929.399473108008, 2929.9853500732575, 2996.925076873074, 3014.668386477486, 3020.305329774142, 940.1303793990531, 971.3394891473795, 977.8337682593976, 1001.1640280365904, 1001.9048190421898, 9698.36960597566, 9749.561269742879, 9756.95121524395, 9764.804703905953, 9773.41359518424, 3874.0702231464247, 3875.1862108957434, 3895.182011777502, 3928.3125453045604, 3973.8609148679657, 8534.231919127309, 8543.401961862734, 8574.314054875595, 8574.485530868167, 8574.95712521446, 4321.762303073361, 4332.718373305725, 4344.370066340363, 4359.215341238544, 4364.585364390377, 3989.980050099789, 3996.1208534122447, 3996.660283875845, 3998.6001399859783, 4002.8598999034893, 3236.6277878043857, 3578.302231064917, 3593.1196856769734, 3601.963980360163, 3647.598764135943, 1092.4319353936069, 1122.5173175534599, 1144.2047776795214, 1147.3230793831679, 1153.7807816514835, 1015.9644412445676, 1016.9389836609827, 1042.6455005298235, 1054.9367037977745, 1062.7396287909512, 7118.537295075804, 7146.464015198881, 7204.387627051655, 7229.963850180716, 7236.746713864989, 1067.1622776120707, 1070.9678709638724, 1086.8804431512526, 1094.819354806464, 1103.4979084516526, 5534.976029434568, 5589.580781441408, 5621.325440947113, 5624.690642014729, 5632.915506267409, 8331.8333633327, 8611.0, 8748.606312715943, 8795.47227166372, 8799.032106468283, 8583.613737381833, 8638.913610863936, 8673.176048275403, 8673.609687564074, 8698.304135669257, 6655.0, 6750.6624668767345, 6852.45180385568, 6899.655017249117, 6952.791416257521, 6666.366695163952, 6684.4652427804685, 6697.09589205451, 6714.6978385973725, 6721.932780672326, 7687.423443241667, 7885.684572617031, 7891.605419728876, 7896.447248692766, 7903.802404939923, 7818.413618978486, 7827.726029588937, 7979.082405523439, 8086.757397278091, 8089.878651820345, 6361.745530178741, 6457.321981191907, 6502.3172566881685, 6507.28419873823, 6604.306547812411, 6402.6158430494315, 6561.442277406474, 7254.129504459499, 7305.525140865827, 7318.780436586911, 6396.808095757135, 6480.870382592416, 6715.764948226984, 6749.86500269982, 6839.487038472035, 6592.0, 6617.636030018395, 6644.867102657823, 6697.0, 6703.463722902254, 6372.808815735535, 6411.807645770635, 6447.194100737408, 6452.35476452351, 6459.773907913201, 5935.614185078129, 5970.194023806905, 5975.193348897843, 5977.326348622392, 5982.670953097621, 5817.331006934257, 5863.325717542537, 5868.061110222344, 5878.529717622494, 5913.822585322448], "unit": "score", "name": "mootools.html", "value": 4237.348160443918}, {"lowerIsBetter": false, "replicates": [337.09490019298187, 338.43481386085233, 346.95663042119736, 347.74093300491137, 353.8195520284654, 6011.639301641904, 6037.275526936768, 6040.0, 6063.120847477113, 6137.87724245516, 5728.598998070126, 5783.421657834215, 5934.703264836762, 5980.671063091529, 6018.9398106018925, 4631.120087183441, 4631.884202894921, 4636.768161591907, 4655.813767449306, 4665.926836827532, 4447.377367168583, 4636.5595268449615, 4652.790624421892, 4652.97673511632, 4653.092646933849, 4488.97755511222, 4502.909941801162, 4628.907421851561, 4636.953630463703, 4670.182718024349, 4578.336141259499, 4617.422822147231, 4622.58396744293, 4626.051659409846, 4636.582707556319, 4080.326746086892, 4083.7141400102005, 4083.8570650027104, 4084.836606535735, 4095.5290141633795, 5587.580931430119, 5676.290463692038, 5745.224394706703, 5754.223179870705, 5756.0, 5350.946490535084, 5363.919541206885, 5364.034473794715, 5365.03429382711, 5382.515573598355, 6443.613383197023, 6446.419822216023, 6447.580907241015, 6448.709808058648, 6452.257990331125, 4456.7548784817145, 4462.352958820985, 4462.553744625544, 4465.910681786346, 4479.910401791978, 6587.703553340111, 6649.0, 6701.262861085325, 6706.094677218611, 6710.496712746563, 4575.359449677047, 4575.519570445122, 4579.816807327737, 4580.061087477059, 4585.679002469862, 4633.582977532038, 4636.374089497875, 4642.141203877293, 4642.3500709900645, 4649.488556258809, 5359.062164121263, 5362.2224777407055, 5366.543843773245, 5367.892642147213, 5379.515843574097, 6309.842253943596, 6428.71070801815, 6475.32009139043, 6486.935130648633, 6492.5455218134275, 1632.5428879913643, 1646.9588260293588, 1648.32418708329, 1649.150687395992, 1649.4556796257207, 1093.7101668057971, 1095.4960718069617, 1098.3355070182583, 1101.3446999035561, 1119.6361182615683, 6108.450239478469, 6112.205413296243, 6115.541334399849, 6116.633002019804, 6119.082137679384, 6469.159009328757, 6585.111010013683, 6624.0, 6636.535442518977, 6642.236142843538, 6012.579119461683, 6066.272047354346, 6172.043333283348, 6187.257529096447, 6201.906971395432, 3580.838862251205, 3629.9637003630155, 3631.5823680276576, 3633.3823250047553, 3635.1093981974586, 6664.433523150587, 6897.379235868796, 6897.55165914214, 6899.724011039602, 6903.102596662402, 6866.485013623998, 6868.553544019623, 6869.175698916162, 6873.415759660485, 6879.552829066195, 6940.271271516519, 6948.478864085214, 6949.0, 6949.339812717885, 6957.234704182536, 6499.7400103995315, 6692.063111164343, 6710.396064354231, 6712.228093769084, 6713.899291510729, 6582.80251592453, 6601.0, 6630.701618427279, 6643.56816806906, 6661.233958094687, 6940.236573976757, 6940.9652951734915, 6944.618046007518, 6948.826279343057, 6961.164660240804, 4490.618297444754, 4499.7975091120325, 4500.189965806187, 4503.707259028152, 4505.662075344297, 6550.0, 6724.226713927961, 6728.0, 6737.66311684404, 6746.392824645805, 6504.772332968323, 6507.544471886922, 6509.153810004669, 6517.185351831021, 6518.73925042993, 6265.624062556261, 6488.156539649815, 6498.545101842826, 6504.804855854332, 6506.41442270198, 6324.905126423016, 6360.77737279193, 6372.044193371032, 6372.55392122547, 6379.170707808141, 6509.511786616117, 6522.119513865758, 6523.804285871432, 6528.804135875931, 6536.477081833537, 6226.968865155645, 6380.202474690664, 6380.649064301508, 6381.266154392304, 6387.201599800025], "unit": "score", "name": "prototype.html", "value": 4863.0751848241325}, {"lowerIsBetter": false, "replicates": [718.5042320798652, 753.4800987318753, 797.5135167547795, 856.3192262151589, 864.5417928497897, 12523.561675341365, 12685.492580296801, 12778.744425111492, 12800.103992720513, 12806.615801525957, 11164.162687798407, 11823.994960428352, 12665.303408312539, 12841.80737288939, 12848.74302513949, 803.7990502374391, 822.4695071678764, 825.9050209225956, 826.6197549127409, 827.3960009193293, 804.2801692485223, 808.312934006096, 809.7975506123469, 810.307187354812, 810.9026916769996, 833.5540485840077, 834.1241696218976, 838.3921656798802, 840.3613253927028, 841.8232171244047, 830.6677329068391, 831.8960129983752, 832.0389949608242, 832.7585000349891, 833.4915701422127, 617.2839506172818, 617.9907301390483, 618.0636335951037, 619.0373968479013, 619.8419403052193, 11341.489632966537, 11463.0, 11499.080073594176, 11499.827502587468, 11539.423028848523, 10358.43028633425, 10465.68602941913, 10531.84202236967, 10620.415877126756, 11071.225014249007, 9659.178969787576, 9694.903050969471, 9797.90202097977, 9830.705078847646, 9970.651027214013, 3544.85820567177, 3571.4821350904235, 3588.2644057968055, 3588.569371675416, 3592.317459682652, 45053.54946450559, 45109.3233601493, 45113.77443112763, 45166.32250516245, 45300.3204951926, 8742.650293988296, 8748.0, 8791.956040219886, 8850.336224783166, 8954.0, 16098.517044488684, 16107.838921610868, 16145.838541614668, 16147.757783633255, 16165.4342098026, 7117.92882071183, 7154.785356439315, 7232.710691572383, 7355.448341374418, 7566.054243219598, 3949.0, 4124.6906482013965, 4155.729877557949, 4168.979155104205, 4241.978790106092, 2864.3698386354968, 2940.9264768380963, 2953.4979053560946, 2954.512505436579, 2959.097475270063, 599.4005994005994, 602.1299222623355, 604.9969750151309, 616.4359610956014, 618.7401291457599, 646.767163821024, 654.2508827392609, 670.5842377725744, 678.0334053061248, 678.9694463749144, 8585.941831367842, 8606.967163940368, 8616.09530999236, 8662.783430414163, 8711.738647840575, 602.8975074237391, 617.219217689623, 630.0710315927104, 651.2543138106842, 669.1802541886151, 3538.805365704911, 4182.707210495297, 4291.31338985767, 4301.354796780508, 4359.280718681445, 52117.0, 52649.99825016617, 52967.735161323944, 53050.73474632602, 53089.46910530845, 44514.554854451686, 46518.767406162755, 47108.764456178185, 55088.17367739487, 55800.72099639476, 44834.0, 45116.54883451123, 45523.089538209715, 45711.08577828491, 45910.31134532985, 6923.584584924921, 8623.568821559022, 8757.343199259954, 8878.95560522219, 9036.23192028685, 33477.83261083679, 33541.16147096342, 33545.0, 33664.66335336615, 34092.31815363729, 43317.566824331356, 43939.0, 44000.779996099816, 44058.55941440545, 44257.0, 10675.359478431319, 10684.412357320422, 10727.356358618508, 10765.138788897026, 10898.07366373867, 11565.768684626091, 12067.879321206676, 12269.447874845475, 12300.261984280973, 12625.621231363073, 11147.442627868411, 11311.208215424842, 11397.202195846212, 11416.486258118572, 11865.644030679094, 11162.550674586057, 11208.0, 11365.204435689422, 11497.252678575866, 11760.882391176321, 10501.0, 10701.518431670438, 10853.34879907208, 10994.450277485934, 11044.558217671203, 9054.185123338932, 9154.633814647339, 9197.816043679222, 9664.855027174739, 9761.80476390454, 8505.031145184395, 8659.6103175356, 8726.738197854074, 9220.723378298662, 9246.630134794534], "unit": "score", "name": "yui.html", "value": 6095.380849331183}], "name": "dromaeo_css", "value": 6925.312849290341}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 105.0, 115.0, 110.0, 111.0, 102.0, 113.0, 110.0, 119.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [151.0, 125.0, 153.0, 163.0, 131.0, 146.0, 152.0, 130.0, 163.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 143.9}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 162.0, 161.0, 161.0, 163.0, 161.0, 163.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.3}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 89.0, 97.0, 73.0, 72.0, 74.0, 102.0, 93.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.6}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 138.0, 94.0, 94.0, 94.0, 137.0, 94.0, 95.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 107.0}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 147.0, 146.0, 148.0, 146.0, 148.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 59.0, 59.0, 59.0, 57.0, 59.0, 69.0, 55.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.1}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 68.0, 70.0, 69.0, 70.0, 70.0, 69.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [117.0, 123.0, 123.0, 116.0, 123.0, 121.0, 131.0, 115.0, 122.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.8}, {"lowerIsBetter": true, "replicates": [146.0, 143.0, 152.0, 152.0, 155.0, 142.0, 154.0, 151.0, 152.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.2}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 67.0, 69.0, 68.0, 66.0, 69.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1507.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.63889351774705], "unit": "score", "name": "Richards", "value": 211.84730199999996}, {"lowerIsBetter": false, "replicates": [196.46365422396858], "unit": "score", "name": "DeltaBlue", "value": 336.5406200000001}, {"lowerIsBetter": false, "replicates": [287.85261945883707], "unit": "score", "name": "Encrypt", "value": 924.7127939999998}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1992.03187250996], "unit": "score", "name": "RayTrace", "value": 371.474478}, {"lowerIsBetter": false, "replicates": [766.2835249042146], "unit": "score", "name": "Earley", "value": 869.7342150000001}, {"lowerIsBetter": false, "replicates": [12132.530120481928], "unit": "score", "name": "Boyer", "value": 54.93190566037737}, {"lowerIsBetter": false, "replicates": [25625.0], "unit": "score", "name": "RegExp", "value": 35.55063414634149}, {"lowerIsBetter": false, "replicates": [598.8023952095808], "unit": "score", "name": "Splay", "value": 136.08996999999997}, {"lowerIsBetter": false, "replicates": [4892.682926829269], "unit": "score", "name": "NavierStokes", "value": 303.3100697906281}], "name": "v8_7", "value": 19772.659743320277}]} 11:19:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19772.66"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1508.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6925.32"}}} 11:19:33 INFO - Return code: 0 11:19:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:19:33 INFO - # TBPL SUCCESS # 11:19:33 INFO - Running post-action listener: _resource_record_post_action 11:19:33 INFO - Running post-run listener: _resource_record_post_run 11:19:34 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 564977664; Read time: 8; Write time: 1057484 11:19:34 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 242061312; Read time: 0; Write time: 536992 11:19:34 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 4096; Write bytes: 318857216; Read time: 8; Write time: 520176 11:19:34 INFO - Running post-run listener: _upload_blobber_files 11:19:34 INFO - Blob upload gear active. 11:19:34 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:19:34 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 11:19:34 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'] 11:19:34 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 11:19:34 INFO - (blobuploader) - INFO - Open directory for files ... 11:19:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 11:19:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:19:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:19:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:19:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:19:35 INFO - (blobuploader) - INFO - Done attempting. 11:19:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:19:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:19:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:19:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:19:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:19:36 INFO - (blobuploader) - INFO - Done attempting. 11:19:36 INFO - (blobuploader) - INFO - Iteration through files over. 11:19:36 INFO - Return code: 0 11:19:36 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:19:36 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:19:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7375c4e9a43e162d284fe2a2a0de213b5b0b48921a16073a76ae4ac67bea2e9d1b0f52be92d4bcecbafc3c941c94adfaed02cd68f29db2d589d9f0cb45417616", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ebf8b11ce1a2a07f9fea56422127a15c760c3cfde12d9e692891b15c01ff81b230832e660efd7af48e0387e2d17957aa536ca2327c0362735c6655880a03ed25"} 11:19:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:19:36 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:19:36 INFO - Contents: 11:19:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7375c4e9a43e162d284fe2a2a0de213b5b0b48921a16073a76ae4ac67bea2e9d1b0f52be92d4bcecbafc3c941c94adfaed02cd68f29db2d589d9f0cb45417616", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ebf8b11ce1a2a07f9fea56422127a15c760c3cfde12d9e692891b15c01ff81b230832e660efd7af48e0387e2d17957aa536ca2327c0362735c6655880a03ed25"} 11:19:36 INFO - Copying logs to upload dir... 11:19:36 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1267.474880 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-24 11:19:34.420981) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-24 11:19:34.424364) ========= 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=0ae9de487587ba4b94dd3100000001b5-1450983507.314307-1134351290 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/7375c4e9a43e162d284fe2a2a0de213b5b0b48921a16073a76ae4ac67bea2e9d1b0f52be92d4bcecbafc3c941c94adfaed02cd68f29db2d589d9f0cb45417616", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ebf8b11ce1a2a07f9fea56422127a15c760c3cfde12d9e692891b15c01ff81b230832e660efd7af48e0387e2d17957aa536ca2327c0362735c6655880a03ed25"} build_url:https://queue.taskcluster.net/v1/task/l4l_G2N7TNWe9diKDRxaaA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011328 build_url: 'https://queue.taskcluster.net/v1/task/l4l_G2N7TNWe9diKDRxaaA/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/7375c4e9a43e162d284fe2a2a0de213b5b0b48921a16073a76ae4ac67bea2e9d1b0f52be92d4bcecbafc3c941c94adfaed02cd68f29db2d589d9f0cb45417616", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ebf8b11ce1a2a07f9fea56422127a15c760c3cfde12d9e692891b15c01ff81b230832e660efd7af48e0387e2d17957aa536ca2327c0362735c6655880a03ed25"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-24 11:19:34.450658) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 11:19:34.451144) ========= 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=0ae9de487587ba4b94dd3100000001b5-1450983507.314307-1134351290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004407 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 11:19:34.533759) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-24 11:19:34.534114) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-24 11:19:34.534504) ========= ========= Total master_lag: 0.21 =========