builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-038 starttime: 1452059509.79 results: success (0) buildid: 20160105193035 builduid: 5d7d91b43e5b47c39abbdf2cb6ce0ccf revision: 9d6ffc7a08b6b47056eefe1e652710a3849adbf7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:49.791581) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:49.792078) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:49.792367) ========= 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=8783db0840cc980e80bb0bd400000236-1452054080.303350-1291974514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006410 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:49.816351) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:49.816673) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:49.829977) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:49.830243) ========= 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=8783db0840cc980e80bb0bd400000236-1452054080.303350-1291974514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:49.879264) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:49.879539) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:49.879895) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:49.880178) ========= 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=8783db0840cc980e80bb0bd400000236-1452054080.303350-1291974514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-05 21:51:50-- 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% 73.5M=0s 2016-01-05 21:51:50 (73.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170207 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:50.072632) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:50.072907) ========= 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=8783db0840cc980e80bb0bd400000236-1452054080.303350-1291974514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016427 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:50.148008) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:50.148321) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9d6ffc7a08b6b47056eefe1e652710a3849adbf7 --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 9d6ffc7a08b6b47056eefe1e652710a3849adbf7 --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=8783db0840cc980e80bb0bd400000236-1452054080.303350-1291974514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-05 21:51:50,590 truncating revision to first 12 chars 2016-01-05 21:51:50,590 Setting DEBUG logging. 2016-01-05 21:51:50,590 attempt 1/10 2016-01-05 21:51:50,590 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9d6ffc7a08b6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-05 21:51:51,221 unpacking tar archive at: mozilla-central-9d6ffc7a08b6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.945645 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:51.110621) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:51.110903) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:51.121869) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:51.122184) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:51.122639) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 50 secs) (at 2016-01-05 21:51:51.122917) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=8783db0840cc980e80bb0bd400000236-1452054080.303350-1291974514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:51:51 INFO - MultiFileLogger online at 20160105 21:51:51 in /builds/slave/test-pgo 21:51:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:51:51 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:51:51 INFO - {'append_to_log': False, 21:51:51 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:51:51 INFO - 'blob_upload_branch': 'Firefox', 21:51:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:51:51 INFO - 'branch': 'Firefox', 21:51:51 INFO - 'buildbot_json_path': 'buildprops.json', 21:51:51 INFO - 'config_files': ('talos/linux_config.py',), 21:51:51 INFO - 'default_actions': ('clobber', 21:51:51 INFO - 'read-buildbot-config', 21:51:51 INFO - 'download-and-extract', 21:51:51 INFO - 'populate-webroot', 21:51:51 INFO - 'create-virtualenv', 21:51:51 INFO - 'install', 21:51:51 INFO - 'run-tests'), 21:51:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:51:51 INFO - 'download_minidump_stackwalk': True, 21:51:51 INFO - 'download_symbols': 'ondemand', 21:51:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:51:51 INFO - 'tooltool.py': '/tools/tooltool.py', 21:51:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:51:51 INFO - '/tools/misc-python/virtualenv.py')}, 21:51:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:51:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:51:51 INFO - 'installer_path': 'installer.exe', 21:51:51 INFO - 'log_level': 'info', 21:51:51 INFO - 'log_name': 'talos', 21:51:51 INFO - 'log_to_console': True, 21:51:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:51:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:51:51 INFO - 'opt_config_files': (), 21:51:51 INFO - 'pip_index': False, 21:51:51 INFO - 'sps_profile': False, 21:51:51 INFO - 'sps_profile_interval': 0, 21:51:51 INFO - 'suite': 'dromaeojs-e10s', 21:51:51 INFO - 'system_bits': '32', 21:51:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:51:51 INFO - 'title': 'talos-linux64-ix-038', 21:51:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:51:51 INFO - 'use_talos_json': True, 21:51:51 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:51:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:51:51 INFO - 'work_dir': 'build'} 21:51:51 INFO - ##### 21:51:51 INFO - ##### Running clobber step. 21:51:51 INFO - ##### 21:51:51 INFO - Running pre-action listener: _resource_record_pre_action 21:51:51 INFO - Running main action method: clobber 21:51:51 INFO - rmtree: /builds/slave/test-pgo/build 21:51:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:51:52 INFO - Running post-action listener: _resource_record_post_action 21:51:52 INFO - ##### 21:51:52 INFO - ##### Running read-buildbot-config step. 21:51:52 INFO - ##### 21:51:52 INFO - Running pre-action listener: _resource_record_pre_action 21:51:52 INFO - Running main action method: read_buildbot_config 21:51:52 INFO - Using buildbot properties: 21:51:52 INFO - { 21:51:52 INFO - "project": "", 21:51:52 INFO - "product": "firefox", 21:51:52 INFO - "script_repo_revision": "production", 21:51:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 21:51:52 INFO - "repository": "", 21:51:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 21:51:52 INFO - "buildid": "20160105193035", 21:51:52 INFO - "pgo_build": "True", 21:51:52 INFO - "basedir": "/builds/slave/test-pgo", 21:51:52 INFO - "buildnumber": 67, 21:51:52 INFO - "slavename": "talos-linux64-ix-038", 21:51:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:51:52 INFO - "platform": "ubuntu64_hw", 21:51:52 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 21:51:52 INFO - "branch": "mozilla-central", 21:51:52 INFO - "repo_path": "mozilla-central", 21:51:52 INFO - "revision": "9d6ffc7a08b6b47056eefe1e652710a3849adbf7", 21:51:52 INFO - "stage_platform": "linux64-pgo", 21:51:52 INFO - "builduid": "5d7d91b43e5b47c39abbdf2cb6ce0ccf", 21:51:52 INFO - "slavebuilddir": "test" 21:51:52 INFO - } 21:51:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 21:51:52 INFO - Running post-action listener: _resource_record_post_action 21:51:52 INFO - ##### 21:51:52 INFO - ##### Running download-and-extract step. 21:51:52 INFO - ##### 21:51:52 INFO - Running pre-action listener: _resource_record_pre_action 21:51:52 INFO - Running main action method: download_and_extract 21:51:52 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:51:52 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')]} 21:51:52 INFO - https://queue.taskcluster.net/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:51:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/test_packages.json 21:51:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/test_packages.json 21:51:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:51:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:52:05 INFO - Downloaded 1302 bytes. 21:52:05 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:52:05 INFO - Using the following test package requirements: 21:52:05 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:52:05 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:52:05 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:52:05 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:52:05 INFO - u'jsshell-linux-x86_64.zip'], 21:52:05 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:52:05 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:52:05 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:52:05 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:52:05 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:52:05 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:52:05 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:52:05 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:52:05 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:52:05 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:52:05 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:52:05 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:52:05 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:05 INFO - https://queue.taskcluster.net/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:52:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:52:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:52:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/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 21:52:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/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 21:52:08 INFO - Downloaded 24054382 bytes. 21:52:08 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 21:52:08 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:52:08 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 21:52:09 INFO - Return code: 0 21:52:09 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 21:52: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')]} 21:52:09 INFO - https://queue.taskcluster.net/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:52:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:52:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:52:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/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 21:52:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/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 21:52:11 INFO - Downloaded 24054382 bytes. 21:52:11 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 21:52:11 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:52:11 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 21:52:12 INFO - Return code: 0 21:52: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')]} 21:52:12 INFO - https://queue.taskcluster.net/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:52:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:52:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:52:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/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 21:52:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/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 21:52:13 INFO - Downloaded 11132285 bytes. 21:52:13 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 21:52:13 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:52:13 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 21:52:13 INFO - Return code: 0 21:52:13 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')]} 21:52:13 INFO - https://queue.taskcluster.net/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:52:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:52:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:52:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/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 21:52:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/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 21:52:15 INFO - Downloaded 55062623 bytes. 21:52:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:52:15 INFO - mkdir: /builds/slave/test-pgo/properties 21:52:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:52:15 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:52:15 INFO - Contents: 21:52:15 INFO - build_url:https://queue.taskcluster.net/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:52:15 INFO - Running post-action listener: _resource_record_post_action 21:52:15 INFO - Running post-action listener: set_extra_try_arguments 21:52:15 INFO - ##### 21:52:15 INFO - ##### Running populate-webroot step. 21:52:15 INFO - ##### 21:52:15 INFO - Running pre-action listener: _resource_record_pre_action 21:52:15 INFO - Running main action method: populate_webroot 21:52:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:52:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:52:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:52:15 INFO - '--tppagecycles', 21:52:15 INFO - '7'], 21:52:15 INFO - 'tests': ['tsvgm']}}, 21:52:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:52:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:52:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:52:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:52:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:52:15 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:52:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:52:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:15 INFO - 'talos_options': ['--e10s'], 21:52:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:52:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:15 INFO - 'tests': ['damp', 'tps']}, 21:52:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:15 INFO - 'talos_options': ['--e10s'], 21:52:15 INFO - 'tests': ['damp', 'tps']}, 21:52:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:52:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:52:15 INFO - 'other': {'tests': ['a11yr', 21:52:15 INFO - 'ts_paint', 21:52:15 INFO - 'tpaint', 21:52:15 INFO - 'sessionrestore', 21:52:15 INFO - 'sessionrestore_no_auto_restore']}, 21:52:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:52:15 INFO - 'tests': ['a11yr', 21:52:15 INFO - 'ts_paint', 21:52:15 INFO - 'tpaint', 21:52:15 INFO - 'sessionrestore', 21:52:15 INFO - 'sessionrestore_no_auto_restore']}, 21:52:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:52:15 INFO - 'tests': ['a11yr', 21:52:15 INFO - 'ts_paint', 21:52:15 INFO - 'tpaint', 21:52:15 INFO - 'sessionrestore', 21:52:15 INFO - 'sessionrestore_no_auto_restore']}, 21:52:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:52:15 INFO - 'tests': ['a11yr', 21:52:15 INFO - 'ts_paint', 21:52:15 INFO - 'tpaint', 21:52:15 INFO - 'sessionrestore', 21:52:15 INFO - 'sessionrestore_no_auto_restore']}, 21:52:15 INFO - 'other_l64': {'tests': ['a11yr', 21:52:15 INFO - 'ts_paint', 21:52:15 INFO - 'tpaint', 21:52:15 INFO - 'sessionrestore', 21:52:15 INFO - 'sessionrestore_no_auto_restore']}, 21:52:15 INFO - 'other_nol64': {'tests': ['a11yr', 21:52:15 INFO - 'ts_paint', 21:52:15 INFO - 'tpaint', 21:52:15 INFO - 'sessionrestore', 21:52:15 INFO - 'sessionrestore_no_auto_restore']}, 21:52:15 INFO - 'svgr': {'tests': ['tsvgx', 21:52:15 INFO - 'tsvgr_opacity', 21:52:15 INFO - 'tart', 21:52:15 INFO - 'tscrollx', 21:52:15 INFO - 'cart']}, 21:52:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:52:15 INFO - 'tests': ['tsvgx', 21:52:15 INFO - 'tsvgr_opacity', 21:52:15 INFO - 'tart', 21:52:15 INFO - 'tscrollx', 21:52:15 INFO - 'cart']}, 21:52:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:15 INFO - 'tests': ['tp5o']}, 21:52:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:15 INFO - 'talos_options': ['--e10s'], 21:52:15 INFO - 'tests': ['tp5o']}, 21:52:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:15 INFO - 'talos_options': ['--xperf_path', 21:52:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:52:15 INFO - 'tests': ['tp5n']}, 21:52:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:15 INFO - 'talos_options': ['--e10s', 21:52:15 INFO - '--xperf_path', 21:52:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:52:15 INFO - 'tests': ['tp5n']}}, 21:52:15 INFO - 'talos.zip': {'path': '', 21:52:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:52:15 INFO - Running post-action listener: _resource_record_post_action 21:52:15 INFO - ##### 21:52:15 INFO - ##### Running create-virtualenv step. 21:52:15 INFO - ##### 21:52:15 INFO - Running pre-action listener: _resource_record_pre_action 21:52:15 INFO - Running main action method: create_virtualenv 21:52:15 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:52:15 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 21:52:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:52:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:52:15 INFO - Using real prefix '/usr' 21:52:15 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:52:15 INFO - Installing distribute.............................................................................................................................................................................................done. 21:52:17 INFO - Installing pip.................done. 21:52:17 INFO - Return code: 0 21:52:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:17 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 0x7fd490e5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1057630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8840>, '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 0x10556b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055b60>, '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': '8783db0840cc980e80bb0bd400000236-1452054080.303350-1291974514', '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 21:52:17 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 21:52:17 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 21:52:17 INFO - Using env: {'DISPLAY': ':0', 21:52:17 INFO - 'HOME': '/home/cltbld', 21:52:17 INFO - 'LANG': 'en_US.UTF-8', 21:52:17 INFO - 'LANGUAGE': 'en_US:en', 21:52:17 INFO - 'LOGNAME': 'cltbld', 21:52:17 INFO - 'MAIL': '/var/mail/cltbld', 21:52:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:17 INFO - 'MOZ_NO_REMOTE': '1', 21:52:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:17 INFO - 'NO_EM_RESTART': '1', 21:52:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:52:17 INFO - 'PWD': '/builds/slave/test-pgo', 21:52:17 INFO - 'SHELL': '/bin/bash', 21:52:17 INFO - 'SHLVL': '1', 21:52:17 INFO - 'TERM': 'linux', 21:52:17 INFO - 'TMOUT': '86400', 21:52:17 INFO - 'USER': 'cltbld', 21:52:17 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452054080.303350-1291974514', 21:52:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:17 INFO - '_': '/tools/buildbot/bin/python'} 21:52:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:17 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 21:52:17 INFO - Cleaning up... 21:52:18 INFO - Return code: 0 21:52:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:18 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 0x7fd490e5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1057630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8840>, '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 0x10556b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055b60>, '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': '8783db0840cc980e80bb0bd400000236-1452054080.303350-1291974514', '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 21:52:18 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 21:52:18 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 21:52:18 INFO - Using env: {'DISPLAY': ':0', 21:52:18 INFO - 'HOME': '/home/cltbld', 21:52:18 INFO - 'LANG': 'en_US.UTF-8', 21:52:18 INFO - 'LANGUAGE': 'en_US:en', 21:52:18 INFO - 'LOGNAME': 'cltbld', 21:52:18 INFO - 'MAIL': '/var/mail/cltbld', 21:52:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:18 INFO - 'MOZ_NO_REMOTE': '1', 21:52:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:18 INFO - 'NO_EM_RESTART': '1', 21:52:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:52:18 INFO - 'PWD': '/builds/slave/test-pgo', 21:52:18 INFO - 'SHELL': '/bin/bash', 21:52:18 INFO - 'SHLVL': '1', 21:52:18 INFO - 'TERM': 'linux', 21:52:18 INFO - 'TMOUT': '86400', 21:52:18 INFO - 'USER': 'cltbld', 21:52:18 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452054080.303350-1291974514', 21:52:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:18 INFO - '_': '/tools/buildbot/bin/python'} 21:52:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:18 INFO - Downloading/unpacking psutil>=0.7.1 21:52:18 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 21:52:18 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 21:52:18 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 21:52:18 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 21:52:18 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 21:52:18 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 21:52:19 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:52:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:52:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:52:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:52:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:52:20 INFO - Installing collected packages: psutil 21:52:20 INFO - Running setup.py install for psutil 21:52:20 INFO - building 'psutil._psutil_linux' extension 21:52:20 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 21:52:20 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 21:52:20 INFO - building 'psutil._psutil_posix' extension 21:52:20 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 21:52:20 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 21:52:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:52:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:52:20 INFO - Successfully installed psutil 21:52:20 INFO - Cleaning up... 21:52:20 INFO - Return code: 0 21:52:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:52:20 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')]} 21:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:20 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')]} 21:52:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:20 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 0x7fd490e5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1057630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8840>, '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 0x10556b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055b60>, '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': '8783db0840cc980e80bb0bd400000236-1452054080.303350-1291974514', '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 21:52:20 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 21:52:20 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 21:52:20 INFO - Using env: {'DISPLAY': ':0', 21:52:20 INFO - 'HOME': '/home/cltbld', 21:52:20 INFO - 'LANG': 'en_US.UTF-8', 21:52:20 INFO - 'LANGUAGE': 'en_US:en', 21:52:20 INFO - 'LOGNAME': 'cltbld', 21:52:20 INFO - 'MAIL': '/var/mail/cltbld', 21:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:20 INFO - 'MOZ_NO_REMOTE': '1', 21:52:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:20 INFO - 'NO_EM_RESTART': '1', 21:52:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:52:20 INFO - 'PWD': '/builds/slave/test-pgo', 21:52:20 INFO - 'SHELL': '/bin/bash', 21:52:20 INFO - 'SHLVL': '1', 21:52:20 INFO - 'TERM': 'linux', 21:52:20 INFO - 'TMOUT': '86400', 21:52:20 INFO - 'USER': 'cltbld', 21:52:20 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452054080.303350-1291974514', 21:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:20 INFO - '_': '/tools/buildbot/bin/python'} 21:52:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:52:20 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 21:52:20 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 21:52:20 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 21:52:20 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 21:52:20 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 21:52:20 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 21:52:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:52:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:52:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:52:22 INFO - Installing collected packages: mozsystemmonitor 21:52:22 INFO - Running setup.py install for mozsystemmonitor 21:52:22 INFO - Successfully installed mozsystemmonitor 21:52:22 INFO - Cleaning up... 21:52:22 INFO - Return code: 0 21:52:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:52:22 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')]} 21:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:22 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')]} 21:52:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:22 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 0x7fd490e5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1057630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8840>, '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 0x10556b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055b60>, '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': '8783db0840cc980e80bb0bd400000236-1452054080.303350-1291974514', '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 21:52:22 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 21:52:22 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 21:52:22 INFO - Using env: {'DISPLAY': ':0', 21:52:22 INFO - 'HOME': '/home/cltbld', 21:52:22 INFO - 'LANG': 'en_US.UTF-8', 21:52:22 INFO - 'LANGUAGE': 'en_US:en', 21:52:22 INFO - 'LOGNAME': 'cltbld', 21:52:22 INFO - 'MAIL': '/var/mail/cltbld', 21:52:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:22 INFO - 'MOZ_NO_REMOTE': '1', 21:52:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:22 INFO - 'NO_EM_RESTART': '1', 21:52:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:52:22 INFO - 'PWD': '/builds/slave/test-pgo', 21:52:22 INFO - 'SHELL': '/bin/bash', 21:52:22 INFO - 'SHLVL': '1', 21:52:22 INFO - 'TERM': 'linux', 21:52:22 INFO - 'TMOUT': '86400', 21:52:22 INFO - 'USER': 'cltbld', 21:52:22 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452054080.303350-1291974514', 21:52:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:22 INFO - '_': '/tools/buildbot/bin/python'} 21:52:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:22 INFO - Downloading/unpacking blobuploader==1.2.4 21:52: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 21:52: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 21:52: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 21:52: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 21:52: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 21:52: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 21:52:24 INFO - Downloading blobuploader-1.2.4.tar.gz 21:52:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:52:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:52:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:52:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:52:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:52: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 21:52: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 21:52: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 21:52: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 21:52: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 21:52: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 21:52:25 INFO - Downloading docopt-0.6.1.tar.gz 21:52:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:52:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:52:25 INFO - Installing collected packages: blobuploader, requests, docopt 21:52:25 INFO - Running setup.py install for blobuploader 21:52:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:52:25 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:52:25 INFO - Running setup.py install for requests 21:52:25 INFO - Running setup.py install for docopt 21:52:25 INFO - Successfully installed blobuploader requests docopt 21:52:25 INFO - Cleaning up... 21:52:26 INFO - Return code: 0 21:52:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:52: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')]} 21:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52: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')]} 21:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:26 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 0x7fd490e5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1057630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8840>, '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 0x10556b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055b60>, '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': '8783db0840cc980e80bb0bd400000236-1452054080.303350-1291974514', '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 21:52:26 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 21:52:26 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 21:52:26 INFO - Using env: {'DISPLAY': ':0', 21:52:26 INFO - 'HOME': '/home/cltbld', 21:52:26 INFO - 'LANG': 'en_US.UTF-8', 21:52:26 INFO - 'LANGUAGE': 'en_US:en', 21:52:26 INFO - 'LOGNAME': 'cltbld', 21:52:26 INFO - 'MAIL': '/var/mail/cltbld', 21:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:26 INFO - 'MOZ_NO_REMOTE': '1', 21:52:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:26 INFO - 'NO_EM_RESTART': '1', 21:52:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:52:26 INFO - 'PWD': '/builds/slave/test-pgo', 21:52:26 INFO - 'SHELL': '/bin/bash', 21:52:26 INFO - 'SHLVL': '1', 21:52:26 INFO - 'TERM': 'linux', 21:52:26 INFO - 'TMOUT': '86400', 21:52:26 INFO - 'USER': 'cltbld', 21:52:26 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452054080.303350-1291974514', 21:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:26 INFO - '_': '/tools/buildbot/bin/python'} 21:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:52:26 INFO - Running setup.py (path:/tmp/pip-dknwtT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:52:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:52:26 INFO - Running setup.py (path:/tmp/pip-Q6M68H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:52:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:52:26 INFO - Running setup.py (path:/tmp/pip-CiMAHZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:52:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:52:26 INFO - Running setup.py (path:/tmp/pip-WiznDs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:52:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:52:26 INFO - Running setup.py (path:/tmp/pip-005QpY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:52:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:52:26 INFO - Running setup.py (path:/tmp/pip-4i2w7d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:52:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:52:26 INFO - Running setup.py (path:/tmp/pip-q0X1Kf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:52:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:52:26 INFO - Running setup.py (path:/tmp/pip-qZzDhJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:52:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:52:26 INFO - Running setup.py (path:/tmp/pip-Rj0rGJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:52:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:52:26 INFO - Running setup.py (path:/tmp/pip-4wKqHC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:52:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:52:26 INFO - Running setup.py (path:/tmp/pip-r2LKxM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:52:27 INFO - Running setup.py (path:/tmp/pip-mH9MbK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:52:27 INFO - Running setup.py (path:/tmp/pip-1QNyew-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:52:27 INFO - Running setup.py (path:/tmp/pip-YfIF3O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:52:27 INFO - Running setup.py (path:/tmp/pip-Pd0cyt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:52:27 INFO - Running setup.py (path:/tmp/pip-jlw9en-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:52:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:52:27 INFO - Running setup.py (path:/tmp/pip-wCfdhh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:52:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:52:27 INFO - Running setup.py install for manifestparser 21:52:27 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:52:27 INFO - Running setup.py install for mozcrash 21:52:27 INFO - Running setup.py install for mozdebug 21:52:27 INFO - Running setup.py install for mozdevice 21:52:27 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:52:27 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:52:27 INFO - Running setup.py install for mozfile 21:52:27 INFO - Running setup.py install for mozhttpd 21:52:28 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:52:28 INFO - Running setup.py install for mozinfo 21:52:28 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:52:28 INFO - Running setup.py install for mozInstall 21:52:28 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:52:28 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:52:28 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:52:28 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:52:28 INFO - Running setup.py install for mozleak 21:52:28 INFO - Running setup.py install for mozlog 21:52:28 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:52:28 INFO - Running setup.py install for moznetwork 21:52:28 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:52:28 INFO - Running setup.py install for mozprocess 21:52:28 INFO - Running setup.py install for mozprofile 21:52:28 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:52:28 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:52:28 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:52:28 INFO - Running setup.py install for mozrunner 21:52:28 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:52:28 INFO - Running setup.py install for mozscreenshot 21:52:29 INFO - Running setup.py install for moztest 21:52:29 INFO - Running setup.py install for mozversion 21:52:29 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:52:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:52:29 INFO - Cleaning up... 21:52:29 INFO - Return code: 0 21:52:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:29 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 0x7fd490e5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1057630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8840>, '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 0x10556b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055b60>, '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': '8783db0840cc980e80bb0bd400000236-1452054080.303350-1291974514', '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 21:52:29 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 21:52:29 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 21:52:29 INFO - Using env: {'DISPLAY': ':0', 21:52:29 INFO - 'HOME': '/home/cltbld', 21:52:29 INFO - 'LANG': 'en_US.UTF-8', 21:52:29 INFO - 'LANGUAGE': 'en_US:en', 21:52:29 INFO - 'LOGNAME': 'cltbld', 21:52:29 INFO - 'MAIL': '/var/mail/cltbld', 21:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:29 INFO - 'MOZ_NO_REMOTE': '1', 21:52:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:29 INFO - 'NO_EM_RESTART': '1', 21:52:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:52:29 INFO - 'PWD': '/builds/slave/test-pgo', 21:52:29 INFO - 'SHELL': '/bin/bash', 21:52:29 INFO - 'SHLVL': '1', 21:52:29 INFO - 'TERM': 'linux', 21:52:29 INFO - 'TMOUT': '86400', 21:52:29 INFO - 'USER': 'cltbld', 21:52:29 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452054080.303350-1291974514', 21:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:29 INFO - '_': '/tools/buildbot/bin/python'} 21:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:52:29 INFO - Running setup.py (path:/tmp/pip-DYuhuP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:52:29 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)) 21:52:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:52:29 INFO - Running setup.py (path:/tmp/pip-v2tq_P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:52:29 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)) 21:52:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:52:29 INFO - Running setup.py (path:/tmp/pip-mjbu2Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:52:29 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)) 21:52:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:52:29 INFO - Running setup.py (path:/tmp/pip-SHqMcA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:52:29 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)) 21:52:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:52:29 INFO - Running setup.py (path:/tmp/pip-jnJFGD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:52:29 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)) 21:52:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:52:29 INFO - Running setup.py (path:/tmp/pip-YeUdpj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:52:29 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)) 21:52:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:52:29 INFO - Running setup.py (path:/tmp/pip-QjmSAw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:52:29 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)) 21:52:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:52:29 INFO - Running setup.py (path:/tmp/pip-pCtpni-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:52:30 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)) 21:52:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:52:30 INFO - Running setup.py (path:/tmp/pip-4ATSvo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:52:30 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)) 21:52:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:52:30 INFO - Running setup.py (path:/tmp/pip-PY0BPL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:52:30 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)) 21:52:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:52:30 INFO - Running setup.py (path:/tmp/pip-YCmnoi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:52:30 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)) 21:52:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:52:30 INFO - Running setup.py (path:/tmp/pip-J_IKse-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:52:30 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)) 21:52:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:52:30 INFO - Running setup.py (path:/tmp/pip-y_uv_o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:52:30 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)) 21:52:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:52:30 INFO - Running setup.py (path:/tmp/pip-s76rQJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:52:30 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)) 21:52:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:52:30 INFO - Running setup.py (path:/tmp/pip-Q2rSlr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:52:30 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)) 21:52:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:52:30 INFO - Running setup.py (path:/tmp/pip-wm8SWQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:52:30 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)) 21:52:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:52:30 INFO - Running setup.py (path:/tmp/pip-n5FIVh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:52:30 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)) 21:52:30 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)) 21:52:30 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)) 21:52:30 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)) 21:52:30 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)) 21:52:30 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)) 21:52:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:32 INFO - Downloading blessings-1.5.1.tar.gz 21:52:32 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 21:52:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:52:32 INFO - Installing collected packages: blessings 21:52:32 INFO - Running setup.py install for blessings 21:52:32 INFO - Successfully installed blessings 21:52:32 INFO - Cleaning up... 21:52:32 INFO - Return code: 0 21:52:32 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:52:32 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:52:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:52:32 INFO - Reading from file tmpfile_stdout 21:52:32 INFO - Current package versions: 21:52:32 INFO - argparse == 1.2.1 21:52:32 INFO - blessings == 1.5.1 21:52:32 INFO - blobuploader == 1.2.4 21:52:32 INFO - docopt == 0.6.1 21:52:32 INFO - manifestparser == 1.1 21:52:32 INFO - mozInstall == 1.12 21:52:32 INFO - mozcrash == 0.16 21:52:32 INFO - mozdebug == 0.1 21:52:32 INFO - mozdevice == 0.47 21:52:32 INFO - mozfile == 1.2 21:52:32 INFO - mozhttpd == 0.7 21:52:32 INFO - mozinfo == 0.9 21:52:32 INFO - mozleak == 0.1 21:52:32 INFO - mozlog == 3.1 21:52:32 INFO - moznetwork == 0.27 21:52:32 INFO - mozprocess == 0.22 21:52:32 INFO - mozprofile == 0.28 21:52:32 INFO - mozrunner == 6.11 21:52:32 INFO - mozscreenshot == 0.1 21:52:32 INFO - mozsystemmonitor == 0.0 21:52:32 INFO - moztest == 0.7 21:52:32 INFO - mozversion == 1.4 21:52:32 INFO - psutil == 3.1.1 21:52:32 INFO - requests == 1.2.3 21:52:32 INFO - wsgiref == 0.1.2 21:52:32 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:32 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 0x7fd490e5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1057630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8840>, '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 0x10556b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055b60>, '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': '8783db0840cc980e80bb0bd400000236-1452054080.303350-1291974514', '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 21:52:32 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 21:52:32 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 21:52:32 INFO - Using env: {'DISPLAY': ':0', 21:52:32 INFO - 'HOME': '/home/cltbld', 21:52:32 INFO - 'LANG': 'en_US.UTF-8', 21:52:32 INFO - 'LANGUAGE': 'en_US:en', 21:52:32 INFO - 'LOGNAME': 'cltbld', 21:52:32 INFO - 'MAIL': '/var/mail/cltbld', 21:52:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:32 INFO - 'MOZ_NO_REMOTE': '1', 21:52:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:32 INFO - 'NO_EM_RESTART': '1', 21:52:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:52:32 INFO - 'PWD': '/builds/slave/test-pgo', 21:52:32 INFO - 'SHELL': '/bin/bash', 21:52:32 INFO - 'SHLVL': '1', 21:52:32 INFO - 'TERM': 'linux', 21:52:32 INFO - 'TMOUT': '86400', 21:52:32 INFO - 'USER': 'cltbld', 21:52:32 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452054080.303350-1291974514', 21:52:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:32 INFO - '_': '/tools/buildbot/bin/python'} 21:52:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:33 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)) 21:52:33 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)) 21:52:33 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)) 21:52:33 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)) 21:52:33 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)) 21:52:33 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)) 21:52:33 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)) 21:52:33 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)) 21:52:33 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)) 21:52:33 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)) 21:52:33 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)) 21:52:33 INFO - Cleaning up... 21:52:33 INFO - Return code: 0 21:52:33 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 21:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:33 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 0x7fd490e5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1057630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8840>, '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 0x10556b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055b60>, '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': '8783db0840cc980e80bb0bd400000236-1452054080.303350-1291974514', '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 21:52:33 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 21:52:33 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 21:52:33 INFO - Using env: {'DISPLAY': ':0', 21:52:33 INFO - 'HOME': '/home/cltbld', 21:52:33 INFO - 'LANG': 'en_US.UTF-8', 21:52:33 INFO - 'LANGUAGE': 'en_US:en', 21:52:33 INFO - 'LOGNAME': 'cltbld', 21:52:33 INFO - 'MAIL': '/var/mail/cltbld', 21:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:33 INFO - 'MOZ_NO_REMOTE': '1', 21:52:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:33 INFO - 'NO_EM_RESTART': '1', 21:52:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:52:33 INFO - 'PWD': '/builds/slave/test-pgo', 21:52:33 INFO - 'SHELL': '/bin/bash', 21:52:33 INFO - 'SHLVL': '1', 21:52:33 INFO - 'TERM': 'linux', 21:52:33 INFO - 'TMOUT': '86400', 21:52:33 INFO - 'USER': 'cltbld', 21:52:33 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452054080.303350-1291974514', 21:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:33 INFO - '_': '/tools/buildbot/bin/python'} 21:52:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:33 INFO - Downloading/unpacking jsonschema 21:52:33 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 21:52:33 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 21:52:33 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 21:52:33 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 21:52:33 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 21:52:33 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 21:52:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:52:34 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 21:52:34 INFO - Downloading/unpacking functools32 (from jsonschema) 21:52:34 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 21:52:34 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 21:52:34 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 21:52:34 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 21:52:34 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 21:52:34 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 21:52:35 INFO - Downloading functools32-3.2.3-2.tar.gz 21:52:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 21:52:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 21:52:35 INFO - warning: no files found matching '*.txt' 21:52:35 INFO - no previously-included directories found matching 'build' 21:52:35 INFO - no previously-included directories found matching 'dist' 21:52:35 INFO - no previously-included directories found matching '.git*' 21:52:35 INFO - Installing collected packages: jsonschema, functools32 21:52:35 INFO - Running setup.py install for functools32 21:52:35 INFO - warning: no files found matching '*.txt' 21:52:35 INFO - no previously-included directories found matching 'build' 21:52:35 INFO - no previously-included directories found matching 'dist' 21:52:35 INFO - no previously-included directories found matching '.git*' 21:52:35 INFO - Successfully installed jsonschema functools32 21:52:35 INFO - Cleaning up... 21:52:35 INFO - Return code: 0 21:52:35 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 21:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:35 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 0x7fd490e5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1057630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8840>, '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 0x10556b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055b60>, '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': '8783db0840cc980e80bb0bd400000236-1452054080.303350-1291974514', '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 21:52:35 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 21:52:35 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 21:52:35 INFO - Using env: {'DISPLAY': ':0', 21:52:35 INFO - 'HOME': '/home/cltbld', 21:52:35 INFO - 'LANG': 'en_US.UTF-8', 21:52:35 INFO - 'LANGUAGE': 'en_US:en', 21:52:35 INFO - 'LOGNAME': 'cltbld', 21:52:35 INFO - 'MAIL': '/var/mail/cltbld', 21:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:35 INFO - 'MOZ_NO_REMOTE': '1', 21:52:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:35 INFO - 'NO_EM_RESTART': '1', 21:52:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:52:35 INFO - 'PWD': '/builds/slave/test-pgo', 21:52:35 INFO - 'SHELL': '/bin/bash', 21:52:35 INFO - 'SHLVL': '1', 21:52:35 INFO - 'TERM': 'linux', 21:52:35 INFO - 'TMOUT': '86400', 21:52:35 INFO - 'USER': 'cltbld', 21:52:35 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452054080.303350-1291974514', 21:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:35 INFO - '_': '/tools/buildbot/bin/python'} 21:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:35 INFO - Downloading/unpacking flake8 21:52:35 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 21:52:35 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 21:52:35 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 21:52:35 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 21:52:35 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 21:52:35 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 21:52:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:52:37 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 21:52:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:52:37 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 21:52:37 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 21:52:37 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 21:52:37 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 21:52:37 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 21:52:37 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 21:52:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:52:37 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 21:52:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:52:37 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 21:52:37 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 21:52:37 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 21:52:37 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 21:52:37 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 21:52:37 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 21:52:37 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 21:52:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:52:37 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 21:52:37 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 21:52:37 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 21:52:37 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 21:52:37 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 21:52:37 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 21:52:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 21:52:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 21:52:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:52:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:52:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:52:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:52:37 INFO - no previously-included directories found matching 'docs/_build' 21:52:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:52:37 INFO - Running setup.py install for pep8 21:52:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:52:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:52:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:52:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:52:38 INFO - no previously-included directories found matching 'docs/_build' 21:52:38 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 21:52:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:52:38 INFO - Cleaning up... 21:52:38 INFO - Return code: 0 21:52:38 INFO - Running post-action listener: _resource_record_post_action 21:52:38 INFO - Running post-action listener: _start_resource_monitoring 21:52:38 INFO - Starting resource monitoring. 21:52:38 INFO - ##### 21:52:38 INFO - ##### Running install step. 21:52:38 INFO - ##### 21:52:38 INFO - Running pre-action listener: _resource_record_pre_action 21:52:38 INFO - Running main action method: install 21:52:38 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:52:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:52:38 INFO - Reading from file tmpfile_stdout 21:52:38 INFO - Detecting whether we're running mozinstall >=1.0... 21:52:38 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:52:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:52:38 INFO - Reading from file tmpfile_stdout 21:52:38 INFO - Output received: 21:52:38 INFO - Usage: mozinstall [options] installer 21:52:38 INFO - Options: 21:52:38 INFO - -h, --help show this help message and exit 21:52:38 INFO - -d DEST, --destination=DEST 21:52:38 INFO - Directory to install application into. [default: 21:52:38 INFO - "/builds/slave/test-pgo"] 21:52:38 INFO - --app=APP Application being installed. [default: firefox] 21:52:38 INFO - mkdir: /builds/slave/test-pgo/build/application 21:52:38 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'] 21:52:38 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 21:52:54 INFO - Reading from file tmpfile_stdout 21:52:54 INFO - Output received: 21:52:54 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:52:54 INFO - Running post-action listener: _resource_record_post_action 21:52:54 INFO - ##### 21:52:54 INFO - ##### Running run-tests step. 21:52:54 INFO - ##### 21:52:54 INFO - Running pre-action listener: _resource_record_pre_action 21:52:54 INFO - Running main action method: run_tests 21:52:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:52:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:52:54 INFO - Python 2.7.3 21:52:54 INFO - Return code: 0 21:52:54 INFO - grabbing minidump binary from tooltool 21:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:54 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 0x10e8840>, '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 0x10556b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:52:54 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 21:52:54 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 21:52:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:52:54 INFO - Return code: 0 21:52:54 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:52:54 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:52:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:52:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:52:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:52:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 21:52:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 21:52:55 INFO - Return code: 0 21:52:55 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 21:52:55 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:52:55 INFO - Using env: {'DISPLAY': ':0', 21:52:55 INFO - 'HOME': '/home/cltbld', 21:52:55 INFO - 'LANG': 'en_US.UTF-8', 21:52:55 INFO - 'LANGUAGE': 'en_US:en', 21:52:55 INFO - 'LOGNAME': 'cltbld', 21:52:55 INFO - 'MAIL': '/var/mail/cltbld', 21:52:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:52:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:55 INFO - 'MOZ_NO_REMOTE': '1', 21:52:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:52:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:55 INFO - 'NO_EM_RESTART': '1', 21:52:55 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:52:55 INFO - 'PWD': '/builds/slave/test-pgo', 21:52:55 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:52:55 INFO - 'SHELL': '/bin/bash', 21:52:55 INFO - 'SHLVL': '1', 21:52:55 INFO - 'TERM': 'linux', 21:52:55 INFO - 'TMOUT': '86400', 21:52:55 INFO - 'USER': 'cltbld', 21:52:55 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452054080.303350-1291974514', 21:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:55 INFO - '_': '/tools/buildbot/bin/python'} 21:52:55 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:52:55 INFO - mozversion application_buildid: 20160105193035 21:52:55 INFO - mozversion application_changeset: 9d6ffc7a08b6b47056eefe1e652710a3849adbf7 21:52:55 INFO - mozversion application_display_name: Nightly 21:52:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:52:55 INFO - mozversion application_name: Firefox 21:52:55 INFO - mozversion application_remotingname: firefox 21:52:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:52:55 INFO - mozversion application_vendor: Mozilla 21:52:55 INFO - mozversion application_version: 46.0a1 21:52:55 INFO - mozversion platform_buildid: 20160105193035 21:52:55 INFO - mozversion platform_changeset: 9d6ffc7a08b6b47056eefe1e652710a3849adbf7 21:52:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:52:55 INFO - mozversion platform_version: 46.0a1 21:52:55 INFO - using testdate: 1452059575 21:52:55 INFO - actual date: 1452059575 21:52:55 INFO - starting webserver on 'localhost:47239' 21:52:55 INFO - SUITE-START | Running 3 tests 21:52:55 INFO - TEST-START | dromaeo_css 21:52:55 INFO - operating with platform_type : linux_ 21:52:55 INFO - Initialising browser for dromaeo_css test... 21:52:55 INFO - TEST-INFO | started process 10921 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptO0S1X/profile http://localhost:47239/getInfo.html) 21:53:00 INFO - PROCESS | 10921 | __metrics Screen width/height:1600/1200 21:53:00 INFO - PROCESS | 10921 | colorDepth:24 21:53:00 INFO - PROCESS | 10921 | Browser inner width/height: 1024/697 21:53:00 INFO - PROCESS | 10921 | __metrics 21:53:01 INFO - PROCESS | 10921 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:53:02 INFO - TEST-INFO | 10921: exit 0 21:53:02 INFO - Browser initialized. 21:53:02 INFO - Running cycle 1/1 for dromaeo_css test... 21:53:02 INFO - TEST-INFO | started process 11053 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptO0S1X/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:53:13 INFO - PROCESS | 11053 | RSS: Main: 150327296 21:53:13 INFO - PROCESS | 11053 | 21:54:03 INFO - PROCESS | 11053 | 1452059643418 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] 21:56:12 INFO - PROCESS | 11053 | Cycle 1(1): loaded http://localhost:47239/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47239/tests/dromaeo/cssquery-ext.html) 21:56:13 INFO - PROCESS | 11053 | RSS: Main: 156450816 21:56:13 INFO - PROCESS | 11053 | 21:59:15 INFO - PROCESS | 11053 | Cycle 1(1): loaded http://localhost:47239/tests/dromaeo/cssquery-ext.html (next: http://localhost:47239/tests/dromaeo/cssquery-jquery.html) 21:59:16 INFO - PROCESS | 11053 | RSS: Main: 152662016 21:59:16 INFO - PROCESS | 11053 | 22:02:17 INFO - PROCESS | 11053 | Cycle 1(1): loaded http://localhost:47239/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47239/tests/dromaeo/cssquery-mootools.html) 22:02:18 INFO - PROCESS | 11053 | RSS: Main: 153079808 22:02:18 INFO - PROCESS | 11053 | 22:05:20 INFO - PROCESS | 11053 | Cycle 1(1): loaded http://localhost:47239/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47239/tests/dromaeo/cssquery-prototype.html) 22:05:20 INFO - PROCESS | 11053 | RSS: Main: 152395776 22:05:20 INFO - PROCESS | 11053 | 22:08:23 INFO - PROCESS | 11053 | Cycle 1(1): loaded http://localhost:47239/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47239/tests/dromaeo/cssquery-yui.html) 22:08:23 INFO - PROCESS | 11053 | RSS: Main: 152334336 22:08:23 INFO - PROCESS | 11053 | 22:11:26 INFO - PROCESS | 11053 | Cycle 1(1): loaded http://localhost:47239/tests/dromaeo/cssquery-yui.html (next: http://localhost:47239/tests/dromaeo/cssquery-dojo.html) 22:11:26 INFO - PROCESS | 11053 | RSS: Main: 155115520 22:11:26 INFO - PROCESS | 11053 | 22:11:26 INFO - PROCESS | 11053 | __start_tp_report 22:11:26 INFO - PROCESS | 11053 | _x_x_mozilla_page_load 22:11:26 INFO - PROCESS | 11053 | _x_x_mozilla_page_load_details 22:11:26 INFO - PROCESS | 11053 | |i|pagename|runs| 22:11:26 INFO - PROCESS | 11053 | |0;dojo.html;3127.984360078199;3157.1475701560566;3175.095097897099;3179.968200317997;3181.824999625021;5274.973625131869;5349.304590403247;5361.597880158994;5375.677459352437;5376.408595054546;5333.626646134772;5352.2239275305155;5403.027455058088;5549.223108764776;5552.139418390146;4865.708057516552;4937.037277730844;4998.5001499849905;5002.624803139761;5025.798968041274;4996.475370086125;5026.522480364378;5072.695638261697;5085.753990272388;5093.210552364371;4821.951780482221;4933.654644174909;5017.297578339036;5094.235864620299;5104.8979020419565;4880.609551235928;4993.076280888047;4999.725015124167;5005.6996580205305;5017.54842064216;4874.561289483963;4886.022795440926;4898.4121905371585;4921.26181072842;4941.234108713155;5014.473480284554;5140.3831540215415;5191.506806853343;5200.063988482072;5248;5641.210230567724;5729.398413166599;5812.680302583356;5820.621659592113;5875;5908.793192238251;5921.940780592182;5933.991221492313;5945.554083443759;5946.762129514815;5370.4361042090795;5498.972505137449;5504.091824848895;5511.944880551183;5526.309211348582;5949.732262048218;5978.491828194652;5988.760449581968;6040.063790112539;6103.206583144251;5668.886622267614;5726.770929162787;5729.713514324267;5739.081746920473;5766.913496297559;5625.943740562542;5672.517835983905;5769.423057694197;5822.155787410802;5842.707864606753;5806.129080637854;5809.564282678732;5828.417158284137;5833.270841144857;5856.677882716492;5798.33319168301;5813.244278243801;5819.098039803753;5824.88350232993;5832.854178645568;4358.6295164911335;4455.799489023002;4478.440194975628;4486.820527178941;4560.931586026212;3917.373220284741;3921.9215615687526;3941.2117576484243;3960.2277555876326;3974.7813870237414;5360.195970604441;5381.865453363697;5386.218998245233;5389.407165211902;5393.083175860113;5662.688552129673;5768.826935191951;5831.679257640871;5943.286805583358;5954.672493012926;5404.32445944257;5423.484768946943;5430.972845135749;5436.10304299794;5448.809291674852;4928.162212423897;4937.950620493821;4943.258511223274;4951.950480495149;4974.651774375831;5912.940870591325;5928.614640048383;5998.040313549724;6043.486303664238;6057.757689692451;5790.768369265183;5796.507296879812;5803.187553742564;5833.4749872511675;5843.678597677169;5853.853653658693;5938.910916336345;6001.549883758823;6009.098635204754;6011.27864656244;5730.684812335195;5759.164921086335;5816.854578635399;5858.5898987070495;5883.735231914659;5854.736536855937;5893.02765043763;5901.881962360643;5923.703814809156;5932.822015339374;5768.971155144198;5782.971085144547;5783.190353350618;5801.680907549957;5803.622764520293;5551.583631227593;5634.549236061187;5679.0345641240265;5746.454086861741;5771.480566749013;5602.579806514609;5618.438156184349;5633.9295533848435;5643.661380317194;5673.432656734293;5631.352394474524;5730.799422020209;5736.483716465538;5738.426157384228;5792.0443126885275;5577.330720313588;5615.298087739033;5677.261955945701;5719.914201287067;5760.539156867357 22:11:26 INFO - PROCESS | 11053 | |1;ext.html;502.1689104531998;516.220507034378;532.4515748778757;540.2058973309239;543.6004536665552;34672.4799128013;35362.82318588404;35418.8229058855;35466;35513.289734205304;38163.61836381636;38604.420933686015;38675.41986870192;38676.41985370222;38886;8393.412461127724;8523.616437260338;8533.871991920127;8572.014218364906;8595.054544000155;8211.302039326665;8357.58212089393;8418.284445822112;8461.576921153948;8483;8604.354673399488;8641.827163456726;8642.438241514314;8651.437656552303;8695.304375649934;8424.705135320264;8565.443246188977;8570.742877713647;8589.785255368603;8599.312055035582;8425.74722758312;8536.018357888797;8548.615312310962;8551.358648101355;8554.315654747668;39289.41065884014;39559.40660890089;39588.80205598954;39644.40533392001;39645;3330.8001519908885;3407.1822762537063;3541.0793193769546;3587.94618080729;3761.6426439488205;29387.55918661222;30199.698003020127;30255;30286;30477.390452190833;3602.711783057375;3663.816809159531;3807.9428808567895;3824.579296277407;3845.2693988142164;251045;252364.73817630977;253032;253873;254103;51860;52480.73759631254;56998.43001570014;58766.41233587695;59724.10413843796;51347.74326128345;51680.74159629178;51870.22194667083;51959.74020129875;51965.22052169221;14096.295185240697;14112.647183820487;14189.929050354682;14199.148051116967;14226.28868556568;11757.529698811952;11788.410579470992;11788.528458861721;11828.76342473163;11904.642860714192;19518.414447566596;19825.909574973513;19861.30485433003;19867.821148616153;19868.403947881587;7650.655720492591;7746.496477729042;7766.262579826302;7814.413918956101;7845.37237021037;868.9913100869037;899.7300809757047;914.9359544831798;973.8101070291367;1036.6060896859144;24849.627255591182;24932;25217.369565760637;27604.861975689993;28473.85763071213;1000.429755039635;1025.661531694539;1033.8552602635637;1040.99479502602;1118.8209886418133;13419.155049800755;14167.433302667983;14173.78739318911;14333.354999025069;14399.78400323996;290676;292752;293502;293548;294150;49978.75010624924;50014.499855000984;50630.24054639183;50654.49345506498;50763.23855142176;1339.5110784563758;1357.1585616917378;1357.7895426208954;1362.0193460708076;1371.245814801855;26541.469170616867;26834;27309.726902731512;27351.726482734917;27679.723202767713;45247;45553.772231139956;45715.31427028664;45793;45801.77099114483;272591;272745;272923;275134;276629;29984.400311994075;31452;31495.842520788166;31582.842085789423;31679.20801979969;35611.465828012086;35800.46299305565;36404.81797590995;36637;36946.63053369432;31142.265572380435;31299;33223;34153;34559.4816077754;34569.654303457646;34672.479912801835;34769;34776.30447390988;34780.65219347774;33628.159296017795;33879.153021174665;34204.14489637779;34309.656903430645;34544.30911381808;29537;31143.22141946379;31817;31892.84053579717;32186.35627287488;24137.758622413552;24305.27084187477;24488;24772.504549909263;24821 22:11:26 INFO - PROCESS | 11053 | |2;jquery.html;341.5900918897322;344.49187448513436;345.8772135891758;346.9930601387971;347.27246418752736;16193;16661.916690416547;17461.563460913483;17624.55938601534;18118.728219076726;10886.61896833611;10915.890841091586;11053.778924421507;11116.11071114311;11116.944415277912;4762.738049407281;4786.138495070886;4859.927101093486;4860.222364421676;4894.241392584137;4841.709497430148;4852.539008794177;4862.270659401101;4865;4881.243407271879;3695.8152092395408;3813.2373525294915;4817.397825271841;4820.542048505386;5239.187925871477;5335.653182543161;5374.140137578008;5397.163439666858;5407.080796264625;5408.864778380533;4790.401199850019;4958.479359667255;4965.453800081988;5158.767855446514;5198.2722418861385;11928.642140735705;12087.516499340016;12191.817122743167;12258.08064395174;12380.319082450462;1960.5294729265017;1986.8112529309692;2025.463252238158;2066.4007437843006;2123.309924274617;9152.17630413266;10218.846717299246;10470.42412667303;12663.493460261578;12887.613371598867;1693.0941946058922;1754.2018381636453;1781.2963879267745;1791.838734513887;1807.788389429409;60178.69910650419;62075.6896215516;62747.6862615684;63027.36972630261;63153.68423157855;9875.308728388944;10076.899231007596;10172.847407288897;10199.337043092175;10227.539760710786;13334.333283335794;13367.46530138803;13393.732125357634;13395.933020334836;13402.530911418053;7146.32109949554;7191.64041797908;7303.7443689471675;7408.148062972719;7532.811679708051;6721.899171512431;6722.361375669304;6751.054852320679;6754.493412994045;6779;4130.153318569686;4185.91628167441;4209.915801683949;4237.067845074079;4329.523752387235;1838.6414649143555;1863.478226096668;1876.221368132237;1900.8669393142347;1913.7703475583019;419.6349176216711;427.5468003915859;432.5371852118266;945.2438049560325;989.0603926270072;9703.6118555257;10616.628418005334;10749.78500429987;10828.566857325777;10884.891151088546;415.66746602717706;428.26124934487757;445.6768842589097;450.0908165505726;461.42552522109514;5816.098504731774;5949.286085669747;5972.402759723993;5984.491318237911;6036.547258955596;390657;396173;396547;402314;555453;40721.38917916234;40740.592594074275;43192;72310;79603.60198198972;1131.971700707489;1143.6454699043322;1143.9542418303174;1169.0997931592626;1169.713210673132;15640.608984775017;15641.296141673425;15757.290921908312;15872.20638968024;15927.920360398124;35373.82313088418;35508;35894.102647434025;36204.81897590495;36348.454773177895;46442.76778616085;46726;46761.06477870492;48154.51845481501;48238.51761482481;9145.039770823967;9267.953660231655;9352.625894964125;9364.157225849705;9442.81114377695;11077.723056923642;11169.273997190481;11221.775564488828;11290.266132701348;11329.150313726668;10763.730906727395;12670.619881403572;13830.308484575933;14323.14061156334;14359.851211903231;13371.465141394236;13485.457495943077;13554.322283885964;13835.239061851695;14324;13181.736365272833;13298.202107873558;13547.525836595672;14224.502142424966;14240.643983900485;9037.593308301273;9170.908290917272;9184.816303674022;9206.585703643219;9213.447193168431;10586.258961872903;13916.304184790923;14096.08375455592;14100.153990760587;14136.363863626368 22:11:26 INFO - PROCESS | 11053 | |3;mootools.html;1421.6730152065024;1422.6941207640355;1426.5961854275547;1442.199579233525;1445.9638509037266;6382.138411314471;6457.192850893638;7068.717251309948;7188.496805223636;7224.638768061595;6792.898106528393;6910.516263861532;6941.54879932804;6963.582185068887;7008.789736307906;2180.3458962311324;2203.55928814237;2224.2993457060975;2229.977700223001;2242.932712018634;2231.0518029837335;2240.092762431218;2288.1305104060434;2291.5760584291875;2294.6328587426015;2206.227820262903;2222.5665995130958;2229.2754854672216;2229.7993180613744;2245.62947113726;2194.5940001099766;2205.3163519309064;2221.2336743823435;2225.321277010511;2229.851626412399;2258.1983395894385;2283.8287128465267;2285.1887579909226;2292.85096468729;2293.908243670251;7186.6704659638135;7231.529950553249;7240.818979525501;7247.347738703542;7267.273272672691;4508.909821803579;4550.8862278442975;4565.269556870885;4570.588647021751;4585.885352866172;2886.1774394297736;2990.790644654853;2997;3011.337505748732;3014.4573976684187;919.954002299889;938.4228699349919;942.1520631431698;948.7580666929957;967.970960871175;9603.087706667855;9697.981711920218;9744.707658770178;9749;9758.658446954394;4090.365993271048;4103.138340948374;4136.544980052192;4146.771927543954;4149.356849688304;8292.460990035628;8349.123342049119;8350.62422191003;8351.791205219797;8361.498310101291;4532.4334458192725;4534.115847409724;4539.182947069559;4540.954590454053;4558.1795276849825;4042.939355909664;4046.858359957387;4051.331530297527;4164.187983343219;4168.353905144708;3306.6858648428843;3312.850921708529;3338.983305083459;3355.597328320617;3388.881389151368;1075.9515821788038;1083.6803143072812;1085.6634443322596;1085.7502774361942;1095.27164435651;1243.583399561139;1254.2286493806243;1261.186534685123;1308.339288659221;1308.5158491358259;6534.411902928759;6665.966670166618;6697.497687673444;6714.227863795629;6723.7646682365885;466.8482743108435;470.88698712309485;472.357593672605;477.0839987224537;481.1819906159543;5274.498922602346;5285.920711189336;5295.682259064469;5317.494837990384;5331.760070796823;8352.707655232038;8399.706010289732;8583.785405364792;8618.095100014409;8628.697995570124;8468.32253419725;8529.061803201643;8534.53060081689;8570.74287771368;8624.482531048157;6533.085368048477;6575.276719560845;6812.62530560814;6853.280405557444;6915.343042410963;6660.300668429939;6679.966600166968;6705.8323541909895;6720.126383570105;6755.05429239897;7442.962785186256;7598.354139898171;7617.733379331697;7747.070351557849;7798.376129909707;7680.5391676499585;7813;7840.921590784019;7872;7892.131865494676;6074.51403887679;6176.907346389898;6365.649889256136;6556.901646475402;6567.704453299518;6850.520463567503;6868.210155832143;6889.069975553236;6903.482238832208;6907.481938854707;6376.202974628171;6505.154329937078;6578.407943285128;6586.37429444202;6595.835104122435;6033.42682445167;6111.633302001894;6148.16999705052;6258.718357674006;6418.614883107029;6377.0753240778895;6426.100345951664;6438.871222575616;6459.61242325462;6469.385408386196;5534.391216966211;5578.581606379456;5598.832035038955;5611.354694210218;5613.298337707786;5838.32859221195;6013.6692481913915;6022.126791615104;6074.3925607438905;6086.239220097488 22:11:26 INFO - PROCESS | 11053 | |4;prototype.html;323.08566756080296;325.0946115069532;329.1491494486752;334.0296438845154;334.6235485079286;6149.077638354249;6254.84362890928;6257.342978987209;6271.027990661443;6344.619322840633;6138.14066030756;6187.0719392091205;6236.656983865897;6237.5009999200065;6259.374062593738;4772.546608072236;4790.54489823468;4794.304825800257;4797.2324428091515;4804.207305794557;4771.284307353907;4790.496997815231;4792.424909010923;4798.808047678089;4803.1114243864995;4685.789139488714;4742.762861856911;4751.429828420577;4767.213409787381;4773.498782627808;4730.219513780222;4746.264329029006;4752.12085764133;4753.191957367256;4756.548127927841;4149.481314835645;4161.854335098257;4166.291730405808;4174.686898482626;4176.164767046603;5934.109883517507;5936.050231962909;5938.138969849391;5945.048792193228;5952.970235148797;5466.699331536764;5565.833025009256;5569;5571.582131340166;5578.665280083208;6612.900806487906;6642;6654.633995130266;6658.300878407746;6662.7334906604165;4580.7938642761155;4596.126735920165;4598.540145985408;4608.792604332813;4615.561521655437;6765.154355705537;6948.965255173692;6968.128983877015;6969.372756451944;6974.721011159548;4739.028499157734;4745.786439610157;4748.074125545486;4751.049790042005;4755.548222918817;4782.139214941274;4815.133276010281;4815.975920120377;4816.8554943351755;4822;5558.249636299048;5562.082256427644;5562.276904002454;5562.276904002454;5563.860903477364;6599.70301336441;6685.76599819004;6719.428848547928;6720.899186512206;6731.293214212437;1614.701280263155;1655.983440165607;1659.585103724069;1664.5672125247281;1689.4509284482592;1087.4671411008549;1089.199438412766;1100.5212732461405;1103.45379037377;1111.4609414433994;6163.753449862045;6214.751409943642;6228.906566401508;6265.467435267962;6277.089821975879;6829.214640316427;6829.385355318045;6840.452763778886;6841.418479429205;6848.6918088686125;6109.77804439114;6208.348123446973;6228.688565571703;6230.408111229426;6247.843803904848;3679.4296883983025;3727.993441770761;3728.6457786510236;3730.347189241926;3730.720195985312;7037.331453511908;7082.964585177041;7119.67961441726;7140.642967851691;7141.642917854087;6923.2038315593345;7012.263712310134;7034.296570343027;7046;7056.823579410556;7136.928630713626;7291.125064992235;7295.70817167318;7303.926960730431;7305.671244794104;6973.65131743421;6984.301569842975;6988.440924726111;6989;6993.055937448379;6829.89755153683;6896;6909.723611055501;6922.10012698346;6931.341522555349;7215.855682886207;7227.674754636159;7233.819154521179;7269.818254543678;7274.418046556369;4616.215243408696;4661.557152070548;4665.790039448301;4668.7665616719705;4677.2750223715375;6752.898706519308;6938.202106757787;6967.756128535477;6980.6509674515055;6993.985872048423;6757.93242067573;6778.627175505198;6779.72881084751;6835.316468353125;6842.178938527409;6791.252962174256;6792.252852186157;6793.354631310018;6802.897956530557;6809.21694005176;6525.771597994048;6616.2391324996315;6646.235682896336;6653.135092438146;6674.566153200027;6734.73061077571;6782.796516104525;6786.457083433214;6835.69239384219;6845.794626161223;6615.636140012345;6642.535022548375;6650.73397064112;6650.935850264128;6656 22:11:26 INFO - PROCESS | 11053 | |5;yui.html;791.0941971442702;794.9125596184418;797.7686470923433;809.4900212865894;833.8040560468289;13676.863231367683;13975.930120349409;13977.79033314501;14023.999999999987;14034.228117453536;12719.36403179842;12793;12872.356382180877;12902.22586644802;12905.741885162292;789.4473868292204;804.8309854930471;805.114374188394;824.47233770387;825.3809642767924;807.4307613132756;823.7199352220244;824.7979245084963;830.4353039932844;831.0193971114084;832.7668252889171;855.7304449098546;860.8407444622734;861.7974775927684;861.8233262181237;834.5326617094416;847.9830403391898;851.5274022917279;853.4665833853873;855.0167307596251;618.0543768034913;619.4301242856583;625.9155014073133;626.9561130720851;626.9999351035092;13580.728385432334;13632.113912595749;13646.181229126285;13676;13700;12231.204971676812;12322.691932701664;12406.937965310206;12598.68503287416;13184.472621095145;9343.439393636403;9466.90533094667;9588.616455341778;9645.228381729516;9717.514124293757;3475.7045651119683;3493.8951831445097;3513.7364697647777;3517.8592856285973;3523.982380088083;49240;49315.26027109596;50708;50823;50993.49006509924;9439.858402123973;9453.291003174652;9549.713508594754;9613.086756758097;9634.807303853884;17789.288428462976;17825.46523604294;17947.551311217063;17994.5501362467;17994.820051799576;7346.302101300368;7478.878168274802;7587.810304742426;7704.768856934301;7811.101723301779;4232.195882782262;4315.5900189481945;4394.934075988863;4402.889927751832;4435.911281774346;3075.815451072943;3082.2756652186717;3090.9227269318;3096.9535456968165;3100.860461279203;566.4165909113619;576.3084298841408;587.6033677267827;595.8838026584774;600.1417972299654;541.5748637319685;571.3001573072952;664.6145235763246;687.9096631838592;707.9610621415871;8097.676092956333;8173.34613230952;8317.792055198668;8354.498730076215;8380.748577542683;521.119308368863;538.4776766536453;604.320139842677;629.559308484063;662.6322391072904;3732.869349572752;3878.864239751595;3994.2211268802885;3999.6200360965663;4019.879403617896;54194.72902635462;54969.1754623681;55372;55662;55852;47727.28409073866;47887.76056119697;48378;48500.27249591259;48932.26601600979;44772.10455790931;45600.7719961398;46000.539994599625;46104.308435373496;46219.306710399374;7875.291223789886;7945.920540794749;8117.188281171835;8384.203500667427;8486.61810218554;33435.66564334326;33652.326953461285;34331.82834085914;34949.47575786416;35044.82477587596;42461.363079553215;43075;43098.78450607727;43114.353284701385;43897.34153987629;10814.405207713651;11113.666590002313;11302;11318.32090074598;11545.307281563133;12226.938865305616;12267.938660306641;12392.876071239532;12504.937475312929;12508.437120329425;11681.766364672829;11684.649460516199;11910.285382877055;12164.330961797186;12251.571195008131;11038.392888390894;11082.113430925669;11180.720481988015;11342.20604557673;11686.04910880462;11756.764864702829;11757.059435244988;11812.350320732443;12109.818352724893;12145.878541214475;9657.517124143906;9756.219502439646;9841.655542055994;9895.786497207157;10035.19718422539;8772.38593298463;8987.370884038317;9309.44143351401;9328.766780830534;9796.853047204155 22:11:26 INFO - PROCESS | 11053 | __end_tp_report 22:11:26 INFO - PROCESS | 11053 | __start_cc_report 22:11:26 INFO - PROCESS | 11053 | _x_x_mozilla_cycle_collect,317 22:11:26 INFO - PROCESS | 11053 | __end_cc_report 22:11:26 INFO - PROCESS | 11053 | __startTimestamp1452060686287__endTimestamp 22:11:26 INFO - PROCESS | 11053 | 22:11:26 INFO - PROCESS | 11053 | ------- Summary: start ------- 22:11:26 INFO - PROCESS | 11053 | Number of tests: 6 22:11:26 INFO - PROCESS | 11053 | 22:11:26 INFO - PROCESS | 11053 | [#0] dojo.html Cycles:165 Average:5403.00 Median:5633.93 stddev:618.37 (11.0%) stddev-sans-first:593.95 22:11:26 INFO - PROCESS | 11053 | Values: 3128.0 3157.1 3175.1 3180.0 3181.8 5275.0 5349.3 5361.6 5375.7 5376.4 5333.6 5352.2 5403.0 5549.2 5552.1 4865.7 4937.0 4998.5 5002.6 5025.8 4996.5 5026.5 5072.7 5085.8 5093.2 4822.0 4933.7 5017.3 5094.2 5104.9 4880.6 4993.1 4999.7 5005.7 5017.5 4874.6 4886.0 4898.4 4921.3 4941.2 5014.5 5140.4 5191.5 5200.1 5248.0 5641.2 5729.4 5812.7 5820.6 5875.0 5908.8 5921.9 5934.0 5945.6 5946.8 5370.4 5499.0 5504.1 5511.9 5526.3 5949.7 5978.5 5988.8 6040.1 6103.2 5668.9 5726.8 5729.7 5739.1 5766.9 5625.9 5672.5 5769.4 5822.2 5842.7 5806.1 5809.6 5828.4 5833.3 5856.7 5798.3 5813.2 5819.1 5824.9 5832.9 4358.6 4455.8 4478.4 4486.8 4560.9 3917.4 3921.9 3941.2 3960.2 3974.8 5360.2 5381.9 5386.2 5389.4 5393.1 5662.7 5768.8 5831.7 5943.3 5954.7 5404.3 5423.5 5431.0 5436.1 5448.8 4928.2 4938.0 4943.3 4952.0 4974.7 5912.9 5928.6 5998.0 6043.5 6057.8 5790.8 5796.5 5803.2 5833.5 5843.7 5853.9 5938.9 6001.5 6009.1 6011.3 5730.7 5759.2 5816.9 5858.6 5883.7 5854.7 5893.0 5901.9 5923.7 5932.8 5769.0 5783.0 5783.2 5801.7 5803.6 5551.6 5634.5 5679.0 5746.5 5771.5 5602.6 5618.4 5633.9 5643.7 5673.4 5631.4 5730.8 5736.5 5738.4 5792.0 5577.3 5615.3 5677.3 5719.9 5760.5 22:11:26 INFO - PROCESS | 11053 | 22:11:26 INFO - PROCESS | 11053 | [#1] ext.html Cycles:180 Average:43525.87 Median:34720.74 stddev:71384.30 (205.6%) stddev-sans-first:71511.45 22:11:26 INFO - PROCESS | 11053 | Values: 502.2 516.2 532.5 540.2 543.6 34672.5 35362.8 35418.8 35466.0 35513.3 38163.6 38604.4 38675.4 38676.4 38886.0 8393.4 8523.6 8533.9 8572.0 8595.1 8211.3 8357.6 8418.3 8461.6 8483.0 8604.4 8641.8 8642.4 8651.4 8695.3 8424.7 8565.4 8570.7 8589.8 8599.3 8425.7 8536.0 8548.6 8551.4 8554.3 39289.4 39559.4 39588.8 39644.4 39645.0 3330.8 3407.2 3541.1 3587.9 3761.6 29387.6 30199.7 30255.0 30286.0 30477.4 3602.7 3663.8 3807.9 3824.6 3845.3 251045.0 252364.7 253032.0 253873.0 254103.0 51860.0 52480.7 56998.4 58766.4 59724.1 51347.7 51680.7 51870.2 51959.7 51965.2 14096.3 14112.6 14189.9 14199.1 14226.3 11757.5 11788.4 11788.5 11828.8 11904.6 19518.4 19825.9 19861.3 19867.8 19868.4 7650.7 7746.5 7766.3 7814.4 7845.4 869.0 899.7 914.9 973.8 1036.6 24849.6 24932.0 25217.4 27604.9 28473.9 1000.4 1025.7 1033.9 1041.0 1118.8 13419.2 14167.4 14173.8 14333.4 14399.8 290676.0 292752.0 293502.0 293548.0 294150.0 49978.8 50014.5 50630.2 50654.5 50763.2 1339.5 1357.2 1357.8 1362.0 1371.2 26541.5 26834.0 27309.7 27351.7 27679.7 45247.0 45553.8 45715.3 45793.0 45801.8 272591.0 272745.0 272923.0 275134.0 276629.0 29984.4 31452.0 31495.8 31582.8 31679.2 35611.5 35800.5 36404.8 36637.0 36946.6 31142.3 31299.0 33223.0 34153.0 34559.5 34569.7 34672.5 34769.0 34776.3 34780.7 33628.2 33879.2 34204.1 34309.7 34544.3 29537.0 31143.2 31817.0 31892.8 32186.4 24137.8 24305.3 24488.0 24772.5 24821.0 22:11:26 INFO - PROCESS | 11053 | 22:11:26 INFO - PROCESS | 11053 | [#2] jquery.html Cycles:180 Average:24192.31 Median:36276.64 stddev:70861.46 (195.3%) stddev-sans-first:71037.61 22:11:26 INFO - PROCESS | 11053 | Values: 341.6 344.5 345.9 347.0 347.3 16193.0 16661.9 17461.6 17624.6 18118.7 10886.6 10915.9 11053.8 11116.1 11116.9 4762.7 4786.1 4859.9 4860.2 4894.2 4841.7 4852.5 4862.3 4865.0 4881.2 3695.8 3813.2 4817.4 4820.5 5239.2 5335.7 5374.1 5397.2 5407.1 5408.9 4790.4 4958.5 4965.5 5158.8 5198.3 11928.6 12087.5 12191.8 12258.1 12380.3 1960.5 1986.8 2025.5 2066.4 2123.3 9152.2 10218.8 10470.4 12663.5 12887.6 1693.1 1754.2 1781.3 1791.8 1807.8 60178.7 62075.7 62747.7 63027.4 63153.7 9875.3 10076.9 10172.8 10199.3 10227.5 13334.3 13367.5 13393.7 13395.9 13402.5 7146.3 7191.6 7303.7 7408.1 7532.8 6721.9 6722.4 6751.1 6754.5 6779.0 4130.2 4185.9 4209.9 4237.1 4329.5 1838.6 1863.5 1876.2 1900.9 1913.8 419.6 427.5 432.5 945.2 989.1 9703.6 10616.6 10749.8 10828.6 10884.9 415.7 428.3 445.7 450.1 461.4 5816.1 5949.3 5972.4 5984.5 6036.5 390657.0 396173.0 396547.0 402314.0 555453.0 40721.4 40740.6 43192.0 72310.0 79603.6 1132.0 1143.6 1144.0 1169.1 1169.7 15640.6 15641.3 15757.3 15872.2 15927.9 35373.8 35508.0 35894.1 36204.8 36348.5 46442.8 46726.0 46761.1 48154.5 48238.5 9145.0 9268.0 9352.6 9364.2 9442.8 11077.7 11169.3 11221.8 11290.3 11329.2 10763.7 12670.6 13830.3 14323.1 14359.9 13371.5 13485.5 13554.3 13835.2 14324.0 13181.7 13298.2 13547.5 14224.5 14240.6 9037.6 9170.9 9184.8 9206.6 9213.4 10586.3 13916.3 14096.1 14100.2 14136.4 22:11:26 INFO - PROCESS | 11053 | 22:11:26 INFO - PROCESS | 11053 | [#3] mootools.html Cycles:180 Average:5029.10 Median:6080.38 stddev:2549.66 (41.9%) stddev-sans-first:2542.40 22:11:26 INFO - PROCESS | 11053 | Values: 1421.7 1422.7 1426.6 1442.2 1446.0 6382.1 6457.2 7068.7 7188.5 7224.6 6792.9 6910.5 6941.5 6963.6 7008.8 2180.3 2203.6 2224.3 2230.0 2242.9 2231.1 2240.1 2288.1 2291.6 2294.6 2206.2 2222.6 2229.3 2229.8 2245.6 2194.6 2205.3 2221.2 2225.3 2229.9 2258.2 2283.8 2285.2 2292.9 2293.9 7186.7 7231.5 7240.8 7247.3 7267.3 4508.9 4550.9 4565.3 4570.6 4585.9 2886.2 2990.8 2997.0 3011.3 3014.5 920.0 938.4 942.2 948.8 968.0 9603.1 9698.0 9744.7 9749.0 9758.7 4090.4 4103.1 4136.5 4146.8 4149.4 8292.5 8349.1 8350.6 8351.8 8361.5 4532.4 4534.1 4539.2 4541.0 4558.2 4042.9 4046.9 4051.3 4164.2 4168.4 3306.7 3312.9 3339.0 3355.6 3388.9 1076.0 1083.7 1085.7 1085.8 1095.3 1243.6 1254.2 1261.2 1308.3 1308.5 6534.4 6666.0 6697.5 6714.2 6723.8 466.8 470.9 472.4 477.1 481.2 5274.5 5285.9 5295.7 5317.5 5331.8 8352.7 8399.7 8583.8 8618.1 8628.7 8468.3 8529.1 8534.5 8570.7 8624.5 6533.1 6575.3 6812.6 6853.3 6915.3 6660.3 6680.0 6705.8 6720.1 6755.1 7443.0 7598.4 7617.7 7747.1 7798.4 7680.5 7813.0 7840.9 7872.0 7892.1 6074.5 6176.9 6365.6 6556.9 6567.7 6850.5 6868.2 6889.1 6903.5 6907.5 6376.2 6505.2 6578.4 6586.4 6595.8 6033.4 6111.6 6148.2 6258.7 6418.6 6377.1 6426.1 6438.9 6459.6 6469.4 5534.4 5578.6 5598.8 5611.4 5613.3 5838.3 6013.7 6022.1 6074.4 6086.2 22:11:26 INFO - PROCESS | 11053 | 22:11:26 INFO - PROCESS | 11053 | [#4] prototype.html Cycles:180 Average:5583.80 Median:6237.08 stddev:1704.75 (27.3%) stddev-sans-first:1663.18 22:11:26 INFO - PROCESS | 11053 | Values: 323.1 325.1 329.1 334.0 334.6 6149.1 6254.8 6257.3 6271.0 6344.6 6138.1 6187.1 6236.7 6237.5 6259.4 4772.5 4790.5 4794.3 4797.2 4804.2 4771.3 4790.5 4792.4 4798.8 4803.1 4685.8 4742.8 4751.4 4767.2 4773.5 4730.2 4746.3 4752.1 4753.2 4756.5 4149.5 4161.9 4166.3 4174.7 4176.2 5934.1 5936.1 5938.1 5945.0 5953.0 5466.7 5565.8 5569.0 5571.6 5578.7 6612.9 6642.0 6654.6 6658.3 6662.7 4580.8 4596.1 4598.5 4608.8 4615.6 6765.2 6949.0 6968.1 6969.4 6974.7 4739.0 4745.8 4748.1 4751.0 4755.5 4782.1 4815.1 4816.0 4816.9 4822.0 5558.2 5562.1 5562.3 5562.3 5563.9 6599.7 6685.8 6719.4 6720.9 6731.3 1614.7 1656.0 1659.6 1664.6 1689.5 1087.5 1089.2 1100.5 1103.5 1111.5 6163.8 6214.8 6228.9 6265.5 6277.1 6829.2 6829.4 6840.5 6841.4 6848.7 6109.8 6208.3 6228.7 6230.4 6247.8 3679.4 3728.0 3728.6 3730.3 3730.7 7037.3 7083.0 7119.7 7140.6 7141.6 6923.2 7012.3 7034.3 7046.0 7056.8 7136.9 7291.1 7295.7 7303.9 7305.7 6973.7 6984.3 6988.4 6989.0 6993.1 6829.9 6896.0 6909.7 6922.1 6931.3 7215.9 7227.7 7233.8 7269.8 7274.4 4616.2 4661.6 4665.8 4668.8 4677.3 6752.9 6938.2 6967.8 6980.7 6994.0 6757.9 6778.6 6779.7 6835.3 6842.2 6791.3 6792.3 6793.4 6802.9 6809.2 6525.8 6616.2 6646.2 6653.1 6674.6 6734.7 6782.8 6786.5 6835.7 6845.8 6615.6 6642.5 6650.7 6650.9 6656.0 22:11:26 INFO - PROCESS | 11053 | 22:11:26 INFO - PROCESS | 11053 | [#5] yui.html Cycles:180 Average:13613.79 Median:49086.13 stddev:15581.40 (31.7%) stddev-sans-first:15595.35 22:11:26 INFO - PROCESS | 11053 | Values: 791.1 794.9 797.8 809.5 833.8 13676.9 13975.9 13977.8 14024.0 14034.2 12719.4 12793.0 12872.4 12902.2 12905.7 789.4 804.8 805.1 824.5 825.4 807.4 823.7 824.8 830.4 831.0 832.8 855.7 860.8 861.8 861.8 834.5 848.0 851.5 853.5 855.0 618.1 619.4 625.9 627.0 627.0 13580.7 13632.1 13646.2 13676.0 13700.0 12231.2 12322.7 12406.9 12598.7 13184.5 9343.4 9466.9 9588.6 9645.2 9717.5 3475.7 3493.9 3513.7 3517.9 3524.0 49240.0 49315.3 50708.0 50823.0 50993.5 9439.9 9453.3 9549.7 9613.1 9634.8 17789.3 17825.5 17947.6 17994.6 17994.8 7346.3 7478.9 7587.8 7704.8 7811.1 4232.2 4315.6 4394.9 4402.9 4435.9 3075.8 3082.3 3090.9 3097.0 3100.9 566.4 576.3 587.6 595.9 600.1 541.6 571.3 664.6 687.9 708.0 8097.7 8173.3 8317.8 8354.5 8380.7 521.1 538.5 604.3 629.6 662.6 3732.9 3878.9 3994.2 3999.6 4019.9 54194.7 54969.2 55372.0 55662.0 55852.0 47727.3 47887.8 48378.0 48500.3 48932.3 44772.1 45600.8 46000.5 46104.3 46219.3 7875.3 7945.9 8117.2 8384.2 8486.6 33435.7 33652.3 34331.8 34949.5 35044.8 42461.4 43075.0 43098.8 43114.4 43897.3 10814.4 11113.7 11302.0 11318.3 11545.3 12226.9 12267.9 12392.9 12504.9 12508.4 11681.8 11684.6 11910.3 12164.3 12251.6 11038.4 11082.1 11180.7 11342.2 11686.0 11756.8 11757.1 11812.4 12109.8 12145.9 9657.5 9756.2 9841.7 9895.8 10035.2 8772.4 8987.4 9309.4 9328.8 9796.9 22:11:26 INFO - PROCESS | 11053 | -------- Summary: end -------- 22:11:26 INFO - PROCESS | 11053 | 22:11:27 INFO - TEST-INFO | 11053: exit 0 22:11:27 INFO - TEST-OK | dromaeo_css | took 1111433ms 22:11:27 INFO - TEST-START | kraken 22:11:27 INFO - operating with platform_type : linux_ 22:11:27 INFO - Initialising browser for kraken test... 22:11:27 INFO - TEST-INFO | started process 11287 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppzMhv8/profile http://localhost:47239/getInfo.html) 22:11:31 INFO - PROCESS | 11287 | __metrics Screen width/height:1600/1200 22:11:31 INFO - PROCESS | 11287 | colorDepth:24 22:11:31 INFO - PROCESS | 11287 | Browser inner width/height: 1024/697 22:11:31 INFO - PROCESS | 11287 | __metrics 22:11:31 INFO - PROCESS | 11287 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:11:31 INFO - PROCESS | 11287 | 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. 22:11:32 INFO - TEST-INFO | 11287: exit 0 22:11:32 INFO - Browser initialized. 22:11:32 INFO - Running cycle 1/1 for kraken test... 22:11:32 INFO - TEST-INFO | started process 11408 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppzMhv8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:11:44 INFO - PROCESS | 11408 | RSS: Main: 150872064 22:11:44 INFO - PROCESS | 11408 | 22:11:47 INFO - PROCESS | 11408 | Cycle 1(1): loaded http://localhost:47239/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47239/tests/kraken/driver.html?testName=audio-beat-detection) 22:11:47 INFO - PROCESS | 11408 | RSS: Main: 152047616 22:11:47 INFO - PROCESS | 11408 | 22:11:50 INFO - PROCESS | 11408 | Cycle 1(1): loaded http://localhost:47239/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47239/tests/kraken/driver.html?testName=audio-dft) 22:11:50 INFO - PROCESS | 11408 | RSS: Main: 151769088 22:11:50 INFO - PROCESS | 11408 | 22:11:53 INFO - PROCESS | 11408 | Cycle 1(1): loaded http://localhost:47239/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47239/tests/kraken/driver.html?testName=audio-fft) 22:11:54 INFO - PROCESS | 11408 | RSS: Main: 146767872 22:11:54 INFO - PROCESS | 11408 | 22:11:56 INFO - PROCESS | 11408 | Cycle 1(1): loaded http://localhost:47239/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47239/tests/kraken/driver.html?testName=audio-oscillator) 22:11:56 INFO - PROCESS | 11408 | RSS: Main: 146644992 22:11:56 INFO - PROCESS | 11408 | 22:11:59 INFO - PROCESS | 11408 | Cycle 1(1): loaded http://localhost:47239/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47239/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:11:59 INFO - PROCESS | 11408 | RSS: Main: 147595264 22:11:59 INFO - PROCESS | 11408 | 22:12:02 INFO - PROCESS | 11408 | Cycle 1(1): loaded http://localhost:47239/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47239/tests/kraken/driver.html?testName=imaging-darkroom) 22:12:03 INFO - PROCESS | 11408 | RSS: Main: 147431424 22:12:03 INFO - PROCESS | 11408 | 22:12:06 INFO - PROCESS | 11408 | Cycle 1(1): loaded http://localhost:47239/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47239/tests/kraken/driver.html?testName=imaging-desaturate) 22:12:07 INFO - PROCESS | 11408 | RSS: Main: 149377024 22:12:07 INFO - PROCESS | 11408 | 22:12:10 INFO - PROCESS | 11408 | Cycle 1(1): loaded http://localhost:47239/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47239/tests/kraken/driver.html?testName=json-parse-financial) 22:12:10 INFO - PROCESS | 11408 | RSS: Main: 149188608 22:12:10 INFO - PROCESS | 11408 | 22:12:12 INFO - PROCESS | 11408 | Cycle 1(1): loaded http://localhost:47239/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47239/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:12:12 INFO - PROCESS | 11408 | RSS: Main: 148488192 22:12:12 INFO - PROCESS | 11408 | 22:12:14 INFO - PROCESS | 11408 | Cycle 1(1): loaded http://localhost:47239/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47239/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:12:15 INFO - PROCESS | 11408 | RSS: Main: 148684800 22:12:15 INFO - PROCESS | 11408 | 22:12:17 INFO - PROCESS | 11408 | Cycle 1(1): loaded http://localhost:47239/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47239/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:12:18 INFO - PROCESS | 11408 | RSS: Main: 148844544 22:12:18 INFO - PROCESS | 11408 | 22:12:20 INFO - PROCESS | 11408 | Cycle 1(1): loaded http://localhost:47239/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:12:21 INFO - PROCESS | 11408 | RSS: Main: 149065728 22:12:21 INFO - PROCESS | 11408 | 22:12:23 INFO - PROCESS | 11408 | Cycle 1(1): loaded http://localhost:47239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:12:24 INFO - PROCESS | 11408 | RSS: Main: 149225472 22:12:24 INFO - PROCESS | 11408 | 22:12:25 INFO - PROCESS | 11408 | Cycle 1(1): loaded http://localhost:47239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47239/tests/kraken/driver.html?testName=ai-astar) 22:12:26 INFO - PROCESS | 11408 | RSS: Main: 149991424 22:12:26 INFO - PROCESS | 11408 | 22:12:26 INFO - PROCESS | 11408 | __start_tp_report 22:12:26 INFO - PROCESS | 11408 | _x_x_mozilla_page_load 22:12:26 INFO - PROCESS | 11408 | _x_x_mozilla_page_load_details 22:12:26 INFO - PROCESS | 11408 | |i|pagename|runs| 22:12:26 INFO - PROCESS | 11408 | |0;ai-astar;114;108;109;110;113;122;110;112;112;111 22:12:26 INFO - PROCESS | 11408 | |1;audio-beat-detection;155;126;148;165;126;149;151;128;165;127 22:12:26 INFO - PROCESS | 11408 | |2;audio-dft;161;162;161;159;162;161;160;163;176;162 22:12:26 INFO - PROCESS | 11408 | |3;audio-fft;70;71;74;74;74;144;71;74;72;72 22:12:26 INFO - PROCESS | 11408 | |4;audio-oscillator;95;96;147;96;97;97;143;96;96;137 22:12:26 INFO - PROCESS | 11408 | |5;imaging-gaussian-blur;110;110;110;110;111;109;110;111;110;109 22:12:26 INFO - PROCESS | 11408 | |6;imaging-darkroom;146;147;147;147;147;147;147;146;146;147 22:12:26 INFO - PROCESS | 11408 | |7;imaging-desaturate;96;96;96;96;96;102;96;96;96;96 22:12:26 INFO - PROCESS | 11408 | |8;json-parse-financial;58;60;58;61;58;60;59;59;62;57 22:12:26 INFO - PROCESS | 11408 | |9;json-stringify-tinderbox;69;68;69;69;69;68;68;68;67;68 22:12:26 INFO - PROCESS | 11408 | |10;stanford-crypto-aes;86;88;85;86;87;86;93;93;87;87 22:12:26 INFO - PROCESS | 11408 | |11;stanford-crypto-ccm;116;118;127;127;127;131;121;132;119;116 22:12:26 INFO - PROCESS | 11408 | |12;stanford-crypto-pbkdf2;155;155;152;156;155;144;154;153;146;147 22:12:26 INFO - PROCESS | 11408 | |13;stanford-crypto-sha256-iterative;70;71;71;70;69;68;68;70;69;68 22:12:26 INFO - PROCESS | 11408 | __end_tp_report 22:12:26 INFO - PROCESS | 11408 | __start_cc_report 22:12:26 INFO - PROCESS | 11408 | _x_x_mozilla_cycle_collect,722 22:12:26 INFO - PROCESS | 11408 | __end_cc_report 22:12:26 INFO - PROCESS | 11408 | __startTimestamp1452060746223__endTimestamp 22:12:26 INFO - PROCESS | 11408 | 22:12:26 INFO - PROCESS | 11408 | ------- Summary: start ------- 22:12:26 INFO - PROCESS | 11408 | Number of tests: 14 22:12:26 INFO - PROCESS | 11408 | 22:12:26 INFO - PROCESS | 11408 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:3.93 (3.5%) stddev-sans-first:4.11 22:12:26 INFO - PROCESS | 11408 | Values: 114.0 108.0 109.0 110.0 113.0 122.0 110.0 112.0 112.0 111.0 22:12:26 INFO - PROCESS | 11408 | 22:12:26 INFO - PROCESS | 11408 | [#1] audio-beat-detection Cycles:10 Average:144.00 Median:150.00 stddev:15.94 (10.6%) stddev-sans-first:16.40 22:12:26 INFO - PROCESS | 11408 | Values: 155.0 126.0 148.0 165.0 126.0 149.0 151.0 128.0 165.0 127.0 22:12:26 INFO - PROCESS | 11408 | 22:12:26 INFO - PROCESS | 11408 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.00 stddev:4.81 (3.0%) stddev-sans-first:5.06 22:12:26 INFO - PROCESS | 11408 | Values: 161.0 162.0 161.0 159.0 162.0 161.0 160.0 163.0 176.0 162.0 22:12:26 INFO - PROCESS | 11408 | 22:12:26 INFO - PROCESS | 11408 | [#3] audio-fft Cycles:10 Average:79.60 Median:73.00 stddev:22.68 (31.1%) stddev-sans-first:23.79 22:12:26 INFO - PROCESS | 11408 | Values: 70.0 71.0 74.0 74.0 74.0 144.0 71.0 74.0 72.0 72.0 22:12:26 INFO - PROCESS | 11408 | 22:12:26 INFO - PROCESS | 11408 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:96.00 stddev:22.44 (23.4%) stddev-sans-first:23.14 22:12:26 INFO - PROCESS | 11408 | Values: 95.0 96.0 147.0 96.0 97.0 97.0 143.0 96.0 96.0 137.0 22:12:26 INFO - PROCESS | 11408 | 22:12:26 INFO - PROCESS | 11408 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 22:12:26 INFO - PROCESS | 11408 | Values: 110.0 110.0 110.0 110.0 111.0 109.0 110.0 111.0 110.0 109.0 22:12:26 INFO - PROCESS | 11408 | 22:12:26 INFO - PROCESS | 11408 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 22:12:26 INFO - PROCESS | 11408 | Values: 146.0 147.0 147.0 147.0 147.0 147.0 147.0 146.0 146.0 147.0 22:12:26 INFO - PROCESS | 11408 | 22:12:26 INFO - PROCESS | 11408 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.00 stddev:1.90 (2.0%) stddev-sans-first:2.00 22:12:26 INFO - PROCESS | 11408 | Values: 96.0 96.0 96.0 96.0 96.0 102.0 96.0 96.0 96.0 96.0 22:12:26 INFO - PROCESS | 11408 | 22:12:26 INFO - PROCESS | 11408 | [#8] json-parse-financial Cycles:10 Average:59.20 Median:59.50 stddev:1.55 (2.6%) stddev-sans-first:1.58 22:12:26 INFO - PROCESS | 11408 | Values: 58.0 60.0 58.0 61.0 58.0 60.0 59.0 59.0 62.0 57.0 22:12:26 INFO - PROCESS | 11408 | 22:12:26 INFO - PROCESS | 11408 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 22:12:26 INFO - PROCESS | 11408 | Values: 69.0 68.0 69.0 69.0 69.0 68.0 68.0 68.0 67.0 68.0 22:12:26 INFO - PROCESS | 11408 | 22:12:26 INFO - PROCESS | 11408 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:87.00 stddev:2.86 (3.3%) stddev-sans-first:2.96 22:12:26 INFO - PROCESS | 11408 | Values: 86.0 88.0 85.0 86.0 87.0 86.0 93.0 93.0 87.0 87.0 22:12:26 INFO - PROCESS | 11408 | 22:12:26 INFO - PROCESS | 11408 | [#11] stanford-crypto-ccm Cycles:10 Average:123.40 Median:127.00 stddev:6.10 (4.8%) stddev-sans-first:5.85 22:12:26 INFO - PROCESS | 11408 | Values: 116.0 118.0 127.0 127.0 127.0 131.0 121.0 132.0 119.0 116.0 22:12:26 INFO - PROCESS | 11408 | 22:12:26 INFO - PROCESS | 11408 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.70 Median:154.50 stddev:4.37 (2.8%) stddev-sans-first:4.47 22:12:26 INFO - PROCESS | 11408 | Values: 155.0 155.0 152.0 156.0 155.0 144.0 154.0 153.0 146.0 147.0 22:12:26 INFO - PROCESS | 11408 | 22:12:26 INFO - PROCESS | 11408 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.00 stddev:1.17 (1.7%) stddev-sans-first:1.22 22:12:26 INFO - PROCESS | 11408 | Values: 70.0 71.0 71.0 70.0 69.0 68.0 68.0 70.0 69.0 68.0 22:12:26 INFO - PROCESS | 11408 | -------- Summary: end -------- 22:12:26 INFO - PROCESS | 11408 | 22:12:27 INFO - TEST-INFO | 11408: exit 0 22:12:27 INFO - TEST-OK | kraken | took 60132ms 22:12:27 INFO - TEST-START | v8_7 22:12:27 INFO - operating with platform_type : linux_ 22:12:27 INFO - Initialising browser for v8_7 test... 22:12:27 INFO - TEST-INFO | started process 11695 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVUzwUx/profile http://localhost:47239/getInfo.html) 22:12:31 INFO - PROCESS | 11695 | __metrics Screen width/height:1600/1200 22:12:31 INFO - PROCESS | 11695 | colorDepth:24 22:12:31 INFO - PROCESS | 11695 | Browser inner width/height: 1024/697 22:12:31 INFO - PROCESS | 11695 | __metrics 22:12:32 INFO - PROCESS | 11695 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:12:33 INFO - TEST-INFO | 11695: exit 0 22:12:33 INFO - Browser initialized. 22:12:33 INFO - Running cycle 1/1 for v8_7 test... 22:12:33 INFO - TEST-INFO | started process 11817 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVUzwUx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:12:44 INFO - PROCESS | 11817 | RSS: Main: 150822912 22:12:44 INFO - PROCESS | 11817 | 22:13:06 INFO - PROCESS | 11817 | Cycle 1(1): loaded http://localhost:47239/tests/v8_7/run.html (next: http://localhost:47239/tests/v8_7/run.html) 22:13:06 INFO - PROCESS | 11817 | RSS: Main: 145764352 22:13:06 INFO - PROCESS | 11817 | 22:13:06 INFO - PROCESS | 11817 | __start_tp_report 22:13:06 INFO - PROCESS | 11817 | _x_x_mozilla_page_load 22:13:06 INFO - PROCESS | 11817 | _x_x_mozilla_page_load_details 22:13:06 INFO - PROCESS | 11817 | |i|pagename|runs| 22:13:06 INFO - PROCESS | 11817 | |0;Richards;166.00265604249668 22:13:06 INFO - PROCESS | 11817 | |1;DeltaBlue;189.8614011771407 22:13:06 INFO - PROCESS | 11817 | |2;Encrypt;281.8489289740699 22:13:06 INFO - PROCESS | 11817 | |3;Decrypt;5291.005291005291 22:13:06 INFO - PROCESS | 11817 | |4;RayTrace;1067.2358591248667 22:13:06 INFO - PROCESS | 11817 | |5;Earley;716.0228898426324 22:13:06 INFO - PROCESS | 11817 | |6;Boyer;12156.626506024097 22:13:06 INFO - PROCESS | 11817 | |7;RegExp;24975.60975609756 22:13:06 INFO - PROCESS | 11817 | |8;Splay;554.6311702717693 22:13:06 INFO - PROCESS | 11817 | |9;NavierStokes;4830.917874396136 22:13:06 INFO - PROCESS | 11817 | __end_tp_report 22:13:06 INFO - PROCESS | 11817 | __startTimestamp1452060786537__endTimestamp 22:13:06 INFO - PROCESS | 11817 | 22:13:06 INFO - PROCESS | 11817 | ------- Summary: start ------- 22:13:06 INFO - PROCESS | 11817 | Number of tests: 10 22:13:06 INFO - PROCESS | 11817 | 22:13:06 INFO - PROCESS | 11817 | [#0] Richards Cycles:1 Average:166.00 Median:166.00 stddev:0.00 (0.0%) 22:13:06 INFO - PROCESS | 11817 | Values: 166.0 22:13:06 INFO - PROCESS | 11817 | 22:13:06 INFO - PROCESS | 11817 | [#1] DeltaBlue Cycles:1 Average:189.86 Median:189.86 stddev:0.00 (0.0%) 22:13:06 INFO - PROCESS | 11817 | Values: 189.9 22:13:06 INFO - PROCESS | 11817 | 22:13:06 INFO - PROCESS | 11817 | [#2] Encrypt Cycles:1 Average:281.85 Median:281.85 stddev:0.00 (0.0%) 22:13:06 INFO - PROCESS | 11817 | Values: 281.8 22:13:06 INFO - PROCESS | 11817 | 22:13:06 INFO - PROCESS | 11817 | [#3] Decrypt Cycles:1 Average:5291.01 Median:5291.01 stddev:0.00 (0.0%) 22:13:06 INFO - PROCESS | 11817 | Values: 5291.0 22:13:06 INFO - PROCESS | 11817 | 22:13:06 INFO - PROCESS | 11817 | [#4] RayTrace Cycles:1 Average:1067.24 Median:1067.24 stddev:0.00 (0.0%) 22:13:06 INFO - PROCESS | 11817 | Values: 1067.2 22:13:06 INFO - PROCESS | 11817 | 22:13:06 INFO - PROCESS | 11817 | [#5] Earley Cycles:1 Average:716.02 Median:716.02 stddev:0.00 (0.0%) 22:13:06 INFO - PROCESS | 11817 | Values: 716.0 22:13:06 INFO - PROCESS | 11817 | 22:13:06 INFO - PROCESS | 11817 | [#6] Boyer Cycles:1 Average:12156.63 Median:12156.63 stddev:0.00 (0.0%) 22:13:06 INFO - PROCESS | 11817 | Values: 12156.6 22:13:06 INFO - PROCESS | 11817 | 22:13:06 INFO - PROCESS | 11817 | [#7] RegExp Cycles:1 Average:24975.61 Median:24975.61 stddev:0.00 (0.0%) 22:13:06 INFO - PROCESS | 11817 | Values: 24975.6 22:13:06 INFO - PROCESS | 11817 | 22:13:06 INFO - PROCESS | 11817 | [#8] Splay Cycles:1 Average:554.63 Median:554.63 stddev:0.00 (0.0%) 22:13:06 INFO - PROCESS | 11817 | Values: 554.6 22:13:06 INFO - PROCESS | 11817 | 22:13:06 INFO - PROCESS | 11817 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 22:13:06 INFO - PROCESS | 11817 | Values: 4830.9 22:13:06 INFO - PROCESS | 11817 | -------- Summary: end -------- 22:13:06 INFO - PROCESS | 11817 | 22:13:07 INFO - TEST-INFO | 11817: exit 0 22:13:07 INFO - TEST-OK | v8_7 | took 40335ms 22:13:07 INFO - SUITE-END | took 1211s 22:13:07 INFO - Completed test suite (00:20:11) 22:13:07 INFO - Working with test: dromaeo_css 22:13:07 INFO - Generating results file: dromaeo_css 22:13:07 INFO - Working with test: kraken 22:13:07 INFO - Generating results file: kraken 22:13:07 INFO - javascript benchmark 22:13:07 INFO - Working with test: v8_7 22:13:07 INFO - Generating results file: v8_7 22:13:07 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:13:07 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 22:13:07 INFO - process_Request line: dromaeo_css 6758.52 graph.html#tests=[[72,1,43]] 22:13:07 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:13:07 INFO - process_Request line: kraken 1521.50 graph.html#tests=[[232,1,43]] 22:13:07 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:13:07 INFO - process_Request line: v8_7 21522.13 graph.html#tests=[[230,1,43]] 22:13:07 INFO - RETURN: dromaeo_css: 6758.52 22:13:07 INFO - RETURN: kraken: 1521.50 22:13:07 INFO - RETURN: v8_7: 21522.13 22:13:07 INFO - javascript benchmark 22:13:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3127.984360078199, 3157.1475701560566, 3175.095097897099, 3179.968200317997, 3181.824999625021, 5274.973625131869, 5349.304590403247, 5361.597880158994, 5375.677459352437, 5376.408595054546, 5333.626646134772, 5352.2239275305155, 5403.027455058088, 5549.223108764776, 5552.139418390146, 4865.708057516552, 4937.037277730844, 4998.5001499849905, 5002.624803139761, 5025.798968041274, 4996.475370086125, 5026.522480364378, 5072.695638261697, 5085.753990272388, 5093.210552364371, 4821.951780482221, 4933.654644174909, 5017.297578339036, 5094.235864620299, 5104.8979020419565, 4880.609551235928, 4993.076280888047, 4999.725015124167, 5005.6996580205305, 5017.54842064216, 4874.561289483963, 4886.022795440926, 4898.4121905371585, 4921.26181072842, 4941.234108713155, 5014.473480284554, 5140.3831540215415, 5191.506806853343, 5200.063988482072, 5248.0, 5641.210230567724, 5729.398413166599, 5812.680302583356, 5820.621659592113, 5875.0, 5908.793192238251, 5921.940780592182, 5933.991221492313, 5945.554083443759, 5946.762129514815, 5370.4361042090795, 5498.972505137449, 5504.091824848895, 5511.944880551183, 5526.309211348582, 5949.732262048218, 5978.491828194652, 5988.760449581968, 6040.063790112539, 6103.206583144251, 5668.886622267614, 5726.770929162787, 5729.713514324267, 5739.081746920473, 5766.913496297559, 5625.943740562542, 5672.517835983905, 5769.423057694197, 5822.155787410802, 5842.707864606753, 5806.129080637854, 5809.564282678732, 5828.417158284137, 5833.270841144857, 5856.677882716492, 5798.33319168301, 5813.244278243801, 5819.098039803753, 5824.88350232993, 5832.854178645568, 4358.6295164911335, 4455.799489023002, 4478.440194975628, 4486.820527178941, 4560.931586026212, 3917.373220284741, 3921.9215615687526, 3941.2117576484243, 3960.2277555876326, 3974.7813870237414, 5360.195970604441, 5381.865453363697, 5386.218998245233, 5389.407165211902, 5393.083175860113, 5662.688552129673, 5768.826935191951, 5831.679257640871, 5943.286805583358, 5954.672493012926, 5404.32445944257, 5423.484768946943, 5430.972845135749, 5436.10304299794, 5448.809291674852, 4928.162212423897, 4937.950620493821, 4943.258511223274, 4951.950480495149, 4974.651774375831, 5912.940870591325, 5928.614640048383, 5998.040313549724, 6043.486303664238, 6057.757689692451, 5790.768369265183, 5796.507296879812, 5803.187553742564, 5833.4749872511675, 5843.678597677169, 5853.853653658693, 5938.910916336345, 6001.549883758823, 6009.098635204754, 6011.27864656244, 5730.684812335195, 5759.164921086335, 5816.854578635399, 5858.5898987070495, 5883.735231914659, 5854.736536855937, 5893.02765043763, 5901.881962360643, 5923.703814809156, 5932.822015339374, 5768.971155144198, 5782.971085144547, 5783.190353350618, 5801.680907549957, 5803.622764520293, 5551.583631227593, 5634.549236061187, 5679.0345641240265, 5746.454086861741, 5771.480566749013, 5602.579806514609, 5618.438156184349, 5633.9295533848435, 5643.661380317194, 5673.432656734293, 5631.352394474524, 5730.799422020209, 5736.483716465538, 5738.426157384228, 5792.0443126885275, 5577.330720313588, 5615.298087739033, 5677.261955945701, 5719.914201287067, 5760.539156867357], "unit": "score", "name": "dojo.html", "value": 5361.201751671292}, {"lowerIsBetter": false, "replicates": [502.1689104531998, 516.220507034378, 532.4515748778757, 540.2058973309239, 543.6004536665552, 34672.4799128013, 35362.82318588404, 35418.8229058855, 35466.0, 35513.289734205304, 38163.61836381636, 38604.420933686015, 38675.41986870192, 38676.41985370222, 38886.0, 8393.412461127724, 8523.616437260338, 8533.871991920127, 8572.014218364906, 8595.054544000155, 8211.302039326665, 8357.58212089393, 8418.284445822112, 8461.576921153948, 8483.0, 8604.354673399488, 8641.827163456726, 8642.438241514314, 8651.437656552303, 8695.304375649934, 8424.705135320264, 8565.443246188977, 8570.742877713647, 8589.785255368603, 8599.312055035582, 8425.74722758312, 8536.018357888797, 8548.615312310962, 8551.358648101355, 8554.315654747668, 39289.41065884014, 39559.40660890089, 39588.80205598954, 39644.40533392001, 39645.0, 3330.8001519908885, 3407.1822762537063, 3541.0793193769546, 3587.94618080729, 3761.6426439488205, 29387.55918661222, 30199.698003020127, 30255.0, 30286.0, 30477.390452190833, 3602.711783057375, 3663.816809159531, 3807.9428808567895, 3824.579296277407, 3845.2693988142164, 251045.0, 252364.73817630977, 253032.0, 253873.0, 254103.0, 51860.0, 52480.73759631254, 56998.43001570014, 58766.41233587695, 59724.10413843796, 51347.74326128345, 51680.74159629178, 51870.22194667083, 51959.74020129875, 51965.22052169221, 14096.295185240697, 14112.647183820487, 14189.929050354682, 14199.148051116967, 14226.28868556568, 11757.529698811952, 11788.410579470992, 11788.528458861721, 11828.76342473163, 11904.642860714192, 19518.414447566596, 19825.909574973513, 19861.30485433003, 19867.821148616153, 19868.403947881587, 7650.655720492591, 7746.496477729042, 7766.262579826302, 7814.413918956101, 7845.37237021037, 868.9913100869037, 899.7300809757047, 914.9359544831798, 973.8101070291367, 1036.6060896859144, 24849.627255591182, 24932.0, 25217.369565760637, 27604.861975689993, 28473.85763071213, 1000.429755039635, 1025.661531694539, 1033.8552602635637, 1040.99479502602, 1118.8209886418133, 13419.155049800755, 14167.433302667983, 14173.78739318911, 14333.354999025069, 14399.78400323996, 290676.0, 292752.0, 293502.0, 293548.0, 294150.0, 49978.75010624924, 50014.499855000984, 50630.24054639183, 50654.49345506498, 50763.23855142176, 1339.5110784563758, 1357.1585616917378, 1357.7895426208954, 1362.0193460708076, 1371.245814801855, 26541.469170616867, 26834.0, 27309.726902731512, 27351.726482734917, 27679.723202767713, 45247.0, 45553.772231139956, 45715.31427028664, 45793.0, 45801.77099114483, 272591.0, 272745.0, 272923.0, 275134.0, 276629.0, 29984.400311994075, 31452.0, 31495.842520788166, 31582.842085789423, 31679.20801979969, 35611.465828012086, 35800.46299305565, 36404.81797590995, 36637.0, 36946.63053369432, 31142.265572380435, 31299.0, 33223.0, 34153.0, 34559.4816077754, 34569.654303457646, 34672.479912801835, 34769.0, 34776.30447390988, 34780.65219347774, 33628.159296017795, 33879.153021174665, 34204.14489637779, 34309.656903430645, 34544.30911381808, 29537.0, 31143.22141946379, 31817.0, 31892.84053579717, 32186.35627287488, 24137.758622413552, 24305.27084187477, 24488.0, 24772.504549909263, 24821.0], "unit": "score", "name": "ext.html", "value": 17675.083165867833}, {"lowerIsBetter": false, "replicates": [341.5900918897322, 344.49187448513436, 345.8772135891758, 346.9930601387971, 347.27246418752736, 16193.0, 16661.916690416547, 17461.563460913483, 17624.55938601534, 18118.728219076726, 10886.61896833611, 10915.890841091586, 11053.778924421507, 11116.11071114311, 11116.944415277912, 4762.738049407281, 4786.138495070886, 4859.927101093486, 4860.222364421676, 4894.241392584137, 4841.709497430148, 4852.539008794177, 4862.270659401101, 4865.0, 4881.243407271879, 3695.8152092395408, 3813.2373525294915, 4817.397825271841, 4820.542048505386, 5239.187925871477, 5335.653182543161, 5374.140137578008, 5397.163439666858, 5407.080796264625, 5408.864778380533, 4790.401199850019, 4958.479359667255, 4965.453800081988, 5158.767855446514, 5198.2722418861385, 11928.642140735705, 12087.516499340016, 12191.817122743167, 12258.08064395174, 12380.319082450462, 1960.5294729265017, 1986.8112529309692, 2025.463252238158, 2066.4007437843006, 2123.309924274617, 9152.17630413266, 10218.846717299246, 10470.42412667303, 12663.493460261578, 12887.613371598867, 1693.0941946058922, 1754.2018381636453, 1781.2963879267745, 1791.838734513887, 1807.788389429409, 60178.69910650419, 62075.6896215516, 62747.6862615684, 63027.36972630261, 63153.68423157855, 9875.308728388944, 10076.899231007596, 10172.847407288897, 10199.337043092175, 10227.539760710786, 13334.333283335794, 13367.46530138803, 13393.732125357634, 13395.933020334836, 13402.530911418053, 7146.32109949554, 7191.64041797908, 7303.7443689471675, 7408.148062972719, 7532.811679708051, 6721.899171512431, 6722.361375669304, 6751.054852320679, 6754.493412994045, 6779.0, 4130.153318569686, 4185.91628167441, 4209.915801683949, 4237.067845074079, 4329.523752387235, 1838.6414649143555, 1863.478226096668, 1876.221368132237, 1900.8669393142347, 1913.7703475583019, 419.6349176216711, 427.5468003915859, 432.5371852118266, 945.2438049560325, 989.0603926270072, 9703.6118555257, 10616.628418005334, 10749.78500429987, 10828.566857325777, 10884.891151088546, 415.66746602717706, 428.26124934487757, 445.6768842589097, 450.0908165505726, 461.42552522109514, 5816.098504731774, 5949.286085669747, 5972.402759723993, 5984.491318237911, 6036.547258955596, 390657.0, 396173.0, 396547.0, 402314.0, 555453.0, 40721.38917916234, 40740.592594074275, 43192.0, 72310.0, 79603.60198198972, 1131.971700707489, 1143.6454699043322, 1143.9542418303174, 1169.0997931592626, 1169.713210673132, 15640.608984775017, 15641.296141673425, 15757.290921908312, 15872.20638968024, 15927.920360398124, 35373.82313088418, 35508.0, 35894.102647434025, 36204.81897590495, 36348.454773177895, 46442.76778616085, 46726.0, 46761.06477870492, 48154.51845481501, 48238.51761482481, 9145.039770823967, 9267.953660231655, 9352.625894964125, 9364.157225849705, 9442.81114377695, 11077.723056923642, 11169.273997190481, 11221.775564488828, 11290.266132701348, 11329.150313726668, 10763.730906727395, 12670.619881403572, 13830.308484575933, 14323.14061156334, 14359.851211903231, 13371.465141394236, 13485.457495943077, 13554.322283885964, 13835.239061851695, 14324.0, 13181.736365272833, 13298.202107873558, 13547.525836595672, 14224.502142424966, 14240.643983900485, 9037.593308301273, 9170.908290917272, 9184.816303674022, 9206.585703643219, 9213.447193168431, 10586.258961872903, 13916.304184790923, 14096.08375455592, 14100.153990760587, 14136.363863626368], "unit": "score", "name": "jquery.html", "value": 7786.729050187436}, {"lowerIsBetter": false, "replicates": [1421.6730152065024, 1422.6941207640355, 1426.5961854275547, 1442.199579233525, 1445.9638509037266, 6382.138411314471, 6457.192850893638, 7068.717251309948, 7188.496805223636, 7224.638768061595, 6792.898106528393, 6910.516263861532, 6941.54879932804, 6963.582185068887, 7008.789736307906, 2180.3458962311324, 2203.55928814237, 2224.2993457060975, 2229.977700223001, 2242.932712018634, 2231.0518029837335, 2240.092762431218, 2288.1305104060434, 2291.5760584291875, 2294.6328587426015, 2206.227820262903, 2222.5665995130958, 2229.2754854672216, 2229.7993180613744, 2245.62947113726, 2194.5940001099766, 2205.3163519309064, 2221.2336743823435, 2225.321277010511, 2229.851626412399, 2258.1983395894385, 2283.8287128465267, 2285.1887579909226, 2292.85096468729, 2293.908243670251, 7186.6704659638135, 7231.529950553249, 7240.818979525501, 7247.347738703542, 7267.273272672691, 4508.909821803579, 4550.8862278442975, 4565.269556870885, 4570.588647021751, 4585.885352866172, 2886.1774394297736, 2990.790644654853, 2997.0, 3011.337505748732, 3014.4573976684187, 919.954002299889, 938.4228699349919, 942.1520631431698, 948.7580666929957, 967.970960871175, 9603.087706667855, 9697.981711920218, 9744.707658770178, 9749.0, 9758.658446954394, 4090.365993271048, 4103.138340948374, 4136.544980052192, 4146.771927543954, 4149.356849688304, 8292.460990035628, 8349.123342049119, 8350.62422191003, 8351.791205219797, 8361.498310101291, 4532.4334458192725, 4534.115847409724, 4539.182947069559, 4540.954590454053, 4558.1795276849825, 4042.939355909664, 4046.858359957387, 4051.331530297527, 4164.187983343219, 4168.353905144708, 3306.6858648428843, 3312.850921708529, 3338.983305083459, 3355.597328320617, 3388.881389151368, 1075.9515821788038, 1083.6803143072812, 1085.6634443322596, 1085.7502774361942, 1095.27164435651, 1243.583399561139, 1254.2286493806243, 1261.186534685123, 1308.339288659221, 1308.5158491358259, 6534.411902928759, 6665.966670166618, 6697.497687673444, 6714.227863795629, 6723.7646682365885, 466.8482743108435, 470.88698712309485, 472.357593672605, 477.0839987224537, 481.1819906159543, 5274.498922602346, 5285.920711189336, 5295.682259064469, 5317.494837990384, 5331.760070796823, 8352.707655232038, 8399.706010289732, 8583.785405364792, 8618.095100014409, 8628.697995570124, 8468.32253419725, 8529.061803201643, 8534.53060081689, 8570.74287771368, 8624.482531048157, 6533.085368048477, 6575.276719560845, 6812.62530560814, 6853.280405557444, 6915.343042410963, 6660.300668429939, 6679.966600166968, 6705.8323541909895, 6720.126383570105, 6755.05429239897, 7442.962785186256, 7598.354139898171, 7617.733379331697, 7747.070351557849, 7798.376129909707, 7680.5391676499585, 7813.0, 7840.921590784019, 7872.0, 7892.131865494676, 6074.51403887679, 6176.907346389898, 6365.649889256136, 6556.901646475402, 6567.704453299518, 6850.520463567503, 6868.210155832143, 6889.069975553236, 6903.482238832208, 6907.481938854707, 6376.202974628171, 6505.154329937078, 6578.407943285128, 6586.37429444202, 6595.835104122435, 6033.42682445167, 6111.633302001894, 6148.16999705052, 6258.718357674006, 6418.614883107029, 6377.0753240778895, 6426.100345951664, 6438.871222575616, 6459.61242325462, 6469.385408386196, 5534.391216966211, 5578.581606379456, 5598.832035038955, 5611.354694210218, 5613.298337707786, 5838.32859221195, 6013.6692481913915, 6022.126791615104, 6074.3925607438905, 6086.239220097488], "unit": "score", "name": "mootools.html", "value": 4113.379515066029}, {"lowerIsBetter": false, "replicates": [323.08566756080296, 325.0946115069532, 329.1491494486752, 334.0296438845154, 334.6235485079286, 6149.077638354249, 6254.84362890928, 6257.342978987209, 6271.027990661443, 6344.619322840633, 6138.14066030756, 6187.0719392091205, 6236.656983865897, 6237.5009999200065, 6259.374062593738, 4772.546608072236, 4790.54489823468, 4794.304825800257, 4797.2324428091515, 4804.207305794557, 4771.284307353907, 4790.496997815231, 4792.424909010923, 4798.808047678089, 4803.1114243864995, 4685.789139488714, 4742.762861856911, 4751.429828420577, 4767.213409787381, 4773.498782627808, 4730.219513780222, 4746.264329029006, 4752.12085764133, 4753.191957367256, 4756.548127927841, 4149.481314835645, 4161.854335098257, 4166.291730405808, 4174.686898482626, 4176.164767046603, 5934.109883517507, 5936.050231962909, 5938.138969849391, 5945.048792193228, 5952.970235148797, 5466.699331536764, 5565.833025009256, 5569.0, 5571.582131340166, 5578.665280083208, 6612.900806487906, 6642.0, 6654.633995130266, 6658.300878407746, 6662.7334906604165, 4580.7938642761155, 4596.126735920165, 4598.540145985408, 4608.792604332813, 4615.561521655437, 6765.154355705537, 6948.965255173692, 6968.128983877015, 6969.372756451944, 6974.721011159548, 4739.028499157734, 4745.786439610157, 4748.074125545486, 4751.049790042005, 4755.548222918817, 4782.139214941274, 4815.133276010281, 4815.975920120377, 4816.8554943351755, 4822.0, 5558.249636299048, 5562.082256427644, 5562.276904002454, 5562.276904002454, 5563.860903477364, 6599.70301336441, 6685.76599819004, 6719.428848547928, 6720.899186512206, 6731.293214212437, 1614.701280263155, 1655.983440165607, 1659.585103724069, 1664.5672125247281, 1689.4509284482592, 1087.4671411008549, 1089.199438412766, 1100.5212732461405, 1103.45379037377, 1111.4609414433994, 6163.753449862045, 6214.751409943642, 6228.906566401508, 6265.467435267962, 6277.089821975879, 6829.214640316427, 6829.385355318045, 6840.452763778886, 6841.418479429205, 6848.6918088686125, 6109.77804439114, 6208.348123446973, 6228.688565571703, 6230.408111229426, 6247.843803904848, 3679.4296883983025, 3727.993441770761, 3728.6457786510236, 3730.347189241926, 3730.720195985312, 7037.331453511908, 7082.964585177041, 7119.67961441726, 7140.642967851691, 7141.642917854087, 6923.2038315593345, 7012.263712310134, 7034.296570343027, 7046.0, 7056.823579410556, 7136.928630713626, 7291.125064992235, 7295.70817167318, 7303.926960730431, 7305.671244794104, 6973.65131743421, 6984.301569842975, 6988.440924726111, 6989.0, 6993.055937448379, 6829.89755153683, 6896.0, 6909.723611055501, 6922.10012698346, 6931.341522555349, 7215.855682886207, 7227.674754636159, 7233.819154521179, 7269.818254543678, 7274.418046556369, 4616.215243408696, 4661.557152070548, 4665.790039448301, 4668.7665616719705, 4677.2750223715375, 6752.898706519308, 6938.202106757787, 6967.756128535477, 6980.6509674515055, 6993.985872048423, 6757.93242067573, 6778.627175505198, 6779.72881084751, 6835.316468353125, 6842.178938527409, 6791.252962174256, 6792.252852186157, 6793.354631310018, 6802.897956530557, 6809.21694005176, 6525.771597994048, 6616.2391324996315, 6646.235682896336, 6653.135092438146, 6674.566153200027, 6734.73061077571, 6782.796516104525, 6786.457083433214, 6835.69239384219, 6845.794626161223, 6615.636140012345, 6642.535022548375, 6650.73397064112, 6650.935850264128, 6656.0], "unit": "score", "name": "prototype.html", "value": 5017.8502770484565}, {"lowerIsBetter": false, "replicates": [791.0941971442702, 794.9125596184418, 797.7686470923433, 809.4900212865894, 833.8040560468289, 13676.863231367683, 13975.930120349409, 13977.79033314501, 14023.999999999987, 14034.228117453536, 12719.36403179842, 12793.0, 12872.356382180877, 12902.22586644802, 12905.741885162292, 789.4473868292204, 804.8309854930471, 805.114374188394, 824.47233770387, 825.3809642767924, 807.4307613132756, 823.7199352220244, 824.7979245084963, 830.4353039932844, 831.0193971114084, 832.7668252889171, 855.7304449098546, 860.8407444622734, 861.7974775927684, 861.8233262181237, 834.5326617094416, 847.9830403391898, 851.5274022917279, 853.4665833853873, 855.0167307596251, 618.0543768034913, 619.4301242856583, 625.9155014073133, 626.9561130720851, 626.9999351035092, 13580.728385432334, 13632.113912595749, 13646.181229126285, 13676.0, 13700.0, 12231.204971676812, 12322.691932701664, 12406.937965310206, 12598.68503287416, 13184.472621095145, 9343.439393636403, 9466.90533094667, 9588.616455341778, 9645.228381729516, 9717.514124293757, 3475.7045651119683, 3493.8951831445097, 3513.7364697647777, 3517.8592856285973, 3523.982380088083, 49240.0, 49315.26027109596, 50708.0, 50823.0, 50993.49006509924, 9439.858402123973, 9453.291003174652, 9549.713508594754, 9613.086756758097, 9634.807303853884, 17789.288428462976, 17825.46523604294, 17947.551311217063, 17994.5501362467, 17994.820051799576, 7346.302101300368, 7478.878168274802, 7587.810304742426, 7704.768856934301, 7811.101723301779, 4232.195882782262, 4315.5900189481945, 4394.934075988863, 4402.889927751832, 4435.911281774346, 3075.815451072943, 3082.2756652186717, 3090.9227269318, 3096.9535456968165, 3100.860461279203, 566.4165909113619, 576.3084298841408, 587.6033677267827, 595.8838026584774, 600.1417972299654, 541.5748637319685, 571.3001573072952, 664.6145235763246, 687.9096631838592, 707.9610621415871, 8097.676092956333, 8173.34613230952, 8317.792055198668, 8354.498730076215, 8380.748577542683, 521.119308368863, 538.4776766536453, 604.320139842677, 629.559308484063, 662.6322391072904, 3732.869349572752, 3878.864239751595, 3994.2211268802885, 3999.6200360965663, 4019.879403617896, 54194.72902635462, 54969.1754623681, 55372.0, 55662.0, 55852.0, 47727.28409073866, 47887.76056119697, 48378.0, 48500.27249591259, 48932.26601600979, 44772.10455790931, 45600.7719961398, 46000.539994599625, 46104.308435373496, 46219.306710399374, 7875.291223789886, 7945.920540794749, 8117.188281171835, 8384.203500667427, 8486.61810218554, 33435.66564334326, 33652.326953461285, 34331.82834085914, 34949.47575786416, 35044.82477587596, 42461.363079553215, 43075.0, 43098.78450607727, 43114.353284701385, 43897.34153987629, 10814.405207713651, 11113.666590002313, 11302.0, 11318.32090074598, 11545.307281563133, 12226.938865305616, 12267.938660306641, 12392.876071239532, 12504.937475312929, 12508.437120329425, 11681.766364672829, 11684.649460516199, 11910.285382877055, 12164.330961797186, 12251.571195008131, 11038.392888390894, 11082.113430925669, 11180.720481988015, 11342.20604557673, 11686.04910880462, 11756.764864702829, 11757.059435244988, 11812.350320732443, 12109.818352724893, 12145.878541214475, 9657.517124143906, 9756.219502439646, 9841.655542055994, 9895.786497207157, 10035.19718422539, 8772.38593298463, 8987.370884038317, 9309.44143351401, 9328.766780830534, 9796.853047204155], "unit": "score", "name": "yui.html", "value": 6257.159395745579}], "name": "dromaeo_css", "value": 6758.520220095685}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 108.0, 109.0, 110.0, 113.0, 122.0, 110.0, 112.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.1}, {"lowerIsBetter": true, "replicates": [155.0, 126.0, 148.0, 165.0, 126.0, 149.0, 151.0, 128.0, 165.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 144.0}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 159.0, 162.0, 161.0, 160.0, 163.0, 176.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.7}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 74.0, 74.0, 74.0, 144.0, 71.0, 74.0, 72.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 147.0, 96.0, 97.0, 97.0, 143.0, 96.0, 96.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 111.0, 109.0, 110.0, 111.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 102.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [58.0, 60.0, 58.0, 61.0, 58.0, 60.0, 59.0, 59.0, 62.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.2}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 69.0, 69.0, 69.0, 68.0, 68.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [86.0, 88.0, 85.0, 86.0, 87.0, 86.0, 93.0, 93.0, 87.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.8}, {"lowerIsBetter": true, "replicates": [116.0, 118.0, 127.0, 127.0, 127.0, 131.0, 121.0, 132.0, 119.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.4}, {"lowerIsBetter": true, "replicates": [155.0, 155.0, 152.0, 156.0, 155.0, 144.0, 154.0, 153.0, 146.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.7}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 71.0, 70.0, 69.0, 68.0, 68.0, 70.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1521.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.00265604249668], "unit": "score", "name": "Richards", "value": 212.659248}, {"lowerIsBetter": false, "replicates": [189.8614011771407], "unit": "score", "name": "DeltaBlue", "value": 348.24350599999997}, {"lowerIsBetter": false, "replicates": [281.8489289740699], "unit": "score", "name": "Encrypt", "value": 944.410188}, {"lowerIsBetter": false, "replicates": [5291.005291005291], "unit": "score", "name": "Decrypt", "value": 50.30820900000001}, {"lowerIsBetter": false, "replicates": [1067.2358591248667], "unit": "score", "name": "RayTrace", "value": 693.3696929999998}, {"lowerIsBetter": false, "replicates": [716.0228898426324], "unit": "score", "name": "Earley", "value": 930.7844895104892}, {"lowerIsBetter": false, "replicates": [12156.626506024097], "unit": "score", "name": "Boyer", "value": 54.82302180376615}, {"lowerIsBetter": false, "replicates": [24975.60975609756], "unit": "score", "name": "RegExp", "value": 36.47498535156248}, {"lowerIsBetter": false, "replicates": [554.6311702717693], "unit": "score", "name": "Splay", "value": 146.92827300000002}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21522.13192051574}]} 22:13:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21522.13"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1521.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6758.52"}}} 22:13:07 INFO - Return code: 0 22:13:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:13:07 INFO - # TBPL SUCCESS # 22:13:07 INFO - Running post-action listener: _resource_record_post_action 22:13:07 INFO - Running post-run listener: _resource_record_post_run 22:13:08 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 557441024; Read time: 0; Write time: 975916 22:13:08 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 238649344; Read time: 0; Write time: 562224 22:13:08 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 318574592; Read time: 0; Write time: 413692 22:13:08 INFO - Running post-run listener: _upload_blobber_files 22:13:08 INFO - Blob upload gear active. 22:13:08 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:13:08 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 22:13:08 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'] 22:13:08 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 22:13:40 INFO - (blobuploader) - INFO - Open directory for files ... 22:13:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:13:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:13:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:13:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:13:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:13:41 INFO - (blobuploader) - INFO - Done attempting. 22:13:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:13:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:13:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:13:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:13:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:13:42 INFO - (blobuploader) - INFO - Done attempting. 22:13:42 INFO - (blobuploader) - INFO - Iteration through files over. 22:13:42 INFO - Return code: 0 22:13:42 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:13:42 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:13:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c099f17c207525c95361c73c4a427aa4452c75cced03d453ca1a0ff71977e9a01f3d2a939ddbfb7e9b96cf38ec6d6ede6757a385e547f3667cfcd7ddac025f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b937249f7fe6791fe9fb2a89d3aaa6f04f8d34899aaca73054afaafd26f1e217e606291b23d408a4e72d513e4c304a4cdb1fd1b07085f0f4c784d7c6119be2c"} 22:13:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:13:42 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:13:42 INFO - Contents: 22:13:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c099f17c207525c95361c73c4a427aa4452c75cced03d453ca1a0ff71977e9a01f3d2a939ddbfb7e9b96cf38ec6d6ede6757a385e547f3667cfcd7ddac025f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b937249f7fe6791fe9fb2a89d3aaa6f04f8d34899aaca73054afaafd26f1e217e606291b23d408a4e72d513e4c304a4cdb1fd1b07085f0f4c784d7c6119be2c"} 22:13:42 INFO - Copying logs to upload dir... 22:13:42 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1310.637254 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 50 secs) (at 2016-01-05 22:13:41.778689) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 22:13:41.784913) ========= 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=8783db0840cc980e80bb0bd400000236-1452054080.303350-1291974514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c099f17c207525c95361c73c4a427aa4452c75cced03d453ca1a0ff71977e9a01f3d2a939ddbfb7e9b96cf38ec6d6ede6757a385e547f3667cfcd7ddac025f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b937249f7fe6791fe9fb2a89d3aaa6f04f8d34899aaca73054afaafd26f1e217e606291b23d408a4e72d513e4c304a4cdb1fd1b07085f0f4c784d7c6119be2c"} build_url:https://queue.taskcluster.net/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011373 build_url: 'https://queue.taskcluster.net/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c099f17c207525c95361c73c4a427aa4452c75cced03d453ca1a0ff71977e9a01f3d2a939ddbfb7e9b96cf38ec6d6ede6757a385e547f3667cfcd7ddac025f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b937249f7fe6791fe9fb2a89d3aaa6f04f8d34899aaca73054afaafd26f1e217e606291b23d408a4e72d513e4c304a4cdb1fd1b07085f0f4c784d7c6119be2c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 22:13:41.809647) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:13:41.809975) ========= 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=8783db0840cc980e80bb0bd400000236-1452054080.303350-1291974514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:13:41.893546) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 22:13:41.893907) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 22:13:41.894282) ========= ========= Total master_lag: 0.27 =========