builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1451142409.78 results: success (0) buildid: 20151226043006 builduid: 816b96bea93a41109a3b008e36abfa34 revision: c39a71cf41460924d2988d2d63be2f5d267db82a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-26 07:06:49.780333) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-26 07:06:49.780825) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-26 07:06:49.781120) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1451126694.276205-846526768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006280 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-26 07:06:49.842183) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-26 07:06:49.842532) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-26 07:06:49.927224) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 07:06:49.927546) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1451126694.276205-846526768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.042870 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 07:06:49.988960) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-26 07:06:49.989217) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-26 07:06:49.989611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 07:06:49.989890) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1451126694.276205-846526768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-26 07:06:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.5M=0s 2015-12-26 07:06:50 (47.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.244642 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 07:06:50.246398) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 07:06:50.246759) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1451126694.276205-846526768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.270327 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 07:06:50.529948) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 07:06:50.530298) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c39a71cf41460924d2988d2d63be2f5d267db82a --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 c39a71cf41460924d2988d2d63be2f5d267db82a --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=2dd9ebcff44b3efbe7b51203000001d7-1451126694.276205-846526768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-26 07:06:50,694 truncating revision to first 12 chars 2015-12-26 07:06:50,694 Setting DEBUG logging. 2015-12-26 07:06:50,694 attempt 1/10 2015-12-26 07:06:50,694 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c39a71cf4146?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-26 07:06:50,941 unpacking tar archive at: mozilla-central-c39a71cf4146/testing/mozharness/ program finished with exit code 0 elapsedTime=0.513836 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 07:06:51.056762) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-26 07:06:51.057074) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-26 07:06:51.066130) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-26 07:06:51.066516) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-26 07:06:51.066962) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2015-12-26 07:06:51.067243) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--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=2dd9ebcff44b3efbe7b51203000001d7-1451126694.276205-846526768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:06:51 INFO - MultiFileLogger online at 20151226 07:06:51 in /builds/slave/test-pgo 07:06:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:06:51 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:06:51 INFO - {'append_to_log': False, 07:06:51 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:06:51 INFO - 'blob_upload_branch': 'Firefox', 07:06:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:06:51 INFO - 'branch': 'Firefox', 07:06:51 INFO - 'buildbot_json_path': 'buildprops.json', 07:06:51 INFO - 'config_files': ('talos/linux_config.py',), 07:06:51 INFO - 'default_actions': ('clobber', 07:06:51 INFO - 'read-buildbot-config', 07:06:51 INFO - 'download-and-extract', 07:06:51 INFO - 'populate-webroot', 07:06:51 INFO - 'create-virtualenv', 07:06:51 INFO - 'install', 07:06:51 INFO - 'run-tests'), 07:06:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:06:51 INFO - 'download_minidump_stackwalk': True, 07:06:51 INFO - 'download_symbols': 'ondemand', 07:06:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:06:51 INFO - 'tooltool.py': '/tools/tooltool.py', 07:06:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:06:51 INFO - '/tools/misc-python/virtualenv.py')}, 07:06:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:06:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:06:51 INFO - 'installer_path': 'installer.exe', 07:06:51 INFO - 'log_level': 'info', 07:06:51 INFO - 'log_name': 'talos', 07:06:51 INFO - 'log_to_console': True, 07:06:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:06:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:06:51 INFO - 'opt_config_files': (), 07:06:51 INFO - 'pip_index': False, 07:06:51 INFO - 'sps_profile': False, 07:06:51 INFO - 'sps_profile_interval': 0, 07:06:51 INFO - 'suite': 'dromaeojs', 07:06:51 INFO - 'system_bits': '64', 07:06:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:06:51 INFO - 'title': 'talos-linux64-ix-032', 07:06:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:06:51 INFO - 'use_talos_json': True, 07:06:51 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:06:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:06:51 INFO - 'work_dir': 'build'} 07:06:51 INFO - ##### 07:06:51 INFO - ##### Running clobber step. 07:06:51 INFO - ##### 07:06:51 INFO - Running pre-action listener: _resource_record_pre_action 07:06:51 INFO - Running main action method: clobber 07:06:51 INFO - rmtree: /builds/slave/test-pgo/build 07:06:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:06:59 INFO - Running post-action listener: _resource_record_post_action 07:06:59 INFO - ##### 07:06:59 INFO - ##### Running read-buildbot-config step. 07:06:59 INFO - ##### 07:06:59 INFO - Running pre-action listener: _resource_record_pre_action 07:06:59 INFO - Running main action method: read_buildbot_config 07:06:59 INFO - Using buildbot properties: 07:06:59 INFO - { 07:06:59 INFO - "project": "", 07:06:59 INFO - "product": "firefox", 07:06:59 INFO - "script_repo_revision": "production", 07:06:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:06:59 INFO - "repository": "", 07:06:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:06:59 INFO - "buildid": "20151226043006", 07:06:59 INFO - "pgo_build": "True", 07:06:59 INFO - "basedir": "/builds/slave/test-pgo", 07:06:59 INFO - "buildnumber": 147, 07:06:59 INFO - "slavename": "talos-linux64-ix-032", 07:06:59 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:06:59 INFO - "platform": "ubuntu64_hw", 07:06:59 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:06:59 INFO - "branch": "mozilla-central", 07:06:59 INFO - "repo_path": "mozilla-central", 07:06:59 INFO - "revision": "c39a71cf41460924d2988d2d63be2f5d267db82a", 07:06:59 INFO - "stage_platform": "linux64-pgo", 07:06:59 INFO - "builduid": "816b96bea93a41109a3b008e36abfa34", 07:06:59 INFO - "slavebuilddir": "test" 07:06:59 INFO - } 07:06:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:06:59 INFO - Running post-action listener: _resource_record_post_action 07:06:59 INFO - ##### 07:06:59 INFO - ##### Running download-and-extract step. 07:06:59 INFO - ##### 07:06:59 INFO - Running pre-action listener: _resource_record_pre_action 07:06:59 INFO - Running main action method: download_and_extract 07:06:59 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:06: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')]} 07:06:59 INFO - https://queue.taskcluster.net/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:06:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/artifacts/public/build/test_packages.json 07:06:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/artifacts/public/build/test_packages.json 07:06:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:06:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:06:59 INFO - Downloaded 1302 bytes. 07:06:59 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:06:59 INFO - Using the following test package requirements: 07:06:59 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:06:59 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:06:59 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:59 INFO - u'jsshell-linux-x86_64.zip'], 07:06:59 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:06:59 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:06:59 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:06:59 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:06:59 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:06:59 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:06:59 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:59 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:06:59 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:06: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')]} 07:06:59 INFO - https://queue.taskcluster.net/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:06:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:06:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:06:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/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 07:06:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/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 07:07:06 INFO - Downloaded 23191445 bytes. 07:07:06 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 07:07:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:07:06 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 07:07:07 INFO - Return code: 0 07:07:07 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 07:07:07 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')]} 07:07:07 INFO - https://queue.taskcluster.net/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:07:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:07:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:07:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/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 07:07:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/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 07:07:09 INFO - Downloaded 23191445 bytes. 07:07:09 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 07:07:09 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:07:09 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 07:07:13 INFO - Return code: 0 07:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:13 INFO - https://queue.taskcluster.net/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:07:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:07:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:07:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/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 07:07:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/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 07:07:14 INFO - Downloaded 11132270 bytes. 07:07:14 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 07:07:14 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:07:14 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 07:07:14 INFO - Return code: 0 07:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:14 INFO - https://queue.taskcluster.net/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:07:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:07:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:07:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/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 07:07:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/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 07:07:15 INFO - Downloaded 54911209 bytes. 07:07:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:07:15 INFO - mkdir: /builds/slave/test-pgo/properties 07:07:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:07:15 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:07:15 INFO - Contents: 07:07:15 INFO - build_url:https://queue.taskcluster.net/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:07:15 INFO - Running post-action listener: _resource_record_post_action 07:07:15 INFO - Running post-action listener: set_extra_try_arguments 07:07:15 INFO - ##### 07:07:15 INFO - ##### Running populate-webroot step. 07:07:15 INFO - ##### 07:07:15 INFO - Running pre-action listener: _resource_record_pre_action 07:07:15 INFO - Running main action method: populate_webroot 07:07:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:07:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:07:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:07:15 INFO - '--tppagecycles', 07:07:15 INFO - '7'], 07:07:15 INFO - 'tests': ['tsvgm']}}, 07:07:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:07:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:07:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:07:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:07:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:07:15 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:07:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:07:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:15 INFO - 'talos_options': ['--e10s'], 07:07:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:07:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:15 INFO - 'tests': ['damp', 'tps']}, 07:07:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:15 INFO - 'talos_options': ['--e10s'], 07:07:15 INFO - 'tests': ['damp', 'tps']}, 07:07:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:07:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:07:15 INFO - 'other': {'tests': ['a11yr', 07:07:15 INFO - 'ts_paint', 07:07:15 INFO - 'tpaint', 07:07:15 INFO - 'sessionrestore', 07:07:15 INFO - 'sessionrestore_no_auto_restore']}, 07:07:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:07:15 INFO - 'tests': ['a11yr', 07:07:15 INFO - 'ts_paint', 07:07:15 INFO - 'tpaint', 07:07:15 INFO - 'sessionrestore', 07:07:15 INFO - 'sessionrestore_no_auto_restore']}, 07:07:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:07:15 INFO - 'tests': ['a11yr', 07:07:15 INFO - 'ts_paint', 07:07:15 INFO - 'tpaint', 07:07:15 INFO - 'sessionrestore', 07:07:15 INFO - 'sessionrestore_no_auto_restore']}, 07:07:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:07:15 INFO - 'tests': ['a11yr', 07:07:15 INFO - 'ts_paint', 07:07:15 INFO - 'tpaint', 07:07:15 INFO - 'sessionrestore', 07:07:15 INFO - 'sessionrestore_no_auto_restore']}, 07:07:15 INFO - 'other_l64': {'tests': ['a11yr', 07:07:15 INFO - 'ts_paint', 07:07:15 INFO - 'tpaint', 07:07:15 INFO - 'sessionrestore', 07:07:15 INFO - 'sessionrestore_no_auto_restore']}, 07:07:15 INFO - 'other_nol64': {'tests': ['a11yr', 07:07:15 INFO - 'ts_paint', 07:07:15 INFO - 'tpaint', 07:07:15 INFO - 'sessionrestore', 07:07:15 INFO - 'sessionrestore_no_auto_restore']}, 07:07:15 INFO - 'svgr': {'tests': ['tsvgx', 07:07:15 INFO - 'tsvgr_opacity', 07:07:15 INFO - 'tart', 07:07:15 INFO - 'tscrollx', 07:07:15 INFO - 'cart']}, 07:07:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:07:15 INFO - 'tests': ['tsvgx', 07:07:15 INFO - 'tsvgr_opacity', 07:07:15 INFO - 'tart', 07:07:15 INFO - 'tscrollx', 07:07:15 INFO - 'cart']}, 07:07:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:15 INFO - 'tests': ['tp5o']}, 07:07:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:15 INFO - 'talos_options': ['--e10s'], 07:07:15 INFO - 'tests': ['tp5o']}, 07:07:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:15 INFO - 'talos_options': ['--xperf_path', 07:07:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:07:15 INFO - 'tests': ['tp5n']}, 07:07:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:15 INFO - 'talos_options': ['--e10s', 07:07:15 INFO - '--xperf_path', 07:07:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:07:15 INFO - 'tests': ['tp5n']}}, 07:07:15 INFO - 'talos.zip': {'path': '', 07:07:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:07:15 INFO - Running post-action listener: _resource_record_post_action 07:07:15 INFO - ##### 07:07:15 INFO - ##### Running create-virtualenv step. 07:07:15 INFO - ##### 07:07:15 INFO - Running pre-action listener: _resource_record_pre_action 07:07:15 INFO - Running main action method: create_virtualenv 07:07:15 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:07:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 07:07:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:07:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:07:15 INFO - Using real prefix '/usr' 07:07:15 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:07:16 INFO - Installing distribute.............................................................................................................................................................................................done. 07:07:20 INFO - Installing pip.................done. 07:07:21 INFO - Return code: 0 07:07:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7ffc09130f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2690840>, '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 0x25fd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fdb60>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1451126694.276205-846526768', '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 07:07:21 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 07:07:21 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 07:07:21 INFO - Using env: {'DISPLAY': ':0', 07:07:21 INFO - 'HOME': '/home/cltbld', 07:07:21 INFO - 'LANG': 'en_US.UTF-8', 07:07:21 INFO - 'LANGUAGE': 'en_US:en', 07:07:21 INFO - 'LOGNAME': 'cltbld', 07:07:21 INFO - 'MAIL': '/var/mail/cltbld', 07:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:21 INFO - 'MOZ_NO_REMOTE': '1', 07:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:21 INFO - 'NO_EM_RESTART': '1', 07:07:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:21 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:21 INFO - 'SHELL': '/bin/bash', 07:07:21 INFO - 'SHLVL': '1', 07:07:21 INFO - 'TERM': 'linux', 07:07:21 INFO - 'TMOUT': '86400', 07:07:21 INFO - 'USER': 'cltbld', 07:07:21 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1451126694.276205-846526768', 07:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:21 INFO - '_': '/tools/buildbot/bin/python'} 07:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:23 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 07:07:23 INFO - Cleaning up... 07:07:23 INFO - Return code: 0 07:07:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:07:23 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')]} 07:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:23 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')]} 07:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:23 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 0x7ffc09130f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2690840>, '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 0x25fd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fdb60>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1451126694.276205-846526768', '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 07:07:23 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 07:07:23 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 07:07:23 INFO - Using env: {'DISPLAY': ':0', 07:07:23 INFO - 'HOME': '/home/cltbld', 07:07:23 INFO - 'LANG': 'en_US.UTF-8', 07:07:23 INFO - 'LANGUAGE': 'en_US:en', 07:07:23 INFO - 'LOGNAME': 'cltbld', 07:07:23 INFO - 'MAIL': '/var/mail/cltbld', 07:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:23 INFO - 'MOZ_NO_REMOTE': '1', 07:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:23 INFO - 'NO_EM_RESTART': '1', 07:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:23 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:23 INFO - 'SHELL': '/bin/bash', 07:07:23 INFO - 'SHLVL': '1', 07:07:23 INFO - 'TERM': 'linux', 07:07:23 INFO - 'TMOUT': '86400', 07:07:23 INFO - 'USER': 'cltbld', 07:07:23 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1451126694.276205-846526768', 07:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:23 INFO - '_': '/tools/buildbot/bin/python'} 07:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:23 INFO - Downloading/unpacking psutil>=0.7.1 07:07:23 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 07:07:23 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 07:07:23 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 07:07:23 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 07:07:23 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 07:07:23 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 07:07:25 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:07:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:07:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:07:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:07:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:07:25 INFO - Installing collected packages: psutil 07:07:25 INFO - Running setup.py install for psutil 07:07:26 INFO - building 'psutil._psutil_linux' extension 07:07:26 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 07:07:29 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 07:07:29 INFO - building 'psutil._psutil_posix' extension 07:07:29 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 07:07:29 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 07:07:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:07:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:07:29 INFO - Successfully installed psutil 07:07:29 INFO - Cleaning up... 07:07:29 INFO - Return code: 0 07:07:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7ffc09130f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2690840>, '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 0x25fd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fdb60>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1451126694.276205-846526768', '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 07:07:29 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 07:07:29 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 07:07:29 INFO - Using env: {'DISPLAY': ':0', 07:07:29 INFO - 'HOME': '/home/cltbld', 07:07:29 INFO - 'LANG': 'en_US.UTF-8', 07:07:29 INFO - 'LANGUAGE': 'en_US:en', 07:07:29 INFO - 'LOGNAME': 'cltbld', 07:07:29 INFO - 'MAIL': '/var/mail/cltbld', 07:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:29 INFO - 'MOZ_NO_REMOTE': '1', 07:07:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:29 INFO - 'NO_EM_RESTART': '1', 07:07:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:29 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:29 INFO - 'SHELL': '/bin/bash', 07:07:29 INFO - 'SHLVL': '1', 07:07:29 INFO - 'TERM': 'linux', 07:07:29 INFO - 'TMOUT': '86400', 07:07:29 INFO - 'USER': 'cltbld', 07:07:29 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1451126694.276205-846526768', 07:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:29 INFO - '_': '/tools/buildbot/bin/python'} 07:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:07:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:07:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:07:31 INFO - Installing collected packages: mozsystemmonitor 07:07:31 INFO - Running setup.py install for mozsystemmonitor 07:07:31 INFO - Successfully installed mozsystemmonitor 07:07:31 INFO - Cleaning up... 07:07:31 INFO - Return code: 0 07:07:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:31 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 0x7ffc09130f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2690840>, '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 0x25fd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fdb60>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1451126694.276205-846526768', '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 07:07:31 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 07:07:31 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 07:07:31 INFO - Using env: {'DISPLAY': ':0', 07:07:31 INFO - 'HOME': '/home/cltbld', 07:07:31 INFO - 'LANG': 'en_US.UTF-8', 07:07:31 INFO - 'LANGUAGE': 'en_US:en', 07:07:31 INFO - 'LOGNAME': 'cltbld', 07:07:31 INFO - 'MAIL': '/var/mail/cltbld', 07:07:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:31 INFO - 'MOZ_NO_REMOTE': '1', 07:07:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:31 INFO - 'NO_EM_RESTART': '1', 07:07:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:31 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:31 INFO - 'SHELL': '/bin/bash', 07:07:31 INFO - 'SHLVL': '1', 07:07:31 INFO - 'TERM': 'linux', 07:07:31 INFO - 'TMOUT': '86400', 07:07:31 INFO - 'USER': 'cltbld', 07:07:31 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1451126694.276205-846526768', 07:07:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:31 INFO - '_': '/tools/buildbot/bin/python'} 07:07:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:31 INFO - Downloading/unpacking blobuploader==1.2.4 07:07:31 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 07:07:31 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 07:07:31 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 07:07:31 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 07:07:31 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 07:07:31 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 07:07:33 INFO - Downloading blobuploader-1.2.4.tar.gz 07:07:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:07:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:07:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:07:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:07:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:34 INFO - Downloading docopt-0.6.1.tar.gz 07:07:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:07:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:07:34 INFO - Installing collected packages: blobuploader, requests, docopt 07:07:34 INFO - Running setup.py install for blobuploader 07:07:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:07:34 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:07:34 INFO - Running setup.py install for requests 07:07:34 INFO - Running setup.py install for docopt 07:07:34 INFO - Successfully installed blobuploader requests docopt 07:07:34 INFO - Cleaning up... 07:07:35 INFO - Return code: 0 07:07:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:35 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 0x7ffc09130f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2690840>, '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 0x25fd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fdb60>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1451126694.276205-846526768', '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 07:07:35 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 07:07:35 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 07:07:35 INFO - Using env: {'DISPLAY': ':0', 07:07:35 INFO - 'HOME': '/home/cltbld', 07:07:35 INFO - 'LANG': 'en_US.UTF-8', 07:07:35 INFO - 'LANGUAGE': 'en_US:en', 07:07:35 INFO - 'LOGNAME': 'cltbld', 07:07:35 INFO - 'MAIL': '/var/mail/cltbld', 07:07:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:35 INFO - 'MOZ_NO_REMOTE': '1', 07:07:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:35 INFO - 'NO_EM_RESTART': '1', 07:07:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:35 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:35 INFO - 'SHELL': '/bin/bash', 07:07:35 INFO - 'SHLVL': '1', 07:07:35 INFO - 'TERM': 'linux', 07:07:35 INFO - 'TMOUT': '86400', 07:07:35 INFO - 'USER': 'cltbld', 07:07:35 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1451126694.276205-846526768', 07:07:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:35 INFO - '_': '/tools/buildbot/bin/python'} 07:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:07:35 INFO - Running setup.py (path:/tmp/pip-BGkbCD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:07:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:07:35 INFO - Running setup.py (path:/tmp/pip-2poGZ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:07:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:07:35 INFO - Running setup.py (path:/tmp/pip-KBkteU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:07:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:07:35 INFO - Running setup.py (path:/tmp/pip-4shvXz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:07:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:07:35 INFO - Running setup.py (path:/tmp/pip-rfE3Ya-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:07:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:07:35 INFO - Running setup.py (path:/tmp/pip-Qe6IO7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:07:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:07:35 INFO - Running setup.py (path:/tmp/pip-LtzJ2k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:07:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:07:35 INFO - Running setup.py (path:/tmp/pip-fk6nLM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:07:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:07:35 INFO - Running setup.py (path:/tmp/pip-HGRgG6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:07:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:07:35 INFO - Running setup.py (path:/tmp/pip-dbymIj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:07:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:07:35 INFO - Running setup.py (path:/tmp/pip-S7Y1BO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:07:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:07:36 INFO - Running setup.py (path:/tmp/pip-EqstoY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:07:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:07:36 INFO - Running setup.py (path:/tmp/pip-Q5_VHX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:07:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:07:36 INFO - Running setup.py (path:/tmp/pip-Gp7j5t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:07:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:07:36 INFO - Running setup.py (path:/tmp/pip-fkAIPP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:07:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:07:36 INFO - Running setup.py (path:/tmp/pip-HGPA6K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:07:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:07:36 INFO - Running setup.py (path:/tmp/pip-kjRxdf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:07:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:07:36 INFO - Running setup.py install for manifestparser 07:07:36 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:07:36 INFO - Running setup.py install for mozcrash 07:07:36 INFO - Running setup.py install for mozdebug 07:07:36 INFO - Running setup.py install for mozdevice 07:07:36 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:07:36 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:07:36 INFO - Running setup.py install for mozfile 07:07:36 INFO - Running setup.py install for mozhttpd 07:07:37 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:07:37 INFO - Running setup.py install for mozinfo 07:07:37 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:07:37 INFO - Running setup.py install for mozInstall 07:07:37 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:07:37 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:07:37 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:07:37 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:07:37 INFO - Running setup.py install for mozleak 07:07:37 INFO - Running setup.py install for mozlog 07:07:37 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:07:37 INFO - Running setup.py install for moznetwork 07:07:37 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:07:37 INFO - Running setup.py install for mozprocess 07:07:37 INFO - Running setup.py install for mozprofile 07:07:37 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:07:37 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:07:37 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:07:37 INFO - Running setup.py install for mozrunner 07:07:37 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:07:37 INFO - Running setup.py install for mozscreenshot 07:07:38 INFO - Running setup.py install for moztest 07:07:38 INFO - Running setup.py install for mozversion 07:07:38 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:07:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:07:38 INFO - Cleaning up... 07:07:38 INFO - Return code: 0 07:07:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:07: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')]} 07:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07: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')]} 07:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:38 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 0x7ffc09130f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2690840>, '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 0x25fd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fdb60>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1451126694.276205-846526768', '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 07:07:38 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 07:07:38 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 07:07:38 INFO - Using env: {'DISPLAY': ':0', 07:07:38 INFO - 'HOME': '/home/cltbld', 07:07:38 INFO - 'LANG': 'en_US.UTF-8', 07:07:38 INFO - 'LANGUAGE': 'en_US:en', 07:07:38 INFO - 'LOGNAME': 'cltbld', 07:07:38 INFO - 'MAIL': '/var/mail/cltbld', 07:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:38 INFO - 'MOZ_NO_REMOTE': '1', 07:07:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:38 INFO - 'NO_EM_RESTART': '1', 07:07:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:38 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:38 INFO - 'SHELL': '/bin/bash', 07:07:38 INFO - 'SHLVL': '1', 07:07:38 INFO - 'TERM': 'linux', 07:07:38 INFO - 'TMOUT': '86400', 07:07:38 INFO - 'USER': 'cltbld', 07:07:38 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1451126694.276205-846526768', 07:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:38 INFO - '_': '/tools/buildbot/bin/python'} 07:07:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:07:38 INFO - Running setup.py (path:/tmp/pip-h0jvea-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:07:38 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)) 07:07:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:07:38 INFO - Running setup.py (path:/tmp/pip-PczD71-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:07:38 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)) 07:07:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:07:38 INFO - Running setup.py (path:/tmp/pip-ycQ30y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:07:38 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)) 07:07:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:07:38 INFO - Running setup.py (path:/tmp/pip-5LS8aJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:07:38 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)) 07:07:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:07:38 INFO - Running setup.py (path:/tmp/pip-uvxN6G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:07:38 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)) 07:07:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:07:38 INFO - Running setup.py (path:/tmp/pip-iiChRV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:07:38 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)) 07:07:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:07:38 INFO - Running setup.py (path:/tmp/pip-T1JXt3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:07:38 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)) 07:07:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:07:38 INFO - Running setup.py (path:/tmp/pip-ZHY4Ij-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:07:39 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)) 07:07:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:07:39 INFO - Running setup.py (path:/tmp/pip-JNmGAR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:07:39 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)) 07:07:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:07:39 INFO - Running setup.py (path:/tmp/pip-YxExMB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:07:39 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)) 07:07:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:07:39 INFO - Running setup.py (path:/tmp/pip-MaZJZB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:07:39 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)) 07:07:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:07:39 INFO - Running setup.py (path:/tmp/pip-K8JmDo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:07:39 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)) 07:07:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:07:39 INFO - Running setup.py (path:/tmp/pip-_13i0n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:07:39 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)) 07:07:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:07:39 INFO - Running setup.py (path:/tmp/pip-JFJX3H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:07:39 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)) 07:07:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:07:39 INFO - Running setup.py (path:/tmp/pip-YQuXyL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:07:39 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)) 07:07:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:07:39 INFO - Running setup.py (path:/tmp/pip-UEGRmb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:07:39 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)) 07:07:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:07:39 INFO - Running setup.py (path:/tmp/pip-oxC85X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:07:39 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)) 07:07:39 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)) 07:07:39 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)) 07:07:39 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)) 07:07:39 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)) 07:07:39 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)) 07:07:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:07:39 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 07:07:39 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 07:07:39 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 07:07:39 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 07:07:39 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 07:07:39 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 07:07:41 INFO - Downloading blessings-1.5.1.tar.gz 07:07:41 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 07:07:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:07:41 INFO - Installing collected packages: blessings 07:07:41 INFO - Running setup.py install for blessings 07:07:41 INFO - Successfully installed blessings 07:07:41 INFO - Cleaning up... 07:07:41 INFO - Return code: 0 07:07:41 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:07:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:07:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:07:41 INFO - Reading from file tmpfile_stdout 07:07:41 INFO - Current package versions: 07:07:41 INFO - argparse == 1.2.1 07:07:41 INFO - blessings == 1.5.1 07:07:41 INFO - blobuploader == 1.2.4 07:07:41 INFO - docopt == 0.6.1 07:07:41 INFO - manifestparser == 1.1 07:07:41 INFO - mozInstall == 1.12 07:07:41 INFO - mozcrash == 0.16 07:07:41 INFO - mozdebug == 0.1 07:07:41 INFO - mozdevice == 0.47 07:07:41 INFO - mozfile == 1.2 07:07:41 INFO - mozhttpd == 0.7 07:07:41 INFO - mozinfo == 0.9 07:07:41 INFO - mozleak == 0.1 07:07:41 INFO - mozlog == 3.1 07:07:41 INFO - moznetwork == 0.27 07:07:41 INFO - mozprocess == 0.22 07:07:41 INFO - mozprofile == 0.28 07:07:41 INFO - mozrunner == 6.11 07:07:41 INFO - mozscreenshot == 0.1 07:07:41 INFO - mozsystemmonitor == 0.0 07:07:41 INFO - moztest == 0.7 07:07:41 INFO - mozversion == 1.4 07:07:41 INFO - psutil == 3.1.1 07:07:41 INFO - requests == 1.2.3 07:07:41 INFO - wsgiref == 0.1.2 07:07:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:07: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')]} 07:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07: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')]} 07:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:41 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 0x7ffc09130f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2690840>, '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 0x25fd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fdb60>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1451126694.276205-846526768', '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 07:07:41 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 07:07:41 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 07:07:41 INFO - Using env: {'DISPLAY': ':0', 07:07:41 INFO - 'HOME': '/home/cltbld', 07:07:41 INFO - 'LANG': 'en_US.UTF-8', 07:07:41 INFO - 'LANGUAGE': 'en_US:en', 07:07:41 INFO - 'LOGNAME': 'cltbld', 07:07:41 INFO - 'MAIL': '/var/mail/cltbld', 07:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:41 INFO - 'MOZ_NO_REMOTE': '1', 07:07:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:41 INFO - 'NO_EM_RESTART': '1', 07:07:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:41 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:41 INFO - 'SHELL': '/bin/bash', 07:07:41 INFO - 'SHLVL': '1', 07:07:41 INFO - 'TERM': 'linux', 07:07:41 INFO - 'TMOUT': '86400', 07:07:41 INFO - 'USER': 'cltbld', 07:07:41 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1451126694.276205-846526768', 07:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:41 INFO - '_': '/tools/buildbot/bin/python'} 07:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:42 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)) 07:07:42 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)) 07:07:42 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)) 07:07:42 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)) 07:07:42 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)) 07:07:42 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)) 07:07:42 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)) 07:07:42 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)) 07:07:42 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)) 07:07:42 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)) 07:07:42 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)) 07:07:42 INFO - Cleaning up... 07:07:42 INFO - Return code: 0 07:07:42 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc09130f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2690840>, '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 0x25fd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fdb60>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1451126694.276205-846526768', '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 07:07:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 07:07:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:07:42 INFO - Using env: {'DISPLAY': ':0', 07:07:42 INFO - 'HOME': '/home/cltbld', 07:07:42 INFO - 'LANG': 'en_US.UTF-8', 07:07:42 INFO - 'LANGUAGE': 'en_US:en', 07:07:42 INFO - 'LOGNAME': 'cltbld', 07:07:42 INFO - 'MAIL': '/var/mail/cltbld', 07:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:42 INFO - 'MOZ_NO_REMOTE': '1', 07:07:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:42 INFO - 'NO_EM_RESTART': '1', 07:07:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:42 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:42 INFO - 'SHELL': '/bin/bash', 07:07:42 INFO - 'SHLVL': '1', 07:07:42 INFO - 'TERM': 'linux', 07:07:42 INFO - 'TMOUT': '86400', 07:07:42 INFO - 'USER': 'cltbld', 07:07:42 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1451126694.276205-846526768', 07:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:42 INFO - '_': '/tools/buildbot/bin/python'} 07:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:42 INFO - Downloading/unpacking jsonschema 07:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:07:43 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 07:07:43 INFO - Downloading/unpacking functools32 (from jsonschema) 07:07:43 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 07:07:43 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 07:07:43 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 07:07:43 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 07:07:43 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 07:07:43 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 07:07:44 INFO - Downloading functools32-3.2.3-2.tar.gz 07:07:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:07:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:07:44 INFO - warning: no files found matching '*.txt' 07:07:44 INFO - no previously-included directories found matching 'build' 07:07:44 INFO - no previously-included directories found matching 'dist' 07:07:44 INFO - no previously-included directories found matching '.git*' 07:07:44 INFO - Installing collected packages: jsonschema, functools32 07:07:44 INFO - Running setup.py install for functools32 07:07:44 INFO - warning: no files found matching '*.txt' 07:07:44 INFO - no previously-included directories found matching 'build' 07:07:44 INFO - no previously-included directories found matching 'dist' 07:07:44 INFO - no previously-included directories found matching '.git*' 07:07:44 INFO - Successfully installed jsonschema functools32 07:07:44 INFO - Cleaning up... 07:07:44 INFO - Return code: 0 07:07:44 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc09130f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ff630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2690840>, '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 0x25fd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fdb60>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1451126694.276205-846526768', '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 07:07:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 07:07:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:07:44 INFO - Using env: {'DISPLAY': ':0', 07:07:44 INFO - 'HOME': '/home/cltbld', 07:07:44 INFO - 'LANG': 'en_US.UTF-8', 07:07:44 INFO - 'LANGUAGE': 'en_US:en', 07:07:44 INFO - 'LOGNAME': 'cltbld', 07:07:44 INFO - 'MAIL': '/var/mail/cltbld', 07:07:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:44 INFO - 'MOZ_NO_REMOTE': '1', 07:07:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:44 INFO - 'NO_EM_RESTART': '1', 07:07:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:44 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:44 INFO - 'SHELL': '/bin/bash', 07:07:44 INFO - 'SHLVL': '1', 07:07:44 INFO - 'TERM': 'linux', 07:07:44 INFO - 'TMOUT': '86400', 07:07:44 INFO - 'USER': 'cltbld', 07:07:44 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1451126694.276205-846526768', 07:07:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:44 INFO - '_': '/tools/buildbot/bin/python'} 07:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:44 INFO - Downloading/unpacking flake8 07:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:07:46 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 07:07:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:07:46 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 07:07:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:46 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 07:07:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:07:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:07:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:07:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:07:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:07:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:07:46 INFO - no previously-included directories found matching 'docs/_build' 07:07:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:07:47 INFO - Running setup.py install for pep8 07:07:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:07:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:07:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:07:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:07:47 INFO - no previously-included directories found matching 'docs/_build' 07:07:47 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:07:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:07:47 INFO - Cleaning up... 07:07:47 INFO - Return code: 0 07:07:47 INFO - Running post-action listener: _resource_record_post_action 07:07:47 INFO - Running post-action listener: _start_resource_monitoring 07:07:47 INFO - Starting resource monitoring. 07:07:47 INFO - ##### 07:07:47 INFO - ##### Running install step. 07:07:47 INFO - ##### 07:07:47 INFO - Running pre-action listener: _resource_record_pre_action 07:07:47 INFO - Running main action method: install 07:07:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:07:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:07:47 INFO - Reading from file tmpfile_stdout 07:07:47 INFO - Detecting whether we're running mozinstall >=1.0... 07:07:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:07:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:07:47 INFO - Reading from file tmpfile_stdout 07:07:47 INFO - Output received: 07:07:47 INFO - Usage: mozinstall [options] installer 07:07:47 INFO - Options: 07:07:47 INFO - -h, --help show this help message and exit 07:07:47 INFO - -d DEST, --destination=DEST 07:07:47 INFO - Directory to install application into. [default: 07:07:47 INFO - "/builds/slave/test-pgo"] 07:07:47 INFO - --app=APP Application being installed. [default: firefox] 07:07:47 INFO - mkdir: /builds/slave/test-pgo/build/application 07:07:47 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'] 07:07:47 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 07:08:03 INFO - Reading from file tmpfile_stdout 07:08:03 INFO - Output received: 07:08:03 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:08:03 INFO - Running post-action listener: _resource_record_post_action 07:08:03 INFO - ##### 07:08:03 INFO - ##### Running run-tests step. 07:08:03 INFO - ##### 07:08:03 INFO - Running pre-action listener: _resource_record_pre_action 07:08:03 INFO - Running main action method: run_tests 07:08:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:08:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:08:03 INFO - Python 2.7.3 07:08:03 INFO - Return code: 0 07:08:03 INFO - grabbing minidump binary from tooltool 07:08: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')]} 07:08:03 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 0x2690840>, '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 0x25fd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fdb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:08:03 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 07:08:03 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 07:08:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:08:03 INFO - Return code: 0 07:08:03 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:08:03 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:08:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:08:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:08:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:08:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:08:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:08:04 INFO - Return code: 0 07:08:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 07:08:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 07:08:04 INFO - Using env: {'DISPLAY': ':0', 07:08:04 INFO - 'HOME': '/home/cltbld', 07:08:04 INFO - 'LANG': 'en_US.UTF-8', 07:08:04 INFO - 'LANGUAGE': 'en_US:en', 07:08:04 INFO - 'LOGNAME': 'cltbld', 07:08:04 INFO - 'MAIL': '/var/mail/cltbld', 07:08:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:08:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:04 INFO - 'MOZ_NO_REMOTE': '1', 07:08:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:04 INFO - 'NO_EM_RESTART': '1', 07:08:04 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:08:04 INFO - 'PWD': '/builds/slave/test-pgo', 07:08:04 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:08:04 INFO - 'SHELL': '/bin/bash', 07:08:04 INFO - 'SHLVL': '1', 07:08:04 INFO - 'TERM': 'linux', 07:08:04 INFO - 'TMOUT': '86400', 07:08:04 INFO - 'USER': 'cltbld', 07:08:04 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1451126694.276205-846526768', 07:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:04 INFO - '_': '/tools/buildbot/bin/python'} 07:08:04 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:08:04 INFO - mozversion application_buildid: 20151226043006 07:08:04 INFO - mozversion application_changeset: c39a71cf41460924d2988d2d63be2f5d267db82a 07:08:04 INFO - mozversion application_display_name: Nightly 07:08:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:08:04 INFO - mozversion application_name: Firefox 07:08:04 INFO - mozversion application_remotingname: firefox 07:08:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:08:04 INFO - mozversion application_vendor: Mozilla 07:08:04 INFO - mozversion application_version: 46.0a1 07:08:04 INFO - mozversion platform_buildid: 20151226043006 07:08:04 INFO - mozversion platform_changeset: c39a71cf41460924d2988d2d63be2f5d267db82a 07:08:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:08:04 INFO - mozversion platform_version: 46.0a1 07:08:04 INFO - using testdate: 1451142484 07:08:04 INFO - actual date: 1451142484 07:08:04 INFO - starting webserver on 'localhost:46674' 07:08:04 INFO - SUITE-START | Running 3 tests 07:08:04 INFO - TEST-START | dromaeo_css 07:08:04 INFO - operating with platform_type : linux_ 07:08:04 INFO - Initialising browser for dromaeo_css test... 07:08:04 INFO - TEST-INFO | started process 3520 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpK2O4ng/profile http://localhost:46674/getInfo.html) 07:08:12 INFO - PROCESS | 3520 | __metrics Screen width/height:1600/1200 07:08:12 INFO - PROCESS | 3520 | colorDepth:24 07:08:12 INFO - PROCESS | 3520 | Browser inner width/height: 1024/697 07:08:12 INFO - PROCESS | 3520 | __metrics 07:08:13 INFO - PROCESS | 3520 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:08:13 INFO - PROCESS | 3520 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:08:14 INFO - TEST-INFO | 3520: exit 0 07:08:14 INFO - Browser initialized. 07:08:14 INFO - Running cycle 1/1 for dromaeo_css test... 07:08:14 INFO - TEST-INFO | started process 3613 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpK2O4ng/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:08:26 INFO - PROCESS | 3613 | RSS: Main: 148922368 07:08:26 INFO - PROCESS | 3613 | 07:09:16 INFO - PROCESS | 3613 | 1451142556864 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] 07:11:26 INFO - PROCESS | 3613 | Cycle 1(1): loaded http://localhost:46674/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46674/tests/dromaeo/cssquery-ext.html) 07:11:27 INFO - PROCESS | 3613 | RSS: Main: 267411456 07:11:27 INFO - PROCESS | 3613 | 07:14:30 INFO - PROCESS | 3613 | Cycle 1(1): loaded http://localhost:46674/tests/dromaeo/cssquery-ext.html (next: http://localhost:46674/tests/dromaeo/cssquery-jquery.html) 07:14:30 INFO - PROCESS | 3613 | RSS: Main: 238239744 07:14:30 INFO - PROCESS | 3613 | 07:17:32 INFO - PROCESS | 3613 | Cycle 1(1): loaded http://localhost:46674/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46674/tests/dromaeo/cssquery-mootools.html) 07:17:33 INFO - PROCESS | 3613 | RSS: Main: 226832384 07:17:33 INFO - PROCESS | 3613 | 07:20:35 INFO - PROCESS | 3613 | Cycle 1(1): loaded http://localhost:46674/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46674/tests/dromaeo/cssquery-prototype.html) 07:20:35 INFO - PROCESS | 3613 | RSS: Main: 212819968 07:20:35 INFO - PROCESS | 3613 | 07:23:38 INFO - PROCESS | 3613 | Cycle 1(1): loaded http://localhost:46674/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46674/tests/dromaeo/cssquery-yui.html) 07:23:39 INFO - PROCESS | 3613 | RSS: Main: 213581824 07:23:39 INFO - PROCESS | 3613 | 07:26:41 INFO - PROCESS | 3613 | Cycle 1(1): loaded http://localhost:46674/tests/dromaeo/cssquery-yui.html (next: http://localhost:46674/tests/dromaeo/cssquery-dojo.html) 07:26:41 INFO - PROCESS | 3613 | RSS: Main: 307728384 07:26:41 INFO - PROCESS | 3613 | 07:26:41 INFO - PROCESS | 3613 | __start_tp_report 07:26:41 INFO - PROCESS | 3613 | _x_x_mozilla_page_load 07:26:41 INFO - PROCESS | 3613 | _x_x_mozilla_page_load_details 07:26:41 INFO - PROCESS | 3613 | |i|pagename|runs| 07:26:41 INFO - PROCESS | 3613 | |0;dojo.html;3125.4686703260445;3168.3663267346537;3199.216192032951;3210.3418799146193;3236.0130160301105;5102.438731739506;5210.086551763747;5219.895602087956;5223.164293713006;5253.369595648518;5248.134057880455;5260.842174734764;5335.413104558495;5367.46325367463;5368.570514358852;4796.640251981089;4838.371011768465;4872.049950259683;4873.658843880929;4922.286268491084;4864.221724524077;4923.852284431473;4969.900601987976;4972.676776009566;5016.523430274118;4791.041791641685;4859.659823812334;4887;4897.755112244391;4965.155923493015;4764.714117152982;4854.708717476928;4865.732384718839;4871.683340582851;4875.609951203895;4804.20730579454;4842.58837998767;4846;4852.684575502581;4889.193283108283;5069.822556210552;5072.442031376546;5134.717590532519;5155.484451554852;5183.663061901002;5626.831195064155;5639.154126881001;5644.57665675076;5654.321481422215;5669.894370597735;5681;5683.943160568383;5687.943120568782;5695.345035320908;5699.487046165865;5175.767090480937;5278.630495865253;5290.788368465257;5298.231756395301;5407.918881216785;5821.53427725781;5829.854253643608;5833;5850.61970971894;5874.1776151338845;5611.831645050655;5618.325800903917;5621.550275977912;5624.409437009137;5626.690532020778;5516.531094856902;5595.720213989284;5608.663480191201;5697.487226149667;5717.256756621613;5651.745671444794;5652.7738890443925;5654.858628534237;5659.462351076641;5665.66006039639;5608.298962629671;5629.43705629442;5671.829845104653;5672.177534257509;5674.120511320752;4246.129543443587;4295.6778241632;4335.089631177488;4366.19225443294;4404.163208990281;3915.5497117831246;3918.90270724192;3924.274009308287;3954.209158168378;3958.426028225891;5178.844634660966;5240.109181439165;5246.055709972242;5250.894982100336;5251.658642188246;5662.150677398423;5663.292088488939;5666.348369937427;5757.366689664133;5811.360750317462;5249.107651699221;5262.105442074857;5263.6578622389425;5271.446498117719;5290;4720.12677654635;4838.564529192319;4851.757412129379;4860.8298709545;4893.755312234374;5755.1367294906095;5781.768729250867;5791.247137872049;5822.184894114743;5865.296164460292;5699.344575373885;5699.974004679198;5700.914486282792;5704.686242256716;5711.200431939615;5652.147935711292;5826.184334193301;5841.970790146022;5845.620034697731;5847.473727364558;5600.243967064394;5607.07483265273;5643.971780141073;5725.312962444534;5773.509251713652;5608.10270356741;5662.716864156693;5662.943370566241;5668.121441176624;5669.971650141723;5481.780728770805;5529.972350138223;5532.944670553243;5546.140348246028;5550.55595552363;5553.167024946129;5565.220869078414;5579.972100139474;5623.634463759842;5668.433156684464;5451.3458384994055;5458.536024437967;5465.016297066566;5466.480684334982;5476.2607048049595;5526.336839579276;5577.0797818359515;5578.219049333178;5594.608377413542;5634.915476267941;5415.296011518478;5471.316085489314;5472.699001554953;5481.780728770964;5520.282363292747 07:26:41 INFO - PROCESS | 3613 | |1;ext.html;560.8205374280229;577.7226931073083;586.6245602814203;591.2402562706922;615.5106690181304;28063.298417539547;35439.291214175704;35827.4625880612;35830.462543061876;35837;38283.617163828356;38413.80793096038;38422.231555368875;38496;38759.41860872082;7306.707731690753;7437.628118594076;8325.875111873342;8494.702685406011;8499.447535910145;7452.292032256954;7540.0197974263265;9954;10147.949260253688;10200.540975656077;9905.15806156474;9952.054554817281;9997.2002239821;10022.24833137514;10022.348547344436;7625.733099341552;9846.655367062154;9917.107460328532;9945.75135621608;9948.651797187063;7469.887951680729;10012.59949602015;10256.07695307426;10261.127804136657;10271.897281027168;36549.81725091384;37049.81475092634;37052.44421333682;37106.257874842355;37114;3015.5977470476114;3029.3638335949477;3127.4839651457482;3182.80903145812;3726.136931534233;30365.696343036507;30386.54420183699;30548;30944.0716778497;31424.842875785474;3922.6035172976945;3948.881533553998;3957.08986933007;3997.360422332413;4054.0472988847596;281111;281600;281914;282920.99999999796;283716;50649.24026139611;52003;55852.720736396055;56275.15587266194;56300;60190.39809601936;60975;61025.38974610197;61056;61130.694346527984;14770.556883293519;15028.248587570797;15069.246537673293;15100.169490678118;15111.924440377948;11004.559817607365;11052.447377631086;11062.502187401586;11064;11066;17914.641707165785;17935;18004;18536.44390668282;18580;7032.964835175791;7227.1327440707455;7341.375983041501;7368.815779605553;7410.703571857173;904.7195369435497;941.4821847983582;972.6304004478394;1014.8731408573929;1018.1701912940929;28141.43717125646;28540.571891421645;28693.28266793305;28912;29062.85468572686;1053.8155822730992;1074.8881986648607;1115.2360632966445;1125.780472807811;1137.9644523483755;14926.4775732851;14975.400983960737;14997.2501374933;15086.396544138111;15124;337478;342219;342492;343510;343919;52084.218736718976;52347.214791778155;52392.73803630957;52402.73798631059;52432.47567524276;1308.57912861206;1315.355475816862;1329.3486191765965;1338.3508998136092;1339.8191244182105;27687.446251075267;28487;28881.133565993056;29088.7091129086;29142.27144321324;41798.791006044776;42017;45493.54506454893;46452.30321545112;47148;198599;199084;199246;200773;201040;27227.183184504498;27246.04638837631;27436.725632744216;27470.725292746818;27478.5878211823;31305.21736956503;39261.60738392694;41084.29097707139;41585;42356.57643423649;34546.136346591535;34561.65438345685;35186.82406588053;36016.4597531032;36125.0968725784;34406.48390274198;34992;35115.64884351226;35161.8241908799;35196.824015879756;33212;34575.82712086423;34586.48120278148;34603;34622.826885866416;28958.565621516114;31491.527627085154;31928.68071319257;31984.68015319817;32045;24286.63570046486;24525.632115518638;24546.140885068937;24909.501809964062;24918.626220607068 07:26:41 INFO - PROCESS | 3613 | |2;jquery.html;355.97508174427793;357.5816294934926;357.92304654499276;360.07999561121323;360.998195009025;13455.663608409795;13768.24274664893;16288.18559072046;16334.2649580769;16930;12944.74110517789;12978.675533111676;13002.349882505885;15139.772903406458;15701;5047.394312682465;5191.1953647184655;5203.063448579254;5207.244949482323;5211.478852114796;3739.420389839579;3825.2923209206247;5176.715280659562;5225.190095535179;5389.946100538984;5304.20436934459;5325.7603407846545;5334.333208348957;5360.195970604402;5368.865778355534;5041.445441001487;5138.948610513884;5155.175171972466;5163.7159956202395;5341.252224688527;4918.532739389752;4984.102861484931;4988.5260900214425;4989.052080104769;5179.119549676527;12247.265164090182;12433.191842530206;12477.937610311981;12505.187162834387;18328.358507452307;2031.4515080928215;2058.217877206667;2062.4019034479984;2086.95826083479;2126.0964090261577;9288;9300.72097837066;9353.812923741487;9406.905930940671;9657.565409556586;1818.7271909213723;1833.9449816505526;1839.1264149529;1868.8318051375306;1928.9324873629355;59196;60513.69743151256;61186.694066529824;62125.37874621241;62380;9987.350822196535;10001.44992025431;10011.899881001242;10021.148202402877;10067.848982265272;13118;13139.868601314056;13153;13169.144005639602;13183.472661093449;7350.117985841626;7354.301341372561;7389.593572353465;7425.368843648351;7430.554166750012;7129.928700713031;7173.565286942632;7187.5687458752645;7244.529105608119;7255.383292420098;4222.4299719538085;4265.210935976792;4282.593153650399;4297.613214810682;4323.616442738356;1697.380456133527;1756.3150371355182;1774.38783619651;1791.570023194424;1798.3615816384995;909.0818273543769;917.4128557723062;994.2592768387598;1007.6322142417964;1045.2996492350144;12949.611511654666;15265.160416176996;16599;16695.91652041732;17057;867.111211008721;882.4969767232744;908.3868388837641;922.8431166701677;932.9877083364626;9218.032106628842;9442;9445.433274003582;9485.478298693639;9568.282378821616;405853;410656;412631;417187;522724;69794;71019;71250.2874971254;73041;81584;1070.053003092269;1080.1628737728324;1083.3878858444953;1106.3085571517802;1135.4947048563474;15030.774538382151;15299.46451874179;15485.148316842682;15506.844931550992;15764.68470630604;34741.65258347384;35224.47163292604;35229.64770352366;35911.64088359083;36159.819200903825;47772.761136194094;47928.52071479241;49338.50661493483;49426.75286623544;49608.50391496039;9279.350445468752;9280.350375473921;9420.952895235754;9486.28852836054;9507.429554226768;13890.722185556435;16580.336786528405;16771;16828.326866925185;17315.56711082233;13610;14122.364493597608;14412.927935360256;14474.565763027125;14705.852941470876;13670.863291367357;13867.72264554683;13989.370478328296;14069.437222510986;14356;11878.346690931736;11936.701582460508;12561.309127997682;14536.563903082924;14539.491117811249;9029.36794424384;9482.85775713351;9507.857382139135;9649.324547281904;9655.324127311302;10369.792604148026;10483.633072842415;13336.86663133395;14472.638184045483;14537.491187808377 07:26:41 INFO - PROCESS | 3613 | |3;mootools.html;1309.9476020959162;1432.3912337256666;1438.6259572511144;1603.6552141289621;1797.397871712976;6894.413974812141;7472.065991751031;7600.125985511668;7616.65725042373;7620.428467864918;7421.666025028887;7614.314711675948;7627.275408836165;7628.809279768008;7632.3894088472925;1940.049375805852;1969.6946973219103;2191.4630915425664;2201.66974953757;2218.1127548980376;2255.7857003584713;2269.5347453771938;2278.134308962592;2284.9885750571225;2286.9313920582326;2126.075157306577;2188.223180770827;2201.306588424641;2202.031106313217;2204.162418281051;2165.0798410675557;2177.2379667116543;2180.3023032629567;2201.5376770878133;2225.8887055647233;2218.0462401167492;2238.597052530544;2242.7532971373134;2268.727752669674;2273.9317820465412;7702.614869256571;7778.64996075178;7781.41639377049;7802.960985195038;7824.804379890491;4619.907601847978;4685.5314468553215;4692.718436893763;4692.741899195543;4693.366395536627;3014.9849250753823;3061.8775248990014;3103.286244163855;3108.145260053481;3133.9843300783577;980.2158273381337;983.695054533097;1020.9591616335412;1023.5905637744887;1042.5985995391752;10211.132053775364;10324.89675103247;10336.999999999925;10339.741506462324;10350.741231469197;4064.166845796605;4134.37984302357;4205.747655140702;4206.369044643328;4229.936550951738;8394.412391132562;8557.957210213908;8561.657533698706;8583.141685831368;8586.484810911365;4691.53084691535;4721.032188401369;4737.170995075848;4737.810487580458;4738.218193997952;4324.610785029363;4368.4102646143;4373.671974601918;4374.978125109354;4375.649948004152;3252.625948015961;3305.355455686118;3345.749068819848;3373;3421.726261899042;1052.957881684724;1053.4206186597341;1054.8470471781702;1069.7432616172064;1080.448971024783;1067.653012770837;1071.1056268016293;1122.5565901468874;1317.8616245294297;1318.6637407461037;7082;7176.820579485555;7358.96320518394;7429.85140297191;7477.775666729898;1077.3482043363808;1101.7686285879895;1102.366139469808;1110.8444817725524;1147.6270212180907;5746.569007324468;5836.358000619928;5850;5857.15071314657;5859.677717725566;8800.119988001277;8817.118288171132;8985.371024028385;8998.14517620825;9154.176124148858;8873.866891996626;8990.056044115405;9014.729558113268;9022.368434209542;9064.320175986828;7067.363937245673;7191.964040179871;7199.568025918357;7267.927320726831;7313.268673132644;7229.63851807397;7279.563226206233;7288.416926645961;7295.088113985752;7295.23400043009;7936.761897143095;8166.510009399455;8187.549684767395;8321.375896807642;8344.457610255315;8492.957535212285;8536.103709110454;8682.262007729414;8698;8740.475571465733;6710;6773.695183716646;6819.215790184192;6823.522353435411;6837.145356830396;6485.3514648534765;6604.240512341143;6963.199232088172;7093.964530177523;7375.446841486802;6829.214640316427;6909.689063992032;6916.688749006206;7042.0845290114;7045.647717613996;6689.799306020827;6785.050092986887;6821.147356580427;6886.035954966209;6924.203716572457;6787.694553745192;6819.897701534382;6833.487488438288;6834.248232694499;6836.042953986346;6219.40915613016;6221.129041934042;6237.1891654084675;6241.282252540835;6297.2128483939505;6233.688315584293;6246.063090536456;6249.093881387264;6257.4681152102585;6258.749650013949 07:26:41 INFO - PROCESS | 3613 | |4;prototype.html;344.1499496244277;350.6160753974397;351.99505412048603;352.9347070791902;357.17492592112205;5928.436798504146;5950.315713692927;6104.9694751526295;6125.5405844561665;6139.600925939811;5871.853203669911;5949.732262048207;5974.8805023899495;5990.1913241712355;6036.879262414749;4653.092646933841;4669.229577119788;4673.579377855992;4674.088552732219;4674.766261686902;4463.4643842738915;4536.72779633223;4547.226971414851;4666.370040044601;4673.556012178838;4583.449986001685;4602.217623004098;4610;4613.953860461403;4616.6306695464455;4571.5428457154185;4625.098105869373;4633.258678611406;4645.558671926162;4651.976740116278;4111.958880411187;4113.4858142732155;4114.629683328485;4118.238125946679;4124.278251306009;5652.378238393773;5766.279215098113;5771.163181338724;5776.046952252916;5784.739686714066;5420.512153906167;5423.267858839085;5432.83701488952;5433.022056029913;5433.918491222596;6391.1371964785085;6396.648184349859;6403.455706264973;6404.167458230447;6407.583507072025;4308.78456077198;4376.737395756233;4380.452443444569;4418.5581441855875;4453.643708503312;6564.474842012628;6594.274629790767;6598.439132673729;6603.537752357337;6607.141071660653;4631.861044168681;4632.791524381411;4633.62930965522;4635.953640463552;4637.930431043537;4600.60894823937;4702.553257440606;4704.411948506437;4704.811807527661;4747.572718455355;5350.491703288181;5395.892082158335;5397.055515284809;5398.838034858961;5402.621816472888;6377.266614339317;6380.234371875312;6382.936170638327;6393.488520918316;6395.968020159962;1649.6205872649118;1683.1500092453232;1683.402392150769;1684.6041180322613;1685.755565443004;1143.8227074803253;1150.0799360511558;1151.694800877768;1168.6377223060879;1175.4769127738246;6136.539759518054;6137.846553836101;6149.200603921461;6150.07748837669;6156.6921653917125;6671.966640166866;6679.6640671865825;6680.933190668128;6684.2981486944145;6687.331266873371;5973.910391344133;6143.662098584531;6143.754249830046;6144.41628045335;6146.200993870768;3579.3736096183065;3612.512310838056;3614.313280476701;3617.4935509028755;3619.389371729608;6859.348361905611;6871.553349032297;6871.725130994804;6878.3465570770695;6880.793576192722;6697.6986035628515;6813.454923606099;6821.829454263584;6833.350831670983;6833.794986150423;6805.795826125224;6817.045613614098;6844.4182244509775;6848.6918088686125;6856.760013399607;6394.1687580614225;6622.437092847162;6628;6633.6019838809825;6647.235567909753;6408.359164083555;6424.839379015562;6566.179227596551;6575.671216439063;6621.404073633396;6869.347411995853;6873.896891546531;6879.415249703831;6897.448204143556;6901.447884169154;4604.815807367801;4681.368015317888;4681.882952926067;4688.484266730725;4690.413698287714;6727.293634168342;6741.764038258638;6751.662416879039;6754.223264324665;6755;6526.869462610816;6528.249251336157;6531.085648009187;6534.183227096613;6558.147440832661;6377.426031657174;6513.088167656627;6523.7716679915975;6525.347465253437;6525.934740652722;6407.935920640734;6421.839454013687;6422.871542569029;6426.582272152295;6427.100205971261;6551.6069035858;6555.737770489127;6557.868842623026;6564.146660934048;6568.441682457044;6191.845203869759;6361.363863613602;6368.840778980562;6381.585196962183;6395.6482393468805 07:26:41 INFO - PROCESS | 3613 | |5;yui.html;782.5845151551265;837.5728378526953;841.3395484544634;843.5571325054345;847.1189962439064;13339.53311634093;13587.660308492292;13591;13600.319984000798;13602;14907.701845963102;15200.771988420183;15206.619834504143;15218.771718424232;15234.771478427805;681.8090934538337;807.4549678966689;818.2063398503442;818.2349503214514;819.8360327934437;683.9555428897131;815.1522416686639;829.7966998085477;832.3840358134967;832.4256263178418;853.3045567862204;862.1034124510502;862.5169904853302;863.3266052479077;863.6027427383411;702.7399862051022;706.2196273118182;835.0772396501839;850.8425941200867;855.5380094748829;620.928593211782;624.8312955502034;625.5777350288537;628.0485065126337;628.0861346740481;13272.601821945356;13387;13392.598222053257;13399.531016414476;13427.66430839227;12402.81395779064;13094.214347139106;13144.539941102015;13286.20282783036;13362.86637133626;10306.433146176958;10404.479776011245;10486.528106235237;10526.42104684242;10641.36151830885;3737.7009839212797;3785.0915780212827;3818.2363527294374;3887.8833634990997;3893.5717071122153;46318;46773;46908.53091469076;46913.5308646916;47330.05339893217;8948.8657670135;9024.413413128126;9171.220446262008;9221.585028673591;9397.201237894855;17048.65902681964;17154.742678859828;17196.570085747957;17239.31042758301;17246.223919923632;7427.888581671279;7562.886556701654;7581.658825352873;7702.383809295243;7819;4375.584319489643;4411.183930972717;4468.620167285752;4564.97717511417;4581.450225972904;3027.2885871820104;3075.3695492424445;3080.0451859923496;3081.260497480633;3088.274255549944;523.6857885268885;531.614579429918;536.7209051293306;539.2423644779092;548.4460694698304;533.703794394115;623.1182876230174;639.5043841023244;665.1498329657395;722.9674664640104;8292.33661307094;8588.441751286271;8680.826383472295;8732.738017859474;9684;569.6268943841791;661.454300202335;665.3379887012453;677.8271540757174;678.5860625018735;4053.6757059435176;4214.7471151731;4362.10576831755;4392.604665580113;4418.867433976986;57163.42836571581;57427;57864.42135578675;58074.7096264516;59695.70152149211;50784.49215507872;52129;52158.47841521536;52201;52430;47838;47968.76015619969;48234.27648585274;48932.26601600979;49090.263646045336;8264.586770661563;8376.664933402595;8393.496390216607;8432.747017589236;8587.914120858712;36604.26791464102;36864.44703329399;37283;37688.05779855416;37858.81070594629;42804.78597606992;45438.31842522431;45941.77029114833;46188.53811461842;46680;10410.323328983592;10616.89383106159;10790.298630588986;10827.133829293794;10881.526224508003;12178.634640960785;12400.62798116058;12498.37508124572;12588.559400420942;12968.351582420653;11621.302721836717;11865.584704535646;11880.881191188324;11982;12393.752124957631;11267.830982535432;11284.548618055514;11298.49156787963;11605.187636865337;11840;11166.944165279121;11193.944030279796;11272.267302625303;11342.659720208407;11371.545138194711;9840.250493608242;10164.745881353025;10307.690769276935;10419;10528.105111065644;9226.815463690555;10034.951301848721;10124.493775311057;10130.746731331776;10147.64483243083 07:26:41 INFO - PROCESS | 3613 | __end_tp_report 07:26:41 INFO - PROCESS | 3613 | __start_cc_report 07:26:41 INFO - PROCESS | 3613 | _x_x_mozilla_cycle_collect,991 07:26:41 INFO - PROCESS | 3613 | __end_cc_report 07:26:41 INFO - PROCESS | 3613 | __startTimestamp1451143601885__endTimestamp 07:26:41 INFO - PROCESS | 3613 | 07:26:41 INFO - PROCESS | 3613 | ------- Summary: start ------- 07:26:41 INFO - PROCESS | 3613 | Number of tests: 6 07:26:41 INFO - PROCESS | 3613 | 07:26:41 INFO - PROCESS | 3613 | [#0] dojo.html Cycles:165 Average:5267.41 Median:5476.26 stddev:575.54 (10.5%) stddev-sans-first:552.24 07:26:41 INFO - PROCESS | 3613 | Values: 3125.5 3168.4 3199.2 3210.3 3236.0 5102.4 5210.1 5219.9 5223.2 5253.4 5248.1 5260.8 5335.4 5367.5 5368.6 4796.6 4838.4 4872.0 4873.7 4922.3 4864.2 4923.9 4969.9 4972.7 5016.5 4791.0 4859.7 4887.0 4897.8 4965.2 4764.7 4854.7 4865.7 4871.7 4875.6 4804.2 4842.6 4846.0 4852.7 4889.2 5069.8 5072.4 5134.7 5155.5 5183.7 5626.8 5639.2 5644.6 5654.3 5669.9 5681.0 5683.9 5687.9 5695.3 5699.5 5175.8 5278.6 5290.8 5298.2 5407.9 5821.5 5829.9 5833.0 5850.6 5874.2 5611.8 5618.3 5621.6 5624.4 5626.7 5516.5 5595.7 5608.7 5697.5 5717.3 5651.7 5652.8 5654.9 5659.5 5665.7 5608.3 5629.4 5671.8 5672.2 5674.1 4246.1 4295.7 4335.1 4366.2 4404.2 3915.5 3918.9 3924.3 3954.2 3958.4 5178.8 5240.1 5246.1 5250.9 5251.7 5662.2 5663.3 5666.3 5757.4 5811.4 5249.1 5262.1 5263.7 5271.4 5290.0 4720.1 4838.6 4851.8 4860.8 4893.8 5755.1 5781.8 5791.2 5822.2 5865.3 5699.3 5700.0 5700.9 5704.7 5711.2 5652.1 5826.2 5842.0 5845.6 5847.5 5600.2 5607.1 5644.0 5725.3 5773.5 5608.1 5662.7 5662.9 5668.1 5670.0 5481.8 5530.0 5532.9 5546.1 5550.6 5553.2 5565.2 5580.0 5623.6 5668.4 5451.3 5458.5 5465.0 5466.5 5476.3 5526.3 5577.1 5578.2 5594.6 5634.9 5415.3 5471.3 5472.7 5481.8 5520.3 07:26:41 INFO - PROCESS | 3613 | 07:26:41 INFO - PROCESS | 3613 | [#1] ext.html Cycles:180 Average:44014.69 Median:343714.50 stddev:73554.91 (21.4%) stddev-sans-first:73688.89 07:26:41 INFO - PROCESS | 3613 | Values: 560.8 577.7 586.6 591.2 615.5 28063.3 35439.3 35827.5 35830.5 35837.0 38283.6 38413.8 38422.2 38496.0 38759.4 7306.7 7437.6 8325.9 8494.7 8499.4 7452.3 7540.0 9954.0 10147.9 10200.5 9905.2 9952.1 9997.2 10022.2 10022.3 7625.7 9846.7 9917.1 9945.8 9948.7 7469.9 10012.6 10256.1 10261.1 10271.9 36549.8 37049.8 37052.4 37106.3 37114.0 3015.6 3029.4 3127.5 3182.8 3726.1 30365.7 30386.5 30548.0 30944.1 31424.8 3922.6 3948.9 3957.1 3997.4 4054.0 281111.0 281600.0 281914.0 282921.0 283716.0 50649.2 52003.0 55852.7 56275.2 56300.0 60190.4 60975.0 61025.4 61056.0 61130.7 14770.6 15028.2 15069.2 15100.2 15111.9 11004.6 11052.4 11062.5 11064.0 11066.0 17914.6 17935.0 18004.0 18536.4 18580.0 7033.0 7227.1 7341.4 7368.8 7410.7 904.7 941.5 972.6 1014.9 1018.2 28141.4 28540.6 28693.3 28912.0 29062.9 1053.8 1074.9 1115.2 1125.8 1138.0 14926.5 14975.4 14997.3 15086.4 15124.0 337478.0 342219.0 342492.0 343510.0 343919.0 52084.2 52347.2 52392.7 52402.7 52432.5 1308.6 1315.4 1329.3 1338.4 1339.8 27687.4 28487.0 28881.1 29088.7 29142.3 41798.8 42017.0 45493.5 46452.3 47148.0 198599.0 199084.0 199246.0 200773.0 201040.0 27227.2 27246.0 27436.7 27470.7 27478.6 31305.2 39261.6 41084.3 41585.0 42356.6 34546.1 34561.7 35186.8 36016.5 36125.1 34406.5 34992.0 35115.6 35161.8 35196.8 33212.0 34575.8 34586.5 34603.0 34622.8 28958.6 31491.5 31928.7 31984.7 32045.0 24286.6 24525.6 24546.1 24909.5 24918.6 07:26:41 INFO - PROCESS | 3613 | 07:26:41 INFO - PROCESS | 3613 | [#2] jquery.html Cycles:180 Average:25303.22 Median:19949.62 stddev:71479.07 (358.3%) stddev-sans-first:71655.04 07:26:41 INFO - PROCESS | 3613 | Values: 356.0 357.6 357.9 360.1 361.0 13455.7 13768.2 16288.2 16334.3 16930.0 12944.7 12978.7 13002.3 15139.8 15701.0 5047.4 5191.2 5203.1 5207.2 5211.5 3739.4 3825.3 5176.7 5225.2 5389.9 5304.2 5325.8 5334.3 5360.2 5368.9 5041.4 5138.9 5155.2 5163.7 5341.3 4918.5 4984.1 4988.5 4989.1 5179.1 12247.3 12433.2 12477.9 12505.2 18328.4 2031.5 2058.2 2062.4 2087.0 2126.1 9288.0 9300.7 9353.8 9406.9 9657.6 1818.7 1833.9 1839.1 1868.8 1928.9 59196.0 60513.7 61186.7 62125.4 62380.0 9987.4 10001.4 10011.9 10021.1 10067.8 13118.0 13139.9 13153.0 13169.1 13183.5 7350.1 7354.3 7389.6 7425.4 7430.6 7129.9 7173.6 7187.6 7244.5 7255.4 4222.4 4265.2 4282.6 4297.6 4323.6 1697.4 1756.3 1774.4 1791.6 1798.4 909.1 917.4 994.3 1007.6 1045.3 12949.6 15265.2 16599.0 16695.9 17057.0 867.1 882.5 908.4 922.8 933.0 9218.0 9442.0 9445.4 9485.5 9568.3 405853.0 410656.0 412631.0 417187.0 522724.0 69794.0 71019.0 71250.3 73041.0 81584.0 1070.1 1080.2 1083.4 1106.3 1135.5 15030.8 15299.5 15485.1 15506.8 15764.7 34741.7 35224.5 35229.6 35911.6 36159.8 47772.8 47928.5 49338.5 49426.8 49608.5 9279.4 9280.4 9421.0 9486.3 9507.4 13890.7 16580.3 16771.0 16828.3 17315.6 13610.0 14122.4 14412.9 14474.6 14705.9 13670.9 13867.7 13989.4 14069.4 14356.0 11878.3 11936.7 12561.3 14536.6 14539.5 9029.4 9482.9 9507.9 9649.3 9655.3 10369.8 10483.6 13336.9 14472.6 14537.5 07:26:41 INFO - PROCESS | 3613 | 07:26:41 INFO - PROCESS | 3613 | [#3] mootools.html Cycles:180 Average:5334.92 Median:6235.44 stddev:2741.14 (44.0%) stddev-sans-first:2732.14 07:26:41 INFO - PROCESS | 3613 | Values: 1309.9 1432.4 1438.6 1603.7 1797.4 6894.4 7472.1 7600.1 7616.7 7620.4 7421.7 7614.3 7627.3 7628.8 7632.4 1940.0 1969.7 2191.5 2201.7 2218.1 2255.8 2269.5 2278.1 2285.0 2286.9 2126.1 2188.2 2201.3 2202.0 2204.2 2165.1 2177.2 2180.3 2201.5 2225.9 2218.0 2238.6 2242.8 2268.7 2273.9 7702.6 7778.6 7781.4 7803.0 7824.8 4619.9 4685.5 4692.7 4692.7 4693.4 3015.0 3061.9 3103.3 3108.1 3134.0 980.2 983.7 1021.0 1023.6 1042.6 10211.1 10324.9 10337.0 10339.7 10350.7 4064.2 4134.4 4205.7 4206.4 4229.9 8394.4 8558.0 8561.7 8583.1 8586.5 4691.5 4721.0 4737.2 4737.8 4738.2 4324.6 4368.4 4373.7 4375.0 4375.6 3252.6 3305.4 3345.7 3373.0 3421.7 1053.0 1053.4 1054.8 1069.7 1080.4 1067.7 1071.1 1122.6 1317.9 1318.7 7082.0 7176.8 7359.0 7429.9 7477.8 1077.3 1101.8 1102.4 1110.8 1147.6 5746.6 5836.4 5850.0 5857.2 5859.7 8800.1 8817.1 8985.4 8998.1 9154.2 8873.9 8990.1 9014.7 9022.4 9064.3 7067.4 7192.0 7199.6 7267.9 7313.3 7229.6 7279.6 7288.4 7295.1 7295.2 7936.8 8166.5 8187.5 8321.4 8344.5 8493.0 8536.1 8682.3 8698.0 8740.5 6710.0 6773.7 6819.2 6823.5 6837.1 6485.4 6604.2 6963.2 7094.0 7375.4 6829.2 6909.7 6916.7 7042.1 7045.6 6689.8 6785.1 6821.1 6886.0 6924.2 6787.7 6819.9 6833.5 6834.2 6836.0 6219.4 6221.1 6237.2 6241.3 6297.2 6233.7 6246.1 6249.1 6257.5 6258.7 07:26:41 INFO - PROCESS | 3613 | 07:26:41 INFO - PROCESS | 3613 | [#4] prototype.html Cycles:180 Average:5396.20 Median:6137.19 stddev:1611.12 (26.3%) stddev-sans-first:1570.39 07:26:41 INFO - PROCESS | 3613 | Values: 344.1 350.6 352.0 352.9 357.2 5928.4 5950.3 6105.0 6125.5 6139.6 5871.9 5949.7 5974.9 5990.2 6036.9 4653.1 4669.2 4673.6 4674.1 4674.8 4463.5 4536.7 4547.2 4666.4 4673.6 4583.4 4602.2 4610.0 4614.0 4616.6 4571.5 4625.1 4633.3 4645.6 4652.0 4112.0 4113.5 4114.6 4118.2 4124.3 5652.4 5766.3 5771.2 5776.0 5784.7 5420.5 5423.3 5432.8 5433.0 5433.9 6391.1 6396.6 6403.5 6404.2 6407.6 4308.8 4376.7 4380.5 4418.6 4453.6 6564.5 6594.3 6598.4 6603.5 6607.1 4631.9 4632.8 4633.6 4636.0 4637.9 4600.6 4702.6 4704.4 4704.8 4747.6 5350.5 5395.9 5397.1 5398.8 5402.6 6377.3 6380.2 6382.9 6393.5 6396.0 1649.6 1683.2 1683.4 1684.6 1685.8 1143.8 1150.1 1151.7 1168.6 1175.5 6136.5 6137.8 6149.2 6150.1 6156.7 6672.0 6679.7 6680.9 6684.3 6687.3 5973.9 6143.7 6143.8 6144.4 6146.2 3579.4 3612.5 3614.3 3617.5 3619.4 6859.3 6871.6 6871.7 6878.3 6880.8 6697.7 6813.5 6821.8 6833.4 6833.8 6805.8 6817.0 6844.4 6848.7 6856.8 6394.2 6622.4 6628.0 6633.6 6647.2 6408.4 6424.8 6566.2 6575.7 6621.4 6869.3 6873.9 6879.4 6897.4 6901.4 4604.8 4681.4 4681.9 4688.5 4690.4 6727.3 6741.8 6751.7 6754.2 6755.0 6526.9 6528.2 6531.1 6534.2 6558.1 6377.4 6513.1 6523.8 6525.3 6525.9 6407.9 6421.8 6422.9 6426.6 6427.1 6551.6 6555.7 6557.9 6564.1 6568.4 6191.8 6361.4 6368.8 6381.6 6395.6 07:26:41 INFO - PROCESS | 3613 | 07:26:41 INFO - PROCESS | 3613 | [#5] yui.html Cycles:180 Average:14026.50 Median:46065.15 stddev:16185.61 (35.1%) stddev-sans-first:16200.46 07:26:41 INFO - PROCESS | 3613 | Values: 782.6 837.6 841.3 843.6 847.1 13339.5 13587.7 13591.0 13600.3 13602.0 14907.7 15200.8 15206.6 15218.8 15234.8 681.8 807.5 818.2 818.2 819.8 684.0 815.2 829.8 832.4 832.4 853.3 862.1 862.5 863.3 863.6 702.7 706.2 835.1 850.8 855.5 620.9 624.8 625.6 628.0 628.1 13272.6 13387.0 13392.6 13399.5 13427.7 12402.8 13094.2 13144.5 13286.2 13362.9 10306.4 10404.5 10486.5 10526.4 10641.4 3737.7 3785.1 3818.2 3887.9 3893.6 46318.0 46773.0 46908.5 46913.5 47330.1 8948.9 9024.4 9171.2 9221.6 9397.2 17048.7 17154.7 17196.6 17239.3 17246.2 7427.9 7562.9 7581.7 7702.4 7819.0 4375.6 4411.2 4468.6 4565.0 4581.5 3027.3 3075.4 3080.0 3081.3 3088.3 523.7 531.6 536.7 539.2 548.4 533.7 623.1 639.5 665.1 723.0 8292.3 8588.4 8680.8 8732.7 9684.0 569.6 661.5 665.3 677.8 678.6 4053.7 4214.7 4362.1 4392.6 4418.9 57163.4 57427.0 57864.4 58074.7 59695.7 50784.5 52129.0 52158.5 52201.0 52430.0 47838.0 47968.8 48234.3 48932.3 49090.3 8264.6 8376.7 8393.5 8432.7 8587.9 36604.3 36864.4 37283.0 37688.1 37858.8 42804.8 45438.3 45941.8 46188.5 46680.0 10410.3 10616.9 10790.3 10827.1 10881.5 12178.6 12400.6 12498.4 12588.6 12968.4 11621.3 11865.6 11880.9 11982.0 12393.8 11267.8 11284.5 11298.5 11605.2 11840.0 11166.9 11193.9 11272.3 11342.7 11371.5 9840.3 10164.7 10307.7 10419.0 10528.1 9226.8 10035.0 10124.5 10130.7 10147.6 07:26:41 INFO - PROCESS | 3613 | -------- Summary: end -------- 07:26:41 INFO - PROCESS | 3613 | 07:26:42 INFO - TEST-INFO | 3613: exit 0 07:26:42 INFO - TEST-OK | dromaeo_css | took 1117795ms 07:26:42 INFO - TEST-START | kraken 07:26:42 INFO - operating with platform_type : linux_ 07:26:42 INFO - Initialising browser for kraken test... 07:26:42 INFO - TEST-INFO | started process 3809 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHGZoE6/profile http://localhost:46674/getInfo.html) 07:26:47 INFO - PROCESS | 3809 | __metrics Screen width/height:1600/1200 07:26:47 INFO - PROCESS | 3809 | colorDepth:24 07:26:47 INFO - PROCESS | 3809 | Browser inner width/height: 1024/697 07:26:47 INFO - PROCESS | 3809 | __metrics 07:26:47 INFO - PROCESS | 3809 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:26:47 INFO - PROCESS | 3809 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:26:48 INFO - TEST-INFO | 3809: exit 0 07:26:48 INFO - Browser initialized. 07:26:48 INFO - Running cycle 1/1 for kraken test... 07:26:48 INFO - TEST-INFO | started process 3890 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHGZoE6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:27:00 INFO - PROCESS | 3890 | RSS: Main: 148946944 07:27:00 INFO - PROCESS | 3890 | 07:27:02 INFO - PROCESS | 3890 | Cycle 1(1): loaded http://localhost:46674/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46674/tests/kraken/driver.html?testName=audio-beat-detection) 07:27:03 INFO - PROCESS | 3890 | RSS: Main: 184893440 07:27:03 INFO - PROCESS | 3890 | 07:27:06 INFO - PROCESS | 3890 | Cycle 1(1): loaded http://localhost:46674/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46674/tests/kraken/driver.html?testName=audio-dft) 07:27:06 INFO - PROCESS | 3890 | RSS: Main: 173813760 07:27:06 INFO - PROCESS | 3890 | 07:27:09 INFO - PROCESS | 3890 | Cycle 1(1): loaded http://localhost:46674/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46674/tests/kraken/driver.html?testName=audio-fft) 07:27:10 INFO - PROCESS | 3890 | RSS: Main: 159449088 07:27:10 INFO - PROCESS | 3890 | 07:27:12 INFO - PROCESS | 3890 | Cycle 1(1): loaded http://localhost:46674/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46674/tests/kraken/driver.html?testName=audio-oscillator) 07:27:12 INFO - PROCESS | 3890 | RSS: Main: 161783808 07:27:12 INFO - PROCESS | 3890 | 07:27:14 INFO - PROCESS | 3890 | Cycle 1(1): loaded http://localhost:46674/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46674/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:27:15 INFO - PROCESS | 3890 | RSS: Main: 164675584 07:27:15 INFO - PROCESS | 3890 | 07:27:18 INFO - PROCESS | 3890 | Cycle 1(1): loaded http://localhost:46674/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46674/tests/kraken/driver.html?testName=imaging-darkroom) 07:27:18 INFO - PROCESS | 3890 | RSS: Main: 164245504 07:27:18 INFO - PROCESS | 3890 | 07:27:22 INFO - PROCESS | 3890 | Cycle 1(1): loaded http://localhost:46674/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46674/tests/kraken/driver.html?testName=imaging-desaturate) 07:27:22 INFO - PROCESS | 3890 | RSS: Main: 166440960 07:27:22 INFO - PROCESS | 3890 | 07:27:25 INFO - PROCESS | 3890 | Cycle 1(1): loaded http://localhost:46674/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46674/tests/kraken/driver.html?testName=json-parse-financial) 07:27:26 INFO - PROCESS | 3890 | RSS: Main: 166006784 07:27:26 INFO - PROCESS | 3890 | 07:27:27 INFO - PROCESS | 3890 | Cycle 1(1): loaded http://localhost:46674/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46674/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:27:28 INFO - PROCESS | 3890 | RSS: Main: 177442816 07:27:28 INFO - PROCESS | 3890 | 07:27:30 INFO - PROCESS | 3890 | Cycle 1(1): loaded http://localhost:46674/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46674/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:27:30 INFO - PROCESS | 3890 | RSS: Main: 176934912 07:27:30 INFO - PROCESS | 3890 | 07:27:33 INFO - PROCESS | 3890 | Cycle 1(1): loaded http://localhost:46674/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46674/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:27:33 INFO - PROCESS | 3890 | RSS: Main: 182329344 07:27:33 INFO - PROCESS | 3890 | 07:27:36 INFO - PROCESS | 3890 | Cycle 1(1): loaded http://localhost:46674/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46674/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:27:36 INFO - PROCESS | 3890 | RSS: Main: 191705088 07:27:36 INFO - PROCESS | 3890 | 07:27:39 INFO - PROCESS | 3890 | Cycle 1(1): loaded http://localhost:46674/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46674/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:27:40 INFO - PROCESS | 3890 | RSS: Main: 189292544 07:27:40 INFO - PROCESS | 3890 | 07:27:41 INFO - PROCESS | 3890 | Cycle 1(1): loaded http://localhost:46674/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46674/tests/kraken/driver.html?testName=ai-astar) 07:27:42 INFO - PROCESS | 3890 | RSS: Main: 245780480 07:27:42 INFO - PROCESS | 3890 | 07:27:42 INFO - PROCESS | 3890 | __start_tp_report 07:27:42 INFO - PROCESS | 3890 | _x_x_mozilla_page_load 07:27:42 INFO - PROCESS | 3890 | _x_x_mozilla_page_load_details 07:27:42 INFO - PROCESS | 3890 | |i|pagename|runs| 07:27:42 INFO - PROCESS | 3890 | |0;ai-astar;109;112;104;110;110;109;98;110;110;101 07:27:42 INFO - PROCESS | 3890 | |1;audio-beat-detection;154;129;147;168;130;149;152;127;166;127 07:27:42 INFO - PROCESS | 3890 | |2;audio-dft;160;162;162;160;162;160;159;161;159;161 07:27:42 INFO - PROCESS | 3890 | |3;audio-fft;71;70;75;96;76;71;73;99;92;72 07:27:42 INFO - PROCESS | 3890 | |4;audio-oscillator;96;96;139;96;96;96;144;98;98;137 07:27:42 INFO - PROCESS | 3890 | |5;imaging-gaussian-blur;109;110;110;109;110;109;110;109;109;110 07:27:42 INFO - PROCESS | 3890 | |6;imaging-darkroom;146;145;145;145;144;145;145;146;146;145 07:27:42 INFO - PROCESS | 3890 | |7;imaging-desaturate;96;96;96;95;96;95;95;96;95;95 07:27:42 INFO - PROCESS | 3890 | |8;json-parse-financial;58;58;57;57;58;58;58;65;55;55 07:27:42 INFO - PROCESS | 3890 | |9;json-stringify-tinderbox;67;68;66;67;75;67;66;67;66;66 07:27:42 INFO - PROCESS | 3890 | |10;stanford-crypto-aes;83;83;85;85;92;84;84;85;85;85 07:27:42 INFO - PROCESS | 3890 | |11;stanford-crypto-ccm;129;114;121;123;124;123;125;120;130;120 07:27:42 INFO - PROCESS | 3890 | |12;stanford-crypto-pbkdf2;144;148;148;150;153;138;150;148;148;140 07:27:42 INFO - PROCESS | 3890 | |13;stanford-crypto-sha256-iterative;67;69;69;67;67;67;66;66;66;67 07:27:42 INFO - PROCESS | 3890 | __end_tp_report 07:27:42 INFO - PROCESS | 3890 | __start_cc_report 07:27:42 INFO - PROCESS | 3890 | _x_x_mozilla_cycle_collect,929 07:27:42 INFO - PROCESS | 3890 | __end_cc_report 07:27:42 INFO - PROCESS | 3890 | __startTimestamp1451143662007__endTimestamp 07:27:42 INFO - PROCESS | 3890 | 07:27:42 INFO - PROCESS | 3890 | ------- Summary: start ------- 07:27:42 INFO - PROCESS | 3890 | Number of tests: 14 07:27:42 INFO - PROCESS | 3890 | 07:27:42 INFO - PROCESS | 3890 | [#0] ai-astar Cycles:10 Average:107.30 Median:110.00 stddev:4.64 (4.2%) stddev-sans-first:4.88 07:27:42 INFO - PROCESS | 3890 | Values: 109.0 112.0 104.0 110.0 110.0 109.0 98.0 110.0 110.0 101.0 07:27:42 INFO - PROCESS | 3890 | 07:27:42 INFO - PROCESS | 3890 | [#1] audio-beat-detection Cycles:10 Average:144.90 Median:150.50 stddev:15.81 (10.5%) stddev-sans-first:16.42 07:27:42 INFO - PROCESS | 3890 | Values: 154.0 129.0 147.0 168.0 130.0 149.0 152.0 127.0 166.0 127.0 07:27:42 INFO - PROCESS | 3890 | 07:27:42 INFO - PROCESS | 3890 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.17 (0.7%) stddev-sans-first:1.22 07:27:42 INFO - PROCESS | 3890 | Values: 160.0 162.0 162.0 160.0 162.0 160.0 159.0 161.0 159.0 161.0 07:27:42 INFO - PROCESS | 3890 | 07:27:42 INFO - PROCESS | 3890 | [#3] audio-fft Cycles:10 Average:79.50 Median:75.50 stddev:11.42 (15.1%) stddev-sans-first:11.70 07:27:42 INFO - PROCESS | 3890 | Values: 71.0 70.0 75.0 96.0 76.0 71.0 73.0 99.0 92.0 72.0 07:27:42 INFO - PROCESS | 3890 | 07:27:42 INFO - PROCESS | 3890 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:96.00 stddev:21.06 (21.9%) stddev-sans-first:21.76 07:27:42 INFO - PROCESS | 3890 | Values: 96.0 96.0 139.0 96.0 96.0 96.0 144.0 98.0 98.0 137.0 07:27:42 INFO - PROCESS | 3890 | 07:27:42 INFO - PROCESS | 3890 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:27:42 INFO - PROCESS | 3890 | Values: 109.0 110.0 110.0 109.0 110.0 109.0 110.0 109.0 109.0 110.0 07:27:42 INFO - PROCESS | 3890 | 07:27:42 INFO - PROCESS | 3890 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 07:27:42 INFO - PROCESS | 3890 | Values: 146.0 145.0 145.0 145.0 144.0 145.0 145.0 146.0 146.0 145.0 07:27:42 INFO - PROCESS | 3890 | 07:27:42 INFO - PROCESS | 3890 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:27:42 INFO - PROCESS | 3890 | Values: 96.0 96.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 07:27:42 INFO - PROCESS | 3890 | 07:27:42 INFO - PROCESS | 3890 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:58.00 stddev:2.77 (4.8%) stddev-sans-first:2.93 07:27:42 INFO - PROCESS | 3890 | Values: 58.0 58.0 57.0 57.0 58.0 58.0 58.0 65.0 55.0 55.0 07:27:42 INFO - PROCESS | 3890 | 07:27:42 INFO - PROCESS | 3890 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.00 stddev:2.72 (4.1%) stddev-sans-first:2.88 07:27:42 INFO - PROCESS | 3890 | Values: 67.0 68.0 66.0 67.0 75.0 67.0 66.0 67.0 66.0 66.0 07:27:42 INFO - PROCESS | 3890 | 07:27:42 INFO - PROCESS | 3890 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:2.56 (3.0%) stddev-sans-first:2.60 07:27:42 INFO - PROCESS | 3890 | Values: 83.0 83.0 85.0 85.0 92.0 84.0 84.0 85.0 85.0 85.0 07:27:42 INFO - PROCESS | 3890 | 07:27:42 INFO - PROCESS | 3890 | [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:123.50 stddev:4.63 (3.7%) stddev-sans-first:4.35 07:27:42 INFO - PROCESS | 3890 | Values: 129.0 114.0 121.0 123.0 124.0 123.0 125.0 120.0 130.0 120.0 07:27:42 INFO - PROCESS | 3890 | 07:27:42 INFO - PROCESS | 3890 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.70 Median:148.00 stddev:4.67 (3.2%) stddev-sans-first:4.85 07:27:42 INFO - PROCESS | 3890 | Values: 144.0 148.0 148.0 150.0 153.0 138.0 150.0 148.0 148.0 140.0 07:27:42 INFO - PROCESS | 3890 | 07:27:42 INFO - PROCESS | 3890 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.10 (1.6%) stddev-sans-first:1.17 07:27:42 INFO - PROCESS | 3890 | Values: 67.0 69.0 69.0 67.0 67.0 67.0 66.0 66.0 66.0 67.0 07:27:42 INFO - PROCESS | 3890 | -------- Summary: end -------- 07:27:42 INFO - PROCESS | 3890 | 07:27:42 INFO - TEST-INFO | 3890: exit 0 07:27:42 INFO - TEST-OK | kraken | took 60322ms 07:27:42 INFO - TEST-START | v8_7 07:27:42 INFO - operating with platform_type : linux_ 07:27:42 INFO - Initialising browser for v8_7 test... 07:27:42 INFO - TEST-INFO | started process 4139 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkzAwED/profile http://localhost:46674/getInfo.html) 07:27:47 INFO - PROCESS | 4139 | __metrics Screen width/height:1600/1200 07:27:47 INFO - PROCESS | 4139 | colorDepth:24 07:27:47 INFO - PROCESS | 4139 | Browser inner width/height: 1024/697 07:27:47 INFO - PROCESS | 4139 | __metrics 07:27:47 INFO - PROCESS | 4139 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:27:47 INFO - PROCESS | 4139 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:27:49 INFO - TEST-INFO | 4139: exit 0 07:27:49 INFO - Browser initialized. 07:27:49 INFO - Running cycle 1/1 for v8_7 test... 07:27:49 INFO - TEST-INFO | started process 4221 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkzAwED/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:28:00 INFO - PROCESS | 4221 | RSS: Main: 148312064 07:28:00 INFO - PROCESS | 4221 | 07:28:22 INFO - PROCESS | 4221 | Cycle 1(1): loaded http://localhost:46674/tests/v8_7/run.html (next: http://localhost:46674/tests/v8_7/run.html) 07:28:22 INFO - PROCESS | 4221 | RSS: Main: 575209472 07:28:22 INFO - PROCESS | 4221 | 07:28:22 INFO - PROCESS | 4221 | __start_tp_report 07:28:22 INFO - PROCESS | 4221 | _x_x_mozilla_page_load 07:28:22 INFO - PROCESS | 4221 | _x_x_mozilla_page_load_details 07:28:22 INFO - PROCESS | 4221 | |i|pagename|runs| 07:28:22 INFO - PROCESS | 4221 | |0;Richards;166.86133822793258 07:28:22 INFO - PROCESS | 4221 | |1;DeltaBlue;191.68104274487254 07:28:22 INFO - PROCESS | 4221 | |2;Encrypt;282.08744710860367 07:28:22 INFO - PROCESS | 4221 | |3;Decrypt;5278.9473684210525 07:28:22 INFO - PROCESS | 4221 | |4;RayTrace;1968.5039370078741 07:28:22 INFO - PROCESS | 4221 | |5;Earley;809.0614886731391 07:28:22 INFO - PROCESS | 4221 | |6;Boyer;12419.753086419752 07:28:22 INFO - PROCESS | 4221 | |7;RegExp;25300 07:28:22 INFO - PROCESS | 4221 | |8;Splay;636.1323155216285 07:28:22 INFO - PROCESS | 4221 | |9;NavierStokes;4840.579710144928 07:28:22 INFO - PROCESS | 4221 | __end_tp_report 07:28:22 INFO - PROCESS | 4221 | __startTimestamp1451143702524__endTimestamp 07:28:22 INFO - PROCESS | 4221 | 07:28:22 INFO - PROCESS | 4221 | ------- Summary: start ------- 07:28:22 INFO - PROCESS | 4221 | Number of tests: 10 07:28:22 INFO - PROCESS | 4221 | 07:28:22 INFO - PROCESS | 4221 | [#0] Richards Cycles:1 Average:166.86 Median:166.86 stddev:0.00 (0.0%) 07:28:22 INFO - PROCESS | 4221 | Values: 166.9 07:28:22 INFO - PROCESS | 4221 | 07:28:22 INFO - PROCESS | 4221 | [#1] DeltaBlue Cycles:1 Average:191.68 Median:191.68 stddev:0.00 (0.0%) 07:28:22 INFO - PROCESS | 4221 | Values: 191.7 07:28:22 INFO - PROCESS | 4221 | 07:28:22 INFO - PROCESS | 4221 | [#2] Encrypt Cycles:1 Average:282.09 Median:282.09 stddev:0.00 (0.0%) 07:28:22 INFO - PROCESS | 4221 | Values: 282.1 07:28:22 INFO - PROCESS | 4221 | 07:28:22 INFO - PROCESS | 4221 | [#3] Decrypt Cycles:1 Average:5278.95 Median:5278.95 stddev:0.00 (0.0%) 07:28:22 INFO - PROCESS | 4221 | Values: 5278.9 07:28:22 INFO - PROCESS | 4221 | 07:28:22 INFO - PROCESS | 4221 | [#4] RayTrace Cycles:1 Average:1968.50 Median:1968.50 stddev:0.00 (0.0%) 07:28:22 INFO - PROCESS | 4221 | Values: 1968.5 07:28:22 INFO - PROCESS | 4221 | 07:28:22 INFO - PROCESS | 4221 | [#5] Earley Cycles:1 Average:809.06 Median:809.06 stddev:0.00 (0.0%) 07:28:22 INFO - PROCESS | 4221 | Values: 809.1 07:28:22 INFO - PROCESS | 4221 | 07:28:22 INFO - PROCESS | 4221 | [#6] Boyer Cycles:1 Average:12419.75 Median:12419.75 stddev:0.00 (0.0%) 07:28:22 INFO - PROCESS | 4221 | Values: 12419.8 07:28:22 INFO - PROCESS | 4221 | 07:28:22 INFO - PROCESS | 4221 | [#7] RegExp Cycles:1 Average:25300.00 Median:25300.00 stddev:0.00 (0.0%) 07:28:22 INFO - PROCESS | 4221 | Values: 25300.0 07:28:22 INFO - PROCESS | 4221 | 07:28:22 INFO - PROCESS | 4221 | [#8] Splay Cycles:1 Average:636.13 Median:636.13 stddev:0.00 (0.0%) 07:28:22 INFO - PROCESS | 4221 | Values: 636.1 07:28:22 INFO - PROCESS | 4221 | 07:28:22 INFO - PROCESS | 4221 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 07:28:22 INFO - PROCESS | 4221 | Values: 4840.6 07:28:22 INFO - PROCESS | 4221 | -------- Summary: end -------- 07:28:22 INFO - PROCESS | 4221 | 07:28:23 INFO - TEST-INFO | 4221: exit 0 07:28:23 INFO - TEST-OK | v8_7 | took 40437ms 07:28:23 INFO - SUITE-END | took 1218s 07:28:23 INFO - Completed test suite (00:20:18) 07:28:23 INFO - Working with test: dromaeo_css 07:28:23 INFO - Generating results file: dromaeo_css 07:28:23 INFO - Working with test: kraken 07:28:23 INFO - Generating results file: kraken 07:28:23 INFO - javascript benchmark 07:28:23 INFO - Working with test: v8_7 07:28:23 INFO - Generating results file: v8_7 07:28:23 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:28:23 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 07:28:23 INFO - process_Request line: dromaeo_css 6906.91 graph.html#tests=[[72,1,35]] 07:28:23 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:28:23 INFO - process_Request line: kraken 1499.30 graph.html#tests=[[232,1,35]] 07:28:23 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:28:23 INFO - process_Request line: v8_7 19625.70 graph.html#tests=[[230,1,35]] 07:28:23 INFO - RETURN: dromaeo_css: 6906.91 07:28:23 INFO - RETURN: kraken: 1499.30 07:28:23 INFO - RETURN: v8_7: 19625.70 07:28:23 INFO - javascript benchmark 07:28:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3125.4686703260445, 3168.3663267346537, 3199.216192032951, 3210.3418799146193, 3236.0130160301105, 5102.438731739506, 5210.086551763747, 5219.895602087956, 5223.164293713006, 5253.369595648518, 5248.134057880455, 5260.842174734764, 5335.413104558495, 5367.46325367463, 5368.570514358852, 4796.640251981089, 4838.371011768465, 4872.049950259683, 4873.658843880929, 4922.286268491084, 4864.221724524077, 4923.852284431473, 4969.900601987976, 4972.676776009566, 5016.523430274118, 4791.041791641685, 4859.659823812334, 4887.0, 4897.755112244391, 4965.155923493015, 4764.714117152982, 4854.708717476928, 4865.732384718839, 4871.683340582851, 4875.609951203895, 4804.20730579454, 4842.58837998767, 4846.0, 4852.684575502581, 4889.193283108283, 5069.822556210552, 5072.442031376546, 5134.717590532519, 5155.484451554852, 5183.663061901002, 5626.831195064155, 5639.154126881001, 5644.57665675076, 5654.321481422215, 5669.894370597735, 5681.0, 5683.943160568383, 5687.943120568782, 5695.345035320908, 5699.487046165865, 5175.767090480937, 5278.630495865253, 5290.788368465257, 5298.231756395301, 5407.918881216785, 5821.53427725781, 5829.854253643608, 5833.0, 5850.61970971894, 5874.1776151338845, 5611.831645050655, 5618.325800903917, 5621.550275977912, 5624.409437009137, 5626.690532020778, 5516.531094856902, 5595.720213989284, 5608.663480191201, 5697.487226149667, 5717.256756621613, 5651.745671444794, 5652.7738890443925, 5654.858628534237, 5659.462351076641, 5665.66006039639, 5608.298962629671, 5629.43705629442, 5671.829845104653, 5672.177534257509, 5674.120511320752, 4246.129543443587, 4295.6778241632, 4335.089631177488, 4366.19225443294, 4404.163208990281, 3915.5497117831246, 3918.90270724192, 3924.274009308287, 3954.209158168378, 3958.426028225891, 5178.844634660966, 5240.109181439165, 5246.055709972242, 5250.894982100336, 5251.658642188246, 5662.150677398423, 5663.292088488939, 5666.348369937427, 5757.366689664133, 5811.360750317462, 5249.107651699221, 5262.105442074857, 5263.6578622389425, 5271.446498117719, 5290.0, 4720.12677654635, 4838.564529192319, 4851.757412129379, 4860.8298709545, 4893.755312234374, 5755.1367294906095, 5781.768729250867, 5791.247137872049, 5822.184894114743, 5865.296164460292, 5699.344575373885, 5699.974004679198, 5700.914486282792, 5704.686242256716, 5711.200431939615, 5652.147935711292, 5826.184334193301, 5841.970790146022, 5845.620034697731, 5847.473727364558, 5600.243967064394, 5607.07483265273, 5643.971780141073, 5725.312962444534, 5773.509251713652, 5608.10270356741, 5662.716864156693, 5662.943370566241, 5668.121441176624, 5669.971650141723, 5481.780728770805, 5529.972350138223, 5532.944670553243, 5546.140348246028, 5550.55595552363, 5553.167024946129, 5565.220869078414, 5579.972100139474, 5623.634463759842, 5668.433156684464, 5451.3458384994055, 5458.536024437967, 5465.016297066566, 5466.480684334982, 5476.2607048049595, 5526.336839579276, 5577.0797818359515, 5578.219049333178, 5594.608377413542, 5634.915476267941, 5415.296011518478, 5471.316085489314, 5472.699001554953, 5481.780728770964, 5520.282363292747], "unit": "score", "name": "dojo.html", "value": 5230.612790526424}, {"lowerIsBetter": false, "replicates": [560.8205374280229, 577.7226931073083, 586.6245602814203, 591.2402562706922, 615.5106690181304, 28063.298417539547, 35439.291214175704, 35827.4625880612, 35830.462543061876, 35837.0, 38283.617163828356, 38413.80793096038, 38422.231555368875, 38496.0, 38759.41860872082, 7306.707731690753, 7437.628118594076, 8325.875111873342, 8494.702685406011, 8499.447535910145, 7452.292032256954, 7540.0197974263265, 9954.0, 10147.949260253688, 10200.540975656077, 9905.15806156474, 9952.054554817281, 9997.2002239821, 10022.24833137514, 10022.348547344436, 7625.733099341552, 9846.655367062154, 9917.107460328532, 9945.75135621608, 9948.651797187063, 7469.887951680729, 10012.59949602015, 10256.07695307426, 10261.127804136657, 10271.897281027168, 36549.81725091384, 37049.81475092634, 37052.44421333682, 37106.257874842355, 37114.0, 3015.5977470476114, 3029.3638335949477, 3127.4839651457482, 3182.80903145812, 3726.136931534233, 30365.696343036507, 30386.54420183699, 30548.0, 30944.0716778497, 31424.842875785474, 3922.6035172976945, 3948.881533553998, 3957.08986933007, 3997.360422332413, 4054.0472988847596, 281111.0, 281600.0, 281914.0, 282920.99999999796, 283716.0, 50649.24026139611, 52003.0, 55852.720736396055, 56275.15587266194, 56300.0, 60190.39809601936, 60975.0, 61025.38974610197, 61056.0, 61130.694346527984, 14770.556883293519, 15028.248587570797, 15069.246537673293, 15100.169490678118, 15111.924440377948, 11004.559817607365, 11052.447377631086, 11062.502187401586, 11064.0, 11066.0, 17914.641707165785, 17935.0, 18004.0, 18536.44390668282, 18580.0, 7032.964835175791, 7227.1327440707455, 7341.375983041501, 7368.815779605553, 7410.703571857173, 904.7195369435497, 941.4821847983582, 972.6304004478394, 1014.8731408573929, 1018.1701912940929, 28141.43717125646, 28540.571891421645, 28693.28266793305, 28912.0, 29062.85468572686, 1053.8155822730992, 1074.8881986648607, 1115.2360632966445, 1125.780472807811, 1137.9644523483755, 14926.4775732851, 14975.400983960737, 14997.2501374933, 15086.396544138111, 15124.0, 337478.0, 342219.0, 342492.0, 343510.0, 343919.0, 52084.218736718976, 52347.214791778155, 52392.73803630957, 52402.73798631059, 52432.47567524276, 1308.57912861206, 1315.355475816862, 1329.3486191765965, 1338.3508998136092, 1339.8191244182105, 27687.446251075267, 28487.0, 28881.133565993056, 29088.7091129086, 29142.27144321324, 41798.791006044776, 42017.0, 45493.54506454893, 46452.30321545112, 47148.0, 198599.0, 199084.0, 199246.0, 200773.0, 201040.0, 27227.183184504498, 27246.04638837631, 27436.725632744216, 27470.725292746818, 27478.5878211823, 31305.21736956503, 39261.60738392694, 41084.29097707139, 41585.0, 42356.57643423649, 34546.136346591535, 34561.65438345685, 35186.82406588053, 36016.4597531032, 36125.0968725784, 34406.48390274198, 34992.0, 35115.64884351226, 35161.8241908799, 35196.824015879756, 33212.0, 34575.82712086423, 34586.48120278148, 34603.0, 34622.826885866416, 28958.565621516114, 31491.527627085154, 31928.68071319257, 31984.68015319817, 32045.0, 24286.63570046486, 24525.632115518638, 24546.140885068937, 24909.501809964062, 24918.626220607068], "unit": "score", "name": "ext.html", "value": 17979.291601788584}, {"lowerIsBetter": false, "replicates": [355.97508174427793, 357.5816294934926, 357.92304654499276, 360.07999561121323, 360.998195009025, 13455.663608409795, 13768.24274664893, 16288.18559072046, 16334.2649580769, 16930.0, 12944.74110517789, 12978.675533111676, 13002.349882505885, 15139.772903406458, 15701.0, 5047.394312682465, 5191.1953647184655, 5203.063448579254, 5207.244949482323, 5211.478852114796, 3739.420389839579, 3825.2923209206247, 5176.715280659562, 5225.190095535179, 5389.946100538984, 5304.20436934459, 5325.7603407846545, 5334.333208348957, 5360.195970604402, 5368.865778355534, 5041.445441001487, 5138.948610513884, 5155.175171972466, 5163.7159956202395, 5341.252224688527, 4918.532739389752, 4984.102861484931, 4988.5260900214425, 4989.052080104769, 5179.119549676527, 12247.265164090182, 12433.191842530206, 12477.937610311981, 12505.187162834387, 18328.358507452307, 2031.4515080928215, 2058.217877206667, 2062.4019034479984, 2086.95826083479, 2126.0964090261577, 9288.0, 9300.72097837066, 9353.812923741487, 9406.905930940671, 9657.565409556586, 1818.7271909213723, 1833.9449816505526, 1839.1264149529, 1868.8318051375306, 1928.9324873629355, 59196.0, 60513.69743151256, 61186.694066529824, 62125.37874621241, 62380.0, 9987.350822196535, 10001.44992025431, 10011.899881001242, 10021.148202402877, 10067.848982265272, 13118.0, 13139.868601314056, 13153.0, 13169.144005639602, 13183.472661093449, 7350.117985841626, 7354.301341372561, 7389.593572353465, 7425.368843648351, 7430.554166750012, 7129.928700713031, 7173.565286942632, 7187.5687458752645, 7244.529105608119, 7255.383292420098, 4222.4299719538085, 4265.210935976792, 4282.593153650399, 4297.613214810682, 4323.616442738356, 1697.380456133527, 1756.3150371355182, 1774.38783619651, 1791.570023194424, 1798.3615816384995, 909.0818273543769, 917.4128557723062, 994.2592768387598, 1007.6322142417964, 1045.2996492350144, 12949.611511654666, 15265.160416176996, 16599.0, 16695.91652041732, 17057.0, 867.111211008721, 882.4969767232744, 908.3868388837641, 922.8431166701677, 932.9877083364626, 9218.032106628842, 9442.0, 9445.433274003582, 9485.478298693639, 9568.282378821616, 405853.0, 410656.0, 412631.0, 417187.0, 522724.0, 69794.0, 71019.0, 71250.2874971254, 73041.0, 81584.0, 1070.053003092269, 1080.1628737728324, 1083.3878858444953, 1106.3085571517802, 1135.4947048563474, 15030.774538382151, 15299.46451874179, 15485.148316842682, 15506.844931550992, 15764.68470630604, 34741.65258347384, 35224.47163292604, 35229.64770352366, 35911.64088359083, 36159.819200903825, 47772.761136194094, 47928.52071479241, 49338.50661493483, 49426.75286623544, 49608.50391496039, 9279.350445468752, 9280.350375473921, 9420.952895235754, 9486.28852836054, 9507.429554226768, 13890.722185556435, 16580.336786528405, 16771.0, 16828.326866925185, 17315.56711082233, 13610.0, 14122.364493597608, 14412.927935360256, 14474.565763027125, 14705.852941470876, 13670.863291367357, 13867.72264554683, 13989.370478328296, 14069.437222510986, 14356.0, 11878.346690931736, 11936.701582460508, 12561.309127997682, 14536.563903082924, 14539.491117811249, 9029.36794424384, 9482.85775713351, 9507.857382139135, 9649.324547281904, 9655.324127311302, 10369.792604148026, 10483.633072842415, 13336.86663133395, 14472.638184045483, 14537.491187808377], "unit": "score", "name": "jquery.html", "value": 8455.22292549373}, {"lowerIsBetter": false, "replicates": [1309.9476020959162, 1432.3912337256666, 1438.6259572511144, 1603.6552141289621, 1797.397871712976, 6894.413974812141, 7472.065991751031, 7600.125985511668, 7616.65725042373, 7620.428467864918, 7421.666025028887, 7614.314711675948, 7627.275408836165, 7628.809279768008, 7632.3894088472925, 1940.049375805852, 1969.6946973219103, 2191.4630915425664, 2201.66974953757, 2218.1127548980376, 2255.7857003584713, 2269.5347453771938, 2278.134308962592, 2284.9885750571225, 2286.9313920582326, 2126.075157306577, 2188.223180770827, 2201.306588424641, 2202.031106313217, 2204.162418281051, 2165.0798410675557, 2177.2379667116543, 2180.3023032629567, 2201.5376770878133, 2225.8887055647233, 2218.0462401167492, 2238.597052530544, 2242.7532971373134, 2268.727752669674, 2273.9317820465412, 7702.614869256571, 7778.64996075178, 7781.41639377049, 7802.960985195038, 7824.804379890491, 4619.907601847978, 4685.5314468553215, 4692.718436893763, 4692.741899195543, 4693.366395536627, 3014.9849250753823, 3061.8775248990014, 3103.286244163855, 3108.145260053481, 3133.9843300783577, 980.2158273381337, 983.695054533097, 1020.9591616335412, 1023.5905637744887, 1042.5985995391752, 10211.132053775364, 10324.89675103247, 10336.999999999925, 10339.741506462324, 10350.741231469197, 4064.166845796605, 4134.37984302357, 4205.747655140702, 4206.369044643328, 4229.936550951738, 8394.412391132562, 8557.957210213908, 8561.657533698706, 8583.141685831368, 8586.484810911365, 4691.53084691535, 4721.032188401369, 4737.170995075848, 4737.810487580458, 4738.218193997952, 4324.610785029363, 4368.4102646143, 4373.671974601918, 4374.978125109354, 4375.649948004152, 3252.625948015961, 3305.355455686118, 3345.749068819848, 3373.0, 3421.726261899042, 1052.957881684724, 1053.4206186597341, 1054.8470471781702, 1069.7432616172064, 1080.448971024783, 1067.653012770837, 1071.1056268016293, 1122.5565901468874, 1317.8616245294297, 1318.6637407461037, 7082.0, 7176.820579485555, 7358.96320518394, 7429.85140297191, 7477.775666729898, 1077.3482043363808, 1101.7686285879895, 1102.366139469808, 1110.8444817725524, 1147.6270212180907, 5746.569007324468, 5836.358000619928, 5850.0, 5857.15071314657, 5859.677717725566, 8800.119988001277, 8817.118288171132, 8985.371024028385, 8998.14517620825, 9154.176124148858, 8873.866891996626, 8990.056044115405, 9014.729558113268, 9022.368434209542, 9064.320175986828, 7067.363937245673, 7191.964040179871, 7199.568025918357, 7267.927320726831, 7313.268673132644, 7229.63851807397, 7279.563226206233, 7288.416926645961, 7295.088113985752, 7295.23400043009, 7936.761897143095, 8166.510009399455, 8187.549684767395, 8321.375896807642, 8344.457610255315, 8492.957535212285, 8536.103709110454, 8682.262007729414, 8698.0, 8740.475571465733, 6710.0, 6773.695183716646, 6819.215790184192, 6823.522353435411, 6837.145356830396, 6485.3514648534765, 6604.240512341143, 6963.199232088172, 7093.964530177523, 7375.446841486802, 6829.214640316427, 6909.689063992032, 6916.688749006206, 7042.0845290114, 7045.647717613996, 6689.799306020827, 6785.050092986887, 6821.147356580427, 6886.035954966209, 6924.203716572457, 6787.694553745192, 6819.897701534382, 6833.487488438288, 6834.248232694499, 6836.042953986346, 6219.40915613016, 6221.129041934042, 6237.1891654084675, 6241.282252540835, 6297.2128483939505, 6233.688315584293, 6246.063090536456, 6249.093881387264, 6257.4681152102585, 6258.749650013949], "unit": "score", "name": "mootools.html", "value": 4387.845932882435}, {"lowerIsBetter": false, "replicates": [344.1499496244277, 350.6160753974397, 351.99505412048603, 352.9347070791902, 357.17492592112205, 5928.436798504146, 5950.315713692927, 6104.9694751526295, 6125.5405844561665, 6139.600925939811, 5871.853203669911, 5949.732262048207, 5974.8805023899495, 5990.1913241712355, 6036.879262414749, 4653.092646933841, 4669.229577119788, 4673.579377855992, 4674.088552732219, 4674.766261686902, 4463.4643842738915, 4536.72779633223, 4547.226971414851, 4666.370040044601, 4673.556012178838, 4583.449986001685, 4602.217623004098, 4610.0, 4613.953860461403, 4616.6306695464455, 4571.5428457154185, 4625.098105869373, 4633.258678611406, 4645.558671926162, 4651.976740116278, 4111.958880411187, 4113.4858142732155, 4114.629683328485, 4118.238125946679, 4124.278251306009, 5652.378238393773, 5766.279215098113, 5771.163181338724, 5776.046952252916, 5784.739686714066, 5420.512153906167, 5423.267858839085, 5432.83701488952, 5433.022056029913, 5433.918491222596, 6391.1371964785085, 6396.648184349859, 6403.455706264973, 6404.167458230447, 6407.583507072025, 4308.78456077198, 4376.737395756233, 4380.452443444569, 4418.5581441855875, 4453.643708503312, 6564.474842012628, 6594.274629790767, 6598.439132673729, 6603.537752357337, 6607.141071660653, 4631.861044168681, 4632.791524381411, 4633.62930965522, 4635.953640463552, 4637.930431043537, 4600.60894823937, 4702.553257440606, 4704.411948506437, 4704.811807527661, 4747.572718455355, 5350.491703288181, 5395.892082158335, 5397.055515284809, 5398.838034858961, 5402.621816472888, 6377.266614339317, 6380.234371875312, 6382.936170638327, 6393.488520918316, 6395.968020159962, 1649.6205872649118, 1683.1500092453232, 1683.402392150769, 1684.6041180322613, 1685.755565443004, 1143.8227074803253, 1150.0799360511558, 1151.694800877768, 1168.6377223060879, 1175.4769127738246, 6136.539759518054, 6137.846553836101, 6149.200603921461, 6150.07748837669, 6156.6921653917125, 6671.966640166866, 6679.6640671865825, 6680.933190668128, 6684.2981486944145, 6687.331266873371, 5973.910391344133, 6143.662098584531, 6143.754249830046, 6144.41628045335, 6146.200993870768, 3579.3736096183065, 3612.512310838056, 3614.313280476701, 3617.4935509028755, 3619.389371729608, 6859.348361905611, 6871.553349032297, 6871.725130994804, 6878.3465570770695, 6880.793576192722, 6697.6986035628515, 6813.454923606099, 6821.829454263584, 6833.350831670983, 6833.794986150423, 6805.795826125224, 6817.045613614098, 6844.4182244509775, 6848.6918088686125, 6856.760013399607, 6394.1687580614225, 6622.437092847162, 6628.0, 6633.6019838809825, 6647.235567909753, 6408.359164083555, 6424.839379015562, 6566.179227596551, 6575.671216439063, 6621.404073633396, 6869.347411995853, 6873.896891546531, 6879.415249703831, 6897.448204143556, 6901.447884169154, 4604.815807367801, 4681.368015317888, 4681.882952926067, 4688.484266730725, 4690.413698287714, 6727.293634168342, 6741.764038258638, 6751.662416879039, 6754.223264324665, 6755.0, 6526.869462610816, 6528.249251336157, 6531.085648009187, 6534.183227096613, 6558.147440832661, 6377.426031657174, 6513.088167656627, 6523.7716679915975, 6525.347465253437, 6525.934740652722, 6407.935920640734, 6421.839454013687, 6422.871542569029, 6426.582272152295, 6427.100205971261, 6551.6069035858, 6555.737770489127, 6557.868842623026, 6564.146660934048, 6568.441682457044, 6191.845203869759, 6361.363863613602, 6368.840778980562, 6381.585196962183, 6395.6482393468805], "unit": "score", "name": "prototype.html", "value": 4880.854045562751}, {"lowerIsBetter": false, "replicates": [782.5845151551265, 837.5728378526953, 841.3395484544634, 843.5571325054345, 847.1189962439064, 13339.53311634093, 13587.660308492292, 13591.0, 13600.319984000798, 13602.0, 14907.701845963102, 15200.771988420183, 15206.619834504143, 15218.771718424232, 15234.771478427805, 681.8090934538337, 807.4549678966689, 818.2063398503442, 818.2349503214514, 819.8360327934437, 683.9555428897131, 815.1522416686639, 829.7966998085477, 832.3840358134967, 832.4256263178418, 853.3045567862204, 862.1034124510502, 862.5169904853302, 863.3266052479077, 863.6027427383411, 702.7399862051022, 706.2196273118182, 835.0772396501839, 850.8425941200867, 855.5380094748829, 620.928593211782, 624.8312955502034, 625.5777350288537, 628.0485065126337, 628.0861346740481, 13272.601821945356, 13387.0, 13392.598222053257, 13399.531016414476, 13427.66430839227, 12402.81395779064, 13094.214347139106, 13144.539941102015, 13286.20282783036, 13362.86637133626, 10306.433146176958, 10404.479776011245, 10486.528106235237, 10526.42104684242, 10641.36151830885, 3737.7009839212797, 3785.0915780212827, 3818.2363527294374, 3887.8833634990997, 3893.5717071122153, 46318.0, 46773.0, 46908.53091469076, 46913.5308646916, 47330.05339893217, 8948.8657670135, 9024.413413128126, 9171.220446262008, 9221.585028673591, 9397.201237894855, 17048.65902681964, 17154.742678859828, 17196.570085747957, 17239.31042758301, 17246.223919923632, 7427.888581671279, 7562.886556701654, 7581.658825352873, 7702.383809295243, 7819.0, 4375.584319489643, 4411.183930972717, 4468.620167285752, 4564.97717511417, 4581.450225972904, 3027.2885871820104, 3075.3695492424445, 3080.0451859923496, 3081.260497480633, 3088.274255549944, 523.6857885268885, 531.614579429918, 536.7209051293306, 539.2423644779092, 548.4460694698304, 533.703794394115, 623.1182876230174, 639.5043841023244, 665.1498329657395, 722.9674664640104, 8292.33661307094, 8588.441751286271, 8680.826383472295, 8732.738017859474, 9684.0, 569.6268943841791, 661.454300202335, 665.3379887012453, 677.8271540757174, 678.5860625018735, 4053.6757059435176, 4214.7471151731, 4362.10576831755, 4392.604665580113, 4418.867433976986, 57163.42836571581, 57427.0, 57864.42135578675, 58074.7096264516, 59695.70152149211, 50784.49215507872, 52129.0, 52158.47841521536, 52201.0, 52430.0, 47838.0, 47968.76015619969, 48234.27648585274, 48932.26601600979, 49090.263646045336, 8264.586770661563, 8376.664933402595, 8393.496390216607, 8432.747017589236, 8587.914120858712, 36604.26791464102, 36864.44703329399, 37283.0, 37688.05779855416, 37858.81070594629, 42804.78597606992, 45438.31842522431, 45941.77029114833, 46188.53811461842, 46680.0, 10410.323328983592, 10616.89383106159, 10790.298630588986, 10827.133829293794, 10881.526224508003, 12178.634640960785, 12400.62798116058, 12498.37508124572, 12588.559400420942, 12968.351582420653, 11621.302721836717, 11865.584704535646, 11880.881191188324, 11982.0, 12393.752124957631, 11267.830982535432, 11284.548618055514, 11298.49156787963, 11605.187636865337, 11840.0, 11166.944165279121, 11193.944030279796, 11272.267302625303, 11342.659720208407, 11371.545138194711, 9840.250493608242, 10164.745881353025, 10307.690769276935, 10419.0, 10528.105111065644, 9226.815463690555, 10034.951301848721, 10124.493775311057, 10130.746731331776, 10147.64483243083], "unit": "score", "name": "yui.html", "value": 6374.850111849252}], "name": "dromaeo_css", "value": 6906.915164779494}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 104.0, 110.0, 110.0, 109.0, 98.0, 110.0, 110.0, 101.0], "unit": "score", "name": "ai-astar", "value": 107.3}, {"lowerIsBetter": true, "replicates": [154.0, 129.0, 147.0, 168.0, 130.0, 149.0, 152.0, 127.0, 166.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 144.9}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 162.0, 160.0, 162.0, 160.0, 159.0, 161.0, 159.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 75.0, 96.0, 76.0, 71.0, 73.0, 99.0, 92.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 139.0, 96.0, 96.0, 96.0, 144.0, 98.0, 98.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 144.0, 145.0, 145.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 57.0, 57.0, 58.0, 58.0, 58.0, 65.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.9}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 66.0, 67.0, 75.0, 67.0, 66.0, 67.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 85.0, 85.0, 92.0, 84.0, 84.0, 85.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [129.0, 114.0, 121.0, 123.0, 124.0, 123.0, 125.0, 120.0, 130.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.9}, {"lowerIsBetter": true, "replicates": [144.0, 148.0, 148.0, 150.0, 153.0, 138.0, 150.0, 148.0, 148.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.7}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 69.0, 67.0, 67.0, 67.0, 66.0, 66.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1499.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.86133822793258], "unit": "score", "name": "Richards", "value": 211.56488599999994}, {"lowerIsBetter": false, "replicates": [191.68104274487254], "unit": "score", "name": "DeltaBlue", "value": 344.937606}, {"lowerIsBetter": false, "replicates": [282.08744710860367], "unit": "score", "name": "Encrypt", "value": 943.6116450000002}, {"lowerIsBetter": false, "replicates": [5278.9473684210525], "unit": "score", "name": "Decrypt", "value": 50.423120638085756}, {"lowerIsBetter": false, "replicates": [1968.5039370078741], "unit": "score", "name": "RayTrace", "value": 375.9144119999999}, {"lowerIsBetter": false, "replicates": [809.0614886731391], "unit": "score", "name": "Earley", "value": 823.7482679999999}, {"lowerIsBetter": false, "replicates": [12419.753086419752], "unit": "score", "name": "Boyer", "value": 53.66153379721673}, {"lowerIsBetter": false, "replicates": [25300.0], "unit": "score", "name": "RegExp", "value": 36.007312252964404}, {"lowerIsBetter": false, "replicates": [636.1323155216285], "unit": "score", "name": "Splay", "value": 128.10385200000002}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19625.701458051542}]} 07:28:23 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19625.70"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1499.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6906.91"}}} 07:28:23 INFO - Return code: 0 07:28:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:28:23 INFO - # TBPL SUCCESS # 07:28:23 INFO - Running post-action listener: _resource_record_post_action 07:28:23 INFO - Running post-run listener: _resource_record_post_run 07:28:24 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 10432512; Write bytes: 451276800; Read time: 4756; Write time: 785648 07:28:24 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 8192; Write bytes: 91709440; Read time: 196; Write time: 147924 07:28:25 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 8663040; Write bytes: 359567360; Read time: 4528; Write time: 637724 07:28:25 INFO - Running post-run listener: _upload_blobber_files 07:28:25 INFO - Blob upload gear active. 07:28:25 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:28:25 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 07:28:25 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'] 07:28:25 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 07:28:25 INFO - (blobuploader) - INFO - Open directory for files ... 07:28:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:28:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:28:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:28:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:28:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:28:26 INFO - (blobuploader) - INFO - Done attempting. 07:28:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 07:28:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:28:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:28:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:28:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:28:26 INFO - (blobuploader) - INFO - Done attempting. 07:28:26 INFO - (blobuploader) - INFO - Iteration through files over. 07:28:26 INFO - Return code: 0 07:28:26 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:28:26 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:28:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8103c9d2dae9fd113b9fe1b8520396cf61c817e3efc00b84b553c3f0cfbf8b98c57957a652ad8ad8552fbaece41051bbb3e9b7cc3e3c98cab015e2165f434243", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa7d2c4dfb530bbf14a02f2d0e22281c1868fd5470b3c0c449b50622fd7b7792b47e63f000527d9ce14bc4c00d4d2848fca04d30c9fdf4f38c87d6131a966911"} 07:28:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:28:26 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:28:26 INFO - Contents: 07:28:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8103c9d2dae9fd113b9fe1b8520396cf61c817e3efc00b84b553c3f0cfbf8b98c57957a652ad8ad8552fbaece41051bbb3e9b7cc3e3c98cab015e2165f434243", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa7d2c4dfb530bbf14a02f2d0e22281c1868fd5470b3c0c449b50622fd7b7792b47e63f000527d9ce14bc4c00d4d2848fca04d30c9fdf4f38c87d6131a966911"} 07:28:26 INFO - Copying logs to upload dir... 07:28:26 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1295.835840 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2015-12-26 07:28:26.920292) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-26 07:28:26.923873) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1451126694.276205-846526768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8103c9d2dae9fd113b9fe1b8520396cf61c817e3efc00b84b553c3f0cfbf8b98c57957a652ad8ad8552fbaece41051bbb3e9b7cc3e3c98cab015e2165f434243", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa7d2c4dfb530bbf14a02f2d0e22281c1868fd5470b3c0c449b50622fd7b7792b47e63f000527d9ce14bc4c00d4d2848fca04d30c9fdf4f38c87d6131a966911"} build_url:https://queue.taskcluster.net/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011429 build_url: 'https://queue.taskcluster.net/v1/task/a1JB2d2lSN-u4Dsvc0yxUg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8103c9d2dae9fd113b9fe1b8520396cf61c817e3efc00b84b553c3f0cfbf8b98c57957a652ad8ad8552fbaece41051bbb3e9b7cc3e3c98cab015e2165f434243", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa7d2c4dfb530bbf14a02f2d0e22281c1868fd5470b3c0c449b50622fd7b7792b47e63f000527d9ce14bc4c00d4d2848fca04d30c9fdf4f38c87d6131a966911"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-26 07:28:26.949382) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 07:28:26.949697) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1451126694.276205-846526768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 07:28:27.032196) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-26 07:28:27.032510) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-26 07:28:27.032822) ========= ========= Total master_lag: 0.22 =========