builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-008 starttime: 1452383246.63 results: success (0) buildid: 20160109133014 builduid: c11aa47d691f4819be32df7a88673234 revision: c33f30666b37dbceffb9fbe5089a668db8893a85 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-09 15:47:26.633283) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-09 15:47:26.633729) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-09 15:47:26.634027) ========= 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=32c5991c409366f7fec8a718000001d2-1452383247.284149-955829352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006211 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-09 15:47:26.656825) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-09 15:47:26.657215) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-09 15:47:26.769153) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 15:47:26.769486) ========= 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=32c5991c409366f7fec8a718000001d2-1452383247.284149-955829352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004554 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 15:47:26.865258) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-09 15:47:26.865533) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-09 15:47:26.865881) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 15:47:26.866155) ========= 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=32c5991c409366f7fec8a718000001d2-1452383247.284149-955829352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-09 15:47:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 217M=0s 2016-01-09 15:47:28 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177513 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 15:47:27.085551) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 15:47:27.085838) ========= 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=32c5991c409366f7fec8a718000001d2-1452383247.284149-955829352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017209 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 15:47:27.144495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 15:47:27.144802) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c33f30666b37dbceffb9fbe5089a668db8893a85 --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 c33f30666b37dbceffb9fbe5089a668db8893a85 --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=32c5991c409366f7fec8a718000001d2-1452383247.284149-955829352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-09 15:47:28,586 truncating revision to first 12 chars 2016-01-09 15:47:28,587 Setting DEBUG logging. 2016-01-09 15:47:28,587 attempt 1/10 2016-01-09 15:47:28,587 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c33f30666b37?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-09 15:47:28,829 unpacking tar archive at: mozilla-central-c33f30666b37/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545167 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 15:47:27.711259) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-09 15:47:27.711560) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-09 15:47:27.723680) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-09 15:47:27.723945) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-09 15:47:27.724611) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-09 15:47:27.724897) ========= /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=32c5991c409366f7fec8a718000001d2-1452383247.284149-955829352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:47:29 INFO - MultiFileLogger online at 20160109 15:47:29 in /builds/slave/test-pgo 15:47:29 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 15:47:29 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:47:29 INFO - {'append_to_log': False, 15:47:29 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:47:29 INFO - 'blob_upload_branch': 'Firefox', 15:47:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:47:29 INFO - 'branch': 'Firefox', 15:47:29 INFO - 'buildbot_json_path': 'buildprops.json', 15:47:29 INFO - 'config_files': ('talos/linux_config.py',), 15:47:29 INFO - 'default_actions': ('clobber', 15:47:29 INFO - 'read-buildbot-config', 15:47:29 INFO - 'download-and-extract', 15:47:29 INFO - 'populate-webroot', 15:47:29 INFO - 'create-virtualenv', 15:47:29 INFO - 'install', 15:47:29 INFO - 'run-tests'), 15:47:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:47:29 INFO - 'download_minidump_stackwalk': True, 15:47:29 INFO - 'download_symbols': 'ondemand', 15:47:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:47:29 INFO - 'tooltool.py': '/tools/tooltool.py', 15:47:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:47:29 INFO - '/tools/misc-python/virtualenv.py')}, 15:47:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:47:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:47:29 INFO - 'installer_path': 'installer.exe', 15:47:29 INFO - 'log_level': 'info', 15:47:29 INFO - 'log_name': 'talos', 15:47:29 INFO - 'log_to_console': True, 15:47:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:47:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:47:29 INFO - 'opt_config_files': (), 15:47:29 INFO - 'pip_index': False, 15:47:29 INFO - 'sps_profile': False, 15:47:29 INFO - 'sps_profile_interval': 0, 15:47:29 INFO - 'suite': 'dromaeojs-e10s', 15:47:29 INFO - 'system_bits': '32', 15:47:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:47:29 INFO - 'title': 'talos-linux64-ix-008', 15:47:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:47:29 INFO - 'use_talos_json': True, 15:47:29 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:47:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:47:29 INFO - 'work_dir': 'build'} 15:47:29 INFO - ##### 15:47:29 INFO - ##### Running clobber step. 15:47:29 INFO - ##### 15:47:29 INFO - Running pre-action listener: _resource_record_pre_action 15:47:29 INFO - Running main action method: clobber 15:47:29 INFO - rmtree: /builds/slave/test-pgo/build 15:47:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:47:30 INFO - Running post-action listener: _resource_record_post_action 15:47:30 INFO - ##### 15:47:30 INFO - ##### Running read-buildbot-config step. 15:47:30 INFO - ##### 15:47:30 INFO - Running pre-action listener: _resource_record_pre_action 15:47:30 INFO - Running main action method: read_buildbot_config 15:47:30 INFO - Using buildbot properties: 15:47:30 INFO - { 15:47:30 INFO - "project": "", 15:47:30 INFO - "product": "firefox", 15:47:30 INFO - "script_repo_revision": "production", 15:47:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:47:30 INFO - "repository": "", 15:47:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 15:47:30 INFO - "buildid": "20160109133014", 15:47:30 INFO - "pgo_build": "True", 15:47:30 INFO - "basedir": "/builds/slave/test-pgo", 15:47:30 INFO - "buildnumber": 296, 15:47:30 INFO - "slavename": "talos-linux64-ix-008", 15:47:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:47:30 INFO - "platform": "ubuntu64_hw", 15:47:30 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 15:47:30 INFO - "branch": "mozilla-central", 15:47:30 INFO - "repo_path": "mozilla-central", 15:47:30 INFO - "revision": "c33f30666b37dbceffb9fbe5089a668db8893a85", 15:47:30 INFO - "stage_platform": "linux64-pgo", 15:47:30 INFO - "builduid": "c11aa47d691f4819be32df7a88673234", 15:47:30 INFO - "slavebuilddir": "test" 15:47:30 INFO - } 15:47:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/C1Jw8qSZQJODDUFi1LFjmg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 15:47:30 INFO - Running post-action listener: _resource_record_post_action 15:47:30 INFO - ##### 15:47:30 INFO - ##### Running download-and-extract step. 15:47:30 INFO - ##### 15:47:30 INFO - Running pre-action listener: _resource_record_pre_action 15:47:30 INFO - Running main action method: download_and_extract 15:47:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:30 INFO - https://queue.taskcluster.net/v1/task/C1Jw8qSZQJODDUFi1LFjmg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:47:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1Jw8qSZQJODDUFi1LFjmg/artifacts/public/build/test_packages.json 15:47:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1Jw8qSZQJODDUFi1LFjmg/artifacts/public/build/test_packages.json 15:47:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1Jw8qSZQJODDUFi1LFjmg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:47:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1Jw8qSZQJODDUFi1LFjmg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:47:38 INFO - Downloaded 1302 bytes. 15:47:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:47:38 INFO - Using the following test package requirements: 15:47:38 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:47:38 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:47:38 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:38 INFO - u'jsshell-linux-x86_64.zip'], 15:47:38 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:47:38 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:47:38 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:47:38 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:47:38 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:47:38 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:47:38 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:47:38 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:38 INFO - https://queue.taskcluster.net/v1/task/C1Jw8qSZQJODDUFi1LFjmg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:47:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1Jw8qSZQJODDUFi1LFjmg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:47:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1Jw8qSZQJODDUFi1LFjmg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:47:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1Jw8qSZQJODDUFi1LFjmg/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 15:47:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1Jw8qSZQJODDUFi1LFjmg/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 15:47:39 INFO - Downloaded 24028275 bytes. 15:47:39 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 15:47:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:47:39 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 15:47:41 INFO - Return code: 0 15:47:41 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 15:47:41 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')]} 15:47:41 INFO - https://queue.taskcluster.net/v1/task/C1Jw8qSZQJODDUFi1LFjmg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:47:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1Jw8qSZQJODDUFi1LFjmg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:47:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1Jw8qSZQJODDUFi1LFjmg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:47:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1Jw8qSZQJODDUFi1LFjmg/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 15:47:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1Jw8qSZQJODDUFi1LFjmg/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 15:47:44 INFO - Downloaded 24028275 bytes. 15:47:44 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 15:47:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:47:44 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 15:47:45 INFO - Return code: 0 15:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:45 INFO - https://queue.taskcluster.net/v1/task/C1Jw8qSZQJODDUFi1LFjmg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:47:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1Jw8qSZQJODDUFi1LFjmg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:47:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1Jw8qSZQJODDUFi1LFjmg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:47:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1Jw8qSZQJODDUFi1LFjmg/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 15:47:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1Jw8qSZQJODDUFi1LFjmg/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 15:47:47 INFO - Downloaded 11132285 bytes. 15:47:47 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 15:47:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:47:47 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 15:47:47 INFO - Return code: 0 15:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:47 INFO - https://queue.taskcluster.net/v1/task/C1Jw8qSZQJODDUFi1LFjmg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:47:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1Jw8qSZQJODDUFi1LFjmg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:47:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1Jw8qSZQJODDUFi1LFjmg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:47:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1Jw8qSZQJODDUFi1LFjmg/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 15:47:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C1Jw8qSZQJODDUFi1LFjmg/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 15:47:48 INFO - Downloaded 55923947 bytes. 15:47:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C1Jw8qSZQJODDUFi1LFjmg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:47:48 INFO - mkdir: /builds/slave/test-pgo/properties 15:47:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:47:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:47:48 INFO - Contents: 15:47:48 INFO - build_url:https://queue.taskcluster.net/v1/task/C1Jw8qSZQJODDUFi1LFjmg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:47:48 INFO - Running post-action listener: _resource_record_post_action 15:47:48 INFO - Running post-action listener: set_extra_try_arguments 15:47:48 INFO - ##### 15:47:48 INFO - ##### Running populate-webroot step. 15:47:48 INFO - ##### 15:47:48 INFO - Running pre-action listener: _resource_record_pre_action 15:47:48 INFO - Running main action method: populate_webroot 15:47:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:47:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:47:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:47:48 INFO - '--tppagecycles', 15:47:48 INFO - '7'], 15:47:48 INFO - 'tests': ['tsvgm']}}, 15:47:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:47:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:47:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:47:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:47:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:47:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:47:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:47:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:48 INFO - 'talos_options': ['--e10s'], 15:47:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:47:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:48 INFO - 'tests': ['damp', 'tps']}, 15:47:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:48 INFO - 'talos_options': ['--e10s'], 15:47:48 INFO - 'tests': ['damp', 'tps']}, 15:47:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:47:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:47:48 INFO - 'other': {'tests': ['a11yr', 15:47:48 INFO - 'ts_paint', 15:47:48 INFO - 'tpaint', 15:47:48 INFO - 'sessionrestore', 15:47:48 INFO - 'sessionrestore_no_auto_restore']}, 15:47:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:47:48 INFO - 'tests': ['a11yr', 15:47:48 INFO - 'ts_paint', 15:47:48 INFO - 'tpaint', 15:47:48 INFO - 'sessionrestore', 15:47:48 INFO - 'sessionrestore_no_auto_restore']}, 15:47:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:47:48 INFO - 'tests': ['a11yr', 15:47:48 INFO - 'ts_paint', 15:47:48 INFO - 'tpaint', 15:47:48 INFO - 'sessionrestore', 15:47:48 INFO - 'sessionrestore_no_auto_restore']}, 15:47:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:47:48 INFO - 'tests': ['a11yr', 15:47:48 INFO - 'ts_paint', 15:47:48 INFO - 'tpaint', 15:47:48 INFO - 'sessionrestore', 15:47:48 INFO - 'sessionrestore_no_auto_restore']}, 15:47:48 INFO - 'other_l64': {'tests': ['a11yr', 15:47:48 INFO - 'ts_paint', 15:47:48 INFO - 'tpaint', 15:47:48 INFO - 'sessionrestore', 15:47:48 INFO - 'sessionrestore_no_auto_restore']}, 15:47:48 INFO - 'other_nol64': {'tests': ['a11yr', 15:47:48 INFO - 'ts_paint', 15:47:48 INFO - 'tpaint', 15:47:48 INFO - 'sessionrestore', 15:47:48 INFO - 'sessionrestore_no_auto_restore']}, 15:47:48 INFO - 'svgr': {'tests': ['tsvgx', 15:47:48 INFO - 'tsvgr_opacity', 15:47:48 INFO - 'tart', 15:47:48 INFO - 'tscrollx', 15:47:48 INFO - 'cart']}, 15:47:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:47:48 INFO - 'tests': ['tsvgx', 15:47:48 INFO - 'tsvgr_opacity', 15:47:48 INFO - 'tart', 15:47:48 INFO - 'tscrollx', 15:47:48 INFO - 'cart']}, 15:47:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:48 INFO - 'tests': ['tp5o']}, 15:47:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:48 INFO - 'talos_options': ['--e10s'], 15:47:48 INFO - 'tests': ['tp5o']}, 15:47:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:48 INFO - 'talos_options': ['--xperf_path', 15:47:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:47:48 INFO - 'tests': ['tp5n']}, 15:47:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:48 INFO - 'talos_options': ['--e10s', 15:47:48 INFO - '--xperf_path', 15:47:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:47:48 INFO - 'tests': ['tp5n']}}, 15:47:48 INFO - 'talos.zip': {'path': '', 15:47:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:47:48 INFO - Running post-action listener: _resource_record_post_action 15:47:48 INFO - ##### 15:47:48 INFO - ##### Running create-virtualenv step. 15:47:48 INFO - ##### 15:47:48 INFO - Running pre-action listener: _resource_record_pre_action 15:47:48 INFO - Running main action method: create_virtualenv 15:47:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:47:48 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 15:47:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:47:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:47:48 INFO - Using real prefix '/usr' 15:47:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:47:49 INFO - Installing distribute.............................................................................................................................................................................................done. 15:47:51 INFO - Installing pip.................done. 15:47:51 INFO - Return code: 0 15:47:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:47:51 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')]} 15:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:51 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')]} 15:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:51 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 0x7f2207614f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1668660>, '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 0x1669560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1669a10>, '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': '32c5991c409366f7fec8a718000001d2-1452383247.284149-955829352', '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 15:47:51 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 15:47:51 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 15:47:51 INFO - Using env: {'DISPLAY': ':0', 15:47:51 INFO - 'HOME': '/home/cltbld', 15:47:51 INFO - 'LANG': 'en_US.UTF-8', 15:47:51 INFO - 'LANGUAGE': 'en_US:en', 15:47:51 INFO - 'LOGNAME': 'cltbld', 15:47:51 INFO - 'MAIL': '/var/mail/cltbld', 15:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:51 INFO - 'MOZ_NO_REMOTE': '1', 15:47:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:51 INFO - 'NO_EM_RESTART': '1', 15:47:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:51 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:51 INFO - 'SHELL': '/bin/bash', 15:47:51 INFO - 'SHLVL': '1', 15:47:51 INFO - 'TERM': 'linux', 15:47:51 INFO - 'TMOUT': '86400', 15:47:51 INFO - 'USER': 'cltbld', 15:47:51 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452383247.284149-955829352', 15:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:51 INFO - '_': '/tools/buildbot/bin/python'} 15:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:51 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 15:47:51 INFO - Cleaning up... 15:47:51 INFO - Return code: 0 15:47:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:47:51 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')]} 15:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:51 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')]} 15:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:51 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 0x7f2207614f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1668660>, '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 0x1669560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1669a10>, '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': '32c5991c409366f7fec8a718000001d2-1452383247.284149-955829352', '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 15:47:51 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 15:47:51 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 15:47:51 INFO - Using env: {'DISPLAY': ':0', 15:47:51 INFO - 'HOME': '/home/cltbld', 15:47:51 INFO - 'LANG': 'en_US.UTF-8', 15:47:51 INFO - 'LANGUAGE': 'en_US:en', 15:47:51 INFO - 'LOGNAME': 'cltbld', 15:47:51 INFO - 'MAIL': '/var/mail/cltbld', 15:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:51 INFO - 'MOZ_NO_REMOTE': '1', 15:47:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:51 INFO - 'NO_EM_RESTART': '1', 15:47:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:51 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:51 INFO - 'SHELL': '/bin/bash', 15:47:51 INFO - 'SHLVL': '1', 15:47:51 INFO - 'TERM': 'linux', 15:47:51 INFO - 'TMOUT': '86400', 15:47:51 INFO - 'USER': 'cltbld', 15:47:51 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452383247.284149-955829352', 15:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:51 INFO - '_': '/tools/buildbot/bin/python'} 15:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:51 INFO - Downloading/unpacking psutil>=0.7.1 15:47:51 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 15:47:51 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 15:47:51 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 15:47:51 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 15:47:51 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 15:47:51 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 15:47:53 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 15:47:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:47:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:47:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:47:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:47:53 INFO - Installing collected packages: psutil 15:47:53 INFO - Running setup.py install for psutil 15:47:53 INFO - building 'psutil._psutil_linux' extension 15:47:53 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 15:47:54 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 15:47:54 INFO - building 'psutil._psutil_posix' extension 15:47:54 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 15:47:54 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 15:47:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:47:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:47:54 INFO - Successfully installed psutil 15:47:54 INFO - Cleaning up... 15:47:54 INFO - Return code: 0 15:47:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:47: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')]} 15:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47: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')]} 15:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2207614f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1668660>, '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 0x1669560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1669a10>, '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': '32c5991c409366f7fec8a718000001d2-1452383247.284149-955829352', '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 15:47:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 15:47:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:47:54 INFO - Using env: {'DISPLAY': ':0', 15:47:54 INFO - 'HOME': '/home/cltbld', 15:47:54 INFO - 'LANG': 'en_US.UTF-8', 15:47:54 INFO - 'LANGUAGE': 'en_US:en', 15:47:54 INFO - 'LOGNAME': 'cltbld', 15:47:54 INFO - 'MAIL': '/var/mail/cltbld', 15:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:54 INFO - 'MOZ_NO_REMOTE': '1', 15:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:54 INFO - 'NO_EM_RESTART': '1', 15:47:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:54 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:54 INFO - 'SHELL': '/bin/bash', 15:47:54 INFO - 'SHLVL': '1', 15:47:54 INFO - 'TERM': 'linux', 15:47:54 INFO - 'TMOUT': '86400', 15:47:54 INFO - 'USER': 'cltbld', 15:47:54 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452383247.284149-955829352', 15:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:54 INFO - '_': '/tools/buildbot/bin/python'} 15:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:47:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:47:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:47:56 INFO - Installing collected packages: mozsystemmonitor 15:47:56 INFO - Running setup.py install for mozsystemmonitor 15:47:56 INFO - Successfully installed mozsystemmonitor 15:47:56 INFO - Cleaning up... 15:47:56 INFO - Return code: 0 15:47:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:47:56 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')]} 15:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:56 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')]} 15:47:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:56 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 0x7f2207614f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1668660>, '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 0x1669560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1669a10>, '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': '32c5991c409366f7fec8a718000001d2-1452383247.284149-955829352', '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 15:47:56 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 15:47:56 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 15:47:56 INFO - Using env: {'DISPLAY': ':0', 15:47:56 INFO - 'HOME': '/home/cltbld', 15:47:56 INFO - 'LANG': 'en_US.UTF-8', 15:47:56 INFO - 'LANGUAGE': 'en_US:en', 15:47:56 INFO - 'LOGNAME': 'cltbld', 15:47:56 INFO - 'MAIL': '/var/mail/cltbld', 15:47:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:56 INFO - 'MOZ_NO_REMOTE': '1', 15:47:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:56 INFO - 'NO_EM_RESTART': '1', 15:47:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:56 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:56 INFO - 'SHELL': '/bin/bash', 15:47:56 INFO - 'SHLVL': '1', 15:47:56 INFO - 'TERM': 'linux', 15:47:56 INFO - 'TMOUT': '86400', 15:47:56 INFO - 'USER': 'cltbld', 15:47:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452383247.284149-955829352', 15:47:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:56 INFO - '_': '/tools/buildbot/bin/python'} 15:47:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:56 INFO - Downloading/unpacking blobuploader==1.2.4 15:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:58 INFO - Downloading blobuploader-1.2.4.tar.gz 15:47:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:47:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:47:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:47:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:47:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:59 INFO - Downloading docopt-0.6.1.tar.gz 15:47:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:47:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:47:59 INFO - Installing collected packages: blobuploader, requests, docopt 15:47:59 INFO - Running setup.py install for blobuploader 15:47:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:47:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:47:59 INFO - Running setup.py install for requests 15:47:59 INFO - Running setup.py install for docopt 15:47:59 INFO - Successfully installed blobuploader requests docopt 15:47:59 INFO - Cleaning up... 15:47:59 INFO - Return code: 0 15:47:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:47:59 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')]} 15:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:59 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')]} 15:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:59 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 0x7f2207614f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1668660>, '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 0x1669560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1669a10>, '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': '32c5991c409366f7fec8a718000001d2-1452383247.284149-955829352', '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 15:47:59 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 15:47:59 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 15:47:59 INFO - Using env: {'DISPLAY': ':0', 15:47:59 INFO - 'HOME': '/home/cltbld', 15:47:59 INFO - 'LANG': 'en_US.UTF-8', 15:47:59 INFO - 'LANGUAGE': 'en_US:en', 15:47:59 INFO - 'LOGNAME': 'cltbld', 15:47:59 INFO - 'MAIL': '/var/mail/cltbld', 15:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:59 INFO - 'MOZ_NO_REMOTE': '1', 15:47:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:59 INFO - 'NO_EM_RESTART': '1', 15:47:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:59 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:59 INFO - 'SHELL': '/bin/bash', 15:47:59 INFO - 'SHLVL': '1', 15:47:59 INFO - 'TERM': 'linux', 15:47:59 INFO - 'TMOUT': '86400', 15:47:59 INFO - 'USER': 'cltbld', 15:47:59 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452383247.284149-955829352', 15:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:59 INFO - '_': '/tools/buildbot/bin/python'} 15:48:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:48:00 INFO - Running setup.py (path:/tmp/pip-WTpHTo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:48:00 INFO - Running setup.py (path:/tmp/pip-ujNY8i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:48:00 INFO - Running setup.py (path:/tmp/pip-cbntPA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:48:00 INFO - Running setup.py (path:/tmp/pip-acx4bU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:48:00 INFO - Running setup.py (path:/tmp/pip-XDDK47-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:48:00 INFO - Running setup.py (path:/tmp/pip-F95iWH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:48:00 INFO - Running setup.py (path:/tmp/pip-MX07_m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:48:00 INFO - Running setup.py (path:/tmp/pip-dMsgxN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:48:00 INFO - Running setup.py (path:/tmp/pip-X9bJ0E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:48:00 INFO - Running setup.py (path:/tmp/pip-WFKP57-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:48:00 INFO - Running setup.py (path:/tmp/pip-UJOgRT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:48:00 INFO - Running setup.py (path:/tmp/pip-6ypM85-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:48:00 INFO - Running setup.py (path:/tmp/pip-Bx_kNM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:48:00 INFO - Running setup.py (path:/tmp/pip-Fp1_CU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:48:01 INFO - Running setup.py (path:/tmp/pip-inVXQJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:48:01 INFO - Running setup.py (path:/tmp/pip-3CRMN1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:48:01 INFO - Running setup.py (path:/tmp/pip-l_VY_s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:48:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:48:01 INFO - Running setup.py install for manifestparser 15:48:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:48:01 INFO - Running setup.py install for mozcrash 15:48:01 INFO - Running setup.py install for mozdebug 15:48:01 INFO - Running setup.py install for mozdevice 15:48:01 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:48:01 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:48:01 INFO - Running setup.py install for mozfile 15:48:01 INFO - Running setup.py install for mozhttpd 15:48:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:48:01 INFO - Running setup.py install for mozinfo 15:48:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:48:01 INFO - Running setup.py install for mozInstall 15:48:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:48:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:48:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:48:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:48:02 INFO - Running setup.py install for mozleak 15:48:02 INFO - Running setup.py install for mozlog 15:48:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:48:02 INFO - Running setup.py install for moznetwork 15:48:02 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:48:02 INFO - Running setup.py install for mozprocess 15:48:02 INFO - Running setup.py install for mozprofile 15:48:02 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:48:02 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:48:02 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:48:02 INFO - Running setup.py install for mozrunner 15:48:02 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:48:02 INFO - Running setup.py install for mozscreenshot 15:48:02 INFO - Running setup.py install for moztest 15:48:02 INFO - Running setup.py install for mozversion 15:48:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:48:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:48:02 INFO - Cleaning up... 15:48:03 INFO - Return code: 0 15:48:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:03 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 0x7f2207614f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1668660>, '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 0x1669560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1669a10>, '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': '32c5991c409366f7fec8a718000001d2-1452383247.284149-955829352', '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 15:48:03 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 15:48:03 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 15:48:03 INFO - Using env: {'DISPLAY': ':0', 15:48:03 INFO - 'HOME': '/home/cltbld', 15:48:03 INFO - 'LANG': 'en_US.UTF-8', 15:48:03 INFO - 'LANGUAGE': 'en_US:en', 15:48:03 INFO - 'LOGNAME': 'cltbld', 15:48:03 INFO - 'MAIL': '/var/mail/cltbld', 15:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:03 INFO - 'MOZ_NO_REMOTE': '1', 15:48:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:03 INFO - 'NO_EM_RESTART': '1', 15:48:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:48:03 INFO - 'PWD': '/builds/slave/test-pgo', 15:48:03 INFO - 'SHELL': '/bin/bash', 15:48:03 INFO - 'SHLVL': '1', 15:48:03 INFO - 'TERM': 'linux', 15:48:03 INFO - 'TMOUT': '86400', 15:48:03 INFO - 'USER': 'cltbld', 15:48:03 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452383247.284149-955829352', 15:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:03 INFO - '_': '/tools/buildbot/bin/python'} 15:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:48:03 INFO - Running setup.py (path:/tmp/pip-zUrLM0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:48:03 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)) 15:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:48:03 INFO - Running setup.py (path:/tmp/pip-UL8s9S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:48:03 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)) 15:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:48:03 INFO - Running setup.py (path:/tmp/pip-xr8G5q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:48:03 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)) 15:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:48:03 INFO - Running setup.py (path:/tmp/pip-RZjIw6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:48:03 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)) 15:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:48:03 INFO - Running setup.py (path:/tmp/pip-MQPJnb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:48:03 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)) 15:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:48:03 INFO - Running setup.py (path:/tmp/pip-ezYYMu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:48:03 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)) 15:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:48:03 INFO - Running setup.py (path:/tmp/pip-LzTLmm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:48:03 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)) 15:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:48:03 INFO - Running setup.py (path:/tmp/pip-EB4OtR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:48:03 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)) 15:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:48:03 INFO - Running setup.py (path:/tmp/pip-7PA1d6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:48:03 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)) 15:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:48:03 INFO - Running setup.py (path:/tmp/pip-4Oio15-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:48:03 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)) 15:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:48:03 INFO - Running setup.py (path:/tmp/pip-qct2hs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:48:04 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)) 15:48:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:48:04 INFO - Running setup.py (path:/tmp/pip-2yxjCK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:48:04 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)) 15:48:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:48:04 INFO - Running setup.py (path:/tmp/pip-dmzZoY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:48:04 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)) 15:48:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:48:04 INFO - Running setup.py (path:/tmp/pip-CB05S6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:48:04 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)) 15:48:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:48:04 INFO - Running setup.py (path:/tmp/pip-L4cfZx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:48:04 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)) 15:48:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:48:04 INFO - Running setup.py (path:/tmp/pip-4WEYgl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:48:04 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)) 15:48:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:48:04 INFO - Running setup.py (path:/tmp/pip-_NA2L4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:48:04 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)) 15:48:04 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)) 15:48:04 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)) 15:48:04 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)) 15:48:04 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)) 15:48:04 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)) 15:48:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:48:04 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 15:48:04 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 15:48:04 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 15:48:04 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 15:48:04 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 15:48:04 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 15:48:06 INFO - Downloading blessings-1.5.1.tar.gz 15:48:06 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 15:48:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:48:06 INFO - Installing collected packages: blessings 15:48:06 INFO - Running setup.py install for blessings 15:48:06 INFO - Successfully installed blessings 15:48:06 INFO - Cleaning up... 15:48:06 INFO - Return code: 0 15:48:06 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:48:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:48:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:48:06 INFO - Reading from file tmpfile_stdout 15:48:06 INFO - Current package versions: 15:48:06 INFO - argparse == 1.2.1 15:48:06 INFO - blessings == 1.5.1 15:48:06 INFO - blobuploader == 1.2.4 15:48:06 INFO - docopt == 0.6.1 15:48:06 INFO - manifestparser == 1.1 15:48:06 INFO - mozInstall == 1.12 15:48:06 INFO - mozcrash == 0.16 15:48:06 INFO - mozdebug == 0.1 15:48:06 INFO - mozdevice == 0.47 15:48:06 INFO - mozfile == 1.2 15:48:06 INFO - mozhttpd == 0.7 15:48:06 INFO - mozinfo == 0.9 15:48:06 INFO - mozleak == 0.1 15:48:06 INFO - mozlog == 3.1 15:48:06 INFO - moznetwork == 0.27 15:48:06 INFO - mozprocess == 0.22 15:48:06 INFO - mozprofile == 0.28 15:48:06 INFO - mozrunner == 6.11 15:48:06 INFO - mozscreenshot == 0.1 15:48:06 INFO - mozsystemmonitor == 0.0 15:48:06 INFO - moztest == 0.7 15:48:06 INFO - mozversion == 1.4 15:48:06 INFO - psutil == 3.1.1 15:48:06 INFO - requests == 1.2.3 15:48:06 INFO - wsgiref == 0.1.2 15:48:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:48:06 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')]} 15:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:06 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')]} 15:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:06 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 0x7f2207614f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1668660>, '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 0x1669560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1669a10>, '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': '32c5991c409366f7fec8a718000001d2-1452383247.284149-955829352', '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 15:48:06 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 15:48:06 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 15:48:06 INFO - Using env: {'DISPLAY': ':0', 15:48:06 INFO - 'HOME': '/home/cltbld', 15:48:06 INFO - 'LANG': 'en_US.UTF-8', 15:48:06 INFO - 'LANGUAGE': 'en_US:en', 15:48:06 INFO - 'LOGNAME': 'cltbld', 15:48:06 INFO - 'MAIL': '/var/mail/cltbld', 15:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:06 INFO - 'MOZ_NO_REMOTE': '1', 15:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:06 INFO - 'NO_EM_RESTART': '1', 15:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:48:06 INFO - 'PWD': '/builds/slave/test-pgo', 15:48:06 INFO - 'SHELL': '/bin/bash', 15:48:06 INFO - 'SHLVL': '1', 15:48:06 INFO - 'TERM': 'linux', 15:48:06 INFO - 'TMOUT': '86400', 15:48:06 INFO - 'USER': 'cltbld', 15:48:06 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452383247.284149-955829352', 15:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:06 INFO - '_': '/tools/buildbot/bin/python'} 15:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:06 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)) 15:48:06 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)) 15:48:06 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)) 15:48:06 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)) 15:48:06 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)) 15:48:06 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)) 15:48:06 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)) 15:48:06 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)) 15:48:06 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)) 15:48:06 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)) 15:48:06 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)) 15:48:06 INFO - Cleaning up... 15:48:06 INFO - Return code: 0 15:48:06 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:48:06 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')]} 15:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:06 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')]} 15:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:06 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 0x7f2207614f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1668660>, '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 0x1669560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1669a10>, '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': '32c5991c409366f7fec8a718000001d2-1452383247.284149-955829352', '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 15:48:06 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 15:48:06 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 15:48:06 INFO - Using env: {'DISPLAY': ':0', 15:48:06 INFO - 'HOME': '/home/cltbld', 15:48:06 INFO - 'LANG': 'en_US.UTF-8', 15:48:06 INFO - 'LANGUAGE': 'en_US:en', 15:48:06 INFO - 'LOGNAME': 'cltbld', 15:48:06 INFO - 'MAIL': '/var/mail/cltbld', 15:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:06 INFO - 'MOZ_NO_REMOTE': '1', 15:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:06 INFO - 'NO_EM_RESTART': '1', 15:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:48:06 INFO - 'PWD': '/builds/slave/test-pgo', 15:48:06 INFO - 'SHELL': '/bin/bash', 15:48:06 INFO - 'SHLVL': '1', 15:48:06 INFO - 'TERM': 'linux', 15:48:06 INFO - 'TMOUT': '86400', 15:48:06 INFO - 'USER': 'cltbld', 15:48:06 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452383247.284149-955829352', 15:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:06 INFO - '_': '/tools/buildbot/bin/python'} 15:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:07 INFO - Downloading/unpacking jsonschema 15:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:48:08 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 15:48:08 INFO - Downloading/unpacking functools32 (from jsonschema) 15:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:08 INFO - Downloading functools32-3.2.3-2.tar.gz 15:48:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 15:48:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:48:09 INFO - warning: no files found matching '*.txt' 15:48:09 INFO - no previously-included directories found matching 'build' 15:48:09 INFO - no previously-included directories found matching 'dist' 15:48:09 INFO - no previously-included directories found matching '.git*' 15:48:09 INFO - Installing collected packages: jsonschema, functools32 15:48:09 INFO - Running setup.py install for functools32 15:48:09 INFO - warning: no files found matching '*.txt' 15:48:09 INFO - no previously-included directories found matching 'build' 15:48:09 INFO - no previously-included directories found matching 'dist' 15:48:09 INFO - no previously-included directories found matching '.git*' 15:48:09 INFO - Successfully installed jsonschema functools32 15:48:09 INFO - Cleaning up... 15:48:09 INFO - Return code: 0 15:48:09 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:48: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')]} 15:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48: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')]} 15:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2207614f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1668660>, '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 0x1669560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1669a10>, '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': '32c5991c409366f7fec8a718000001d2-1452383247.284149-955829352', '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 15:48:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 15:48:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:48:09 INFO - Using env: {'DISPLAY': ':0', 15:48:09 INFO - 'HOME': '/home/cltbld', 15:48:09 INFO - 'LANG': 'en_US.UTF-8', 15:48:09 INFO - 'LANGUAGE': 'en_US:en', 15:48:09 INFO - 'LOGNAME': 'cltbld', 15:48:09 INFO - 'MAIL': '/var/mail/cltbld', 15:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:09 INFO - 'MOZ_NO_REMOTE': '1', 15:48:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:09 INFO - 'NO_EM_RESTART': '1', 15:48:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:48:09 INFO - 'PWD': '/builds/slave/test-pgo', 15:48:09 INFO - 'SHELL': '/bin/bash', 15:48:09 INFO - 'SHLVL': '1', 15:48:09 INFO - 'TERM': 'linux', 15:48:09 INFO - 'TMOUT': '86400', 15:48:09 INFO - 'USER': 'cltbld', 15:48:09 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452383247.284149-955829352', 15:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:09 INFO - '_': '/tools/buildbot/bin/python'} 15:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:09 INFO - Downloading/unpacking flake8 15:48:09 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 15:48:09 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 15:48:09 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 15:48:09 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 15:48:09 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 15:48:09 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 15:48:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:48:11 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 15:48:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:48:11 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 15:48:11 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 15:48:11 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 15:48:11 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 15:48:11 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 15:48:11 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 15:48:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:48:11 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 15:48:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:48:11 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 15:48:11 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 15:48:11 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 15:48:11 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 15:48:11 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 15:48:11 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 15:48:11 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 15:48:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:48:11 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 15:48:11 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 15:48:11 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 15:48:11 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 15:48:11 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 15:48:11 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 15:48:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 15:48:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:48:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:48:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:48:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:48:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:48:11 INFO - no previously-included directories found matching 'docs/_build' 15:48:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:48:11 INFO - Running setup.py install for pep8 15:48:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:48:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:48:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:48:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:48:11 INFO - no previously-included directories found matching 'docs/_build' 15:48:11 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:48:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:48:11 INFO - Cleaning up... 15:48:12 INFO - Return code: 0 15:48:12 INFO - Running post-action listener: _resource_record_post_action 15:48:12 INFO - Running post-action listener: _start_resource_monitoring 15:48:12 INFO - Starting resource monitoring. 15:48:12 INFO - ##### 15:48:12 INFO - ##### Running install step. 15:48:12 INFO - ##### 15:48:12 INFO - Running pre-action listener: _resource_record_pre_action 15:48:12 INFO - Running main action method: install 15:48:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:48:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:48:12 INFO - Reading from file tmpfile_stdout 15:48:12 INFO - Detecting whether we're running mozinstall >=1.0... 15:48:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:48:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:48:12 INFO - Reading from file tmpfile_stdout 15:48:12 INFO - Output received: 15:48:12 INFO - Usage: mozinstall [options] installer 15:48:12 INFO - Options: 15:48:12 INFO - -h, --help show this help message and exit 15:48:12 INFO - -d DEST, --destination=DEST 15:48:12 INFO - Directory to install application into. [default: 15:48:12 INFO - "/builds/slave/test-pgo"] 15:48:12 INFO - --app=APP Application being installed. [default: firefox] 15:48:12 INFO - mkdir: /builds/slave/test-pgo/build/application 15:48:12 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'] 15:48:12 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 15:48:28 INFO - Reading from file tmpfile_stdout 15:48:28 INFO - Output received: 15:48:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:48:28 INFO - Running post-action listener: _resource_record_post_action 15:48:28 INFO - ##### 15:48:28 INFO - ##### Running run-tests step. 15:48:28 INFO - ##### 15:48:28 INFO - Running pre-action listener: _resource_record_pre_action 15:48:28 INFO - Running main action method: run_tests 15:48:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:48:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:48:28 INFO - Python 2.7.3 15:48:28 INFO - Return code: 0 15:48:28 INFO - grabbing minidump binary from tooltool 15:48:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:28 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 0x1668660>, '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 0x1669560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1669a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:48:28 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 15:48:28 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 15:48:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:48:28 INFO - Return code: 0 15:48:28 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:48:28 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:48:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:48:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:48:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:48:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 15:48:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 15:48:29 INFO - Return code: 0 15:48:29 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/C1Jw8qSZQJODDUFi1LFjmg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 15:48:29 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/C1Jw8qSZQJODDUFi1LFjmg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 15:48:29 INFO - Using env: {'DISPLAY': ':0', 15:48:29 INFO - 'HOME': '/home/cltbld', 15:48:29 INFO - 'LANG': 'en_US.UTF-8', 15:48:29 INFO - 'LANGUAGE': 'en_US:en', 15:48:29 INFO - 'LOGNAME': 'cltbld', 15:48:29 INFO - 'MAIL': '/var/mail/cltbld', 15:48:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:48:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:48:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:29 INFO - 'MOZ_NO_REMOTE': '1', 15:48:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:48:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:29 INFO - 'NO_EM_RESTART': '1', 15:48:29 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:48:29 INFO - 'PWD': '/builds/slave/test-pgo', 15:48:29 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:48:29 INFO - 'SHELL': '/bin/bash', 15:48:29 INFO - 'SHLVL': '1', 15:48:29 INFO - 'TERM': 'linux', 15:48:29 INFO - 'TMOUT': '86400', 15:48:29 INFO - 'USER': 'cltbld', 15:48:29 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452383247.284149-955829352', 15:48:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:29 INFO - '_': '/tools/buildbot/bin/python'} 15:48:29 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/C1Jw8qSZQJODDUFi1LFjmg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 15:48:29 INFO - mozversion application_buildid: 20160109133014 15:48:29 INFO - mozversion application_changeset: c33f30666b37dbceffb9fbe5089a668db8893a85 15:48:29 INFO - mozversion application_display_name: Nightly 15:48:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:48:29 INFO - mozversion application_name: Firefox 15:48:29 INFO - mozversion application_remotingname: firefox 15:48:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:48:29 INFO - mozversion application_vendor: Mozilla 15:48:29 INFO - mozversion application_version: 46.0a1 15:48:29 INFO - mozversion platform_buildid: 20160109133014 15:48:29 INFO - mozversion platform_changeset: c33f30666b37dbceffb9fbe5089a668db8893a85 15:48:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:48:29 INFO - mozversion platform_version: 46.0a1 15:48:29 INFO - using testdate: 1452383309 15:48:29 INFO - actual date: 1452383309 15:48:29 INFO - starting webserver on 'localhost:46905' 15:48:29 INFO - SUITE-START | Running 3 tests 15:48:29 INFO - TEST-START | dromaeo_css 15:48:29 INFO - operating with platform_type : linux_ 15:48:29 INFO - Initialising browser for dromaeo_css test... 15:48:29 INFO - TEST-INFO | started process 2225 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH7T5sI/profile http://localhost:46905/getInfo.html) 15:48:33 INFO - PROCESS | 2225 | 15:48:33 INFO - PROCESS | 2225 | (process:2309): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:48:33 INFO - PROCESS | 2225 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 15:48:34 INFO - PROCESS | 2225 | __metrics Screen width/height:1600/1200 15:48:34 INFO - PROCESS | 2225 | colorDepth:24 15:48:34 INFO - PROCESS | 2225 | Browser inner width/height: 1024/697 15:48:34 INFO - PROCESS | 2225 | __metrics 15:48:34 INFO - PROCESS | 2225 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:48:34 INFO - TEST-INFO | 2225: exit 0 15:48:34 INFO - Browser initialized. 15:48:34 INFO - Running cycle 1/1 for dromaeo_css test... 15:48:34 INFO - TEST-INFO | started process 2358 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH7T5sI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:48:36 INFO - PROCESS | 2358 | 15:48:36 INFO - PROCESS | 2358 | (process:2494): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:48:46 INFO - PROCESS | 2358 | RSS: Main: 150929408 15:48:46 INFO - PROCESS | 2358 | 15:49:36 INFO - PROCESS | 2358 | 1452383376449 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] 15:51:45 INFO - PROCESS | 2358 | Cycle 1(1): loaded http://localhost:46905/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46905/tests/dromaeo/cssquery-ext.html) 15:51:46 INFO - PROCESS | 2358 | RSS: Main: 158515200 15:51:46 INFO - PROCESS | 2358 | 15:54:48 INFO - PROCESS | 2358 | Cycle 1(1): loaded http://localhost:46905/tests/dromaeo/cssquery-ext.html (next: http://localhost:46905/tests/dromaeo/cssquery-jquery.html) 15:54:49 INFO - PROCESS | 2358 | RSS: Main: 152915968 15:54:49 INFO - PROCESS | 2358 | 15:57:50 INFO - PROCESS | 2358 | Cycle 1(1): loaded http://localhost:46905/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46905/tests/dromaeo/cssquery-mootools.html) 15:57:51 INFO - PROCESS | 2358 | RSS: Main: 153677824 15:57:51 INFO - PROCESS | 2358 | 16:00:53 INFO - PROCESS | 2358 | Cycle 1(1): loaded http://localhost:46905/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46905/tests/dromaeo/cssquery-prototype.html) 16:00:53 INFO - PROCESS | 2358 | RSS: Main: 153055232 16:00:53 INFO - PROCESS | 2358 | 16:03:56 INFO - PROCESS | 2358 | Cycle 1(1): loaded http://localhost:46905/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46905/tests/dromaeo/cssquery-yui.html) 16:03:56 INFO - PROCESS | 2358 | RSS: Main: 154071040 16:03:56 INFO - PROCESS | 2358 | 16:06:59 INFO - PROCESS | 2358 | Cycle 1(1): loaded http://localhost:46905/tests/dromaeo/cssquery-yui.html (next: http://localhost:46905/tests/dromaeo/cssquery-dojo.html) 16:06:59 INFO - PROCESS | 2358 | RSS: Main: 155279360 16:06:59 INFO - PROCESS | 2358 | 16:06:59 INFO - PROCESS | 2358 | __start_tp_report 16:06:59 INFO - PROCESS | 2358 | _x_x_mozilla_page_load 16:06:59 INFO - PROCESS | 2358 | _x_x_mozilla_page_load_details 16:06:59 INFO - PROCESS | 2358 | |i|pagename|runs| 16:06:59 INFO - PROCESS | 2358 | |0;dojo.html;3204.1028512016637;3255.348930213958;3278.967210327896;3322.0864262327855;3323.8171900545476;5241.42344342123;5377.946220537793;5390.434004429532;5395.568354531638;5407;5304.840854774353;5316.282301889244;5322.787088516455;5361;5428.83713488595;4841.6852904561265;4894.1924582444035;4905.82829600964;4943.307936888838;4988.052270068693;4608.446986361624;4952.380952380952;5016.573591244749;5018.2974383586325;5049.192129259319;4768.2847572864175;4781.593564547018;4877.122118018755;4909.509049095098;4921.064997650471;4870.805167793284;4876.561109500162;4883.682560633548;4918.04098200851;4920.926186107211;4822.758862056919;4826.903461930777;4842.564169224752;4853.320535125085;4867.902641947177;5142.588592912558;5196.948030519684;5216.843494695127;5250.08123578376;5366.060939335601;5789.247397838296;5792.333881603585;5792.913106303409;5794.391588883191;5807.477327040587;5830.4169583041785;5835.679037652927;5840.123981402781;5845.736941837585;5848.824535263949;5267.315249017642;5346.705931173784;5413.648112872651;5473.507384335429;5540.806071787549;5843.2403787507355;5847.912281315784;5851.61964472308;5853.239078919713;5853.560982926212;5616.241807356037;5617.606767526316;5627.324721033502;5629.943700563023;5636.070048442043;5659.43405659439;5707.828765137053;5769.509591684669;5779.855503612359;5782.913256301159;5685.602007859493;5703.486686198179;5708.885822283614;5719.456651618173;5720.370759216483;5697.772089116472;5724.398938111438;5726.914096288559;5742.655440673573;5781.421857814269;4444.644428445717;4449.087936972913;4458.108378324348;4466.017476155241;4486.663500237495;3921.8235179416993;3943.428202910562;3949.6247856454165;3970.305196590585;3984.7210695251633;5375.7849686012905;5399.136138217867;5450.236966824647;5476.424975377608;5516.862078447991;5763;5784.566157538202;5804.767809287581;5816.88366232673;5818;5225.477452254744;5341.359036915517;5424.7016414096815;5425.996190704732;5434.782608695687;4937.629677774109;5013.24801279811;5014.824481143142;5015.548600625962;5063.721495317719;5906.232189815297;5973.551983601247;6011.428914253139;6021.42796434338;6022.036474164112;5582.190582365615;5664.0371136906;5720.8283751487525;5769.94230057694;5782.797602083907;6018.277806663228;6030.698465076816;6052.818415447544;6056.939430605637;6087.2999605044215;5764.913526297025;5779.335376431764;5784.681842498703;5789.884202316014;5802.245708057925;5626.718664066862;5699.743511542073;5760.596758226884;5868.853278668067;5880.206172166702;5693.202951586864;5694.658320500783;5698.20225168485;5704.714764261687;5739.253896993364;5643.209950607001;5653.632513886584;5696.373398926197;5704.3154821421695;5718.027935251101;5480.205370221216;5577.135543990688;5585.832425027255;5605.5235304997905;5666.206731057738;5546.029444847216;5575.386707462095;5589.608727389043;5594.832155035356;5597.860053498695;5505.394406615349;5518.503334699736;5521.806736764354;5523.392426832965;5582.302212223472 16:06:59 INFO - PROCESS | 2358 | |1;ext.html;519.4441947116585;534.2867272191625;559.8131960244283;567.639548886457;573.6099452372388;35046.82476587617;36017.81991090047;36203.094922626915;36206.2758744825;36274.27451450973;41084.58915410852;41762.373564396556;41844.58155418445;41976.37035444463;42142;8435.198656127657;8583.442076265022;8635.740927772145;8638.913610863874;8642.913570864273;8366.83266334673;8455.154484551556;8522.87215691762;8527.317814574819;8538.829223415529;8451.83096338073;8506.489610623383;8530.616122274481;8535.103814099522;8575.099614540477;8439.367047471433;8450.830983380298;8496.107908669625;8537.530435826027;8558.70044548441;8286.254237118688;8373.83252334956;8393.370497212734;8417.326613870937;8451.704190353308;38196.23607527862;38618.03454913622;38749.225015499534;38910.61089389098;38922.22155556873;2731.6721993360725;3040.6959304069637;3159.4944808830705;3271.3947919634943;3294.7528935329947;26751.732482675314;27292.181234562795;27574.172774816787;27901.860490697618;28154.577681334795;3816.637419445148;3838.673712734421;3855.4409610606585;3903.512060992376;3953.782541960191;220620;223634;223714;224081;224255;50359.49640503548;51594.74202628963;53922.7303863486;57179.14231286534;58576;51314;51539.22691159636;51597.7420112897;51721.48278517242;51726.48273517292;12825.486980520862;12963.740725185444;13044.869551304555;13058.412371443308;13085.672858178621;10240.590376384862;10372.42951637652;10385.117265032406;10401.219908506891;10517.579296828042;18547.629047419246;18802.34191803308;18908.81091189098;18923;18937.715934260996;7675.961620191975;7959.323457506177;7963.203679632106;8051.275385215242;8052.637631306605;849.9447535910147;889.8620713789373;948.2271948362063;977.8656758160641;1087.363892123101;27535.86232068827;27734.167974960783;27802.304942376602;27866.16401507958;27879.745411456533;1013.6502906497394;1027.984580231297;1028.7016765138026;1085.592902661502;1155.976880462403;12986.870131298756;13052.934735326262;13210.933945330213;13214.867851321556;14999.625009374853;240703;241131;241320;242001;244341;44848.3272750909;45114.32328515075;45150.54849451529;45164.096718065455;45378;1335.3189873164756;1339.2968691437075;1339.7387509435566;1345.3340596404842;1359.7484465373936;26351.472970540097;28024;28492.857535712188;28638.85680571667;29151.854240728662;42011.36982945197;42093.36859947042;42347.70653668291;42408.78795606002;42475.787621061696;199753;200416;200886;201784;202052;30165.849170754005;31485.740570377846;32159.874404395734;32336.191595210308;32343;37146.25707485781;37861.81069094747;38010.0497487565;38124.809375952944;38196;32132.83933580317;32574.511382329758;32747.508787367733;32967;33125.17187070342;33825.15437114092;34575.13562160966;34645.826770865984;35337.64662353344;36199;31757.20606984844;34557;34942.825285873405;35128.648713512535;35354.64645353513;27416.725832742217;31539;32225;32708.836455817567;34719.4792078114;23693.526129477657;23779.64330535078;23891.880540597187;24088.51822963496;24098.51802963966 16:06:59 INFO - PROCESS | 2358 | |2;jquery.html;357.80678433645835;360.6519708481315;360.91879327151383;361.22877656204;367.0932795993894;16479;16872.409465668705;17198.57003574911;17273;17970.281188752433;11212.27120237184;11286.661400157987;11302.604408845693;12565.246085234892;16199.676006479864;4814.301926220696;5005.824796132136;5110.795568177287;5461.098918678414;5462.071447853875;5328.600354973373;5439.211314359415;5442.265294185294;5448.318960129984;5455.454454554532;4805.759712014403;5853.32686741026;5900.144479050535;6015.308239552463;6375.617462952215;6327.01931200667;6341.651209183493;6410.8076757697345;6420.1974753155855;6644.402003819631;6210.96894515529;6388.840278993016;6399.168108145911;6409.262934762515;6411.455026322768;20742.170313187453;21000;21434.356969290948;22300.107995680155;22456.214032508946;2152.2251989283845;2152.849300548962;2183.4213933307688;2223.8220942324574;2416.673749043874;12641.431135598828;13185.34073296341;13271;13332.866671333259;13671.931640341834;1926.5472613935715;1934.2746470073723;1936.74822273105;1942.65032294187;1970.290695349673;49779.999999999636;50044.249336259985;51014.7449262755;54555;56256.71871640656;14752.63118422048;15061.246937653073;15111.773323400157;15133.243337833064;15155.242237888062;23194.840257987034;23257.53484930292;23300.65049024266;23327.41681457977;23577.41056473602;8315.210055044761;8325.375596830141;8361.832763344699;8362.916370836214;8391;6976.860462790817;7005.649717514206;7012.9298707013295;7020.1575810901995;7059.364657180879;7634.122075961224;7679.232076792276;7723;7783.532988020624;7812.375009999187;1791.570023194424;1840.8343249107645;3038.255627371308;3179.856906439216;3188.8086714797187;844.514404217565;892.5804871710286;900.2797761790672;982.597135174575;1012.8126296635146;15191.632753052278;15464.304106315243;15760.211989400485;16488.34046638121;16497.257623406975;885.9557022148866;924.2790623313826;942.458086600194;955.0278674537059;1002.0780881588955;8658.913410865936;8772.605232764541;8894.644214231359;9507.619695212252;9718.319717619841;529192;531514;538775;549466;550655;69984;70290.64854675694;73270.26729732634;73890;74364;1126.9154813388864;1127.8984891359653;1143.6397534776518;1145.7937571237258;1146.2377518949804;15203.61990950191;15246.3901443941;15301.693966120838;15366.769498457756;15627;32307;32463.837680811444;32555.511667324536;32746.836265818518;33653;42342.57657423386;42344.94137646584;42364.152716944875;42511.3623295657;42792.57207427886;7063.39961103312;7356.301151390609;7368.963155184189;7450.441216908645;7533.209013053551;10413.791724165625;10859.131269498263;10970.670879873616;11169.664910052712;11259;9422.152006319464;9836.3606365586;9842.163416109424;10001.2999090063;10019.198464122706;9455.905440945502;10096.899031009889;10109.241806864662;10363.94818025905;10411.865567558481;10117.140043096419;10216.489175541044;10285.588576456857;10328.638497652546;10396.896031039592;7463.850722985619;7573.734919277799;7577.128630207597;7580.658870350737;7642.273983971514;9346.579403926704;9413.482258475575;10229.948850255701;10271.281010329205;10368.170546356425 16:06:59 INFO - PROCESS | 2358 | |3;mootools.html;1429.0782445322768;1435.8133442652456;1584.192062048355;1737.5916659585002;1755.5260079778461;7326.633668316583;7411.0736157980255;7426.257374262571;7538.924610753891;7739.4969326993705;7888.763337099882;7917.960410197956;7977.56123413212;7990.440669153161;8012.799680007988;2292.358139720881;2296.7932886040294;2323.256557901472;2328.1036800831716;2329.697139371879;2368.5973384524586;2390.103711108334;2410.529946660402;2413.746556611548;2415.6376543518527;2260.242818655752;2285.714285714286;2309.2379514760087;2334.5681049005902;2344.460774021976;2312.884355782221;2323.349462150592;2355.5406695694346;2358.7287461941924;2364.5861974154454;2361.173589243751;2368.0882860098814;2371.395294199985;2375.9762402375927;2385.0698227691214;7744.0319960005;7776.300132988002;7780.688772449095;7782.416318776058;7815.179406162385;4903.436104847952;5032.295478632995;5033.798648054073;5034.14419548674;5051.166557518005;3143.1513491357205;3203.4073696366013;3229.0474310078584;3233.676632336771;3255.983720081408;1012.8683271174774;1024.293237666008;1045.383223897904;1055.3298655353906;1071.3518321415509;10671.092957098655;10850.457477126112;10924.399158046224;10939.726506837313;10990.780184396268;4184.581541845852;4345.97827010863;4348.065165989265;4359.978200108979;4391.780410979502;8842.557872106368;8869.157430044135;8892.64429422816;8900.821983560292;8902.465852048897;4848.854534363974;4853.053654537332;4857.854264372075;4867.586255168279;4869.975650121798;4386.320120381346;4387.868363949086;4405.449318835145;4423.8230470781455;4437.622802061861;3406.267652454734;3443.6212016678146;3461.480777883338;3480.269143479847;3499.8600055997986;1016.3038318751679;1055.2349546578823;1060.9681709548572;1069.427856097;1093.6172339681207;1072.855164552791;1118.3178261260625;1157.386585109893;1228.4717571444364;1308.3196737696535;7170.749023784142;7229.915512673141;7269.89095163573;7300.707971681073;7314.743983960536;640.0591131037368;643.3759253524167;652.807421810567;661.7386132477644;785.2304741353505;5528.143137813645;5686.715664216773;5711.029125048752;5711.8000869969355;5812.3025236971835;9224.123708247706;9430.3870248435;9579.568919398644;9628.66299679522;9658.420494770337;9462.668806591737;9523.428594284365;9539.47532885684;9549.952250238704;9598.95200523993;7365.226651201654;7410.666520006613;7520.1351844537485;7535.472516923763;7554.206808285161;7299.489035767445;7300.634968251672;7307.853842923006;7357.705691772483;7364.96317518409;8233.300169485661;8569.785755356166;8595;8609.569521523774;8631.43895646781;8404.957975210085;8766.868496972424;8812.2950163988;8830.337724670548;8899.911000889908;6503.2196136462035;6631.336866313523;6637.236717777518;6644.7009884554345;6680.832979175365;7305.52514086604;7374.778756637309;7380.815479613053;7386.2613738625705;7394.4454165936695;6758.797236082925;6810.727570897108;6875.896861547181;6909.930900690929;7003.054587630605;6936.158183684656;7135.357817796424;7191.352778249982;7193.964030179815;7230.530015548972;7202.49582529218;7218.711251549879;7248.130224373109;7248.565086094851;7254.129504459499;6626.801195964129;6639.402453779183;6666.400023997863;6672.332766723289;6710.127683401127;6464.450521705708;6598.439132673584;6607.405333520006;6609.768658096944;6619.470442364503 16:06:59 INFO - PROCESS | 2358 | |4;prototype.html;341.6327447993407;352.1882061847444;352.2075330506361;356.89650001499564;357.2479929747881;6113.847153821157;6206.5034797216285;6257.5306851986115;6265.248170219575;6280.748770049204;6038.728257228424;6211.844703882394;6212.161358216639;6213.596116252452;6234.158388617535;4735.9526404736025;4755.619550435957;4759.762011899408;4761;4768.356271903301;4758.809647614108;4759.119562880878;4773.594244489223;4778.498257682945;4782.091402633506;4664.440267167927;4676.181668208067;4687.92968105477;4692.6949748266425;4711.363965864616;4689.2966055091665;4723.338732577442;4725.432948046222;4745.810167593292;4747.311639812242;4115.382692596105;4140.15126898988;4145.295299799011;4150.605692459211;4164.8125834337525;5870.26621672291;5884.588078834483;5892.558058145613;5901.675407852566;5905.261842269716;5247.9737601311745;5419.729013549346;5444.265024221719;5448.509634132947;5476.7535460904355;6527.053577231322;6545.952647576365;6546.541742078057;6551.6069035858;6566.606003639797;4481.417415735966;4503.03184815263;4503.311258278146;4507.706999045052;4509.346144808985;6656;6882.793516194472;6898.896516552256;6909.3090690931;6935;4690.507496712864;4755.9286610700865;4761.666683332133;4772.117158325721;4799.112164249625;4844.346013288161;4851.272309153655;4857.441394239708;4860.586850117709;4861.562459378602;5565.805196818092;5568.276124103922;5568.303962004749;5572.08060669993;5574.944250557523;6396.680165991682;6679.699413526403;6734.56225345351;6741.52809303344;6746.0892779475125;1686.3844696685621;1717.9914100429419;1748.1608827762745;1749.2215963895944;1756.1570446185901;1156.329328989201;1163.8312444695641;1164.121088578135;1187.1215300677436;1208.3173007250875;6177.289611694712;6184.752609895644;6206.627602343783;6206.875862482815;6227.283862355887;6749.730010799513;6751;6755.527113102035;6779.389854913082;6787.762428315084;6060.787872424444;6191.628502289877;6193.071039344044;6198.845028874314;6216.285127210429;3669.541307336583;3705.925881482355;3706.4810926470313;3709.666130048309;3716.851325946986;7062.611556364346;7095.3968912643;7097.361237488548;7101.360877521048;7108.964455177691;6733.293004234485;6898.586084834926;6953.582785032914;6953.79138625842;6962.965185174042;6992.860142797115;7000.124984376851;7066.823329416806;7082.804330657513;7091.60996145217;6737.191537015589;6749.696263668245;6765.864682706417;6777.728890844311;6780.864382712417;6579.243387010363;6669.433098186709;6695.12963314766;6712.731490740316;6727.260001399744;7003.299670032956;7025.227225005143;7038.577685338896;7044.330788575282;7068.823279418056;4715.693479923794;4740.502247263988;4759.405074365704;4762.78567464458;4766.308885211694;6632.966835165987;6755.7973260802255;6772.5936443813525;6775.457963363017;6905.482088843457;6725.798226053226;6729.528932974645;6744.156980377453;6746.089277947414;6751.527393082437;6695.426574755026;6717.227518835396;6722.596644201363;6726.428253598303;6733.528652994243;6466.644334561644;6596.142501474777;6606.273309935807;6611.272759996493;6622.1722284714415;6745.865082698417;6756.932430675631;6767.1879374475375;6769.627670477974;6797.660116994031;6576.2766095728475;6584.275729669828;6587.736490540325;6614.966925165343;6632.900506492503 16:06:59 INFO - PROCESS | 2358 | |5;yui.html;703.7360989628886;717.3687155303332;787.5904529644583;804.7746630943336;840.5377042626558;13480.52818151365;13616.45534178634;13674.316284185788;13680.863191368084;13718.862811371884;12144.757104857898;12183.878161218407;12234.93882530586;12237.0822188336;12268.570600029001;793.345489970775;804.0190967020226;804.0793291681022;805.046020465747;806.2622700229313;803.7186984555417;804.798800299925;806.846699127164;807.289585165054;808.1191501263621;825.1995564302617;826.3513142183388;828.7306625346756;829.3199576347398;829.4649950781742;832.3590835057003;836.1596595421623;837.4431003382743;838.4005436113148;842.0989541190928;619.8357435279654;619.9938000619982;620.5594028239955;621.3103455164763;621.940915613016;12395;12549.93725031369;12572.874271257262;12611.36943152848;12616.621501354974;10785.514651840607;10806.405647689375;10907.34555926639;11112.666620001413;11448.599299024494;9810.509474526245;9817.214622830157;9904.207663386911;9938.602455901755;10188.898111018869;3481.3211423772373;3514.947275790865;3527.735419843522;3548.91127721809;3660.981695091534;40996.1800763986;41796.37305440421;42963.785181073894;44315.33526997098;45882;10346.120579750655;10506.894931050745;10540;10556.841647375142;10869.83695244572;17906.194221260073;17935.192916318796;18012.9099354505;18045.097745112693;18069.096545172688;7274.96362518184;7416.96291518539;7441.516301440389;7532.17146113927;7557.206493318233;4226.450561426995;4240.448741663564;4248.830046798155;4507.121111383249;4526.773661316921;2916.460454815866;2925.1078421081775;2942.087952734659;2945.779066569973;2959.9112026639236;548.2790130977752;559.454531831461;560.117814442255;579.261441661876;582.775631381921;495.14093048560716;508.67953189490385;544.1266766839245;668.620535492522;761.8514389694068;8281.254687078072;8318.750437486886;8431.831363372821;9007.36948413618;9177.21993630549;535.6491498068771;551.3053552523849;586.7095787585173;626.3360837512251;689.9034135221073;3927.48942637461;4079.265732168238;4294.763787991628;4441.289393696993;4481.932771008437;52215.216771748455;52762;53048.73475632597;53266.20100698493;53301;47490.76254618705;47826.28260576094;48236.517634823904;48296.27555586669;48314.75842620764;50182.24726629104;51334.48665513372;53344.46655533473;53818.73090634522;54035.72982135143;8362.790930226549;8460.407771456184;8662.220400163764;8714.782130446789;8871.112888711077;32653.18367040843;33059;33219;33716.66283337135;33757.83121084477;39078.413823793235;39171.41242881302;41021.38467923043;42134.15731685411;42591.57408425876;11160.274582152135;11211.439428028729;11280.887191127984;11521.251118677594;11546.076313895037;11166.162537809534;11289.548418063514;11608.24546404481;11844.407779611158;11854.348010859141;10937.562497500328;11295.7740845181;11491.08071354273;11517.136214784092;11603.419829008348;10576.312539684895;10747.623833165802;10929.726756830825;11130.944345278222;11136.554537818396;11148.888511114785;11533.884661153617;11731.88268117342;11812.76374472523;11831.05351571855;9118.589663465293;9135.26917846584;9146.085391460801;9214.631414743335;9330.533473326172;8959.238464730572;9334.449767877328;9375.962790327849;9953.601855925683;10147.847782283125 16:06:59 INFO - PROCESS | 2358 | __end_tp_report 16:06:59 INFO - PROCESS | 2358 | __start_cc_report 16:06:59 INFO - PROCESS | 2358 | _x_x_mozilla_cycle_collect,319 16:06:59 INFO - PROCESS | 2358 | __end_cc_report 16:06:59 INFO - PROCESS | 2358 | __startTimestamp1452384419943__endTimestamp 16:06:59 INFO - PROCESS | 2358 | 16:06:59 INFO - PROCESS | 2358 | ------- Summary: start ------- 16:06:59 INFO - PROCESS | 2358 | Number of tests: 6 16:06:59 INFO - PROCESS | 2358 | 16:06:59 INFO - PROCESS | 2358 | [#0] dojo.html Cycles:165 Average:5356.48 Median:5577.14 stddev:592.29 (10.6%) stddev-sans-first:569.53 16:06:59 INFO - PROCESS | 2358 | Values: 3204.1 3255.3 3279.0 3322.1 3323.8 5241.4 5377.9 5390.4 5395.6 5407.0 5304.8 5316.3 5322.8 5361.0 5428.8 4841.7 4894.2 4905.8 4943.3 4988.1 4608.4 4952.4 5016.6 5018.3 5049.2 4768.3 4781.6 4877.1 4909.5 4921.1 4870.8 4876.6 4883.7 4918.0 4920.9 4822.8 4826.9 4842.6 4853.3 4867.9 5142.6 5196.9 5216.8 5250.1 5366.1 5789.2 5792.3 5792.9 5794.4 5807.5 5830.4 5835.7 5840.1 5845.7 5848.8 5267.3 5346.7 5413.6 5473.5 5540.8 5843.2 5847.9 5851.6 5853.2 5853.6 5616.2 5617.6 5627.3 5629.9 5636.1 5659.4 5707.8 5769.5 5779.9 5782.9 5685.6 5703.5 5708.9 5719.5 5720.4 5697.8 5724.4 5726.9 5742.7 5781.4 4444.6 4449.1 4458.1 4466.0 4486.7 3921.8 3943.4 3949.6 3970.3 3984.7 5375.8 5399.1 5450.2 5476.4 5516.9 5763.0 5784.6 5804.8 5816.9 5818.0 5225.5 5341.4 5424.7 5426.0 5434.8 4937.6 5013.2 5014.8 5015.5 5063.7 5906.2 5973.6 6011.4 6021.4 6022.0 5582.2 5664.0 5720.8 5769.9 5782.8 6018.3 6030.7 6052.8 6056.9 6087.3 5764.9 5779.3 5784.7 5789.9 5802.2 5626.7 5699.7 5760.6 5868.9 5880.2 5693.2 5694.7 5698.2 5704.7 5739.3 5643.2 5653.6 5696.4 5704.3 5718.0 5480.2 5577.1 5585.8 5605.5 5666.2 5546.0 5575.4 5589.6 5594.8 5597.9 5505.4 5518.5 5521.8 5523.4 5582.3 16:06:59 INFO - PROCESS | 2358 | 16:06:59 INFO - PROCESS | 2358 | [#1] ext.html Cycles:180 Average:38984.00 Median:34831.15 stddev:57680.18 (165.6%) stddev-sans-first:57769.68 16:06:59 INFO - PROCESS | 2358 | Values: 519.4 534.3 559.8 567.6 573.6 35046.8 36017.8 36203.1 36206.3 36274.3 41084.6 41762.4 41844.6 41976.4 42142.0 8435.2 8583.4 8635.7 8638.9 8642.9 8366.8 8455.2 8522.9 8527.3 8538.8 8451.8 8506.5 8530.6 8535.1 8575.1 8439.4 8450.8 8496.1 8537.5 8558.7 8286.3 8373.8 8393.4 8417.3 8451.7 38196.2 38618.0 38749.2 38910.6 38922.2 2731.7 3040.7 3159.5 3271.4 3294.8 26751.7 27292.2 27574.2 27901.9 28154.6 3816.6 3838.7 3855.4 3903.5 3953.8 220620.0 223634.0 223714.0 224081.0 224255.0 50359.5 51594.7 53922.7 57179.1 58576.0 51314.0 51539.2 51597.7 51721.5 51726.5 12825.5 12963.7 13044.9 13058.4 13085.7 10240.6 10372.4 10385.1 10401.2 10517.6 18547.6 18802.3 18908.8 18923.0 18937.7 7676.0 7959.3 7963.2 8051.3 8052.6 849.9 889.9 948.2 977.9 1087.4 27535.9 27734.2 27802.3 27866.2 27879.7 1013.7 1028.0 1028.7 1085.6 1156.0 12986.9 13052.9 13210.9 13214.9 14999.6 240703.0 241131.0 241320.0 242001.0 244341.0 44848.3 45114.3 45150.5 45164.1 45378.0 1335.3 1339.3 1339.7 1345.3 1359.7 26351.5 28024.0 28492.9 28638.9 29151.9 42011.4 42093.4 42347.7 42408.8 42475.8 199753.0 200416.0 200886.0 201784.0 202052.0 30165.8 31485.7 32159.9 32336.2 32343.0 37146.3 37861.8 38010.0 38124.8 38196.0 32132.8 32574.5 32747.5 32967.0 33125.2 33825.2 34575.1 34645.8 35337.6 36199.0 31757.2 34557.0 34942.8 35128.6 35354.6 27416.7 31539.0 32225.0 32708.8 34719.5 23693.5 23779.6 23891.9 24088.5 24098.5 16:06:59 INFO - PROCESS | 2358 | 16:06:59 INFO - PROCESS | 2358 | [#2] jquery.html Cycles:180 Average:28094.34 Median:21354.83 stddev:88038.94 (412.3%) stddev-sans-first:88261.27 16:06:59 INFO - PROCESS | 2358 | Values: 357.8 360.7 360.9 361.2 367.1 16479.0 16872.4 17198.6 17273.0 17970.3 11212.3 11286.7 11302.6 12565.2 16199.7 4814.3 5005.8 5110.8 5461.1 5462.1 5328.6 5439.2 5442.3 5448.3 5455.5 4805.8 5853.3 5900.1 6015.3 6375.6 6327.0 6341.7 6410.8 6420.2 6644.4 6211.0 6388.8 6399.2 6409.3 6411.5 20742.2 21000.0 21434.4 22300.1 22456.2 2152.2 2152.8 2183.4 2223.8 2416.7 12641.4 13185.3 13271.0 13332.9 13671.9 1926.5 1934.3 1936.7 1942.7 1970.3 49780.0 50044.2 51014.7 54555.0 56256.7 14752.6 15061.2 15111.8 15133.2 15155.2 23194.8 23257.5 23300.7 23327.4 23577.4 8315.2 8325.4 8361.8 8362.9 8391.0 6976.9 7005.6 7012.9 7020.2 7059.4 7634.1 7679.2 7723.0 7783.5 7812.4 1791.6 1840.8 3038.3 3179.9 3188.8 844.5 892.6 900.3 982.6 1012.8 15191.6 15464.3 15760.2 16488.3 16497.3 886.0 924.3 942.5 955.0 1002.1 8658.9 8772.6 8894.6 9507.6 9718.3 529192.0 531514.0 538775.0 549466.0 550655.0 69984.0 70290.6 73270.3 73890.0 74364.0 1126.9 1127.9 1143.6 1145.8 1146.2 15203.6 15246.4 15301.7 15366.8 15627.0 32307.0 32463.8 32555.5 32746.8 33653.0 42342.6 42344.9 42364.2 42511.4 42792.6 7063.4 7356.3 7369.0 7450.4 7533.2 10413.8 10859.1 10970.7 11169.7 11259.0 9422.2 9836.4 9842.2 10001.3 10019.2 9455.9 10096.9 10109.2 10363.9 10411.9 10117.1 10216.5 10285.6 10328.6 10396.9 7463.9 7573.7 7577.1 7580.7 7642.3 9346.6 9413.5 10229.9 10271.3 10368.2 16:06:59 INFO - PROCESS | 2358 | 16:06:59 INFO - PROCESS | 2358 | [#3] mootools.html Cycles:180 Average:5502.01 Median:6602.92 stddev:2856.43 (43.3%) stddev-sans-first:2848.03 16:06:59 INFO - PROCESS | 2358 | Values: 1429.1 1435.8 1584.2 1737.6 1755.5 7326.6 7411.1 7426.3 7538.9 7739.5 7888.8 7918.0 7977.6 7990.4 8012.8 2292.4 2296.8 2323.3 2328.1 2329.7 2368.6 2390.1 2410.5 2413.7 2415.6 2260.2 2285.7 2309.2 2334.6 2344.5 2312.9 2323.3 2355.5 2358.7 2364.6 2361.2 2368.1 2371.4 2376.0 2385.1 7744.0 7776.3 7780.7 7782.4 7815.2 4903.4 5032.3 5033.8 5034.1 5051.2 3143.2 3203.4 3229.0 3233.7 3256.0 1012.9 1024.3 1045.4 1055.3 1071.4 10671.1 10850.5 10924.4 10939.7 10990.8 4184.6 4346.0 4348.1 4360.0 4391.8 8842.6 8869.2 8892.6 8900.8 8902.5 4848.9 4853.1 4857.9 4867.6 4870.0 4386.3 4387.9 4405.4 4423.8 4437.6 3406.3 3443.6 3461.5 3480.3 3499.9 1016.3 1055.2 1061.0 1069.4 1093.6 1072.9 1118.3 1157.4 1228.5 1308.3 7170.7 7229.9 7269.9 7300.7 7314.7 640.1 643.4 652.8 661.7 785.2 5528.1 5686.7 5711.0 5711.8 5812.3 9224.1 9430.4 9579.6 9628.7 9658.4 9462.7 9523.4 9539.5 9550.0 9599.0 7365.2 7410.7 7520.1 7535.5 7554.2 7299.5 7300.6 7307.9 7357.7 7365.0 8233.3 8569.8 8595.0 8609.6 8631.4 8405.0 8766.9 8812.3 8830.3 8899.9 6503.2 6631.3 6637.2 6644.7 6680.8 7305.5 7374.8 7380.8 7386.3 7394.4 6758.8 6810.7 6875.9 6909.9 7003.1 6936.2 7135.4 7191.4 7194.0 7230.5 7202.5 7218.7 7248.1 7248.6 7254.1 6626.8 6639.4 6666.4 6672.3 6710.1 6464.5 6598.4 6607.4 6609.8 6619.5 16:06:59 INFO - PROCESS | 2358 | 16:06:59 INFO - PROCESS | 2358 | [#4] prototype.html Cycles:180 Average:5529.73 Median:6209.36 stddev:1656.39 (26.7%) stddev-sans-first:1614.61 16:06:59 INFO - PROCESS | 2358 | Values: 341.6 352.2 352.2 356.9 357.2 6113.8 6206.5 6257.5 6265.2 6280.7 6038.7 6211.8 6212.2 6213.6 6234.2 4736.0 4755.6 4759.8 4761.0 4768.4 4758.8 4759.1 4773.6 4778.5 4782.1 4664.4 4676.2 4687.9 4692.7 4711.4 4689.3 4723.3 4725.4 4745.8 4747.3 4115.4 4140.2 4145.3 4150.6 4164.8 5870.3 5884.6 5892.6 5901.7 5905.3 5248.0 5419.7 5444.3 5448.5 5476.8 6527.1 6546.0 6546.5 6551.6 6566.6 4481.4 4503.0 4503.3 4507.7 4509.3 6656.0 6882.8 6898.9 6909.3 6935.0 4690.5 4755.9 4761.7 4772.1 4799.1 4844.3 4851.3 4857.4 4860.6 4861.6 5565.8 5568.3 5568.3 5572.1 5574.9 6396.7 6679.7 6734.6 6741.5 6746.1 1686.4 1718.0 1748.2 1749.2 1756.2 1156.3 1163.8 1164.1 1187.1 1208.3 6177.3 6184.8 6206.6 6206.9 6227.3 6749.7 6751.0 6755.5 6779.4 6787.8 6060.8 6191.6 6193.1 6198.8 6216.3 3669.5 3705.9 3706.5 3709.7 3716.9 7062.6 7095.4 7097.4 7101.4 7109.0 6733.3 6898.6 6953.6 6953.8 6963.0 6992.9 7000.1 7066.8 7082.8 7091.6 6737.2 6749.7 6765.9 6777.7 6780.9 6579.2 6669.4 6695.1 6712.7 6727.3 7003.3 7025.2 7038.6 7044.3 7068.8 4715.7 4740.5 4759.4 4762.8 4766.3 6633.0 6755.8 6772.6 6775.5 6905.5 6725.8 6729.5 6744.2 6746.1 6751.5 6695.4 6717.2 6722.6 6726.4 6733.5 6466.6 6596.1 6606.3 6611.3 6622.2 6745.9 6756.9 6767.2 6769.6 6797.7 6576.3 6584.3 6587.7 6615.0 6632.9 16:06:59 INFO - PROCESS | 2358 | 16:06:59 INFO - PROCESS | 2358 | [#5] yui.html Cycles:180 Average:13344.34 Median:25204.39 stddev:15263.14 (60.6%) stddev-sans-first:15276.44 16:06:59 INFO - PROCESS | 2358 | Values: 703.7 717.4 787.6 804.8 840.5 13480.5 13616.5 13674.3 13680.9 13718.9 12144.8 12183.9 12234.9 12237.1 12268.6 793.3 804.0 804.1 805.0 806.3 803.7 804.8 806.8 807.3 808.1 825.2 826.4 828.7 829.3 829.5 832.4 836.2 837.4 838.4 842.1 619.8 620.0 620.6 621.3 621.9 12395.0 12549.9 12572.9 12611.4 12616.6 10785.5 10806.4 10907.3 11112.7 11448.6 9810.5 9817.2 9904.2 9938.6 10188.9 3481.3 3514.9 3527.7 3548.9 3661.0 40996.2 41796.4 42963.8 44315.3 45882.0 10346.1 10506.9 10540.0 10556.8 10869.8 17906.2 17935.2 18012.9 18045.1 18069.1 7275.0 7417.0 7441.5 7532.2 7557.2 4226.5 4240.4 4248.8 4507.1 4526.8 2916.5 2925.1 2942.1 2945.8 2959.9 548.3 559.5 560.1 579.3 582.8 495.1 508.7 544.1 668.6 761.9 8281.3 8318.8 8431.8 9007.4 9177.2 535.6 551.3 586.7 626.3 689.9 3927.5 4079.3 4294.8 4441.3 4481.9 52215.2 52762.0 53048.7 53266.2 53301.0 47490.8 47826.3 48236.5 48296.3 48314.8 50182.2 51334.5 53344.5 53818.7 54035.7 8362.8 8460.4 8662.2 8714.8 8871.1 32653.2 33059.0 33219.0 33716.7 33757.8 39078.4 39171.4 41021.4 42134.2 42591.6 11160.3 11211.4 11280.9 11521.3 11546.1 11166.2 11289.5 11608.2 11844.4 11854.3 10937.6 11295.8 11491.1 11517.1 11603.4 10576.3 10747.6 10929.7 11130.9 11136.6 11148.9 11533.9 11731.9 11812.8 11831.1 9118.6 9135.3 9146.1 9214.6 9330.5 8959.2 9334.4 9376.0 9953.6 10147.8 16:06:59 INFO - PROCESS | 2358 | -------- Summary: end -------- 16:06:59 INFO - PROCESS | 2358 | 16:07:00 INFO - TEST-INFO | 2358: exit 0 16:07:00 INFO - TEST-OK | dromaeo_css | took 1110918ms 16:07:00 INFO - TEST-START | kraken 16:07:00 INFO - operating with platform_type : linux_ 16:07:00 INFO - Initialising browser for kraken test... 16:07:00 INFO - TEST-INFO | started process 2689 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4j20g2/profile http://localhost:46905/getInfo.html) 16:07:04 INFO - PROCESS | 2689 | 16:07:04 INFO - PROCESS | 2689 | (process:2836): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:07:04 INFO - PROCESS | 2689 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 16:07:05 INFO - PROCESS | 2689 | __metrics Screen width/height:1600/1200 16:07:05 INFO - PROCESS | 2689 | colorDepth:24 16:07:05 INFO - PROCESS | 2689 | Browser inner width/height: 1024/697 16:07:05 INFO - PROCESS | 2689 | __metrics 16:07:05 INFO - PROCESS | 2689 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:07:06 INFO - TEST-INFO | 2689: exit 0 16:07:06 INFO - Browser initialized. 16:07:06 INFO - Running cycle 1/1 for kraken test... 16:07:06 INFO - TEST-INFO | started process 2904 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4j20g2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:07:07 INFO - PROCESS | 2904 | 16:07:07 INFO - PROCESS | 2904 | (process:2970): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:07:17 INFO - PROCESS | 2904 | RSS: Main: 151121920 16:07:17 INFO - PROCESS | 2904 | 16:07:20 INFO - PROCESS | 2904 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46905/tests/kraken/driver.html?testName=audio-beat-detection) 16:07:20 INFO - PROCESS | 2904 | RSS: Main: 151785472 16:07:20 INFO - PROCESS | 2904 | 16:07:23 INFO - PROCESS | 2904 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46905/tests/kraken/driver.html?testName=audio-dft) 16:07:24 INFO - PROCESS | 2904 | RSS: Main: 152223744 16:07:24 INFO - PROCESS | 2904 | 16:07:27 INFO - PROCESS | 2904 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46905/tests/kraken/driver.html?testName=audio-fft) 16:07:27 INFO - PROCESS | 2904 | RSS: Main: 145895424 16:07:27 INFO - PROCESS | 2904 | 16:07:29 INFO - PROCESS | 2904 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46905/tests/kraken/driver.html?testName=audio-oscillator) 16:07:30 INFO - PROCESS | 2904 | RSS: Main: 147431424 16:07:30 INFO - PROCESS | 2904 | 16:07:32 INFO - PROCESS | 2904 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46905/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:07:33 INFO - PROCESS | 2904 | RSS: Main: 147206144 16:07:33 INFO - PROCESS | 2904 | 16:07:36 INFO - PROCESS | 2904 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46905/tests/kraken/driver.html?testName=imaging-darkroom) 16:07:36 INFO - PROCESS | 2904 | RSS: Main: 147091456 16:07:36 INFO - PROCESS | 2904 | 16:07:40 INFO - PROCESS | 2904 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46905/tests/kraken/driver.html?testName=imaging-desaturate) 16:07:40 INFO - PROCESS | 2904 | RSS: Main: 149147648 16:07:40 INFO - PROCESS | 2904 | 16:07:43 INFO - PROCESS | 2904 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46905/tests/kraken/driver.html?testName=json-parse-financial) 16:07:44 INFO - PROCESS | 2904 | RSS: Main: 149127168 16:07:44 INFO - PROCESS | 2904 | 16:07:45 INFO - PROCESS | 2904 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46905/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:07:46 INFO - PROCESS | 2904 | RSS: Main: 149352448 16:07:46 INFO - PROCESS | 2904 | 16:07:48 INFO - PROCESS | 2904 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46905/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:07:48 INFO - PROCESS | 2904 | RSS: Main: 149110784 16:07:48 INFO - PROCESS | 2904 | 16:07:51 INFO - PROCESS | 2904 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46905/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:07:51 INFO - PROCESS | 2904 | RSS: Main: 149000192 16:07:51 INFO - PROCESS | 2904 | 16:07:54 INFO - PROCESS | 2904 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46905/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:07:54 INFO - PROCESS | 2904 | RSS: Main: 149934080 16:07:54 INFO - PROCESS | 2904 | 16:07:57 INFO - PROCESS | 2904 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46905/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:07:57 INFO - PROCESS | 2904 | RSS: Main: 149155840 16:07:57 INFO - PROCESS | 2904 | 16:07:59 INFO - PROCESS | 2904 | Cycle 1(1): loaded http://localhost:46905/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46905/tests/kraken/driver.html?testName=ai-astar) 16:07:59 INFO - PROCESS | 2904 | RSS: Main: 149213184 16:07:59 INFO - PROCESS | 2904 | 16:07:59 INFO - PROCESS | 2904 | __start_tp_report 16:07:59 INFO - PROCESS | 2904 | _x_x_mozilla_page_load 16:07:59 INFO - PROCESS | 2904 | _x_x_mozilla_page_load_details 16:07:59 INFO - PROCESS | 2904 | |i|pagename|runs| 16:07:59 INFO - PROCESS | 2904 | |0;ai-astar;113;108;113;114;114;125;111;115;113;112 16:07:59 INFO - PROCESS | 2904 | |1;audio-beat-detection;149;137;145;163;129;156;166;131;177;129 16:07:59 INFO - PROCESS | 2904 | |2;audio-dft;161;161;163;163;161;162;165;170;165;163 16:07:59 INFO - PROCESS | 2904 | |3;audio-fft;73;72;72;75;73;137;72;72;73;71 16:07:59 INFO - PROCESS | 2904 | |4;audio-oscillator;97;97;142;97;96;98;146;98;98;140 16:07:59 INFO - PROCESS | 2904 | |5;imaging-gaussian-blur;110;110;110;110;110;109;109;110;110;109 16:07:59 INFO - PROCESS | 2904 | |6;imaging-darkroom;147;146;146;147;147;145;146;146;147;148 16:07:59 INFO - PROCESS | 2904 | |7;imaging-desaturate;96;96;96;98;96;97;96;96;96;96 16:07:59 INFO - PROCESS | 2904 | |8;json-parse-financial;57;59;57;57;61;56;58;59;54;55 16:07:59 INFO - PROCESS | 2904 | |9;json-stringify-tinderbox;68;69;69;68;69;69;68;68;70;69 16:07:59 INFO - PROCESS | 2904 | |10;stanford-crypto-aes;85;94;88;87;90;86;85;86;87;86 16:07:59 INFO - PROCESS | 2904 | |11;stanford-crypto-ccm;122;125;128;118;121;127;124;128;120;119 16:07:59 INFO - PROCESS | 2904 | |12;stanford-crypto-pbkdf2;148;161;158;154;151;155;151;153;149;140 16:07:59 INFO - PROCESS | 2904 | |13;stanford-crypto-sha256-iterative;69;73;72;67;68;67;69;68;68;67 16:07:59 INFO - PROCESS | 2904 | __end_tp_report 16:07:59 INFO - PROCESS | 2904 | __start_cc_report 16:07:59 INFO - PROCESS | 2904 | _x_x_mozilla_cycle_collect,764 16:07:59 INFO - PROCESS | 2904 | __end_cc_report 16:07:59 INFO - PROCESS | 2904 | __startTimestamp1452384479827__endTimestamp 16:07:59 INFO - PROCESS | 2904 | 16:07:59 INFO - PROCESS | 2904 | ------- Summary: start ------- 16:07:59 INFO - PROCESS | 2904 | Number of tests: 14 16:07:59 INFO - PROCESS | 2904 | 16:07:59 INFO - PROCESS | 2904 | [#0] ai-astar Cycles:10 Average:113.80 Median:113.50 stddev:4.39 (3.9%) stddev-sans-first:4.65 16:07:59 INFO - PROCESS | 2904 | Values: 113.0 108.0 113.0 114.0 114.0 125.0 111.0 115.0 113.0 112.0 16:07:59 INFO - PROCESS | 2904 | 16:07:59 INFO - PROCESS | 2904 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:152.50 stddev:16.98 (11.1%) stddev-sans-first:18.01 16:07:59 INFO - PROCESS | 2904 | Values: 149.0 137.0 145.0 163.0 129.0 156.0 166.0 131.0 177.0 129.0 16:07:59 INFO - PROCESS | 2904 | 16:07:59 INFO - PROCESS | 2904 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:2.76 (1.7%) stddev-sans-first:2.78 16:07:59 INFO - PROCESS | 2904 | Values: 161.0 161.0 163.0 163.0 161.0 162.0 165.0 170.0 165.0 163.0 16:07:59 INFO - PROCESS | 2904 | 16:07:59 INFO - PROCESS | 2904 | [#3] audio-fft Cycles:10 Average:79.00 Median:72.50 stddev:20.41 (28.1%) stddev-sans-first:21.53 16:07:59 INFO - PROCESS | 2904 | Values: 73.0 72.0 72.0 75.0 73.0 137.0 72.0 72.0 73.0 71.0 16:07:59 INFO - PROCESS | 2904 | 16:07:59 INFO - PROCESS | 2904 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:97.00 stddev:21.98 (22.7%) stddev-sans-first:22.73 16:07:59 INFO - PROCESS | 2904 | Values: 97.0 97.0 142.0 97.0 96.0 98.0 146.0 98.0 98.0 140.0 16:07:59 INFO - PROCESS | 2904 | 16:07:59 INFO - PROCESS | 2904 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 16:07:59 INFO - PROCESS | 2904 | Values: 110.0 110.0 110.0 110.0 110.0 109.0 109.0 110.0 110.0 109.0 16:07:59 INFO - PROCESS | 2904 | 16:07:59 INFO - PROCESS | 2904 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 16:07:59 INFO - PROCESS | 2904 | Values: 147.0 146.0 146.0 147.0 147.0 145.0 146.0 146.0 147.0 148.0 16:07:59 INFO - PROCESS | 2904 | 16:07:59 INFO - PROCESS | 2904 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 16:07:59 INFO - PROCESS | 2904 | Values: 96.0 96.0 96.0 98.0 96.0 97.0 96.0 96.0 96.0 96.0 16:07:59 INFO - PROCESS | 2904 | 16:07:59 INFO - PROCESS | 2904 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.50 stddev:2.06 (3.6%) stddev-sans-first:2.18 16:07:59 INFO - PROCESS | 2904 | Values: 57.0 59.0 57.0 57.0 61.0 56.0 58.0 59.0 54.0 55.0 16:07:59 INFO - PROCESS | 2904 | 16:07:59 INFO - PROCESS | 2904 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 16:07:59 INFO - PROCESS | 2904 | Values: 68.0 69.0 69.0 68.0 69.0 69.0 68.0 68.0 70.0 69.0 16:07:59 INFO - PROCESS | 2904 | 16:07:59 INFO - PROCESS | 2904 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:87.00 stddev:2.76 (3.2%) stddev-sans-first:2.78 16:07:59 INFO - PROCESS | 2904 | Values: 85.0 94.0 88.0 87.0 90.0 86.0 85.0 86.0 87.0 86.0 16:07:59 INFO - PROCESS | 2904 | 16:07:59 INFO - PROCESS | 2904 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:124.50 stddev:3.74 (3.0%) stddev-sans-first:3.94 16:07:59 INFO - PROCESS | 2904 | Values: 122.0 125.0 128.0 118.0 121.0 127.0 124.0 128.0 120.0 119.0 16:07:59 INFO - PROCESS | 2904 | 16:07:59 INFO - PROCESS | 2904 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.00 Median:153.50 stddev:5.79 (3.8%) stddev-sans-first:5.96 16:07:59 INFO - PROCESS | 2904 | Values: 148.0 161.0 158.0 154.0 151.0 155.0 151.0 153.0 149.0 140.0 16:07:59 INFO - PROCESS | 2904 | 16:07:59 INFO - PROCESS | 2904 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:68.50 stddev:2.10 (3.1%) stddev-sans-first:2.22 16:07:59 INFO - PROCESS | 2904 | Values: 69.0 73.0 72.0 67.0 68.0 67.0 69.0 68.0 68.0 67.0 16:07:59 INFO - PROCESS | 2904 | -------- Summary: end -------- 16:07:59 INFO - PROCESS | 2904 | 16:08:00 INFO - TEST-INFO | 2904: exit 0 16:08:00 INFO - TEST-OK | kraken | took 60057ms 16:08:00 INFO - TEST-START | v8_7 16:08:00 INFO - operating with platform_type : linux_ 16:08:00 INFO - Initialising browser for v8_7 test... 16:08:00 INFO - TEST-INFO | started process 3198 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3dQIsY/profile http://localhost:46905/getInfo.html) 16:08:04 INFO - PROCESS | 3198 | 16:08:04 INFO - PROCESS | 3198 | (process:3271): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:08:04 INFO - PROCESS | 3198 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 16:08:04 INFO - PROCESS | 3198 | __metrics Screen width/height:1600/1200 16:08:04 INFO - PROCESS | 3198 | colorDepth:24 16:08:04 INFO - PROCESS | 3198 | Browser inner width/height: 1024/697 16:08:04 INFO - PROCESS | 3198 | __metrics 16:08:04 INFO - PROCESS | 3198 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:08:05 INFO - TEST-INFO | 3198: exit 0 16:08:05 INFO - Browser initialized. 16:08:05 INFO - Running cycle 1/1 for v8_7 test... 16:08:05 INFO - TEST-INFO | started process 3320 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3dQIsY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:08:07 INFO - PROCESS | 3320 | 16:08:07 INFO - PROCESS | 3320 | (process:3377): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:08:17 INFO - PROCESS | 3320 | RSS: Main: 150769664 16:08:17 INFO - PROCESS | 3320 | 16:08:40 INFO - PROCESS | 3320 | Cycle 1(1): loaded http://localhost:46905/tests/v8_7/run.html (next: http://localhost:46905/tests/v8_7/run.html) 16:08:40 INFO - PROCESS | 3320 | RSS: Main: 146010112 16:08:40 INFO - PROCESS | 3320 | 16:08:40 INFO - PROCESS | 3320 | __start_tp_report 16:08:40 INFO - PROCESS | 3320 | _x_x_mozilla_page_load 16:08:40 INFO - PROCESS | 3320 | _x_x_mozilla_page_load_details 16:08:40 INFO - PROCESS | 3320 | |i|pagename|runs| 16:08:40 INFO - PROCESS | 3320 | |0;Richards;167.84155756965424 16:08:40 INFO - PROCESS | 3320 | |1;DeltaBlue;190.5850962454736 16:08:40 INFO - PROCESS | 3320 | |2;Encrypt;279.4857462269424 16:08:40 INFO - PROCESS | 3320 | |3;Decrypt;5235.602094240838 16:08:40 INFO - PROCESS | 3320 | |4;RayTrace;1057.0824524312895 16:08:40 INFO - PROCESS | 3320 | |5;Earley;706.2146892655368 16:08:40 INFO - PROCESS | 3320 | |6;Boyer;12370.37037037037 16:08:40 INFO - PROCESS | 3320 | |7;RegExp;41714.28571428572 16:08:40 INFO - PROCESS | 3320 | |8;Splay;595.1248513674198 16:08:40 INFO - PROCESS | 3320 | |9;NavierStokes;4840.579710144928 16:08:40 INFO - PROCESS | 3320 | __end_tp_report 16:08:40 INFO - PROCESS | 3320 | __startTimestamp1452384520345__endTimestamp 16:08:40 INFO - PROCESS | 3320 | 16:08:40 INFO - PROCESS | 3320 | ------- Summary: start ------- 16:08:40 INFO - PROCESS | 3320 | Number of tests: 10 16:08:40 INFO - PROCESS | 3320 | 16:08:40 INFO - PROCESS | 3320 | [#0] Richards Cycles:1 Average:167.84 Median:167.84 stddev:0.00 (0.0%) 16:08:40 INFO - PROCESS | 3320 | Values: 167.8 16:08:40 INFO - PROCESS | 3320 | 16:08:40 INFO - PROCESS | 3320 | [#1] DeltaBlue Cycles:1 Average:190.59 Median:190.59 stddev:0.00 (0.0%) 16:08:40 INFO - PROCESS | 3320 | Values: 190.6 16:08:40 INFO - PROCESS | 3320 | 16:08:40 INFO - PROCESS | 3320 | [#2] Encrypt Cycles:1 Average:279.49 Median:279.49 stddev:0.00 (0.0%) 16:08:40 INFO - PROCESS | 3320 | Values: 279.5 16:08:40 INFO - PROCESS | 3320 | 16:08:40 INFO - PROCESS | 3320 | [#3] Decrypt Cycles:1 Average:5235.60 Median:5235.60 stddev:0.00 (0.0%) 16:08:40 INFO - PROCESS | 3320 | Values: 5235.6 16:08:40 INFO - PROCESS | 3320 | 16:08:40 INFO - PROCESS | 3320 | [#4] RayTrace Cycles:1 Average:1057.08 Median:1057.08 stddev:0.00 (0.0%) 16:08:40 INFO - PROCESS | 3320 | Values: 1057.1 16:08:40 INFO - PROCESS | 3320 | 16:08:40 INFO - PROCESS | 3320 | [#5] Earley Cycles:1 Average:706.21 Median:706.21 stddev:0.00 (0.0%) 16:08:40 INFO - PROCESS | 3320 | Values: 706.2 16:08:40 INFO - PROCESS | 3320 | 16:08:40 INFO - PROCESS | 3320 | [#6] Boyer Cycles:1 Average:12370.37 Median:12370.37 stddev:0.00 (0.0%) 16:08:40 INFO - PROCESS | 3320 | Values: 12370.4 16:08:40 INFO - PROCESS | 3320 | 16:08:40 INFO - PROCESS | 3320 | [#7] RegExp Cycles:1 Average:41714.29 Median:41714.29 stddev:0.00 (0.0%) 16:08:40 INFO - PROCESS | 3320 | Values: 41714.3 16:08:40 INFO - PROCESS | 3320 | 16:08:40 INFO - PROCESS | 3320 | [#8] Splay Cycles:1 Average:595.12 Median:595.12 stddev:0.00 (0.0%) 16:08:40 INFO - PROCESS | 3320 | Values: 595.1 16:08:40 INFO - PROCESS | 3320 | 16:08:40 INFO - PROCESS | 3320 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 16:08:40 INFO - PROCESS | 3320 | Values: 4840.6 16:08:40 INFO - PROCESS | 3320 | -------- Summary: end -------- 16:08:40 INFO - PROCESS | 3320 | 16:08:41 INFO - TEST-INFO | 3320: exit 0 16:08:41 INFO - TEST-OK | v8_7 | took 40498ms 16:08:41 INFO - SUITE-END | took 1211s 16:08:41 INFO - Completed test suite (00:20:11) 16:08:41 INFO - Working with test: dromaeo_css 16:08:41 INFO - Generating results file: dromaeo_css 16:08:41 INFO - Working with test: kraken 16:08:41 INFO - Generating results file: kraken 16:08:41 INFO - javascript benchmark 16:08:41 INFO - Working with test: v8_7 16:08:41 INFO - Generating results file: v8_7 16:08:41 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:08:41 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 16:08:41 INFO - process_Request line: dromaeo_css 6929.23 graph.html#tests=[[72,1,43]] 16:08:41 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:08:41 INFO - process_Request line: kraken 1525.20 graph.html#tests=[[232,1,43]] 16:08:41 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:08:41 INFO - process_Request line: v8_7 20350.71 graph.html#tests=[[230,1,43]] 16:08:41 INFO - RETURN: dromaeo_css: 6929.23 16:08:41 INFO - RETURN: kraken: 1525.20 16:08:41 INFO - RETURN: v8_7: 20350.71 16:08:41 INFO - javascript benchmark 16:08:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3204.1028512016637, 3255.348930213958, 3278.967210327896, 3322.0864262327855, 3323.8171900545476, 5241.42344342123, 5377.946220537793, 5390.434004429532, 5395.568354531638, 5407.0, 5304.840854774353, 5316.282301889244, 5322.787088516455, 5361.0, 5428.83713488595, 4841.6852904561265, 4894.1924582444035, 4905.82829600964, 4943.307936888838, 4988.052270068693, 4608.446986361624, 4952.380952380952, 5016.573591244749, 5018.2974383586325, 5049.192129259319, 4768.2847572864175, 4781.593564547018, 4877.122118018755, 4909.509049095098, 4921.064997650471, 4870.805167793284, 4876.561109500162, 4883.682560633548, 4918.04098200851, 4920.926186107211, 4822.758862056919, 4826.903461930777, 4842.564169224752, 4853.320535125085, 4867.902641947177, 5142.588592912558, 5196.948030519684, 5216.843494695127, 5250.08123578376, 5366.060939335601, 5789.247397838296, 5792.333881603585, 5792.913106303409, 5794.391588883191, 5807.477327040587, 5830.4169583041785, 5835.679037652927, 5840.123981402781, 5845.736941837585, 5848.824535263949, 5267.315249017642, 5346.705931173784, 5413.648112872651, 5473.507384335429, 5540.806071787549, 5843.2403787507355, 5847.912281315784, 5851.61964472308, 5853.239078919713, 5853.560982926212, 5616.241807356037, 5617.606767526316, 5627.324721033502, 5629.943700563023, 5636.070048442043, 5659.43405659439, 5707.828765137053, 5769.509591684669, 5779.855503612359, 5782.913256301159, 5685.602007859493, 5703.486686198179, 5708.885822283614, 5719.456651618173, 5720.370759216483, 5697.772089116472, 5724.398938111438, 5726.914096288559, 5742.655440673573, 5781.421857814269, 4444.644428445717, 4449.087936972913, 4458.108378324348, 4466.017476155241, 4486.663500237495, 3921.8235179416993, 3943.428202910562, 3949.6247856454165, 3970.305196590585, 3984.7210695251633, 5375.7849686012905, 5399.136138217867, 5450.236966824647, 5476.424975377608, 5516.862078447991, 5763.0, 5784.566157538202, 5804.767809287581, 5816.88366232673, 5818.0, 5225.477452254744, 5341.359036915517, 5424.7016414096815, 5425.996190704732, 5434.782608695687, 4937.629677774109, 5013.24801279811, 5014.824481143142, 5015.548600625962, 5063.721495317719, 5906.232189815297, 5973.551983601247, 6011.428914253139, 6021.42796434338, 6022.036474164112, 5582.190582365615, 5664.0371136906, 5720.8283751487525, 5769.94230057694, 5782.797602083907, 6018.277806663228, 6030.698465076816, 6052.818415447544, 6056.939430605637, 6087.2999605044215, 5764.913526297025, 5779.335376431764, 5784.681842498703, 5789.884202316014, 5802.245708057925, 5626.718664066862, 5699.743511542073, 5760.596758226884, 5868.853278668067, 5880.206172166702, 5693.202951586864, 5694.658320500783, 5698.20225168485, 5704.714764261687, 5739.253896993364, 5643.209950607001, 5653.632513886584, 5696.373398926197, 5704.3154821421695, 5718.027935251101, 5480.205370221216, 5577.135543990688, 5585.832425027255, 5605.5235304997905, 5666.206731057738, 5546.029444847216, 5575.386707462095, 5589.608727389043, 5594.832155035356, 5597.860053498695, 5505.394406615349, 5518.503334699736, 5521.806736764354, 5523.392426832965, 5582.302212223472], "unit": "score", "name": "dojo.html", "value": 5318.589714784928}, {"lowerIsBetter": false, "replicates": [519.4441947116585, 534.2867272191625, 559.8131960244283, 567.639548886457, 573.6099452372388, 35046.82476587617, 36017.81991090047, 36203.094922626915, 36206.2758744825, 36274.27451450973, 41084.58915410852, 41762.373564396556, 41844.58155418445, 41976.37035444463, 42142.0, 8435.198656127657, 8583.442076265022, 8635.740927772145, 8638.913610863874, 8642.913570864273, 8366.83266334673, 8455.154484551556, 8522.87215691762, 8527.317814574819, 8538.829223415529, 8451.83096338073, 8506.489610623383, 8530.616122274481, 8535.103814099522, 8575.099614540477, 8439.367047471433, 8450.830983380298, 8496.107908669625, 8537.530435826027, 8558.70044548441, 8286.254237118688, 8373.83252334956, 8393.370497212734, 8417.326613870937, 8451.704190353308, 38196.23607527862, 38618.03454913622, 38749.225015499534, 38910.61089389098, 38922.22155556873, 2731.6721993360725, 3040.6959304069637, 3159.4944808830705, 3271.3947919634943, 3294.7528935329947, 26751.732482675314, 27292.181234562795, 27574.172774816787, 27901.860490697618, 28154.577681334795, 3816.637419445148, 3838.673712734421, 3855.4409610606585, 3903.512060992376, 3953.782541960191, 220620.0, 223634.0, 223714.0, 224081.0, 224255.0, 50359.49640503548, 51594.74202628963, 53922.7303863486, 57179.14231286534, 58576.0, 51314.0, 51539.22691159636, 51597.7420112897, 51721.48278517242, 51726.48273517292, 12825.486980520862, 12963.740725185444, 13044.869551304555, 13058.412371443308, 13085.672858178621, 10240.590376384862, 10372.42951637652, 10385.117265032406, 10401.219908506891, 10517.579296828042, 18547.629047419246, 18802.34191803308, 18908.81091189098, 18923.0, 18937.715934260996, 7675.961620191975, 7959.323457506177, 7963.203679632106, 8051.275385215242, 8052.637631306605, 849.9447535910147, 889.8620713789373, 948.2271948362063, 977.8656758160641, 1087.363892123101, 27535.86232068827, 27734.167974960783, 27802.304942376602, 27866.16401507958, 27879.745411456533, 1013.6502906497394, 1027.984580231297, 1028.7016765138026, 1085.592902661502, 1155.976880462403, 12986.870131298756, 13052.934735326262, 13210.933945330213, 13214.867851321556, 14999.625009374853, 240703.0, 241131.0, 241320.0, 242001.0, 244341.0, 44848.3272750909, 45114.32328515075, 45150.54849451529, 45164.096718065455, 45378.0, 1335.3189873164756, 1339.2968691437075, 1339.7387509435566, 1345.3340596404842, 1359.7484465373936, 26351.472970540097, 28024.0, 28492.857535712188, 28638.85680571667, 29151.854240728662, 42011.36982945197, 42093.36859947042, 42347.70653668291, 42408.78795606002, 42475.787621061696, 199753.0, 200416.0, 200886.0, 201784.0, 202052.0, 30165.849170754005, 31485.740570377846, 32159.874404395734, 32336.191595210308, 32343.0, 37146.25707485781, 37861.81069094747, 38010.0497487565, 38124.809375952944, 38196.0, 32132.83933580317, 32574.511382329758, 32747.508787367733, 32967.0, 33125.17187070342, 33825.15437114092, 34575.13562160966, 34645.826770865984, 35337.64662353344, 36199.0, 31757.20606984844, 34557.0, 34942.825285873405, 35128.648713512535, 35354.64645353513, 27416.725832742217, 31539.0, 32225.0, 32708.836455817567, 34719.4792078114, 23693.526129477657, 23779.64330535078, 23891.880540597187, 24088.51822963496, 24098.51802963966], "unit": "score", "name": "ext.html", "value": 17166.375872786895}, {"lowerIsBetter": false, "replicates": [357.80678433645835, 360.6519708481315, 360.91879327151383, 361.22877656204, 367.0932795993894, 16479.0, 16872.409465668705, 17198.57003574911, 17273.0, 17970.281188752433, 11212.27120237184, 11286.661400157987, 11302.604408845693, 12565.246085234892, 16199.676006479864, 4814.301926220696, 5005.824796132136, 5110.795568177287, 5461.098918678414, 5462.071447853875, 5328.600354973373, 5439.211314359415, 5442.265294185294, 5448.318960129984, 5455.454454554532, 4805.759712014403, 5853.32686741026, 5900.144479050535, 6015.308239552463, 6375.617462952215, 6327.01931200667, 6341.651209183493, 6410.8076757697345, 6420.1974753155855, 6644.402003819631, 6210.96894515529, 6388.840278993016, 6399.168108145911, 6409.262934762515, 6411.455026322768, 20742.170313187453, 21000.0, 21434.356969290948, 22300.107995680155, 22456.214032508946, 2152.2251989283845, 2152.849300548962, 2183.4213933307688, 2223.8220942324574, 2416.673749043874, 12641.431135598828, 13185.34073296341, 13271.0, 13332.866671333259, 13671.931640341834, 1926.5472613935715, 1934.2746470073723, 1936.74822273105, 1942.65032294187, 1970.290695349673, 49779.999999999636, 50044.249336259985, 51014.7449262755, 54555.0, 56256.71871640656, 14752.63118422048, 15061.246937653073, 15111.773323400157, 15133.243337833064, 15155.242237888062, 23194.840257987034, 23257.53484930292, 23300.65049024266, 23327.41681457977, 23577.41056473602, 8315.210055044761, 8325.375596830141, 8361.832763344699, 8362.916370836214, 8391.0, 6976.860462790817, 7005.649717514206, 7012.9298707013295, 7020.1575810901995, 7059.364657180879, 7634.122075961224, 7679.232076792276, 7723.0, 7783.532988020624, 7812.375009999187, 1791.570023194424, 1840.8343249107645, 3038.255627371308, 3179.856906439216, 3188.8086714797187, 844.514404217565, 892.5804871710286, 900.2797761790672, 982.597135174575, 1012.8126296635146, 15191.632753052278, 15464.304106315243, 15760.211989400485, 16488.34046638121, 16497.257623406975, 885.9557022148866, 924.2790623313826, 942.458086600194, 955.0278674537059, 1002.0780881588955, 8658.913410865936, 8772.605232764541, 8894.644214231359, 9507.619695212252, 9718.319717619841, 529192.0, 531514.0, 538775.0, 549466.0, 550655.0, 69984.0, 70290.64854675694, 73270.26729732634, 73890.0, 74364.0, 1126.9154813388864, 1127.8984891359653, 1143.6397534776518, 1145.7937571237258, 1146.2377518949804, 15203.61990950191, 15246.3901443941, 15301.693966120838, 15366.769498457756, 15627.0, 32307.0, 32463.837680811444, 32555.511667324536, 32746.836265818518, 33653.0, 42342.57657423386, 42344.94137646584, 42364.152716944875, 42511.3623295657, 42792.57207427886, 7063.39961103312, 7356.301151390609, 7368.963155184189, 7450.441216908645, 7533.209013053551, 10413.791724165625, 10859.131269498263, 10970.670879873616, 11169.664910052712, 11259.0, 9422.152006319464, 9836.3606365586, 9842.163416109424, 10001.2999090063, 10019.198464122706, 9455.905440945502, 10096.899031009889, 10109.241806864662, 10363.94818025905, 10411.865567558481, 10117.140043096419, 10216.489175541044, 10285.588576456857, 10328.638497652546, 10396.896031039592, 7463.850722985619, 7573.734919277799, 7577.128630207597, 7580.658870350737, 7642.273983971514, 9346.579403926704, 9413.482258475575, 10229.948850255701, 10271.281010329205, 10368.170546356425], "unit": "score", "name": "jquery.html", "value": 8804.519043373746}, {"lowerIsBetter": false, "replicates": [1429.0782445322768, 1435.8133442652456, 1584.192062048355, 1737.5916659585002, 1755.5260079778461, 7326.633668316583, 7411.0736157980255, 7426.257374262571, 7538.924610753891, 7739.4969326993705, 7888.763337099882, 7917.960410197956, 7977.56123413212, 7990.440669153161, 8012.799680007988, 2292.358139720881, 2296.7932886040294, 2323.256557901472, 2328.1036800831716, 2329.697139371879, 2368.5973384524586, 2390.103711108334, 2410.529946660402, 2413.746556611548, 2415.6376543518527, 2260.242818655752, 2285.714285714286, 2309.2379514760087, 2334.5681049005902, 2344.460774021976, 2312.884355782221, 2323.349462150592, 2355.5406695694346, 2358.7287461941924, 2364.5861974154454, 2361.173589243751, 2368.0882860098814, 2371.395294199985, 2375.9762402375927, 2385.0698227691214, 7744.0319960005, 7776.300132988002, 7780.688772449095, 7782.416318776058, 7815.179406162385, 4903.436104847952, 5032.295478632995, 5033.798648054073, 5034.14419548674, 5051.166557518005, 3143.1513491357205, 3203.4073696366013, 3229.0474310078584, 3233.676632336771, 3255.983720081408, 1012.8683271174774, 1024.293237666008, 1045.383223897904, 1055.3298655353906, 1071.3518321415509, 10671.092957098655, 10850.457477126112, 10924.399158046224, 10939.726506837313, 10990.780184396268, 4184.581541845852, 4345.97827010863, 4348.065165989265, 4359.978200108979, 4391.780410979502, 8842.557872106368, 8869.157430044135, 8892.64429422816, 8900.821983560292, 8902.465852048897, 4848.854534363974, 4853.053654537332, 4857.854264372075, 4867.586255168279, 4869.975650121798, 4386.320120381346, 4387.868363949086, 4405.449318835145, 4423.8230470781455, 4437.622802061861, 3406.267652454734, 3443.6212016678146, 3461.480777883338, 3480.269143479847, 3499.8600055997986, 1016.3038318751679, 1055.2349546578823, 1060.9681709548572, 1069.427856097, 1093.6172339681207, 1072.855164552791, 1118.3178261260625, 1157.386585109893, 1228.4717571444364, 1308.3196737696535, 7170.749023784142, 7229.915512673141, 7269.89095163573, 7300.707971681073, 7314.743983960536, 640.0591131037368, 643.3759253524167, 652.807421810567, 661.7386132477644, 785.2304741353505, 5528.143137813645, 5686.715664216773, 5711.029125048752, 5711.8000869969355, 5812.3025236971835, 9224.123708247706, 9430.3870248435, 9579.568919398644, 9628.66299679522, 9658.420494770337, 9462.668806591737, 9523.428594284365, 9539.47532885684, 9549.952250238704, 9598.95200523993, 7365.226651201654, 7410.666520006613, 7520.1351844537485, 7535.472516923763, 7554.206808285161, 7299.489035767445, 7300.634968251672, 7307.853842923006, 7357.705691772483, 7364.96317518409, 8233.300169485661, 8569.785755356166, 8595.0, 8609.569521523774, 8631.43895646781, 8404.957975210085, 8766.868496972424, 8812.2950163988, 8830.337724670548, 8899.911000889908, 6503.2196136462035, 6631.336866313523, 6637.236717777518, 6644.7009884554345, 6680.832979175365, 7305.52514086604, 7374.778756637309, 7380.815479613053, 7386.2613738625705, 7394.4454165936695, 6758.797236082925, 6810.727570897108, 6875.896861547181, 6909.930900690929, 7003.054587630605, 6936.158183684656, 7135.357817796424, 7191.352778249982, 7193.964030179815, 7230.530015548972, 7202.49582529218, 7218.711251549879, 7248.130224373109, 7248.565086094851, 7254.129504459499, 6626.801195964129, 6639.402453779183, 6666.400023997863, 6672.332766723289, 6710.127683401127, 6464.450521705708, 6598.439132673584, 6607.405333520006, 6609.768658096944, 6619.470442364503], "unit": "score", "name": "mootools.html", "value": 4474.477003310733}, {"lowerIsBetter": false, "replicates": [341.6327447993407, 352.1882061847444, 352.2075330506361, 356.89650001499564, 357.2479929747881, 6113.847153821157, 6206.5034797216285, 6257.5306851986115, 6265.248170219575, 6280.748770049204, 6038.728257228424, 6211.844703882394, 6212.161358216639, 6213.596116252452, 6234.158388617535, 4735.9526404736025, 4755.619550435957, 4759.762011899408, 4761.0, 4768.356271903301, 4758.809647614108, 4759.119562880878, 4773.594244489223, 4778.498257682945, 4782.091402633506, 4664.440267167927, 4676.181668208067, 4687.92968105477, 4692.6949748266425, 4711.363965864616, 4689.2966055091665, 4723.338732577442, 4725.432948046222, 4745.810167593292, 4747.311639812242, 4115.382692596105, 4140.15126898988, 4145.295299799011, 4150.605692459211, 4164.8125834337525, 5870.26621672291, 5884.588078834483, 5892.558058145613, 5901.675407852566, 5905.261842269716, 5247.9737601311745, 5419.729013549346, 5444.265024221719, 5448.509634132947, 5476.7535460904355, 6527.053577231322, 6545.952647576365, 6546.541742078057, 6551.6069035858, 6566.606003639797, 4481.417415735966, 4503.03184815263, 4503.311258278146, 4507.706999045052, 4509.346144808985, 6656.0, 6882.793516194472, 6898.896516552256, 6909.3090690931, 6935.0, 4690.507496712864, 4755.9286610700865, 4761.666683332133, 4772.117158325721, 4799.112164249625, 4844.346013288161, 4851.272309153655, 4857.441394239708, 4860.586850117709, 4861.562459378602, 5565.805196818092, 5568.276124103922, 5568.303962004749, 5572.08060669993, 5574.944250557523, 6396.680165991682, 6679.699413526403, 6734.56225345351, 6741.52809303344, 6746.0892779475125, 1686.3844696685621, 1717.9914100429419, 1748.1608827762745, 1749.2215963895944, 1756.1570446185901, 1156.329328989201, 1163.8312444695641, 1164.121088578135, 1187.1215300677436, 1208.3173007250875, 6177.289611694712, 6184.752609895644, 6206.627602343783, 6206.875862482815, 6227.283862355887, 6749.730010799513, 6751.0, 6755.527113102035, 6779.389854913082, 6787.762428315084, 6060.787872424444, 6191.628502289877, 6193.071039344044, 6198.845028874314, 6216.285127210429, 3669.541307336583, 3705.925881482355, 3706.4810926470313, 3709.666130048309, 3716.851325946986, 7062.611556364346, 7095.3968912643, 7097.361237488548, 7101.360877521048, 7108.964455177691, 6733.293004234485, 6898.586084834926, 6953.582785032914, 6953.79138625842, 6962.965185174042, 6992.860142797115, 7000.124984376851, 7066.823329416806, 7082.804330657513, 7091.60996145217, 6737.191537015589, 6749.696263668245, 6765.864682706417, 6777.728890844311, 6780.864382712417, 6579.243387010363, 6669.433098186709, 6695.12963314766, 6712.731490740316, 6727.260001399744, 7003.299670032956, 7025.227225005143, 7038.577685338896, 7044.330788575282, 7068.823279418056, 4715.693479923794, 4740.502247263988, 4759.405074365704, 4762.78567464458, 4766.308885211694, 6632.966835165987, 6755.7973260802255, 6772.5936443813525, 6775.457963363017, 6905.482088843457, 6725.798226053226, 6729.528932974645, 6744.156980377453, 6746.089277947414, 6751.527393082437, 6695.426574755026, 6717.227518835396, 6722.596644201363, 6726.428253598303, 6733.528652994243, 6466.644334561644, 6596.142501474777, 6606.273309935807, 6611.272759996493, 6622.1722284714415, 6745.865082698417, 6756.932430675631, 6767.1879374475375, 6769.627670477974, 6797.660116994031, 6576.2766095728475, 6584.275729669828, 6587.736490540325, 6614.966925165343, 6632.900506492503], "unit": "score", "name": "prototype.html", "value": 4997.209934066128}, {"lowerIsBetter": false, "replicates": [703.7360989628886, 717.3687155303332, 787.5904529644583, 804.7746630943336, 840.5377042626558, 13480.52818151365, 13616.45534178634, 13674.316284185788, 13680.863191368084, 13718.862811371884, 12144.757104857898, 12183.878161218407, 12234.93882530586, 12237.0822188336, 12268.570600029001, 793.345489970775, 804.0190967020226, 804.0793291681022, 805.046020465747, 806.2622700229313, 803.7186984555417, 804.798800299925, 806.846699127164, 807.289585165054, 808.1191501263621, 825.1995564302617, 826.3513142183388, 828.7306625346756, 829.3199576347398, 829.4649950781742, 832.3590835057003, 836.1596595421623, 837.4431003382743, 838.4005436113148, 842.0989541190928, 619.8357435279654, 619.9938000619982, 620.5594028239955, 621.3103455164763, 621.940915613016, 12395.0, 12549.93725031369, 12572.874271257262, 12611.36943152848, 12616.621501354974, 10785.514651840607, 10806.405647689375, 10907.34555926639, 11112.666620001413, 11448.599299024494, 9810.509474526245, 9817.214622830157, 9904.207663386911, 9938.602455901755, 10188.898111018869, 3481.3211423772373, 3514.947275790865, 3527.735419843522, 3548.91127721809, 3660.981695091534, 40996.1800763986, 41796.37305440421, 42963.785181073894, 44315.33526997098, 45882.0, 10346.120579750655, 10506.894931050745, 10540.0, 10556.841647375142, 10869.83695244572, 17906.194221260073, 17935.192916318796, 18012.9099354505, 18045.097745112693, 18069.096545172688, 7274.96362518184, 7416.96291518539, 7441.516301440389, 7532.17146113927, 7557.206493318233, 4226.450561426995, 4240.448741663564, 4248.830046798155, 4507.121111383249, 4526.773661316921, 2916.460454815866, 2925.1078421081775, 2942.087952734659, 2945.779066569973, 2959.9112026639236, 548.2790130977752, 559.454531831461, 560.117814442255, 579.261441661876, 582.775631381921, 495.14093048560716, 508.67953189490385, 544.1266766839245, 668.620535492522, 761.8514389694068, 8281.254687078072, 8318.750437486886, 8431.831363372821, 9007.36948413618, 9177.21993630549, 535.6491498068771, 551.3053552523849, 586.7095787585173, 626.3360837512251, 689.9034135221073, 3927.48942637461, 4079.265732168238, 4294.763787991628, 4441.289393696993, 4481.932771008437, 52215.216771748455, 52762.0, 53048.73475632597, 53266.20100698493, 53301.0, 47490.76254618705, 47826.28260576094, 48236.517634823904, 48296.27555586669, 48314.75842620764, 50182.24726629104, 51334.48665513372, 53344.46655533473, 53818.73090634522, 54035.72982135143, 8362.790930226549, 8460.407771456184, 8662.220400163764, 8714.782130446789, 8871.112888711077, 32653.18367040843, 33059.0, 33219.0, 33716.66283337135, 33757.83121084477, 39078.413823793235, 39171.41242881302, 41021.38467923043, 42134.15731685411, 42591.57408425876, 11160.274582152135, 11211.439428028729, 11280.887191127984, 11521.251118677594, 11546.076313895037, 11166.162537809534, 11289.548418063514, 11608.24546404481, 11844.407779611158, 11854.348010859141, 10937.562497500328, 11295.7740845181, 11491.08071354273, 11517.136214784092, 11603.419829008348, 10576.312539684895, 10747.623833165802, 10929.726756830825, 11130.944345278222, 11136.554537818396, 11148.888511114785, 11533.884661153617, 11731.88268117342, 11812.76374472523, 11831.05351571855, 9118.589663465293, 9135.26917846584, 9146.085391460801, 9214.631414743335, 9330.533473326172, 8959.238464730572, 9334.449767877328, 9375.962790327849, 9953.601855925683, 10147.847782283125], "unit": "score", "name": "yui.html", "value": 6157.778512960638}], "name": "dromaeo_css", "value": 6929.228761429505}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 113.0, 114.0, 114.0, 125.0, 111.0, 115.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 113.8}, {"lowerIsBetter": true, "replicates": [149.0, 137.0, 145.0, 163.0, 129.0, 156.0, 166.0, 131.0, 177.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 148.2}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 163.0, 163.0, 161.0, 162.0, 165.0, 170.0, 165.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.4}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 72.0, 75.0, 73.0, 137.0, 72.0, 72.0, 73.0, 71.0], "unit": "score", "name": "audio-fft", "value": 79.0}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 142.0, 97.0, 96.0, 98.0, 146.0, 98.0, 98.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 110.9}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 147.0, 147.0, 145.0, 146.0, 146.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 98.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [57.0, 59.0, 57.0, 57.0, 61.0, 56.0, 58.0, 59.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 68.0, 69.0, 69.0, 68.0, 68.0, 70.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [85.0, 94.0, 88.0, 87.0, 90.0, 86.0, 85.0, 86.0, 87.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.4}, {"lowerIsBetter": true, "replicates": [122.0, 125.0, 128.0, 118.0, 121.0, 127.0, 124.0, 128.0, 120.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.2}, {"lowerIsBetter": true, "replicates": [148.0, 161.0, 158.0, 154.0, 151.0, 155.0, 151.0, 153.0, 149.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.0}, {"lowerIsBetter": true, "replicates": [69.0, 73.0, 72.0, 67.0, 68.0, 67.0, 69.0, 68.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1525.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.84155756965424], "unit": "score", "name": "Richards", "value": 210.32931599999992}, {"lowerIsBetter": false, "replicates": [190.5850962454736], "unit": "score", "name": "DeltaBlue", "value": 346.9211459999999}, {"lowerIsBetter": false, "replicates": [279.4857462269424], "unit": "score", "name": "Encrypt", "value": 952.3956179999999}, {"lowerIsBetter": false, "replicates": [5235.602094240838], "unit": "score", "name": "Decrypt", "value": 50.84057100000005}, {"lowerIsBetter": false, "replicates": [1057.0824524312895], "unit": "score", "name": "RayTrace", "value": 700.0295939999999}, {"lowerIsBetter": false, "replicates": [706.2146892655368], "unit": "score", "name": "Earley", "value": 943.711608}, {"lowerIsBetter": false, "replicates": [12370.37037037037], "unit": "score", "name": "Boyer", "value": 53.87575149700595}, {"lowerIsBetter": false, "replicates": [41714.28571428572], "unit": "score", "name": "RegExp", "value": 21.83868150684931}, {"lowerIsBetter": false, "replicates": [595.1248513674198], "unit": "score", "name": "Splay", "value": 136.93093106893107}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20350.706230847463}]} 16:08:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20350.71"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1525.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6929.23"}}} 16:08:41 INFO - Return code: 0 16:08:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:08:41 INFO - # TBPL SUCCESS # 16:08:41 INFO - Running post-action listener: _resource_record_post_action 16:08:41 INFO - Running post-run listener: _resource_record_post_run 16:08:42 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 4096; Write bytes: 562683904; Read time: 172; Write time: 396484 16:08:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 245403648; Read time: 0; Write time: 198060 16:08:42 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 317280256; Read time: 172; Write time: 198424 16:08:42 INFO - Running post-run listener: _upload_blobber_files 16:08:42 INFO - Blob upload gear active. 16:08:42 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:08:42 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 16:08:42 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'] 16:08:42 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 16:08:43 INFO - (blobuploader) - INFO - Open directory for files ... 16:08:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:08:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:08:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:43 INFO - (blobuploader) - INFO - Done attempting. 16:08:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:08:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:08:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:44 INFO - (blobuploader) - INFO - Done attempting. 16:08:44 INFO - (blobuploader) - INFO - Iteration through files over. 16:08:44 INFO - Return code: 0 16:08:44 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:08:44 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:08:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c850e77081395ffb509cced63c5810b792fed3ed192db0c2f0a21e90d0b90d4beced3784bb004c9000adc5445d2aa7e0ba27936a4fdd4f7b378a97e0200ad19", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/492f46755717b2fde4b30342dad7248507cf167c019e9906c610127b5188d3a78bebcc3e5bf82ec1fcdfc30a5e43e606714d7120a89839ae054611d647925f85"} 16:08:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:08:44 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:08:44 INFO - Contents: 16:08:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c850e77081395ffb509cced63c5810b792fed3ed192db0c2f0a21e90d0b90d4beced3784bb004c9000adc5445d2aa7e0ba27936a4fdd4f7b378a97e0200ad19", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/492f46755717b2fde4b30342dad7248507cf167c019e9906c610127b5188d3a78bebcc3e5bf82ec1fcdfc30a5e43e606714d7120a89839ae054611d647925f85"} 16:08:44 INFO - Copying logs to upload dir... 16:08:44 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1275.625132 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-09 16:08:43.360835) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-09 16:08:43.363849) ========= 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=32c5991c409366f7fec8a718000001d2-1452383247.284149-955829352 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/4c850e77081395ffb509cced63c5810b792fed3ed192db0c2f0a21e90d0b90d4beced3784bb004c9000adc5445d2aa7e0ba27936a4fdd4f7b378a97e0200ad19", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/492f46755717b2fde4b30342dad7248507cf167c019e9906c610127b5188d3a78bebcc3e5bf82ec1fcdfc30a5e43e606714d7120a89839ae054611d647925f85"} build_url:https://queue.taskcluster.net/v1/task/C1Jw8qSZQJODDUFi1LFjmg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011376 build_url: 'https://queue.taskcluster.net/v1/task/C1Jw8qSZQJODDUFi1LFjmg/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/4c850e77081395ffb509cced63c5810b792fed3ed192db0c2f0a21e90d0b90d4beced3784bb004c9000adc5445d2aa7e0ba27936a4fdd4f7b378a97e0200ad19", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/492f46755717b2fde4b30342dad7248507cf167c019e9906c610127b5188d3a78bebcc3e5bf82ec1fcdfc30a5e43e606714d7120a89839ae054611d647925f85"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-09 16:08:43.392191) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 16:08:43.392676) ========= 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=32c5991c409366f7fec8a718000001d2-1452383247.284149-955829352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 16:08:43.475407) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-09 16:08:43.475732) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-09 16:08:43.476009) ========= ========= Total master_lag: 0.32 =========