builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1452605904.64 results: success (0) buildid: 20160112030227 builduid: 4124b34476ae432886b754639501efec revision: e790bba372f14241addda469a4bdb7ab00786ab3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 05:38:24.642676) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 05:38:24.643214) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 05:38:24.643601) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452605748.118281-1908812497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006368 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 05:38:24.674847) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 05:38:24.675192) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 05:38:24.726408) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:38:24.726811) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452605748.118281-1908812497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018789 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:38:24.778421) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 05:38:24.778785) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 05:38:24.779225) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:38:24.779541) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452605748.118281-1908812497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-12 05:38:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 96.9M=0s 2016-01-12 05:38:24 (96.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111668 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:38:24.903985) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:38:24.904403) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452605748.118281-1908812497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.048253 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:38:24.964989) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:38:24.965460) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e790bba372f14241addda469a4bdb7ab00786ab3 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev e790bba372f14241addda469a4bdb7ab00786ab3 --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=a4ce256d2ec601f24a60a71e000001bc-1452605748.118281-1908812497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-12 05:38:25,049 truncating revision to first 12 chars 2016-01-12 05:38:25,049 Setting DEBUG logging. 2016-01-12 05:38:25,049 attempt 1/10 2016-01-12 05:38:25,049 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e790bba372f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-12 05:38:25,380 unpacking tar archive at: mozilla-central-e790bba372f1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.662851 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 05:38:25.641131) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 05:38:25.641456) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 05:38:25.650514) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 05:38:25.650799) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 05:38:25.651224) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 40 secs) (at 2016-01-12 05:38:25.651515) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=a4ce256d2ec601f24a60a71e000001bc-1452605748.118281-1908812497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:38:25 INFO - MultiFileLogger online at 20160112 05:38:25 in /builds/slave/test-pgo 05:38:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:38:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:38:25 INFO - {'append_to_log': False, 05:38:25 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:38:25 INFO - 'blob_upload_branch': 'Firefox', 05:38:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:38:25 INFO - 'branch': 'Firefox', 05:38:25 INFO - 'buildbot_json_path': 'buildprops.json', 05:38:25 INFO - 'config_files': ('talos/linux_config.py',), 05:38:25 INFO - 'default_actions': ('clobber', 05:38:25 INFO - 'read-buildbot-config', 05:38:25 INFO - 'download-and-extract', 05:38:25 INFO - 'populate-webroot', 05:38:25 INFO - 'create-virtualenv', 05:38:25 INFO - 'install', 05:38:25 INFO - 'run-tests'), 05:38:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:38:25 INFO - 'download_minidump_stackwalk': True, 05:38:25 INFO - 'download_symbols': 'ondemand', 05:38:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:38:25 INFO - 'tooltool.py': '/tools/tooltool.py', 05:38:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:38:25 INFO - '/tools/misc-python/virtualenv.py')}, 05:38:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:38:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:38:25 INFO - 'installer_path': 'installer.exe', 05:38:25 INFO - 'log_level': 'info', 05:38:25 INFO - 'log_name': 'talos', 05:38:25 INFO - 'log_to_console': True, 05:38:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:38:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:38:25 INFO - 'opt_config_files': (), 05:38:25 INFO - 'pip_index': False, 05:38:25 INFO - 'sps_profile': False, 05:38:25 INFO - 'sps_profile_interval': 0, 05:38:25 INFO - 'suite': 'dromaeojs', 05:38:25 INFO - 'system_bits': '32', 05:38:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:38:25 INFO - 'title': 'talos-linux64-ix-062', 05:38:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:38:25 INFO - 'use_talos_json': True, 05:38:25 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:38:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:38:25 INFO - 'work_dir': 'build'} 05:38:25 INFO - ##### 05:38:25 INFO - ##### Running clobber step. 05:38:25 INFO - ##### 05:38:25 INFO - Running pre-action listener: _resource_record_pre_action 05:38:25 INFO - Running main action method: clobber 05:38:25 INFO - rmtree: /builds/slave/test-pgo/build 05:38:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:38:26 INFO - Running post-action listener: _resource_record_post_action 05:38:26 INFO - ##### 05:38:26 INFO - ##### Running read-buildbot-config step. 05:38:26 INFO - ##### 05:38:26 INFO - Running pre-action listener: _resource_record_pre_action 05:38:26 INFO - Running main action method: read_buildbot_config 05:38:26 INFO - Using buildbot properties: 05:38:26 INFO - { 05:38:26 INFO - "project": "", 05:38:26 INFO - "product": "firefox", 05:38:26 INFO - "script_repo_revision": "production", 05:38:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:38:26 INFO - "repository": "", 05:38:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:38:26 INFO - "buildid": "20160112030227", 05:38:26 INFO - "stage_platform": "linux64-pgo", 05:38:26 INFO - "basedir": "/builds/slave/test-pgo", 05:38:26 INFO - "nightly_build": "True", 05:38:26 INFO - "buildnumber": 641, 05:38:26 INFO - "slavename": "talos-linux64-ix-062", 05:38:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:38:26 INFO - "platform": "ubuntu64_hw", 05:38:26 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:38:26 INFO - "branch": "mozilla-central", 05:38:26 INFO - "repo_path": "mozilla-central", 05:38:26 INFO - "revision": "e790bba372f14241addda469a4bdb7ab00786ab3", 05:38:26 INFO - "pgo_build": "True", 05:38:26 INFO - "builduid": "4124b34476ae432886b754639501efec", 05:38:26 INFO - "slavebuilddir": "test" 05:38:26 INFO - } 05:38:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/eHxvEco6Rw6p6OVoN0thYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:38:26 INFO - Running post-action listener: _resource_record_post_action 05:38:26 INFO - ##### 05:38:26 INFO - ##### Running download-and-extract step. 05:38:26 INFO - ##### 05:38:26 INFO - Running pre-action listener: _resource_record_pre_action 05:38:26 INFO - Running main action method: download_and_extract 05:38:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:38:26 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')]} 05:38:26 INFO - https://queue.taskcluster.net/v1/task/eHxvEco6Rw6p6OVoN0thYA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:38:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHxvEco6Rw6p6OVoN0thYA/artifacts/public/build/test_packages.json 05:38:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHxvEco6Rw6p6OVoN0thYA/artifacts/public/build/test_packages.json 05:38:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHxvEco6Rw6p6OVoN0thYA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:38:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHxvEco6Rw6p6OVoN0thYA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:38:31 INFO - Downloaded 1302 bytes. 05:38:31 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:38:31 INFO - Using the following test package requirements: 05:38:31 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:38:31 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:38:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:38:31 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:38:31 INFO - u'jsshell-linux-x86_64.zip'], 05:38:31 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:38:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:38:31 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:38:31 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:38:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:38:31 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:38:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:38:31 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:38:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:38:31 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:38:31 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:38:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:38:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:38:31 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')]} 05:38:31 INFO - https://queue.taskcluster.net/v1/task/eHxvEco6Rw6p6OVoN0thYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:38:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHxvEco6Rw6p6OVoN0thYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:38:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHxvEco6Rw6p6OVoN0thYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:38:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHxvEco6Rw6p6OVoN0thYA/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 05:38:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHxvEco6Rw6p6OVoN0thYA/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 05:38:48 INFO - Downloaded 24027332 bytes. 05:38:48 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 05:38:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:38:48 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 05:38:49 INFO - Return code: 0 05:38:49 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 05:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:49 INFO - https://queue.taskcluster.net/v1/task/eHxvEco6Rw6p6OVoN0thYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:38:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHxvEco6Rw6p6OVoN0thYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:38:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHxvEco6Rw6p6OVoN0thYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:38:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHxvEco6Rw6p6OVoN0thYA/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 05:38:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHxvEco6Rw6p6OVoN0thYA/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 05:38:59 INFO - Downloaded 24027332 bytes. 05:38:59 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 05:38:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:38:59 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 05:39:00 INFO - Return code: 0 05:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:00 INFO - https://queue.taskcluster.net/v1/task/eHxvEco6Rw6p6OVoN0thYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:39:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHxvEco6Rw6p6OVoN0thYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:39:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHxvEco6Rw6p6OVoN0thYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:39:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHxvEco6Rw6p6OVoN0thYA/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 05:39:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHxvEco6Rw6p6OVoN0thYA/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 05:39:03 INFO - Downloaded 11132285 bytes. 05:39:03 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 05:39:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:39:03 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 05:39:03 INFO - Return code: 0 05:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:03 INFO - https://queue.taskcluster.net/v1/task/eHxvEco6Rw6p6OVoN0thYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:39:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHxvEco6Rw6p6OVoN0thYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:39:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHxvEco6Rw6p6OVoN0thYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:39:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHxvEco6Rw6p6OVoN0thYA/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 05:39:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eHxvEco6Rw6p6OVoN0thYA/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 05:39:07 INFO - Downloaded 55739386 bytes. 05:39:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eHxvEco6Rw6p6OVoN0thYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:39:07 INFO - mkdir: /builds/slave/test-pgo/properties 05:39:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:39:07 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:39:07 INFO - Contents: 05:39:07 INFO - build_url:https://queue.taskcluster.net/v1/task/eHxvEco6Rw6p6OVoN0thYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:39:07 INFO - Running post-action listener: _resource_record_post_action 05:39:07 INFO - Running post-action listener: set_extra_try_arguments 05:39:07 INFO - ##### 05:39:07 INFO - ##### Running populate-webroot step. 05:39:07 INFO - ##### 05:39:07 INFO - Running pre-action listener: _resource_record_pre_action 05:39:07 INFO - Running main action method: populate_webroot 05:39:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:39:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:39:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:39:07 INFO - '--tppagecycles', 05:39:07 INFO - '7'], 05:39:07 INFO - 'tests': ['tsvgm']}}, 05:39:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:39:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:39:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:39:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:39:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:39:07 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:39:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:39:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:07 INFO - 'talos_options': ['--e10s'], 05:39:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:39:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:07 INFO - 'tests': ['damp', 'tps']}, 05:39:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:07 INFO - 'talos_options': ['--e10s'], 05:39:07 INFO - 'tests': ['damp', 'tps']}, 05:39:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:39:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:39:07 INFO - 'other': {'tests': ['a11yr', 05:39:07 INFO - 'ts_paint', 05:39:07 INFO - 'tpaint', 05:39:07 INFO - 'sessionrestore', 05:39:07 INFO - 'sessionrestore_no_auto_restore']}, 05:39:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:39:07 INFO - 'tests': ['a11yr', 05:39:07 INFO - 'ts_paint', 05:39:07 INFO - 'tpaint', 05:39:07 INFO - 'sessionrestore', 05:39:07 INFO - 'sessionrestore_no_auto_restore']}, 05:39:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:39:07 INFO - 'tests': ['a11yr', 05:39:07 INFO - 'ts_paint', 05:39:07 INFO - 'tpaint', 05:39:07 INFO - 'sessionrestore', 05:39:07 INFO - 'sessionrestore_no_auto_restore']}, 05:39:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:39:07 INFO - 'tests': ['a11yr', 05:39:07 INFO - 'ts_paint', 05:39:07 INFO - 'tpaint', 05:39:07 INFO - 'sessionrestore', 05:39:07 INFO - 'sessionrestore_no_auto_restore']}, 05:39:07 INFO - 'other_l64': {'tests': ['a11yr', 05:39:07 INFO - 'ts_paint', 05:39:07 INFO - 'tpaint', 05:39:07 INFO - 'sessionrestore', 05:39:07 INFO - 'sessionrestore_no_auto_restore']}, 05:39:07 INFO - 'other_nol64': {'tests': ['a11yr', 05:39:07 INFO - 'ts_paint', 05:39:07 INFO - 'tpaint', 05:39:07 INFO - 'sessionrestore', 05:39:07 INFO - 'sessionrestore_no_auto_restore']}, 05:39:07 INFO - 'svgr': {'tests': ['tsvgx', 05:39:07 INFO - 'tsvgr_opacity', 05:39:07 INFO - 'tart', 05:39:07 INFO - 'tscrollx', 05:39:07 INFO - 'cart']}, 05:39:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:39:07 INFO - 'tests': ['tsvgx', 05:39:07 INFO - 'tsvgr_opacity', 05:39:07 INFO - 'tart', 05:39:07 INFO - 'tscrollx', 05:39:07 INFO - 'cart']}, 05:39:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:07 INFO - 'tests': ['tp5o']}, 05:39:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:07 INFO - 'talos_options': ['--e10s'], 05:39:07 INFO - 'tests': ['tp5o']}, 05:39:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:07 INFO - 'talos_options': ['--xperf_path', 05:39:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:39:07 INFO - 'tests': ['tp5n']}, 05:39:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:39:07 INFO - 'talos_options': ['--e10s', 05:39:07 INFO - '--xperf_path', 05:39:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:39:07 INFO - 'tests': ['tp5n']}}, 05:39:07 INFO - 'talos.zip': {'path': '', 05:39:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:39:07 INFO - Running post-action listener: _resource_record_post_action 05:39:07 INFO - ##### 05:39:07 INFO - ##### Running create-virtualenv step. 05:39:07 INFO - ##### 05:39:07 INFO - Running pre-action listener: _resource_record_pre_action 05:39:07 INFO - Running main action method: create_virtualenv 05:39:07 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:39:07 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 05:39:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:39:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:39:07 INFO - Using real prefix '/usr' 05:39:07 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:39:07 INFO - Installing distribute.............................................................................................................................................................................................done. 05:39:09 INFO - Installing pip.................done. 05:39:09 INFO - Return code: 0 05:39:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:39:09 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')]} 05:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:09 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')]} 05:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:09 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 0x7f819b4a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b840>, '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 0x26886b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2688b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452605748.118281-1908812497', '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 05:39:09 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 05:39:09 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 05:39:09 INFO - Using env: {'DISPLAY': ':0', 05:39:09 INFO - 'HOME': '/home/cltbld', 05:39:09 INFO - 'LANG': 'en_US.UTF-8', 05:39:09 INFO - 'LANGUAGE': 'en_US:en', 05:39:09 INFO - 'LOGNAME': 'cltbld', 05:39:09 INFO - 'MAIL': '/var/mail/cltbld', 05:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:09 INFO - 'MOZ_NO_REMOTE': '1', 05:39:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:09 INFO - 'NO_EM_RESTART': '1', 05:39:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:39:09 INFO - 'PWD': '/builds/slave/test-pgo', 05:39:09 INFO - 'SHELL': '/bin/bash', 05:39:09 INFO - 'SHLVL': '1', 05:39:09 INFO - 'TERM': 'linux', 05:39:09 INFO - 'TMOUT': '86400', 05:39:09 INFO - 'USER': 'cltbld', 05:39:09 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452605748.118281-1908812497', 05:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:09 INFO - '_': '/tools/buildbot/bin/python'} 05:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:09 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 05:39:09 INFO - Cleaning up... 05:39:09 INFO - Return code: 0 05:39:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:39:09 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')]} 05:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:09 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')]} 05:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:09 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 0x7f819b4a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b840>, '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 0x26886b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2688b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452605748.118281-1908812497', '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 05:39:09 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 05:39:09 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 05:39:09 INFO - Using env: {'DISPLAY': ':0', 05:39:09 INFO - 'HOME': '/home/cltbld', 05:39:09 INFO - 'LANG': 'en_US.UTF-8', 05:39:09 INFO - 'LANGUAGE': 'en_US:en', 05:39:09 INFO - 'LOGNAME': 'cltbld', 05:39:09 INFO - 'MAIL': '/var/mail/cltbld', 05:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:09 INFO - 'MOZ_NO_REMOTE': '1', 05:39:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:09 INFO - 'NO_EM_RESTART': '1', 05:39:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:39:09 INFO - 'PWD': '/builds/slave/test-pgo', 05:39:09 INFO - 'SHELL': '/bin/bash', 05:39:09 INFO - 'SHLVL': '1', 05:39:09 INFO - 'TERM': 'linux', 05:39:09 INFO - 'TMOUT': '86400', 05:39:09 INFO - 'USER': 'cltbld', 05:39:09 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452605748.118281-1908812497', 05:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:09 INFO - '_': '/tools/buildbot/bin/python'} 05:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:10 INFO - Downloading/unpacking psutil>=0.7.1 05:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:11 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:39:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:39:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:39:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:39:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:39:11 INFO - Installing collected packages: psutil 05:39:11 INFO - Running setup.py install for psutil 05:39:11 INFO - building 'psutil._psutil_linux' extension 05:39:11 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 05:39:12 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 05:39:12 INFO - building 'psutil._psutil_posix' extension 05:39:12 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 05:39:12 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 05:39:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:39:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:39:12 INFO - Successfully installed psutil 05:39:12 INFO - Cleaning up... 05:39:12 INFO - Return code: 0 05:39:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:39:12 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')]} 05:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:12 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')]} 05:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:12 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 0x7f819b4a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b840>, '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 0x26886b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2688b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452605748.118281-1908812497', '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 05:39:12 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 05:39:12 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 05:39:12 INFO - Using env: {'DISPLAY': ':0', 05:39:12 INFO - 'HOME': '/home/cltbld', 05:39:12 INFO - 'LANG': 'en_US.UTF-8', 05:39:12 INFO - 'LANGUAGE': 'en_US:en', 05:39:12 INFO - 'LOGNAME': 'cltbld', 05:39:12 INFO - 'MAIL': '/var/mail/cltbld', 05:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:12 INFO - 'MOZ_NO_REMOTE': '1', 05:39:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:12 INFO - 'NO_EM_RESTART': '1', 05:39:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:39:12 INFO - 'PWD': '/builds/slave/test-pgo', 05:39:12 INFO - 'SHELL': '/bin/bash', 05:39:12 INFO - 'SHLVL': '1', 05:39:12 INFO - 'TERM': 'linux', 05:39:12 INFO - 'TMOUT': '86400', 05:39:12 INFO - 'USER': 'cltbld', 05:39:12 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452605748.118281-1908812497', 05:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:12 INFO - '_': '/tools/buildbot/bin/python'} 05:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:39:12 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 05:39:12 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 05:39:12 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 05:39:12 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 05:39:12 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 05:39:12 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 05:39:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:39:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:39:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:39:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:39:14 INFO - Installing collected packages: mozsystemmonitor 05:39:14 INFO - Running setup.py install for mozsystemmonitor 05:39:14 INFO - Successfully installed mozsystemmonitor 05:39:14 INFO - Cleaning up... 05:39:14 INFO - Return code: 0 05:39:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:39:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:14 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 0x7f819b4a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b840>, '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 0x26886b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2688b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452605748.118281-1908812497', '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 05:39:14 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 05:39:14 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 05:39:14 INFO - Using env: {'DISPLAY': ':0', 05:39:14 INFO - 'HOME': '/home/cltbld', 05:39:14 INFO - 'LANG': 'en_US.UTF-8', 05:39:14 INFO - 'LANGUAGE': 'en_US:en', 05:39:14 INFO - 'LOGNAME': 'cltbld', 05:39:14 INFO - 'MAIL': '/var/mail/cltbld', 05:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:14 INFO - 'MOZ_NO_REMOTE': '1', 05:39:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:14 INFO - 'NO_EM_RESTART': '1', 05:39:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:39:14 INFO - 'PWD': '/builds/slave/test-pgo', 05:39:14 INFO - 'SHELL': '/bin/bash', 05:39:14 INFO - 'SHLVL': '1', 05:39:14 INFO - 'TERM': 'linux', 05:39:14 INFO - 'TMOUT': '86400', 05:39:14 INFO - 'USER': 'cltbld', 05:39:14 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452605748.118281-1908812497', 05:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:14 INFO - '_': '/tools/buildbot/bin/python'} 05:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:14 INFO - Downloading/unpacking blobuploader==1.2.4 05:39:14 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 05:39:14 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 05:39:14 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 05:39:14 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 05:39:14 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 05:39:14 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 05:39:16 INFO - Downloading blobuploader-1.2.4.tar.gz 05:39:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:39:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:39:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:39:16 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 05:39:16 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 05:39:16 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 05:39:16 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 05:39:16 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 05:39:16 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 05:39:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:39:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:39:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:39:17 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 05:39:17 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 05:39:17 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 05:39:17 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 05:39:17 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 05:39:17 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 05:39:17 INFO - Downloading docopt-0.6.1.tar.gz 05:39:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:39:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:39:17 INFO - Installing collected packages: blobuploader, requests, docopt 05:39:17 INFO - Running setup.py install for blobuploader 05:39:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:39:17 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:39:17 INFO - Running setup.py install for requests 05:39:17 INFO - Running setup.py install for docopt 05:39:18 INFO - Successfully installed blobuploader requests docopt 05:39:18 INFO - Cleaning up... 05:39:18 INFO - Return code: 0 05:39:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:18 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 0x7f819b4a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b840>, '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 0x26886b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2688b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452605748.118281-1908812497', '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 05:39:18 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 05:39:18 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 05:39:18 INFO - Using env: {'DISPLAY': ':0', 05:39:18 INFO - 'HOME': '/home/cltbld', 05:39:18 INFO - 'LANG': 'en_US.UTF-8', 05:39:18 INFO - 'LANGUAGE': 'en_US:en', 05:39:18 INFO - 'LOGNAME': 'cltbld', 05:39:18 INFO - 'MAIL': '/var/mail/cltbld', 05:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:18 INFO - 'MOZ_NO_REMOTE': '1', 05:39:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:18 INFO - 'NO_EM_RESTART': '1', 05:39:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:39:18 INFO - 'PWD': '/builds/slave/test-pgo', 05:39:18 INFO - 'SHELL': '/bin/bash', 05:39:18 INFO - 'SHLVL': '1', 05:39:18 INFO - 'TERM': 'linux', 05:39:18 INFO - 'TMOUT': '86400', 05:39:18 INFO - 'USER': 'cltbld', 05:39:18 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452605748.118281-1908812497', 05:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:18 INFO - '_': '/tools/buildbot/bin/python'} 05:39:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:39:18 INFO - Running setup.py (path:/tmp/pip-FcxOgW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:39:18 INFO - Running setup.py (path:/tmp/pip-8ftmp_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:39:18 INFO - Running setup.py (path:/tmp/pip-vfbiLT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:39:18 INFO - Running setup.py (path:/tmp/pip-ulq6_t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:39:18 INFO - Running setup.py (path:/tmp/pip-N7tsHO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:39:18 INFO - Running setup.py (path:/tmp/pip-YbeXGU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:39:18 INFO - Running setup.py (path:/tmp/pip-swLTEn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:39:18 INFO - Running setup.py (path:/tmp/pip-X2yFLu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:39:18 INFO - Running setup.py (path:/tmp/pip-2uIQ6q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:39:18 INFO - Running setup.py (path:/tmp/pip-lPqgqK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:39:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:39:19 INFO - Running setup.py (path:/tmp/pip-9fTjOS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:39:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:39:19 INFO - Running setup.py (path:/tmp/pip-cauuH8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:39:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:39:19 INFO - Running setup.py (path:/tmp/pip-OhFCiK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:39:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:39:19 INFO - Running setup.py (path:/tmp/pip-ZF5Idc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:39:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:39:19 INFO - Running setup.py (path:/tmp/pip-MxhuLy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:39:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:39:19 INFO - Running setup.py (path:/tmp/pip-URHMk2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:39:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:39:19 INFO - Running setup.py (path:/tmp/pip-sFbgt9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:39:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:39:19 INFO - Running setup.py install for manifestparser 05:39:19 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:39:19 INFO - Running setup.py install for mozcrash 05:39:19 INFO - Running setup.py install for mozdebug 05:39:19 INFO - Running setup.py install for mozdevice 05:39:19 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:39:19 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:39:19 INFO - Running setup.py install for mozfile 05:39:20 INFO - Running setup.py install for mozhttpd 05:39:20 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:39:20 INFO - Running setup.py install for mozinfo 05:39:20 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:39:20 INFO - Running setup.py install for mozInstall 05:39:20 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:39:20 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:39:20 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:39:20 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:39:20 INFO - Running setup.py install for mozleak 05:39:20 INFO - Running setup.py install for mozlog 05:39:20 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:39:20 INFO - Running setup.py install for moznetwork 05:39:20 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:39:20 INFO - Running setup.py install for mozprocess 05:39:20 INFO - Running setup.py install for mozprofile 05:39:20 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:39:20 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:39:20 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:39:20 INFO - Running setup.py install for mozrunner 05:39:21 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:39:21 INFO - Running setup.py install for mozscreenshot 05:39:21 INFO - Running setup.py install for moztest 05:39:21 INFO - Running setup.py install for mozversion 05:39:21 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:39:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:39:21 INFO - Cleaning up... 05:39:21 INFO - Return code: 0 05:39:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:39:21 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')]} 05:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:21 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')]} 05:39:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:21 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 0x7f819b4a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b840>, '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 0x26886b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2688b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452605748.118281-1908812497', '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 05:39:21 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 05:39:21 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 05:39:21 INFO - Using env: {'DISPLAY': ':0', 05:39:21 INFO - 'HOME': '/home/cltbld', 05:39:21 INFO - 'LANG': 'en_US.UTF-8', 05:39:21 INFO - 'LANGUAGE': 'en_US:en', 05:39:21 INFO - 'LOGNAME': 'cltbld', 05:39:21 INFO - 'MAIL': '/var/mail/cltbld', 05:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:21 INFO - 'MOZ_NO_REMOTE': '1', 05:39:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:21 INFO - 'NO_EM_RESTART': '1', 05:39:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:39:21 INFO - 'PWD': '/builds/slave/test-pgo', 05:39:21 INFO - 'SHELL': '/bin/bash', 05:39:21 INFO - 'SHLVL': '1', 05:39:21 INFO - 'TERM': 'linux', 05:39:21 INFO - 'TMOUT': '86400', 05:39:21 INFO - 'USER': 'cltbld', 05:39:21 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452605748.118281-1908812497', 05:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:21 INFO - '_': '/tools/buildbot/bin/python'} 05:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:39:21 INFO - Running setup.py (path:/tmp/pip-UYBzP9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:39:21 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)) 05:39:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:39:21 INFO - Running setup.py (path:/tmp/pip-CkmuL7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:39:21 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)) 05:39:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:39:21 INFO - Running setup.py (path:/tmp/pip-sPN_gv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:39:21 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)) 05:39:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:39:21 INFO - Running setup.py (path:/tmp/pip-8tqNDe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:39:21 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)) 05:39:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:39:21 INFO - Running setup.py (path:/tmp/pip-9uwXij-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:39:21 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)) 05:39:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:39:21 INFO - Running setup.py (path:/tmp/pip-Lw8834-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:39:21 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)) 05:39:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:39:21 INFO - Running setup.py (path:/tmp/pip-SMLGIa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:39:22 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)) 05:39:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:39:22 INFO - Running setup.py (path:/tmp/pip-6ai0e0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:39:22 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)) 05:39:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:39:22 INFO - Running setup.py (path:/tmp/pip-z6k3bK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:39:22 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)) 05:39:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:39:22 INFO - Running setup.py (path:/tmp/pip-lYaVvL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:39:22 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)) 05:39:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:39:22 INFO - Running setup.py (path:/tmp/pip-0qhk_b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:39:22 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)) 05:39:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:39:22 INFO - Running setup.py (path:/tmp/pip-KrQYc7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:39:22 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)) 05:39:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:39:22 INFO - Running setup.py (path:/tmp/pip-6bsyPS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:39:22 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)) 05:39:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:39:22 INFO - Running setup.py (path:/tmp/pip-ratjSt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:39:22 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)) 05:39:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:39:22 INFO - Running setup.py (path:/tmp/pip-cBwBT2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:39:22 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)) 05:39:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:39:22 INFO - Running setup.py (path:/tmp/pip-53dB3J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:39:22 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)) 05:39:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:39:22 INFO - Running setup.py (path:/tmp/pip-9F00Ap-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:39:22 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)) 05:39:22 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)) 05:39:22 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)) 05:39:22 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)) 05:39:22 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)) 05:39:22 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)) 05:39:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:39:22 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 05:39:22 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 05:39:22 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 05:39:22 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 05:39:22 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 05:39:22 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 05:39:24 INFO - Downloading blessings-1.5.1.tar.gz 05:39:24 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 05:39:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:39:24 INFO - Installing collected packages: blessings 05:39:24 INFO - Running setup.py install for blessings 05:39:24 INFO - Successfully installed blessings 05:39:24 INFO - Cleaning up... 05:39:24 INFO - Return code: 0 05:39:24 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:39:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:39:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:39:24 INFO - Reading from file tmpfile_stdout 05:39:24 INFO - Current package versions: 05:39:24 INFO - argparse == 1.2.1 05:39:24 INFO - blessings == 1.5.1 05:39:24 INFO - blobuploader == 1.2.4 05:39:24 INFO - docopt == 0.6.1 05:39:24 INFO - manifestparser == 1.1 05:39:24 INFO - mozInstall == 1.12 05:39:24 INFO - mozcrash == 0.16 05:39:24 INFO - mozdebug == 0.1 05:39:24 INFO - mozdevice == 0.47 05:39:24 INFO - mozfile == 1.2 05:39:24 INFO - mozhttpd == 0.7 05:39:24 INFO - mozinfo == 0.9 05:39:24 INFO - mozleak == 0.1 05:39:24 INFO - mozlog == 3.1 05:39:24 INFO - moznetwork == 0.27 05:39:24 INFO - mozprocess == 0.22 05:39:24 INFO - mozprofile == 0.28 05:39:24 INFO - mozrunner == 6.11 05:39:24 INFO - mozscreenshot == 0.1 05:39:24 INFO - mozsystemmonitor == 0.0 05:39:24 INFO - moztest == 0.7 05:39:24 INFO - mozversion == 1.4 05:39:24 INFO - psutil == 3.1.1 05:39:24 INFO - requests == 1.2.3 05:39:24 INFO - wsgiref == 0.1.2 05:39:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:24 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f819b4a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b840>, '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 0x26886b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2688b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452605748.118281-1908812497', '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 05:39:24 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 05:39:24 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 05:39:24 INFO - Using env: {'DISPLAY': ':0', 05:39:24 INFO - 'HOME': '/home/cltbld', 05:39:24 INFO - 'LANG': 'en_US.UTF-8', 05:39:24 INFO - 'LANGUAGE': 'en_US:en', 05:39:24 INFO - 'LOGNAME': 'cltbld', 05:39:24 INFO - 'MAIL': '/var/mail/cltbld', 05:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:24 INFO - 'MOZ_NO_REMOTE': '1', 05:39:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:24 INFO - 'NO_EM_RESTART': '1', 05:39:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:39:24 INFO - 'PWD': '/builds/slave/test-pgo', 05:39:24 INFO - 'SHELL': '/bin/bash', 05:39:24 INFO - 'SHLVL': '1', 05:39:24 INFO - 'TERM': 'linux', 05:39:24 INFO - 'TMOUT': '86400', 05:39:24 INFO - 'USER': 'cltbld', 05:39:24 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452605748.118281-1908812497', 05:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:24 INFO - '_': '/tools/buildbot/bin/python'} 05:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:25 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)) 05:39:25 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)) 05:39:25 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)) 05:39:25 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)) 05:39:25 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)) 05:39:25 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)) 05:39:25 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)) 05:39:25 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)) 05:39:25 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)) 05:39:25 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)) 05:39:25 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)) 05:39:25 INFO - Cleaning up... 05:39:25 INFO - Return code: 0 05:39:25 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:39:25 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')]} 05:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:25 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')]} 05:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:25 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 0x7f819b4a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b840>, '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 0x26886b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2688b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452605748.118281-1908812497', '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 05:39:25 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 05:39:25 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 05:39:25 INFO - Using env: {'DISPLAY': ':0', 05:39:25 INFO - 'HOME': '/home/cltbld', 05:39:25 INFO - 'LANG': 'en_US.UTF-8', 05:39:25 INFO - 'LANGUAGE': 'en_US:en', 05:39:25 INFO - 'LOGNAME': 'cltbld', 05:39:25 INFO - 'MAIL': '/var/mail/cltbld', 05:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:25 INFO - 'MOZ_NO_REMOTE': '1', 05:39:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:25 INFO - 'NO_EM_RESTART': '1', 05:39:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:39:25 INFO - 'PWD': '/builds/slave/test-pgo', 05:39:25 INFO - 'SHELL': '/bin/bash', 05:39:25 INFO - 'SHLVL': '1', 05:39:25 INFO - 'TERM': 'linux', 05:39:25 INFO - 'TMOUT': '86400', 05:39:25 INFO - 'USER': 'cltbld', 05:39:25 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452605748.118281-1908812497', 05:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:25 INFO - '_': '/tools/buildbot/bin/python'} 05:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:25 INFO - Downloading/unpacking jsonschema 05:39:25 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 05:39:25 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 05:39:25 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 05:39:25 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 05:39:25 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 05:39:25 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 05:39:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:39:27 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 05:39:27 INFO - Downloading/unpacking functools32 (from jsonschema) 05:39:27 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 05:39:27 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 05:39:27 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 05:39:27 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 05:39:27 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 05:39:27 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 05:39:27 INFO - Downloading functools32-3.2.3-2.tar.gz 05:39:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:39:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:39:27 INFO - warning: no files found matching '*.txt' 05:39:27 INFO - no previously-included directories found matching 'build' 05:39:27 INFO - no previously-included directories found matching 'dist' 05:39:27 INFO - no previously-included directories found matching '.git*' 05:39:27 INFO - Installing collected packages: jsonschema, functools32 05:39:27 INFO - Running setup.py install for functools32 05:39:27 INFO - warning: no files found matching '*.txt' 05:39:27 INFO - no previously-included directories found matching 'build' 05:39:27 INFO - no previously-included directories found matching 'dist' 05:39:27 INFO - no previously-included directories found matching '.git*' 05:39:27 INFO - Successfully installed jsonschema functools32 05:39:27 INFO - Cleaning up... 05:39:27 INFO - Return code: 0 05:39:27 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:27 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 0x7f819b4a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b840>, '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 0x26886b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2688b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452605748.118281-1908812497', '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 05:39:27 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 05:39:27 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 05:39:27 INFO - Using env: {'DISPLAY': ':0', 05:39:27 INFO - 'HOME': '/home/cltbld', 05:39:27 INFO - 'LANG': 'en_US.UTF-8', 05:39:27 INFO - 'LANGUAGE': 'en_US:en', 05:39:27 INFO - 'LOGNAME': 'cltbld', 05:39:27 INFO - 'MAIL': '/var/mail/cltbld', 05:39:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:27 INFO - 'MOZ_NO_REMOTE': '1', 05:39:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:27 INFO - 'NO_EM_RESTART': '1', 05:39:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:39:27 INFO - 'PWD': '/builds/slave/test-pgo', 05:39:27 INFO - 'SHELL': '/bin/bash', 05:39:27 INFO - 'SHLVL': '1', 05:39:27 INFO - 'TERM': 'linux', 05:39:27 INFO - 'TMOUT': '86400', 05:39:27 INFO - 'USER': 'cltbld', 05:39:27 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452605748.118281-1908812497', 05:39:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:27 INFO - '_': '/tools/buildbot/bin/python'} 05:39:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:27 INFO - Downloading/unpacking flake8 05:39:27 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 05:39:27 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 05:39:27 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 05:39:27 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 05:39:27 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 05:39:27 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 05:39:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:39:29 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 05:39:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:39:29 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 05:39:29 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 05:39:29 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 05:39:29 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 05:39:29 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 05:39:29 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 05:39:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:39:29 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 05:39:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:39:29 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 05:39:29 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 05:39:29 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 05:39:29 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 05:39:29 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 05:39:29 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 05:39:29 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 05:39:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:39:29 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 05:39:29 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 05:39:29 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 05:39:29 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 05:39:29 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 05:39:29 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 05:39:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:39:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:39:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:39:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:39:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:39:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:39:30 INFO - no previously-included directories found matching 'docs/_build' 05:39:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:39:30 INFO - Running setup.py install for pep8 05:39:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:39:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:39:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:39:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:39:30 INFO - no previously-included directories found matching 'docs/_build' 05:39:30 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:39:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:39:30 INFO - Cleaning up... 05:39:30 INFO - Return code: 0 05:39:30 INFO - Running post-action listener: _resource_record_post_action 05:39:30 INFO - Running post-action listener: _start_resource_monitoring 05:39:30 INFO - Starting resource monitoring. 05:39:30 INFO - ##### 05:39:30 INFO - ##### Running install step. 05:39:30 INFO - ##### 05:39:30 INFO - Running pre-action listener: _resource_record_pre_action 05:39:30 INFO - Running main action method: install 05:39:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:39:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:39:30 INFO - Reading from file tmpfile_stdout 05:39:30 INFO - Detecting whether we're running mozinstall >=1.0... 05:39:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:39:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:39:30 INFO - Reading from file tmpfile_stdout 05:39:30 INFO - Output received: 05:39:30 INFO - Usage: mozinstall [options] installer 05:39:30 INFO - Options: 05:39:30 INFO - -h, --help show this help message and exit 05:39:30 INFO - -d DEST, --destination=DEST 05:39:30 INFO - Directory to install application into. [default: 05:39:30 INFO - "/builds/slave/test-pgo"] 05:39:30 INFO - --app=APP Application being installed. [default: firefox] 05:39:30 INFO - mkdir: /builds/slave/test-pgo/build/application 05:39:30 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'] 05:39:30 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 05:39:46 INFO - Reading from file tmpfile_stdout 05:39:46 INFO - Output received: 05:39:46 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:39:46 INFO - Running post-action listener: _resource_record_post_action 05:39:46 INFO - ##### 05:39:46 INFO - ##### Running run-tests step. 05:39:46 INFO - ##### 05:39:46 INFO - Running pre-action listener: _resource_record_pre_action 05:39:46 INFO - Running main action method: run_tests 05:39:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:39:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:39:46 INFO - Python 2.7.3 05:39:46 INFO - Return code: 0 05:39:46 INFO - grabbing minidump binary from tooltool 05:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:46 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 0x271b840>, '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 0x26886b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2688b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:39:46 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 05:39:46 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 05:39:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:39:46 INFO - Return code: 0 05:39:46 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:39:46 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:39:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:39:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:39:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:39:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:39:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:39:47 INFO - Return code: 0 05:39:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eHxvEco6Rw6p6OVoN0thYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 05:39:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eHxvEco6Rw6p6OVoN0thYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 05:39:47 INFO - Using env: {'DISPLAY': ':0', 05:39:47 INFO - 'HOME': '/home/cltbld', 05:39:47 INFO - 'LANG': 'en_US.UTF-8', 05:39:47 INFO - 'LANGUAGE': 'en_US:en', 05:39:47 INFO - 'LOGNAME': 'cltbld', 05:39:47 INFO - 'MAIL': '/var/mail/cltbld', 05:39:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:39:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:39:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:47 INFO - 'MOZ_NO_REMOTE': '1', 05:39:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:39:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:47 INFO - 'NO_EM_RESTART': '1', 05:39:47 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:39:47 INFO - 'PWD': '/builds/slave/test-pgo', 05:39:47 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:39:47 INFO - 'SHELL': '/bin/bash', 05:39:47 INFO - 'SHLVL': '1', 05:39:47 INFO - 'TERM': 'linux', 05:39:47 INFO - 'TMOUT': '86400', 05:39:47 INFO - 'USER': 'cltbld', 05:39:47 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452605748.118281-1908812497', 05:39:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:47 INFO - '_': '/tools/buildbot/bin/python'} 05:39:47 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eHxvEco6Rw6p6OVoN0thYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 05:39:47 INFO - mozversion application_buildid: 20160112030227 05:39:47 INFO - mozversion application_changeset: e790bba372f14241addda469a4bdb7ab00786ab3 05:39:47 INFO - mozversion application_display_name: Nightly 05:39:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:39:47 INFO - mozversion application_name: Firefox 05:39:47 INFO - mozversion application_remotingname: firefox 05:39:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:39:47 INFO - mozversion application_vendor: Mozilla 05:39:47 INFO - mozversion application_version: 46.0a1 05:39:47 INFO - mozversion platform_buildid: 20160112030227 05:39:47 INFO - mozversion platform_changeset: e790bba372f14241addda469a4bdb7ab00786ab3 05:39:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:39:47 INFO - mozversion platform_version: 46.0a1 05:39:47 INFO - using testdate: 1452605987 05:39:47 INFO - actual date: 1452605987 05:39:47 INFO - starting webserver on 'localhost:57861' 05:39:47 INFO - SUITE-START | Running 3 tests 05:39:47 INFO - TEST-START | dromaeo_css 05:39:47 INFO - operating with platform_type : linux_ 05:39:47 INFO - Initialising browser for dromaeo_css test... 05:39:48 INFO - TEST-INFO | started process 5466 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnYLige/profile http://localhost:57861/getInfo.html) 05:39:52 INFO - PROCESS | 5466 | __metrics Screen width/height:1600/1200 05:39:52 INFO - PROCESS | 5466 | colorDepth:24 05:39:52 INFO - PROCESS | 5466 | Browser inner width/height: 1024/697 05:39:52 INFO - PROCESS | 5466 | __metrics 05:39:52 INFO - PROCESS | 5466 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:39:52 INFO - PROCESS | 5466 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:39:52 INFO - PROCESS | 5466 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 05:39:53 INFO - TEST-INFO | 5466: exit 0 05:39:53 INFO - Browser initialized. 05:39:53 INFO - Running cycle 1/1 for dromaeo_css test... 05:39:53 INFO - TEST-INFO | started process 5561 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnYLige/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:40:04 INFO - PROCESS | 5561 | RSS: Main: 147009536 05:40:04 INFO - PROCESS | 5561 | 05:40:56 INFO - PROCESS | 5561 | 1452606056249 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] 05:43:04 INFO - PROCESS | 5561 | Cycle 1(1): loaded http://localhost:57861/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57861/tests/dromaeo/cssquery-ext.html) 05:43:05 INFO - PROCESS | 5561 | RSS: Main: 232366080 05:43:05 INFO - PROCESS | 5561 | 05:46:07 INFO - PROCESS | 5561 | Cycle 1(1): loaded http://localhost:57861/tests/dromaeo/cssquery-ext.html (next: http://localhost:57861/tests/dromaeo/cssquery-jquery.html) 05:46:08 INFO - PROCESS | 5561 | RSS: Main: 236474368 05:46:08 INFO - PROCESS | 5561 | 05:49:10 INFO - PROCESS | 5561 | Cycle 1(1): loaded http://localhost:57861/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57861/tests/dromaeo/cssquery-mootools.html) 05:49:11 INFO - PROCESS | 5561 | RSS: Main: 256512000 05:49:11 INFO - PROCESS | 5561 | 05:52:12 INFO - PROCESS | 5561 | Cycle 1(1): loaded http://localhost:57861/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57861/tests/dromaeo/cssquery-prototype.html) 05:52:13 INFO - PROCESS | 5561 | RSS: Main: 212148224 05:52:13 INFO - PROCESS | 5561 | 05:55:16 INFO - PROCESS | 5561 | Cycle 1(1): loaded http://localhost:57861/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57861/tests/dromaeo/cssquery-yui.html) 05:55:16 INFO - PROCESS | 5561 | RSS: Main: 215494656 05:55:16 INFO - PROCESS | 5561 | 05:58:19 INFO - PROCESS | 5561 | Cycle 1(1): loaded http://localhost:57861/tests/dromaeo/cssquery-yui.html (next: http://localhost:57861/tests/dromaeo/cssquery-dojo.html) 05:58:19 INFO - PROCESS | 5561 | RSS: Main: 260509696 05:58:19 INFO - PROCESS | 5561 | 05:58:19 INFO - PROCESS | 5561 | __start_tp_report 05:58:19 INFO - PROCESS | 5561 | _x_x_mozilla_page_load 05:58:19 INFO - PROCESS | 5561 | _x_x_mozilla_page_load_details 05:58:19 INFO - PROCESS | 5561 | |i|pagename|runs| 05:58:19 INFO - PROCESS | 5561 | |0;dojo.html;3102.1158969693633;3109.098361475172;3149.2756665966826;3156.4634012217934;3170.1599076244784;4930.285108659242;5062.898742025157;5067.670601410906;5068.771905264262;5107.591392688585;5074.188129899217;5076.593872490201;5098.286239926413;5121.590272778178;5191.117510023296;4625.306204069399;4628.997283218258;4668.813247470106;4767.237242041274;4822.348982887318;4774.212254977924;4792.544708252728;4822.951770482303;4861.513848615145;4865.195408241897;4582.656300777422;4637.559431853985;4658.114958157939;4666.510016448292;4710.034442939206;4684.1334353144775;4721.433427988629;4723.244280915072;4735.976320118411;4756.66703330767;4675.064987002579;4686.297055441677;4688.976555117202;4720.268358404419;4746.762661866893;4866.951330486685;4923.655344125877;4933.383327084114;4940.530649588283;4952.207646776498;5398.91901621476;5431.293931788881;5433.293671822677;5442.346918369782;5449.891002179974;5433.429489903543;5439.156930675752;5450.509454149145;5457.481539253765;5461.126219804852;5117.437081920985;5154.690718556823;5193.844184674465;5196.272521846944;5197.948020519822;5451.209574611738;5473.75368108436;5519.751611177507;5521.4478552145265;5522.972385138049;5309.787608495617;5327.920081198785;5329.200619906967;5331.733413329318;5338.679679219182;5510.559155267569;5522.392536820947;5587.636803607753;5599.8880022400135;5636.436356364331;5549.944500554942;5555.138953462219;5558.305211848519;5563.666180029211;5569.220309156722;5353.625246232804;5454.263674403905;5570.080936645408;5577.972110139504;5588.860278492989;4188.476440444944;4206.936895946563;4210.726302790309;4225.345071513921;4267.1679022590915;3840.8271627776817;3847.9038024049064;3848.8460461581785;3865.2849222893856;3886.9222615548097;4992.90014199714;5070.670406423571;5143.048536020848;5145;5192.1173400522;5429.077056900336;5451.373092094381;5469.206964990134;5475.534579560782;5523;4950.775234208651;4961.355023846877;4965.4289756678445;4970.453250142481;5004.074246264453;4602.424696912886;4607.654425918069;4617.492075871652;4666.136764698542;4697.389339385926;5475.890482190413;5508;5522.696251706115;5533.584981126432;5537.833864984057;5425.43032981547;5430.647007944471;5434.701091440009;5437.157240627709;5449.400565937823;5407.729613519387;5475.616706830484;5481.040817856939;5539.362973258127;5568.16477528374;5372;5391.514763671288;5393.325834270716;5395;5405.78376864921;5479.945200548103;5485.204645326485;5492.642978206404;5499.835004949858;5552.750126244409;5203.947960520346;5345.732713364238;5374.946250537445;5375.3012108425655;5435.619506634655;5339.519443250126;5351.063563876384;5356.625036247426;5382.407935127211;5386.165144402624;5155.613329000415;5316.468353164652;5320.414754376938;5323.920141197807;5336.279602253801;5331.333583302087;5395.379531353945;5454.945450545602;5462.726863656881;5512.6692398456225;5266.89466210666;5293.629445938747;5293.655912365684;5296.126139187145;5302.920456193083 05:58:19 INFO - PROCESS | 5561 | |1;ext.html;505.0958783777039;509.68144909431606;524.3786113455556;535.1597991153885;541.3287523470894;28410.857945710268;35035;35816;35866.64133358665;35866.64133358672;39237.60762392375;39613.40579891304;39704.80147599265;39729.40405893914;39767.204655906935;8352.832943341145;8622.439541429818;8628.309735221199;8637.136286371344;8637.39538232324;8347.207015333564;8445.788855278606;8488.108748581402;8502.574871256444;8514.659413623478;8313.542755148464;8373.246407823295;8381.24568788809;8387.119352467995;8400.495970241775;8448.535330556817;8478;8501.022382426037;8507.319414446829;8507.574621268912;8318.37612179089;8406.159384061606;8468.195521425454;8481.194286542768;8487.533185674785;38536;38996.805015974736;39004.41493377602;39044.609553904666;39052.609473905184;3086.151308390188;3140;3159.41550813098;3177.4121787469394;3587.964120358789;28747.85626071877;29315.560266596018;29624.555631665542;29803.25491862699;30711.846440767877;3538.539989801335;3540.822958852047;3667.7065834733426;3711.722858026616;3795.9240815183816;259344;259554;259857.9999999981;260490;260583;53663.19505207425;53982;54015;54043.45956540463;54080;53311.46688533143;54903.450965490636;54963;54997.25013749296;58502.70748646229;13762.380692868845;14177.716445671029;14183;14200.786988195185;14203.573892783234;9867.210623150131;10020.749481263027;10041.949790251001;10054.597816087275;10082.69751907444;16872.831271687126;17141.82858171427;17910.283588656308;18121.637567248847;18579.535511612048;6876.896846547305;7067.399271062018;7143.321384468467;7145.785626431215;7185.209626941032;900.3922352412096;965.5654955270156;1031.4687935713114;1041.5521325829814;1042.7497400623795;26481.337966550604;26992.730072699414;26992.865035675088;28110.578341324897;28774.280642984093;1030.907218350352;1055.4195192644015;1059.6344261229863;1092.2463500184847;1161.7734541764444;14914.254287285808;15435.382584696486;15461.226938653248;15638.296276667577;16160.75758863618;326627;332579;334202;335256;335787;51536;51682.22476662853;51725.48274517282;51816;51925;1293.4179619171412;1301.271288078679;1307.5815738963631;1313.1464548043657;1314.8370929820392;26615.733842661324;27925;28490;28546.714532855236;29070.401127938167;41993;42296;42432.09055592567;42508.574914250465;42521.89737231552;197476;200064;200262;200331;200351;28634.284142896595;28847.5672864903;28931.710682892903;29224.853875731336;29233;36126;36799.816000919825;42285.02886273383;42709.78645106754;46169;33856.83071584626;34080.48879266763;34280.314393712484;34444.65555344515;35031.29937401289;34356.52069681972;34955.650443496255;35102.824485877405;35250.823745881105;35344.646553534134;30835.691643083283;31062.534061988637;31288.217794554406;34069.659303406646;36003.639963601076;29366.265843353234;30829.845850770602;31146;31307.373852523277;31399.52900706537;23071.307860764206;23939.086899511432;23981.400464988514;24257.51484970326;24442.633360499964 05:58:19 INFO - PROCESS | 5561 | |2;jquery.html;361.1891304022468;361.2576155999422;362.84216365880843;363.18646232439335;370.49982523593167;13346.399412026458;13449.036798473186;15668.294926728297;16509.422170224043;17563.64872702547;14461.276936153203;14924.701505969873;15210.087394756323;15305.464308749197;15863.206839658029;5275.815346462875;5450.454954504537;5456.399796022434;5458.972705136469;5469.453054694519;3962.9405558916637;4078.9184216315657;5368.30212072432;5437.782488700447;5645.15322701594;5785.508231800281;5984.311804142514;6025.035994240922;6033.064874944391;6044.063170208603;5934.347221805598;5986.8503287417725;5991.370906054867;5993.9400605993815;5994.220751302325;5130.5625231095255;5276.5251127398715;5279.076161671731;5328.8401347959625;5346.117890548055;18319.54201144969;19181.712274315898;19639.214431422726;20206;20351.89824050885;1975.733276007735;2046.7339245898088;2324.1633012115626;2333.941651458727;2408.3497455687043;10951.616693415692;12519.687007824787;12664.68338291541;12695.55565555201;13153.031417045895;1812.9274829006824;1846.344547685579;1858.3031363238786;1862.245790454868;1903.0294549779574;51834.48165518334;53699.19451208235;53879;54848.45151548473;54864.72567637136;14120.717585648435;14503.564893053226;14583.416663333348;14710.926445367704;14755.40978360875;23074.65388019181;23201.651975220386;23278.883605581865;23412;23445.7655423447;8314.542700151549;8325.25072743456;8396.706115285935;8420.368472364475;8439.57802109892;6926.099607051152;6955.200151982485;7053.541519801196;7086.50394472382;7110.004599356094;7303.59830209333;7384.298491643285;7469.663865126083;7549.320561149523;7570.280823321776;2538.59382498803;2856.714328567168;2888.35012122275;2925.283305590144;2990.596269503589;426.75035104464234;432.56527190173676;441.50110375275733;798.2735710503414;903.7559858838208;10019.448930308903;10492.265541412027;10715.46422678863;10774.515146818412;10786.191035672198;453.93417954396426;457.0310940805514;460.3302195305822;871.7602659268625;909.7589138878203;8666.696665616799;8805.603747831363;8810.088477172645;9045;9114.179723824887;538647;541871.0690251645;544353;548417;558343;68925.2768680777;69248;71960;72199.63900180465;72721;998.5606333213362;1024.262530977695;1031.8761748590218;1032.8140934631838;1067.7117178361955;13628.727425451634;13723.725525489235;13814.309284535531;14472.638184045061;14674.926625366805;32296.192595185308;32341.838290808395;32586.51120233246;32755.836220818743;33004.50493242555;36404.27191456103;36539.451908220864;38613.42079868748;39773.204535909696;40505.39241911432;7088.362047415757;7311.597862117422;7426;7440.55356678601;7474.476786624884;8983.505907175168;10532.842007369742;10600.575976961143;10750.46247687628;11092.33445993243;9672.564734587102;9674.661386851427;9826.5086745661;10045.246606504688;10139.391636501834;9404.717858464257;9888.390737380949;9996.350237234556;10117.190624749855;10153.176362510818;9682.128608425275;9958.107959487674;10027.548760305657;10056.54745536438;10217.74455638615;7416.332530072319;7446.515976461513;7462.328390444886;7525.360344370571;7543.170251272246;9553.856692149484;9815.263855210746;10079.395236285847;10196.184305255414;10221.74445638865 05:58:19 INFO - PROCESS | 5561 | |3;mootools.html;1262.8610852806185;1396.2390497179038;1402.5161319344825;1530.9081455112694;1740.6866763982478;6648.667566621668;7590.203028681992;7623.847523049536;7670.578118203496;7699.461037727354;7474.439417043716;7503.0996280446425;7573.621318934059;7599.316061554459;7626.809329766758;1889.8582606304512;1951.5999220159904;2243.977560224397;2263.7736226377397;2267.183813827021;2219.556088782242;2288.4507718147606;2294.288770481156;2297.24191016964;2298.9195378161767;2255.323402979108;2264.8414610977156;2317.4901521665206;2317.918872839451;2319.860808351496;2256.5599708056934;2279.737830149529;2286.2683941138844;2293.3578597992587;2301.3211102724736;2253.9323820285417;2282.189822612965;2286.954260914789;2293.334932869466;2302.1482051640833;7773.766786996399;7779.7666070017995;7784.143744188134;7785.922140778576;7796.961015194945;4634.582887540138;4697.530246975275;4719.386479757643;4740.336352910595;4744.193487107165;2971.138369872756;3010.5634682971067;3089.5056790913345;3093.7834351595397;3098.721115099652;891.3092353426082;903.0978934324659;909.6725178935644;923.0815338737932;940.3981451870808;10295.588176472933;10374.429406382646;10379.377237365707;10397.428141452217;10454.52954617044;4110.260153172398;4127.628513433805;4211;4217.1776503581505;4302.9569704303185;9232.53837308132;9254.537273136317;9256.444613323221;9261.351705380559;9282;4731.668783185213;4735.147673418749;4767.73777442244;4773.95226047742;4776.283557466408;4247.426597409372;4316.0720445103825;4338.284183109815;4340.739555626673;4365.039691267916;3243.4323993301077;3246.3507298540385;3501.492283618912;3600.6039335673054;3601.0637234319265;1156.640946887404;1163.8836116388293;1165.720227145496;1170.8712041675408;1177.587844254504;1226.3439060102803;1252.2549083295426;1273.2106094221642;1321.8479874814327;1322.1670347681093;7140.642967851587;7215.458840586977;7230.9638451807405;7320;7322.414206863438;996.6611352140308;1012.711377257478;1065.4672663668166;1079.3308148947547;1086.3699054548342;5212.582993360522;5292.391374991848;5297.549708274762;5299.231611416323;5315.069862773999;9035.593398297093;9167.862482062774;9265.749123868327;9290.349675522648;9382.90617093834;9274.072592740808;9327.533623318806;9352.532373381304;9473.66842160521;9542.997985211592;6888.621125838027;7135.714571417086;7147.321004504668;7304.707811687473;7307.598082105429;6979.953007048984;6980.441564674916;7003.54476958996;7066;7068.71725130989;7724.111727151225;7825.1783562725095;7986.720464783704;7987.16134805837;8438.704645337384;8021.218055176766;8328.292095171979;8397.664093436195;8402.285805706339;8403.873941890753;6838.213605435439;6869.965650171717;6976.616286104313;7057.576545407087;7058;6312.936870631419;6489.253735820441;7048.929510705032;7259.963700181465;7298.306660867209;6813.148356455443;6875.48433867472;6883.036374907617;7037.859242815218;7060.858782824212;6754.898676519954;6839.247682754993;6945.2707465715375;6965.651717414008;6992.265812089658;7014.5440546364325;7055.118110236221;7056.858862822817;7066.116735408074;7067.6819543119655;6236.875262494634;6376.968115159394;6415.133956915756;6441.1626488556185;6449.903251451138;6329.398707122816;6361.809145725636;6364.936350636434;6366.681665916593;6382.6170429774365 05:58:19 INFO - PROCESS | 5561 | |4;prototype.html;334.4264586234608;341.4724251032155;345.12510785159594;346.5667915106117;350.6837339373437;5648.068068768658;5735.598508104429;5818.156367326746;5865.882682346356;5875.970620146904;5588.077967135428;5765.1928729977735;5766.106253530699;5771.740271687773;5772.220750198722;4456.532064133268;4474.351219073233;4474.910501789978;4500.752458614775;4503.054358584701;4283.764392958386;4370.409994650713;4376.474823021226;4474.328850672393;4495.325701144821;4420.97789511052;4432.756198409086;4436.489803672586;4437.933430998538;4441.666874984373;4414.624756895668;4419.801108950072;4424.048829501657;4427.203103441379;4439.911201775979;3939.9015024624327;3945.585713500099;3945.881623551298;3946.8026598669953;3950.604939506055;5373.194020896858;5509.944900550983;5514.641548299348;5538.861528461781;5542.889142217133;5129.563987061104;5147.510986456281;5191.143461328877;5200.323957885488;5204.9219261711105;6037.667928263943;6072.726727297282;6081.148639190517;6087.1173679816175;6090.086487026937;4364.388985542027;4367.54140815213;4368.366586844922;4368.737875727466;4382.8904277393;5864.824055278348;6059.66671833049;6344.619322840645;6348.936510634927;6391.712372943229;4516.119356725473;4516.16450956574;4517.616002639812;4517.616002639812;4520.208963431386;4573.925127595013;4578.35902973584;4580.38164847748;4585.403897493371;4587.472440669299;5184.8185313514605;5207.984443033648;5214.8527323988665;5216.895662086737;5223.52988231061;5996.5202783777195;6168.074788781719;6208.906866397007;6214.844628884223;6234.127222188898;1555.642202293479;1573.6144644562155;1574.2915687940472;1576.7004269188817;1577.4715470317572;1044.639599338227;1044.7179261599479;1050.144132531984;1057.0856209378985;1063.9202059845543;5779.942200577941;5780.826575202751;5782.739776709974;5788.27646544182;5796.072628379439;6121.112438696364;6198.845028874314;6316.242050953915;6327.746890124436;6334.968325158345;5715.5427565794635;5833.154192642043;5848.795292164839;5888.793892213837;5897.380775018647;3386.356592247465;3414.7951122932704;3417.8120203389053;3420.0252927915426;3420.247545539977;6328.177336946167;6490.1238332825405;6497.545171837926;6506.479481641457;6515.348465153446;6537.313582073909;6549.377809108127;6567.277599464055;6575.539712220098;6576.605403675699;6447;6506.674666266667;6515.120458738104;6515.446187074152;6518.761435327273;6272.121902933502;6367.108604795239;6376.9043464349;6378.394052564999;6408.871822563616;6332.430081292706;6335.429811317003;6337.7148028337915;6344.270408903035;6352.872942541216;6517.478601711947;6520.282768895512;6525.249596296297;6525.673716314261;6529.7061632227615;4405.361222622766;4414.139242847614;4415.381846541422;4417.447819022622;4432.113577284492;6170.10533472635;6289.119523266838;6327.588706734047;6374.235091789015;6434.935650643621;6197.597156184834;6239.377761781879;6244.562880598496;6250.249970003629;6275.497960163268;6245.718942647501;6253.249610046823;6254.249490061222;6254.405831446005;6259.96870015647;6022;6081.6655083969035;6100.450959413674;6129.785457508966;6133.509319254538;6187.752489900354;6203.689815509116;6262.968685156728;6282.748690052346;6284.717187726655;6108.144859719554;6109.877802444015;6119.755209791559;6124.908126378197;6125.591114043706 05:58:19 INFO - PROCESS | 5561 | |5;yui.html;826.8139668574571;827.9172082791722;833.3083540661255;836.3392919593522;856.7815207122183;13088.280144592043;13240.668983275411;13415.19508829471;13433.261170635611;13439.865601343996;12666.683332916682;12728.61814145577;12733.872661273384;12734.808977865316;12780.297083660394;672.6199697171107;680.3026897430125;795.2246559604368;799.5762246009609;816.4448175240834;792.0495405513378;795.3716563914501;798.9201079892023;800.8038030682491;802.1657476224749;848.8641817309232;849.3799526345771;849.3926842307749;849.7918010087507;849.9405041647057;694.3334398976988;696.022088965005;838.7609531283616;852.927501162402;853.6372041882237;620.0389396435552;621.1924498152429;621.4003486635419;621.7668374359615;622.7758007117434;12932.159409638343;12987.805182922264;13012.86987130126;13071.281079540622;13074.673133171747;12009.819852702216;12463;12604.306763128025;12753.489860405665;13095.803562946563;10462.110720588758;10501.894981050169;10539;10650.201234907336;10699.251052426333;3543.698785603227;3648.343298206322;3654;3692.8892133236045;3695.6489133532273;42442.938926526775;42764;42808.57191428077;42979.57020429818;43151.35272970908;9704.466254355937;9880.808600788016;9927.354721943051;10088.798224035625;10204.897951020543;16850.57873553171;17485.562860928578;17505.824941750674;17558.736618950727;17598.824011759974;7375.668094935633;7393.112826460859;7406.259374062658;7618.466707330434;7647.044119485065;4033.8991525212105;4226.978865105716;4251.022264879095;4297.634701050446;4301.806418711166;3026.8940587079346;3042.269855234772;3050.740687041582;3053.7862349635757;3067.4171907337536;508.30362403507434;515.4536191636877;518.3002946022914;540.1789280293931;542.0811724127566;536.8979893820161;622.5237693164732;624.9906401162091;629.8016124920636;678.1551391910984;8738.825223495494;9154.86267705985;9287.860682089775;9474.763130921645;9686.225101991824;485.7037207303542;599.2778701664483;633.94294513494;682.7098483144644;699.3181647893264;3512.84192211346;3656.1956369598647;3773.52830896138;3965.2466031453932;4460.219461594208;53533.197002045;53809.1928621071;53981;54610;54636.72681636566;46562.76718616385;46994.5300546997;47115.76442117767;47279.527204727514;47389.289160662614;46408;46425.303620445724;46783.532164678596;47079.05841883143;47311.29033064507;8561.871571926302;8707.3693422235;9114.498702571156;9219.216366608913;9320.860187097063;33719;33736;35075.649243507236;35250.471242930864;35317.646823532465;42912.570874292105;42955.570444295154;43643.78178109089;43723.56276437322;45191.548084518734;10864.891351086388;10867.673969780919;11043.061339786209;11106.944465277946;11396.373199474108;12016.579419720269;12087.697807554881;12126;12418.130730848754;12445.226100694505;11448.484818183035;11476.254043487146;11476.942615286871;11629.651110466699;11865.940670296593;11142.721431964266;11147.888521114684;11664.300141991507;11744.823827642764;11863.58477453285;9921.195598097655;10256.410256410078;10325;10352.948235258775;11540.653780386601;8544.40189186751;8751.737447876574;9079.591418386057;9128.49793261377;9256.629734810802;8691.478511289342;9565.904340956502;9682.951585242028;9744.17174540172;9750 05:58:19 INFO - PROCESS | 5561 | __end_tp_report 05:58:19 INFO - PROCESS | 5561 | __start_cc_report 05:58:19 INFO - PROCESS | 5561 | _x_x_mozilla_cycle_collect,709 05:58:19 INFO - PROCESS | 5561 | __end_cc_report 05:58:19 INFO - PROCESS | 5561 | __startTimestamp1452607099717__endTimestamp 05:58:19 INFO - PROCESS | 5561 | 05:58:19 INFO - PROCESS | 5561 | ------- Summary: start ------- 05:58:19 INFO - PROCESS | 5561 | Number of tests: 6 05:58:19 INFO - PROCESS | 5561 | 05:58:19 INFO - PROCESS | 5561 | [#0] dojo.html Cycles:165 Average:5080.85 Median:5309.79 stddev:535.28 (10.1%) stddev-sans-first:513.92 05:58:19 INFO - PROCESS | 5561 | Values: 3102.1 3109.1 3149.3 3156.5 3170.2 4930.3 5062.9 5067.7 5068.8 5107.6 5074.2 5076.6 5098.3 5121.6 5191.1 4625.3 4629.0 4668.8 4767.2 4822.3 4774.2 4792.5 4823.0 4861.5 4865.2 4582.7 4637.6 4658.1 4666.5 4710.0 4684.1 4721.4 4723.2 4736.0 4756.7 4675.1 4686.3 4689.0 4720.3 4746.8 4867.0 4923.7 4933.4 4940.5 4952.2 5398.9 5431.3 5433.3 5442.3 5449.9 5433.4 5439.2 5450.5 5457.5 5461.1 5117.4 5154.7 5193.8 5196.3 5197.9 5451.2 5473.8 5519.8 5521.4 5523.0 5309.8 5327.9 5329.2 5331.7 5338.7 5510.6 5522.4 5587.6 5599.9 5636.4 5549.9 5555.1 5558.3 5563.7 5569.2 5353.6 5454.3 5570.1 5578.0 5588.9 4188.5 4206.9 4210.7 4225.3 4267.2 3840.8 3847.9 3848.8 3865.3 3886.9 4992.9 5070.7 5143.0 5145.0 5192.1 5429.1 5451.4 5469.2 5475.5 5523.0 4950.8 4961.4 4965.4 4970.5 5004.1 4602.4 4607.7 4617.5 4666.1 4697.4 5475.9 5508.0 5522.7 5533.6 5537.8 5425.4 5430.6 5434.7 5437.2 5449.4 5407.7 5475.6 5481.0 5539.4 5568.2 5372.0 5391.5 5393.3 5395.0 5405.8 5479.9 5485.2 5492.6 5499.8 5552.8 5203.9 5345.7 5374.9 5375.3 5435.6 5339.5 5351.1 5356.6 5382.4 5386.2 5155.6 5316.5 5320.4 5323.9 5336.3 5331.3 5395.4 5454.9 5462.7 5512.7 5266.9 5293.6 5293.7 5296.1 5302.9 05:58:19 INFO - PROCESS | 5561 | 05:58:19 INFO - PROCESS | 5561 | [#1] ext.html Cycles:180 Average:42722.39 Median:34700.15 stddev:70617.19 (203.5%) stddev-sans-first:70744.15 05:58:19 INFO - PROCESS | 5561 | Values: 505.1 509.7 524.4 535.2 541.3 28410.9 35035.0 35816.0 35866.6 35866.6 39237.6 39613.4 39704.8 39729.4 39767.2 8352.8 8622.4 8628.3 8637.1 8637.4 8347.2 8445.8 8488.1 8502.6 8514.7 8313.5 8373.2 8381.2 8387.1 8400.5 8448.5 8478.0 8501.0 8507.3 8507.6 8318.4 8406.2 8468.2 8481.2 8487.5 38536.0 38996.8 39004.4 39044.6 39052.6 3086.2 3140.0 3159.4 3177.4 3588.0 28747.9 29315.6 29624.6 29803.3 30711.8 3538.5 3540.8 3667.7 3711.7 3795.9 259344.0 259554.0 259858.0 260490.0 260583.0 53663.2 53982.0 54015.0 54043.5 54080.0 53311.5 54903.5 54963.0 54997.3 58502.7 13762.4 14177.7 14183.0 14200.8 14203.6 9867.2 10020.7 10041.9 10054.6 10082.7 16872.8 17141.8 17910.3 18121.6 18579.5 6876.9 7067.4 7143.3 7145.8 7185.2 900.4 965.6 1031.5 1041.6 1042.7 26481.3 26992.7 26992.9 28110.6 28774.3 1030.9 1055.4 1059.6 1092.2 1161.8 14914.3 15435.4 15461.2 15638.3 16160.8 326627.0 332579.0 334202.0 335256.0 335787.0 51536.0 51682.2 51725.5 51816.0 51925.0 1293.4 1301.3 1307.6 1313.1 1314.8 26615.7 27925.0 28490.0 28546.7 29070.4 41993.0 42296.0 42432.1 42508.6 42521.9 197476.0 200064.0 200262.0 200331.0 200351.0 28634.3 28847.6 28931.7 29224.9 29233.0 36126.0 36799.8 42285.0 42709.8 46169.0 33856.8 34080.5 34280.3 34444.7 35031.3 34356.5 34955.7 35102.8 35250.8 35344.6 30835.7 31062.5 31288.2 34069.7 36003.6 29366.3 30829.8 31146.0 31307.4 31399.5 23071.3 23939.1 23981.4 24257.5 24442.6 05:58:19 INFO - PROCESS | 5561 | 05:58:19 INFO - PROCESS | 5561 | [#2] jquery.html Cycles:180 Average:27798.96 Median:429.66 stddev:89111.90 (20740.2%) stddev-sans-first:89338.07 05:58:19 INFO - PROCESS | 5561 | Values: 361.2 361.3 362.8 363.2 370.5 13346.4 13449.0 15668.3 16509.4 17563.6 14461.3 14924.7 15210.1 15305.5 15863.2 5275.8 5450.5 5456.4 5459.0 5469.5 3962.9 4078.9 5368.3 5437.8 5645.2 5785.5 5984.3 6025.0 6033.1 6044.1 5934.3 5986.9 5991.4 5993.9 5994.2 5130.6 5276.5 5279.1 5328.8 5346.1 18319.5 19181.7 19639.2 20206.0 20351.9 1975.7 2046.7 2324.2 2333.9 2408.3 10951.6 12519.7 12664.7 12695.6 13153.0 1812.9 1846.3 1858.3 1862.2 1903.0 51834.5 53699.2 53879.0 54848.5 54864.7 14120.7 14503.6 14583.4 14710.9 14755.4 23074.7 23201.7 23278.9 23412.0 23445.8 8314.5 8325.3 8396.7 8420.4 8439.6 6926.1 6955.2 7053.5 7086.5 7110.0 7303.6 7384.3 7469.7 7549.3 7570.3 2538.6 2856.7 2888.4 2925.3 2990.6 426.8 432.6 441.5 798.3 903.8 10019.4 10492.3 10715.5 10774.5 10786.2 453.9 457.0 460.3 871.8 909.8 8666.7 8805.6 8810.1 9045.0 9114.2 538647.0 541871.1 544353.0 548417.0 558343.0 68925.3 69248.0 71960.0 72199.6 72721.0 998.6 1024.3 1031.9 1032.8 1067.7 13628.7 13723.7 13814.3 14472.6 14674.9 32296.2 32341.8 32586.5 32755.8 33004.5 36404.3 36539.5 38613.4 39773.2 40505.4 7088.4 7311.6 7426.0 7440.6 7474.5 8983.5 10532.8 10600.6 10750.5 11092.3 9672.6 9674.7 9826.5 10045.2 10139.4 9404.7 9888.4 9996.4 10117.2 10153.2 9682.1 9958.1 10027.5 10056.5 10217.7 7416.3 7446.5 7462.3 7525.4 7543.2 9553.9 9815.3 10079.4 10196.2 10221.7 05:58:19 INFO - PROCESS | 5561 | 05:58:19 INFO - PROCESS | 5561 | [#3] mootools.html Cycles:180 Average:5364.95 Median:6379.79 stddev:2773.50 (43.5%) stddev-sans-first:2764.14 05:58:19 INFO - PROCESS | 5561 | Values: 1262.9 1396.2 1402.5 1530.9 1740.7 6648.7 7590.2 7623.8 7670.6 7699.5 7474.4 7503.1 7573.6 7599.3 7626.8 1889.9 1951.6 2244.0 2263.8 2267.2 2219.6 2288.5 2294.3 2297.2 2298.9 2255.3 2264.8 2317.5 2317.9 2319.9 2256.6 2279.7 2286.3 2293.4 2301.3 2253.9 2282.2 2287.0 2293.3 2302.1 7773.8 7779.8 7784.1 7785.9 7797.0 4634.6 4697.5 4719.4 4740.3 4744.2 2971.1 3010.6 3089.5 3093.8 3098.7 891.3 903.1 909.7 923.1 940.4 10295.6 10374.4 10379.4 10397.4 10454.5 4110.3 4127.6 4211.0 4217.2 4303.0 9232.5 9254.5 9256.4 9261.4 9282.0 4731.7 4735.1 4767.7 4774.0 4776.3 4247.4 4316.1 4338.3 4340.7 4365.0 3243.4 3246.4 3501.5 3600.6 3601.1 1156.6 1163.9 1165.7 1170.9 1177.6 1226.3 1252.3 1273.2 1321.8 1322.2 7140.6 7215.5 7231.0 7320.0 7322.4 996.7 1012.7 1065.5 1079.3 1086.4 5212.6 5292.4 5297.5 5299.2 5315.1 9035.6 9167.9 9265.7 9290.3 9382.9 9274.1 9327.5 9352.5 9473.7 9543.0 6888.6 7135.7 7147.3 7304.7 7307.6 6980.0 6980.4 7003.5 7066.0 7068.7 7724.1 7825.2 7986.7 7987.2 8438.7 8021.2 8328.3 8397.7 8402.3 8403.9 6838.2 6870.0 6976.6 7057.6 7058.0 6312.9 6489.3 7048.9 7260.0 7298.3 6813.1 6875.5 6883.0 7037.9 7060.9 6754.9 6839.2 6945.3 6965.7 6992.3 7014.5 7055.1 7056.9 7066.1 7067.7 6236.9 6377.0 6415.1 6441.2 6449.9 6329.4 6361.8 6364.9 6366.7 6382.6 05:58:19 INFO - PROCESS | 5561 | 05:58:19 INFO - PROCESS | 5561 | [#4] prototype.html Cycles:180 Average:5158.33 Median:5785.51 stddev:1534.33 (26.5%) stddev-sans-first:1495.31 05:58:19 INFO - PROCESS | 5561 | Values: 334.4 341.5 345.1 346.6 350.7 5648.1 5735.6 5818.2 5865.9 5876.0 5588.1 5765.2 5766.1 5771.7 5772.2 4456.5 4474.4 4474.9 4500.8 4503.1 4283.8 4370.4 4376.5 4474.3 4495.3 4421.0 4432.8 4436.5 4437.9 4441.7 4414.6 4419.8 4424.0 4427.2 4439.9 3939.9 3945.6 3945.9 3946.8 3950.6 5373.2 5509.9 5514.6 5538.9 5542.9 5129.6 5147.5 5191.1 5200.3 5204.9 6037.7 6072.7 6081.1 6087.1 6090.1 4364.4 4367.5 4368.4 4368.7 4382.9 5864.8 6059.7 6344.6 6348.9 6391.7 4516.1 4516.2 4517.6 4517.6 4520.2 4573.9 4578.4 4580.4 4585.4 4587.5 5184.8 5208.0 5214.9 5216.9 5223.5 5996.5 6168.1 6208.9 6214.8 6234.1 1555.6 1573.6 1574.3 1576.7 1577.5 1044.6 1044.7 1050.1 1057.1 1063.9 5779.9 5780.8 5782.7 5788.3 5796.1 6121.1 6198.8 6316.2 6327.7 6335.0 5715.5 5833.2 5848.8 5888.8 5897.4 3386.4 3414.8 3417.8 3420.0 3420.2 6328.2 6490.1 6497.5 6506.5 6515.3 6537.3 6549.4 6567.3 6575.5 6576.6 6447.0 6506.7 6515.1 6515.4 6518.8 6272.1 6367.1 6376.9 6378.4 6408.9 6332.4 6335.4 6337.7 6344.3 6352.9 6517.5 6520.3 6525.2 6525.7 6529.7 4405.4 4414.1 4415.4 4417.4 4432.1 6170.1 6289.1 6327.6 6374.2 6434.9 6197.6 6239.4 6244.6 6250.2 6275.5 6245.7 6253.2 6254.2 6254.4 6260.0 6022.0 6081.7 6100.5 6129.8 6133.5 6187.8 6203.7 6263.0 6282.7 6284.7 6108.1 6109.9 6119.8 6124.9 6125.6 05:58:19 INFO - PROCESS | 5561 | 05:58:19 INFO - PROCESS | 5561 | [#5] yui.html Cycles:180 Average:13359.14 Median:45799.77 stddev:15074.86 (32.9%) stddev-sans-first:15087.77 05:58:19 INFO - PROCESS | 5561 | Values: 826.8 827.9 833.3 836.3 856.8 13088.3 13240.7 13415.2 13433.3 13439.9 12666.7 12728.6 12733.9 12734.8 12780.3 672.6 680.3 795.2 799.6 816.4 792.0 795.4 798.9 800.8 802.2 848.9 849.4 849.4 849.8 849.9 694.3 696.0 838.8 852.9 853.6 620.0 621.2 621.4 621.8 622.8 12932.2 12987.8 13012.9 13071.3 13074.7 12009.8 12463.0 12604.3 12753.5 13095.8 10462.1 10501.9 10539.0 10650.2 10699.3 3543.7 3648.3 3654.0 3692.9 3695.6 42442.9 42764.0 42808.6 42979.6 43151.4 9704.5 9880.8 9927.4 10088.8 10204.9 16850.6 17485.6 17505.8 17558.7 17598.8 7375.7 7393.1 7406.3 7618.5 7647.0 4033.9 4227.0 4251.0 4297.6 4301.8 3026.9 3042.3 3050.7 3053.8 3067.4 508.3 515.5 518.3 540.2 542.1 536.9 622.5 625.0 629.8 678.2 8738.8 9154.9 9287.9 9474.8 9686.2 485.7 599.3 633.9 682.7 699.3 3512.8 3656.2 3773.5 3965.2 4460.2 53533.2 53809.2 53981.0 54610.0 54636.7 46562.8 46994.5 47115.8 47279.5 47389.3 46408.0 46425.3 46783.5 47079.1 47311.3 8561.9 8707.4 9114.5 9219.2 9320.9 33719.0 33736.0 35075.6 35250.5 35317.6 42912.6 42955.6 43643.8 43723.6 45191.5 10864.9 10867.7 11043.1 11106.9 11396.4 12016.6 12087.7 12126.0 12418.1 12445.2 11448.5 11476.3 11476.9 11629.7 11865.9 11142.7 11147.9 11664.3 11744.8 11863.6 9921.2 10256.4 10325.0 10352.9 11540.7 8544.4 8751.7 9079.6 9128.5 9256.6 8691.5 9565.9 9683.0 9744.2 9750.0 05:58:19 INFO - PROCESS | 5561 | -------- Summary: end -------- 05:58:19 INFO - PROCESS | 5561 | 05:58:20 INFO - TEST-INFO | 5561: exit 0 05:58:20 INFO - TEST-OK | dromaeo_css | took 1112423ms 05:58:20 INFO - TEST-START | kraken 05:58:20 INFO - operating with platform_type : linux_ 05:58:20 INFO - Initialising browser for kraken test... 05:58:20 INFO - TEST-INFO | started process 5747 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZ2pz3W/profile http://localhost:57861/getInfo.html) 05:58:24 INFO - PROCESS | 5747 | __metrics Screen width/height:1600/1200 05:58:24 INFO - PROCESS | 5747 | colorDepth:24 05:58:24 INFO - PROCESS | 5747 | Browser inner width/height: 1024/697 05:58:24 INFO - PROCESS | 5747 | __metrics 05:58:24 INFO - PROCESS | 5747 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:58:24 INFO - PROCESS | 5747 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:58:25 INFO - TEST-INFO | 5747: exit 0 05:58:25 INFO - Browser initialized. 05:58:25 INFO - Running cycle 1/1 for kraken test... 05:58:25 INFO - TEST-INFO | started process 5831 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZ2pz3W/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:58:37 INFO - PROCESS | 5831 | RSS: Main: 147439616 05:58:37 INFO - PROCESS | 5831 | 05:58:39 INFO - PROCESS | 5831 | Cycle 1(1): loaded http://localhost:57861/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57861/tests/kraken/driver.html?testName=audio-beat-detection) 05:58:40 INFO - PROCESS | 5831 | RSS: Main: 185593856 05:58:40 INFO - PROCESS | 5831 | 05:58:42 INFO - PROCESS | 5831 | Cycle 1(1): loaded http://localhost:57861/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57861/tests/kraken/driver.html?testName=audio-dft) 05:58:43 INFO - PROCESS | 5831 | RSS: Main: 174563328 05:58:43 INFO - PROCESS | 5831 | 05:58:46 INFO - PROCESS | 5831 | Cycle 1(1): loaded http://localhost:57861/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57861/tests/kraken/driver.html?testName=audio-fft) 05:58:46 INFO - PROCESS | 5831 | RSS: Main: 158732288 05:58:46 INFO - PROCESS | 5831 | 05:58:48 INFO - PROCESS | 5831 | Cycle 1(1): loaded http://localhost:57861/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57861/tests/kraken/driver.html?testName=audio-oscillator) 05:58:49 INFO - PROCESS | 5831 | RSS: Main: 163115008 05:58:49 INFO - PROCESS | 5831 | 05:58:51 INFO - PROCESS | 5831 | Cycle 1(1): loaded http://localhost:57861/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57861/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:58:52 INFO - PROCESS | 5831 | RSS: Main: 163659776 05:58:52 INFO - PROCESS | 5831 | 05:58:55 INFO - PROCESS | 5831 | Cycle 1(1): loaded http://localhost:57861/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57861/tests/kraken/driver.html?testName=imaging-darkroom) 05:58:55 INFO - PROCESS | 5831 | RSS: Main: 162684928 05:58:55 INFO - PROCESS | 5831 | 05:58:59 INFO - PROCESS | 5831 | Cycle 1(1): loaded http://localhost:57861/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57861/tests/kraken/driver.html?testName=imaging-desaturate) 05:58:59 INFO - PROCESS | 5831 | RSS: Main: 163708928 05:58:59 INFO - PROCESS | 5831 | 05:59:02 INFO - PROCESS | 5831 | Cycle 1(1): loaded http://localhost:57861/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57861/tests/kraken/driver.html?testName=json-parse-financial) 05:59:02 INFO - PROCESS | 5831 | RSS: Main: 165113856 05:59:02 INFO - PROCESS | 5831 | 05:59:04 INFO - PROCESS | 5831 | Cycle 1(1): loaded http://localhost:57861/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57861/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:59:05 INFO - PROCESS | 5831 | RSS: Main: 176300032 05:59:05 INFO - PROCESS | 5831 | 05:59:06 INFO - PROCESS | 5831 | Cycle 1(1): loaded http://localhost:57861/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57861/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:59:07 INFO - PROCESS | 5831 | RSS: Main: 174690304 05:59:07 INFO - PROCESS | 5831 | 05:59:09 INFO - PROCESS | 5831 | Cycle 1(1): loaded http://localhost:57861/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57861/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:59:10 INFO - PROCESS | 5831 | RSS: Main: 186814464 05:59:10 INFO - PROCESS | 5831 | 05:59:12 INFO - PROCESS | 5831 | Cycle 1(1): loaded http://localhost:57861/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57861/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:59:13 INFO - PROCESS | 5831 | RSS: Main: 194265088 05:59:13 INFO - PROCESS | 5831 | 05:59:15 INFO - PROCESS | 5831 | Cycle 1(1): loaded http://localhost:57861/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57861/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:59:16 INFO - PROCESS | 5831 | RSS: Main: 193224704 05:59:16 INFO - PROCESS | 5831 | 05:59:18 INFO - PROCESS | 5831 | Cycle 1(1): loaded http://localhost:57861/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57861/tests/kraken/driver.html?testName=ai-astar) 05:59:18 INFO - PROCESS | 5831 | RSS: Main: 251084800 05:59:18 INFO - PROCESS | 5831 | 05:59:18 INFO - PROCESS | 5831 | __start_tp_report 05:59:18 INFO - PROCESS | 5831 | _x_x_mozilla_page_load 05:59:18 INFO - PROCESS | 5831 | _x_x_mozilla_page_load_details 05:59:18 INFO - PROCESS | 5831 | |i|pagename|runs| 05:59:18 INFO - PROCESS | 5831 | |0;ai-astar;104;111;111;110;111;113;113;115;113;123 05:59:18 INFO - PROCESS | 5831 | |1;audio-beat-detection;149;129;154;173;129;150;151;124;171;129 05:59:18 INFO - PROCESS | 5831 | |2;audio-dft;161;163;163;162;166;163;163;159;162;160 05:59:18 INFO - PROCESS | 5831 | |3;audio-fft;72;73;83;90;74;72;74;98;97;74 05:59:18 INFO - PROCESS | 5831 | |4;audio-oscillator;98;97;141;95;96;97;137;97;96;145 05:59:18 INFO - PROCESS | 5831 | |5;imaging-gaussian-blur;111;110;109;109;109;110;110;109;110;109 05:59:18 INFO - PROCESS | 5831 | |6;imaging-darkroom;148;145;146;146;146;147;146;147;147;147 05:59:18 INFO - PROCESS | 5831 | |7;imaging-desaturate;96;96;96;96;96;96;97;98;96;95 05:59:18 INFO - PROCESS | 5831 | |8;json-parse-financial;56;54;55;55;57;57;55;63;53;53 05:59:18 INFO - PROCESS | 5831 | |9;json-stringify-tinderbox;68;68;68;69;69;69;69;67;68;67 05:59:18 INFO - PROCESS | 5831 | |10;stanford-crypto-aes;85;86;88;88;86;95;87;94;96;87 05:59:18 INFO - PROCESS | 5831 | |11;stanford-crypto-ccm;116;118;119;118;114;115;119;124;116;123 05:59:18 INFO - PROCESS | 5831 | |12;stanford-crypto-pbkdf2;141;153;143;151;153;141;160;153;152;142 05:59:18 INFO - PROCESS | 5831 | |13;stanford-crypto-sha256-iterative;73;70;69;69;68;68;69;71;72;68 05:59:18 INFO - PROCESS | 5831 | __end_tp_report 05:59:18 INFO - PROCESS | 5831 | __start_cc_report 05:59:18 INFO - PROCESS | 5831 | _x_x_mozilla_cycle_collect,909 05:59:18 INFO - PROCESS | 5831 | __end_cc_report 05:59:18 INFO - PROCESS | 5831 | __startTimestamp1452607158280__endTimestamp 05:59:18 INFO - PROCESS | 5831 | 05:59:18 INFO - PROCESS | 5831 | ------- Summary: start ------- 05:59:18 INFO - PROCESS | 5831 | Number of tests: 14 05:59:18 INFO - PROCESS | 5831 | 05:59:18 INFO - PROCESS | 5831 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:4.74 (4.2%) stddev-sans-first:3.94 05:59:18 INFO - PROCESS | 5831 | Values: 104.0 111.0 111.0 110.0 111.0 113.0 113.0 115.0 113.0 123.0 05:59:18 INFO - PROCESS | 5831 | 05:59:18 INFO - PROCESS | 5831 | [#1] audio-beat-detection Cycles:10 Average:145.90 Median:150.50 stddev:17.70 (11.8%) stddev-sans-first:18.74 05:59:18 INFO - PROCESS | 5831 | Values: 149.0 129.0 154.0 173.0 129.0 150.0 151.0 124.0 171.0 129.0 05:59:18 INFO - PROCESS | 5831 | 05:59:18 INFO - PROCESS | 5831 | [#2] audio-dft Cycles:10 Average:162.20 Median:163.00 stddev:1.93 (1.2%) stddev-sans-first:2.00 05:59:18 INFO - PROCESS | 5831 | Values: 161.0 163.0 163.0 162.0 166.0 163.0 163.0 159.0 162.0 160.0 05:59:18 INFO - PROCESS | 5831 | 05:59:18 INFO - PROCESS | 5831 | [#3] audio-fft Cycles:10 Average:80.70 Median:78.50 stddev:10.55 (13.4%) stddev-sans-first:10.71 05:59:18 INFO - PROCESS | 5831 | Values: 72.0 73.0 83.0 90.0 74.0 72.0 74.0 98.0 97.0 74.0 05:59:18 INFO - PROCESS | 5831 | 05:59:18 INFO - PROCESS | 5831 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:96.50 stddev:21.56 (22.3%) stddev-sans-first:22.43 05:59:18 INFO - PROCESS | 5831 | Values: 98.0 97.0 141.0 95.0 96.0 97.0 137.0 97.0 96.0 145.0 05:59:18 INFO - PROCESS | 5831 | 05:59:18 INFO - PROCESS | 5831 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 05:59:18 INFO - PROCESS | 5831 | Values: 111.0 110.0 109.0 109.0 109.0 110.0 110.0 109.0 110.0 109.0 05:59:18 INFO - PROCESS | 5831 | 05:59:18 INFO - PROCESS | 5831 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.85 (0.6%) stddev-sans-first:0.71 05:59:18 INFO - PROCESS | 5831 | Values: 148.0 145.0 146.0 146.0 146.0 147.0 146.0 147.0 147.0 147.0 05:59:18 INFO - PROCESS | 5831 | 05:59:18 INFO - PROCESS | 5831 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 05:59:18 INFO - PROCESS | 5831 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 97.0 98.0 96.0 95.0 05:59:18 INFO - PROCESS | 5831 | 05:59:18 INFO - PROCESS | 5831 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.50 stddev:2.90 (5.2%) stddev-sans-first:3.07 05:59:18 INFO - PROCESS | 5831 | Values: 56.0 54.0 55.0 55.0 57.0 57.0 55.0 63.0 53.0 53.0 05:59:18 INFO - PROCESS | 5831 | 05:59:18 INFO - PROCESS | 5831 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.50 stddev:0.79 (1.2%) stddev-sans-first:0.83 05:59:18 INFO - PROCESS | 5831 | Values: 68.0 68.0 68.0 69.0 69.0 69.0 69.0 67.0 68.0 67.0 05:59:18 INFO - PROCESS | 5831 | 05:59:18 INFO - PROCESS | 5831 | [#10] stanford-crypto-aes Cycles:10 Average:89.20 Median:88.00 stddev:4.13 (4.7%) stddev-sans-first:4.09 05:59:18 INFO - PROCESS | 5831 | Values: 85.0 86.0 88.0 88.0 86.0 95.0 87.0 94.0 96.0 87.0 05:59:18 INFO - PROCESS | 5831 | 05:59:18 INFO - PROCESS | 5831 | [#11] stanford-crypto-ccm Cycles:10 Average:118.20 Median:118.50 stddev:3.26 (2.8%) stddev-sans-first:3.36 05:59:18 INFO - PROCESS | 5831 | Values: 116.0 118.0 119.0 118.0 114.0 115.0 119.0 124.0 116.0 123.0 05:59:18 INFO - PROCESS | 5831 | 05:59:18 INFO - PROCESS | 5831 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.90 Median:152.50 stddev:6.62 (4.3%) stddev-sans-first:6.38 05:59:18 INFO - PROCESS | 5831 | Values: 141.0 153.0 143.0 151.0 153.0 141.0 160.0 153.0 152.0 142.0 05:59:18 INFO - PROCESS | 5831 | 05:59:18 INFO - PROCESS | 5831 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:69.50 stddev:1.77 (2.5%) stddev-sans-first:1.41 05:59:18 INFO - PROCESS | 5831 | Values: 73.0 70.0 69.0 69.0 68.0 68.0 69.0 71.0 72.0 68.0 05:59:18 INFO - PROCESS | 5831 | -------- Summary: end -------- 05:59:18 INFO - PROCESS | 5831 | 05:59:19 INFO - TEST-INFO | 5831: exit 0 05:59:19 INFO - TEST-OK | kraken | took 58844ms 05:59:19 INFO - TEST-START | v8_7 05:59:19 INFO - operating with platform_type : linux_ 05:59:19 INFO - Initialising browser for v8_7 test... 05:59:19 INFO - TEST-INFO | started process 6080 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2z00lD/profile http://localhost:57861/getInfo.html) 05:59:22 INFO - PROCESS | 6080 | __metrics Screen width/height:1600/1200 05:59:22 INFO - PROCESS | 6080 | colorDepth:24 05:59:22 INFO - PROCESS | 6080 | Browser inner width/height: 1024/697 05:59:22 INFO - PROCESS | 6080 | __metrics 05:59:22 INFO - PROCESS | 6080 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:59:22 INFO - PROCESS | 6080 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:59:24 INFO - TEST-INFO | 6080: exit 0 05:59:24 INFO - Browser initialized. 05:59:24 INFO - Running cycle 1/1 for v8_7 test... 05:59:24 INFO - TEST-INFO | started process 6163 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2z00lD/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:35 INFO - PROCESS | 6163 | RSS: Main: 147820544 05:59:35 INFO - PROCESS | 6163 | 05:59:58 INFO - PROCESS | 6163 | Cycle 1(1): loaded http://localhost:57861/tests/v8_7/run.html (next: http://localhost:57861/tests/v8_7/run.html) 05:59:58 INFO - PROCESS | 6163 | RSS: Main: 582549504 05:59:58 INFO - PROCESS | 6163 | 05:59:58 INFO - PROCESS | 6163 | __start_tp_report 05:59:58 INFO - PROCESS | 6163 | _x_x_mozilla_page_load 05:59:58 INFO - PROCESS | 6163 | _x_x_mozilla_page_load_details 05:59:58 INFO - PROCESS | 6163 | |i|pagename|runs| 05:59:58 INFO - PROCESS | 6163 | |0;Richards;167.11229946524065 05:59:58 INFO - PROCESS | 6163 | |1;DeltaBlue;198.01980198019803 05:59:58 INFO - PROCESS | 6163 | |2;Encrypt;286.20492272467084 05:59:58 INFO - PROCESS | 6163 | |3;Decrypt;5273.684210526316 05:59:58 INFO - PROCESS | 6163 | |4;RayTrace;1970.4724409448818 05:59:58 INFO - PROCESS | 6163 | |5;Earley;768.0491551459294 05:59:58 INFO - PROCESS | 6163 | |6;Boyer;12180.722891566265 05:59:58 INFO - PROCESS | 6163 | |7;RegExp;42102.04081632653 05:59:58 INFO - PROCESS | 6163 | |8;Splay;612.1580547112462 05:59:58 INFO - PROCESS | 6163 | |9;NavierStokes;4864.077669902913 05:59:58 INFO - PROCESS | 6163 | __end_tp_report 05:59:58 INFO - PROCESS | 6163 | __startTimestamp1452607198562__endTimestamp 05:59:58 INFO - PROCESS | 6163 | 05:59:58 INFO - PROCESS | 6163 | ------- Summary: start ------- 05:59:58 INFO - PROCESS | 6163 | Number of tests: 10 05:59:58 INFO - PROCESS | 6163 | 05:59:58 INFO - PROCESS | 6163 | [#0] Richards Cycles:1 Average:167.11 Median:167.11 stddev:0.00 (0.0%) 05:59:58 INFO - PROCESS | 6163 | Values: 167.1 05:59:58 INFO - PROCESS | 6163 | 05:59:58 INFO - PROCESS | 6163 | [#1] DeltaBlue Cycles:1 Average:198.02 Median:198.02 stddev:0.00 (0.0%) 05:59:58 INFO - PROCESS | 6163 | Values: 198.0 05:59:58 INFO - PROCESS | 6163 | 05:59:58 INFO - PROCESS | 6163 | [#2] Encrypt Cycles:1 Average:286.20 Median:286.20 stddev:0.00 (0.0%) 05:59:58 INFO - PROCESS | 6163 | Values: 286.2 05:59:58 INFO - PROCESS | 6163 | 05:59:58 INFO - PROCESS | 6163 | [#3] Decrypt Cycles:1 Average:5273.68 Median:5273.68 stddev:0.00 (0.0%) 05:59:58 INFO - PROCESS | 6163 | Values: 5273.7 05:59:58 INFO - PROCESS | 6163 | 05:59:58 INFO - PROCESS | 6163 | [#4] RayTrace Cycles:1 Average:1970.47 Median:1970.47 stddev:0.00 (0.0%) 05:59:58 INFO - PROCESS | 6163 | Values: 1970.5 05:59:58 INFO - PROCESS | 6163 | 05:59:58 INFO - PROCESS | 6163 | [#5] Earley Cycles:1 Average:768.05 Median:768.05 stddev:0.00 (0.0%) 05:59:58 INFO - PROCESS | 6163 | Values: 768.0 05:59:58 INFO - PROCESS | 6163 | 05:59:58 INFO - PROCESS | 6163 | [#6] Boyer Cycles:1 Average:12180.72 Median:12180.72 stddev:0.00 (0.0%) 05:59:58 INFO - PROCESS | 6163 | Values: 12180.7 05:59:58 INFO - PROCESS | 6163 | 05:59:58 INFO - PROCESS | 6163 | [#7] RegExp Cycles:1 Average:42102.04 Median:42102.04 stddev:0.00 (0.0%) 05:59:58 INFO - PROCESS | 6163 | Values: 42102.0 05:59:58 INFO - PROCESS | 6163 | 05:59:58 INFO - PROCESS | 6163 | [#8] Splay Cycles:1 Average:612.16 Median:612.16 stddev:0.00 (0.0%) 05:59:58 INFO - PROCESS | 6163 | Values: 612.2 05:59:58 INFO - PROCESS | 6163 | 05:59:58 INFO - PROCESS | 6163 | [#9] NavierStokes Cycles:1 Average:4864.08 Median:4864.08 stddev:0.00 (0.0%) 05:59:58 INFO - PROCESS | 6163 | Values: 4864.1 05:59:58 INFO - PROCESS | 6163 | -------- Summary: end -------- 05:59:58 INFO - PROCESS | 6163 | 05:59:59 INFO - TEST-INFO | 6163: exit 0 05:59:59 INFO - TEST-OK | v8_7 | took 40250ms 05:59:59 INFO - SUITE-END | took 1211s 05:59:59 INFO - Completed test suite (00:20:12) 05:59:59 INFO - Working with test: dromaeo_css 05:59:59 INFO - Generating results file: dromaeo_css 05:59:59 INFO - Working with test: kraken 05:59:59 INFO - Generating results file: kraken 05:59:59 INFO - javascript benchmark 05:59:59 INFO - Working with test: v8_7 05:59:59 INFO - Generating results file: v8_7 05:59:59 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:00:00 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 06:00:00 INFO - process_Request line: dromaeo_css 6732.57 graph.html#tests=[[72,1,35]] 06:00:00 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:00:00 INFO - process_Request line: kraken 1513.40 graph.html#tests=[[232,1,35]] 06:00:00 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:00:00 INFO - process_Request line: v8_7 18784.90 graph.html#tests=[[230,1,35]] 06:00:00 INFO - RETURN: dromaeo_css: 6732.57 06:00:00 INFO - RETURN: kraken: 1513.40 06:00:00 INFO - RETURN: v8_7: 18784.90 06:00:00 INFO - javascript benchmark 06:00:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3102.1158969693633, 3109.098361475172, 3149.2756665966826, 3156.4634012217934, 3170.1599076244784, 4930.285108659242, 5062.898742025157, 5067.670601410906, 5068.771905264262, 5107.591392688585, 5074.188129899217, 5076.593872490201, 5098.286239926413, 5121.590272778178, 5191.117510023296, 4625.306204069399, 4628.997283218258, 4668.813247470106, 4767.237242041274, 4822.348982887318, 4774.212254977924, 4792.544708252728, 4822.951770482303, 4861.513848615145, 4865.195408241897, 4582.656300777422, 4637.559431853985, 4658.114958157939, 4666.510016448292, 4710.034442939206, 4684.1334353144775, 4721.433427988629, 4723.244280915072, 4735.976320118411, 4756.66703330767, 4675.064987002579, 4686.297055441677, 4688.976555117202, 4720.268358404419, 4746.762661866893, 4866.951330486685, 4923.655344125877, 4933.383327084114, 4940.530649588283, 4952.207646776498, 5398.91901621476, 5431.293931788881, 5433.293671822677, 5442.346918369782, 5449.891002179974, 5433.429489903543, 5439.156930675752, 5450.509454149145, 5457.481539253765, 5461.126219804852, 5117.437081920985, 5154.690718556823, 5193.844184674465, 5196.272521846944, 5197.948020519822, 5451.209574611738, 5473.75368108436, 5519.751611177507, 5521.4478552145265, 5522.972385138049, 5309.787608495617, 5327.920081198785, 5329.200619906967, 5331.733413329318, 5338.679679219182, 5510.559155267569, 5522.392536820947, 5587.636803607753, 5599.8880022400135, 5636.436356364331, 5549.944500554942, 5555.138953462219, 5558.305211848519, 5563.666180029211, 5569.220309156722, 5353.625246232804, 5454.263674403905, 5570.080936645408, 5577.972110139504, 5588.860278492989, 4188.476440444944, 4206.936895946563, 4210.726302790309, 4225.345071513921, 4267.1679022590915, 3840.8271627776817, 3847.9038024049064, 3848.8460461581785, 3865.2849222893856, 3886.9222615548097, 4992.90014199714, 5070.670406423571, 5143.048536020848, 5145.0, 5192.1173400522, 5429.077056900336, 5451.373092094381, 5469.206964990134, 5475.534579560782, 5523.0, 4950.775234208651, 4961.355023846877, 4965.4289756678445, 4970.453250142481, 5004.074246264453, 4602.424696912886, 4607.654425918069, 4617.492075871652, 4666.136764698542, 4697.389339385926, 5475.890482190413, 5508.0, 5522.696251706115, 5533.584981126432, 5537.833864984057, 5425.43032981547, 5430.647007944471, 5434.701091440009, 5437.157240627709, 5449.400565937823, 5407.729613519387, 5475.616706830484, 5481.040817856939, 5539.362973258127, 5568.16477528374, 5372.0, 5391.514763671288, 5393.325834270716, 5395.0, 5405.78376864921, 5479.945200548103, 5485.204645326485, 5492.642978206404, 5499.835004949858, 5552.750126244409, 5203.947960520346, 5345.732713364238, 5374.946250537445, 5375.3012108425655, 5435.619506634655, 5339.519443250126, 5351.063563876384, 5356.625036247426, 5382.407935127211, 5386.165144402624, 5155.613329000415, 5316.468353164652, 5320.414754376938, 5323.920141197807, 5336.279602253801, 5331.333583302087, 5395.379531353945, 5454.945450545602, 5462.726863656881, 5512.6692398456225, 5266.89466210666, 5293.629445938747, 5293.655912365684, 5296.126139187145, 5302.920456193083], "unit": "score", "name": "dojo.html", "value": 5048.09499095174}, {"lowerIsBetter": false, "replicates": [505.0958783777039, 509.68144909431606, 524.3786113455556, 535.1597991153885, 541.3287523470894, 28410.857945710268, 35035.0, 35816.0, 35866.64133358665, 35866.64133358672, 39237.60762392375, 39613.40579891304, 39704.80147599265, 39729.40405893914, 39767.204655906935, 8352.832943341145, 8622.439541429818, 8628.309735221199, 8637.136286371344, 8637.39538232324, 8347.207015333564, 8445.788855278606, 8488.108748581402, 8502.574871256444, 8514.659413623478, 8313.542755148464, 8373.246407823295, 8381.24568788809, 8387.119352467995, 8400.495970241775, 8448.535330556817, 8478.0, 8501.022382426037, 8507.319414446829, 8507.574621268912, 8318.37612179089, 8406.159384061606, 8468.195521425454, 8481.194286542768, 8487.533185674785, 38536.0, 38996.805015974736, 39004.41493377602, 39044.609553904666, 39052.609473905184, 3086.151308390188, 3140.0, 3159.41550813098, 3177.4121787469394, 3587.964120358789, 28747.85626071877, 29315.560266596018, 29624.555631665542, 29803.25491862699, 30711.846440767877, 3538.539989801335, 3540.822958852047, 3667.7065834733426, 3711.722858026616, 3795.9240815183816, 259344.0, 259554.0, 259857.9999999981, 260490.0, 260583.0, 53663.19505207425, 53982.0, 54015.0, 54043.45956540463, 54080.0, 53311.46688533143, 54903.450965490636, 54963.0, 54997.25013749296, 58502.70748646229, 13762.380692868845, 14177.716445671029, 14183.0, 14200.786988195185, 14203.573892783234, 9867.210623150131, 10020.749481263027, 10041.949790251001, 10054.597816087275, 10082.69751907444, 16872.831271687126, 17141.82858171427, 17910.283588656308, 18121.637567248847, 18579.535511612048, 6876.896846547305, 7067.399271062018, 7143.321384468467, 7145.785626431215, 7185.209626941032, 900.3922352412096, 965.5654955270156, 1031.4687935713114, 1041.5521325829814, 1042.7497400623795, 26481.337966550604, 26992.730072699414, 26992.865035675088, 28110.578341324897, 28774.280642984093, 1030.907218350352, 1055.4195192644015, 1059.6344261229863, 1092.2463500184847, 1161.7734541764444, 14914.254287285808, 15435.382584696486, 15461.226938653248, 15638.296276667577, 16160.75758863618, 326627.0, 332579.0, 334202.0, 335256.0, 335787.0, 51536.0, 51682.22476662853, 51725.48274517282, 51816.0, 51925.0, 1293.4179619171412, 1301.271288078679, 1307.5815738963631, 1313.1464548043657, 1314.8370929820392, 26615.733842661324, 27925.0, 28490.0, 28546.714532855236, 29070.401127938167, 41993.0, 42296.0, 42432.09055592567, 42508.574914250465, 42521.89737231552, 197476.0, 200064.0, 200262.0, 200331.0, 200351.0, 28634.284142896595, 28847.5672864903, 28931.710682892903, 29224.853875731336, 29233.0, 36126.0, 36799.816000919825, 42285.02886273383, 42709.78645106754, 46169.0, 33856.83071584626, 34080.48879266763, 34280.314393712484, 34444.65555344515, 35031.29937401289, 34356.52069681972, 34955.650443496255, 35102.824485877405, 35250.823745881105, 35344.646553534134, 30835.691643083283, 31062.534061988637, 31288.217794554406, 34069.659303406646, 36003.639963601076, 29366.265843353234, 30829.845850770602, 31146.0, 31307.373852523277, 31399.52900706537, 23071.307860764206, 23939.086899511432, 23981.400464988514, 24257.51484970326, 24442.633360499964], "unit": "score", "name": "ext.html", "value": 17431.131486201193}, {"lowerIsBetter": false, "replicates": [361.1891304022468, 361.2576155999422, 362.84216365880843, 363.18646232439335, 370.49982523593167, 13346.399412026458, 13449.036798473186, 15668.294926728297, 16509.422170224043, 17563.64872702547, 14461.276936153203, 14924.701505969873, 15210.087394756323, 15305.464308749197, 15863.206839658029, 5275.815346462875, 5450.454954504537, 5456.399796022434, 5458.972705136469, 5469.453054694519, 3962.9405558916637, 4078.9184216315657, 5368.30212072432, 5437.782488700447, 5645.15322701594, 5785.508231800281, 5984.311804142514, 6025.035994240922, 6033.064874944391, 6044.063170208603, 5934.347221805598, 5986.8503287417725, 5991.370906054867, 5993.9400605993815, 5994.220751302325, 5130.5625231095255, 5276.5251127398715, 5279.076161671731, 5328.8401347959625, 5346.117890548055, 18319.54201144969, 19181.712274315898, 19639.214431422726, 20206.0, 20351.89824050885, 1975.733276007735, 2046.7339245898088, 2324.1633012115626, 2333.941651458727, 2408.3497455687043, 10951.616693415692, 12519.687007824787, 12664.68338291541, 12695.55565555201, 13153.031417045895, 1812.9274829006824, 1846.344547685579, 1858.3031363238786, 1862.245790454868, 1903.0294549779574, 51834.48165518334, 53699.19451208235, 53879.0, 54848.45151548473, 54864.72567637136, 14120.717585648435, 14503.564893053226, 14583.416663333348, 14710.926445367704, 14755.40978360875, 23074.65388019181, 23201.651975220386, 23278.883605581865, 23412.0, 23445.7655423447, 8314.542700151549, 8325.25072743456, 8396.706115285935, 8420.368472364475, 8439.57802109892, 6926.099607051152, 6955.200151982485, 7053.541519801196, 7086.50394472382, 7110.004599356094, 7303.59830209333, 7384.298491643285, 7469.663865126083, 7549.320561149523, 7570.280823321776, 2538.59382498803, 2856.714328567168, 2888.35012122275, 2925.283305590144, 2990.596269503589, 426.75035104464234, 432.56527190173676, 441.50110375275733, 798.2735710503414, 903.7559858838208, 10019.448930308903, 10492.265541412027, 10715.46422678863, 10774.515146818412, 10786.191035672198, 453.93417954396426, 457.0310940805514, 460.3302195305822, 871.7602659268625, 909.7589138878203, 8666.696665616799, 8805.603747831363, 8810.088477172645, 9045.0, 9114.179723824887, 538647.0, 541871.0690251645, 544353.0, 548417.0, 558343.0, 68925.2768680777, 69248.0, 71960.0, 72199.63900180465, 72721.0, 998.5606333213362, 1024.262530977695, 1031.8761748590218, 1032.8140934631838, 1067.7117178361955, 13628.727425451634, 13723.725525489235, 13814.309284535531, 14472.638184045061, 14674.926625366805, 32296.192595185308, 32341.838290808395, 32586.51120233246, 32755.836220818743, 33004.50493242555, 36404.27191456103, 36539.451908220864, 38613.42079868748, 39773.204535909696, 40505.39241911432, 7088.362047415757, 7311.597862117422, 7426.0, 7440.55356678601, 7474.476786624884, 8983.505907175168, 10532.842007369742, 10600.575976961143, 10750.46247687628, 11092.33445993243, 9672.564734587102, 9674.661386851427, 9826.5086745661, 10045.246606504688, 10139.391636501834, 9404.717858464257, 9888.390737380949, 9996.350237234556, 10117.190624749855, 10153.176362510818, 9682.128608425275, 9958.107959487674, 10027.548760305657, 10056.54745536438, 10217.74455638615, 7416.332530072319, 7446.515976461513, 7462.328390444886, 7525.360344370571, 7543.170251272246, 9553.856692149484, 9815.263855210746, 10079.395236285847, 10196.184305255414, 10221.74445638865], "unit": "score", "name": "jquery.html", "value": 8321.35509474598}, {"lowerIsBetter": false, "replicates": [1262.8610852806185, 1396.2390497179038, 1402.5161319344825, 1530.9081455112694, 1740.6866763982478, 6648.667566621668, 7590.203028681992, 7623.847523049536, 7670.578118203496, 7699.461037727354, 7474.439417043716, 7503.0996280446425, 7573.621318934059, 7599.316061554459, 7626.809329766758, 1889.8582606304512, 1951.5999220159904, 2243.977560224397, 2263.7736226377397, 2267.183813827021, 2219.556088782242, 2288.4507718147606, 2294.288770481156, 2297.24191016964, 2298.9195378161767, 2255.323402979108, 2264.8414610977156, 2317.4901521665206, 2317.918872839451, 2319.860808351496, 2256.5599708056934, 2279.737830149529, 2286.2683941138844, 2293.3578597992587, 2301.3211102724736, 2253.9323820285417, 2282.189822612965, 2286.954260914789, 2293.334932869466, 2302.1482051640833, 7773.766786996399, 7779.7666070017995, 7784.143744188134, 7785.922140778576, 7796.961015194945, 4634.582887540138, 4697.530246975275, 4719.386479757643, 4740.336352910595, 4744.193487107165, 2971.138369872756, 3010.5634682971067, 3089.5056790913345, 3093.7834351595397, 3098.721115099652, 891.3092353426082, 903.0978934324659, 909.6725178935644, 923.0815338737932, 940.3981451870808, 10295.588176472933, 10374.429406382646, 10379.377237365707, 10397.428141452217, 10454.52954617044, 4110.260153172398, 4127.628513433805, 4211.0, 4217.1776503581505, 4302.9569704303185, 9232.53837308132, 9254.537273136317, 9256.444613323221, 9261.351705380559, 9282.0, 4731.668783185213, 4735.147673418749, 4767.73777442244, 4773.95226047742, 4776.283557466408, 4247.426597409372, 4316.0720445103825, 4338.284183109815, 4340.739555626673, 4365.039691267916, 3243.4323993301077, 3246.3507298540385, 3501.492283618912, 3600.6039335673054, 3601.0637234319265, 1156.640946887404, 1163.8836116388293, 1165.720227145496, 1170.8712041675408, 1177.587844254504, 1226.3439060102803, 1252.2549083295426, 1273.2106094221642, 1321.8479874814327, 1322.1670347681093, 7140.642967851587, 7215.458840586977, 7230.9638451807405, 7320.0, 7322.414206863438, 996.6611352140308, 1012.711377257478, 1065.4672663668166, 1079.3308148947547, 1086.3699054548342, 5212.582993360522, 5292.391374991848, 5297.549708274762, 5299.231611416323, 5315.069862773999, 9035.593398297093, 9167.862482062774, 9265.749123868327, 9290.349675522648, 9382.90617093834, 9274.072592740808, 9327.533623318806, 9352.532373381304, 9473.66842160521, 9542.997985211592, 6888.621125838027, 7135.714571417086, 7147.321004504668, 7304.707811687473, 7307.598082105429, 6979.953007048984, 6980.441564674916, 7003.54476958996, 7066.0, 7068.71725130989, 7724.111727151225, 7825.1783562725095, 7986.720464783704, 7987.16134805837, 8438.704645337384, 8021.218055176766, 8328.292095171979, 8397.664093436195, 8402.285805706339, 8403.873941890753, 6838.213605435439, 6869.965650171717, 6976.616286104313, 7057.576545407087, 7058.0, 6312.936870631419, 6489.253735820441, 7048.929510705032, 7259.963700181465, 7298.306660867209, 6813.148356455443, 6875.48433867472, 6883.036374907617, 7037.859242815218, 7060.858782824212, 6754.898676519954, 6839.247682754993, 6945.2707465715375, 6965.651717414008, 6992.265812089658, 7014.5440546364325, 7055.118110236221, 7056.858862822817, 7066.116735408074, 7067.6819543119655, 6236.875262494634, 6376.968115159394, 6415.133956915756, 6441.1626488556185, 6449.903251451138, 6329.398707122816, 6361.809145725636, 6364.936350636434, 6366.681665916593, 6382.6170429774365], "unit": "score", "name": "mootools.html", "value": 4410.177271489387}, {"lowerIsBetter": false, "replicates": [334.4264586234608, 341.4724251032155, 345.12510785159594, 346.5667915106117, 350.6837339373437, 5648.068068768658, 5735.598508104429, 5818.156367326746, 5865.882682346356, 5875.970620146904, 5588.077967135428, 5765.1928729977735, 5766.106253530699, 5771.740271687773, 5772.220750198722, 4456.532064133268, 4474.351219073233, 4474.910501789978, 4500.752458614775, 4503.054358584701, 4283.764392958386, 4370.409994650713, 4376.474823021226, 4474.328850672393, 4495.325701144821, 4420.97789511052, 4432.756198409086, 4436.489803672586, 4437.933430998538, 4441.666874984373, 4414.624756895668, 4419.801108950072, 4424.048829501657, 4427.203103441379, 4439.911201775979, 3939.9015024624327, 3945.585713500099, 3945.881623551298, 3946.8026598669953, 3950.604939506055, 5373.194020896858, 5509.944900550983, 5514.641548299348, 5538.861528461781, 5542.889142217133, 5129.563987061104, 5147.510986456281, 5191.143461328877, 5200.323957885488, 5204.9219261711105, 6037.667928263943, 6072.726727297282, 6081.148639190517, 6087.1173679816175, 6090.086487026937, 4364.388985542027, 4367.54140815213, 4368.366586844922, 4368.737875727466, 4382.8904277393, 5864.824055278348, 6059.66671833049, 6344.619322840645, 6348.936510634927, 6391.712372943229, 4516.119356725473, 4516.16450956574, 4517.616002639812, 4517.616002639812, 4520.208963431386, 4573.925127595013, 4578.35902973584, 4580.38164847748, 4585.403897493371, 4587.472440669299, 5184.8185313514605, 5207.984443033648, 5214.8527323988665, 5216.895662086737, 5223.52988231061, 5996.5202783777195, 6168.074788781719, 6208.906866397007, 6214.844628884223, 6234.127222188898, 1555.642202293479, 1573.6144644562155, 1574.2915687940472, 1576.7004269188817, 1577.4715470317572, 1044.639599338227, 1044.7179261599479, 1050.144132531984, 1057.0856209378985, 1063.9202059845543, 5779.942200577941, 5780.826575202751, 5782.739776709974, 5788.27646544182, 5796.072628379439, 6121.112438696364, 6198.845028874314, 6316.242050953915, 6327.746890124436, 6334.968325158345, 5715.5427565794635, 5833.154192642043, 5848.795292164839, 5888.793892213837, 5897.380775018647, 3386.356592247465, 3414.7951122932704, 3417.8120203389053, 3420.0252927915426, 3420.247545539977, 6328.177336946167, 6490.1238332825405, 6497.545171837926, 6506.479481641457, 6515.348465153446, 6537.313582073909, 6549.377809108127, 6567.277599464055, 6575.539712220098, 6576.605403675699, 6447.0, 6506.674666266667, 6515.120458738104, 6515.446187074152, 6518.761435327273, 6272.121902933502, 6367.108604795239, 6376.9043464349, 6378.394052564999, 6408.871822563616, 6332.430081292706, 6335.429811317003, 6337.7148028337915, 6344.270408903035, 6352.872942541216, 6517.478601711947, 6520.282768895512, 6525.249596296297, 6525.673716314261, 6529.7061632227615, 4405.361222622766, 4414.139242847614, 4415.381846541422, 4417.447819022622, 4432.113577284492, 6170.10533472635, 6289.119523266838, 6327.588706734047, 6374.235091789015, 6434.935650643621, 6197.597156184834, 6239.377761781879, 6244.562880598496, 6250.249970003629, 6275.497960163268, 6245.718942647501, 6253.249610046823, 6254.249490061222, 6254.405831446005, 6259.96870015647, 6022.0, 6081.6655083969035, 6100.450959413674, 6129.785457508966, 6133.509319254538, 6187.752489900354, 6203.689815509116, 6262.968685156728, 6282.748690052346, 6284.717187726655, 6108.144859719554, 6109.877802444015, 6119.755209791559, 6124.908126378197, 6125.591114043706], "unit": "score", "name": "prototype.html", "value": 4664.350645538136}, {"lowerIsBetter": false, "replicates": [826.8139668574571, 827.9172082791722, 833.3083540661255, 836.3392919593522, 856.7815207122183, 13088.280144592043, 13240.668983275411, 13415.19508829471, 13433.261170635611, 13439.865601343996, 12666.683332916682, 12728.61814145577, 12733.872661273384, 12734.808977865316, 12780.297083660394, 672.6199697171107, 680.3026897430125, 795.2246559604368, 799.5762246009609, 816.4448175240834, 792.0495405513378, 795.3716563914501, 798.9201079892023, 800.8038030682491, 802.1657476224749, 848.8641817309232, 849.3799526345771, 849.3926842307749, 849.7918010087507, 849.9405041647057, 694.3334398976988, 696.022088965005, 838.7609531283616, 852.927501162402, 853.6372041882237, 620.0389396435552, 621.1924498152429, 621.4003486635419, 621.7668374359615, 622.7758007117434, 12932.159409638343, 12987.805182922264, 13012.86987130126, 13071.281079540622, 13074.673133171747, 12009.819852702216, 12463.0, 12604.306763128025, 12753.489860405665, 13095.803562946563, 10462.110720588758, 10501.894981050169, 10539.0, 10650.201234907336, 10699.251052426333, 3543.698785603227, 3648.343298206322, 3654.0, 3692.8892133236045, 3695.6489133532273, 42442.938926526775, 42764.0, 42808.57191428077, 42979.57020429818, 43151.35272970908, 9704.466254355937, 9880.808600788016, 9927.354721943051, 10088.798224035625, 10204.897951020543, 16850.57873553171, 17485.562860928578, 17505.824941750674, 17558.736618950727, 17598.824011759974, 7375.668094935633, 7393.112826460859, 7406.259374062658, 7618.466707330434, 7647.044119485065, 4033.8991525212105, 4226.978865105716, 4251.022264879095, 4297.634701050446, 4301.806418711166, 3026.8940587079346, 3042.269855234772, 3050.740687041582, 3053.7862349635757, 3067.4171907337536, 508.30362403507434, 515.4536191636877, 518.3002946022914, 540.1789280293931, 542.0811724127566, 536.8979893820161, 622.5237693164732, 624.9906401162091, 629.8016124920636, 678.1551391910984, 8738.825223495494, 9154.86267705985, 9287.860682089775, 9474.763130921645, 9686.225101991824, 485.7037207303542, 599.2778701664483, 633.94294513494, 682.7098483144644, 699.3181647893264, 3512.84192211346, 3656.1956369598647, 3773.52830896138, 3965.2466031453932, 4460.219461594208, 53533.197002045, 53809.1928621071, 53981.0, 54610.0, 54636.72681636566, 46562.76718616385, 46994.5300546997, 47115.76442117767, 47279.527204727514, 47389.289160662614, 46408.0, 46425.303620445724, 46783.532164678596, 47079.05841883143, 47311.29033064507, 8561.871571926302, 8707.3693422235, 9114.498702571156, 9219.216366608913, 9320.860187097063, 33719.0, 33736.0, 35075.649243507236, 35250.471242930864, 35317.646823532465, 42912.570874292105, 42955.570444295154, 43643.78178109089, 43723.56276437322, 45191.548084518734, 10864.891351086388, 10867.673969780919, 11043.061339786209, 11106.944465277946, 11396.373199474108, 12016.579419720269, 12087.697807554881, 12126.0, 12418.130730848754, 12445.226100694505, 11448.484818183035, 11476.254043487146, 11476.942615286871, 11629.651110466699, 11865.940670296593, 11142.721431964266, 11147.888521114684, 11664.300141991507, 11744.823827642764, 11863.58477453285, 9921.195598097655, 10256.410256410078, 10325.0, 10352.948235258775, 11540.653780386601, 8544.40189186751, 8751.737447876574, 9079.591418386057, 9128.49793261377, 9256.629734810802, 8691.478511289342, 9565.904340956502, 9682.951585242028, 9744.17174540172, 9750.0], "unit": "score", "name": "yui.html", "value": 6182.354104546499}], "name": "dromaeo_css", "value": 6732.572379466068}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [104.0, 111.0, 111.0, 110.0, 111.0, 113.0, 113.0, 115.0, 113.0, 123.0], "unit": "score", "name": "ai-astar", "value": 112.4}, {"lowerIsBetter": true, "replicates": [149.0, 129.0, 154.0, 173.0, 129.0, 150.0, 151.0, 124.0, 171.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 145.9}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 163.0, 162.0, 166.0, 163.0, 163.0, 159.0, 162.0, 160.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 83.0, 90.0, 74.0, 72.0, 74.0, 98.0, 97.0, 74.0], "unit": "score", "name": "audio-fft", "value": 80.7}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 141.0, 95.0, 96.0, 97.0, 137.0, 97.0, 96.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 109.9}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [148.0, 145.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 98.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [56.0, 54.0, 55.0, 55.0, 57.0, 57.0, 55.0, 63.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.8}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 69.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 88.0, 88.0, 86.0, 95.0, 87.0, 94.0, 96.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.2}, {"lowerIsBetter": true, "replicates": [116.0, 118.0, 119.0, 118.0, 114.0, 115.0, 119.0, 124.0, 116.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.2}, {"lowerIsBetter": true, "replicates": [141.0, 153.0, 143.0, 151.0, 153.0, 141.0, 160.0, 153.0, 152.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.9}, {"lowerIsBetter": true, "replicates": [73.0, 70.0, 69.0, 69.0, 68.0, 68.0, 69.0, 71.0, 72.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1513.4000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.11229946524065], "unit": "score", "name": "Richards", "value": 211.24716800000004}, {"lowerIsBetter": false, "replicates": [198.01980198019803], "unit": "score", "name": "DeltaBlue", "value": 333.89590000000015}, {"lowerIsBetter": false, "replicates": [286.20492272467084], "unit": "score", "name": "Encrypt", "value": 930.036414}, {"lowerIsBetter": false, "replicates": [5273.684210526316], "unit": "score", "name": "Decrypt", "value": 50.47344311377245}, {"lowerIsBetter": false, "replicates": [1970.4724409448818], "unit": "score", "name": "RayTrace", "value": 375.5388731268733}, {"lowerIsBetter": false, "replicates": [768.0491551459294], "unit": "score", "name": "Earley", "value": 867.7348259999999}, {"lowerIsBetter": false, "replicates": [12180.722891566265], "unit": "score", "name": "Boyer", "value": 54.714568743818035}, {"lowerIsBetter": false, "replicates": [42102.04081632653], "unit": "score", "name": "RegExp", "value": 21.637549684924874}, {"lowerIsBetter": false, "replicates": [612.1580547112462], "unit": "score", "name": "Splay", "value": 133.12084905660373}, {"lowerIsBetter": false, "replicates": [4864.077669902913], "unit": "score", "name": "NavierStokes", "value": 305.0938123752493}], "name": "v8_7", "value": 18784.903529487663}]} 06:00:00 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "18784.90"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1513.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6732.57"}}} 06:00:00 INFO - Return code: 0 06:00:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:00:00 INFO - # TBPL SUCCESS # 06:00:00 INFO - Running post-action listener: _resource_record_post_action 06:00:00 INFO - Running post-run listener: _resource_record_post_run 06:00:01 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 598016; Write bytes: 374099968; Read time: 152; Write time: 269244 06:00:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 76013568; Read time: 0; Write time: 75600 06:00:01 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 598016; Write bytes: 298086400; Read time: 152; Write time: 193644 06:00:01 INFO - Running post-run listener: _upload_blobber_files 06:00:01 INFO - Blob upload gear active. 06:00:01 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:00:01 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 06:00:01 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 06:00:01 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 06:00:01 INFO - (blobuploader) - INFO - Open directory for files ... 06:00:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 06:00:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:00:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:04 INFO - (blobuploader) - INFO - Done attempting. 06:00:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:00:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:00:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:05 INFO - (blobuploader) - INFO - Done attempting. 06:00:05 INFO - (blobuploader) - INFO - Iteration through files over. 06:00:05 INFO - Return code: 0 06:00:05 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:00:05 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:00:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/743eeb4efc89ac4d47884ea0c04a2bed27f7fb6c6657453ed70b22441549e9225f91a3ffabd9ddb1ded5074e585f62b8313e205df906f96ca7723d9923352281", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98d7719fd756cb12ab7d99cce1c7b40fdf35bb359bb28576f500c9e6f26cdb89790a5f27ca8715d8fcc18c1b4677363fc2fc4bc59b6b5310f2a53ddad435ec17"} 06:00:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:00:05 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:00:05 INFO - Contents: 06:00:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/743eeb4efc89ac4d47884ea0c04a2bed27f7fb6c6657453ed70b22441549e9225f91a3ffabd9ddb1ded5074e585f62b8313e205df906f96ca7723d9923352281", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98d7719fd756cb12ab7d99cce1c7b40fdf35bb359bb28576f500c9e6f26cdb89790a5f27ca8715d8fcc18c1b4677363fc2fc4bc59b6b5310f2a53ddad435ec17"} 06:00:05 INFO - Copying logs to upload dir... 06:00:05 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1300.068393 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 40 secs) (at 2016-01-12 06:00:05.735128) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 06:00:05.740648) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452605748.118281-1908812497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/743eeb4efc89ac4d47884ea0c04a2bed27f7fb6c6657453ed70b22441549e9225f91a3ffabd9ddb1ded5074e585f62b8313e205df906f96ca7723d9923352281", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98d7719fd756cb12ab7d99cce1c7b40fdf35bb359bb28576f500c9e6f26cdb89790a5f27ca8715d8fcc18c1b4677363fc2fc4bc59b6b5310f2a53ddad435ec17"} build_url:https://queue.taskcluster.net/v1/task/eHxvEco6Rw6p6OVoN0thYA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/eHxvEco6Rw6p6OVoN0thYA/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/Firefox/sha512/743eeb4efc89ac4d47884ea0c04a2bed27f7fb6c6657453ed70b22441549e9225f91a3ffabd9ddb1ded5074e585f62b8313e205df906f96ca7723d9923352281", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98d7719fd756cb12ab7d99cce1c7b40fdf35bb359bb28576f500c9e6f26cdb89790a5f27ca8715d8fcc18c1b4677363fc2fc4bc59b6b5310f2a53ddad435ec17"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 06:00:05.767386) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 06:00:05.767803) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452605748.118281-1908812497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004383 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 06:00:05.851191) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 06:00:05.851627) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 06:00:05.851990) ========= ========= Total master_lag: 0.21 =========