builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1450810420.28 results: success (0) buildid: 20151222083059 builduid: c97c3d83d9eb47d3a9630f93b9d10fc7 revision: 42d08735dae077433216ad7da9cfda9e347ce95e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 10:53:40.280520) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 10:53:40.281052) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 10:53:40.281392) ========= 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=3e14eba40af1795cf0357910000001c3-1450809091.352221-1933322949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006362 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 10:53:40.315988) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 10:53:40.316283) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 10:53:40.359254) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 10:53:40.359623) ========= 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=3e14eba40af1795cf0357910000001c3-1450809091.352221-1933322949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 10:53:40.427461) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 10:53:40.427748) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 10:53:40.428086) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 10:53:40.428380) ========= 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=3e14eba40af1795cf0357910000001c3-1450809091.352221-1933322949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-22 10:53:40-- 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% 220M=0s 2015-12-22 10:53:41 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102084 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 10:53:40.603343) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 10:53:40.603786) ========= 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=3e14eba40af1795cf0357910000001c3-1450809091.352221-1933322949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013312 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 10:53:40.653278) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 10:53:40.653693) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 42d08735dae077433216ad7da9cfda9e347ce95e --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 42d08735dae077433216ad7da9cfda9e347ce95e --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=3e14eba40af1795cf0357910000001c3-1450809091.352221-1933322949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-22 10:53:41,181 truncating revision to first 12 chars 2015-12-22 10:53:41,181 Setting DEBUG logging. 2015-12-22 10:53:41,181 attempt 1/10 2015-12-22 10:53:41,181 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/42d08735dae0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-22 10:53:41,441 unpacking tar archive at: b2g-inbound-42d08735dae0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.562318 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 10:53:41.245380) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 10:53:41.245664) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 10:53:41.254742) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 10:53:41.255001) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 10:53:41.255415) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-22 10:53:41.255693) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 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', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] 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=3e14eba40af1795cf0357910000001c3-1450809091.352221-1933322949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:53:41 INFO - MultiFileLogger online at 20151222 10:53:41 in /builds/slave/test-pgo 10:53:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 10:53:41 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:53:41 INFO - {'append_to_log': False, 10:53:41 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:53:41 INFO - 'blob_upload_branch': 'B2G-Inbound', 10:53:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:53:41 INFO - 'branch': 'B2G-Inbound', 10:53:41 INFO - 'buildbot_json_path': 'buildprops.json', 10:53:41 INFO - 'config_files': ('talos/linux_config.py',), 10:53:41 INFO - 'default_actions': ('clobber', 10:53:41 INFO - 'read-buildbot-config', 10:53:41 INFO - 'download-and-extract', 10:53:41 INFO - 'populate-webroot', 10:53:41 INFO - 'create-virtualenv', 10:53:41 INFO - 'install', 10:53:41 INFO - 'run-tests'), 10:53:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:53:41 INFO - 'download_minidump_stackwalk': True, 10:53:41 INFO - 'download_symbols': 'ondemand', 10:53:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:53:41 INFO - 'tooltool.py': '/tools/tooltool.py', 10:53:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:53:41 INFO - '/tools/misc-python/virtualenv.py')}, 10:53:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:53:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:53:41 INFO - 'installer_path': 'installer.exe', 10:53:41 INFO - 'log_level': 'info', 10:53:41 INFO - 'log_name': 'talos', 10:53:41 INFO - 'log_to_console': True, 10:53:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:53:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:53:41 INFO - 'opt_config_files': (), 10:53:41 INFO - 'pip_index': False, 10:53:41 INFO - 'sps_profile': False, 10:53:41 INFO - 'sps_profile_interval': 0, 10:53:41 INFO - 'suite': 'dromaeojs', 10:53:41 INFO - 'system_bits': '64', 10:53:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:53:41 INFO - 'title': 'talos-linux64-ix-067', 10:53:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:53:41 INFO - 'use_talos_json': True, 10:53:41 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:53:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:53:41 INFO - 'work_dir': 'build'} 10:53:41 INFO - ##### 10:53:41 INFO - ##### Running clobber step. 10:53:41 INFO - ##### 10:53:41 INFO - Running pre-action listener: _resource_record_pre_action 10:53:41 INFO - Running main action method: clobber 10:53:41 INFO - rmtree: /builds/slave/test-pgo/build 10:53:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:53:42 INFO - Running post-action listener: _resource_record_post_action 10:53:42 INFO - ##### 10:53:42 INFO - ##### Running read-buildbot-config step. 10:53:42 INFO - ##### 10:53:42 INFO - Running pre-action listener: _resource_record_pre_action 10:53:42 INFO - Running main action method: read_buildbot_config 10:53:42 INFO - Using buildbot properties: 10:53:42 INFO - { 10:53:42 INFO - "project": "", 10:53:42 INFO - "product": "firefox", 10:53:42 INFO - "script_repo_revision": "production", 10:53:42 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 10:53:42 INFO - "repository": "", 10:53:42 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 10:53:42 INFO - "buildid": "20151222083059", 10:53:42 INFO - "pgo_build": "True", 10:53:42 INFO - "basedir": "/builds/slave/test-pgo", 10:53:42 INFO - "buildnumber": 144, 10:53:42 INFO - "slavename": "talos-linux64-ix-067", 10:53:42 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:53:42 INFO - "platform": "ubuntu64_hw", 10:53:42 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 10:53:42 INFO - "branch": "b2g-inbound", 10:53:42 INFO - "repo_path": "integration/b2g-inbound", 10:53:42 INFO - "revision": "42d08735dae077433216ad7da9cfda9e347ce95e", 10:53:42 INFO - "stage_platform": "linux64-pgo", 10:53:42 INFO - "builduid": "c97c3d83d9eb47d3a9630f93b9d10fc7", 10:53:42 INFO - "slavebuilddir": "test" 10:53:42 INFO - } 10:53:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:53:42 INFO - Running post-action listener: _resource_record_post_action 10:53:42 INFO - ##### 10:53:42 INFO - ##### Running download-and-extract step. 10:53:42 INFO - ##### 10:53:42 INFO - Running pre-action listener: _resource_record_pre_action 10:53:42 INFO - Running main action method: download_and_extract 10:53:42 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:42 INFO - https://queue.taskcluster.net/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:53:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/test_packages.json 10:53:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/test_packages.json 10:53:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:53:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:53:45 INFO - Downloaded 1302 bytes. 10:53:45 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:53:45 INFO - Using the following test package requirements: 10:53:45 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:53:45 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:53:45 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:45 INFO - u'jsshell-linux-x86_64.zip'], 10:53:45 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:53:45 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:53:45 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:53:45 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:53:45 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:53:45 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:53:45 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:53:45 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:45 INFO - https://queue.taskcluster.net/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:53:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:53:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:53:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:53:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:53:49 INFO - Downloaded 23175755 bytes. 10:53:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:53:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:53:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:53:50 INFO - Return code: 0 10:53:50 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:50 INFO - https://queue.taskcluster.net/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:53:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:53:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:53:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:53:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:53:52 INFO - Downloaded 23175755 bytes. 10:53:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:53:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:53:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:53:53 INFO - Return code: 0 10:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:53 INFO - https://queue.taskcluster.net/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:53:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:53:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:53:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:53:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:53:54 INFO - Downloaded 11132277 bytes. 10:53:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 10:53:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:53:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 10:53:54 INFO - Return code: 0 10:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:54 INFO - https://queue.taskcluster.net/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:53:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:53:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:53:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:53:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:53:55 INFO - Downloaded 54901638 bytes. 10:53:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:53:55 INFO - mkdir: /builds/slave/test-pgo/properties 10:53:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:53:55 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:53:55 INFO - Contents: 10:53:55 INFO - build_url:https://queue.taskcluster.net/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:53:55 INFO - Running post-action listener: _resource_record_post_action 10:53:55 INFO - Running post-action listener: set_extra_try_arguments 10:53:55 INFO - ##### 10:53:55 INFO - ##### Running populate-webroot step. 10:53:55 INFO - ##### 10:53:55 INFO - Running pre-action listener: _resource_record_pre_action 10:53:55 INFO - Running main action method: populate_webroot 10:53:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:53:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:53:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:53:55 INFO - '--tppagecycles', 10:53:55 INFO - '7'], 10:53:55 INFO - 'tests': ['tsvgm']}}, 10:53:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:53:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:53:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:53:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:53:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:53:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:53:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:55 INFO - 'talos_options': ['--e10s'], 10:53:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:55 INFO - 'tests': ['damp', 'tps']}, 10:53:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:55 INFO - 'talos_options': ['--e10s'], 10:53:55 INFO - 'tests': ['damp', 'tps']}, 10:53:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:53:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:53:55 INFO - 'other': {'tests': ['a11yr', 10:53:55 INFO - 'ts_paint', 10:53:55 INFO - 'tpaint', 10:53:55 INFO - 'sessionrestore', 10:53:55 INFO - 'sessionrestore_no_auto_restore']}, 10:53:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:53:55 INFO - 'tests': ['a11yr', 10:53:55 INFO - 'ts_paint', 10:53:55 INFO - 'tpaint', 10:53:55 INFO - 'sessionrestore', 10:53:55 INFO - 'sessionrestore_no_auto_restore']}, 10:53:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:53:55 INFO - 'tests': ['a11yr', 10:53:55 INFO - 'ts_paint', 10:53:55 INFO - 'tpaint', 10:53:55 INFO - 'sessionrestore', 10:53:55 INFO - 'sessionrestore_no_auto_restore']}, 10:53:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:53:55 INFO - 'tests': ['a11yr', 10:53:55 INFO - 'ts_paint', 10:53:55 INFO - 'tpaint', 10:53:55 INFO - 'sessionrestore', 10:53:55 INFO - 'sessionrestore_no_auto_restore']}, 10:53:55 INFO - 'other_l64': {'tests': ['a11yr', 10:53:55 INFO - 'ts_paint', 10:53:55 INFO - 'tpaint', 10:53:55 INFO - 'sessionrestore', 10:53:55 INFO - 'sessionrestore_no_auto_restore']}, 10:53:55 INFO - 'other_nol64': {'tests': ['a11yr', 10:53:55 INFO - 'ts_paint', 10:53:55 INFO - 'tpaint', 10:53:55 INFO - 'sessionrestore', 10:53:55 INFO - 'sessionrestore_no_auto_restore']}, 10:53:55 INFO - 'svgr': {'tests': ['tsvgx', 10:53:55 INFO - 'tsvgr_opacity', 10:53:55 INFO - 'tart', 10:53:55 INFO - 'tscrollx', 10:53:55 INFO - 'cart']}, 10:53:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:53:55 INFO - 'tests': ['tsvgx', 10:53:55 INFO - 'tsvgr_opacity', 10:53:55 INFO - 'tart', 10:53:55 INFO - 'tscrollx', 10:53:55 INFO - 'cart']}, 10:53:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:55 INFO - 'tests': ['tp5o']}, 10:53:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:55 INFO - 'talos_options': ['--e10s'], 10:53:55 INFO - 'tests': ['tp5o']}, 10:53:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:55 INFO - 'talos_options': ['--xperf_path', 10:53:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:55 INFO - 'tests': ['tp5n']}, 10:53:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:55 INFO - 'talos_options': ['--e10s', 10:53:55 INFO - '--xperf_path', 10:53:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:55 INFO - 'tests': ['tp5n']}}, 10:53:55 INFO - 'talos.zip': {'path': '', 10:53:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:53:55 INFO - Running post-action listener: _resource_record_post_action 10:53:55 INFO - ##### 10:53:55 INFO - ##### Running create-virtualenv step. 10:53:55 INFO - ##### 10:53:55 INFO - Running pre-action listener: _resource_record_pre_action 10:53:55 INFO - Running main action method: create_virtualenv 10:53:55 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:53:55 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 10:53:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:53:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:53:56 INFO - Using real prefix '/usr' 10:53:56 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:53:56 INFO - Installing distribute.............................................................................................................................................................................................done. 10:53:58 INFO - Installing pip.................done. 10:53:58 INFO - Return code: 0 10:53:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:58 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 0x7fb91b583f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bf840>, '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 0x222c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222cb60>, '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': '3e14eba40af1795cf0357910000001c3-1450809091.352221-1933322949', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:53:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 10:53:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:53:58 INFO - Using env: {'DISPLAY': ':0', 10:53:58 INFO - 'HOME': '/home/cltbld', 10:53:58 INFO - 'LANG': 'en_US.UTF-8', 10:53:58 INFO - 'LANGUAGE': 'en_US:en', 10:53:58 INFO - 'LOGNAME': 'cltbld', 10:53:58 INFO - 'MAIL': '/var/mail/cltbld', 10:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:58 INFO - 'MOZ_NO_REMOTE': '1', 10:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:58 INFO - 'NO_EM_RESTART': '1', 10:53:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:58 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:58 INFO - 'SHELL': '/bin/bash', 10:53:58 INFO - 'SHLVL': '1', 10:53:58 INFO - 'TERM': 'linux', 10:53:58 INFO - 'TMOUT': '86400', 10:53:58 INFO - 'USER': 'cltbld', 10:53:58 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450809091.352221-1933322949', 10:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:58 INFO - '_': '/tools/buildbot/bin/python'} 10:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:53:58 INFO - Cleaning up... 10:53:58 INFO - Return code: 0 10:53:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:58 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 0x7fb91b583f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bf840>, '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 0x222c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222cb60>, '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': '3e14eba40af1795cf0357910000001c3-1450809091.352221-1933322949', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:53:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 10:53:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:53:58 INFO - Using env: {'DISPLAY': ':0', 10:53:58 INFO - 'HOME': '/home/cltbld', 10:53:58 INFO - 'LANG': 'en_US.UTF-8', 10:53:58 INFO - 'LANGUAGE': 'en_US:en', 10:53:58 INFO - 'LOGNAME': 'cltbld', 10:53:58 INFO - 'MAIL': '/var/mail/cltbld', 10:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:58 INFO - 'MOZ_NO_REMOTE': '1', 10:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:58 INFO - 'NO_EM_RESTART': '1', 10:53:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:58 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:58 INFO - 'SHELL': '/bin/bash', 10:53:58 INFO - 'SHLVL': '1', 10:53:58 INFO - 'TERM': 'linux', 10:53:58 INFO - 'TMOUT': '86400', 10:53:58 INFO - 'USER': 'cltbld', 10:53:58 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450809091.352221-1933322949', 10:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:58 INFO - '_': '/tools/buildbot/bin/python'} 10:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:59 INFO - Downloading/unpacking psutil>=0.7.1 10:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:00 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:54:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:54:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:54:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:54:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:54:00 INFO - Installing collected packages: psutil 10:54:00 INFO - Running setup.py install for psutil 10:54:00 INFO - building 'psutil._psutil_linux' extension 10:54:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:54:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:54:01 INFO - building 'psutil._psutil_posix' extension 10:54:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:54:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:54:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:54:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:54:01 INFO - Successfully installed psutil 10:54:01 INFO - Cleaning up... 10:54:01 INFO - Return code: 0 10:54:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:01 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 0x7fb91b583f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bf840>, '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 0x222c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222cb60>, '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': '3e14eba40af1795cf0357910000001c3-1450809091.352221-1933322949', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:54:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:54:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:54:01 INFO - Using env: {'DISPLAY': ':0', 10:54:01 INFO - 'HOME': '/home/cltbld', 10:54:01 INFO - 'LANG': 'en_US.UTF-8', 10:54:01 INFO - 'LANGUAGE': 'en_US:en', 10:54:01 INFO - 'LOGNAME': 'cltbld', 10:54:01 INFO - 'MAIL': '/var/mail/cltbld', 10:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:01 INFO - 'MOZ_NO_REMOTE': '1', 10:54:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:01 INFO - 'NO_EM_RESTART': '1', 10:54:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:54:01 INFO - 'PWD': '/builds/slave/test-pgo', 10:54:01 INFO - 'SHELL': '/bin/bash', 10:54:01 INFO - 'SHLVL': '1', 10:54:01 INFO - 'TERM': 'linux', 10:54:01 INFO - 'TMOUT': '86400', 10:54:01 INFO - 'USER': 'cltbld', 10:54:01 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450809091.352221-1933322949', 10:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:01 INFO - '_': '/tools/buildbot/bin/python'} 10:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:54:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:54:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:54:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:54:03 INFO - Installing collected packages: mozsystemmonitor 10:54:03 INFO - Running setup.py install for mozsystemmonitor 10:54:03 INFO - Successfully installed mozsystemmonitor 10:54:03 INFO - Cleaning up... 10:54:03 INFO - Return code: 0 10:54:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:54: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')]} 10:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54: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')]} 10:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fb91b583f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bf840>, '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 0x222c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222cb60>, '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': '3e14eba40af1795cf0357910000001c3-1450809091.352221-1933322949', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:54:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 10:54:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:54:03 INFO - Using env: {'DISPLAY': ':0', 10:54:03 INFO - 'HOME': '/home/cltbld', 10:54:03 INFO - 'LANG': 'en_US.UTF-8', 10:54:03 INFO - 'LANGUAGE': 'en_US:en', 10:54:03 INFO - 'LOGNAME': 'cltbld', 10:54:03 INFO - 'MAIL': '/var/mail/cltbld', 10:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:03 INFO - 'MOZ_NO_REMOTE': '1', 10:54:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:03 INFO - 'NO_EM_RESTART': '1', 10:54:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:54:03 INFO - 'PWD': '/builds/slave/test-pgo', 10:54:03 INFO - 'SHELL': '/bin/bash', 10:54:03 INFO - 'SHLVL': '1', 10:54:03 INFO - 'TERM': 'linux', 10:54:03 INFO - 'TMOUT': '86400', 10:54:03 INFO - 'USER': 'cltbld', 10:54:03 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450809091.352221-1933322949', 10:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:03 INFO - '_': '/tools/buildbot/bin/python'} 10:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:03 INFO - Downloading/unpacking blobuploader==1.2.4 10:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:05 INFO - Downloading blobuploader-1.2.4.tar.gz 10:54:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:54:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:54:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:54:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:54:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:06 INFO - Downloading docopt-0.6.1.tar.gz 10:54:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:54:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:54:06 INFO - Installing collected packages: blobuploader, requests, docopt 10:54:06 INFO - Running setup.py install for blobuploader 10:54:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:54:06 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:54:06 INFO - Running setup.py install for requests 10:54:06 INFO - Running setup.py install for docopt 10:54:06 INFO - Successfully installed blobuploader requests docopt 10:54:06 INFO - Cleaning up... 10:54:06 INFO - Return code: 0 10:54:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:06 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 0x7fb91b583f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bf840>, '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 0x222c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222cb60>, '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': '3e14eba40af1795cf0357910000001c3-1450809091.352221-1933322949', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:54:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 10:54:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:54:06 INFO - Using env: {'DISPLAY': ':0', 10:54:06 INFO - 'HOME': '/home/cltbld', 10:54:06 INFO - 'LANG': 'en_US.UTF-8', 10:54:06 INFO - 'LANGUAGE': 'en_US:en', 10:54:06 INFO - 'LOGNAME': 'cltbld', 10:54:06 INFO - 'MAIL': '/var/mail/cltbld', 10:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:06 INFO - 'MOZ_NO_REMOTE': '1', 10:54:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:06 INFO - 'NO_EM_RESTART': '1', 10:54:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:54:06 INFO - 'PWD': '/builds/slave/test-pgo', 10:54:06 INFO - 'SHELL': '/bin/bash', 10:54:06 INFO - 'SHLVL': '1', 10:54:06 INFO - 'TERM': 'linux', 10:54:06 INFO - 'TMOUT': '86400', 10:54:06 INFO - 'USER': 'cltbld', 10:54:06 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450809091.352221-1933322949', 10:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:06 INFO - '_': '/tools/buildbot/bin/python'} 10:54:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:54:06 INFO - Running setup.py (path:/tmp/pip-zruKYX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:54:06 INFO - Running setup.py (path:/tmp/pip-95IhtM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:54:07 INFO - Running setup.py (path:/tmp/pip-mskuIx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:54:07 INFO - Running setup.py (path:/tmp/pip-WBrlzH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:54:07 INFO - Running setup.py (path:/tmp/pip-TatD_n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:54:07 INFO - Running setup.py (path:/tmp/pip-_5Evaf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:54:07 INFO - Running setup.py (path:/tmp/pip-uxLo2n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:54:07 INFO - Running setup.py (path:/tmp/pip-ZPuGHb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:54:07 INFO - Running setup.py (path:/tmp/pip-ectkt1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:54:07 INFO - Running setup.py (path:/tmp/pip-9IE1R_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:54:07 INFO - Running setup.py (path:/tmp/pip-2E7pTA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:54:07 INFO - Running setup.py (path:/tmp/pip-cPJ4Q4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:54:07 INFO - Running setup.py (path:/tmp/pip-KMzz4a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:54:07 INFO - Running setup.py (path:/tmp/pip-VPjcb0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:54:07 INFO - Running setup.py (path:/tmp/pip-qhrEfb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:54:07 INFO - Running setup.py (path:/tmp/pip-0Sahlb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:54:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:54:08 INFO - Running setup.py (path:/tmp/pip-MNAaVm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:54:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:54:08 INFO - Running setup.py install for manifestparser 10:54:08 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:54:08 INFO - Running setup.py install for mozcrash 10:54:08 INFO - Running setup.py install for mozdebug 10:54:08 INFO - Running setup.py install for mozdevice 10:54:08 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:54:08 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:54:08 INFO - Running setup.py install for mozfile 10:54:08 INFO - Running setup.py install for mozhttpd 10:54:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:54:08 INFO - Running setup.py install for mozinfo 10:54:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:54:08 INFO - Running setup.py install for mozInstall 10:54:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:54:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:54:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:54:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:54:08 INFO - Running setup.py install for mozleak 10:54:09 INFO - Running setup.py install for mozlog 10:54:09 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:54:09 INFO - Running setup.py install for moznetwork 10:54:09 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:54:09 INFO - Running setup.py install for mozprocess 10:54:09 INFO - Running setup.py install for mozprofile 10:54:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:54:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:54:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:54:09 INFO - Running setup.py install for mozrunner 10:54:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:54:09 INFO - Running setup.py install for mozscreenshot 10:54:09 INFO - Running setup.py install for moztest 10:54:09 INFO - Running setup.py install for mozversion 10:54:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:54:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:54:09 INFO - Cleaning up... 10:54:09 INFO - Return code: 0 10:54:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fb91b583f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bf840>, '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 0x222c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222cb60>, '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': '3e14eba40af1795cf0357910000001c3-1450809091.352221-1933322949', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:54:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 10:54:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:54:09 INFO - Using env: {'DISPLAY': ':0', 10:54:09 INFO - 'HOME': '/home/cltbld', 10:54:09 INFO - 'LANG': 'en_US.UTF-8', 10:54:09 INFO - 'LANGUAGE': 'en_US:en', 10:54:09 INFO - 'LOGNAME': 'cltbld', 10:54:09 INFO - 'MAIL': '/var/mail/cltbld', 10:54:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:09 INFO - 'MOZ_NO_REMOTE': '1', 10:54:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:09 INFO - 'NO_EM_RESTART': '1', 10:54:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:54:09 INFO - 'PWD': '/builds/slave/test-pgo', 10:54:09 INFO - 'SHELL': '/bin/bash', 10:54:09 INFO - 'SHLVL': '1', 10:54:09 INFO - 'TERM': 'linux', 10:54:09 INFO - 'TMOUT': '86400', 10:54:09 INFO - 'USER': 'cltbld', 10:54:09 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450809091.352221-1933322949', 10:54:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:09 INFO - '_': '/tools/buildbot/bin/python'} 10:54:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:54:10 INFO - Running setup.py (path:/tmp/pip-v0wly8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 10:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:54:10 INFO - Running setup.py (path:/tmp/pip-ZBgMYv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:54:10 INFO - Running setup.py (path:/tmp/pip-6ZIeLo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 10:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:54:10 INFO - Running setup.py (path:/tmp/pip-a6bHbP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:54:10 INFO - Running setup.py (path:/tmp/pip-QLFgS8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 10:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:54:10 INFO - Running setup.py (path:/tmp/pip-pO8NJw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 10:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:54:10 INFO - Running setup.py (path:/tmp/pip-TzCs9w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 10:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:54:10 INFO - Running setup.py (path:/tmp/pip-AMBxEU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 10:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:54:10 INFO - Running setup.py (path:/tmp/pip-OKpPtj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 10:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:54:10 INFO - Running setup.py (path:/tmp/pip-qZ5Vjy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:54:10 INFO - Running setup.py (path:/tmp/pip-uVDnDT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 10:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:54:10 INFO - Running setup.py (path:/tmp/pip-1xKUGi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 10:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:54:10 INFO - Running setup.py (path:/tmp/pip-Kd9lS0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 10:54:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:54:11 INFO - Running setup.py (path:/tmp/pip-1sB7Tp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 10:54:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:54:11 INFO - Running setup.py (path:/tmp/pip-AWlO7H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 10:54:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:54:11 INFO - Running setup.py (path:/tmp/pip-QwjxgG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 10:54:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:54:11 INFO - Running setup.py (path:/tmp/pip-VwhXbE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 10:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 10:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:54:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:13 INFO - Downloading blessings-1.5.1.tar.gz 10:54:13 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 10:54:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:54:13 INFO - Installing collected packages: blessings 10:54:13 INFO - Running setup.py install for blessings 10:54:13 INFO - Successfully installed blessings 10:54:13 INFO - Cleaning up... 10:54:13 INFO - Return code: 0 10:54:13 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:54:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:54:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:54:13 INFO - Reading from file tmpfile_stdout 10:54:13 INFO - Current package versions: 10:54:13 INFO - argparse == 1.2.1 10:54:13 INFO - blessings == 1.5.1 10:54:13 INFO - blobuploader == 1.2.4 10:54:13 INFO - docopt == 0.6.1 10:54:13 INFO - manifestparser == 1.1 10:54:13 INFO - mozInstall == 1.12 10:54:13 INFO - mozcrash == 0.16 10:54:13 INFO - mozdebug == 0.1 10:54:13 INFO - mozdevice == 0.47 10:54:13 INFO - mozfile == 1.2 10:54:13 INFO - mozhttpd == 0.7 10:54:13 INFO - mozinfo == 0.9 10:54:13 INFO - mozleak == 0.1 10:54:13 INFO - mozlog == 3.1 10:54:13 INFO - moznetwork == 0.27 10:54:13 INFO - mozprocess == 0.22 10:54:13 INFO - mozprofile == 0.28 10:54:13 INFO - mozrunner == 6.11 10:54:13 INFO - mozscreenshot == 0.1 10:54:13 INFO - mozsystemmonitor == 0.0 10:54:13 INFO - moztest == 0.7 10:54:13 INFO - mozversion == 1.4 10:54:13 INFO - psutil == 3.1.1 10:54:13 INFO - requests == 1.2.3 10:54:13 INFO - wsgiref == 0.1.2 10:54:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:54: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')]} 10:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54: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')]} 10:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:13 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 0x7fb91b583f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bf840>, '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 0x222c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222cb60>, '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': '3e14eba40af1795cf0357910000001c3-1450809091.352221-1933322949', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:54:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 10:54:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:54:13 INFO - Using env: {'DISPLAY': ':0', 10:54:13 INFO - 'HOME': '/home/cltbld', 10:54:13 INFO - 'LANG': 'en_US.UTF-8', 10:54:13 INFO - 'LANGUAGE': 'en_US:en', 10:54:13 INFO - 'LOGNAME': 'cltbld', 10:54:13 INFO - 'MAIL': '/var/mail/cltbld', 10:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:13 INFO - 'MOZ_NO_REMOTE': '1', 10:54:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:13 INFO - 'NO_EM_RESTART': '1', 10:54:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:54:13 INFO - 'PWD': '/builds/slave/test-pgo', 10:54:13 INFO - 'SHELL': '/bin/bash', 10:54:13 INFO - 'SHLVL': '1', 10:54:13 INFO - 'TERM': 'linux', 10:54:13 INFO - 'TMOUT': '86400', 10:54:13 INFO - 'USER': 'cltbld', 10:54:13 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450809091.352221-1933322949', 10:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:13 INFO - '_': '/tools/buildbot/bin/python'} 10:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 10:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 10:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 10:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 10:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 10:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 10:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 10:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 10:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 10:54:13 INFO - Cleaning up... 10:54:13 INFO - Return code: 0 10:54:13 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:54: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')]} 10:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54: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')]} 10:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:13 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 0x7fb91b583f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bf840>, '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 0x222c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222cb60>, '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': '3e14eba40af1795cf0357910000001c3-1450809091.352221-1933322949', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:54:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 10:54:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:54:13 INFO - Using env: {'DISPLAY': ':0', 10:54:13 INFO - 'HOME': '/home/cltbld', 10:54:13 INFO - 'LANG': 'en_US.UTF-8', 10:54:13 INFO - 'LANGUAGE': 'en_US:en', 10:54:13 INFO - 'LOGNAME': 'cltbld', 10:54:13 INFO - 'MAIL': '/var/mail/cltbld', 10:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:13 INFO - 'MOZ_NO_REMOTE': '1', 10:54:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:13 INFO - 'NO_EM_RESTART': '1', 10:54:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:54:13 INFO - 'PWD': '/builds/slave/test-pgo', 10:54:13 INFO - 'SHELL': '/bin/bash', 10:54:13 INFO - 'SHLVL': '1', 10:54:13 INFO - 'TERM': 'linux', 10:54:13 INFO - 'TMOUT': '86400', 10:54:13 INFO - 'USER': 'cltbld', 10:54:13 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450809091.352221-1933322949', 10:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:13 INFO - '_': '/tools/buildbot/bin/python'} 10:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:13 INFO - Downloading/unpacking jsonschema 10:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:54:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 10:54:15 INFO - Downloading/unpacking functools32 (from jsonschema) 10:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:15 INFO - Downloading functools32-3.2.3-2.tar.gz 10:54:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:54:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:54:15 INFO - warning: no files found matching '*.txt' 10:54:15 INFO - no previously-included directories found matching 'build' 10:54:15 INFO - no previously-included directories found matching 'dist' 10:54:15 INFO - no previously-included directories found matching '.git*' 10:54:15 INFO - Installing collected packages: jsonschema, functools32 10:54:15 INFO - Running setup.py install for functools32 10:54:15 INFO - warning: no files found matching '*.txt' 10:54:15 INFO - no previously-included directories found matching 'build' 10:54:15 INFO - no previously-included directories found matching 'dist' 10:54:15 INFO - no previously-included directories found matching '.git*' 10:54:16 INFO - Successfully installed jsonschema functools32 10:54:16 INFO - Cleaning up... 10:54:16 INFO - Return code: 0 10:54:16 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:16 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 0x7fb91b583f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bf840>, '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 0x222c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222cb60>, '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': '3e14eba40af1795cf0357910000001c3-1450809091.352221-1933322949', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:54:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 10:54:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:54:16 INFO - Using env: {'DISPLAY': ':0', 10:54:16 INFO - 'HOME': '/home/cltbld', 10:54:16 INFO - 'LANG': 'en_US.UTF-8', 10:54:16 INFO - 'LANGUAGE': 'en_US:en', 10:54:16 INFO - 'LOGNAME': 'cltbld', 10:54:16 INFO - 'MAIL': '/var/mail/cltbld', 10:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:16 INFO - 'MOZ_NO_REMOTE': '1', 10:54:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:16 INFO - 'NO_EM_RESTART': '1', 10:54:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:54:16 INFO - 'PWD': '/builds/slave/test-pgo', 10:54:16 INFO - 'SHELL': '/bin/bash', 10:54:16 INFO - 'SHLVL': '1', 10:54:16 INFO - 'TERM': 'linux', 10:54:16 INFO - 'TMOUT': '86400', 10:54:16 INFO - 'USER': 'cltbld', 10:54:16 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450809091.352221-1933322949', 10:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:16 INFO - '_': '/tools/buildbot/bin/python'} 10:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:16 INFO - Downloading/unpacking flake8 10:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:54:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 10:54:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:54:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 10:54:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 10:54:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:54:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:54:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:54:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:54:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:54:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:54:18 INFO - no previously-included directories found matching 'docs/_build' 10:54:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:54:18 INFO - Running setup.py install for pep8 10:54:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:54:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:54:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:54:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:54:18 INFO - no previously-included directories found matching 'docs/_build' 10:54:18 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:54:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:54:18 INFO - Cleaning up... 10:54:18 INFO - Return code: 0 10:54:18 INFO - Running post-action listener: _resource_record_post_action 10:54:18 INFO - Running post-action listener: _start_resource_monitoring 10:54:18 INFO - Starting resource monitoring. 10:54:18 INFO - ##### 10:54:18 INFO - ##### Running install step. 10:54:18 INFO - ##### 10:54:18 INFO - Running pre-action listener: _resource_record_pre_action 10:54:18 INFO - Running main action method: install 10:54:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:54:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:54:19 INFO - Reading from file tmpfile_stdout 10:54:19 INFO - Detecting whether we're running mozinstall >=1.0... 10:54:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:54:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:54:19 INFO - Reading from file tmpfile_stdout 10:54:19 INFO - Output received: 10:54:19 INFO - Usage: mozinstall [options] installer 10:54:19 INFO - Options: 10:54:19 INFO - -h, --help show this help message and exit 10:54:19 INFO - -d DEST, --destination=DEST 10:54:19 INFO - Directory to install application into. [default: 10:54:19 INFO - "/builds/slave/test-pgo"] 10:54:19 INFO - --app=APP Application being installed. [default: firefox] 10:54:19 INFO - mkdir: /builds/slave/test-pgo/build/application 10:54:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 10:54:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 10:54:35 INFO - Reading from file tmpfile_stdout 10:54:35 INFO - Output received: 10:54:35 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:54:35 INFO - Running post-action listener: _resource_record_post_action 10:54:35 INFO - ##### 10:54:35 INFO - ##### Running run-tests step. 10:54:35 INFO - ##### 10:54:35 INFO - Running pre-action listener: _resource_record_pre_action 10:54:35 INFO - Running main action method: run_tests 10:54:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:54:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:54:35 INFO - Python 2.7.3 10:54:35 INFO - Return code: 0 10:54:35 INFO - grabbing minidump binary from tooltool 10:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:35 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 0x22bf840>, '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 0x222c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222cb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:54:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 10:54:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:54:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:54:35 INFO - Return code: 0 10:54:35 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:54:35 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:54:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:54:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:54:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:54:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:54:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:54:36 INFO - Return code: 0 10:54:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 10:54:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 10:54:36 INFO - Using env: {'DISPLAY': ':0', 10:54:36 INFO - 'HOME': '/home/cltbld', 10:54:36 INFO - 'LANG': 'en_US.UTF-8', 10:54:36 INFO - 'LANGUAGE': 'en_US:en', 10:54:36 INFO - 'LOGNAME': 'cltbld', 10:54:36 INFO - 'MAIL': '/var/mail/cltbld', 10:54:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:54:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:54:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:36 INFO - 'MOZ_NO_REMOTE': '1', 10:54:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:54:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:36 INFO - 'NO_EM_RESTART': '1', 10:54:36 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:54:36 INFO - 'PWD': '/builds/slave/test-pgo', 10:54:36 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:54:36 INFO - 'SHELL': '/bin/bash', 10:54:36 INFO - 'SHLVL': '1', 10:54:36 INFO - 'TERM': 'linux', 10:54:36 INFO - 'TMOUT': '86400', 10:54:36 INFO - 'USER': 'cltbld', 10:54:36 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1450809091.352221-1933322949', 10:54:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:36 INFO - '_': '/tools/buildbot/bin/python'} 10:54:36 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:54:36 INFO - mozversion application_buildid: 20151222083059 10:54:36 INFO - mozversion application_changeset: 42d08735dae077433216ad7da9cfda9e347ce95e 10:54:36 INFO - mozversion application_display_name: Nightly 10:54:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:54:36 INFO - mozversion application_name: Firefox 10:54:36 INFO - mozversion application_remotingname: firefox 10:54:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 10:54:36 INFO - mozversion application_vendor: Mozilla 10:54:36 INFO - mozversion application_version: 46.0a1 10:54:36 INFO - mozversion platform_buildid: 20151222083059 10:54:36 INFO - mozversion platform_changeset: 42d08735dae077433216ad7da9cfda9e347ce95e 10:54:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 10:54:36 INFO - mozversion platform_version: 46.0a1 10:54:36 INFO - using testdate: 1450810476 10:54:36 INFO - actual date: 1450810476 10:54:36 INFO - starting webserver on 'localhost:55682' 10:54:36 INFO - SUITE-START | Running 3 tests 10:54:36 INFO - TEST-START | dromaeo_css 10:54:36 INFO - operating with platform_type : linux_ 10:54:36 INFO - Initialising browser for dromaeo_css test... 10:54:36 INFO - TEST-INFO | started process 24315 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSWVmCo/profile http://localhost:55682/getInfo.html) 10:54:40 INFO - PROCESS | 24315 | __metrics Screen width/height:1600/1200 10:54:40 INFO - PROCESS | 24315 | colorDepth:24 10:54:40 INFO - PROCESS | 24315 | Browser inner width/height: 1024/697 10:54:40 INFO - PROCESS | 24315 | __metrics 10:54:40 INFO - PROCESS | 24315 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:54:40 INFO - PROCESS | 24315 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:54:41 INFO - TEST-INFO | 24315: exit 0 10:54:41 INFO - Browser initialized. 10:54:41 INFO - Running cycle 1/1 for dromaeo_css test... 10:54:41 INFO - TEST-INFO | started process 24415 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSWVmCo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:54:53 INFO - PROCESS | 24415 | RSS: Main: 150175744 10:54:53 INFO - PROCESS | 24415 | 10:55:45 INFO - PROCESS | 24415 | 1450810545154 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] 10:57:53 INFO - PROCESS | 24415 | Cycle 1(1): loaded http://localhost:55682/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55682/tests/dromaeo/cssquery-ext.html) 10:57:55 INFO - PROCESS | 24415 | RSS: Main: 302059520 10:57:55 INFO - PROCESS | 24415 | 11:00:57 INFO - PROCESS | 24415 | Cycle 1(1): loaded http://localhost:55682/tests/dromaeo/cssquery-ext.html (next: http://localhost:55682/tests/dromaeo/cssquery-jquery.html) 11:00:58 INFO - PROCESS | 24415 | RSS: Main: 237670400 11:00:58 INFO - PROCESS | 24415 | 11:04:00 INFO - PROCESS | 24415 | Cycle 1(1): loaded http://localhost:55682/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55682/tests/dromaeo/cssquery-mootools.html) 11:04:00 INFO - PROCESS | 24415 | RSS: Main: 234070016 11:04:00 INFO - PROCESS | 24415 | 11:07:02 INFO - PROCESS | 24415 | Cycle 1(1): loaded http://localhost:55682/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55682/tests/dromaeo/cssquery-prototype.html) 11:07:03 INFO - PROCESS | 24415 | RSS: Main: 210231296 11:07:03 INFO - PROCESS | 24415 | 11:10:05 INFO - PROCESS | 24415 | Cycle 1(1): loaded http://localhost:55682/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55682/tests/dromaeo/cssquery-yui.html) 11:10:06 INFO - PROCESS | 24415 | RSS: Main: 214077440 11:10:06 INFO - PROCESS | 24415 | 11:13:09 INFO - PROCESS | 24415 | Cycle 1(1): loaded http://localhost:55682/tests/dromaeo/cssquery-yui.html (next: http://localhost:55682/tests/dromaeo/cssquery-dojo.html) 11:13:09 INFO - PROCESS | 24415 | RSS: Main: 288088064 11:13:09 INFO - PROCESS | 24415 | 11:13:09 INFO - PROCESS | 24415 | __start_tp_report 11:13:09 INFO - PROCESS | 24415 | _x_x_mozilla_page_load 11:13:09 INFO - PROCESS | 24415 | _x_x_mozilla_page_load_details 11:13:09 INFO - PROCESS | 24415 | |i|pagename|runs| 11:13:09 INFO - PROCESS | 24415 | |0;dojo.html;3163.9050828475147;3206.326671399006;3237.0936137881386;3237.838108094596;3259.1037464697206;5190.169572868342;5337.039332920082;5425.593080518962;5443.891122177554;5506.421825708303;5283.365996080475;5381.973090134554;5385.730713464331;5434.130539113743;5441.156620723784;4904.386951631037;4906.754662266891;4933.679310844784;5020.723860187688;5088.160453525164;4891.241857512091;5002.074616196015;5029.220470827027;5040.899182016357;5072.188449848025;4905.607551395879;4958.157113290749;4958.7024778513405;4970.080535101018;5007.32401125847;4900.044491324194;4902.48523904992;4902.681325713817;4922.483139270396;4935.3090567320605;4872.439669438025;4878.951210487885;4892.926606100876;4905.23968784839;4905.558499735005;5149;5212.035773381936;5308.071087559701;5322.0952438085615;5330.946690533084;5902.203202567642;5915.704214789286;5918.23063001807;5921.230240068807;5933.465988061095;5755.740991655385;5927.673977931212;5934.43622855828;5938.198343223653;5950.256217972754;5452.154915988028;5476.479734425263;5482.862928426821;5568;5574.247476590608;6016.278046634432;6044.516438684895;6047.0627052806;6049.576529642971;6099.268087829489;5666.631668941505;5771.192033115367;5778.306603207558;5784.421557844266;5843.707814609253;5610.831675049755;5697.145428185805;5698.857528561819;5877.706114694248;5887.116932460165;5833.591648584643;5906.852328691731;5907.556933230025;5917.970410147922;5963.5527335450015;5844.912326315109;5846.239988801513;5854.619449735838;5854.765809367577;5860.384659610765;4356;4368.825246990148;4442.73343599385;4493.573110554492;4501.6848820582245;4032.3145065338963;4039.171969746195;4047.5547689754103;4071.470708807836;4078.0416602098485;5489.34127904646;5529.336479622471;5529.917051244234;5532.114861622121;5560.944390556124;5674.546036317085;5782.335031471434;5898.144769008555;5911.615744976649;5913.733881975321;5460.481254280837;5482.150266708666;5552.639078459887;5617.831465055973;5705.343885453143;5138.152204886152;5142.537171654569;5144.717040562805;5154.92267615986;5180.637355385087;5991.760329586855;6016.729247183887;6023.668698221552;6031.819045428644;6035.366286539938;5765.538756899522;5890.6760128191645;5906.26171728534;5908.379620139824;5921.17103605487;5904.940950590439;5938.910916336172;5976.581639285382;5983.222181116427;6040.124181993674;5811.27359080115;5871.94128058714;5893.174955506318;5900.586958912835;5904.350521442552;5657.8019769307875;5862.853428664317;5862.882742345215;5943.613665111927;5945.881082378241;5667.943320566907;5794.507466865363;5813.505852002458;5815.883682326415;5825.155352473952;5765.423457654201;5770.567207459373;5782.855428614318;5783.508401785727;5835.708214589338;5655.519280861173;5663.32040155184;5666.291713535808;5666.603337766317;5675.943240567542;5682.9431705684065;5708.4862362387585;5732.684702341411;5753.252077229933;5772.04761214395;5625.46558076982;5627.18405831144;5627.52166065889;5646.576506761927;5654.886902261849 11:13:09 INFO - PROCESS | 24415 | |1;ext.html;549.8881262088057;578.537170263789;578.675941472775;583.899349725767;588.2264821759386;28096;38691.41962870556;38723.22553548928;38969.61030389695;39008.80495597518;43628;44106.338404923874;44136;44177.55822441775;44181.67454976348;7418.072740907387;7527.20964298749;8603.096674849161;8776.780580485507;8779.2098711116;10335.689929302096;10653.307535010239;10655.094316983026;10655.893441065606;10657.680269591925;10186.949065254663;10265.538050787733;10289.588416463332;10322.896771032269;10369;7689.115751688543;7846.333061689763;10249.538770755335;10370.896291037068;10613.893861061368;10161;10256.641017564349;10304.072633463024;10332.380057196593;10336.328138671037;40083.7995810022;40146.79926600378;40505.1898962022;40554.594454055376;40587.594124058676;3127.749780017616;3285.5400243965864;3449.913752156191;3483.8954831354845;3683.3922402803505;29729.55405668917;30019.099427017223;30265.092047238617;30408.847955760302;30536.54195187074;3614.168741189541;3699.2231631357176;3715.349813782604;3722.3671975764187;3809.123901502642;261683;263345;263579;263982;264048;49796.25305620419;50617;58817.70591147017;59185;65940;59270.407295927354;59277.40722592805;59580;59598.70200648969;59659;13161.53934612303;13374.53189138395;13379.598612041655;13381.866181338257;13382.732345353039;9229.400088994194;9257.166854983085;9283.76790580241;9297.72106836796;9303.25573954082;19969.60060798776;20108.195672172948;20266.392008239778;20314.593708125754;20318.18727250923;7612.505187162817;7694.461387702919;7732.110807257125;7833.216678332121;7839.882401763978;975.5073687787764;992.5186284651938;1004.2719028704131;1021.9984415272926;1037.5071840875523;28333.716662833107;28480.111514909975;28553.71446285552;28561.71438285632;28657.426851462853;1028.5885645741614;1030.7938412317567;1064.8775390829999;1098.6703988803326;1128.3906690387264;14822.407103715947;14879.628009299855;14953.327100280296;15104.39582416713;15166.848331516543;301592;304302;304528;304787;305493;51601.48398516042;51931.48068519342;51967;51990;52109.99999999924;1294.4692676002794;1295.578936845529;1308.8691130886834;1322.497450968645;1324.0202250334876;27506.587401189397;28371;28715;28759.568606471337;28845.567316490688;39620.40569391519;40190;45919.54080459286;46261.53738462572;46266;402692;403288;408782;410492;410528;29003.854980725806;29199.912012318717;29216;29220.7077929218;29243.561346579394;39485.40771888482;40546.797266013484;40796.79601601973;40830;41326.586734133474;33662;33741.32517349689;33828;34017;34499.48250776291;33774;34301.48547771735;34445.82777086098;34488.65511344854;34546.481802772476;33988.83005584956;34281.657183427844;34610.48084278788;34618.30763384768;34652.133696656776;28195.295117622223;29496.262593435335;30848.383032339676;30886.888367931064;31014.734445448023;24025.879870600536;24580;24982.875085624455;25094.62358064594;25459.49081018332 11:13:09 INFO - PROCESS | 24415 | |2;jquery.html;346.2244572158366;350.152630633866;352.6543986892845;354.5284771254232;356.85190645881954;13503.662408439794;13757.380917858696;15958.28187731552;16281.267342969566;17152.399666011694;13700.725985480285;13739.106958047745;16666.333346666117;16819.327226910907;17107.657846843085;5128.974355128219;5261.158214685651;5265.131253343194;5267.26258323835;5270.920936185941;3917.334053210947;4004.619561141687;4925.7537123143875;4995.175795993657;5219.660722053073;5599.832005039855;5715.342735585398;5743.913841292384;5746.396628354005;5758.625689330201;5565.666060036411;5716.371199168088;5753.827385178452;5800.100984347433;5819.214406055213;5222.138347172712;5236.188390799394;5245.632805703603;5248.21276808478;5249.42256351801;20423.897880510653;20487.69268460974;20738.896305518378;20820.791792082036;20899.268525601532;2000.2599038355756;2010.427028296943;2041.3671761753903;2160.5786871560053;2201.306588424641;12909.54816581415;12951.546695865694;12980.675483112904;13026.088173827837;13360.265185414799;1813.6644720726708;1820.417466410749;1825.8448031917303;1839.4205825165163;1925.1721759643349;52090.73954630241;55302.893942121336;55567.72216138934;55606.16590751142;56045;9940.25448091396;10150;10154.949225253826;10161.339512931636;10233.74415639615;13146.342682865818;13226.272555009375;13230.73538529224;13243.470261189444;13273.402696878664;6929.653517324114;6948.131483564554;6971.8605627887155;7002.334778196063;7030.54301470413;6507.511936604774;6558.475321974231;6563.146790917246;6566.1135746674545;6614.735410583523;4367.388565600819;4391.5388884166705;4394.626456751148;4414.404055452473;4417.734935903856;1680.6302613425028;1728.5160155156577;1762.1541660003013;1782.269269599458;1810.5021119192063;888.2849306308354;903.2999425445332;919.3518569408551;925.1719710858878;1032.9070383665505;15710.214489275719;16440.177991100398;16712.415065472895;16800.327986880387;16873.493795186165;815.4699445360444;894.2220268366563;902.273669695901;925.1303774451993;939.2673714502699;8987.46075235488;9389.812203756022;9418.10527999839;9725.805483890283;9773.07155820196;476005;480738;487738;493827;494090;78444.60777696189;78655;79595.20404795877;79705.20294797093;79758;1135.8580177477816;1136.931784092957;1146.7821113988316;1164.941752912351;1165.6328256599145;15068.472603458826;15332;15518.913676042568;15530.84469155294;15812.209389530248;35180.29639407146;35302.646973530966;35474.11314717153;36305.45541816822;36445;44248.34509929414;44779.62956531293;45746.31380529361;45789.542104578526;45985.31022034605;9226.723198304062;9596.712098637052;9629.085236902483;9648.517574121126;9662.855057174289;11193.832092518456;14379.78430323525;16600.83399165993;16777.664446710754;17239.833876124056;13391.665208369868;13516.93241533786;13647.931760341135;13869.79195312051;14078;13348.666283342995;13492.460301587827;13716.588502344946;14066.226357550433;14434.350454229374;10834.458277085956;10959.780804383709;14255.073420227653;14484.85515144835;14848.925755371587;9337.53312334367;9540.95229523848;9574.04259574037;9584.520773961414;9696.466694331879;10192.898071019195;10698.465076745975;13742.106763060368;13787.931060345036;14065.156090634595 11:13:09 INFO - PROCESS | 24415 | |3;mootools.html;1285.0811669656193;1466.7359875222462;1504.1501551623328;1637.4514537629893;1774.485399234222;6361.872762544746;7652.120006199289;7809.336206422454;7833.882491762628;7847.646855891484;7164.247753985835;7315.634218289078;7321.158066822317;7329.56022638642;7330.266973302667;1954.9511262218416;1989.0452582760283;1989.4827344890289;2191.1783081344456;2215.213599172295;2212.3141826033902;2243.7756224377595;2246.898889549966;2247.3819699582664;2247.8763667998255;2162.4593851537115;2184.967225491619;2228.1755750372386;2228.9635319576396;2230.3754948614414;2171.1966572368165;2172.6415141501634;2200.8239340852692;2202.493426511895;2226.9888650556804;2254.797068263848;2271.2731925783755;2302.7697230277004;2305.4466927937174;2309.5265470578493;7773.144954055049;7826.373890088779;7846.450748447611;7867.8033049173655;7869.763907082796;4513.368128462018;4634.83778067766;4638.1187574360765;4639.698419602715;4642.187617166982;2907.9273018174713;2919.168037109435;2956.3496030873175;2958.6597541282813;3052.740517056053;886.6054605700466;892.1747383670144;894.5124906925741;898.4025622960723;937.6624415210518;10775.5689772409;10799.352038877692;10836.458177091194;10838.40388778617;10857.837132443019;4098.364753463218;4146.170765846843;4163.646090082377;4169.979150104291;4187.937180942288;9227.215686666708;9233.030531794198;9233.538323083952;9247.167754902091;9249.630014799333;4681.250999840009;4689.015306785614;4689.95310046902;4717.976410117927;4720.433547974265;4240.639545638655;4264.914701705949;4305.203537345601;4312.504062032906;4316.352547117957;3060.6021217241614;3087.876484940577;3585.8924232273075;3607.404778211618;3659.7621154624862;1171.3147808531933;1183.1126655008743;1183.7573297474169;1186.4779497021455;1190.4285942747529;1002.9348092373972;1019.0421004255976;1019.0573719309609;1128.4639796096953;1319.459021801057;7268.94600282956;7299.4525410594415;7372.115346158388;7374.483786134919;7378.667959941816;1103.542030057533;1110.5335758981248;1126.5212284778936;1132.4394424759796;1137.181229514748;5568.638038527482;5591.384947655754;5615.719214039282;5625.212470254168;5651.9152212716845;9085.727428177166;9099.226565741854;9245.214156796614;9350.812983740423;9355.48544830041;9105.043970383147;9173.266138708887;9197.678081267124;9271.90728092724;9273.35086543949;7036.437085033185;7246.202917679157;7253.891191632129;7304.30609092146;7344.779656610311;6975.790726278016;7104.538205016657;7107.22319420145;7113.644317784194;7114.253003434565;7893.17121702213;8051.8260069782;8091.433599647969;8221.424500285162;8224.794380140544;8113.472624279403;8271.586420678821;8279.172082791672;8431.95784021076;8433;6916.308369163245;6941.93058069433;7001.264867188872;7031.296870312928;7031.964840175767;6533.738650453929;6657.633830139389;7105.46708996817;7360.07999000125;7584;6746.055552222595;6859.794206173823;6899;6985.022096906336;7003.649817509002;6690.364415380531;6704.932950670626;6804.047433359433;6861.519693621598;7083.185433675193;6893.448524118159;6928.896066558905;6934.029235906876;6935.375816176568;6940.09778728762;6056.90914636272;6098.207233059851;6131.110988906495;6133.539984501091;6226.439620434183;6369.1401660777055;6382.393672601095;6406.263279722892;6406.423421892052;6409.134766806422 11:13:09 INFO - PROCESS | 24415 | |4;prototype.html;317.1563640715696;319.7681680781435;325.8761670565185;328.40886404471945;336.5792759051186;5745.741441635126;5905.498032667223;5906.675132867691;5925.170476133339;5939.792107276236;5661.207430959669;5821.56338274629;5832.154337621042;5853.326867410249;5869.7652093916295;4516.435445569304;4534.1385136824065;4538.818447262105;4548.204064288753;4550.5449455054395;4365.4106695596;4384.276594361926;4472.239719247719;4532.9093418131615;4537.296719008543;4452.398926144978;4500.987277862488;4522.909541809162;4544.318352247156;4546.318052292149;4461.866144015685;4464.308032255006;4469.7318160910445;4495.190865644183;4522.932156017662;3966.8809935701975;3973.4039894016128;3977.3039718049226;3981.1838573092446;3994.9201015979515;5485.61600687952;5602.1596760485845;5621.8594535136535;5624.943750562524;5666.461686139852;5242.764075616568;5243.632945693803;5244.056069907415;5244.475552444763;5245.370555533323;6321.115043893813;6322.399372059647;6323.20959880015;6331.113644089831;6331.430171284561;4086.734362266443;4167.770772607505;4190.55999120091;4265.189613973366;4270.978645106786;6462.579932304385;6494.960806270974;6497.18785151856;6504.642244676541;6510.5117116216;4374.890627734332;4375.934360984587;4376.956230437719;4381.18947994622;4385.824567017347;4348.782560871944;4496.460424749051;4501.504834468205;4502;4512.142692888407;5176.120059589879;5219.347581552306;5244.606654500928;5246.527812496894;5253.921191182136;6341.3341599132345;6343.333949935282;6355.110284560165;6357.96821015892;6359.713812878432;1570.4895908829676;1570.5916461719808;1570.6230504679024;1571.9292631831595;1573.9921300393426;1039.8492218628407;1052.1793001458875;1056.5245639462273;1058.4707646176912;1061.596593294543;6061.424164704435;6063.9090413643835;6070.969645151746;6072.666003369769;6076.969615151985;6464.159659244268;6512.283648798629;6517.055027021055;6519.511036672268;6531.346865313526;6036.909446358308;6044.304904935901;6063.878722425615;6065.363136870653;6066.090086486974;3425.3491836550975;3552.236269202134;3555.093451169935;3555.626659200747;3558.181618227822;6701.597904125768;6703.262641109572;6703.832404189934;6706.631135287606;6713.0266111413575;6777.356151165632;6780.220274668378;6780.525363224527;6803.455723542104;6814.386705196556;6495.8700825983215;6711.966440167768;6712.295209003082;6712.38902663367;6725.2602213756445;6327.96836015817;6595.637239951849;6615.073889655356;6616.735330586723;6619.271880093283;6321.841953951188;6407.839804004937;6508.219013718384;6512.934870651233;6524.347565243438;6655.068290439245;6672.132622759204;6673.9666301668185;6675.432588229861;6684.899726504009;4459.152760975404;4474.664400170065;4508.864734057984;4509.864704058883;4512.25547784625;6250.781222657185;6452.387023232785;6521.64130972801;6573.901391479036;6615.338466153346;6410.583312084699;6417.679116044085;6418.743250269937;6421.454176394872;6427.357264273535;6242.063690446469;6339.5562310637815;6398.168238129014;6402.135711678864;6408.61548307103;6226.782062627786;6250.49996000328;6257.8748425030335;6258.217722784652;6269.843253918689;6396.93603063982;6412.621286423441;6428.357164283721;6433.29233784274;6439.452646525097;6099.725512351866;6229.221347331583;6250.812475625738;6252.343503932022;6258.342873998165 11:13:09 INFO - PROCESS | 24415 | |5;yui.html;761.5240474703311;827.991720082799;837.8156805502791;847.5465625890149;848.3382961290192;13247.867521324795;13400.128991615538;13451.327433628305;13478.3260836958;13480.460781568738;12778.233306001646;12875.613731588068;12899.968002559795;12904.354782260896;12973.286469244187;608.4463138543925;614.3303798859242;799.400449662753;814.3200427642926;815.514768712615;805.3436449293836;810.8864758933724;811.1401913971209;811.3630799822141;812.1350761439078;643.4884267007717;839.7606682095604;843.582426698785;846.7459762071354;846.826400587881;625.2340882419023;826.5495305058757;829.929455996241;831.6423937706784;832.4173078844833;611.843979785152;612.5497759147023;613.8864310102646;615.443024063219;617.3733660334764;12820.294883781387;13218;13236.073474856765;13249.337533123402;13271.203727776365;11304.547818087267;11459.541618335257;11652.126090543159;11732.648020559396;12051;9906.851397229048;9925.950370248174;9937.552810123561;10179.89820101797;10204.94897525515;3632.8728494502566;3651.94522082169;3657.6708096271464;3660.4509323601405;3781.489498917666;45756.084878302245;46435.53564464346;46909.29636055496;46927;47063.52936470626;9792.412455252708;9854.655087072062;9923.305368624271;9973.152282055962;10012.299139060196;17918.731219031724;18130.637387252445;18134.637307253783;18138.818611813713;18190.727139092924;7730.845383092306;7905.881411778828;7935.960320198362;8020.438569300093;8093.271605555528;4419.46966364032;4432.889177770581;4438.778061096932;4516.254817955;4561.361409402686;2961.748251398612;3008.3231272963844;3010.5333673280675;3014.261505931061;3014.728674419313;513.9577225124444;526.6655673647261;530.88851341218;531.6252042310163;544.7766415769515;564.4891373307164;623.2566896052805;628.8742251549617;633.5881676910045;690.8790961581703;8368.246857782708;8619.827603447897;8642.783930401665;8811.691590794291;8839.381243313035;557.726713910181;575.2981362737454;618.888600051995;668.2448832818884;681.9761308354184;3896.6687831534637;4051.8784436466362;4217.913904640172;4226.281532139482;4360.869173924724;54033.45966540284;54794;54876.45123548793;54954.725226373615;55003.44996550064;48082.27876581854;48153.75923120432;48567.514324856296;49908.25137622938;49997.75001124971;43623.781881091025;44740;44940.3258951116;44943.876403090835;45286.773566132615;8249.876251856107;8539.444936079135;8612.354073444641;8894.4663320201;8955.955220223857;33117.33765324728;34333.656663433045;34464.48303275503;34970.650293497754;37952;42968;43630;43869.561304386545;45021.099578008914;45189.54810451854;10126.44304563256;10328.451726795733;10776.084032857296;11244.325340479598;11390.886091138982;11991.76016479648;12105.515779368727;12446.25322480654;12611.747765044463;12781.872181278068;11729.120315976506;11746.471408786454;12059.15585908978;12139.39303034827;12215.755684886075;11044.889551104387;11843.28940263587;11917.76164476723;12005.81991270149;12206.206596571194;11109.944450277697;11202.271852329572;11314.547418103184;11393.715157121138;11625.18623696333;9221.170094691242;9419.529023548657;9420.387674801115;9893;9978.900210997797;9906.900930990598;9970.40177589347;10043.497825108569;10045.547950342107;10060.798784024131 11:13:09 INFO - PROCESS | 24415 | __end_tp_report 11:13:09 INFO - PROCESS | 24415 | __start_cc_report 11:13:09 INFO - PROCESS | 24415 | _x_x_mozilla_cycle_collect,1282 11:13:09 INFO - PROCESS | 24415 | __end_cc_report 11:13:09 INFO - PROCESS | 24415 | __startTimestamp1450811589656__endTimestamp 11:13:09 INFO - PROCESS | 24415 | 11:13:09 INFO - PROCESS | 24415 | ------- Summary: start ------- 11:13:09 INFO - PROCESS | 24415 | Number of tests: 6 11:13:09 INFO - PROCESS | 24415 | 11:13:09 INFO - PROCESS | 24415 | [#0] dojo.html Cycles:165 Average:5437.05 Median:5663.32 stddev:616.78 (10.9%) stddev-sans-first:592.33 11:13:09 INFO - PROCESS | 24415 | Values: 3163.9 3206.3 3237.1 3237.8 3259.1 5190.2 5337.0 5425.6 5443.9 5506.4 5283.4 5382.0 5385.7 5434.1 5441.2 4904.4 4906.8 4933.7 5020.7 5088.2 4891.2 5002.1 5029.2 5040.9 5072.2 4905.6 4958.2 4958.7 4970.1 5007.3 4900.0 4902.5 4902.7 4922.5 4935.3 4872.4 4879.0 4892.9 4905.2 4905.6 5149.0 5212.0 5308.1 5322.1 5330.9 5902.2 5915.7 5918.2 5921.2 5933.5 5755.7 5927.7 5934.4 5938.2 5950.3 5452.2 5476.5 5482.9 5568.0 5574.2 6016.3 6044.5 6047.1 6049.6 6099.3 5666.6 5771.2 5778.3 5784.4 5843.7 5610.8 5697.1 5698.9 5877.7 5887.1 5833.6 5906.9 5907.6 5918.0 5963.6 5844.9 5846.2 5854.6 5854.8 5860.4 4356.0 4368.8 4442.7 4493.6 4501.7 4032.3 4039.2 4047.6 4071.5 4078.0 5489.3 5529.3 5529.9 5532.1 5560.9 5674.5 5782.3 5898.1 5911.6 5913.7 5460.5 5482.2 5552.6 5617.8 5705.3 5138.2 5142.5 5144.7 5154.9 5180.6 5991.8 6016.7 6023.7 6031.8 6035.4 5765.5 5890.7 5906.3 5908.4 5921.2 5904.9 5938.9 5976.6 5983.2 6040.1 5811.3 5871.9 5893.2 5900.6 5904.4 5657.8 5862.9 5862.9 5943.6 5945.9 5667.9 5794.5 5813.5 5815.9 5825.2 5765.4 5770.6 5782.9 5783.5 5835.7 5655.5 5663.3 5666.3 5666.6 5675.9 5682.9 5708.5 5732.7 5753.3 5772.0 5625.5 5627.2 5627.5 5646.6 5654.9 11:13:09 INFO - PROCESS | 24415 | 11:13:09 INFO - PROCESS | 24415 | [#1] ext.html Cycles:180 Average:48542.73 Median:33757.66 stddev:86956.06 (257.6%) stddev-sans-first:87125.34 11:13:09 INFO - PROCESS | 24415 | Values: 549.9 578.5 578.7 583.9 588.2 28096.0 38691.4 38723.2 38969.6 39008.8 43628.0 44106.3 44136.0 44177.6 44181.7 7418.1 7527.2 8603.1 8776.8 8779.2 10335.7 10653.3 10655.1 10655.9 10657.7 10186.9 10265.5 10289.6 10322.9 10369.0 7689.1 7846.3 10249.5 10370.9 10613.9 10161.0 10256.6 10304.1 10332.4 10336.3 40083.8 40146.8 40505.2 40554.6 40587.6 3127.7 3285.5 3449.9 3483.9 3683.4 29729.6 30019.1 30265.1 30408.8 30536.5 3614.2 3699.2 3715.3 3722.4 3809.1 261683.0 263345.0 263579.0 263982.0 264048.0 49796.3 50617.0 58817.7 59185.0 65940.0 59270.4 59277.4 59580.0 59598.7 59659.0 13161.5 13374.5 13379.6 13381.9 13382.7 9229.4 9257.2 9283.8 9297.7 9303.3 19969.6 20108.2 20266.4 20314.6 20318.2 7612.5 7694.5 7732.1 7833.2 7839.9 975.5 992.5 1004.3 1022.0 1037.5 28333.7 28480.1 28553.7 28561.7 28657.4 1028.6 1030.8 1064.9 1098.7 1128.4 14822.4 14879.6 14953.3 15104.4 15166.8 301592.0 304302.0 304528.0 304787.0 305493.0 51601.5 51931.5 51967.0 51990.0 52110.0 1294.5 1295.6 1308.9 1322.5 1324.0 27506.6 28371.0 28715.0 28759.6 28845.6 39620.4 40190.0 45919.5 46261.5 46266.0 402692.0 403288.0 408782.0 410492.0 410528.0 29003.9 29199.9 29216.0 29220.7 29243.6 39485.4 40546.8 40796.8 40830.0 41326.6 33662.0 33741.3 33828.0 34017.0 34499.5 33774.0 34301.5 34445.8 34488.7 34546.5 33988.8 34281.7 34610.5 34618.3 34652.1 28195.3 29496.3 30848.4 30886.9 31014.7 24025.9 24580.0 24982.9 25094.6 25459.5 11:13:09 INFO - PROCESS | 24415 | 11:13:09 INFO - PROCESS | 24415 | [#2] jquery.html Cycles:180 Average:27000.55 Median:17914.32 stddev:79533.23 (444.0%) stddev-sans-first:79731.16 11:13:09 INFO - PROCESS | 24415 | Values: 346.2 350.2 352.7 354.5 356.9 13503.7 13757.4 15958.3 16281.3 17152.4 13700.7 13739.1 16666.3 16819.3 17107.7 5129.0 5261.2 5265.1 5267.3 5270.9 3917.3 4004.6 4925.8 4995.2 5219.7 5599.8 5715.3 5743.9 5746.4 5758.6 5565.7 5716.4 5753.8 5800.1 5819.2 5222.1 5236.2 5245.6 5248.2 5249.4 20423.9 20487.7 20738.9 20820.8 20899.3 2000.3 2010.4 2041.4 2160.6 2201.3 12909.5 12951.5 12980.7 13026.1 13360.3 1813.7 1820.4 1825.8 1839.4 1925.2 52090.7 55302.9 55567.7 55606.2 56045.0 9940.3 10150.0 10154.9 10161.3 10233.7 13146.3 13226.3 13230.7 13243.5 13273.4 6929.7 6948.1 6971.9 7002.3 7030.5 6507.5 6558.5 6563.1 6566.1 6614.7 4367.4 4391.5 4394.6 4414.4 4417.7 1680.6 1728.5 1762.2 1782.3 1810.5 888.3 903.3 919.4 925.2 1032.9 15710.2 16440.2 16712.4 16800.3 16873.5 815.5 894.2 902.3 925.1 939.3 8987.5 9389.8 9418.1 9725.8 9773.1 476005.0 480738.0 487738.0 493827.0 494090.0 78444.6 78655.0 79595.2 79705.2 79758.0 1135.9 1136.9 1146.8 1164.9 1165.6 15068.5 15332.0 15518.9 15530.8 15812.2 35180.3 35302.6 35474.1 36305.5 36445.0 44248.3 44779.6 45746.3 45789.5 45985.3 9226.7 9596.7 9629.1 9648.5 9662.9 11193.8 14379.8 16600.8 16777.7 17239.8 13391.7 13516.9 13647.9 13869.8 14078.0 13348.7 13492.5 13716.6 14066.2 14434.4 10834.5 10959.8 14255.1 14484.9 14848.9 9337.5 9541.0 9574.0 9584.5 9696.5 10192.9 10698.5 13742.1 13787.9 14065.2 11:13:09 INFO - PROCESS | 24415 | 11:13:09 INFO - PROCESS | 24415 | [#3] mootools.html Cycles:180 Average:5359.83 Median:6365.51 stddev:2805.68 (44.1%) stddev-sans-first:2796.83 11:13:09 INFO - PROCESS | 24415 | Values: 1285.1 1466.7 1504.2 1637.5 1774.5 6361.9 7652.1 7809.3 7833.9 7847.6 7164.2 7315.6 7321.2 7329.6 7330.3 1955.0 1989.0 1989.5 2191.2 2215.2 2212.3 2243.8 2246.9 2247.4 2247.9 2162.5 2185.0 2228.2 2229.0 2230.4 2171.2 2172.6 2200.8 2202.5 2227.0 2254.8 2271.3 2302.8 2305.4 2309.5 7773.1 7826.4 7846.5 7867.8 7869.8 4513.4 4634.8 4638.1 4639.7 4642.2 2907.9 2919.2 2956.3 2958.7 3052.7 886.6 892.2 894.5 898.4 937.7 10775.6 10799.4 10836.5 10838.4 10857.8 4098.4 4146.2 4163.6 4170.0 4187.9 9227.2 9233.0 9233.5 9247.2 9249.6 4681.3 4689.0 4690.0 4718.0 4720.4 4240.6 4264.9 4305.2 4312.5 4316.4 3060.6 3087.9 3585.9 3607.4 3659.8 1171.3 1183.1 1183.8 1186.5 1190.4 1002.9 1019.0 1019.1 1128.5 1319.5 7268.9 7299.5 7372.1 7374.5 7378.7 1103.5 1110.5 1126.5 1132.4 1137.2 5568.6 5591.4 5615.7 5625.2 5651.9 9085.7 9099.2 9245.2 9350.8 9355.5 9105.0 9173.3 9197.7 9271.9 9273.4 7036.4 7246.2 7253.9 7304.3 7344.8 6975.8 7104.5 7107.2 7113.6 7114.3 7893.2 8051.8 8091.4 8221.4 8224.8 8113.5 8271.6 8279.2 8432.0 8433.0 6916.3 6941.9 7001.3 7031.3 7032.0 6533.7 6657.6 7105.5 7360.1 7584.0 6746.1 6859.8 6899.0 6985.0 7003.6 6690.4 6704.9 6804.0 6861.5 7083.2 6893.4 6928.9 6934.0 6935.4 6940.1 6056.9 6098.2 6131.1 6133.5 6226.4 6369.1 6382.4 6406.3 6406.4 6409.1 11:13:09 INFO - PROCESS | 24415 | 11:13:09 INFO - PROCESS | 24415 | [#4] prototype.html Cycles:180 Average:5265.68 Median:6040.61 stddev:1604.30 (26.6%) stddev-sans-first:1565.21 11:13:09 INFO - PROCESS | 24415 | Values: 317.2 319.8 325.9 328.4 336.6 5745.7 5905.5 5906.7 5925.2 5939.8 5661.2 5821.6 5832.2 5853.3 5869.8 4516.4 4534.1 4538.8 4548.2 4550.5 4365.4 4384.3 4472.2 4532.9 4537.3 4452.4 4501.0 4522.9 4544.3 4546.3 4461.9 4464.3 4469.7 4495.2 4522.9 3966.9 3973.4 3977.3 3981.2 3994.9 5485.6 5602.2 5621.9 5624.9 5666.5 5242.8 5243.6 5244.1 5244.5 5245.4 6321.1 6322.4 6323.2 6331.1 6331.4 4086.7 4167.8 4190.6 4265.2 4271.0 6462.6 6495.0 6497.2 6504.6 6510.5 4374.9 4375.9 4377.0 4381.2 4385.8 4348.8 4496.5 4501.5 4502.0 4512.1 5176.1 5219.3 5244.6 5246.5 5253.9 6341.3 6343.3 6355.1 6358.0 6359.7 1570.5 1570.6 1570.6 1571.9 1574.0 1039.8 1052.2 1056.5 1058.5 1061.6 6061.4 6063.9 6071.0 6072.7 6077.0 6464.2 6512.3 6517.1 6519.5 6531.3 6036.9 6044.3 6063.9 6065.4 6066.1 3425.3 3552.2 3555.1 3555.6 3558.2 6701.6 6703.3 6703.8 6706.6 6713.0 6777.4 6780.2 6780.5 6803.5 6814.4 6495.9 6712.0 6712.3 6712.4 6725.3 6328.0 6595.6 6615.1 6616.7 6619.3 6321.8 6407.8 6508.2 6512.9 6524.3 6655.1 6672.1 6674.0 6675.4 6684.9 4459.2 4474.7 4508.9 4509.9 4512.3 6250.8 6452.4 6521.6 6573.9 6615.3 6410.6 6417.7 6418.7 6421.5 6427.4 6242.1 6339.6 6398.2 6402.1 6408.6 6226.8 6250.5 6257.9 6258.2 6269.8 6396.9 6412.6 6428.4 6433.3 6439.5 6099.7 6229.2 6250.8 6252.3 6258.3 11:13:09 INFO - PROCESS | 24415 | 11:13:09 INFO - PROCESS | 24415 | [#5] yui.html Cycles:180 Average:13555.73 Median:25158.72 stddev:15367.85 (61.1%) stddev-sans-first:15380.93 11:13:09 INFO - PROCESS | 24415 | Values: 761.5 828.0 837.8 847.5 848.3 13247.9 13400.1 13451.3 13478.3 13480.5 12778.2 12875.6 12900.0 12904.4 12973.3 608.4 614.3 799.4 814.3 815.5 805.3 810.9 811.1 811.4 812.1 643.5 839.8 843.6 846.7 846.8 625.2 826.5 829.9 831.6 832.4 611.8 612.5 613.9 615.4 617.4 12820.3 13218.0 13236.1 13249.3 13271.2 11304.5 11459.5 11652.1 11732.6 12051.0 9906.9 9926.0 9937.6 10179.9 10204.9 3632.9 3651.9 3657.7 3660.5 3781.5 45756.1 46435.5 46909.3 46927.0 47063.5 9792.4 9854.7 9923.3 9973.2 10012.3 17918.7 18130.6 18134.6 18138.8 18190.7 7730.8 7905.9 7936.0 8020.4 8093.3 4419.5 4432.9 4438.8 4516.3 4561.4 2961.7 3008.3 3010.5 3014.3 3014.7 514.0 526.7 530.9 531.6 544.8 564.5 623.3 628.9 633.6 690.9 8368.2 8619.8 8642.8 8811.7 8839.4 557.7 575.3 618.9 668.2 682.0 3896.7 4051.9 4217.9 4226.3 4360.9 54033.5 54794.0 54876.5 54954.7 55003.4 48082.3 48153.8 48567.5 49908.3 49997.8 43623.8 44740.0 44940.3 44943.9 45286.8 8249.9 8539.4 8612.4 8894.5 8956.0 33117.3 34333.7 34464.5 34970.7 37952.0 42968.0 43630.0 43869.6 45021.1 45189.5 10126.4 10328.5 10776.1 11244.3 11390.9 11991.8 12105.5 12446.3 12611.7 12781.9 11729.1 11746.5 12059.2 12139.4 12215.8 11044.9 11843.3 11917.8 12005.8 12206.2 11109.9 11202.3 11314.5 11393.7 11625.2 9221.2 9419.5 9420.4 9893.0 9978.9 9906.9 9970.4 10043.5 10045.5 10060.8 11:13:09 INFO - PROCESS | 24415 | -------- Summary: end -------- 11:13:09 INFO - PROCESS | 24415 | 11:13:10 INFO - TEST-INFO | 24415: exit 0 11:13:10 INFO - TEST-OK | dromaeo_css | took 1114143ms 11:13:10 INFO - TEST-START | kraken 11:13:10 INFO - operating with platform_type : linux_ 11:13:10 INFO - Initialising browser for kraken test... 11:13:10 INFO - TEST-INFO | started process 24610 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXfdAoQ/profile http://localhost:55682/getInfo.html) 11:13:14 INFO - PROCESS | 24610 | __metrics Screen width/height:1600/1200 11:13:14 INFO - PROCESS | 24610 | colorDepth:24 11:13:14 INFO - PROCESS | 24610 | Browser inner width/height: 1024/697 11:13:14 INFO - PROCESS | 24610 | __metrics 11:13:14 INFO - PROCESS | 24610 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:13:14 INFO - PROCESS | 24610 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:13:15 INFO - TEST-INFO | 24610: exit 0 11:13:15 INFO - Browser initialized. 11:13:15 INFO - Running cycle 1/1 for kraken test... 11:13:15 INFO - TEST-INFO | started process 24692 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXfdAoQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:13:27 INFO - PROCESS | 24692 | RSS: Main: 150339584 11:13:27 INFO - PROCESS | 24692 | 11:13:29 INFO - PROCESS | 24692 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55682/tests/kraken/driver.html?testName=audio-beat-detection) 11:13:30 INFO - PROCESS | 24692 | RSS: Main: 186347520 11:13:30 INFO - PROCESS | 24692 | 11:13:32 INFO - PROCESS | 24692 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55682/tests/kraken/driver.html?testName=audio-dft) 11:13:33 INFO - PROCESS | 24692 | RSS: Main: 177287168 11:13:33 INFO - PROCESS | 24692 | 11:13:36 INFO - PROCESS | 24692 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55682/tests/kraken/driver.html?testName=audio-fft) 11:13:37 INFO - PROCESS | 24692 | RSS: Main: 160120832 11:13:37 INFO - PROCESS | 24692 | 11:13:39 INFO - PROCESS | 24692 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55682/tests/kraken/driver.html?testName=audio-oscillator) 11:13:39 INFO - PROCESS | 24692 | RSS: Main: 164315136 11:13:39 INFO - PROCESS | 24692 | 11:13:41 INFO - PROCESS | 24692 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55682/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:13:42 INFO - PROCESS | 24692 | RSS: Main: 164089856 11:13:42 INFO - PROCESS | 24692 | 11:13:45 INFO - PROCESS | 24692 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55682/tests/kraken/driver.html?testName=imaging-darkroom) 11:13:45 INFO - PROCESS | 24692 | RSS: Main: 163958784 11:13:45 INFO - PROCESS | 24692 | 11:13:49 INFO - PROCESS | 24692 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55682/tests/kraken/driver.html?testName=imaging-desaturate) 11:13:49 INFO - PROCESS | 24692 | RSS: Main: 165498880 11:13:49 INFO - PROCESS | 24692 | 11:13:52 INFO - PROCESS | 24692 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55682/tests/kraken/driver.html?testName=json-parse-financial) 11:13:52 INFO - PROCESS | 24692 | RSS: Main: 164818944 11:13:52 INFO - PROCESS | 24692 | 11:13:54 INFO - PROCESS | 24692 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55682/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:13:55 INFO - PROCESS | 24692 | RSS: Main: 177377280 11:13:55 INFO - PROCESS | 24692 | 11:13:56 INFO - PROCESS | 24692 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55682/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:13:57 INFO - PROCESS | 24692 | RSS: Main: 175452160 11:13:57 INFO - PROCESS | 24692 | 11:13:59 INFO - PROCESS | 24692 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55682/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:14:00 INFO - PROCESS | 24692 | RSS: Main: 186728448 11:14:00 INFO - PROCESS | 24692 | 11:14:02 INFO - PROCESS | 24692 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55682/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:14:03 INFO - PROCESS | 24692 | RSS: Main: 193933312 11:14:03 INFO - PROCESS | 24692 | 11:14:05 INFO - PROCESS | 24692 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55682/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:14:06 INFO - PROCESS | 24692 | RSS: Main: 189644800 11:14:06 INFO - PROCESS | 24692 | 11:14:08 INFO - PROCESS | 24692 | Cycle 1(1): loaded http://localhost:55682/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55682/tests/kraken/driver.html?testName=ai-astar) 11:14:08 INFO - PROCESS | 24692 | RSS: Main: 248303616 11:14:08 INFO - PROCESS | 24692 | 11:14:08 INFO - PROCESS | 24692 | __start_tp_report 11:14:08 INFO - PROCESS | 24692 | _x_x_mozilla_page_load 11:14:08 INFO - PROCESS | 24692 | _x_x_mozilla_page_load_details 11:14:08 INFO - PROCESS | 24692 | |i|pagename|runs| 11:14:08 INFO - PROCESS | 24692 | |0;ai-astar;109;112;104;109;111;112;100;112;109;115 11:14:08 INFO - PROCESS | 24692 | |1;audio-beat-detection;157;125;150;161;131;148;149;124;169;124 11:14:08 INFO - PROCESS | 24692 | |2;audio-dft;161;161;161;161;161;160;160;165;160;161 11:14:08 INFO - PROCESS | 24692 | |3;audio-fft;71;72;78;96;72;77;71;98;91;71 11:14:08 INFO - PROCESS | 24692 | |4;audio-oscillator;93;93;136;93;93;93;140;93;93;136 11:14:08 INFO - PROCESS | 24692 | |5;imaging-gaussian-blur;109;109;109;109;110;110;110;109;109;110 11:14:08 INFO - PROCESS | 24692 | |6;imaging-darkroom;145;146;146;146;146;145;146;145;145;145 11:14:08 INFO - PROCESS | 24692 | |7;imaging-desaturate;96;96;96;95;95;95;95;96;96;95 11:14:08 INFO - PROCESS | 24692 | |8;json-parse-financial;58;57;57;57;57;57;57;65;56;55 11:14:08 INFO - PROCESS | 24692 | |9;json-stringify-tinderbox;67;68;68;67;68;68;67;68;68;67 11:14:08 INFO - PROCESS | 24692 | |10;stanford-crypto-aes;85;86;85;85;94;85;85;85;86;85 11:14:08 INFO - PROCESS | 24692 | |11;stanford-crypto-ccm;116;112;119;114;123;125;126;120;117;116 11:14:08 INFO - PROCESS | 24692 | |12;stanford-crypto-pbkdf2;144;144;160;167;155;149;154;145;164;142 11:14:08 INFO - PROCESS | 24692 | |13;stanford-crypto-sha256-iterative;67;71;68;68;67;70;66;67;69;66 11:14:08 INFO - PROCESS | 24692 | __end_tp_report 11:14:08 INFO - PROCESS | 24692 | __start_cc_report 11:14:08 INFO - PROCESS | 24692 | _x_x_mozilla_cycle_collect,947 11:14:08 INFO - PROCESS | 24692 | __end_cc_report 11:14:08 INFO - PROCESS | 24692 | __startTimestamp1450811648258__endTimestamp 11:14:08 INFO - PROCESS | 24692 | 11:14:08 INFO - PROCESS | 24692 | ------- Summary: start ------- 11:14:08 INFO - PROCESS | 24692 | Number of tests: 14 11:14:08 INFO - PROCESS | 24692 | 11:14:08 INFO - PROCESS | 24692 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.50 stddev:4.37 (3.9%) stddev-sans-first:4.64 11:14:08 INFO - PROCESS | 24692 | Values: 109.0 112.0 104.0 109.0 111.0 112.0 100.0 112.0 109.0 115.0 11:14:08 INFO - PROCESS | 24692 | 11:14:08 INFO - PROCESS | 24692 | [#1] audio-beat-detection Cycles:10 Average:143.80 Median:149.50 stddev:16.63 (11.1%) stddev-sans-first:16.94 11:14:08 INFO - PROCESS | 24692 | Values: 157.0 125.0 150.0 161.0 131.0 148.0 149.0 124.0 169.0 124.0 11:14:08 INFO - PROCESS | 24692 | 11:14:08 INFO - PROCESS | 24692 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.45 (0.9%) stddev-sans-first:1.54 11:14:08 INFO - PROCESS | 24692 | Values: 161.0 161.0 161.0 161.0 161.0 160.0 160.0 165.0 160.0 161.0 11:14:08 INFO - PROCESS | 24692 | 11:14:08 INFO - PROCESS | 24692 | [#3] audio-fft Cycles:10 Average:79.70 Median:77.50 stddev:10.98 (14.2%) stddev-sans-first:11.18 11:14:08 INFO - PROCESS | 24692 | Values: 71.0 72.0 78.0 96.0 72.0 77.0 71.0 98.0 91.0 71.0 11:14:08 INFO - PROCESS | 24692 | 11:14:08 INFO - PROCESS | 24692 | [#4] audio-oscillator Cycles:10 Average:106.30 Median:93.00 stddev:21.44 (23.1%) stddev-sans-first:22.20 11:14:08 INFO - PROCESS | 24692 | Values: 93.0 93.0 136.0 93.0 93.0 93.0 140.0 93.0 93.0 136.0 11:14:08 INFO - PROCESS | 24692 | 11:14:08 INFO - PROCESS | 24692 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 11:14:08 INFO - PROCESS | 24692 | Values: 109.0 109.0 109.0 109.0 110.0 110.0 110.0 109.0 109.0 110.0 11:14:08 INFO - PROCESS | 24692 | 11:14:08 INFO - PROCESS | 24692 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 11:14:08 INFO - PROCESS | 24692 | Values: 145.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 145.0 145.0 11:14:08 INFO - PROCESS | 24692 | 11:14:08 INFO - PROCESS | 24692 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 11:14:08 INFO - PROCESS | 24692 | Values: 96.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 11:14:08 INFO - PROCESS | 24692 | 11:14:08 INFO - PROCESS | 24692 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.00 stddev:2.72 (4.8%) stddev-sans-first:2.88 11:14:08 INFO - PROCESS | 24692 | Values: 58.0 57.0 57.0 57.0 57.0 57.0 57.0 65.0 56.0 55.0 11:14:08 INFO - PROCESS | 24692 | 11:14:08 INFO - PROCESS | 24692 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 11:14:08 INFO - PROCESS | 24692 | Values: 67.0 68.0 68.0 67.0 68.0 68.0 67.0 68.0 68.0 67.0 11:14:08 INFO - PROCESS | 24692 | 11:14:08 INFO - PROCESS | 24692 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:85.00 stddev:2.81 (3.3%) stddev-sans-first:2.95 11:14:08 INFO - PROCESS | 24692 | Values: 85.0 86.0 85.0 85.0 94.0 85.0 85.0 85.0 86.0 85.0 11:14:08 INFO - PROCESS | 24692 | 11:14:08 INFO - PROCESS | 24692 | [#11] stanford-crypto-ccm Cycles:10 Average:118.80 Median:119.50 stddev:4.69 (3.9%) stddev-sans-first:4.86 11:14:08 INFO - PROCESS | 24692 | Values: 116.0 112.0 119.0 114.0 123.0 125.0 126.0 120.0 117.0 116.0 11:14:08 INFO - PROCESS | 24692 | 11:14:08 INFO - PROCESS | 24692 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.40 Median:154.50 stddev:9.01 (5.8%) stddev-sans-first:9.03 11:14:08 INFO - PROCESS | 24692 | Values: 144.0 144.0 160.0 167.0 155.0 149.0 154.0 145.0 164.0 142.0 11:14:08 INFO - PROCESS | 24692 | 11:14:08 INFO - PROCESS | 24692 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.66 (2.4%) stddev-sans-first:1.73 11:14:08 INFO - PROCESS | 24692 | Values: 67.0 71.0 68.0 68.0 67.0 70.0 66.0 67.0 69.0 66.0 11:14:08 INFO - PROCESS | 24692 | -------- Summary: end -------- 11:14:08 INFO - PROCESS | 24692 | 11:14:09 INFO - TEST-INFO | 24692: exit 0 11:14:09 INFO - TEST-OK | kraken | took 58678ms 11:14:09 INFO - TEST-START | v8_7 11:14:09 INFO - operating with platform_type : linux_ 11:14:09 INFO - Initialising browser for v8_7 test... 11:14:09 INFO - TEST-INFO | started process 24946 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_8fq2o/profile http://localhost:55682/getInfo.html) 11:14:13 INFO - PROCESS | 24946 | __metrics Screen width/height:1600/1200 11:14:13 INFO - PROCESS | 24946 | colorDepth:24 11:14:13 INFO - PROCESS | 24946 | Browser inner width/height: 1024/697 11:14:13 INFO - PROCESS | 24946 | __metrics 11:14:13 INFO - PROCESS | 24946 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:14:13 INFO - PROCESS | 24946 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:14:14 INFO - TEST-INFO | 24946: exit 0 11:14:14 INFO - Browser initialized. 11:14:14 INFO - Running cycle 1/1 for v8_7 test... 11:14:14 INFO - TEST-INFO | started process 25029 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_8fq2o/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:14:25 INFO - PROCESS | 25029 | RSS: Main: 149987328 11:14:25 INFO - PROCESS | 25029 | 11:14:47 INFO - PROCESS | 25029 | Cycle 1(1): loaded http://localhost:55682/tests/v8_7/run.html (next: http://localhost:55682/tests/v8_7/run.html) 11:14:47 INFO - PROCESS | 25029 | RSS: Main: 611880960 11:14:47 INFO - PROCESS | 25029 | 11:14:47 INFO - PROCESS | 25029 | __start_tp_report 11:14:47 INFO - PROCESS | 25029 | _x_x_mozilla_page_load 11:14:47 INFO - PROCESS | 25029 | _x_x_mozilla_page_load_details 11:14:47 INFO - PROCESS | 25029 | |i|pagename|runs| 11:14:47 INFO - PROCESS | 25029 | |0;Richards;170.47391749062393 11:14:47 INFO - PROCESS | 25029 | |1;DeltaBlue;197.08316909735908 11:14:47 INFO - PROCESS | 25029 | |2;Encrypt;283.4467120181406 11:14:47 INFO - PROCESS | 25029 | |3;Decrypt;5133.333333333333 11:14:47 INFO - PROCESS | 25029 | |4;RayTrace;1109.8779134295228 11:14:47 INFO - PROCESS | 25029 | |5;Earley;783.0853563038371 11:14:47 INFO - PROCESS | 25029 | |6;Boyer;12207.317073170732 11:14:47 INFO - PROCESS | 25029 | |7;RegExp;26051.28205128205 11:14:47 INFO - PROCESS | 25029 | |8;Splay;677.5067750677507 11:14:47 INFO - PROCESS | 25029 | |9;NavierStokes;4892.682926829269 11:14:47 INFO - PROCESS | 25029 | __end_tp_report 11:14:47 INFO - PROCESS | 25029 | __startTimestamp1450811687593__endTimestamp 11:14:47 INFO - PROCESS | 25029 | 11:14:47 INFO - PROCESS | 25029 | ------- Summary: start ------- 11:14:47 INFO - PROCESS | 25029 | Number of tests: 10 11:14:47 INFO - PROCESS | 25029 | 11:14:47 INFO - PROCESS | 25029 | [#0] Richards Cycles:1 Average:170.47 Median:170.47 stddev:0.00 (0.0%) 11:14:47 INFO - PROCESS | 25029 | Values: 170.5 11:14:47 INFO - PROCESS | 25029 | 11:14:47 INFO - PROCESS | 25029 | [#1] DeltaBlue Cycles:1 Average:197.08 Median:197.08 stddev:0.00 (0.0%) 11:14:47 INFO - PROCESS | 25029 | Values: 197.1 11:14:47 INFO - PROCESS | 25029 | 11:14:47 INFO - PROCESS | 25029 | [#2] Encrypt Cycles:1 Average:283.45 Median:283.45 stddev:0.00 (0.0%) 11:14:47 INFO - PROCESS | 25029 | Values: 283.4 11:14:47 INFO - PROCESS | 25029 | 11:14:47 INFO - PROCESS | 25029 | [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 11:14:47 INFO - PROCESS | 25029 | Values: 5133.3 11:14:47 INFO - PROCESS | 25029 | 11:14:47 INFO - PROCESS | 25029 | [#4] RayTrace Cycles:1 Average:1109.88 Median:1109.88 stddev:0.00 (0.0%) 11:14:47 INFO - PROCESS | 25029 | Values: 1109.9 11:14:47 INFO - PROCESS | 25029 | 11:14:47 INFO - PROCESS | 25029 | [#5] Earley Cycles:1 Average:783.09 Median:783.09 stddev:0.00 (0.0%) 11:14:47 INFO - PROCESS | 25029 | Values: 783.1 11:14:47 INFO - PROCESS | 25029 | 11:14:47 INFO - PROCESS | 25029 | [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 11:14:47 INFO - PROCESS | 25029 | Values: 12207.3 11:14:47 INFO - PROCESS | 25029 | 11:14:47 INFO - PROCESS | 25029 | [#7] RegExp Cycles:1 Average:26051.28 Median:26051.28 stddev:0.00 (0.0%) 11:14:47 INFO - PROCESS | 25029 | Values: 26051.3 11:14:47 INFO - PROCESS | 25029 | 11:14:47 INFO - PROCESS | 25029 | [#8] Splay Cycles:1 Average:677.51 Median:677.51 stddev:0.00 (0.0%) 11:14:47 INFO - PROCESS | 25029 | Values: 677.5 11:14:47 INFO - PROCESS | 25029 | 11:14:47 INFO - PROCESS | 25029 | [#9] NavierStokes Cycles:1 Average:4892.68 Median:4892.68 stddev:0.00 (0.0%) 11:14:47 INFO - PROCESS | 25029 | Values: 4892.7 11:14:47 INFO - PROCESS | 25029 | -------- Summary: end -------- 11:14:47 INFO - PROCESS | 25029 | 11:14:48 INFO - TEST-INFO | 25029: exit 0 11:14:48 INFO - TEST-OK | v8_7 | took 39315ms 11:14:48 INFO - SUITE-END | took 1212s 11:14:48 INFO - Completed test suite (00:20:12) 11:14:48 INFO - Working with test: dromaeo_css 11:14:48 INFO - Generating results file: dromaeo_css 11:14:48 INFO - Working with test: kraken 11:14:48 INFO - Generating results file: kraken 11:14:48 INFO - javascript benchmark 11:14:48 INFO - Working with test: v8_7 11:14:48 INFO - Generating results file: v8_7 11:14:48 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:14:48 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 11:14:48 INFO - process_Request line: dromaeo_css 6940.68 graph.html#tests=[[72,201,35]] 11:14:48 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:14:48 INFO - process_Request line: kraken 1501.00 graph.html#tests=[[232,201,35]] 11:14:48 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:14:48 INFO - process_Request line: v8_7 20623.30 graph.html#tests=[[230,201,35]] 11:14:48 INFO - RETURN: dromaeo_css: 6940.68 11:14:48 INFO - RETURN: kraken: 1501.00 11:14:48 INFO - RETURN: v8_7: 20623.30 11:14:48 INFO - javascript benchmark 11:14:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3163.9050828475147, 3206.326671399006, 3237.0936137881386, 3237.838108094596, 3259.1037464697206, 5190.169572868342, 5337.039332920082, 5425.593080518962, 5443.891122177554, 5506.421825708303, 5283.365996080475, 5381.973090134554, 5385.730713464331, 5434.130539113743, 5441.156620723784, 4904.386951631037, 4906.754662266891, 4933.679310844784, 5020.723860187688, 5088.160453525164, 4891.241857512091, 5002.074616196015, 5029.220470827027, 5040.899182016357, 5072.188449848025, 4905.607551395879, 4958.157113290749, 4958.7024778513405, 4970.080535101018, 5007.32401125847, 4900.044491324194, 4902.48523904992, 4902.681325713817, 4922.483139270396, 4935.3090567320605, 4872.439669438025, 4878.951210487885, 4892.926606100876, 4905.23968784839, 4905.558499735005, 5149.0, 5212.035773381936, 5308.071087559701, 5322.0952438085615, 5330.946690533084, 5902.203202567642, 5915.704214789286, 5918.23063001807, 5921.230240068807, 5933.465988061095, 5755.740991655385, 5927.673977931212, 5934.43622855828, 5938.198343223653, 5950.256217972754, 5452.154915988028, 5476.479734425263, 5482.862928426821, 5568.0, 5574.247476590608, 6016.278046634432, 6044.516438684895, 6047.0627052806, 6049.576529642971, 6099.268087829489, 5666.631668941505, 5771.192033115367, 5778.306603207558, 5784.421557844266, 5843.707814609253, 5610.831675049755, 5697.145428185805, 5698.857528561819, 5877.706114694248, 5887.116932460165, 5833.591648584643, 5906.852328691731, 5907.556933230025, 5917.970410147922, 5963.5527335450015, 5844.912326315109, 5846.239988801513, 5854.619449735838, 5854.765809367577, 5860.384659610765, 4356.0, 4368.825246990148, 4442.73343599385, 4493.573110554492, 4501.6848820582245, 4032.3145065338963, 4039.171969746195, 4047.5547689754103, 4071.470708807836, 4078.0416602098485, 5489.34127904646, 5529.336479622471, 5529.917051244234, 5532.114861622121, 5560.944390556124, 5674.546036317085, 5782.335031471434, 5898.144769008555, 5911.615744976649, 5913.733881975321, 5460.481254280837, 5482.150266708666, 5552.639078459887, 5617.831465055973, 5705.343885453143, 5138.152204886152, 5142.537171654569, 5144.717040562805, 5154.92267615986, 5180.637355385087, 5991.760329586855, 6016.729247183887, 6023.668698221552, 6031.819045428644, 6035.366286539938, 5765.538756899522, 5890.6760128191645, 5906.26171728534, 5908.379620139824, 5921.17103605487, 5904.940950590439, 5938.910916336172, 5976.581639285382, 5983.222181116427, 6040.124181993674, 5811.27359080115, 5871.94128058714, 5893.174955506318, 5900.586958912835, 5904.350521442552, 5657.8019769307875, 5862.853428664317, 5862.882742345215, 5943.613665111927, 5945.881082378241, 5667.943320566907, 5794.507466865363, 5813.505852002458, 5815.883682326415, 5825.155352473952, 5765.423457654201, 5770.567207459373, 5782.855428614318, 5783.508401785727, 5835.708214589338, 5655.519280861173, 5663.32040155184, 5666.291713535808, 5666.603337766317, 5675.943240567542, 5682.9431705684065, 5708.4862362387585, 5732.684702341411, 5753.252077229933, 5772.04761214395, 5625.46558076982, 5627.18405831144, 5627.52166065889, 5646.576506761927, 5654.886902261849], "unit": "score", "name": "dojo.html", "value": 5396.025877059027}, {"lowerIsBetter": false, "replicates": [549.8881262088057, 578.537170263789, 578.675941472775, 583.899349725767, 588.2264821759386, 28096.0, 38691.41962870556, 38723.22553548928, 38969.61030389695, 39008.80495597518, 43628.0, 44106.338404923874, 44136.0, 44177.55822441775, 44181.67454976348, 7418.072740907387, 7527.20964298749, 8603.096674849161, 8776.780580485507, 8779.2098711116, 10335.689929302096, 10653.307535010239, 10655.094316983026, 10655.893441065606, 10657.680269591925, 10186.949065254663, 10265.538050787733, 10289.588416463332, 10322.896771032269, 10369.0, 7689.115751688543, 7846.333061689763, 10249.538770755335, 10370.896291037068, 10613.893861061368, 10161.0, 10256.641017564349, 10304.072633463024, 10332.380057196593, 10336.328138671037, 40083.7995810022, 40146.79926600378, 40505.1898962022, 40554.594454055376, 40587.594124058676, 3127.749780017616, 3285.5400243965864, 3449.913752156191, 3483.8954831354845, 3683.3922402803505, 29729.55405668917, 30019.099427017223, 30265.092047238617, 30408.847955760302, 30536.54195187074, 3614.168741189541, 3699.2231631357176, 3715.349813782604, 3722.3671975764187, 3809.123901502642, 261683.0, 263345.0, 263579.0, 263982.0, 264048.0, 49796.25305620419, 50617.0, 58817.70591147017, 59185.0, 65940.0, 59270.407295927354, 59277.40722592805, 59580.0, 59598.70200648969, 59659.0, 13161.53934612303, 13374.53189138395, 13379.598612041655, 13381.866181338257, 13382.732345353039, 9229.400088994194, 9257.166854983085, 9283.76790580241, 9297.72106836796, 9303.25573954082, 19969.60060798776, 20108.195672172948, 20266.392008239778, 20314.593708125754, 20318.18727250923, 7612.505187162817, 7694.461387702919, 7732.110807257125, 7833.216678332121, 7839.882401763978, 975.5073687787764, 992.5186284651938, 1004.2719028704131, 1021.9984415272926, 1037.5071840875523, 28333.716662833107, 28480.111514909975, 28553.71446285552, 28561.71438285632, 28657.426851462853, 1028.5885645741614, 1030.7938412317567, 1064.8775390829999, 1098.6703988803326, 1128.3906690387264, 14822.407103715947, 14879.628009299855, 14953.327100280296, 15104.39582416713, 15166.848331516543, 301592.0, 304302.0, 304528.0, 304787.0, 305493.0, 51601.48398516042, 51931.48068519342, 51967.0, 51990.0, 52109.99999999924, 1294.4692676002794, 1295.578936845529, 1308.8691130886834, 1322.497450968645, 1324.0202250334876, 27506.587401189397, 28371.0, 28715.0, 28759.568606471337, 28845.567316490688, 39620.40569391519, 40190.0, 45919.54080459286, 46261.53738462572, 46266.0, 402692.0, 403288.0, 408782.0, 410492.0, 410528.0, 29003.854980725806, 29199.912012318717, 29216.0, 29220.7077929218, 29243.561346579394, 39485.40771888482, 40546.797266013484, 40796.79601601973, 40830.0, 41326.586734133474, 33662.0, 33741.32517349689, 33828.0, 34017.0, 34499.48250776291, 33774.0, 34301.48547771735, 34445.82777086098, 34488.65511344854, 34546.481802772476, 33988.83005584956, 34281.657183427844, 34610.48084278788, 34618.30763384768, 34652.133696656776, 28195.295117622223, 29496.262593435335, 30848.383032339676, 30886.888367931064, 31014.734445448023, 24025.879870600536, 24580.0, 24982.875085624455, 25094.62358064594, 25459.49081018332], "unit": "score", "name": "ext.html", "value": 18433.73893295479}, {"lowerIsBetter": false, "replicates": [346.2244572158366, 350.152630633866, 352.6543986892845, 354.5284771254232, 356.85190645881954, 13503.662408439794, 13757.380917858696, 15958.28187731552, 16281.267342969566, 17152.399666011694, 13700.725985480285, 13739.106958047745, 16666.333346666117, 16819.327226910907, 17107.657846843085, 5128.974355128219, 5261.158214685651, 5265.131253343194, 5267.26258323835, 5270.920936185941, 3917.334053210947, 4004.619561141687, 4925.7537123143875, 4995.175795993657, 5219.660722053073, 5599.832005039855, 5715.342735585398, 5743.913841292384, 5746.396628354005, 5758.625689330201, 5565.666060036411, 5716.371199168088, 5753.827385178452, 5800.100984347433, 5819.214406055213, 5222.138347172712, 5236.188390799394, 5245.632805703603, 5248.21276808478, 5249.42256351801, 20423.897880510653, 20487.69268460974, 20738.896305518378, 20820.791792082036, 20899.268525601532, 2000.2599038355756, 2010.427028296943, 2041.3671761753903, 2160.5786871560053, 2201.306588424641, 12909.54816581415, 12951.546695865694, 12980.675483112904, 13026.088173827837, 13360.265185414799, 1813.6644720726708, 1820.417466410749, 1825.8448031917303, 1839.4205825165163, 1925.1721759643349, 52090.73954630241, 55302.893942121336, 55567.72216138934, 55606.16590751142, 56045.0, 9940.25448091396, 10150.0, 10154.949225253826, 10161.339512931636, 10233.74415639615, 13146.342682865818, 13226.272555009375, 13230.73538529224, 13243.470261189444, 13273.402696878664, 6929.653517324114, 6948.131483564554, 6971.8605627887155, 7002.334778196063, 7030.54301470413, 6507.511936604774, 6558.475321974231, 6563.146790917246, 6566.1135746674545, 6614.735410583523, 4367.388565600819, 4391.5388884166705, 4394.626456751148, 4414.404055452473, 4417.734935903856, 1680.6302613425028, 1728.5160155156577, 1762.1541660003013, 1782.269269599458, 1810.5021119192063, 888.2849306308354, 903.2999425445332, 919.3518569408551, 925.1719710858878, 1032.9070383665505, 15710.214489275719, 16440.177991100398, 16712.415065472895, 16800.327986880387, 16873.493795186165, 815.4699445360444, 894.2220268366563, 902.273669695901, 925.1303774451993, 939.2673714502699, 8987.46075235488, 9389.812203756022, 9418.10527999839, 9725.805483890283, 9773.07155820196, 476005.0, 480738.0, 487738.0, 493827.0, 494090.0, 78444.60777696189, 78655.0, 79595.20404795877, 79705.20294797093, 79758.0, 1135.8580177477816, 1136.931784092957, 1146.7821113988316, 1164.941752912351, 1165.6328256599145, 15068.472603458826, 15332.0, 15518.913676042568, 15530.84469155294, 15812.209389530248, 35180.29639407146, 35302.646973530966, 35474.11314717153, 36305.45541816822, 36445.0, 44248.34509929414, 44779.62956531293, 45746.31380529361, 45789.542104578526, 45985.31022034605, 9226.723198304062, 9596.712098637052, 9629.085236902483, 9648.517574121126, 9662.855057174289, 11193.832092518456, 14379.78430323525, 16600.83399165993, 16777.664446710754, 17239.833876124056, 13391.665208369868, 13516.93241533786, 13647.931760341135, 13869.79195312051, 14078.0, 13348.666283342995, 13492.460301587827, 13716.588502344946, 14066.226357550433, 14434.350454229374, 10834.458277085956, 10959.780804383709, 14255.073420227653, 14484.85515144835, 14848.925755371587, 9337.53312334367, 9540.95229523848, 9574.04259574037, 9584.520773961414, 9696.466694331879, 10192.898071019195, 10698.465076745975, 13742.106763060368, 13787.931060345036, 14065.156090634595], "unit": "score", "name": "jquery.html", "value": 8670.447172273214}, {"lowerIsBetter": false, "replicates": [1285.0811669656193, 1466.7359875222462, 1504.1501551623328, 1637.4514537629893, 1774.485399234222, 6361.872762544746, 7652.120006199289, 7809.336206422454, 7833.882491762628, 7847.646855891484, 7164.247753985835, 7315.634218289078, 7321.158066822317, 7329.56022638642, 7330.266973302667, 1954.9511262218416, 1989.0452582760283, 1989.4827344890289, 2191.1783081344456, 2215.213599172295, 2212.3141826033902, 2243.7756224377595, 2246.898889549966, 2247.3819699582664, 2247.8763667998255, 2162.4593851537115, 2184.967225491619, 2228.1755750372386, 2228.9635319576396, 2230.3754948614414, 2171.1966572368165, 2172.6415141501634, 2200.8239340852692, 2202.493426511895, 2226.9888650556804, 2254.797068263848, 2271.2731925783755, 2302.7697230277004, 2305.4466927937174, 2309.5265470578493, 7773.144954055049, 7826.373890088779, 7846.450748447611, 7867.8033049173655, 7869.763907082796, 4513.368128462018, 4634.83778067766, 4638.1187574360765, 4639.698419602715, 4642.187617166982, 2907.9273018174713, 2919.168037109435, 2956.3496030873175, 2958.6597541282813, 3052.740517056053, 886.6054605700466, 892.1747383670144, 894.5124906925741, 898.4025622960723, 937.6624415210518, 10775.5689772409, 10799.352038877692, 10836.458177091194, 10838.40388778617, 10857.837132443019, 4098.364753463218, 4146.170765846843, 4163.646090082377, 4169.979150104291, 4187.937180942288, 9227.215686666708, 9233.030531794198, 9233.538323083952, 9247.167754902091, 9249.630014799333, 4681.250999840009, 4689.015306785614, 4689.95310046902, 4717.976410117927, 4720.433547974265, 4240.639545638655, 4264.914701705949, 4305.203537345601, 4312.504062032906, 4316.352547117957, 3060.6021217241614, 3087.876484940577, 3585.8924232273075, 3607.404778211618, 3659.7621154624862, 1171.3147808531933, 1183.1126655008743, 1183.7573297474169, 1186.4779497021455, 1190.4285942747529, 1002.9348092373972, 1019.0421004255976, 1019.0573719309609, 1128.4639796096953, 1319.459021801057, 7268.94600282956, 7299.4525410594415, 7372.115346158388, 7374.483786134919, 7378.667959941816, 1103.542030057533, 1110.5335758981248, 1126.5212284778936, 1132.4394424759796, 1137.181229514748, 5568.638038527482, 5591.384947655754, 5615.719214039282, 5625.212470254168, 5651.9152212716845, 9085.727428177166, 9099.226565741854, 9245.214156796614, 9350.812983740423, 9355.48544830041, 9105.043970383147, 9173.266138708887, 9197.678081267124, 9271.90728092724, 9273.35086543949, 7036.437085033185, 7246.202917679157, 7253.891191632129, 7304.30609092146, 7344.779656610311, 6975.790726278016, 7104.538205016657, 7107.22319420145, 7113.644317784194, 7114.253003434565, 7893.17121702213, 8051.8260069782, 8091.433599647969, 8221.424500285162, 8224.794380140544, 8113.472624279403, 8271.586420678821, 8279.172082791672, 8431.95784021076, 8433.0, 6916.308369163245, 6941.93058069433, 7001.264867188872, 7031.296870312928, 7031.964840175767, 6533.738650453929, 6657.633830139389, 7105.46708996817, 7360.07999000125, 7584.0, 6746.055552222595, 6859.794206173823, 6899.0, 6985.022096906336, 7003.649817509002, 6690.364415380531, 6704.932950670626, 6804.047433359433, 6861.519693621598, 7083.185433675193, 6893.448524118159, 6928.896066558905, 6934.029235906876, 6935.375816176568, 6940.09778728762, 6056.90914636272, 6098.207233059851, 6131.110988906495, 6133.539984501091, 6226.439620434183, 6369.1401660777055, 6382.393672601095, 6406.263279722892, 6406.423421892052, 6409.134766806422], "unit": "score", "name": "mootools.html", "value": 4386.900973578885}, {"lowerIsBetter": false, "replicates": [317.1563640715696, 319.7681680781435, 325.8761670565185, 328.40886404471945, 336.5792759051186, 5745.741441635126, 5905.498032667223, 5906.675132867691, 5925.170476133339, 5939.792107276236, 5661.207430959669, 5821.56338274629, 5832.154337621042, 5853.326867410249, 5869.7652093916295, 4516.435445569304, 4534.1385136824065, 4538.818447262105, 4548.204064288753, 4550.5449455054395, 4365.4106695596, 4384.276594361926, 4472.239719247719, 4532.9093418131615, 4537.296719008543, 4452.398926144978, 4500.987277862488, 4522.909541809162, 4544.318352247156, 4546.318052292149, 4461.866144015685, 4464.308032255006, 4469.7318160910445, 4495.190865644183, 4522.932156017662, 3966.8809935701975, 3973.4039894016128, 3977.3039718049226, 3981.1838573092446, 3994.9201015979515, 5485.61600687952, 5602.1596760485845, 5621.8594535136535, 5624.943750562524, 5666.461686139852, 5242.764075616568, 5243.632945693803, 5244.056069907415, 5244.475552444763, 5245.370555533323, 6321.115043893813, 6322.399372059647, 6323.20959880015, 6331.113644089831, 6331.430171284561, 4086.734362266443, 4167.770772607505, 4190.55999120091, 4265.189613973366, 4270.978645106786, 6462.579932304385, 6494.960806270974, 6497.18785151856, 6504.642244676541, 6510.5117116216, 4374.890627734332, 4375.934360984587, 4376.956230437719, 4381.18947994622, 4385.824567017347, 4348.782560871944, 4496.460424749051, 4501.504834468205, 4502.0, 4512.142692888407, 5176.120059589879, 5219.347581552306, 5244.606654500928, 5246.527812496894, 5253.921191182136, 6341.3341599132345, 6343.333949935282, 6355.110284560165, 6357.96821015892, 6359.713812878432, 1570.4895908829676, 1570.5916461719808, 1570.6230504679024, 1571.9292631831595, 1573.9921300393426, 1039.8492218628407, 1052.1793001458875, 1056.5245639462273, 1058.4707646176912, 1061.596593294543, 6061.424164704435, 6063.9090413643835, 6070.969645151746, 6072.666003369769, 6076.969615151985, 6464.159659244268, 6512.283648798629, 6517.055027021055, 6519.511036672268, 6531.346865313526, 6036.909446358308, 6044.304904935901, 6063.878722425615, 6065.363136870653, 6066.090086486974, 3425.3491836550975, 3552.236269202134, 3555.093451169935, 3555.626659200747, 3558.181618227822, 6701.597904125768, 6703.262641109572, 6703.832404189934, 6706.631135287606, 6713.0266111413575, 6777.356151165632, 6780.220274668378, 6780.525363224527, 6803.455723542104, 6814.386705196556, 6495.8700825983215, 6711.966440167768, 6712.295209003082, 6712.38902663367, 6725.2602213756445, 6327.96836015817, 6595.637239951849, 6615.073889655356, 6616.735330586723, 6619.271880093283, 6321.841953951188, 6407.839804004937, 6508.219013718384, 6512.934870651233, 6524.347565243438, 6655.068290439245, 6672.132622759204, 6673.9666301668185, 6675.432588229861, 6684.899726504009, 4459.152760975404, 4474.664400170065, 4508.864734057984, 4509.864704058883, 4512.25547784625, 6250.781222657185, 6452.387023232785, 6521.64130972801, 6573.901391479036, 6615.338466153346, 6410.583312084699, 6417.679116044085, 6418.743250269937, 6421.454176394872, 6427.357264273535, 6242.063690446469, 6339.5562310637815, 6398.168238129014, 6402.135711678864, 6408.61548307103, 6226.782062627786, 6250.49996000328, 6257.8748425030335, 6258.217722784652, 6269.843253918689, 6396.93603063982, 6412.621286423441, 6428.357164283721, 6433.29233784274, 6439.452646525097, 6099.725512351866, 6229.221347331583, 6250.812475625738, 6252.343503932022, 6258.342873998165], "unit": "score", "name": "prototype.html", "value": 4740.095503889499}, {"lowerIsBetter": false, "replicates": [761.5240474703311, 827.991720082799, 837.8156805502791, 847.5465625890149, 848.3382961290192, 13247.867521324795, 13400.128991615538, 13451.327433628305, 13478.3260836958, 13480.460781568738, 12778.233306001646, 12875.613731588068, 12899.968002559795, 12904.354782260896, 12973.286469244187, 608.4463138543925, 614.3303798859242, 799.400449662753, 814.3200427642926, 815.514768712615, 805.3436449293836, 810.8864758933724, 811.1401913971209, 811.3630799822141, 812.1350761439078, 643.4884267007717, 839.7606682095604, 843.582426698785, 846.7459762071354, 846.826400587881, 625.2340882419023, 826.5495305058757, 829.929455996241, 831.6423937706784, 832.4173078844833, 611.843979785152, 612.5497759147023, 613.8864310102646, 615.443024063219, 617.3733660334764, 12820.294883781387, 13218.0, 13236.073474856765, 13249.337533123402, 13271.203727776365, 11304.547818087267, 11459.541618335257, 11652.126090543159, 11732.648020559396, 12051.0, 9906.851397229048, 9925.950370248174, 9937.552810123561, 10179.89820101797, 10204.94897525515, 3632.8728494502566, 3651.94522082169, 3657.6708096271464, 3660.4509323601405, 3781.489498917666, 45756.084878302245, 46435.53564464346, 46909.29636055496, 46927.0, 47063.52936470626, 9792.412455252708, 9854.655087072062, 9923.305368624271, 9973.152282055962, 10012.299139060196, 17918.731219031724, 18130.637387252445, 18134.637307253783, 18138.818611813713, 18190.727139092924, 7730.845383092306, 7905.881411778828, 7935.960320198362, 8020.438569300093, 8093.271605555528, 4419.46966364032, 4432.889177770581, 4438.778061096932, 4516.254817955, 4561.361409402686, 2961.748251398612, 3008.3231272963844, 3010.5333673280675, 3014.261505931061, 3014.728674419313, 513.9577225124444, 526.6655673647261, 530.88851341218, 531.6252042310163, 544.7766415769515, 564.4891373307164, 623.2566896052805, 628.8742251549617, 633.5881676910045, 690.8790961581703, 8368.246857782708, 8619.827603447897, 8642.783930401665, 8811.691590794291, 8839.381243313035, 557.726713910181, 575.2981362737454, 618.888600051995, 668.2448832818884, 681.9761308354184, 3896.6687831534637, 4051.8784436466362, 4217.913904640172, 4226.281532139482, 4360.869173924724, 54033.45966540284, 54794.0, 54876.45123548793, 54954.725226373615, 55003.44996550064, 48082.27876581854, 48153.75923120432, 48567.514324856296, 49908.25137622938, 49997.75001124971, 43623.781881091025, 44740.0, 44940.3258951116, 44943.876403090835, 45286.773566132615, 8249.876251856107, 8539.444936079135, 8612.354073444641, 8894.4663320201, 8955.955220223857, 33117.33765324728, 34333.656663433045, 34464.48303275503, 34970.650293497754, 37952.0, 42968.0, 43630.0, 43869.561304386545, 45021.099578008914, 45189.54810451854, 10126.44304563256, 10328.451726795733, 10776.084032857296, 11244.325340479598, 11390.886091138982, 11991.76016479648, 12105.515779368727, 12446.25322480654, 12611.747765044463, 12781.872181278068, 11729.120315976506, 11746.471408786454, 12059.15585908978, 12139.39303034827, 12215.755684886075, 11044.889551104387, 11843.28940263587, 11917.76164476723, 12005.81991270149, 12206.206596571194, 11109.944450277697, 11202.271852329572, 11314.547418103184, 11393.715157121138, 11625.18623696333, 9221.170094691242, 9419.529023548657, 9420.387674801115, 9893.0, 9978.900210997797, 9906.900930990598, 9970.40177589347, 10043.497825108569, 10045.547950342107, 10060.798784024131], "unit": "score", "name": "yui.html", "value": 6233.014514647067}], "name": "dromaeo_css", "value": 6940.676984796318}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 104.0, 109.0, 111.0, 112.0, 100.0, 112.0, 109.0, 115.0], "unit": "score", "name": "ai-astar", "value": 109.3}, {"lowerIsBetter": true, "replicates": [157.0, 125.0, 150.0, 161.0, 131.0, 148.0, 149.0, 124.0, 169.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 143.8}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 161.0, 161.0, 160.0, 160.0, 165.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 78.0, 96.0, 72.0, 77.0, 71.0, 98.0, 91.0, 71.0], "unit": "score", "name": "audio-fft", "value": 79.7}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 136.0, 93.0, 93.0, 93.0, 140.0, 93.0, 93.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 106.3}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 65.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 67.0, 68.0, 68.0, 67.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 85.0, 85.0, 94.0, 85.0, 85.0, 85.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.1}, {"lowerIsBetter": true, "replicates": [116.0, 112.0, 119.0, 114.0, 123.0, 125.0, 126.0, 120.0, 117.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.8}, {"lowerIsBetter": true, "replicates": [144.0, 144.0, 160.0, 167.0, 155.0, 149.0, 154.0, 145.0, 164.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.4}, {"lowerIsBetter": true, "replicates": [67.0, 71.0, 68.0, 68.0, 67.0, 70.0, 66.0, 67.0, 69.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1501.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.47391749062393], "unit": "score", "name": "Richards", "value": 207.08153200000004}, {"lowerIsBetter": false, "replicates": [197.08316909735908], "unit": "score", "name": "DeltaBlue", "value": 335.48273200000006}, {"lowerIsBetter": false, "replicates": [283.4467120181406], "unit": "score", "name": "Encrypt", "value": 939.0865680000002}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [1109.8779134295228], "unit": "score", "name": "RayTrace", "value": 666.7300889999998}, {"lowerIsBetter": false, "replicates": [783.0853563038371], "unit": "score", "name": "Earley", "value": 851.0732510000003}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [26051.28205128205], "unit": "score", "name": "RegExp", "value": 34.96891240157479}, {"lowerIsBetter": false, "replicates": [677.5067750677507], "unit": "score", "name": "Splay", "value": 120.28071599999996}, {"lowerIsBetter": false, "replicates": [4892.682926829269], "unit": "score", "name": "NavierStokes", "value": 303.3100697906281}], "name": "v8_7", "value": 20623.300891709892}]} 11:14:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20623.30"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1501.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6940.68"}}} 11:14:48 INFO - Return code: 0 11:14:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:14:48 INFO - # TBPL SUCCESS # 11:14:48 INFO - Running post-action listener: _resource_record_post_action 11:14:48 INFO - Running post-run listener: _resource_record_post_run 11:14:49 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 20480; Write bytes: 558043136; Read time: 168; Write time: 473616 11:14:49 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 246079488; Read time: 0; Write time: 307172 11:14:49 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 20480; Write bytes: 311660544; Read time: 168; Write time: 166416 11:14:49 INFO - Running post-run listener: _upload_blobber_files 11:14:49 INFO - Blob upload gear active. 11:14:49 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:14:49 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:14:49 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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 11:14:49 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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 11:14:50 INFO - (blobuploader) - INFO - Open directory for files ... 11:14:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 11:14:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:14:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:51 INFO - (blobuploader) - INFO - Done attempting. 11:14:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:14:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:14:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:52 INFO - (blobuploader) - INFO - Done attempting. 11:14:52 INFO - (blobuploader) - INFO - Iteration through files over. 11:14:52 INFO - Return code: 0 11:14:52 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:14:52 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:14:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/690e21b1d07073f2d7c7214fca8a21ed155f54a8d5adf4220bc2587d38caa60eb5dd783a4c251f5e6d9eab612d850632ba5932511f1ec91982ebc6f9dcb63190", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/5f89a80dcc2cdce324f9dab85fb8b7617509a6e98979d5b603f311e6bdc3460ea1e04d0c651ca08cf0c8e4f4fa4891e2afa7ce0853fb0b6db5326a62cac513d1"} 11:14:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:14:52 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:14:52 INFO - Contents: 11:14:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/690e21b1d07073f2d7c7214fca8a21ed155f54a8d5adf4220bc2587d38caa60eb5dd783a4c251f5e6d9eab612d850632ba5932511f1ec91982ebc6f9dcb63190", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/5f89a80dcc2cdce324f9dab85fb8b7617509a6e98979d5b603f311e6bdc3460ea1e04d0c651ca08cf0c8e4f4fa4891e2afa7ce0853fb0b6db5326a62cac513d1"} 11:14:52 INFO - Copying logs to upload dir... 11:14:52 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1270.603037 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-22 11:14:51.860512) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 11:14:51.863807) ========= 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=3e14eba40af1795cf0357910000001c3-1450809091.352221-1933322949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/690e21b1d07073f2d7c7214fca8a21ed155f54a8d5adf4220bc2587d38caa60eb5dd783a4c251f5e6d9eab612d850632ba5932511f1ec91982ebc6f9dcb63190", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/5f89a80dcc2cdce324f9dab85fb8b7617509a6e98979d5b603f311e6bdc3460ea1e04d0c651ca08cf0c8e4f4fa4891e2afa7ce0853fb0b6db5326a62cac513d1"} build_url:https://queue.taskcluster.net/v1/task/IXa146OHTgC-0NX8IlwJRw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011208 build_url: 'https://queue.taskcluster.net/v1/task/IXa146OHTgC-0NX8IlwJRw/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/B2G-Inbound/sha512/690e21b1d07073f2d7c7214fca8a21ed155f54a8d5adf4220bc2587d38caa60eb5dd783a4c251f5e6d9eab612d850632ba5932511f1ec91982ebc6f9dcb63190", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/5f89a80dcc2cdce324f9dab85fb8b7617509a6e98979d5b603f311e6bdc3460ea1e04d0c651ca08cf0c8e4f4fa4891e2afa7ce0853fb0b6db5326a62cac513d1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 11:14:51.889452) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 11:14:51.889787) ========= 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=3e14eba40af1795cf0357910000001c3-1450809091.352221-1933322949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 11:14:51.973777) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 11:14:51.974146) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 11:14:51.974478) ========= ========= Total master_lag: 0.33 =========