builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-049 starttime: 1452210449.01 results: success (0) buildid: 20160107133027 builduid: e9b51c94a58f4f9c8eebc92c77198a85 revision: 5d93baf4ff9c536b15818ac839e63b42964e7ead ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:29.005615) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:29.006126) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:29.006550) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1452204769.723132-877318961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004862 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:29.055009) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:29.055290) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:29.089955) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:29.090247) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1452204769.723132-877318961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.038053 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:29.142347) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:29.142617) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:29.142981) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:29.143287) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1452204769.723132-877318961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-07 15:47:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.8M=0s 2016-01-07 15:47:29 (47.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.196556 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:29.363164) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:29.363448) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1452204769.723132-877318961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.051659 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:29.424940) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-07 15:47:29.425270) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5d93baf4ff9c536b15818ac839e63b42964e7ead --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/mozilla-inbound --rev 5d93baf4ff9c536b15818ac839e63b42964e7ead --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=8c719f637fb0c43bc4e5671e000001d0-1452204769.723132-877318961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-07 15:47:29,566 truncating revision to first 12 chars 2016-01-07 15:47:29,566 Setting DEBUG logging. 2016-01-07 15:47:29,566 attempt 1/10 2016-01-07 15:47:29,566 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/5d93baf4ff9c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-07 15:47:30,302 unpacking tar archive at: mozilla-inbound-5d93baf4ff9c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.029307 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-07 15:47:30.466011) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:30.466316) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:30.474307) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:30.474589) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:30.475015) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-07 15:47:30.475302) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-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=8c719f637fb0c43bc4e5671e000001d0-1452204769.723132-877318961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:47:30 INFO - MultiFileLogger online at 20160107 15:47:30 in /builds/slave/test-pgo 15:47:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 15:47:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:47:30 INFO - {'append_to_log': False, 15:47:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:47:30 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:47:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:47:30 INFO - 'branch': 'Mozilla-Inbound', 15:47:30 INFO - 'buildbot_json_path': 'buildprops.json', 15:47:30 INFO - 'config_files': ('talos/linux_config.py',), 15:47:30 INFO - 'default_actions': ('clobber', 15:47:30 INFO - 'read-buildbot-config', 15:47:30 INFO - 'download-and-extract', 15:47:30 INFO - 'populate-webroot', 15:47:30 INFO - 'create-virtualenv', 15:47:30 INFO - 'install', 15:47:30 INFO - 'run-tests'), 15:47:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:47:30 INFO - 'download_minidump_stackwalk': True, 15:47:30 INFO - 'download_symbols': 'ondemand', 15:47:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:47:30 INFO - 'tooltool.py': '/tools/tooltool.py', 15:47:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:47:30 INFO - '/tools/misc-python/virtualenv.py')}, 15:47:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:47:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:47:30 INFO - 'installer_path': 'installer.exe', 15:47:30 INFO - 'log_level': 'info', 15:47:30 INFO - 'log_name': 'talos', 15:47:30 INFO - 'log_to_console': True, 15:47:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:47:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:47:30 INFO - 'opt_config_files': (), 15:47:30 INFO - 'pip_index': False, 15:47:30 INFO - 'sps_profile': False, 15:47:30 INFO - 'sps_profile_interval': 0, 15:47:30 INFO - 'suite': 'dromaeojs-e10s', 15:47:30 INFO - 'system_bits': '32', 15:47:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:47:30 INFO - 'title': 'talos-linux64-ix-049', 15:47:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:47:30 INFO - 'use_talos_json': True, 15:47:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:47:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:47:30 INFO - 'work_dir': 'build'} 15:47:30 INFO - ##### 15:47:30 INFO - ##### Running clobber step. 15:47:30 INFO - ##### 15:47:30 INFO - Running pre-action listener: _resource_record_pre_action 15:47:30 INFO - Running main action method: clobber 15:47:30 INFO - rmtree: /builds/slave/test-pgo/build 15:47:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:47:31 INFO - Running post-action listener: _resource_record_post_action 15:47:31 INFO - ##### 15:47:31 INFO - ##### Running read-buildbot-config step. 15:47:31 INFO - ##### 15:47:31 INFO - Running pre-action listener: _resource_record_pre_action 15:47:31 INFO - Running main action method: read_buildbot_config 15:47:31 INFO - Using buildbot properties: 15:47:31 INFO - { 15:47:31 INFO - "project": "", 15:47:31 INFO - "product": "firefox", 15:47:31 INFO - "script_repo_revision": "production", 15:47:31 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 15:47:31 INFO - "repository": "", 15:47:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 15:47:31 INFO - "buildid": "20160107133027", 15:47:31 INFO - "pgo_build": "True", 15:47:31 INFO - "basedir": "/builds/slave/test-pgo", 15:47:31 INFO - "buildnumber": 291, 15:47:31 INFO - "slavename": "talos-linux64-ix-049", 15:47:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:47:31 INFO - "platform": "ubuntu64_hw", 15:47:31 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 15:47:31 INFO - "branch": "mozilla-inbound", 15:47:31 INFO - "repo_path": "integration/mozilla-inbound", 15:47:31 INFO - "revision": "5d93baf4ff9c536b15818ac839e63b42964e7ead", 15:47:31 INFO - "stage_platform": "linux64-pgo", 15:47:31 INFO - "builduid": "e9b51c94a58f4f9c8eebc92c77198a85", 15:47:31 INFO - "slavebuilddir": "test" 15:47:31 INFO - } 15:47:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 15:47:31 INFO - Running post-action listener: _resource_record_post_action 15:47:31 INFO - ##### 15:47:31 INFO - ##### Running download-and-extract step. 15:47:31 INFO - ##### 15:47:31 INFO - Running pre-action listener: _resource_record_pre_action 15:47:31 INFO - Running main action method: download_and_extract 15:47:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:31 INFO - https://queue.taskcluster.net/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:47:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/test_packages.json 15:47:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/test_packages.json 15:47:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:47:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:47:32 INFO - Downloaded 1302 bytes. 15:47:32 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:47:32 INFO - Using the following test package requirements: 15:47:32 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:47:32 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:47:32 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:32 INFO - u'jsshell-linux-x86_64.zip'], 15:47:32 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:47:32 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:47:32 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:47:32 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:47:32 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:47:32 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:47:32 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:47:32 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:47:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:32 INFO - https://queue.taskcluster.net/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:47:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:47:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:47:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:47:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:47:33 INFO - Downloaded 24067193 bytes. 15:47:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 15:47:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:47:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:47:34 INFO - Return code: 0 15:47:34 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:47:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:34 INFO - https://queue.taskcluster.net/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:47:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:47:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:47:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:47:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:47:38 INFO - Downloaded 24067193 bytes. 15:47:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 15:47:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:47:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:47:40 INFO - Return code: 0 15:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:40 INFO - https://queue.taskcluster.net/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:47:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:47:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:47:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:47:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:47:41 INFO - Downloaded 11132285 bytes. 15:47:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 15:47:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:47:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 15:47:41 INFO - Return code: 0 15:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:41 INFO - https://queue.taskcluster.net/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:47:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:47:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:47:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:47:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:47:43 INFO - Downloaded 55961013 bytes. 15:47:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:47:43 INFO - mkdir: /builds/slave/test-pgo/properties 15:47:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:47:43 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:47:43 INFO - Contents: 15:47:43 INFO - build_url:https://queue.taskcluster.net/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:47:43 INFO - Running post-action listener: _resource_record_post_action 15:47:43 INFO - Running post-action listener: set_extra_try_arguments 15:47:43 INFO - ##### 15:47:43 INFO - ##### Running populate-webroot step. 15:47:43 INFO - ##### 15:47:43 INFO - Running pre-action listener: _resource_record_pre_action 15:47:43 INFO - Running main action method: populate_webroot 15:47:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:47:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:47:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:47:43 INFO - '--tppagecycles', 15:47:43 INFO - '7'], 15:47:43 INFO - 'tests': ['tsvgm']}}, 15:47:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:47:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:47:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:47:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:47:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:47:43 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:47:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:47:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:43 INFO - 'talos_options': ['--e10s'], 15:47:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:47:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:43 INFO - 'tests': ['damp', 'tps']}, 15:47:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:43 INFO - 'talos_options': ['--e10s'], 15:47:43 INFO - 'tests': ['damp', 'tps']}, 15:47:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:47:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:47:43 INFO - 'other': {'tests': ['a11yr', 15:47:43 INFO - 'ts_paint', 15:47:43 INFO - 'tpaint', 15:47:43 INFO - 'sessionrestore', 15:47:43 INFO - 'sessionrestore_no_auto_restore']}, 15:47:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:47:43 INFO - 'tests': ['a11yr', 15:47:43 INFO - 'ts_paint', 15:47:43 INFO - 'tpaint', 15:47:43 INFO - 'sessionrestore', 15:47:43 INFO - 'sessionrestore_no_auto_restore']}, 15:47:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:47:43 INFO - 'tests': ['a11yr', 15:47:43 INFO - 'ts_paint', 15:47:43 INFO - 'tpaint', 15:47:43 INFO - 'sessionrestore', 15:47:43 INFO - 'sessionrestore_no_auto_restore']}, 15:47:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:47:43 INFO - 'tests': ['a11yr', 15:47:43 INFO - 'ts_paint', 15:47:43 INFO - 'tpaint', 15:47:43 INFO - 'sessionrestore', 15:47:43 INFO - 'sessionrestore_no_auto_restore']}, 15:47:43 INFO - 'other_l64': {'tests': ['a11yr', 15:47:43 INFO - 'ts_paint', 15:47:43 INFO - 'tpaint', 15:47:43 INFO - 'sessionrestore', 15:47:43 INFO - 'sessionrestore_no_auto_restore']}, 15:47:43 INFO - 'other_nol64': {'tests': ['a11yr', 15:47:43 INFO - 'ts_paint', 15:47:43 INFO - 'tpaint', 15:47:43 INFO - 'sessionrestore', 15:47:43 INFO - 'sessionrestore_no_auto_restore']}, 15:47:43 INFO - 'svgr': {'tests': ['tsvgx', 15:47:43 INFO - 'tsvgr_opacity', 15:47:43 INFO - 'tart', 15:47:43 INFO - 'tscrollx', 15:47:43 INFO - 'cart']}, 15:47:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:47:43 INFO - 'tests': ['tsvgx', 15:47:43 INFO - 'tsvgr_opacity', 15:47:43 INFO - 'tart', 15:47:43 INFO - 'tscrollx', 15:47:43 INFO - 'cart']}, 15:47:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:43 INFO - 'tests': ['tp5o']}, 15:47:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:43 INFO - 'talos_options': ['--e10s'], 15:47:43 INFO - 'tests': ['tp5o']}, 15:47:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:43 INFO - 'talos_options': ['--xperf_path', 15:47:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:47:43 INFO - 'tests': ['tp5n']}, 15:47:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:43 INFO - 'talos_options': ['--e10s', 15:47:43 INFO - '--xperf_path', 15:47:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:47:43 INFO - 'tests': ['tp5n']}}, 15:47:43 INFO - 'talos.zip': {'path': '', 15:47:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:47:43 INFO - Running post-action listener: _resource_record_post_action 15:47:43 INFO - ##### 15:47:43 INFO - ##### Running create-virtualenv step. 15:47:43 INFO - ##### 15:47:43 INFO - Running pre-action listener: _resource_record_pre_action 15:47:43 INFO - Running main action method: create_virtualenv 15:47:43 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:47:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 15:47:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:47:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:47:43 INFO - Using real prefix '/usr' 15:47:43 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:47:44 INFO - Installing distribute.............................................................................................................................................................................................done. 15:47:46 INFO - Installing pip.................done. 15:47:46 INFO - Return code: 0 15:47:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:47:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:46 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 0x7f89babd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe27230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb97f0>, '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 0xe252d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe25760>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452204769.723132-877318961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:47:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 15:47:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:47:46 INFO - Using env: {'DISPLAY': ':0', 15:47:46 INFO - 'HOME': '/home/cltbld', 15:47:46 INFO - 'LANG': 'en_US.UTF-8', 15:47:46 INFO - 'LANGUAGE': 'en_US:en', 15:47:46 INFO - 'LOGNAME': 'cltbld', 15:47:46 INFO - 'MAIL': '/var/mail/cltbld', 15:47:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:46 INFO - 'MOZ_NO_REMOTE': '1', 15:47:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:46 INFO - 'NO_EM_RESTART': '1', 15:47:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:46 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:46 INFO - 'SHELL': '/bin/bash', 15:47:46 INFO - 'SHLVL': '1', 15:47:46 INFO - 'TERM': 'linux', 15:47:46 INFO - 'TMOUT': '86400', 15:47:46 INFO - 'USER': 'cltbld', 15:47:46 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452204769.723132-877318961', 15:47:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:46 INFO - '_': '/tools/buildbot/bin/python'} 15:47:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:47:47 INFO - Cleaning up... 15:47:47 INFO - Return code: 0 15:47:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:47 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 0x7f89babd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe27230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb97f0>, '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 0xe252d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe25760>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452204769.723132-877318961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:47:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 15:47:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:47:47 INFO - Using env: {'DISPLAY': ':0', 15:47:47 INFO - 'HOME': '/home/cltbld', 15:47:47 INFO - 'LANG': 'en_US.UTF-8', 15:47:47 INFO - 'LANGUAGE': 'en_US:en', 15:47:47 INFO - 'LOGNAME': 'cltbld', 15:47:47 INFO - 'MAIL': '/var/mail/cltbld', 15:47:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:47 INFO - 'MOZ_NO_REMOTE': '1', 15:47:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:47 INFO - 'NO_EM_RESTART': '1', 15:47:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:47 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:47 INFO - 'SHELL': '/bin/bash', 15:47:47 INFO - 'SHLVL': '1', 15:47:47 INFO - 'TERM': 'linux', 15:47:47 INFO - 'TMOUT': '86400', 15:47:47 INFO - 'USER': 'cltbld', 15:47:47 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452204769.723132-877318961', 15:47:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:47 INFO - '_': '/tools/buildbot/bin/python'} 15:47:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:47 INFO - Downloading/unpacking psutil>=0.7.1 15:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:49 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 15:47:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:47:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:47:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:47:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:47:49 INFO - Installing collected packages: psutil 15:47:49 INFO - Running setup.py install for psutil 15:47:49 INFO - building 'psutil._psutil_linux' extension 15:47:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:47:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:47:50 INFO - building 'psutil._psutil_posix' extension 15:47:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:47:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:47:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:47:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:47:50 INFO - Successfully installed psutil 15:47:50 INFO - Cleaning up... 15:47:50 INFO - Return code: 0 15:47:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:47: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')]} 15:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47: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')]} 15:47:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:50 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 0x7f89babd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe27230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb97f0>, '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 0xe252d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe25760>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452204769.723132-877318961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:47:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 15:47:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:47:50 INFO - Using env: {'DISPLAY': ':0', 15:47:50 INFO - 'HOME': '/home/cltbld', 15:47:50 INFO - 'LANG': 'en_US.UTF-8', 15:47:50 INFO - 'LANGUAGE': 'en_US:en', 15:47:50 INFO - 'LOGNAME': 'cltbld', 15:47:50 INFO - 'MAIL': '/var/mail/cltbld', 15:47:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:50 INFO - 'MOZ_NO_REMOTE': '1', 15:47:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:50 INFO - 'NO_EM_RESTART': '1', 15:47:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:50 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:50 INFO - 'SHELL': '/bin/bash', 15:47:50 INFO - 'SHLVL': '1', 15:47:50 INFO - 'TERM': 'linux', 15:47:50 INFO - 'TMOUT': '86400', 15:47:50 INFO - 'USER': 'cltbld', 15:47:50 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452204769.723132-877318961', 15:47:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:50 INFO - '_': '/tools/buildbot/bin/python'} 15:47:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:47:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:47:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:47:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:47:52 INFO - Installing collected packages: mozsystemmonitor 15:47:52 INFO - Running setup.py install for mozsystemmonitor 15:47:52 INFO - Successfully installed mozsystemmonitor 15:47:52 INFO - Cleaning up... 15:47:52 INFO - Return code: 0 15:47:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:52 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 0x7f89babd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe27230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb97f0>, '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 0xe252d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe25760>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452204769.723132-877318961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:47:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 15:47:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:47:52 INFO - Using env: {'DISPLAY': ':0', 15:47:52 INFO - 'HOME': '/home/cltbld', 15:47:52 INFO - 'LANG': 'en_US.UTF-8', 15:47:52 INFO - 'LANGUAGE': 'en_US:en', 15:47:52 INFO - 'LOGNAME': 'cltbld', 15:47:52 INFO - 'MAIL': '/var/mail/cltbld', 15:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:52 INFO - 'MOZ_NO_REMOTE': '1', 15:47:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:52 INFO - 'NO_EM_RESTART': '1', 15:47:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:52 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:52 INFO - 'SHELL': '/bin/bash', 15:47:52 INFO - 'SHLVL': '1', 15:47:52 INFO - 'TERM': 'linux', 15:47:52 INFO - 'TMOUT': '86400', 15:47:52 INFO - 'USER': 'cltbld', 15:47:52 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452204769.723132-877318961', 15:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:52 INFO - '_': '/tools/buildbot/bin/python'} 15:47:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:53 INFO - Downloading/unpacking blobuploader==1.2.4 15:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:54 INFO - Downloading blobuploader-1.2.4.tar.gz 15:47:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:47:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:47:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:47:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:47:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:55 INFO - Downloading docopt-0.6.1.tar.gz 15:47:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:47:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:47:55 INFO - Installing collected packages: blobuploader, requests, docopt 15:47:55 INFO - Running setup.py install for blobuploader 15:47:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:47:55 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:47:55 INFO - Running setup.py install for requests 15:47:56 INFO - Running setup.py install for docopt 15:47:56 INFO - Successfully installed blobuploader requests docopt 15:47:56 INFO - Cleaning up... 15:47:56 INFO - Return code: 0 15:47:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f89babd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe27230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb97f0>, '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 0xe252d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe25760>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452204769.723132-877318961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:47:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 15:47:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:47:56 INFO - Using env: {'DISPLAY': ':0', 15:47:56 INFO - 'HOME': '/home/cltbld', 15:47:56 INFO - 'LANG': 'en_US.UTF-8', 15:47:56 INFO - 'LANGUAGE': 'en_US:en', 15:47:56 INFO - 'LOGNAME': 'cltbld', 15:47:56 INFO - 'MAIL': '/var/mail/cltbld', 15:47:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:56 INFO - 'MOZ_NO_REMOTE': '1', 15:47:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:56 INFO - 'NO_EM_RESTART': '1', 15:47:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:56 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:56 INFO - 'SHELL': '/bin/bash', 15:47:56 INFO - 'SHLVL': '1', 15:47:56 INFO - 'TERM': 'linux', 15:47:56 INFO - 'TMOUT': '86400', 15:47:56 INFO - 'USER': 'cltbld', 15:47:56 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452204769.723132-877318961', 15:47:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:56 INFO - '_': '/tools/buildbot/bin/python'} 15:47:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:47:56 INFO - Running setup.py (path:/tmp/pip-eapAUS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:47:56 INFO - Running setup.py (path:/tmp/pip-eUFldO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:47:56 INFO - Running setup.py (path:/tmp/pip-pQjYUV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:47:56 INFO - Running setup.py (path:/tmp/pip-pgdiQn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:47:56 INFO - Running setup.py (path:/tmp/pip-K1rDFC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:47:56 INFO - Running setup.py (path:/tmp/pip-9lZrW3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:47:56 INFO - Running setup.py (path:/tmp/pip-SstUV6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:47:56 INFO - Running setup.py (path:/tmp/pip-llJY1A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:47:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:47:56 INFO - Running setup.py (path:/tmp/pip-N3Zns3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:47:57 INFO - Running setup.py (path:/tmp/pip-lVE27P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:47:57 INFO - Running setup.py (path:/tmp/pip-kVHeLe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:47:57 INFO - Running setup.py (path:/tmp/pip-U5zKXV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:47:57 INFO - Running setup.py (path:/tmp/pip-F94t4S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:47:57 INFO - Running setup.py (path:/tmp/pip-l0lvNZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:47:57 INFO - Running setup.py (path:/tmp/pip-jsrMDp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:47:57 INFO - Running setup.py (path:/tmp/pip-epR4g1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:47:57 INFO - Running setup.py (path:/tmp/pip-OZuR8B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:47:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:47:57 INFO - Running setup.py install for manifestparser 15:47:57 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:47:57 INFO - Running setup.py install for mozcrash 15:47:57 INFO - Running setup.py install for mozdebug 15:47:57 INFO - Running setup.py install for mozdevice 15:47:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:47:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:47:58 INFO - Running setup.py install for mozfile 15:47:58 INFO - Running setup.py install for mozhttpd 15:47:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:47:58 INFO - Running setup.py install for mozinfo 15:47:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:47:58 INFO - Running setup.py install for mozInstall 15:47:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:47:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:47:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:47:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:47:58 INFO - Running setup.py install for mozleak 15:47:58 INFO - Running setup.py install for mozlog 15:47:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:47:58 INFO - Running setup.py install for moznetwork 15:47:58 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:47:58 INFO - Running setup.py install for mozprocess 15:47:58 INFO - Running setup.py install for mozprofile 15:47:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:47:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:47:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:47:58 INFO - Running setup.py install for mozrunner 15:47:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:47:59 INFO - Running setup.py install for mozscreenshot 15:47:59 INFO - Running setup.py install for moztest 15:47:59 INFO - Running setup.py install for mozversion 15:47:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:47:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:47:59 INFO - Cleaning up... 15:47:59 INFO - Return code: 0 15:47:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f89babd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe27230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb97f0>, '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 0xe252d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe25760>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452204769.723132-877318961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:47:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 15:47:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:47:59 INFO - Using env: {'DISPLAY': ':0', 15:47:59 INFO - 'HOME': '/home/cltbld', 15:47:59 INFO - 'LANG': 'en_US.UTF-8', 15:47:59 INFO - 'LANGUAGE': 'en_US:en', 15:47:59 INFO - 'LOGNAME': 'cltbld', 15:47:59 INFO - 'MAIL': '/var/mail/cltbld', 15:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:59 INFO - 'MOZ_NO_REMOTE': '1', 15:47:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:59 INFO - 'NO_EM_RESTART': '1', 15:47:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:59 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:59 INFO - 'SHELL': '/bin/bash', 15:47:59 INFO - 'SHLVL': '1', 15:47:59 INFO - 'TERM': 'linux', 15:47:59 INFO - 'TMOUT': '86400', 15:47:59 INFO - 'USER': 'cltbld', 15:47:59 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452204769.723132-877318961', 15:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:59 INFO - '_': '/tools/buildbot/bin/python'} 15:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:47:59 INFO - Running setup.py (path:/tmp/pip-5alA2C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:47:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 15:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:47:59 INFO - Running setup.py (path:/tmp/pip-bA5oWy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:47:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:47:59 INFO - Running setup.py (path:/tmp/pip-QwjutG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:47:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 15:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:47:59 INFO - Running setup.py (path:/tmp/pip-_r9OBx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:47:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:47:59 INFO - Running setup.py (path:/tmp/pip-amVgl6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:47:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 15:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:47:59 INFO - Running setup.py (path:/tmp/pip-fkxME6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 15:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:48:00 INFO - Running setup.py (path:/tmp/pip-uZ93Pc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 15:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:48:00 INFO - Running setup.py (path:/tmp/pip-0GvNSH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 15:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:48:00 INFO - Running setup.py (path:/tmp/pip-VVDRe3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 15:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:48:00 INFO - Running setup.py (path:/tmp/pip-0kl1Hb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:48:00 INFO - Running setup.py (path:/tmp/pip-vY76aO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 15:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:48:00 INFO - Running setup.py (path:/tmp/pip-4Bb2Ho-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 15:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:48:00 INFO - Running setup.py (path:/tmp/pip-lLS3Jf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 15:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:48:00 INFO - Running setup.py (path:/tmp/pip-b9VwP3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 15:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:48:00 INFO - Running setup.py (path:/tmp/pip-SGH5va-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 15:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:48:00 INFO - Running setup.py (path:/tmp/pip-1qVMEp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 15:48:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:48:00 INFO - Running setup.py (path:/tmp/pip-OSFymF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 15:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 15:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:48:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:48:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:02 INFO - Downloading blessings-1.5.1.tar.gz 15:48:02 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 15:48:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:48:02 INFO - Installing collected packages: blessings 15:48:02 INFO - Running setup.py install for blessings 15:48:02 INFO - Successfully installed blessings 15:48:02 INFO - Cleaning up... 15:48:02 INFO - Return code: 0 15:48:02 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:48:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:48:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:48:03 INFO - Reading from file tmpfile_stdout 15:48:03 INFO - Current package versions: 15:48:03 INFO - argparse == 1.2.1 15:48:03 INFO - blessings == 1.5.1 15:48:03 INFO - blobuploader == 1.2.4 15:48:03 INFO - docopt == 0.6.1 15:48:03 INFO - manifestparser == 1.1 15:48:03 INFO - mozInstall == 1.12 15:48:03 INFO - mozcrash == 0.16 15:48:03 INFO - mozdebug == 0.1 15:48:03 INFO - mozdevice == 0.47 15:48:03 INFO - mozfile == 1.2 15:48:03 INFO - mozhttpd == 0.7 15:48:03 INFO - mozinfo == 0.9 15:48:03 INFO - mozleak == 0.1 15:48:03 INFO - mozlog == 3.1 15:48:03 INFO - moznetwork == 0.27 15:48:03 INFO - mozprocess == 0.22 15:48:03 INFO - mozprofile == 0.28 15:48:03 INFO - mozrunner == 6.11 15:48:03 INFO - mozscreenshot == 0.1 15:48:03 INFO - mozsystemmonitor == 0.0 15:48:03 INFO - moztest == 0.7 15:48:03 INFO - mozversion == 1.4 15:48:03 INFO - psutil == 3.1.1 15:48:03 INFO - requests == 1.2.3 15:48:03 INFO - wsgiref == 0.1.2 15:48:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f89babd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe27230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb97f0>, '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 0xe252d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe25760>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452204769.723132-877318961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 15:48:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:48:03 INFO - Using env: {'DISPLAY': ':0', 15:48:03 INFO - 'HOME': '/home/cltbld', 15:48:03 INFO - 'LANG': 'en_US.UTF-8', 15:48:03 INFO - 'LANGUAGE': 'en_US:en', 15:48:03 INFO - 'LOGNAME': 'cltbld', 15:48:03 INFO - 'MAIL': '/var/mail/cltbld', 15:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:03 INFO - 'MOZ_NO_REMOTE': '1', 15:48:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:03 INFO - 'NO_EM_RESTART': '1', 15:48:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:48:03 INFO - 'PWD': '/builds/slave/test-pgo', 15:48:03 INFO - 'SHELL': '/bin/bash', 15:48:03 INFO - 'SHLVL': '1', 15:48:03 INFO - 'TERM': 'linux', 15:48:03 INFO - 'TMOUT': '86400', 15:48:03 INFO - 'USER': 'cltbld', 15:48:03 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452204769.723132-877318961', 15:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:03 INFO - '_': '/tools/buildbot/bin/python'} 15:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 15:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 15:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 15:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 15:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 15:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 15:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 15:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 15:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 15:48:03 INFO - Cleaning up... 15:48:03 INFO - Return code: 0 15:48:03 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f89babd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe27230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb97f0>, '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 0xe252d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe25760>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452204769.723132-877318961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 15:48: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 jsonschema 15:48:03 INFO - Using env: {'DISPLAY': ':0', 15:48:03 INFO - 'HOME': '/home/cltbld', 15:48:03 INFO - 'LANG': 'en_US.UTF-8', 15:48:03 INFO - 'LANGUAGE': 'en_US:en', 15:48:03 INFO - 'LOGNAME': 'cltbld', 15:48:03 INFO - 'MAIL': '/var/mail/cltbld', 15:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:03 INFO - 'MOZ_NO_REMOTE': '1', 15:48:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:03 INFO - 'NO_EM_RESTART': '1', 15:48:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:48:03 INFO - 'PWD': '/builds/slave/test-pgo', 15:48:03 INFO - 'SHELL': '/bin/bash', 15:48:03 INFO - 'SHLVL': '1', 15:48:03 INFO - 'TERM': 'linux', 15:48:03 INFO - 'TMOUT': '86400', 15:48:03 INFO - 'USER': 'cltbld', 15:48:03 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452204769.723132-877318961', 15:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:03 INFO - '_': '/tools/buildbot/bin/python'} 15:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:03 INFO - Downloading/unpacking jsonschema 15:48: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 15:48: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 15:48: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 15:48: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 15:48: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 15:48: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 15:48:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:48:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 15:48:05 INFO - Downloading/unpacking functools32 (from jsonschema) 15:48: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 15:48: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 15:48: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 15:48: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 15:48: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 15:48: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 15:48:05 INFO - Downloading functools32-3.2.3-2.tar.gz 15:48:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 15:48:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:48:05 INFO - warning: no files found matching '*.txt' 15:48:05 INFO - no previously-included directories found matching 'build' 15:48:05 INFO - no previously-included directories found matching 'dist' 15:48:05 INFO - no previously-included directories found matching '.git*' 15:48:05 INFO - Installing collected packages: jsonschema, functools32 15:48:05 INFO - Running setup.py install for functools32 15:48:05 INFO - warning: no files found matching '*.txt' 15:48:05 INFO - no previously-included directories found matching 'build' 15:48:05 INFO - no previously-included directories found matching 'dist' 15:48:05 INFO - no previously-included directories found matching '.git*' 15:48:05 INFO - Successfully installed jsonschema functools32 15:48:05 INFO - Cleaning up... 15:48:05 INFO - Return code: 0 15:48:05 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:05 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 0x7f89babd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe27230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb97f0>, '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 0xe252d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe25760>, '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': '8c719f637fb0c43bc4e5671e000001d0-1452204769.723132-877318961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 15:48:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:48:05 INFO - Using env: {'DISPLAY': ':0', 15:48:05 INFO - 'HOME': '/home/cltbld', 15:48:05 INFO - 'LANG': 'en_US.UTF-8', 15:48:05 INFO - 'LANGUAGE': 'en_US:en', 15:48:05 INFO - 'LOGNAME': 'cltbld', 15:48:05 INFO - 'MAIL': '/var/mail/cltbld', 15:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:05 INFO - 'MOZ_NO_REMOTE': '1', 15:48:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:05 INFO - 'NO_EM_RESTART': '1', 15:48:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:48:05 INFO - 'PWD': '/builds/slave/test-pgo', 15:48:05 INFO - 'SHELL': '/bin/bash', 15:48:05 INFO - 'SHLVL': '1', 15:48:05 INFO - 'TERM': 'linux', 15:48:05 INFO - 'TMOUT': '86400', 15:48:05 INFO - 'USER': 'cltbld', 15:48:05 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452204769.723132-877318961', 15:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:05 INFO - '_': '/tools/buildbot/bin/python'} 15:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:05 INFO - Downloading/unpacking flake8 15:48: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 15:48: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 15:48: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 15:48: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 15:48: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 15:48: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 15:48:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:48:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 15:48:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:48:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 15:48:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 15:48:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 15:48:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:48:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:48:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:48:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:48:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:48:08 INFO - no previously-included directories found matching 'docs/_build' 15:48:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:48:08 INFO - Running setup.py install for pep8 15:48:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:48:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:48:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:48:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:48:08 INFO - no previously-included directories found matching 'docs/_build' 15:48:08 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:48:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:48:08 INFO - Cleaning up... 15:48:08 INFO - Return code: 0 15:48:08 INFO - Running post-action listener: _resource_record_post_action 15:48:08 INFO - Running post-action listener: _start_resource_monitoring 15:48:08 INFO - Starting resource monitoring. 15:48:08 INFO - ##### 15:48:08 INFO - ##### Running install step. 15:48:08 INFO - ##### 15:48:08 INFO - Running pre-action listener: _resource_record_pre_action 15:48:08 INFO - Running main action method: install 15:48:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:48:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:48:08 INFO - Reading from file tmpfile_stdout 15:48:08 INFO - Detecting whether we're running mozinstall >=1.0... 15:48:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:48:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:48:08 INFO - Reading from file tmpfile_stdout 15:48:08 INFO - Output received: 15:48:08 INFO - Usage: mozinstall [options] installer 15:48:08 INFO - Options: 15:48:08 INFO - -h, --help show this help message and exit 15:48:08 INFO - -d DEST, --destination=DEST 15:48:08 INFO - Directory to install application into. [default: 15:48:08 INFO - "/builds/slave/test-pgo"] 15:48:08 INFO - --app=APP Application being installed. [default: firefox] 15:48:08 INFO - mkdir: /builds/slave/test-pgo/build/application 15:48:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 15:48:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 15:48:25 INFO - Reading from file tmpfile_stdout 15:48:25 INFO - Output received: 15:48:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:48:25 INFO - Running post-action listener: _resource_record_post_action 15:48:25 INFO - ##### 15:48:25 INFO - ##### Running run-tests step. 15:48:25 INFO - ##### 15:48:25 INFO - Running pre-action listener: _resource_record_pre_action 15:48:25 INFO - Running main action method: run_tests 15:48:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:48:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:48:25 INFO - Python 2.7.3 15:48:25 INFO - Return code: 0 15:48:25 INFO - grabbing minidump binary from tooltool 15:48:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:25 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 0xeb97f0>, '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 0xe252d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe25760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:48:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 15:48:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:48:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:48:25 INFO - Return code: 0 15:48:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:48:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:48:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:48:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:48:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:48:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 15:48:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 15:48:26 INFO - Return code: 0 15:48:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 15:48:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:48:26 INFO - Using env: {'DISPLAY': ':0', 15:48:26 INFO - 'HOME': '/home/cltbld', 15:48:26 INFO - 'LANG': 'en_US.UTF-8', 15:48:26 INFO - 'LANGUAGE': 'en_US:en', 15:48:26 INFO - 'LOGNAME': 'cltbld', 15:48:26 INFO - 'MAIL': '/var/mail/cltbld', 15:48:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:48:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:26 INFO - 'MOZ_NO_REMOTE': '1', 15:48:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:48:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:26 INFO - 'NO_EM_RESTART': '1', 15:48:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:48:26 INFO - 'PWD': '/builds/slave/test-pgo', 15:48:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:48:26 INFO - 'SHELL': '/bin/bash', 15:48:26 INFO - 'SHLVL': '1', 15:48:26 INFO - 'TERM': 'linux', 15:48:26 INFO - 'TMOUT': '86400', 15:48:26 INFO - 'USER': 'cltbld', 15:48:26 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452204769.723132-877318961', 15:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:26 INFO - '_': '/tools/buildbot/bin/python'} 15:48:26 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:48:26 INFO - mozversion application_buildid: 20160107133027 15:48:26 INFO - mozversion application_changeset: 5d93baf4ff9c536b15818ac839e63b42964e7ead 15:48:26 INFO - mozversion application_display_name: Nightly 15:48:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:48:26 INFO - mozversion application_name: Firefox 15:48:26 INFO - mozversion application_remotingname: firefox 15:48:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:48:26 INFO - mozversion application_vendor: Mozilla 15:48:26 INFO - mozversion application_version: 46.0a1 15:48:26 INFO - mozversion platform_buildid: 20160107133027 15:48:26 INFO - mozversion platform_changeset: 5d93baf4ff9c536b15818ac839e63b42964e7ead 15:48:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:48:26 INFO - mozversion platform_version: 46.0a1 15:48:26 INFO - using testdate: 1452210506 15:48:26 INFO - actual date: 1452210506 15:48:26 INFO - starting webserver on 'localhost:44182' 15:48:26 INFO - SUITE-START | Running 3 tests 15:48:26 INFO - TEST-START | dromaeo_css 15:48:26 INFO - operating with platform_type : linux_ 15:48:26 INFO - Initialising browser for dromaeo_css test... 15:48:26 INFO - TEST-INFO | started process 3312 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp17w422/profile http://localhost:44182/getInfo.html) 15:48:31 INFO - PROCESS | 3312 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 15:48:33 INFO - PROCESS | 3312 | __metrics Screen width/height:1600/1200 15:48:33 INFO - PROCESS | 3312 | colorDepth:24 15:48:33 INFO - PROCESS | 3312 | Browser inner width/height: 1024/697 15:48:33 INFO - PROCESS | 3312 | __metrics 15:48:33 INFO - PROCESS | 3312 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:48:34 INFO - TEST-INFO | 3312: exit 0 15:48:34 INFO - Browser initialized. 15:48:34 INFO - Running cycle 1/1 for dromaeo_css test... 15:48:34 INFO - TEST-INFO | started process 3449 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp17w422/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:48:46 INFO - PROCESS | 3449 | RSS: Main: 150487040 15:48:46 INFO - PROCESS | 3449 | 15:49:36 INFO - PROCESS | 3449 | 1452210576234 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:51:44 INFO - PROCESS | 3449 | Cycle 1(1): loaded http://localhost:44182/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44182/tests/dromaeo/cssquery-ext.html) 15:51:45 INFO - PROCESS | 3449 | RSS: Main: 159248384 15:51:45 INFO - PROCESS | 3449 | 15:54:48 INFO - PROCESS | 3449 | Cycle 1(1): loaded http://localhost:44182/tests/dromaeo/cssquery-ext.html (next: http://localhost:44182/tests/dromaeo/cssquery-jquery.html) 15:54:48 INFO - PROCESS | 3449 | RSS: Main: 155820032 15:54:48 INFO - PROCESS | 3449 | 15:57:50 INFO - PROCESS | 3449 | Cycle 1(1): loaded http://localhost:44182/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44182/tests/dromaeo/cssquery-mootools.html) 15:57:51 INFO - PROCESS | 3449 | RSS: Main: 153288704 15:57:51 INFO - PROCESS | 3449 | 16:00:52 INFO - PROCESS | 3449 | Cycle 1(1): loaded http://localhost:44182/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44182/tests/dromaeo/cssquery-prototype.html) 16:00:53 INFO - PROCESS | 3449 | RSS: Main: 152399872 16:00:53 INFO - PROCESS | 3449 | 16:03:55 INFO - PROCESS | 3449 | Cycle 1(1): loaded http://localhost:44182/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44182/tests/dromaeo/cssquery-yui.html) 16:03:56 INFO - PROCESS | 3449 | RSS: Main: 153554944 16:03:56 INFO - PROCESS | 3449 | 16:06:59 INFO - PROCESS | 3449 | Cycle 1(1): loaded http://localhost:44182/tests/dromaeo/cssquery-yui.html (next: http://localhost:44182/tests/dromaeo/cssquery-dojo.html) 16:06:59 INFO - PROCESS | 3449 | RSS: Main: 155361280 16:06:59 INFO - PROCESS | 3449 | 16:06:59 INFO - PROCESS | 3449 | __start_tp_report 16:06:59 INFO - PROCESS | 3449 | _x_x_mozilla_page_load 16:06:59 INFO - PROCESS | 3449 | _x_x_mozilla_page_load_details 16:06:59 INFO - PROCESS | 3449 | |i|pagename|runs| 16:06:59 INFO - PROCESS | 3449 | |0;dojo.html;3124.3282694220743;3197.104810653015;3217.1957010747315;3259.1689119274583;3265.6244531878842;5125.8462246132585;5173.198154286082;5204.687718736878;5252.579793616511;5278.1291086970605;5134.486551344864;5186.170212765958;5190.532852043315;5207.0106679730825;5302.337207849019;4793.041391721652;4804.687695299812;4839.467658557547;4882.121218180726;4902;690.3468397743281;4766.380370551823;4769.379980602517;4775.235962246042;4778.832740854071;4767.04659068186;4775.856724298276;4783.402074740658;4806.2310030394965;4820.060088282787;4794.808207671689;4799.568038876518;4803.279508073782;4827.710337379734;4877.439094504142;4663;4834.709917404967;4848.903021939576;4851.51484851512;4868.367112275381;5013.89972200554;5030.84907452777;5067.619928505377;5078.64449488536;5113.028524580318;5692.17463467799;5737.655740655574;5739.741711622987;5744.167095771131;5760.855978600526;5806.970965145148;5808.419158084158;5819.418058194146;5819.73811178498;5828.388019257959;5231.424543300272;5333.813316533902;5382.138857782736;5385.919211211835;5388.084025715599;5693.772249110072;5803.564732645069;5820.796272130455;5832.212651292021;5843.2695913010875;5579.358373786985;5594.832155035356;5604.8038318658655;5610.270664813548;5635.69003704792;5621.662700237917;5668.433156684298;5689.971550142305;5724.998125328134;5739.885202295931;5496.80761173357;5569.136783798518;5588.860278492989;5596.132599447093;5677.09166533361;5684.516816070681;5703.885922281531;5704.201411802351;5710.857228569236;5734.967705812994;4195.8741237762915;4224.218519573888;4229.048464095616;4271.551487093872;4300.935485967713;3732.42147467143;3778.6221377862544;3843.2505661396317;3849;3874.845006199777;5145.4597267287145;5255.500727430888;5258.579313654975;5262.473752624784;5271.525562699376;5558.277423934863;5559.471850174227;5560.499555040065;5564.221009058735;5580.693061881636;5206.869828254324;5329.1206950852675;5414.566834653218;5491.588130890199;5533.944660553423;4825.252085926687;4829.082474329866;4829.541193586604;4847.442544107403;4858.878528036827;5723.284589426322;5844;5844.912326315109;5851.61964472308;5877.764889404461;5556.444355564411;5578.944210558005;5685.317761868602;5771.422857714363;5784.161296612052;6026.939730602638;6033.18551995475;6044.032954727222;6053.424924632153;6058.7273572688455;5480.260164877691;5684.488396044376;5695.544356451557;5706.657600543981;5716.456936591017;5595.132754423071;5668.489835914787;5745.023346031101;5749.338826035059;5781.277340332458;5472.124460086367;5512.366077900932;5514.365847927379;5515.862103447446;5537.086380747131;5371.785128594969;5481.451854814646;5489.835304940858;5495.752691128989;5545.778168873361;5291.206319052173;5331.653442526223;5339.065663508793;5351.03681337363;5358.303420555303;5438;5439.619226654097;5473.507384335429;5517.61376703643;5617.747201375866;5571.13647384656;5596.356419011866;5603.5797315202335;5604.243427137284;5607.130894711327 16:06:59 INFO - PROCESS | 3449 | |1;ext.html;523.3353640876087;523.4346905342234;525.8247816130946;551.3494076989152;564.8785511115109;34942.825285873565;35701.64298357016;35789.136869050475;35882.461763073574;35892.2821543569;38476;38966.415503767465;38978.61021389785;39060.414093788546;39086.8045659772;8478.152184781518;8624.35317351198;8692.739217823475;8700.434471759347;8723.084076172006;8309.293710034653;8469.237768600824;8525.914740852606;8691.39160258779;8693.13068693132;8704.782380440509;8730.781730456725;8738.038815730264;8741;8751;8658.740237792876;8686.261667758217;8737.995130560003;8750.299976001905;8755.956220218859;8518.105598912087;8530.488170709777;8570.785730356729;8572.528510931896;8634.568271586395;38114.23771524554;38391;38463;38535.8073209635;38573.61426385756;3188.984055079733;3229.3903417215074;3257.690519400653;3352.5641666583188;3842.346801043829;25845.224643260543;26457.338566535796;26457.73542264572;26459.603105953425;26531.336716582045;3579.117999512706;3611.981940090309;3616.263725319308;3681.2245665798746;3785.6782173515285;262759;262782;264267;265252;265562.9999999981;57491;57615;57666.711666442236;57669;57803;54425.455745442036;55563;62043;62239.68880155661;67670.66164669146;15217.467388641344;15263.923680381527;15410.921235513631;15412.46056388021;15447.922760386125;11513.827292590619;11637.592684256011;11666.70833229176;11669.708257293465;11755.235909665844;19588.314408995902;20046.699299510517;20110.89944550268;20247.4938126548;20395.184192632427;7654.464187506821;8317.958410208032;8326.417150799507;8448;8510.404271701045;978.8384916488842;1007.8941711120227;1045.7908418316215;1123.7640095579857;1131.5247596009697;27790.583141252897;28017.71982280192;28117.859410703226;28519.28701782472;28529.57205641917;1069.5133714160038;1083.4691001409253;1123.775244951013;1124.9268797528134;1194.0805579703579;14788.186649734367;14854;14863.777043344358;15017.924910375597;15054.397824086915;305042;307457;308735;311993;312310;49713.25430118551;50222;50297.49702503001;50314.74842625837;50332;1315.1254415813569;1319.3073636340805;1320.821689071963;1328.2429015461287;1342.8052932324758;27139.321516961445;28273.293167670974;28559.42881142407;32104.197395065312;32237.194070147496;47103;47922.281165781846;48406.757966209945;48798.26802597893;48903.510964889894;219309;219376;219699;219808;220286;40019;44509.554904451834;45537.31694024526;46130;46271.53728462672;46291.537084628726;46461.76769116268;46541.76729116333;46781;46822;38331.80834095923;38441.80779096087;38481.23037539177;38537.229255415295;40534.594654054265;36514.634853652184;36563.817180913924;36638.267234655694;36895.8155209233;37753;38009.42985855159;38546.421803672405;38803.61196388113;38950.80524597472;38956.80521597374;32802;35032.12419689528;35528;35678;36972.630273696916;22018.669719954534;22208.44410936056;22705.318840434815;22759.203427879944;22882.656760148944 16:06:59 INFO - PROCESS | 3449 | |2;jquery.html;343.4390694294432;345.3490171027613;352.56458274031564;353.69582159342974;355.0750295480274;13886.583402497941;14386.352614132364;15432.614184645376;15963.84036159638;17809.376671816473;13898.166110033406;13957.371918263678;15058.849411505882;15082.170480623561;15118.395264189447;5181.326427564431;5268.578513718903;5404.4595540445835;5406.756695948692;5424.186372044205;5319.281896943921;6037.6075555089;6308.274548426921;6317.452224205076;6318.083877837711;6076.513878889678;6260.9373906261035;6270.874582508347;6272.65500397478;6336.873262534747;5992.460678538909;6143.84640383994;6271.153394291758;6381.521385896053;6466.256380516254;5685.943140568583;5888.5289176865745;5888.911666325009;5907.14346419771;5976.551758618121;18866.245350185975;19757.20971161152;20612.484687882923;22138.33584992453;22152.113915443362;2186.737591489016;2204.2836078274463;2205.5724422450517;2365.5860224460653;2378.108209421467;13183.604491865259;13258.337083145803;13460.192388456724;13612.863871361258;13625.931870340684;1956.2761778142037;2021.6361055010093;2027.8986050697554;2053.5174234054984;2074.2740040985536;58974.41025589732;62093.379066209214;62878;63432.365676343106;64657.99999999953;14244;14481.348339324544;14710.485133020293;14868.275713850246;14920.253987300592;21914.890425547772;22486.550268994855;22547.54904901893;22609.208677696202;22624.773752262598;7987.201279871966;8012.959935200287;8628.913710862811;8647.524386158695;8650.221480066699;7359.705611775469;7367.447441441914;7376.077990251219;7442.553446793209;7478.775636730907;4191.7275377100395;4264.381664658607;4299.097189590158;4345.565443455693;7417.703291868264;1786.8927864328182;1827.8446332061924;1828.7988321284647;1830.20386132033;1840.9447716568525;871.3943809052647;907.7866701325183;955.2024059909915;981.5681100315838;1040.7346126737634;15903.920480397755;15918.124503152438;15960.723142148832;16196.433124840574;16573.254203560868;890.8975467821283;933.9906600934039;954.4559601027487;967.0571193086824;1005.3666190300064;8541.444806087584;8647;8922.73231803047;8936.597853096626;9114.589843456928;359025;420186;512621;534157;537094;68064.6396721263;70627.99662028786;70913.64543177355;72305.27694722985;72339.27660723431;1133.637236084445;1135.182668478694;1135.3471753741633;1144.713821544614;1159.7970355187808;14469.421223150955;14716.77924831107;14767.04014239071;14792.852071479147;14849.92575037118;32062.67937320597;32085.67914320827;32259.51610725794;33028.66971330256;33187.83406082954;41384.58615413928;41874.162516750104;42310;43048;44027;6629.635370054693;6913.446924246149;6997.965010174917;7104.573725576482;7143.6428178591905;3683.3369993401443;5974.910376344272;9413.623455061721;9842.311038227255;10540.209484288556;9340.112689294507;9443.338966272295;9802;9892.060254275832;9997.800043999225;9577;9660;9899.703008909744;10021.849672254777;10096.444695541815;8353.164683531599;8416.24253817135;9212.95393523055;9449.48027858447;9572.377795443273;6609.10777045112;6933.5493192942295;7145.571265724073;7195.6761945713615;7332.413406927326;8611.48331100136;9063.274938004812;9190.656382622388;9240.722778316662;9494.382865113745 16:06:59 INFO - PROCESS | 3449 | |3;mootools.html;1385.9376328065237;1399.174487052639;1516.4995551468016;1715.6911755883943;1715.845573898349;7428.851422971537;7492.700291988321;7555.735549255777;7569.924300756984;7677.3858091352695;7733.381329493641;7739.613019349038;7797.415193860455;7842.8039299017555;7891.250331218525;2254.1434254983164;2271.159670921753;2283.303592404316;2284.7486776454575;2288.8397812153157;2302.0791683326634;2319.895604697784;2343.086196383412;2343.367290831483;2343.5898717724417;2195.352371050536;2235.8434909556336;2264.501809601893;2281.7490076091617;2299.2527428585695;2306.1813056365;2332.976670233293;2340.227724850812;2341.1454818991033;2344.120954642009;2234.3520379090046;2279.7036385269807;2286.702728645282;2291.51878105598;2297.7587353327826;7715.537067775896;7789.337906277973;7805.882911756328;7846.9215307847335;7871.52770833746;4538.841140560065;4658.906821863544;4661.09108723799;4662.8368007119925;4667.509911459282;2943.234758962664;3045.086474057774;3086.8302243376606;3108.518179682153;3118.5166299223656;961.2070042215131;991.1872264742914;995.1044060345674;1025.600015993763;1029.8506716526138;10641.467926603716;10687.519061642168;10884.510197041152;10941.781164376747;10970.232083754141;4248.575142485726;4274.914501709948;4315.482142142901;4326.242907491176;4351.934720979188;9266.67566635178;9271.860922086174;9280.396774209656;9281.21109705669;9284.582193801296;4770.0936822003705;4826.831060912851;4841.491643377465;4856.125897338442;4864.343313652683;4284.828606855754;4293.549177336397;4296.5273819879785;4365.388845561624;4389.122175564899;3587.7488575799443;3625.329314076904;3654.8172591370326;3669.94495082574;3677.9080522987138;1147.3288126445955;1148.3683973814536;1150.7008177873813;1168.5968340922368;1182.2433642468827;974.8440249560036;981.4945303168873;1107.3245320354577;1111.3165403276926;1292.6509842342703;7018.40343570792;7035.6482175891;7047.260037696071;7115.252898445692;7116.5018448709125;1073.3184427888348;1142.942777930411;1195.7907366210877;1203.5125774061519;1205.9939700301443;5596.552275817925;5632.915506267409;5664.915026274609;5671.120976248688;5671.773129074873;8814.77963050916;8971.685990990283;9310.301727370474;9311;9379.108984646447;9139;9159.084091590921;9245.768855778659;9289.256859451227;9294.86057709135;7164.426845852319;7298.781036568911;7343.3758130558435;7411.295926886937;7411.407087432993;7020;7028.9297107030325;7057.682404291922;7062.4703147263135;7151.070360853056;8132.3494120471405;8463.788405289917;8497.500149393481;8596.140385961604;8700.216980471789;8726.869096963677;8803.911960880308;8842.646294148162;8858.822823543622;8898.288136949159;6397.616143031433;6458.580192287486;6512.641804700597;6546.443552297917;6605.339466053356;7129.500934934505;7172.13934327884;7205.819854503679;7228.710851566088;7249.311315425026;6656;6918.619475928872;6945.722171113099;6954.269801670752;7105.928940710527;6607.603543787388;6749.527533072638;6753.898691519533;6876.828079298058;6893.310668933066;6697.196336439463;6697.732090716511;6710.899336509859;6745.797626071226;6748.156480439945;6027.6986150693165;6385.489160867212;6391.073294372197;6391.552591318563;6392.137061496638;6497.967510162419;6521.184851893513;6532.216134063943;6535.738570457129;6551.50863685216 16:06:59 INFO - PROCESS | 3449 | |4;prototype.html;326.1926731339933;335.9496075588663;337.6437858059747;337.66571094616324;348.5590727729423;6107.664078475682;6146.723397447115;6193.349698281683;6209.9068513972325;6354.14219080424;6188.47397971173;6200.131981522591;6214.192155019841;6219.098230756537;6235.719392627331;4668.136394766979;4702.506236845134;4759.309900064489;4774.379330687006;4778.2115950868065;4758.119747846642;4773;4774.379330687006;4776.546228108342;4779.641526885497;4548.363229147922;4639.466461356937;4655.7672116394215;4716.834910778123;4724.4330680318235;4641.327007583882;4694.671373003891;4696.131215725101;4701.224297990828;4706.811727530895;4048.817803198863;4072.2059198456313;4084.8570300039655;4091.345384738457;4096.221717873595;5837.357890632027;5848.766049358021;5867.3839246879315;5870.26621672291;5875.500582450497;5101.107306221396;5361.571074314045;5404.162354835007;5404.83785486436;5427.864303392407;6546.6726663667105;6553.475721942234;6556.639384833832;6561.7375304987745;6563.967180164116;4431.689781715281;4448.555144485558;4450.888727781799;4451.399061126739;4455.353973673799;6492.902606460954;6665.266820649725;6733.8989915151315;6762.898556521656;6774.288699686561;4394.384786129945;4476.127155204704;4478.305862591304;4541.9545804542195;4542.727436353829;4527.501974782771;4536.183486972377;4583.747893865802;4597.080583883237;4598.1033698429155;5303.284056652303;5372.973135134299;5398.91901621476;5413.83758487246;5418.431064738224;6496.577722448026;6547.672616369257;6592.76925307612;6604.273529911706;6615.735370585219;1621.9594510137106;1644.350481559777;1645.2596331650805;1645.7366821308533;1646.2838665180684;1084.4577711144427;1087.3584585094675;1096.8903109688968;1098.4837126550508;1110.0453609895644;6149.0776383542825;6188.226471691039;6271.498280137578;6282.246130464374;6293.653849038255;6606.900896486556;6708.597484150967;6710.127683401224;6764.830879228059;6781.491388145909;6043.939560604425;6096.177016102858;6173.876522469525;6192.8761424771255;6235.532335074888;3621.1128273573145;3644.0707619557375;3656.908577285536;3660.652238037382;3670.908227294339;7142.357187853118;7143.357097861218;7151.60666163366;7156.606386648784;7172.892406613801;6838.7264509420065;6952.826179345557;6992.2658120897595;6993.335633114846;6999;7084.822879428056;7156.749513766993;7255.746048888263;7257.8911316330295;7281.7087316507805;6859.9314006859295;6865.0732151160955;6867.656617169221;6873.793786186422;6891.862162756817;6586.275509693834;6724.49566282521;6726.091977582963;6733.831654208684;6826.283240259701;7046.365827075588;7103.360697537247;7171.354578087997;7201.567905925661;7271.2365201653065;4734.07685501324;4789.544993225638;4795.304680821331;4796.2805579163405;4807.495213002724;6593.901091483727;6757.797266082025;6762.120924280009;6772.729090836311;6841.897371539331;6582.605043697394;6639.103720997604;6649.0691303218555;6652.101966234496;6653.866922661617;6627.569208001657;6640.90038649411;6643.534952553275;6652.301508341555;6662.200535935719;6311.084892690626;6451.645159516084;6453.322401147811;6457.580257283262;6465.515086368447;6534.640594767143;6582;6587.341265873374;6658.6337751424135;6666.500012499179;6382.585131966407;6417.711202995783;6450.870982580228;6466.127072845294;6515.2833188348295 16:06:59 INFO - PROCESS | 3449 | |5;yui.html;737.0602481835659;751.2374939436471;795.3517882925415;824.4476200945365;883.5979629268684;12574;12811.167274127198;12837.550685726;12868.420921058552;12897.161684490502;12110.152289339727;13951.651208719788;14058.297085145752;14068.366923488442;14079.155250684966;767.0718430698861;783.5612057247931;785.1089013969157;786.2530595933857;788.3259812860008;784.7763387434583;790.1624278265028;791.1060501633175;794.1343935110729;797.9321757650578;817.3012074676155;819.9672013119468;820.9630566624486;821.4455242711176;829.4401279136589;811.8213992921607;818.9918100819004;821.2321479416764;824.4764574495179;826.3141592478258;603.5503549855342;603.6649659439009;604.570754764118;607.5746977115992;610.5909040942579;13494.122882012736;13495.797563036562;13502.594922152253;13530.391132398967;13533.864661353457;12095.818562721566;12146.574869879512;12423.31671758053;12798.360081995956;12987.22076675393;10696.893031069667;10846.566137354497;10864.728381790439;10894.836577451344;10913;3561.928761424783;3624.9275014499826;3625.8187090645624;3658.634136586347;3729.086373838427;44212.55787442117;46600.7669961648;46701.5329846704;46768.5323146771;46877.29684054742;9485.383450075724;9590;9828.705138845846;9866.506674666238;10036.297459177787;17371.131443427777;17387.304507819797;17432.91283543574;17506.387276445264;17561.385351512636;7273.599952002585;7388.778336649909;7492.1384040836;7544.434167437465;7549.924500755032;4136.834526618962;4149.751014939114;4375.518692943773;4376.431063961728;4455.532169122261;2932.692067332899;2963.155500682295;2968.005718084423;2969.539721343195;2969.7178768017;535.3575709149037;538.1309185665201;541.8916216756664;542.7584724797427;545.1305168256624;561.6433564686454;611.2512172588544;625.4621025917708;633.297040285283;634.3497914637534;8225;8550.871736923827;8581.785455363666;8629;8845.203931646183;560.0115795620733;573.5325709546789;600.3756093662629;634.876199141163;689.162667359161;3727.6086010969;3995.62041606047;4205.158968206371;4234.25900467417;4294.484661840536;53229;57585;58095.70952145297;58107.4189258102;58137;50470.74764626153;50530.242046369334;50630.49369506331;50744.238836417484;50838.23742643863;43380.79430468364;43826;44682.3297650542;44699.77650111729;44772;8501.914980850112;8991.460512369016;9005.054469280893;9077.991633462314;9096.1813436791;32084.67915320817;32632.83683581567;32702.672973269964;32920.555724976824;32974;41309.58690413057;43640.56359436492;44093.77953110214;44268.778656106515;44445;10497.632582859564;10672.199585030998;10697.893021069689;10750.301230419998;10813.67558973232;11455.198136130392;11546.422678865854;11619.535218591162;11762.176647634584;11764.411779411166;11417.37204453763;11468.770624587629;11689;11701.180917335705;11710.882891170979;10833.729156771144;10835.566577337133;10901.727456813644;10990.450477475933;11128.55485780592;11386.54453821871;11422.200445968703;11441.855814418825;11491.310521368745;11538.48076836561;9252.907470925205;9253.491057991874;9275.489848058422;9308.720738377859;9414.717558473258;9226.446413215228;9543.379680320757;9553.474558899326;9704.272179586418;9709.9029009709 16:06:59 INFO - PROCESS | 3449 | __end_tp_report 16:06:59 INFO - PROCESS | 3449 | __start_cc_report 16:06:59 INFO - PROCESS | 3449 | _x_x_mozilla_cycle_collect,302 16:06:59 INFO - PROCESS | 3449 | __end_cc_report 16:06:59 INFO - PROCESS | 3449 | __startTimestamp1452211619291__endTimestamp 16:06:59 INFO - PROCESS | 3449 | 16:06:59 INFO - PROCESS | 3449 | ------- Summary: start ------- 16:06:59 INFO - PROCESS | 3449 | Number of tests: 6 16:06:59 INFO - PROCESS | 3449 | 16:06:59 INFO - PROCESS | 3449 | [#0] dojo.html Cycles:165 Average:5230.73 Median:5480.26 stddev:699.47 (12.8%) stddev-sans-first:681.81 16:06:59 INFO - PROCESS | 3449 | Values: 3124.3 3197.1 3217.2 3259.2 3265.6 5125.8 5173.2 5204.7 5252.6 5278.1 5134.5 5186.2 5190.5 5207.0 5302.3 4793.0 4804.7 4839.5 4882.1 4902.0 690.3 4766.4 4769.4 4775.2 4778.8 4767.0 4775.9 4783.4 4806.2 4820.1 4794.8 4799.6 4803.3 4827.7 4877.4 4663.0 4834.7 4848.9 4851.5 4868.4 5013.9 5030.8 5067.6 5078.6 5113.0 5692.2 5737.7 5739.7 5744.2 5760.9 5807.0 5808.4 5819.4 5819.7 5828.4 5231.4 5333.8 5382.1 5385.9 5388.1 5693.8 5803.6 5820.8 5832.2 5843.3 5579.4 5594.8 5604.8 5610.3 5635.7 5621.7 5668.4 5690.0 5725.0 5739.9 5496.8 5569.1 5588.9 5596.1 5677.1 5684.5 5703.9 5704.2 5710.9 5735.0 4195.9 4224.2 4229.0 4271.6 4300.9 3732.4 3778.6 3843.3 3849.0 3874.8 5145.5 5255.5 5258.6 5262.5 5271.5 5558.3 5559.5 5560.5 5564.2 5580.7 5206.9 5329.1 5414.6 5491.6 5533.9 4825.3 4829.1 4829.5 4847.4 4858.9 5723.3 5844.0 5844.9 5851.6 5877.8 5556.4 5578.9 5685.3 5771.4 5784.2 6026.9 6033.2 6044.0 6053.4 6058.7 5480.3 5684.5 5695.5 5706.7 5716.5 5595.1 5668.5 5745.0 5749.3 5781.3 5472.1 5512.4 5514.4 5515.9 5537.1 5371.8 5481.5 5489.8 5495.8 5545.8 5291.2 5331.7 5339.1 5351.0 5358.3 5438.0 5439.6 5473.5 5517.6 5617.7 5571.1 5596.4 5603.6 5604.2 5607.1 16:06:59 INFO - PROCESS | 3449 | 16:06:59 INFO - PROCESS | 3449 | [#1] ext.html Cycles:180 Average:44284.42 Median:37362.82 stddev:69554.11 (186.2%) stddev-sans-first:69671.62 16:06:59 INFO - PROCESS | 3449 | Values: 523.3 523.4 525.8 551.3 564.9 34942.8 35701.6 35789.1 35882.5 35892.3 38476.0 38966.4 38978.6 39060.4 39086.8 8478.2 8624.4 8692.7 8700.4 8723.1 8309.3 8469.2 8525.9 8691.4 8693.1 8704.8 8730.8 8738.0 8741.0 8751.0 8658.7 8686.3 8738.0 8750.3 8756.0 8518.1 8530.5 8570.8 8572.5 8634.6 38114.2 38391.0 38463.0 38535.8 38573.6 3189.0 3229.4 3257.7 3352.6 3842.3 25845.2 26457.3 26457.7 26459.6 26531.3 3579.1 3612.0 3616.3 3681.2 3785.7 262759.0 262782.0 264267.0 265252.0 265563.0 57491.0 57615.0 57666.7 57669.0 57803.0 54425.5 55563.0 62043.0 62239.7 67670.7 15217.5 15263.9 15410.9 15412.5 15447.9 11513.8 11637.6 11666.7 11669.7 11755.2 19588.3 20046.7 20110.9 20247.5 20395.2 7654.5 8318.0 8326.4 8448.0 8510.4 978.8 1007.9 1045.8 1123.8 1131.5 27790.6 28017.7 28117.9 28519.3 28529.6 1069.5 1083.5 1123.8 1124.9 1194.1 14788.2 14854.0 14863.8 15017.9 15054.4 305042.0 307457.0 308735.0 311993.0 312310.0 49713.3 50222.0 50297.5 50314.7 50332.0 1315.1 1319.3 1320.8 1328.2 1342.8 27139.3 28273.3 28559.4 32104.2 32237.2 47103.0 47922.3 48406.8 48798.3 48903.5 219309.0 219376.0 219699.0 219808.0 220286.0 40019.0 44509.6 45537.3 46130.0 46271.5 46291.5 46461.8 46541.8 46781.0 46822.0 38331.8 38441.8 38481.2 38537.2 40534.6 36514.6 36563.8 36638.3 36895.8 37753.0 38009.4 38546.4 38803.6 38950.8 38956.8 32802.0 35032.1 35528.0 35678.0 36972.6 22018.7 22208.4 22705.3 22759.2 22882.7 16:06:59 INFO - PROCESS | 3449 | 16:06:59 INFO - PROCESS | 3449 | [#2] jquery.html Cycles:180 Average:26151.36 Median:269738.14 stddev:78174.11 (29.0%) stddev-sans-first:78369.39 16:06:59 INFO - PROCESS | 3449 | Values: 343.4 345.3 352.6 353.7 355.1 13886.6 14386.4 15432.6 15963.8 17809.4 13898.2 13957.4 15058.8 15082.2 15118.4 5181.3 5268.6 5404.5 5406.8 5424.2 5319.3 6037.6 6308.3 6317.5 6318.1 6076.5 6260.9 6270.9 6272.7 6336.9 5992.5 6143.8 6271.2 6381.5 6466.3 5685.9 5888.5 5888.9 5907.1 5976.6 18866.2 19757.2 20612.5 22138.3 22152.1 2186.7 2204.3 2205.6 2365.6 2378.1 13183.6 13258.3 13460.2 13612.9 13625.9 1956.3 2021.6 2027.9 2053.5 2074.3 58974.4 62093.4 62878.0 63432.4 64658.0 14244.0 14481.3 14710.5 14868.3 14920.3 21914.9 22486.6 22547.5 22609.2 22624.8 7987.2 8013.0 8628.9 8647.5 8650.2 7359.7 7367.4 7376.1 7442.6 7478.8 4191.7 4264.4 4299.1 4345.6 7417.7 1786.9 1827.8 1828.8 1830.2 1840.9 871.4 907.8 955.2 981.6 1040.7 15903.9 15918.1 15960.7 16196.4 16573.3 890.9 934.0 954.5 967.1 1005.4 8541.4 8647.0 8922.7 8936.6 9114.6 359025.0 420186.0 512621.0 534157.0 537094.0 68064.6 70628.0 70913.6 72305.3 72339.3 1133.6 1135.2 1135.3 1144.7 1159.8 14469.4 14716.8 14767.0 14792.9 14849.9 32062.7 32085.7 32259.5 33028.7 33187.8 41384.6 41874.2 42310.0 43048.0 44027.0 6629.6 6913.4 6998.0 7104.6 7143.6 3683.3 5974.9 9413.6 9842.3 10540.2 9340.1 9443.3 9802.0 9892.1 9997.8 9577.0 9660.0 9899.7 10021.8 10096.4 8353.2 8416.2 9213.0 9449.5 9572.4 6609.1 6933.5 7145.6 7195.7 7332.4 8611.5 9063.3 9190.7 9240.7 9494.4 16:06:59 INFO - PROCESS | 3449 | 16:06:59 INFO - PROCESS | 3449 | [#3] mootools.html Cycles:180 Average:5423.44 Median:6428.10 stddev:2803.33 (43.6%) stddev-sans-first:2794.77 16:06:59 INFO - PROCESS | 3449 | Values: 1385.9 1399.2 1516.5 1715.7 1715.8 7428.9 7492.7 7555.7 7569.9 7677.4 7733.4 7739.6 7797.4 7842.8 7891.3 2254.1 2271.2 2283.3 2284.7 2288.8 2302.1 2319.9 2343.1 2343.4 2343.6 2195.4 2235.8 2264.5 2281.7 2299.3 2306.2 2333.0 2340.2 2341.1 2344.1 2234.4 2279.7 2286.7 2291.5 2297.8 7715.5 7789.3 7805.9 7846.9 7871.5 4538.8 4658.9 4661.1 4662.8 4667.5 2943.2 3045.1 3086.8 3108.5 3118.5 961.2 991.2 995.1 1025.6 1029.9 10641.5 10687.5 10884.5 10941.8 10970.2 4248.6 4274.9 4315.5 4326.2 4351.9 9266.7 9271.9 9280.4 9281.2 9284.6 4770.1 4826.8 4841.5 4856.1 4864.3 4284.8 4293.5 4296.5 4365.4 4389.1 3587.7 3625.3 3654.8 3669.9 3677.9 1147.3 1148.4 1150.7 1168.6 1182.2 974.8 981.5 1107.3 1111.3 1292.7 7018.4 7035.6 7047.3 7115.3 7116.5 1073.3 1142.9 1195.8 1203.5 1206.0 5596.6 5632.9 5664.9 5671.1 5671.8 8814.8 8971.7 9310.3 9311.0 9379.1 9139.0 9159.1 9245.8 9289.3 9294.9 7164.4 7298.8 7343.4 7411.3 7411.4 7020.0 7028.9 7057.7 7062.5 7151.1 8132.3 8463.8 8497.5 8596.1 8700.2 8726.9 8803.9 8842.6 8858.8 8898.3 6397.6 6458.6 6512.6 6546.4 6605.3 7129.5 7172.1 7205.8 7228.7 7249.3 6656.0 6918.6 6945.7 6954.3 7105.9 6607.6 6749.5 6753.9 6876.8 6893.3 6697.2 6697.7 6710.9 6745.8 6748.2 6027.7 6385.5 6391.1 6391.6 6392.1 6498.0 6521.2 6532.2 6535.7 6551.5 16:06:59 INFO - PROCESS | 3449 | 16:06:59 INFO - PROCESS | 3449 | [#4] prototype.html Cycles:180 Average:5484.03 Median:6205.02 stddev:1677.73 (27.0%) stddev-sans-first:1637.16 16:06:59 INFO - PROCESS | 3449 | Values: 326.2 335.9 337.6 337.7 348.6 6107.7 6146.7 6193.3 6209.9 6354.1 6188.5 6200.1 6214.2 6219.1 6235.7 4668.1 4702.5 4759.3 4774.4 4778.2 4758.1 4773.0 4774.4 4776.5 4779.6 4548.4 4639.5 4655.8 4716.8 4724.4 4641.3 4694.7 4696.1 4701.2 4706.8 4048.8 4072.2 4084.9 4091.3 4096.2 5837.4 5848.8 5867.4 5870.3 5875.5 5101.1 5361.6 5404.2 5404.8 5427.9 6546.7 6553.5 6556.6 6561.7 6564.0 4431.7 4448.6 4450.9 4451.4 4455.4 6492.9 6665.3 6733.9 6762.9 6774.3 4394.4 4476.1 4478.3 4542.0 4542.7 4527.5 4536.2 4583.7 4597.1 4598.1 5303.3 5373.0 5398.9 5413.8 5418.4 6496.6 6547.7 6592.8 6604.3 6615.7 1622.0 1644.4 1645.3 1645.7 1646.3 1084.5 1087.4 1096.9 1098.5 1110.0 6149.1 6188.2 6271.5 6282.2 6293.7 6606.9 6708.6 6710.1 6764.8 6781.5 6043.9 6096.2 6173.9 6192.9 6235.5 3621.1 3644.1 3656.9 3660.7 3670.9 7142.4 7143.4 7151.6 7156.6 7172.9 6838.7 6952.8 6992.3 6993.3 6999.0 7084.8 7156.7 7255.7 7257.9 7281.7 6859.9 6865.1 6867.7 6873.8 6891.9 6586.3 6724.5 6726.1 6733.8 6826.3 7046.4 7103.4 7171.4 7201.6 7271.2 4734.1 4789.5 4795.3 4796.3 4807.5 6593.9 6757.8 6762.1 6772.7 6841.9 6582.6 6639.1 6649.1 6652.1 6653.9 6627.6 6640.9 6643.5 6652.3 6662.2 6311.1 6451.6 6453.3 6457.6 6465.5 6534.6 6582.0 6587.3 6658.6 6666.5 6382.6 6417.7 6450.9 6466.1 6515.3 16:06:59 INFO - PROCESS | 3449 | 16:06:59 INFO - PROCESS | 3449 | [#5] yui.html Cycles:180 Average:13510.70 Median:44735.89 stddev:15502.39 (34.7%) stddev-sans-first:15516.20 16:06:59 INFO - PROCESS | 3449 | Values: 737.1 751.2 795.4 824.4 883.6 12574.0 12811.2 12837.6 12868.4 12897.2 12110.2 13951.7 14058.3 14068.4 14079.2 767.1 783.6 785.1 786.3 788.3 784.8 790.2 791.1 794.1 797.9 817.3 820.0 821.0 821.4 829.4 811.8 819.0 821.2 824.5 826.3 603.6 603.7 604.6 607.6 610.6 13494.1 13495.8 13502.6 13530.4 13533.9 12095.8 12146.6 12423.3 12798.4 12987.2 10696.9 10846.6 10864.7 10894.8 10913.0 3561.9 3624.9 3625.8 3658.6 3729.1 44212.6 46600.8 46701.5 46768.5 46877.3 9485.4 9590.0 9828.7 9866.5 10036.3 17371.1 17387.3 17432.9 17506.4 17561.4 7273.6 7388.8 7492.1 7544.4 7549.9 4136.8 4149.8 4375.5 4376.4 4455.5 2932.7 2963.2 2968.0 2969.5 2969.7 535.4 538.1 541.9 542.8 545.1 561.6 611.3 625.5 633.3 634.3 8225.0 8550.9 8581.8 8629.0 8845.2 560.0 573.5 600.4 634.9 689.2 3727.6 3995.6 4205.2 4234.3 4294.5 53229.0 57585.0 58095.7 58107.4 58137.0 50470.7 50530.2 50630.5 50744.2 50838.2 43380.8 43826.0 44682.3 44699.8 44772.0 8501.9 8991.5 9005.1 9078.0 9096.2 32084.7 32632.8 32702.7 32920.6 32974.0 41309.6 43640.6 44093.8 44268.8 44445.0 10497.6 10672.2 10697.9 10750.3 10813.7 11455.2 11546.4 11619.5 11762.2 11764.4 11417.4 11468.8 11689.0 11701.2 11710.9 10833.7 10835.6 10901.7 10990.5 11128.6 11386.5 11422.2 11441.9 11491.3 11538.5 9252.9 9253.5 9275.5 9308.7 9414.7 9226.4 9543.4 9553.5 9704.3 9709.9 16:06:59 INFO - PROCESS | 3449 | -------- Summary: end -------- 16:06:59 INFO - PROCESS | 3449 | 16:06:59 INFO - TEST-INFO | 3449: exit 0 16:07:00 INFO - TEST-OK | dromaeo_css | took 1113544ms 16:07:00 INFO - TEST-START | kraken 16:07:00 INFO - operating with platform_type : linux_ 16:07:00 INFO - Initialising browser for kraken test... 16:07:00 INFO - TEST-INFO | started process 3691 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppmXvaW/profile http://localhost:44182/getInfo.html) 16:07:03 INFO - PROCESS | 3691 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 16:07:04 INFO - PROCESS | 3691 | __metrics Screen width/height:1600/1200 16:07:04 INFO - PROCESS | 3691 | colorDepth:24 16:07:04 INFO - PROCESS | 3691 | Browser inner width/height: 1024/697 16:07:04 INFO - PROCESS | 3691 | __metrics 16:07:04 INFO - PROCESS | 3691 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:07:04 INFO - TEST-INFO | 3691: exit 0 16:07:04 INFO - Browser initialized. 16:07:04 INFO - Running cycle 1/1 for kraken test... 16:07:04 INFO - TEST-INFO | started process 3813 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppmXvaW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:07:16 INFO - PROCESS | 3813 | RSS: Main: 150126592 16:07:16 INFO - PROCESS | 3813 | 16:07:19 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44182/tests/kraken/driver.html?testName=audio-beat-detection) 16:07:19 INFO - PROCESS | 3813 | RSS: Main: 151224320 16:07:19 INFO - PROCESS | 3813 | 16:07:22 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44182/tests/kraken/driver.html?testName=audio-dft) 16:07:23 INFO - PROCESS | 3813 | RSS: Main: 150110208 16:07:23 INFO - PROCESS | 3813 | 16:07:25 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44182/tests/kraken/driver.html?testName=audio-fft) 16:07:26 INFO - PROCESS | 3813 | RSS: Main: 145518592 16:07:26 INFO - PROCESS | 3813 | 16:07:28 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44182/tests/kraken/driver.html?testName=audio-oscillator) 16:07:29 INFO - PROCESS | 3813 | RSS: Main: 146079744 16:07:29 INFO - PROCESS | 3813 | 16:07:31 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44182/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:07:31 INFO - PROCESS | 3813 | RSS: Main: 146956288 16:07:31 INFO - PROCESS | 3813 | 16:07:34 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44182/tests/kraken/driver.html?testName=imaging-darkroom) 16:07:35 INFO - PROCESS | 3813 | RSS: Main: 147304448 16:07:35 INFO - PROCESS | 3813 | 16:07:38 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44182/tests/kraken/driver.html?testName=imaging-desaturate) 16:07:39 INFO - PROCESS | 3813 | RSS: Main: 148336640 16:07:39 INFO - PROCESS | 3813 | 16:07:42 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44182/tests/kraken/driver.html?testName=json-parse-financial) 16:07:42 INFO - PROCESS | 3813 | RSS: Main: 148582400 16:07:42 INFO - PROCESS | 3813 | 16:07:44 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44182/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:07:45 INFO - PROCESS | 3813 | RSS: Main: 149626880 16:07:45 INFO - PROCESS | 3813 | 16:07:46 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44182/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:07:47 INFO - PROCESS | 3813 | RSS: Main: 149315584 16:07:47 INFO - PROCESS | 3813 | 16:07:49 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44182/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:07:50 INFO - PROCESS | 3813 | RSS: Main: 149151744 16:07:50 INFO - PROCESS | 3813 | 16:07:52 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44182/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:07:53 INFO - PROCESS | 3813 | RSS: Main: 149786624 16:07:53 INFO - PROCESS | 3813 | 16:07:55 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44182/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:07:56 INFO - PROCESS | 3813 | RSS: Main: 148455424 16:07:56 INFO - PROCESS | 3813 | 16:07:58 INFO - PROCESS | 3813 | Cycle 1(1): loaded http://localhost:44182/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44182/tests/kraken/driver.html?testName=ai-astar) 16:07:58 INFO - PROCESS | 3813 | RSS: Main: 148844544 16:07:58 INFO - PROCESS | 3813 | 16:07:58 INFO - PROCESS | 3813 | __start_tp_report 16:07:58 INFO - PROCESS | 3813 | _x_x_mozilla_page_load 16:07:58 INFO - PROCESS | 3813 | _x_x_mozilla_page_load_details 16:07:58 INFO - PROCESS | 3813 | |i|pagename|runs| 16:07:58 INFO - PROCESS | 3813 | |0;ai-astar;114;106;113;113;113;124;113;114;112;111 16:07:58 INFO - PROCESS | 3813 | |1;audio-beat-detection;150;135;149;170;131;154;157;125;159;127 16:07:58 INFO - PROCESS | 3813 | |2;audio-dft;163;165;163;163;163;161;164;165;169;164 16:07:58 INFO - PROCESS | 3813 | |3;audio-fft;74;75;73;72;72;73;151;71;72;74 16:07:58 INFO - PROCESS | 3813 | |4;audio-oscillator;97;95;140;96;96;96;141;97;97;134 16:07:58 INFO - PROCESS | 3813 | |5;imaging-gaussian-blur;110;110;110;110;112;110;110;110;109;111 16:07:58 INFO - PROCESS | 3813 | |6;imaging-darkroom;149;148;146;150;150;147;146;146;147;148 16:07:58 INFO - PROCESS | 3813 | |7;imaging-desaturate;96;97;98;98;96;97;96;97;97;97 16:07:58 INFO - PROCESS | 3813 | |8;json-parse-financial;60;60;59;60;60;60;60;60;57;64 16:07:58 INFO - PROCESS | 3813 | |9;json-stringify-tinderbox;68;68;68;70;68;70;68;68;69;69 16:07:58 INFO - PROCESS | 3813 | |10;stanford-crypto-aes;86;87;86;87;88;89;88;94;89;86 16:07:58 INFO - PROCESS | 3813 | |11;stanford-crypto-ccm;127;135;117;117;133;122;121;119;121;125 16:07:58 INFO - PROCESS | 3813 | |12;stanford-crypto-pbkdf2;140;152;159;143;150;151;150;145;150;139 16:07:58 INFO - PROCESS | 3813 | |13;stanford-crypto-sha256-iterative;79;75;68;68;68;70;69;69;68;69 16:07:58 INFO - PROCESS | 3813 | __end_tp_report 16:07:58 INFO - PROCESS | 3813 | __start_cc_report 16:07:58 INFO - PROCESS | 3813 | _x_x_mozilla_cycle_collect,740 16:07:58 INFO - PROCESS | 3813 | __end_cc_report 16:07:58 INFO - PROCESS | 3813 | __startTimestamp1452211678399__endTimestamp 16:07:58 INFO - PROCESS | 3813 | 16:07:58 INFO - PROCESS | 3813 | ------- Summary: start ------- 16:07:58 INFO - PROCESS | 3813 | Number of tests: 14 16:07:58 INFO - PROCESS | 3813 | 16:07:58 INFO - PROCESS | 3813 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.00 stddev:4.42 (3.9%) stddev-sans-first:4.68 16:07:58 INFO - PROCESS | 3813 | Values: 114.0 106.0 113.0 113.0 113.0 124.0 113.0 114.0 112.0 111.0 16:07:58 INFO - PROCESS | 3813 | 16:07:58 INFO - PROCESS | 3813 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:152.00 stddev:15.28 (10.1%) stddev-sans-first:16.13 16:07:58 INFO - PROCESS | 3813 | Values: 150.0 135.0 149.0 170.0 131.0 154.0 157.0 125.0 159.0 127.0 16:07:58 INFO - PROCESS | 3813 | 16:07:58 INFO - PROCESS | 3813 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:2.11 (1.3%) stddev-sans-first:2.20 16:07:58 INFO - PROCESS | 3813 | Values: 163.0 165.0 163.0 163.0 163.0 161.0 164.0 165.0 169.0 164.0 16:07:58 INFO - PROCESS | 3813 | 16:07:58 INFO - PROCESS | 3813 | [#3] audio-fft Cycles:10 Average:80.70 Median:73.00 stddev:24.73 (33.9%) stddev-sans-first:26.11 16:07:58 INFO - PROCESS | 3813 | Values: 74.0 75.0 73.0 72.0 72.0 73.0 151.0 71.0 72.0 74.0 16:07:58 INFO - PROCESS | 3813 | 16:07:58 INFO - PROCESS | 3813 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:96.00 stddev:20.40 (21.2%) stddev-sans-first:21.18 16:07:58 INFO - PROCESS | 3813 | Values: 97.0 95.0 140.0 96.0 96.0 96.0 141.0 97.0 97.0 134.0 16:07:58 INFO - PROCESS | 3813 | 16:07:58 INFO - PROCESS | 3813 | [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 16:07:58 INFO - PROCESS | 3813 | Values: 110.0 110.0 110.0 110.0 112.0 110.0 110.0 110.0 109.0 111.0 16:07:58 INFO - PROCESS | 3813 | 16:07:58 INFO - PROCESS | 3813 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:1.57 (1.1%) stddev-sans-first:1.59 16:07:58 INFO - PROCESS | 3813 | Values: 149.0 148.0 146.0 150.0 150.0 147.0 146.0 146.0 147.0 148.0 16:07:58 INFO - PROCESS | 3813 | 16:07:58 INFO - PROCESS | 3813 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:97.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 16:07:58 INFO - PROCESS | 3813 | Values: 96.0 97.0 98.0 98.0 96.0 97.0 96.0 97.0 97.0 97.0 16:07:58 INFO - PROCESS | 3813 | 16:07:58 INFO - PROCESS | 3813 | [#8] json-parse-financial Cycles:10 Average:60.00 Median:60.00 stddev:1.70 (2.8%) stddev-sans-first:1.80 16:07:58 INFO - PROCESS | 3813 | Values: 60.0 60.0 59.0 60.0 60.0 60.0 60.0 60.0 57.0 64.0 16:07:58 INFO - PROCESS | 3813 | 16:07:58 INFO - PROCESS | 3813 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:68.50 stddev:0.84 (1.2%) stddev-sans-first:0.87 16:07:58 INFO - PROCESS | 3813 | Values: 68.0 68.0 68.0 70.0 68.0 70.0 68.0 68.0 69.0 69.0 16:07:58 INFO - PROCESS | 3813 | 16:07:58 INFO - PROCESS | 3813 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:88.00 stddev:2.40 (2.7%) stddev-sans-first:2.44 16:07:58 INFO - PROCESS | 3813 | Values: 86.0 87.0 86.0 87.0 88.0 89.0 88.0 94.0 89.0 86.0 16:07:58 INFO - PROCESS | 3813 | 16:07:58 INFO - PROCESS | 3813 | [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:123.50 stddev:6.29 (5.1%) stddev-sans-first:6.56 16:07:58 INFO - PROCESS | 3813 | Values: 127.0 135.0 117.0 117.0 133.0 122.0 121.0 119.0 121.0 125.0 16:07:58 INFO - PROCESS | 3813 | 16:07:58 INFO - PROCESS | 3813 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:150.00 stddev:6.12 (4.1%) stddev-sans-first:5.78 16:07:58 INFO - PROCESS | 3813 | Values: 140.0 152.0 159.0 143.0 150.0 151.0 150.0 145.0 150.0 139.0 16:07:58 INFO - PROCESS | 3813 | 16:07:58 INFO - PROCESS | 3813 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:69.00 stddev:3.71 (5.4%) stddev-sans-first:2.24 16:07:58 INFO - PROCESS | 3813 | Values: 79.0 75.0 68.0 68.0 68.0 70.0 69.0 69.0 68.0 69.0 16:07:58 INFO - PROCESS | 3813 | -------- Summary: end -------- 16:07:58 INFO - PROCESS | 3813 | 16:07:59 INFO - TEST-INFO | 3813: exit 0 16:07:59 INFO - TEST-OK | kraken | took 59334ms 16:07:59 INFO - TEST-START | v8_7 16:07:59 INFO - operating with platform_type : linux_ 16:07:59 INFO - Initialising browser for v8_7 test... 16:07:59 INFO - TEST-INFO | started process 4100 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphPbLEF/profile http://localhost:44182/getInfo.html) 16:08:02 INFO - PROCESS | 4100 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 16:08:03 INFO - PROCESS | 4100 | __metrics Screen width/height:1600/1200 16:08:03 INFO - PROCESS | 4100 | colorDepth:24 16:08:03 INFO - PROCESS | 4100 | Browser inner width/height: 1024/697 16:08:03 INFO - PROCESS | 4100 | __metrics 16:08:03 INFO - PROCESS | 4100 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:08:04 INFO - TEST-INFO | 4100: exit 0 16:08:04 INFO - Browser initialized. 16:08:04 INFO - Running cycle 1/1 for v8_7 test... 16:08:04 INFO - TEST-INFO | started process 4220 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphPbLEF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:08:15 INFO - PROCESS | 4220 | RSS: Main: 150728704 16:08:15 INFO - PROCESS | 4220 | 16:08:38 INFO - PROCESS | 4220 | Cycle 1(1): loaded http://localhost:44182/tests/v8_7/run.html (next: http://localhost:44182/tests/v8_7/run.html) 16:08:38 INFO - PROCESS | 4220 | RSS: Main: 145932288 16:08:38 INFO - PROCESS | 4220 | 16:08:38 INFO - PROCESS | 4220 | __start_tp_report 16:08:38 INFO - PROCESS | 4220 | _x_x_mozilla_page_load 16:08:38 INFO - PROCESS | 4220 | _x_x_mozilla_page_load_details 16:08:38 INFO - PROCESS | 4220 | |i|pagename|runs| 16:08:38 INFO - PROCESS | 4220 | |0;Richards;167.61649346295675 16:08:38 INFO - PROCESS | 4220 | |1;DeltaBlue;189.7173211914248 16:08:38 INFO - PROCESS | 4220 | |2;Encrypt;283.04557033682426 16:08:38 INFO - PROCESS | 4220 | |3;Decrypt;5175.257731958763 16:08:38 INFO - PROCESS | 4220 | |4;RayTrace;1070.6638115631692 16:08:38 INFO - PROCESS | 4220 | |5;Earley;705.2186177715091 16:08:38 INFO - PROCESS | 4220 | |6;Boyer;12168.674698795181 16:08:38 INFO - PROCESS | 4220 | |7;RegExp;41693.87755102041 16:08:38 INFO - PROCESS | 4220 | |8;Splay;572.737686139748 16:08:38 INFO - PROCESS | 4220 | |9;NavierStokes;4845.410628019324 16:08:38 INFO - PROCESS | 4220 | __end_tp_report 16:08:38 INFO - PROCESS | 4220 | __startTimestamp1452211718535__endTimestamp 16:08:38 INFO - PROCESS | 4220 | 16:08:38 INFO - PROCESS | 4220 | ------- Summary: start ------- 16:08:38 INFO - PROCESS | 4220 | Number of tests: 10 16:08:38 INFO - PROCESS | 4220 | 16:08:38 INFO - PROCESS | 4220 | [#0] Richards Cycles:1 Average:167.62 Median:167.62 stddev:0.00 (0.0%) 16:08:38 INFO - PROCESS | 4220 | Values: 167.6 16:08:38 INFO - PROCESS | 4220 | 16:08:38 INFO - PROCESS | 4220 | [#1] DeltaBlue Cycles:1 Average:189.72 Median:189.72 stddev:0.00 (0.0%) 16:08:38 INFO - PROCESS | 4220 | Values: 189.7 16:08:38 INFO - PROCESS | 4220 | 16:08:38 INFO - PROCESS | 4220 | [#2] Encrypt Cycles:1 Average:283.05 Median:283.05 stddev:0.00 (0.0%) 16:08:38 INFO - PROCESS | 4220 | Values: 283.0 16:08:38 INFO - PROCESS | 4220 | 16:08:38 INFO - PROCESS | 4220 | [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 16:08:38 INFO - PROCESS | 4220 | Values: 5175.3 16:08:38 INFO - PROCESS | 4220 | 16:08:38 INFO - PROCESS | 4220 | [#4] RayTrace Cycles:1 Average:1070.66 Median:1070.66 stddev:0.00 (0.0%) 16:08:38 INFO - PROCESS | 4220 | Values: 1070.7 16:08:38 INFO - PROCESS | 4220 | 16:08:38 INFO - PROCESS | 4220 | [#5] Earley Cycles:1 Average:705.22 Median:705.22 stddev:0.00 (0.0%) 16:08:38 INFO - PROCESS | 4220 | Values: 705.2 16:08:38 INFO - PROCESS | 4220 | 16:08:38 INFO - PROCESS | 4220 | [#6] Boyer Cycles:1 Average:12168.67 Median:12168.67 stddev:0.00 (0.0%) 16:08:38 INFO - PROCESS | 4220 | Values: 12168.7 16:08:38 INFO - PROCESS | 4220 | 16:08:38 INFO - PROCESS | 4220 | [#7] RegExp Cycles:1 Average:41693.88 Median:41693.88 stddev:0.00 (0.0%) 16:08:38 INFO - PROCESS | 4220 | Values: 41693.9 16:08:38 INFO - PROCESS | 4220 | 16:08:38 INFO - PROCESS | 4220 | [#8] Splay Cycles:1 Average:572.74 Median:572.74 stddev:0.00 (0.0%) 16:08:38 INFO - PROCESS | 4220 | Values: 572.7 16:08:38 INFO - PROCESS | 4220 | 16:08:38 INFO - PROCESS | 4220 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 16:08:38 INFO - PROCESS | 4220 | Values: 4845.4 16:08:38 INFO - PROCESS | 4220 | -------- Summary: end -------- 16:08:38 INFO - PROCESS | 4220 | 16:08:39 INFO - TEST-INFO | 4220: exit 0 16:08:39 INFO - TEST-OK | v8_7 | took 40104ms 16:08:39 INFO - SUITE-END | took 1212s 16:08:39 INFO - Completed test suite (00:20:13) 16:08:39 INFO - Working with test: dromaeo_css 16:08:39 INFO - Generating results file: dromaeo_css 16:08:39 INFO - Working with test: kraken 16:08:39 INFO - Generating results file: kraken 16:08:39 INFO - javascript benchmark 16:08:39 INFO - Working with test: v8_7 16:08:39 INFO - Generating results file: v8_7 16:08:39 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:08:39 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 16:08:39 INFO - process_Request line: dromaeo_css 6928.22 graph.html#tests=[[72,63,43]] 16:08:39 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:08:39 INFO - process_Request line: kraken 1525.90 graph.html#tests=[[232,63,43]] 16:08:39 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:08:39 INFO - process_Request line: v8_7 20446.97 graph.html#tests=[[230,63,43]] 16:08:39 INFO - RETURN: dromaeo_css: 6928.22 16:08:39 INFO - RETURN: kraken: 1525.90 16:08:39 INFO - RETURN: v8_7: 20446.97 16:08:39 INFO - javascript benchmark 16:08:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3124.3282694220743, 3197.104810653015, 3217.1957010747315, 3259.1689119274583, 3265.6244531878842, 5125.8462246132585, 5173.198154286082, 5204.687718736878, 5252.579793616511, 5278.1291086970605, 5134.486551344864, 5186.170212765958, 5190.532852043315, 5207.0106679730825, 5302.337207849019, 4793.041391721652, 4804.687695299812, 4839.467658557547, 4882.121218180726, 4902.0, 690.3468397743281, 4766.380370551823, 4769.379980602517, 4775.235962246042, 4778.832740854071, 4767.04659068186, 4775.856724298276, 4783.402074740658, 4806.2310030394965, 4820.060088282787, 4794.808207671689, 4799.568038876518, 4803.279508073782, 4827.710337379734, 4877.439094504142, 4663.0, 4834.709917404967, 4848.903021939576, 4851.51484851512, 4868.367112275381, 5013.89972200554, 5030.84907452777, 5067.619928505377, 5078.64449488536, 5113.028524580318, 5692.17463467799, 5737.655740655574, 5739.741711622987, 5744.167095771131, 5760.855978600526, 5806.970965145148, 5808.419158084158, 5819.418058194146, 5819.73811178498, 5828.388019257959, 5231.424543300272, 5333.813316533902, 5382.138857782736, 5385.919211211835, 5388.084025715599, 5693.772249110072, 5803.564732645069, 5820.796272130455, 5832.212651292021, 5843.2695913010875, 5579.358373786985, 5594.832155035356, 5604.8038318658655, 5610.270664813548, 5635.69003704792, 5621.662700237917, 5668.433156684298, 5689.971550142305, 5724.998125328134, 5739.885202295931, 5496.80761173357, 5569.136783798518, 5588.860278492989, 5596.132599447093, 5677.09166533361, 5684.516816070681, 5703.885922281531, 5704.201411802351, 5710.857228569236, 5734.967705812994, 4195.8741237762915, 4224.218519573888, 4229.048464095616, 4271.551487093872, 4300.935485967713, 3732.42147467143, 3778.6221377862544, 3843.2505661396317, 3849.0, 3874.845006199777, 5145.4597267287145, 5255.500727430888, 5258.579313654975, 5262.473752624784, 5271.525562699376, 5558.277423934863, 5559.471850174227, 5560.499555040065, 5564.221009058735, 5580.693061881636, 5206.869828254324, 5329.1206950852675, 5414.566834653218, 5491.588130890199, 5533.944660553423, 4825.252085926687, 4829.082474329866, 4829.541193586604, 4847.442544107403, 4858.878528036827, 5723.284589426322, 5844.0, 5844.912326315109, 5851.61964472308, 5877.764889404461, 5556.444355564411, 5578.944210558005, 5685.317761868602, 5771.422857714363, 5784.161296612052, 6026.939730602638, 6033.18551995475, 6044.032954727222, 6053.424924632153, 6058.7273572688455, 5480.260164877691, 5684.488396044376, 5695.544356451557, 5706.657600543981, 5716.456936591017, 5595.132754423071, 5668.489835914787, 5745.023346031101, 5749.338826035059, 5781.277340332458, 5472.124460086367, 5512.366077900932, 5514.365847927379, 5515.862103447446, 5537.086380747131, 5371.785128594969, 5481.451854814646, 5489.835304940858, 5495.752691128989, 5545.778168873361, 5291.206319052173, 5331.653442526223, 5339.065663508793, 5351.03681337363, 5358.303420555303, 5438.0, 5439.619226654097, 5473.507384335429, 5517.61376703643, 5617.747201375866, 5571.13647384656, 5596.356419011866, 5603.5797315202335, 5604.243427137284, 5607.130894711327], "unit": "score", "name": "dojo.html", "value": 5185.97803280786}, {"lowerIsBetter": false, "replicates": [523.3353640876087, 523.4346905342234, 525.8247816130946, 551.3494076989152, 564.8785511115109, 34942.825285873565, 35701.64298357016, 35789.136869050475, 35882.461763073574, 35892.2821543569, 38476.0, 38966.415503767465, 38978.61021389785, 39060.414093788546, 39086.8045659772, 8478.152184781518, 8624.35317351198, 8692.739217823475, 8700.434471759347, 8723.084076172006, 8309.293710034653, 8469.237768600824, 8525.914740852606, 8691.39160258779, 8693.13068693132, 8704.782380440509, 8730.781730456725, 8738.038815730264, 8741.0, 8751.0, 8658.740237792876, 8686.261667758217, 8737.995130560003, 8750.299976001905, 8755.956220218859, 8518.105598912087, 8530.488170709777, 8570.785730356729, 8572.528510931896, 8634.568271586395, 38114.23771524554, 38391.0, 38463.0, 38535.8073209635, 38573.61426385756, 3188.984055079733, 3229.3903417215074, 3257.690519400653, 3352.5641666583188, 3842.346801043829, 25845.224643260543, 26457.338566535796, 26457.73542264572, 26459.603105953425, 26531.336716582045, 3579.117999512706, 3611.981940090309, 3616.263725319308, 3681.2245665798746, 3785.6782173515285, 262759.0, 262782.0, 264267.0, 265252.0, 265562.9999999981, 57491.0, 57615.0, 57666.711666442236, 57669.0, 57803.0, 54425.455745442036, 55563.0, 62043.0, 62239.68880155661, 67670.66164669146, 15217.467388641344, 15263.923680381527, 15410.921235513631, 15412.46056388021, 15447.922760386125, 11513.827292590619, 11637.592684256011, 11666.70833229176, 11669.708257293465, 11755.235909665844, 19588.314408995902, 20046.699299510517, 20110.89944550268, 20247.4938126548, 20395.184192632427, 7654.464187506821, 8317.958410208032, 8326.417150799507, 8448.0, 8510.404271701045, 978.8384916488842, 1007.8941711120227, 1045.7908418316215, 1123.7640095579857, 1131.5247596009697, 27790.583141252897, 28017.71982280192, 28117.859410703226, 28519.28701782472, 28529.57205641917, 1069.5133714160038, 1083.4691001409253, 1123.775244951013, 1124.9268797528134, 1194.0805579703579, 14788.186649734367, 14854.0, 14863.777043344358, 15017.924910375597, 15054.397824086915, 305042.0, 307457.0, 308735.0, 311993.0, 312310.0, 49713.25430118551, 50222.0, 50297.49702503001, 50314.74842625837, 50332.0, 1315.1254415813569, 1319.3073636340805, 1320.821689071963, 1328.2429015461287, 1342.8052932324758, 27139.321516961445, 28273.293167670974, 28559.42881142407, 32104.197395065312, 32237.194070147496, 47103.0, 47922.281165781846, 48406.757966209945, 48798.26802597893, 48903.510964889894, 219309.0, 219376.0, 219699.0, 219808.0, 220286.0, 40019.0, 44509.554904451834, 45537.31694024526, 46130.0, 46271.53728462672, 46291.537084628726, 46461.76769116268, 46541.76729116333, 46781.0, 46822.0, 38331.80834095923, 38441.80779096087, 38481.23037539177, 38537.229255415295, 40534.594654054265, 36514.634853652184, 36563.817180913924, 36638.267234655694, 36895.8155209233, 37753.0, 38009.42985855159, 38546.421803672405, 38803.61196388113, 38950.80524597472, 38956.80521597374, 32802.0, 35032.12419689528, 35528.0, 35678.0, 36972.630273696916, 22018.669719954534, 22208.44410936056, 22705.318840434815, 22759.203427879944, 22882.656760148944], "unit": "score", "name": "ext.html", "value": 18425.077958994905}, {"lowerIsBetter": false, "replicates": [343.4390694294432, 345.3490171027613, 352.56458274031564, 353.69582159342974, 355.0750295480274, 13886.583402497941, 14386.352614132364, 15432.614184645376, 15963.84036159638, 17809.376671816473, 13898.166110033406, 13957.371918263678, 15058.849411505882, 15082.170480623561, 15118.395264189447, 5181.326427564431, 5268.578513718903, 5404.4595540445835, 5406.756695948692, 5424.186372044205, 5319.281896943921, 6037.6075555089, 6308.274548426921, 6317.452224205076, 6318.083877837711, 6076.513878889678, 6260.9373906261035, 6270.874582508347, 6272.65500397478, 6336.873262534747, 5992.460678538909, 6143.84640383994, 6271.153394291758, 6381.521385896053, 6466.256380516254, 5685.943140568583, 5888.5289176865745, 5888.911666325009, 5907.14346419771, 5976.551758618121, 18866.245350185975, 19757.20971161152, 20612.484687882923, 22138.33584992453, 22152.113915443362, 2186.737591489016, 2204.2836078274463, 2205.5724422450517, 2365.5860224460653, 2378.108209421467, 13183.604491865259, 13258.337083145803, 13460.192388456724, 13612.863871361258, 13625.931870340684, 1956.2761778142037, 2021.6361055010093, 2027.8986050697554, 2053.5174234054984, 2074.2740040985536, 58974.41025589732, 62093.379066209214, 62878.0, 63432.365676343106, 64657.99999999953, 14244.0, 14481.348339324544, 14710.485133020293, 14868.275713850246, 14920.253987300592, 21914.890425547772, 22486.550268994855, 22547.54904901893, 22609.208677696202, 22624.773752262598, 7987.201279871966, 8012.959935200287, 8628.913710862811, 8647.524386158695, 8650.221480066699, 7359.705611775469, 7367.447441441914, 7376.077990251219, 7442.553446793209, 7478.775636730907, 4191.7275377100395, 4264.381664658607, 4299.097189590158, 4345.565443455693, 7417.703291868264, 1786.8927864328182, 1827.8446332061924, 1828.7988321284647, 1830.20386132033, 1840.9447716568525, 871.3943809052647, 907.7866701325183, 955.2024059909915, 981.5681100315838, 1040.7346126737634, 15903.920480397755, 15918.124503152438, 15960.723142148832, 16196.433124840574, 16573.254203560868, 890.8975467821283, 933.9906600934039, 954.4559601027487, 967.0571193086824, 1005.3666190300064, 8541.444806087584, 8647.0, 8922.73231803047, 8936.597853096626, 9114.589843456928, 359025.0, 420186.0, 512621.0, 534157.0, 537094.0, 68064.6396721263, 70627.99662028786, 70913.64543177355, 72305.27694722985, 72339.27660723431, 1133.637236084445, 1135.182668478694, 1135.3471753741633, 1144.713821544614, 1159.7970355187808, 14469.421223150955, 14716.77924831107, 14767.04014239071, 14792.852071479147, 14849.92575037118, 32062.67937320597, 32085.67914320827, 32259.51610725794, 33028.66971330256, 33187.83406082954, 41384.58615413928, 41874.162516750104, 42310.0, 43048.0, 44027.0, 6629.635370054693, 6913.446924246149, 6997.965010174917, 7104.573725576482, 7143.6428178591905, 3683.3369993401443, 5974.910376344272, 9413.623455061721, 9842.311038227255, 10540.209484288556, 9340.112689294507, 9443.338966272295, 9802.0, 9892.060254275832, 9997.800043999225, 9577.0, 9660.0, 9899.703008909744, 10021.849672254777, 10096.444695541815, 8353.164683531599, 8416.24253817135, 9212.95393523055, 9449.48027858447, 9572.377795443273, 6609.10777045112, 6933.5493192942295, 7145.571265724073, 7195.6761945713615, 7332.413406927326, 8611.48331100136, 9063.274938004812, 9190.656382622388, 9240.722778316662, 9494.382865113745], "unit": "score", "name": "jquery.html", "value": 8477.008930333373}, {"lowerIsBetter": false, "replicates": [1385.9376328065237, 1399.174487052639, 1516.4995551468016, 1715.6911755883943, 1715.845573898349, 7428.851422971537, 7492.700291988321, 7555.735549255777, 7569.924300756984, 7677.3858091352695, 7733.381329493641, 7739.613019349038, 7797.415193860455, 7842.8039299017555, 7891.250331218525, 2254.1434254983164, 2271.159670921753, 2283.303592404316, 2284.7486776454575, 2288.8397812153157, 2302.0791683326634, 2319.895604697784, 2343.086196383412, 2343.367290831483, 2343.5898717724417, 2195.352371050536, 2235.8434909556336, 2264.501809601893, 2281.7490076091617, 2299.2527428585695, 2306.1813056365, 2332.976670233293, 2340.227724850812, 2341.1454818991033, 2344.120954642009, 2234.3520379090046, 2279.7036385269807, 2286.702728645282, 2291.51878105598, 2297.7587353327826, 7715.537067775896, 7789.337906277973, 7805.882911756328, 7846.9215307847335, 7871.52770833746, 4538.841140560065, 4658.906821863544, 4661.09108723799, 4662.8368007119925, 4667.509911459282, 2943.234758962664, 3045.086474057774, 3086.8302243376606, 3108.518179682153, 3118.5166299223656, 961.2070042215131, 991.1872264742914, 995.1044060345674, 1025.600015993763, 1029.8506716526138, 10641.467926603716, 10687.519061642168, 10884.510197041152, 10941.781164376747, 10970.232083754141, 4248.575142485726, 4274.914501709948, 4315.482142142901, 4326.242907491176, 4351.934720979188, 9266.67566635178, 9271.860922086174, 9280.396774209656, 9281.21109705669, 9284.582193801296, 4770.0936822003705, 4826.831060912851, 4841.491643377465, 4856.125897338442, 4864.343313652683, 4284.828606855754, 4293.549177336397, 4296.5273819879785, 4365.388845561624, 4389.122175564899, 3587.7488575799443, 3625.329314076904, 3654.8172591370326, 3669.94495082574, 3677.9080522987138, 1147.3288126445955, 1148.3683973814536, 1150.7008177873813, 1168.5968340922368, 1182.2433642468827, 974.8440249560036, 981.4945303168873, 1107.3245320354577, 1111.3165403276926, 1292.6509842342703, 7018.40343570792, 7035.6482175891, 7047.260037696071, 7115.252898445692, 7116.5018448709125, 1073.3184427888348, 1142.942777930411, 1195.7907366210877, 1203.5125774061519, 1205.9939700301443, 5596.552275817925, 5632.915506267409, 5664.915026274609, 5671.120976248688, 5671.773129074873, 8814.77963050916, 8971.685990990283, 9310.301727370474, 9311.0, 9379.108984646447, 9139.0, 9159.084091590921, 9245.768855778659, 9289.256859451227, 9294.86057709135, 7164.426845852319, 7298.781036568911, 7343.3758130558435, 7411.295926886937, 7411.407087432993, 7020.0, 7028.9297107030325, 7057.682404291922, 7062.4703147263135, 7151.070360853056, 8132.3494120471405, 8463.788405289917, 8497.500149393481, 8596.140385961604, 8700.216980471789, 8726.869096963677, 8803.911960880308, 8842.646294148162, 8858.822823543622, 8898.288136949159, 6397.616143031433, 6458.580192287486, 6512.641804700597, 6546.443552297917, 6605.339466053356, 7129.500934934505, 7172.13934327884, 7205.819854503679, 7228.710851566088, 7249.311315425026, 6656.0, 6918.619475928872, 6945.722171113099, 6954.269801670752, 7105.928940710527, 6607.603543787388, 6749.527533072638, 6753.898691519533, 6876.828079298058, 6893.310668933066, 6697.196336439463, 6697.732090716511, 6710.899336509859, 6745.797626071226, 6748.156480439945, 6027.6986150693165, 6385.489160867212, 6391.073294372197, 6391.552591318563, 6392.137061496638, 6497.967510162419, 6521.184851893513, 6532.216134063943, 6535.738570457129, 6551.50863685216], "unit": "score", "name": "mootools.html", "value": 4465.28447408312}, {"lowerIsBetter": false, "replicates": [326.1926731339933, 335.9496075588663, 337.6437858059747, 337.66571094616324, 348.5590727729423, 6107.664078475682, 6146.723397447115, 6193.349698281683, 6209.9068513972325, 6354.14219080424, 6188.47397971173, 6200.131981522591, 6214.192155019841, 6219.098230756537, 6235.719392627331, 4668.136394766979, 4702.506236845134, 4759.309900064489, 4774.379330687006, 4778.2115950868065, 4758.119747846642, 4773.0, 4774.379330687006, 4776.546228108342, 4779.641526885497, 4548.363229147922, 4639.466461356937, 4655.7672116394215, 4716.834910778123, 4724.4330680318235, 4641.327007583882, 4694.671373003891, 4696.131215725101, 4701.224297990828, 4706.811727530895, 4048.817803198863, 4072.2059198456313, 4084.8570300039655, 4091.345384738457, 4096.221717873595, 5837.357890632027, 5848.766049358021, 5867.3839246879315, 5870.26621672291, 5875.500582450497, 5101.107306221396, 5361.571074314045, 5404.162354835007, 5404.83785486436, 5427.864303392407, 6546.6726663667105, 6553.475721942234, 6556.639384833832, 6561.7375304987745, 6563.967180164116, 4431.689781715281, 4448.555144485558, 4450.888727781799, 4451.399061126739, 4455.353973673799, 6492.902606460954, 6665.266820649725, 6733.8989915151315, 6762.898556521656, 6774.288699686561, 4394.384786129945, 4476.127155204704, 4478.305862591304, 4541.9545804542195, 4542.727436353829, 4527.501974782771, 4536.183486972377, 4583.747893865802, 4597.080583883237, 4598.1033698429155, 5303.284056652303, 5372.973135134299, 5398.91901621476, 5413.83758487246, 5418.431064738224, 6496.577722448026, 6547.672616369257, 6592.76925307612, 6604.273529911706, 6615.735370585219, 1621.9594510137106, 1644.350481559777, 1645.2596331650805, 1645.7366821308533, 1646.2838665180684, 1084.4577711144427, 1087.3584585094675, 1096.8903109688968, 1098.4837126550508, 1110.0453609895644, 6149.0776383542825, 6188.226471691039, 6271.498280137578, 6282.246130464374, 6293.653849038255, 6606.900896486556, 6708.597484150967, 6710.127683401224, 6764.830879228059, 6781.491388145909, 6043.939560604425, 6096.177016102858, 6173.876522469525, 6192.8761424771255, 6235.532335074888, 3621.1128273573145, 3644.0707619557375, 3656.908577285536, 3660.652238037382, 3670.908227294339, 7142.357187853118, 7143.357097861218, 7151.60666163366, 7156.606386648784, 7172.892406613801, 6838.7264509420065, 6952.826179345557, 6992.2658120897595, 6993.335633114846, 6999.0, 7084.822879428056, 7156.749513766993, 7255.746048888263, 7257.8911316330295, 7281.7087316507805, 6859.9314006859295, 6865.0732151160955, 6867.656617169221, 6873.793786186422, 6891.862162756817, 6586.275509693834, 6724.49566282521, 6726.091977582963, 6733.831654208684, 6826.283240259701, 7046.365827075588, 7103.360697537247, 7171.354578087997, 7201.567905925661, 7271.2365201653065, 4734.07685501324, 4789.544993225638, 4795.304680821331, 4796.2805579163405, 4807.495213002724, 6593.901091483727, 6757.797266082025, 6762.120924280009, 6772.729090836311, 6841.897371539331, 6582.605043697394, 6639.103720997604, 6649.0691303218555, 6652.101966234496, 6653.866922661617, 6627.569208001657, 6640.90038649411, 6643.534952553275, 6652.301508341555, 6662.200535935719, 6311.084892690626, 6451.645159516084, 6453.322401147811, 6457.580257283262, 6465.515086368447, 6534.640594767143, 6582.0, 6587.341265873374, 6658.6337751424135, 6666.500012499179, 6382.585131966407, 6417.711202995783, 6450.870982580228, 6466.127072845294, 6515.2833188348295], "unit": "score", "name": "prototype.html", "value": 4934.428840087832}, {"lowerIsBetter": false, "replicates": [737.0602481835659, 751.2374939436471, 795.3517882925415, 824.4476200945365, 883.5979629268684, 12574.0, 12811.167274127198, 12837.550685726, 12868.420921058552, 12897.161684490502, 12110.152289339727, 13951.651208719788, 14058.297085145752, 14068.366923488442, 14079.155250684966, 767.0718430698861, 783.5612057247931, 785.1089013969157, 786.2530595933857, 788.3259812860008, 784.7763387434583, 790.1624278265028, 791.1060501633175, 794.1343935110729, 797.9321757650578, 817.3012074676155, 819.9672013119468, 820.9630566624486, 821.4455242711176, 829.4401279136589, 811.8213992921607, 818.9918100819004, 821.2321479416764, 824.4764574495179, 826.3141592478258, 603.5503549855342, 603.6649659439009, 604.570754764118, 607.5746977115992, 610.5909040942579, 13494.122882012736, 13495.797563036562, 13502.594922152253, 13530.391132398967, 13533.864661353457, 12095.818562721566, 12146.574869879512, 12423.31671758053, 12798.360081995956, 12987.22076675393, 10696.893031069667, 10846.566137354497, 10864.728381790439, 10894.836577451344, 10913.0, 3561.928761424783, 3624.9275014499826, 3625.8187090645624, 3658.634136586347, 3729.086373838427, 44212.55787442117, 46600.7669961648, 46701.5329846704, 46768.5323146771, 46877.29684054742, 9485.383450075724, 9590.0, 9828.705138845846, 9866.506674666238, 10036.297459177787, 17371.131443427777, 17387.304507819797, 17432.91283543574, 17506.387276445264, 17561.385351512636, 7273.599952002585, 7388.778336649909, 7492.1384040836, 7544.434167437465, 7549.924500755032, 4136.834526618962, 4149.751014939114, 4375.518692943773, 4376.431063961728, 4455.532169122261, 2932.692067332899, 2963.155500682295, 2968.005718084423, 2969.539721343195, 2969.7178768017, 535.3575709149037, 538.1309185665201, 541.8916216756664, 542.7584724797427, 545.1305168256624, 561.6433564686454, 611.2512172588544, 625.4621025917708, 633.297040285283, 634.3497914637534, 8225.0, 8550.871736923827, 8581.785455363666, 8629.0, 8845.203931646183, 560.0115795620733, 573.5325709546789, 600.3756093662629, 634.876199141163, 689.162667359161, 3727.6086010969, 3995.62041606047, 4205.158968206371, 4234.25900467417, 4294.484661840536, 53229.0, 57585.0, 58095.70952145297, 58107.4189258102, 58137.0, 50470.74764626153, 50530.242046369334, 50630.49369506331, 50744.238836417484, 50838.23742643863, 43380.79430468364, 43826.0, 44682.3297650542, 44699.77650111729, 44772.0, 8501.914980850112, 8991.460512369016, 9005.054469280893, 9077.991633462314, 9096.1813436791, 32084.67915320817, 32632.83683581567, 32702.672973269964, 32920.555724976824, 32974.0, 41309.58690413057, 43640.56359436492, 44093.77953110214, 44268.778656106515, 44445.0, 10497.632582859564, 10672.199585030998, 10697.893021069689, 10750.301230419998, 10813.67558973232, 11455.198136130392, 11546.422678865854, 11619.535218591162, 11762.176647634584, 11764.411779411166, 11417.37204453763, 11468.770624587629, 11689.0, 11701.180917335705, 11710.882891170979, 10833.729156771144, 10835.566577337133, 10901.727456813644, 10990.450477475933, 11128.55485780592, 11386.54453821871, 11422.200445968703, 11441.855814418825, 11491.310521368745, 11538.48076836561, 9252.907470925205, 9253.491057991874, 9275.489848058422, 9308.720738377859, 9414.717558473258, 9226.446413215228, 9543.379680320757, 9553.474558899326, 9704.272179586418, 9709.9029009709], "unit": "score", "name": "yui.html", "value": 6196.161491787492}], "name": "dromaeo_css", "value": 6928.217795242842}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 106.0, 113.0, 113.0, 113.0, 124.0, 113.0, 114.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 113.3}, {"lowerIsBetter": true, "replicates": [150.0, 135.0, 149.0, 170.0, 131.0, 154.0, 157.0, 125.0, 159.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.7}, {"lowerIsBetter": true, "replicates": [163.0, 165.0, 163.0, 163.0, 163.0, 161.0, 164.0, 165.0, 169.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 73.0, 72.0, 72.0, 73.0, 151.0, 71.0, 72.0, 74.0], "unit": "score", "name": "audio-fft", "value": 80.7}, {"lowerIsBetter": true, "replicates": [97.0, 95.0, 140.0, 96.0, 96.0, 96.0, 141.0, 97.0, 97.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 112.0, 110.0, 110.0, 110.0, 109.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [149.0, 148.0, 146.0, 150.0, 150.0, 147.0, 146.0, 146.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 98.0, 98.0, 96.0, 97.0, 96.0, 97.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.9}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 59.0, 60.0, 60.0, 60.0, 60.0, 60.0, 57.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 60.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 70.0, 68.0, 70.0, 68.0, 68.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 86.0, 87.0, 88.0, 89.0, 88.0, 94.0, 89.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.0}, {"lowerIsBetter": true, "replicates": [127.0, 135.0, 117.0, 117.0, 133.0, 122.0, 121.0, 119.0, 121.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.7}, {"lowerIsBetter": true, "replicates": [140.0, 152.0, 159.0, 143.0, 150.0, 151.0, 150.0, 145.0, 150.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [79.0, 75.0, 68.0, 68.0, 68.0, 70.0, 69.0, 69.0, 68.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.3}], "name": "kraken", "value": 1525.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.61649346295675], "unit": "score", "name": "Richards", "value": 210.61173199999993}, {"lowerIsBetter": false, "replicates": [189.7173211914248], "unit": "score", "name": "DeltaBlue", "value": 348.507978}, {"lowerIsBetter": false, "replicates": [283.04557033682426], "unit": "score", "name": "Encrypt", "value": 940.4174729999997}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1070.6638115631692], "unit": "score", "name": "RayTrace", "value": 691.1497260000002}, {"lowerIsBetter": false, "replicates": [705.2186177715091], "unit": "score", "name": "Earley", "value": 945.0445340000002}, {"lowerIsBetter": false, "replicates": [12168.674698795181], "unit": "score", "name": "Boyer", "value": 54.768741584158384}, {"lowerIsBetter": false, "replicates": [41693.87755102041], "unit": "score", "name": "RegExp", "value": 21.849371023005364}, {"lowerIsBetter": false, "replicates": [572.737686139748], "unit": "score", "name": "Splay", "value": 142.28328599999995}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 20446.97169684777}]} 16:08:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20446.97"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1525.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6928.22"}}} 16:08:39 INFO - Return code: 0 16:08:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:08:39 INFO - # TBPL SUCCESS # 16:08:39 INFO - Running post-action listener: _resource_record_post_action 16:08:39 INFO - Running post-run listener: _resource_record_post_run 16:08:40 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 10371072; Write bytes: 454574080; Read time: 2968; Write time: 506408 16:08:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 9662464; Read time: 0; Write time: 13668 16:08:40 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 8609792; Write bytes: 444911616; Read time: 2912; Write time: 492740 16:08:40 INFO - Running post-run listener: _upload_blobber_files 16:08:40 INFO - Blob upload gear active. 16:08:40 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:08:40 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:08:40 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', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 16:08:40 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 Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 16:08:41 INFO - (blobuploader) - INFO - Open directory for files ... 16:08:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:08:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:08:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:42 INFO - (blobuploader) - INFO - Done attempting. 16:08:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:08:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:08:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:46 INFO - (blobuploader) - INFO - Done attempting. 16:08:46 INFO - (blobuploader) - INFO - Iteration through files over. 16:08:46 INFO - Return code: 0 16:08:46 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:08:46 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:08:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7d3d0ed08e962bf6f2dd5a6056186bf7d8fff79ad47433313c39565803b17b1e8d3035a216671bbb29b5543086bdd7ea7971b628b16489f0336de18e248d2b14", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/501ad2afe9154abdcbfabe87333e0271cc8e879e22b97e62b55ff24199602339a2ff03e11192c1fa359b11c5210e5c783732b450463b7fe80a1ea08142cd1429"} 16:08:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:08:46 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:08:46 INFO - Contents: 16:08:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7d3d0ed08e962bf6f2dd5a6056186bf7d8fff79ad47433313c39565803b17b1e8d3035a216671bbb29b5543086bdd7ea7971b628b16489f0336de18e248d2b14", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/501ad2afe9154abdcbfabe87333e0271cc8e879e22b97e62b55ff24199602339a2ff03e11192c1fa359b11c5210e5c783732b450463b7fe80a1ea08142cd1429"} 16:08:46 INFO - Copying logs to upload dir... 16:08:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1275.549338 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-07 16:08:46.032653) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 16:08:46.038467) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1452204769.723132-877318961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7d3d0ed08e962bf6f2dd5a6056186bf7d8fff79ad47433313c39565803b17b1e8d3035a216671bbb29b5543086bdd7ea7971b628b16489f0336de18e248d2b14", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/501ad2afe9154abdcbfabe87333e0271cc8e879e22b97e62b55ff24199602339a2ff03e11192c1fa359b11c5210e5c783732b450463b7fe80a1ea08142cd1429"} build_url:https://queue.taskcluster.net/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011450 build_url: 'https://queue.taskcluster.net/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7d3d0ed08e962bf6f2dd5a6056186bf7d8fff79ad47433313c39565803b17b1e8d3035a216671bbb29b5543086bdd7ea7971b628b16489f0336de18e248d2b14", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/501ad2afe9154abdcbfabe87333e0271cc8e879e22b97e62b55ff24199602339a2ff03e11192c1fa359b11c5210e5c783732b450463b7fe80a1ea08142cd1429"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 16:08:46.062678) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 16:08:46.063013) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1452204769.723132-877318961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004412 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 16:08:46.145823) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 16:08:46.146155) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 16:08:46.146440) ========= ========= Total master_lag: 0.20 =========