builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1452210449.13 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.132350) ========= 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.132814) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:29.133119) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452204729.652686-1273173551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006422 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:29.159873) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:29.160176) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:29.224746) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:29.225003) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452204729.652686-1273173551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.034839 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:29.282331) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:29.282607) ========= 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.282936) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:29.283226) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452204729.652686-1273173551 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% 220M=0s 2016-01-07 15:47:29 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088423 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:29.385014) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:29.385325) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452204729.652686-1273173551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.065201 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:29.463278) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-07 15:47:29.463585) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452204729.652686-1273173551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-07 15:47:29,680 truncating revision to first 12 chars 2016-01-07 15:47:29,680 Setting DEBUG logging. 2016-01-07 15:47:29,680 attempt 1/10 2016-01-07 15:47:29,680 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,551 unpacking tar archive at: mozilla-inbound-5d93baf4ff9c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.124286 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-07 15:47:30.599968) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:30.600282) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:30.611512) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 15:47:30.611866) ========= 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.612335) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-07 15:47:30.612666) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=934fc3100db09dcb9af4d4b6000001ab-1452204729.652686-1273173551 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 --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', 15:47:30 INFO - 'system_bits': '32', 15:47:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:47:30 INFO - 'title': 'talos-linux64-ix-057', 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:32 INFO - Running post-action listener: _resource_record_post_action 15:47:32 INFO - ##### 15:47:32 INFO - ##### Running read-buildbot-config step. 15:47:32 INFO - ##### 15:47:32 INFO - Running pre-action listener: _resource_record_pre_action 15:47:32 INFO - Running main action method: read_buildbot_config 15:47:32 INFO - Using buildbot properties: 15:47:32 INFO - { 15:47:32 INFO - "project": "", 15:47:32 INFO - "product": "firefox", 15:47:32 INFO - "script_repo_revision": "production", 15:47:32 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 15:47:32 INFO - "repository": "", 15:47:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 15:47:32 INFO - "buildid": "20160107133027", 15:47:32 INFO - "pgo_build": "True", 15:47:32 INFO - "basedir": "/builds/slave/test-pgo", 15:47:32 INFO - "buildnumber": 606, 15:47:32 INFO - "slavename": "talos-linux64-ix-057", 15:47:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:47:32 INFO - "platform": "ubuntu64_hw", 15:47:32 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 15:47:32 INFO - "branch": "mozilla-inbound", 15:47:32 INFO - "repo_path": "integration/mozilla-inbound", 15:47:32 INFO - "revision": "5d93baf4ff9c536b15818ac839e63b42964e7ead", 15:47:32 INFO - "stage_platform": "linux64-pgo", 15:47:32 INFO - "builduid": "e9b51c94a58f4f9c8eebc92c77198a85", 15:47:32 INFO - "slavebuilddir": "test" 15:47:32 INFO - } 15:47:32 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:32 INFO - Running post-action listener: _resource_record_post_action 15:47:32 INFO - ##### 15:47:32 INFO - ##### Running download-and-extract step. 15:47:32 INFO - ##### 15:47:32 INFO - Running pre-action listener: _resource_record_pre_action 15:47:32 INFO - Running main action method: download_and_extract 15:47:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 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/test_packages.json 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/test_packages.json 15:47:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/test_packages.json 15:47:32 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:32 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:33 INFO - Downloaded 1302 bytes. 15:47:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:47:33 INFO - Using the following test package requirements: 15:47:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:47:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:47:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:33 INFO - u'jsshell-linux-x86_64.zip'], 15:47:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:47:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:47:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:47:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:47:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:47:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:47:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:47:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:33 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:33 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:33 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:33 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:33 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:34 INFO - Downloaded 24067193 bytes. 15:47:34 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:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:47:34 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:35 INFO - Return code: 0 15:47:35 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:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:35 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:35 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:35 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:35 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:35 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:40 INFO - Downloaded 24067193 bytes. 15:47:40 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:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:47:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:47:41 INFO - Return code: 0 15:47:41 INFO - 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.talos.tests.zip matches https://queue.taskcluster.net 15:47:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 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.talos.tests.zip 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.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:47:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/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:45 INFO - Downloaded 11132285 bytes. 15:47:45 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:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:47:45 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:45 INFO - Return code: 0 15:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:45 INFO - https://queue.taskcluster.net/v1/task/HIhHj--GSe2nerXBxPVxBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:47:45 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:45 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:45 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:45 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:47 INFO - Downloaded 55961013 bytes. 15:47:47 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:47 INFO - mkdir: /builds/slave/test-pgo/properties 15:47:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:47:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:47:47 INFO - Contents: 15:47:47 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:47 INFO - Running post-action listener: _resource_record_post_action 15:47:47 INFO - Running post-action listener: set_extra_try_arguments 15:47:47 INFO - ##### 15:47:47 INFO - ##### Running populate-webroot step. 15:47:47 INFO - ##### 15:47:47 INFO - Running pre-action listener: _resource_record_pre_action 15:47:47 INFO - Running main action method: populate_webroot 15:47:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:47:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:47:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:47:47 INFO - '--tppagecycles', 15:47:47 INFO - '7'], 15:47:47 INFO - 'tests': ['tsvgm']}}, 15:47:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:47:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:47:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:47:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:47:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:47:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:47:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:47:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:47 INFO - 'talos_options': ['--e10s'], 15:47:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:47:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:47 INFO - 'tests': ['damp', 'tps']}, 15:47:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:47 INFO - 'talos_options': ['--e10s'], 15:47:47 INFO - 'tests': ['damp', 'tps']}, 15:47:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:47:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:47:47 INFO - 'other': {'tests': ['a11yr', 15:47:47 INFO - 'ts_paint', 15:47:47 INFO - 'tpaint', 15:47:47 INFO - 'sessionrestore', 15:47:47 INFO - 'sessionrestore_no_auto_restore']}, 15:47:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:47:47 INFO - 'tests': ['a11yr', 15:47:47 INFO - 'ts_paint', 15:47:47 INFO - 'tpaint', 15:47:47 INFO - 'sessionrestore', 15:47:47 INFO - 'sessionrestore_no_auto_restore']}, 15:47:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:47:47 INFO - 'tests': ['a11yr', 15:47:47 INFO - 'ts_paint', 15:47:47 INFO - 'tpaint', 15:47:47 INFO - 'sessionrestore', 15:47:47 INFO - 'sessionrestore_no_auto_restore']}, 15:47:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:47:47 INFO - 'tests': ['a11yr', 15:47:47 INFO - 'ts_paint', 15:47:47 INFO - 'tpaint', 15:47:47 INFO - 'sessionrestore', 15:47:47 INFO - 'sessionrestore_no_auto_restore']}, 15:47:47 INFO - 'other_l64': {'tests': ['a11yr', 15:47:47 INFO - 'ts_paint', 15:47:47 INFO - 'tpaint', 15:47:47 INFO - 'sessionrestore', 15:47:47 INFO - 'sessionrestore_no_auto_restore']}, 15:47:47 INFO - 'other_nol64': {'tests': ['a11yr', 15:47:47 INFO - 'ts_paint', 15:47:47 INFO - 'tpaint', 15:47:47 INFO - 'sessionrestore', 15:47:47 INFO - 'sessionrestore_no_auto_restore']}, 15:47:47 INFO - 'svgr': {'tests': ['tsvgx', 15:47:47 INFO - 'tsvgr_opacity', 15:47:47 INFO - 'tart', 15:47:47 INFO - 'tscrollx', 15:47:47 INFO - 'cart']}, 15:47:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:47:47 INFO - 'tests': ['tsvgx', 15:47:47 INFO - 'tsvgr_opacity', 15:47:47 INFO - 'tart', 15:47:47 INFO - 'tscrollx', 15:47:47 INFO - 'cart']}, 15:47:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:47 INFO - 'tests': ['tp5o']}, 15:47:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:47 INFO - 'talos_options': ['--e10s'], 15:47:47 INFO - 'tests': ['tp5o']}, 15:47:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:47 INFO - 'talos_options': ['--xperf_path', 15:47:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:47:47 INFO - 'tests': ['tp5n']}, 15:47:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:47 INFO - 'talos_options': ['--e10s', 15:47:47 INFO - '--xperf_path', 15:47:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:47:47 INFO - 'tests': ['tp5n']}}, 15:47:47 INFO - 'talos.zip': {'path': '', 15:47:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:47:47 INFO - Running post-action listener: _resource_record_post_action 15:47:47 INFO - ##### 15:47:47 INFO - ##### Running create-virtualenv step. 15:47:47 INFO - ##### 15:47:47 INFO - Running pre-action listener: _resource_record_pre_action 15:47:47 INFO - Running main action method: create_virtualenv 15:47:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:47:47 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:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:47:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:47:47 INFO - Using real prefix '/usr' 15:47:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:47:47 INFO - Installing distribute.............................................................................................................................................................................................done. 15:47:49 INFO - Installing pip.................done. 15:47:49 INFO - Return code: 0 15:47:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:47:49 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:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:49 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:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:49 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 0x7f9ba3cc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13df7f0>, '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 0x134b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134b760>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452204729.652686-1273173551', '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:49 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:49 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:49 INFO - Using env: {'DISPLAY': ':0', 15:47:49 INFO - 'HOME': '/home/cltbld', 15:47:49 INFO - 'LANG': 'en_US.UTF-8', 15:47:49 INFO - 'LANGUAGE': 'en_US:en', 15:47:49 INFO - 'LOGNAME': 'cltbld', 15:47:49 INFO - 'MAIL': '/var/mail/cltbld', 15:47:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:49 INFO - 'MOZ_NO_REMOTE': '1', 15:47:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:49 INFO - 'NO_EM_RESTART': '1', 15:47:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:49 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:49 INFO - 'SHELL': '/bin/bash', 15:47:49 INFO - 'SHLVL': '1', 15:47:49 INFO - 'TERM': 'linux', 15:47:49 INFO - 'TMOUT': '86400', 15:47:49 INFO - 'USER': 'cltbld', 15:47:49 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452204729.652686-1273173551', 15:47:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:49 INFO - '_': '/tools/buildbot/bin/python'} 15:47:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:50 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:50 INFO - Cleaning up... 15:47:50 INFO - Return code: 0 15:47:50 INFO - Installing psutil>=0.7.1 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', '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 0x7f9ba3cc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13df7f0>, '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 0x134b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134b760>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452204729.652686-1273173551', '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', 'psutil>=0.7.1'] 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 psutil>=0.7.1 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': '934fc3100db09dcb9af4d4b6000001ab-1452204729.652686-1273173551', 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 psutil>=0.7.1 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:51 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 15:47:51 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:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:47:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:47:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:47:52 INFO - Installing collected packages: psutil 15:47:52 INFO - Running setup.py install for psutil 15:47:52 INFO - building 'psutil._psutil_linux' extension 15:47:52 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:52 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:52 INFO - building 'psutil._psutil_posix' extension 15:47:52 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:52 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:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:47:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:47:52 INFO - Successfully installed psutil 15:47:52 INFO - Cleaning up... 15:47:52 INFO - Return code: 0 15:47:52 INFO - Installing mozsystemmonitor==0.0.0 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', '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 0x7f9ba3cc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13df7f0>, '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 0x134b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134b760>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452204729.652686-1273173551', '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', 'mozsystemmonitor==0.0.0'] 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 mozsystemmonitor==0.0.0 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': '934fc3100db09dcb9af4d4b6000001ab-1452204729.652686-1273173551', 15:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:52 INFO - '_': '/tools/buildbot/bin/python'} 15:47:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:47:52 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:52 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 - 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:52 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:52 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:52 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 mozsystemmonitor-0.0.tar.gz 15:47:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:47:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:47:54 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:54 INFO - Installing collected packages: mozsystemmonitor 15:47:54 INFO - Running setup.py install for mozsystemmonitor 15:47:54 INFO - Successfully installed mozsystemmonitor 15:47:54 INFO - Cleaning up... 15:47:55 INFO - Return code: 0 15:47:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:47:55 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:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:55 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:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:55 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 0x7f9ba3cc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13df7f0>, '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 0x134b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134b760>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452204729.652686-1273173551', '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:55 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:55 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:55 INFO - Using env: {'DISPLAY': ':0', 15:47:55 INFO - 'HOME': '/home/cltbld', 15:47:55 INFO - 'LANG': 'en_US.UTF-8', 15:47:55 INFO - 'LANGUAGE': 'en_US:en', 15:47:55 INFO - 'LOGNAME': 'cltbld', 15:47:55 INFO - 'MAIL': '/var/mail/cltbld', 15:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:55 INFO - 'MOZ_NO_REMOTE': '1', 15:47:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:55 INFO - 'NO_EM_RESTART': '1', 15:47:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:55 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:55 INFO - 'SHELL': '/bin/bash', 15:47:55 INFO - 'SHLVL': '1', 15:47:55 INFO - 'TERM': 'linux', 15:47:55 INFO - 'TMOUT': '86400', 15:47:55 INFO - 'USER': 'cltbld', 15:47:55 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452204729.652686-1273173551', 15:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:55 INFO - '_': '/tools/buildbot/bin/python'} 15:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:55 INFO - Downloading/unpacking 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:56 INFO - Downloading blobuploader-1.2.4.tar.gz 15:47:57 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:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:47:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:47:57 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:57 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:57 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:57 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:57 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:57 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:57 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:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:47:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:47:57 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:57 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:57 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:57 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:57 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:57 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:57 INFO - Downloading docopt-0.6.1.tar.gz 15:47:57 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:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:47:57 INFO - Installing collected packages: blobuploader, requests, docopt 15:47:57 INFO - Running setup.py install for blobuploader 15:47:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:47:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:47:57 INFO - Running setup.py install for requests 15:47:58 INFO - Running setup.py install for docopt 15:47:58 INFO - Successfully installed blobuploader requests docopt 15:47:58 INFO - Cleaning up... 15:47:58 INFO - Return code: 0 15:47:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:58 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 0x7f9ba3cc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13df7f0>, '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 0x134b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134b760>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452204729.652686-1273173551', '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:58 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:58 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:58 INFO - Using env: {'DISPLAY': ':0', 15:47:58 INFO - 'HOME': '/home/cltbld', 15:47:58 INFO - 'LANG': 'en_US.UTF-8', 15:47:58 INFO - 'LANGUAGE': 'en_US:en', 15:47:58 INFO - 'LOGNAME': 'cltbld', 15:47:58 INFO - 'MAIL': '/var/mail/cltbld', 15:47:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:58 INFO - 'MOZ_NO_REMOTE': '1', 15:47:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:58 INFO - 'NO_EM_RESTART': '1', 15:47:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:58 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:58 INFO - 'SHELL': '/bin/bash', 15:47:58 INFO - 'SHLVL': '1', 15:47:58 INFO - 'TERM': 'linux', 15:47:58 INFO - 'TMOUT': '86400', 15:47:58 INFO - 'USER': 'cltbld', 15:47:58 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452204729.652686-1273173551', 15:47:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:58 INFO - '_': '/tools/buildbot/bin/python'} 15:47:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:47:58 INFO - Running setup.py (path:/tmp/pip-_cmfXt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:47:58 INFO - Running setup.py (path:/tmp/pip-W75PJe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:47:58 INFO - Running setup.py (path:/tmp/pip-NvC_1e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:47:58 INFO - Running setup.py (path:/tmp/pip-yhQDlo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:47:58 INFO - Running setup.py (path:/tmp/pip-PPUtac-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:47:58 INFO - Running setup.py (path:/tmp/pip-rwh5Jf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:47:58 INFO - Running setup.py (path:/tmp/pip-vHyOiH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:47:59 INFO - Running setup.py (path:/tmp/pip-e1sCIY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:47:59 INFO - Running setup.py (path:/tmp/pip-IX8ROA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:47:59 INFO - Running setup.py (path:/tmp/pip-ATq7LF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:47:59 INFO - Running setup.py (path:/tmp/pip-Ow3ytz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:47:59 INFO - Running setup.py (path:/tmp/pip-yy6hWY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:47:59 INFO - Running setup.py (path:/tmp/pip-Pg6Xqq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:47:59 INFO - Running setup.py (path:/tmp/pip-MkNhu6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:47:59 INFO - Running setup.py (path:/tmp/pip-bque0D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:47:59 INFO - Running setup.py (path:/tmp/pip-oHWZ9E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:47:59 INFO - Running setup.py (path:/tmp/pip-Xfjz6p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:47:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:47:59 INFO - Running setup.py install for manifestparser 15:47:59 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:47:59 INFO - Running setup.py install for mozcrash 15:47:59 INFO - Running setup.py install for mozdebug 15:48:00 INFO - Running setup.py install for mozdevice 15:48:00 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:48:00 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:48:00 INFO - Running setup.py install for mozfile 15:48:00 INFO - Running setup.py install for mozhttpd 15:48:00 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:48:00 INFO - Running setup.py install for mozinfo 15:48:00 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:48:00 INFO - Running setup.py install for mozInstall 15:48:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:48:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:48:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:48:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:48:00 INFO - Running setup.py install for mozleak 15:48:00 INFO - Running setup.py install for mozlog 15:48:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:48:00 INFO - Running setup.py install for moznetwork 15:48:00 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:48:00 INFO - Running setup.py install for mozprocess 15:48:00 INFO - Running setup.py install for mozprofile 15:48:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:48:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:48:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:48:01 INFO - Running setup.py install for mozrunner 15:48:01 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:48:01 INFO - Running setup.py install for mozscreenshot 15:48:01 INFO - Running setup.py install for moztest 15:48:01 INFO - Running setup.py install for mozversion 15:48:01 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:48:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:48:01 INFO - Cleaning up... 15:48:01 INFO - Return code: 0 15:48:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f9ba3cc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13df7f0>, '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 0x134b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134b760>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452204729.652686-1273173551', '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:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 15:48:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:48:01 INFO - Using env: {'DISPLAY': ':0', 15:48:01 INFO - 'HOME': '/home/cltbld', 15:48:01 INFO - 'LANG': 'en_US.UTF-8', 15:48:01 INFO - 'LANGUAGE': 'en_US:en', 15:48:01 INFO - 'LOGNAME': 'cltbld', 15:48:01 INFO - 'MAIL': '/var/mail/cltbld', 15:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:01 INFO - 'MOZ_NO_REMOTE': '1', 15:48:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:01 INFO - 'NO_EM_RESTART': '1', 15:48:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:48:01 INFO - 'PWD': '/builds/slave/test-pgo', 15:48:01 INFO - 'SHELL': '/bin/bash', 15:48:01 INFO - 'SHLVL': '1', 15:48:01 INFO - 'TERM': 'linux', 15:48:01 INFO - 'TMOUT': '86400', 15:48:01 INFO - 'USER': 'cltbld', 15:48:01 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452204729.652686-1273173551', 15:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:01 INFO - '_': '/tools/buildbot/bin/python'} 15:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:48:01 INFO - Running setup.py (path:/tmp/pip-s7oljR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 15:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:48:01 INFO - Running setup.py (path:/tmp/pip-ZRf2QY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:48:01 INFO - Running setup.py (path:/tmp/pip-HnwAKm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 15:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:48:01 INFO - Running setup.py (path:/tmp/pip-gy3PhC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:48:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:48:02 INFO - Running setup.py (path:/tmp/pip-FHbcet-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:48:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 15:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:48:02 INFO - Running setup.py (path:/tmp/pip-cC0foQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:48:02 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:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:48:02 INFO - Running setup.py (path:/tmp/pip-ZXMvcC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:48:02 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:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:48:02 INFO - Running setup.py (path:/tmp/pip-uZoM7d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:48:02 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:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:48:02 INFO - Running setup.py (path:/tmp/pip-CsClVZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:48:02 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:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:48:02 INFO - Running setup.py (path:/tmp/pip-vrt_mE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:48:02 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:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:48:02 INFO - Running setup.py (path:/tmp/pip-kUwsDS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:48:02 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:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:48:02 INFO - Running setup.py (path:/tmp/pip-NRNPDn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:48:02 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:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:48:02 INFO - Running setup.py (path:/tmp/pip-RL9yHu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:48:02 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:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:48:02 INFO - Running setup.py (path:/tmp/pip-ovpmvp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:48:02 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:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:48:02 INFO - Running setup.py (path:/tmp/pip-5ygfH4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:48:02 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:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:48:02 INFO - Running setup.py (path:/tmp/pip-WgfhIS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:48:02 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:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:48:02 INFO - Running setup.py (path:/tmp/pip-Zte1VS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:48:02 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:02 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:02 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:02 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:02 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:02 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:02 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:02 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:02 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 - 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:02 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:02 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:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:04 INFO - Downloading blessings-1.5.1.tar.gz 15:48:04 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:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:48:04 INFO - Installing collected packages: blessings 15:48:04 INFO - Running setup.py install for blessings 15:48:04 INFO - Successfully installed blessings 15:48:04 INFO - Cleaning up... 15:48:04 INFO - Return code: 0 15:48:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:48:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:48:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:48:05 INFO - Reading from file tmpfile_stdout 15:48:05 INFO - Current package versions: 15:48:05 INFO - argparse == 1.2.1 15:48:05 INFO - blessings == 1.5.1 15:48:05 INFO - blobuploader == 1.2.4 15:48:05 INFO - docopt == 0.6.1 15:48:05 INFO - manifestparser == 1.1 15:48:05 INFO - mozInstall == 1.12 15:48:05 INFO - mozcrash == 0.16 15:48:05 INFO - mozdebug == 0.1 15:48:05 INFO - mozdevice == 0.47 15:48:05 INFO - mozfile == 1.2 15:48:05 INFO - mozhttpd == 0.7 15:48:05 INFO - mozinfo == 0.9 15:48:05 INFO - mozleak == 0.1 15:48:05 INFO - mozlog == 3.1 15:48:05 INFO - moznetwork == 0.27 15:48:05 INFO - mozprocess == 0.22 15:48:05 INFO - mozprofile == 0.28 15:48:05 INFO - mozrunner == 6.11 15:48:05 INFO - mozscreenshot == 0.1 15:48:05 INFO - mozsystemmonitor == 0.0 15:48:05 INFO - moztest == 0.7 15:48:05 INFO - mozversion == 1.4 15:48:05 INFO - psutil == 3.1.1 15:48:05 INFO - requests == 1.2.3 15:48:05 INFO - wsgiref == 0.1.2 15:48:05 INFO - Installing None 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', '-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 0x7f9ba3cc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13df7f0>, '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 0x134b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134b760>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452204729.652686-1273173551', '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', '-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:05 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: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': '934fc3100db09dcb9af4d4b6000001ab-1452204729.652686-1273173551', 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 - 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:05 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:05 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:05 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:05 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:05 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:05 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:05 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:05 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:05 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:05 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:05 INFO - Cleaning up... 15:48:05 INFO - Return code: 0 15:48:05 INFO - Installing jsonschema 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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ba3cc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13df7f0>, '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 0x134b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134b760>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452204729.652686-1273173551', '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', 'jsonschema'] 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 jsonschema 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': '934fc3100db09dcb9af4d4b6000001ab-1452204729.652686-1273173551', 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 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:07 INFO - Downloading jsonschema-2.5.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%2Fjsonschema-2.5.1-py2.py3-none-any.whl 15:48:07 INFO - Downloading/unpacking functools32 (from jsonschema) 15:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:07 INFO - Downloading functools32-3.2.3-2.tar.gz 15:48:07 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:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:48:07 INFO - warning: no files found matching '*.txt' 15:48:07 INFO - no previously-included directories found matching 'build' 15:48:07 INFO - no previously-included directories found matching 'dist' 15:48:07 INFO - no previously-included directories found matching '.git*' 15:48:07 INFO - Installing collected packages: jsonschema, functools32 15:48:07 INFO - Running setup.py install for functools32 15:48:07 INFO - warning: no files found matching '*.txt' 15:48:07 INFO - no previously-included directories found matching 'build' 15:48:07 INFO - no previously-included directories found matching 'dist' 15:48:07 INFO - no previously-included directories found matching '.git*' 15:48:07 INFO - Successfully installed jsonschema functools32 15:48:07 INFO - Cleaning up... 15:48:07 INFO - Return code: 0 15:48:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:07 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 0x7f9ba3cc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13df7f0>, '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 0x134b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134b760>, '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': '934fc3100db09dcb9af4d4b6000001ab-1452204729.652686-1273173551', '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:07 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:07 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:07 INFO - Using env: {'DISPLAY': ':0', 15:48:07 INFO - 'HOME': '/home/cltbld', 15:48:07 INFO - 'LANG': 'en_US.UTF-8', 15:48:07 INFO - 'LANGUAGE': 'en_US:en', 15:48:07 INFO - 'LOGNAME': 'cltbld', 15:48:07 INFO - 'MAIL': '/var/mail/cltbld', 15:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:07 INFO - 'MOZ_NO_REMOTE': '1', 15:48:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:07 INFO - 'NO_EM_RESTART': '1', 15:48:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:48:07 INFO - 'PWD': '/builds/slave/test-pgo', 15:48:07 INFO - 'SHELL': '/bin/bash', 15:48:07 INFO - 'SHLVL': '1', 15:48:07 INFO - 'TERM': 'linux', 15:48:07 INFO - 'TMOUT': '86400', 15:48:07 INFO - 'USER': 'cltbld', 15:48:07 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452204729.652686-1273173551', 15:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:07 INFO - '_': '/tools/buildbot/bin/python'} 15:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:07 INFO - Downloading/unpacking 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:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:48:09 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:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:48:09 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:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:10 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:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:48:10 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:10 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:10 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:10 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:10 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:10 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:10 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:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:48:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:48:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:48:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:48:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:48:10 INFO - no previously-included directories found matching 'docs/_build' 15:48:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:48:10 INFO - Running setup.py install for pep8 15:48:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:48:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:48:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:48:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:48:10 INFO - no previously-included directories found matching 'docs/_build' 15:48:10 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:48:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:48:10 INFO - Cleaning up... 15:48:10 INFO - Return code: 0 15:48:10 INFO - Running post-action listener: _resource_record_post_action 15:48:10 INFO - Running post-action listener: _start_resource_monitoring 15:48:10 INFO - Starting resource monitoring. 15:48:10 INFO - ##### 15:48:10 INFO - ##### Running install step. 15:48:10 INFO - ##### 15:48:10 INFO - Running pre-action listener: _resource_record_pre_action 15:48:10 INFO - Running main action method: install 15:48:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:48:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:48:10 INFO - Reading from file tmpfile_stdout 15:48:10 INFO - Detecting whether we're running mozinstall >=1.0... 15:48:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:48:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:48:10 INFO - Reading from file tmpfile_stdout 15:48:10 INFO - Output received: 15:48:10 INFO - Usage: mozinstall [options] installer 15:48:10 INFO - Options: 15:48:10 INFO - -h, --help show this help message and exit 15:48:10 INFO - -d DEST, --destination=DEST 15:48:10 INFO - Directory to install application into. [default: 15:48:10 INFO - "/builds/slave/test-pgo"] 15:48:10 INFO - --app=APP Application being installed. [default: firefox] 15:48:10 INFO - mkdir: /builds/slave/test-pgo/build/application 15:48:10 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:10 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:26 INFO - Reading from file tmpfile_stdout 15:48:26 INFO - Output received: 15:48:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:48:26 INFO - Running post-action listener: _resource_record_post_action 15:48:26 INFO - ##### 15:48:26 INFO - ##### Running run-tests step. 15:48:26 INFO - ##### 15:48:26 INFO - Running pre-action listener: _resource_record_pre_action 15:48:26 INFO - Running main action method: run_tests 15:48:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:48:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:48:26 INFO - Python 2.7.3 15:48:26 INFO - Return code: 0 15:48:26 INFO - grabbing minidump binary from tooltool 15:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:26 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 0x13df7f0>, '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 0x134b2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134b760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:48:26 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:26 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:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:48:26 INFO - Return code: 0 15:48:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:48:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:48:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:48:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:48:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:48:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 15:48:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 15:48:27 INFO - Return code: 0 15:48:27 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', '--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-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 15:48:27 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 --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-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 15:48:27 INFO - Using env: {'DISPLAY': ':0', 15:48:27 INFO - 'HOME': '/home/cltbld', 15:48:27 INFO - 'LANG': 'en_US.UTF-8', 15:48:27 INFO - 'LANGUAGE': 'en_US:en', 15:48:27 INFO - 'LOGNAME': 'cltbld', 15:48:27 INFO - 'MAIL': '/var/mail/cltbld', 15:48:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:48:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:27 INFO - 'MOZ_NO_REMOTE': '1', 15:48:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:27 INFO - 'NO_EM_RESTART': '1', 15:48:27 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:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:48:27 INFO - 'PWD': '/builds/slave/test-pgo', 15:48:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:48:27 INFO - 'SHELL': '/bin/bash', 15:48:27 INFO - 'SHLVL': '1', 15:48:27 INFO - 'TERM': 'linux', 15:48:27 INFO - 'TMOUT': '86400', 15:48:27 INFO - 'USER': 'cltbld', 15:48:27 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1452204729.652686-1273173551', 15:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:27 INFO - '_': '/tools/buildbot/bin/python'} 15:48:27 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', '--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-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:48:28 INFO - mozversion application_buildid: 20160107133027 15:48:28 INFO - mozversion application_changeset: 5d93baf4ff9c536b15818ac839e63b42964e7ead 15:48:28 INFO - mozversion application_display_name: Nightly 15:48:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:48:28 INFO - mozversion application_name: Firefox 15:48:28 INFO - mozversion application_remotingname: firefox 15:48:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:48:28 INFO - mozversion application_vendor: Mozilla 15:48:28 INFO - mozversion application_version: 46.0a1 15:48:28 INFO - mozversion platform_buildid: 20160107133027 15:48:28 INFO - mozversion platform_changeset: 5d93baf4ff9c536b15818ac839e63b42964e7ead 15:48:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:48:28 INFO - mozversion platform_version: 46.0a1 15:48:28 INFO - using testdate: 1452210508 15:48:28 INFO - actual date: 1452210508 15:48:28 INFO - starting webserver on 'localhost:35211' 15:48:28 INFO - SUITE-START | Running 3 tests 15:48:28 INFO - TEST-START | dromaeo_css 15:48:28 INFO - operating with platform_type : linux_ 15:48:28 INFO - Initialising browser for dromaeo_css test... 15:48:28 INFO - TEST-INFO | started process 10432 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpF3LSuw/profile http://localhost:35211/getInfo.html) 15:48:32 INFO - PROCESS | 10432 | __metrics Screen width/height:1600/1200 15:48:32 INFO - PROCESS | 10432 | colorDepth:24 15:48:32 INFO - PROCESS | 10432 | Browser inner width/height: 1024/697 15:48:32 INFO - PROCESS | 10432 | __metrics 15:48:32 INFO - PROCESS | 10432 | 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:32 INFO - PROCESS | 10432 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:48:33 INFO - TEST-INFO | 10432: exit 0 15:48:33 INFO - Browser initialized. 15:48:33 INFO - Running cycle 1/1 for dromaeo_css test... 15:48:33 INFO - TEST-INFO | started process 10529 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpF3LSuw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:48:45 INFO - PROCESS | 10529 | RSS: Main: 148602880 15:48:45 INFO - PROCESS | 10529 | 15:49:36 INFO - PROCESS | 10529 | 1452210576626 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:51:45 INFO - PROCESS | 10529 | Cycle 1(1): loaded http://localhost:35211/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35211/tests/dromaeo/cssquery-ext.html) 15:51:46 INFO - PROCESS | 10529 | RSS: Main: 238694400 15:51:46 INFO - PROCESS | 10529 | 15:54:48 INFO - PROCESS | 10529 | Cycle 1(1): loaded http://localhost:35211/tests/dromaeo/cssquery-ext.html (next: http://localhost:35211/tests/dromaeo/cssquery-jquery.html) 15:54:49 INFO - PROCESS | 10529 | RSS: Main: 243752960 15:54:49 INFO - PROCESS | 10529 | 15:57:51 INFO - PROCESS | 10529 | Cycle 1(1): loaded http://localhost:35211/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35211/tests/dromaeo/cssquery-mootools.html) 15:57:51 INFO - PROCESS | 10529 | RSS: Main: 238063616 15:57:51 INFO - PROCESS | 10529 | 16:00:53 INFO - PROCESS | 10529 | Cycle 1(1): loaded http://localhost:35211/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35211/tests/dromaeo/cssquery-prototype.html) 16:00:54 INFO - PROCESS | 10529 | RSS: Main: 212938752 16:00:54 INFO - PROCESS | 10529 | 16:03:56 INFO - PROCESS | 10529 | Cycle 1(1): loaded http://localhost:35211/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35211/tests/dromaeo/cssquery-yui.html) 16:03:57 INFO - PROCESS | 10529 | RSS: Main: 216276992 16:03:57 INFO - PROCESS | 10529 | 16:06:59 INFO - PROCESS | 10529 | Cycle 1(1): loaded http://localhost:35211/tests/dromaeo/cssquery-yui.html (next: http://localhost:35211/tests/dromaeo/cssquery-dojo.html) 16:06:59 INFO - PROCESS | 10529 | RSS: Main: 306040832 16:06:59 INFO - PROCESS | 10529 | 16:06:59 INFO - PROCESS | 10529 | __start_tp_report 16:06:59 INFO - PROCESS | 10529 | _x_x_mozilla_page_load 16:06:59 INFO - PROCESS | 10529 | _x_x_mozilla_page_load_details 16:06:59 INFO - PROCESS | 10529 | |i|pagename|runs| 16:06:59 INFO - PROCESS | 10529 | |0;dojo.html;3102.379524095181;3124.859381327843;3164.952525712115;3173.76196785241;3196.8721251149955;4971.925421118686;5029.145045342291;5032.723200223986;5049.7222652754035;5099.770510327035;5102.515261050204;5119.180931051023;5158.613104017195;5169.30214421053;5185.844424667266;4473.910521789562;4580.679352445339;4597.42532183477;4692.038132182912;4771.928421073687;4630.212863813143;4724.126036683225;4724.291356296549;4733.219018861883;4849.272609108627;4626.629869610423;4708.199606066977;4717.7169369837575;4725.598324142452;4749.548792864673;4731.929021064687;4742.9525704742855;4750.239961606127;4764.475907650156;4838.854834354975;4559.77201139945;4674.135284972291;4750.239961606127;4758.547937945889;4770.880727981794;4965.255211718271;4974.925376119361;4988.725620090893;4991.026749783794;5006.224035274502;5452.536534394581;5456.017916774979;5470.152126420411;5475.5072043515875;5480.04099282628;5468.535174510172;5527.39198688144;5536.307961504812;5536.667799932017;5599.580031497654;5081.339425874649;5083.262926875619;5084.3898732152375;5089.440161582223;5148.459411761749;5489.835304940858;5491.752871120809;5500.339959204921;5544.944550554524;5600.327960644749;5295.470452954673;5357.7053262070185;5390.595705322038;5396.946030539644;5502.009638265151;5515.393306736256;5534.612577119644;5538.224648549206;5539.058360078796;5542.11326187808;5484.588655850827;5504.422035686195;5507.0637991541535;5510.228568000483;5530.529904958124;5290.5238528531845;5392.487713667196;5395.70323632204;5453.809116680897;5576.637518561281;4065.9796701016307;4082.408050832613;4086.2849001425225;4104.0970986382945;4122.732022418533;3706.5737440194184;3710.350688629479;3712.4988126603103;3724.3110024645525;3740.7194460415576;4979.377577802775;5007.173816320339;5055.9241611375855;5070.757664372252;5115.437301896863;5468.699221542774;5485.50630443262;5512.91730624041;5514.145307477347;5514.448555144453;5049.545540901337;5160.870978225575;5178.559822415137;5184.611154163377;5227.215917612389;4687.6249900007915;4691.366665500182;4724.598409135262;4733.83431579893;4779.569838714532;5737.168110624019;5759.395263497357;5763.221965034751;5766.826995190151;5768.423157684198;5320.467953204648;5420.078586640359;5522.0336441121835;5524.364698059774;5555.8888822224135;5698.515626171822;5723.198752174616;5774.653520788766;5791.276090488689;5808.912866307093;5279.868003299948;5281.4190439052445;5292.364916210079;5302.549283310807;5357.892842143213;5344.786208551614;5386.703731294817;5448.536874365724;5463.31708536433;5487.478689524489;5259.605529585373;5268.1834315681135;5276.34045744282;5314.601404894725;5335.253064571041;5304.628675992643;5304.893902121858;5311.681299122065;5320;5356;5060.038592667382;5115.5396014358885;5255;5266.1574148136115;5282.207668849704;5357.0357335679955;5363.919541206963;5373.059714550016;5391.272178255886;5400.810971615974;5161.200013997836;5189.506996835295;5191.896162076813;5193.896122077613;5216.139337009351 16:06:59 INFO - PROCESS | 10529 | |1;ext.html;516.2669010005792;524.6563500906906;528.4002656984327;541.1152765228852;553.8476918847316;27643.861780691095;28303.858480707593;35805.10487237817;35815;35971.64028359715;38006.619933800655;38713.41929871054;39051;39095.21809563814;39204.80397598008;7299.4890357674985;8274.83450330993;8535.530545819978;8558.657653693845;8562.52906090168;7459.179490256068;9943.850842237336;10106.494675266244;10144.087032167103;10163.085322320989;9947.403155810638;10004.649837255698;10018.298719089667;10024.949875250613;10030.448325342104;9861.161801246903;9923;9926.9503652482;9938.15525680318;9941.999999999964;9987.750306242402;10076.798464030751;10100.292979491438;10130.138938190263;10136.645217417428;38140.42789358162;38569.421458678145;38628.80685596582;38668.80665596682;38669.613303866885;3147.166001009711;3148.984255078733;3158.478850989607;3184.4268031754277;3381.7125544328514;29384;29870.701292987225;30014.699853001628;30183.698163018307;30487.23781905448;3776.7545109568064;3788.2802267569073;3838.616138386139;3847.961520384816;3936.9015774605577;270370;271580.999999998;273041.6347918268;273223;273249;51791.48208517942;52617.7369113152;57548.42451575514;57946.71026644924;58998.410015899295;52678.47321526735;52963.47036529663;52996.735016324674;53132.20301695478;53316.20025699618;14394.280285985658;14565.635859103608;14575.489857854924;14585.489507867385;14610.853891461162;10490.685279441628;10623.946880265703;10689.412082335546;10705.30415523004;10726.249162558703;18621;18824.24703011864;18830.152643131092;18916.243350265835;18932;6844;7112.35988761014;7127.92872071283;7144.9642751785905;7147.249538798455;895.3463971300987;914.1270087066836;1000.584173394653;1024.462157367388;1060.3160961179997;27468.313292167455;28280.71719282822;28484;28699;28787.42425151485;995.6701318913777;1043.7495001199657;1046.7801761630144;1066.173715370594;1161.8257261410688;14772.92613536947;14914.179720115499;14919.627009324853;14930.776038359434;14956.626084347978;335546;337683;340977;342233;342703;50913.49086509162;51148.48851511512;51339;51347;51366.48633513617;1262.3751243134707;1295.792673172288;1309.3191540398939;1315.3094625321783;1318.723068155698;27115.1865444037;27969.52487601974;28338.716612834432;28564.285892852844;29426;40718.185636286515;41297;41325.1734965305;41350.586494135874;41423.37864931968;252832;253321;256178;256201;256382;31364.461146421065;32119.678803212602;32130.67869321277;32375.51436728404;32396.838015810714;41761;42045.78977105095;42170.36744448897;43012.35481467843;43313;31847.68152318447;32037;32244.820679414952;32286.515702264955;32532;34048.82975585106;34308.82845585756;34998.82500587481;35011.64988350084;35166;35100;35327.470087949216;35327.823360883034;35338.82330588331;36348.27303453969;27933.58099628548;28251.293717657223;31454;31916.202094947814;32024.359512809147;24137.275881723577;25174.24477265685;25294.747052529237;25353.239402817944;25465.236042918743 16:06:59 INFO - PROCESS | 10529 | |2;jquery.html;339.42128670616603;355.5413516563633;356.6736436160913;358.290584642408;359.1989862606388;12544.184627999173;15873.761893571591;16593.83406165938;17398.30406783727;17419.390321338757;14192.432302707904;14292.213928233943;14868.628284292898;14885.553433396988;14902.254887255647;3984.8206830692543;4060;4062.573429789874;5217.321748172732;5411.648242864201;5602.747876345574;5839.649621022752;5869.8826023479505;5875.941240587582;5881.235439392873;5620.831375058755;5912.17229587858;5930.288365396159;5932.37710040446;5939.227900372945;5780.566457515703;5887.528997680197;5894.322152952423;5897.64614123154;5932.822015339547;5164.561012313958;5189.091908915924;5202.297689811865;5208.401033881114;5210.895782084375;12024;12519.186252893533;19469.513262168417;19912.303069392503;19919.10364033622;2061.1137210999264;2095.8532902696816;2151.5911976724374;2161.4056134562966;2214.867107973527;9379.484128372937;9396.308664440467;12092.153549251556;12096.516139354415;12473.064520161024;1777.1203254389031;1787.2046939112101;1790.8388245057877;1825.4979880532826;1882.7081802320663;55445.72277138629;55642.16536751952;56383.43616563823;57362;57636.71181644107;9771.120599145968;9836.213102951746;9881.505924703735;9881.604735810632;9947.154491868128;13028.80456793149;13132.34338283082;13145.802812957812;13160.341982901009;13183.40674669623;7037.788866334018;7083.468739844532;7111.288871112847;7132.3580877720215;7174.282571742784;6775.898361524581;6777.220619628806;6783.728650853911;6822.181338239443;6832.282610325844;3927.410888366711;3970.7617542947514;4078.4494093297026;4130.277201489727;4142.730722503027;1769.3364988129451;1802.3961972739016;1806.3939190699703;1816.137334766002;1825.963480730378;785.4227143049853;871.8517851965181;1012.8430093335545;1024.4672770159625;1024.6413755185624;14451.638709032359;14767;15178.924105379403;15196.696066078617;15261.389544418322;881.2465342132513;890.7951171230653;903.3947255338938;940.9529523523796;968.99031009689;7793.337566306927;8556.315494760403;8796.516191609522;8820.558972051373;9694.709158725249;468828;476254;506975;514462;515271;68695;68825.65587172132;69213.65393173002;71108.2889171112;72866.63566682133;1089.8692156941058;1090.2586241355955;1118.669992352258;1138.7722455508765;1140.0309736723884;14867.107973521623;14992.47526336573;15369.538913832603;15408.15255160977;15433.382664693287;33207.50188747219;33214.833925830215;33444.49833252455;33449.16377090592;33916.32167356589;41206.38190427206;41427.7928610355;41769;41901.371479428446;42239.366409504495;7127.572345659277;7261.782146535613;7270.491065625567;7307.3058059484265;7459.104907411145;9276.350655454324;11126;11369.2609980351;11561.884381156417;11642.6507204784;9677.516124193902;9702;9736.172425343642;10021.498925053864;10113.292069555355;9411.247100232102;9572.234221262142;9913.900860991585;9925.65260215889;10069.295149339769;7433.070866141732;7552.320291173821;9432.481213533321;9803.754906127404;9898.75253118649;7383.593902335423;9277.211437027658;9665;9883.357581757164;10119.494025298853;9897.58548208351;9938.602455901682;10409.531571079471;10438.164946804389;10751.569937202737 16:06:59 INFO - PROCESS | 10529 | |3;mootools.html;1315.6973896003913;1466.4354223623905;1469.0377802539333;1578.6605879735855;1746.240385432337;6948.548344357613;7558.659860306286;7700.5379677219335;7705.113911900133;7718.151003389623;7513.812154696136;7679;7706.344960678349;7710.7686769397005;7721.150673425933;2002.6395248855201;2048.7439070116234;2054.599353126141;2223.144089525528;2257.548490301938;2028.2191356327846;2289.610766169755;2333.1367394064137;2340.028888011473;2342.472943587696;2253.7971582557566;2259.378670865517;2296.7358753743283;2297.023764899919;2302.1597117052324;2219.611567975606;2221.5112675211426;2233.653783663535;2236.2173239366252;2238.787315205061;2226.6103431899514;2249.5051088760447;2251.448395143184;2253.087499562663;2258.435391152212;7447.106347238312;7520.21037791035;7523.887141692879;7540.057492813398;7542.811429714301;4587.449506059261;4707.482176960531;4708.152532544141;4711.256834971048;4735.502772208903;2900.10096869971;2993.3265015371585;3002.1894088596173;3004.173852190643;3025.9243518911985;962.5716556132523;970.9951450242775;980.568549838069;983.5918093990986;1001.2240513601944;10753.623623173151;10947.726306842313;10982.341059536453;10984.890151098467;11011.174161937806;4392.4289842320295;4421.823127074881;4470.463544374631;4481.126180394792;4481.260592002348;9394.67118650844;9453;9466.432014079177;9468.147866691894;9470.195033422237;4889.144399730104;4896.583790377857;4898.265260210926;4898.828541001048;4901.264810278415;4332.090261045153;4341.435613370305;4391.297392417262;4392.297232442794;4396.758178300224;3494.0915362006062;3575.12409459684;3576.9821150894077;3649.4525821127045;3690.7231957603285;1154.8960593546453;1212.2847519963088;1224.4795961716236;1229.975400491985;1236.6166488388628;1003.372891942536;1025.195221750922;1026.3892983674702;1128.6670432222513;1287.3241548187277;7009.719611215596;7083.043789088407;7097;7097.183823860322;7106.040684507629;1190.5832958464468;1209.3227792436264;1220.1885745979002;1231.2735486063266;1245.103525461666;5596.4123767003875;5622.156676498558;5667.263255776805;5671;5685.715714214272;9462.337636365526;9676.661316853877;9809.411435313905;9827.508624568743;9828.4102953823;9287.535623218811;9440;9583;9663.420194788336;9682.806343873082;7056.964715176494;7205.819854503679;7262.092238470192;7265.89101163483;7288.380487658503;6970.093887794757;7027.262137475696;7028.6134262614005;7077.044598979072;7082.18554866197;7871.527708337518;8341.874871877048;8492.532910689972;8603.311735061305;8650.826983460422;8044.597770111354;8274.882890809664;8285.83428331442;8419.494830310201;8428.367872409717;6614.140161778938;6711.429528490133;6714.261431242462;6719.664016799238;6719.798406047827;6601.669916504059;6601.966990165019;6761.357671021246;7258.12902451688;7279.199288078413;6755.831104222434;6785.117934668461;6831.11195544576;6974.965125174342;6984.825379365557;6706.597604143767;6821.965890170517;6879.140107486564;6957.756478523227;7013.614251216232;7033.964830175816;7069.363757261871;7083.716651334095;7091.219965803654;7093.397061249645;6383.042543618494;6388.648624325707;6418.6469744164515;6441.967790161019;6445.065465507381;6263.56155069159;6277.466415354746;6296.811095667137;6307.369263073656;6321.1782468278825 16:06:59 INFO - PROCESS | 10529 | |4;prototype.html;315.5172585943507;331.26624526673413;334.5600535296087;336.8815532432325;340.4433750817414;5811.564132690044;5881.059030555112;5887.558433117512;5888.057910734284;5896.086106653464;5583.413741557139;5657.2928383952;5682.857928551778;5803.767849286034;5804.042333015058;4484.551544845505;4532.342810292514;4538.546145385468;4541.227991241481;4554.4990051094355;4521.502634710179;4526.547345265463;4527.343535187396;4535.523770004152;4536.206163921301;4268.082362292106;4356.956430435686;4363.629091527208;4453.042595841909;4468.218061839181;4418.270985287424;4427.0924460485685;4436.778161091933;4449.065696203768;4463.085067561142;3945.9013524661827;3973.8807835764974;3975.940360894589;3981.820818063194;3982.303096958021;5547.972260138714;5565.053940830068;5573.359063707685;5575.637583557056;5579.163125531203;5135;5226.503482169188;5234.528892399664;5235.58115350771;5238.345206849144;6168.352323006065;6168.96915515424;6174.722137503823;6178;6179.474744646711;4391.27543955247;4394.318880573516;4399.5820397062225;4400.603945644907;4403.735775853427;6294.244690637152;6457.870842583169;6464.127342808708;6467.191601049869;6472.8705425891685;4516.977415112903;4525.366448697185;4526.456825181;4531.954680453153;4534.2971839364955;4577.588017078412;4581.289900065495;4582.679212455163;4584;4585.449746030497;5232;5237.790488380499;5240.109181439165;5240.371155461369;5240.554552863049;6112.541559383064;6226.750929962751;6228.377162283826;6237.500999919996;6239.812805615838;1604.0455928722392;1622.051100106451;1623.6914986152829;1624.1554391716477;1625.089949628212;1046.9685909422728;1047.1727335405096;1083.5178345636273;1098.8022156011834;1105.3478447715725;5942.138389933435;5944.8811023780145;5959.165716799652;5963.2844058713235;5965.791197308074;6344.6827658616885;6408.487321014401;6415.550911436248;6423.261324947691;6424.646644434601;5704.828855134353;5826.980278451254;5827.446392592697;5893.410658934158;5964.224650795369;3451.5685539307588;3492.214251793326;3494.8602055917477;3499.5100685903994;3505.2638945821154;6753.628550429774;6753.763618273337;6768.69540870662;6768.72925083001;6773.559718618274;6429.357064293533;6583.407493325528;6584.8024559263295;6598.769043083469;6609.966950165219;6755.898661520081;6757.831054223586;6765.086713293741;6771.4582833373215;6782.728690852409;6398.264199616918;6404.359564043559;6413.070104834679;6418;6446.387593178641;6239;6356.141920840812;6376.202974628171;6378.394052564999;6384.201974753156;6725.630090345078;6742.6628668567355;6764.729410823512;6768.357006084414;6769;4444.222261104358;4445.533219012086;4445.644348452051;4449.822007119679;4450.6439484841785;6251.093591429127;6473.935260647333;6474.708638111202;6490.935090649222;6496.350364963466;6298.590591611531;6307.495400367868;6314.494840412848;6314.53733044104;6321.589096708699;6297.842553936005;6300.653464059521;6300.716467759054;6304.18045654062;6304.306526282197;6010.368911264254;6170.876582468236;6182.041783523561;6203.7828675996125;6207.16203312547;6283.183186185766;6331;6339.4928405726505;6349.206349206349;6353.205849268841;6190.699953009918;6191.628502289877;6194.938050619617;6198.6280823150755;6206 16:06:59 INFO - PROCESS | 10529 | |5;yui.html;748.7304570354672;762.8451849726421;814.7148498025691;840.474703310431;846.644409348074;12822.871771282284;12964.092513524058;12993.740125197513;13004.154729942547;13016.674583135415;11612.24520406173;11626;11632.767344653103;11636.941815290933;11639.6508104757;644.1979735229646;648.9643069631169;768.688681084159;773.234497847133;780.1496368957835;776.4991580430619;782.3311069035977;786.1431040166218;786.3001928283832;786.9291763741262;822.0956947357919;822.6585966823761;826.2893911236332;826.9462484938459;827.0612854410258;664.3920812456596;670.33971538035;803.5700900018462;814.3810703865105;816.1063635319316;599.9640021598674;605.6275390634772;606.7997560804923;607.5443417436923;607.9088136779518;12943.676408089874;12980.675483112904;12982.545610903573;12983;13021.609351719464;11826.231294965799;12313.507459701601;12319.076069294839;12408.255504669749;12500.812487812691;10263.178945684327;10301.433421161833;10401.427921464316;10418.062374386342;10464.895351046544;3529.082438565991;3581.516495273157;3599.3881040223223;3612.3678356287546;3730.757500762442;41026.794866025775;41082.58917410817;41099.7945010276;41108.79445602753;41376;9790.314677972616;9945.303828732063;9976.900230997742;9984.550695218733;9996.150327222122;17244.568885777706;17349.653006939792;17377.478675639497;17377.47867563975;17390.913045434692;7202.063731714844;7343.926560734431;7390.96304518474;7430.517016393917;7462.10454745434;4278.106892782811;4278.893027674333;4341.696081274344;4410.625096866802;4436.223660859337;2885.422915416925;2922.576226447196;2923.9122826315242;2925.2101932478536;2928.282570770175;533.2747463449705;550.3753240072547;557.4731878374978;558.5001423725743;559.1556749308573;658.4863806231148;672.2840175213382;678.2518158605875;680.9523333366617;687.2474640268897;8121.228483294078;8180.345572354197;8358.540280284522;8533.359998000175;8631.136886311318;559.5376869465977;620.9937900621027;660.1411336216712;664.7673314340046;694.5450729771907;3865.3042452358845;3868.7291889568023;4001.7398869073418;4018.3771515415156;4053.91892162161;55311.17033244504;55657;55788.442115579135;55919;56035.43964560384;43248;43908.78045609751;43973.56026439759;44432.55567444349;44470.55529444664;38952.61047389547;39431.40852887209;39485.21029579392;39672.80163599164;40238.597614023485;8494.362922780692;8511.446755960842;8647.654093836176;8807.559622019002;9091.727248182566;32276.677233228307;32539.837300813346;33299;33720.32559348848;33947.32105357928;39841.40237896492;40281.79859100686;40787.59212407838;40925.795371022956;41822.58177418308;10489.527971241465;10608.204384671026;10649.414282214553;10770.676879693621;11022.228444008842;11874.881251187378;12018;12110.51557937708;12192.817107743569;12624.684382890502;10158.441285729356;10404.375737455473;10653.147748179972;10902.236843421202;10996.340219586851;10618.203634727271;10751.516181771683;10881.347119172875;10901.56393744273;11278.830817537908;11242.381669008282;11384.089272858317;11543.5959741412;11756.177067605186;11775.76448471043;9001.279897608045;9185;9232.353735238468;9311.813763724553;9755.560999754885;9143.542822858963;9158.129977652112;9168.587413566538;9194.218491428304;9670.70987870365 16:06:59 INFO - PROCESS | 10529 | __end_tp_report 16:06:59 INFO - PROCESS | 10529 | __start_cc_report 16:06:59 INFO - PROCESS | 10529 | _x_x_mozilla_cycle_collect,734 16:06:59 INFO - PROCESS | 10529 | __end_cc_report 16:06:59 INFO - PROCESS | 10529 | __startTimestamp1452211619909__endTimestamp 16:06:59 INFO - PROCESS | 10529 | 16:06:59 INFO - PROCESS | 10529 | ------- Summary: start ------- 16:06:59 INFO - PROCESS | 10529 | Number of tests: 6 16:06:59 INFO - PROCESS | 10529 | 16:06:59 INFO - PROCESS | 10529 | [#0] dojo.html Cycles:165 Average:5080.46 Median:5255.00 stddev:559.59 (10.6%) stddev-sans-first:539.36 16:06:59 INFO - PROCESS | 10529 | Values: 3102.4 3124.9 3165.0 3173.8 3196.9 4971.9 5029.1 5032.7 5049.7 5099.8 5102.5 5119.2 5158.6 5169.3 5185.8 4473.9 4580.7 4597.4 4692.0 4771.9 4630.2 4724.1 4724.3 4733.2 4849.3 4626.6 4708.2 4717.7 4725.6 4749.5 4731.9 4743.0 4750.2 4764.5 4838.9 4559.8 4674.1 4750.2 4758.5 4770.9 4965.3 4974.9 4988.7 4991.0 5006.2 5452.5 5456.0 5470.2 5475.5 5480.0 5468.5 5527.4 5536.3 5536.7 5599.6 5081.3 5083.3 5084.4 5089.4 5148.5 5489.8 5491.8 5500.3 5544.9 5600.3 5295.5 5357.7 5390.6 5396.9 5502.0 5515.4 5534.6 5538.2 5539.1 5542.1 5484.6 5504.4 5507.1 5510.2 5530.5 5290.5 5392.5 5395.7 5453.8 5576.6 4066.0 4082.4 4086.3 4104.1 4122.7 3706.6 3710.4 3712.5 3724.3 3740.7 4979.4 5007.2 5055.9 5070.8 5115.4 5468.7 5485.5 5512.9 5514.1 5514.4 5049.5 5160.9 5178.6 5184.6 5227.2 4687.6 4691.4 4724.6 4733.8 4779.6 5737.2 5759.4 5763.2 5766.8 5768.4 5320.5 5420.1 5522.0 5524.4 5555.9 5698.5 5723.2 5774.7 5791.3 5808.9 5279.9 5281.4 5292.4 5302.5 5357.9 5344.8 5386.7 5448.5 5463.3 5487.5 5259.6 5268.2 5276.3 5314.6 5335.3 5304.6 5304.9 5311.7 5320.0 5356.0 5060.0 5115.5 5255.0 5266.2 5282.2 5357.0 5363.9 5373.1 5391.3 5400.8 5161.2 5189.5 5191.9 5193.9 5216.1 16:06:59 INFO - PROCESS | 10529 | 16:06:59 INFO - PROCESS | 10529 | [#1] ext.html Cycles:180 Average:45057.56 Median:32331.02 stddev:76173.98 (235.6%) stddev-sans-first:76314.25 16:06:59 INFO - PROCESS | 10529 | Values: 516.3 524.7 528.4 541.1 553.8 27643.9 28303.9 35805.1 35815.0 35971.6 38006.6 38713.4 39051.0 39095.2 39204.8 7299.5 8274.8 8535.5 8558.7 8562.5 7459.2 9943.9 10106.5 10144.1 10163.1 9947.4 10004.6 10018.3 10024.9 10030.4 9861.2 9923.0 9927.0 9938.2 9942.0 9987.8 10076.8 10100.3 10130.1 10136.6 38140.4 38569.4 38628.8 38668.8 38669.6 3147.2 3149.0 3158.5 3184.4 3381.7 29384.0 29870.7 30014.7 30183.7 30487.2 3776.8 3788.3 3838.6 3848.0 3936.9 270370.0 271581.0 273041.6 273223.0 273249.0 51791.5 52617.7 57548.4 57946.7 58998.4 52678.5 52963.5 52996.7 53132.2 53316.2 14394.3 14565.6 14575.5 14585.5 14610.9 10490.7 10623.9 10689.4 10705.3 10726.2 18621.0 18824.2 18830.2 18916.2 18932.0 6844.0 7112.4 7127.9 7145.0 7147.2 895.3 914.1 1000.6 1024.5 1060.3 27468.3 28280.7 28484.0 28699.0 28787.4 995.7 1043.7 1046.8 1066.2 1161.8 14772.9 14914.2 14919.6 14930.8 14956.6 335546.0 337683.0 340977.0 342233.0 342703.0 50913.5 51148.5 51339.0 51347.0 51366.5 1262.4 1295.8 1309.3 1315.3 1318.7 27115.2 27969.5 28338.7 28564.3 29426.0 40718.2 41297.0 41325.2 41350.6 41423.4 252832.0 253321.0 256178.0 256201.0 256382.0 31364.5 32119.7 32130.7 32375.5 32396.8 41761.0 42045.8 42170.4 43012.4 43313.0 31847.7 32037.0 32244.8 32286.5 32532.0 34048.8 34308.8 34998.8 35011.6 35166.0 35100.0 35327.5 35327.8 35338.8 36348.3 27933.6 28251.3 31454.0 31916.2 32024.4 24137.3 25174.2 25294.7 25353.2 25465.2 16:06:59 INFO - PROCESS | 10529 | 16:06:59 INFO - PROCESS | 10529 | [#2] jquery.html Cycles:180 Average:26087.18 Median:472541.00 stddev:81166.19 (17.2%) stddev-sans-first:81370.86 16:06:59 INFO - PROCESS | 10529 | Values: 339.4 355.5 356.7 358.3 359.2 12544.2 15873.8 16593.8 17398.3 17419.4 14192.4 14292.2 14868.6 14885.6 14902.3 3984.8 4060.0 4062.6 5217.3 5411.6 5602.7 5839.6 5869.9 5875.9 5881.2 5620.8 5912.2 5930.3 5932.4 5939.2 5780.6 5887.5 5894.3 5897.6 5932.8 5164.6 5189.1 5202.3 5208.4 5210.9 12024.0 12519.2 19469.5 19912.3 19919.1 2061.1 2095.9 2151.6 2161.4 2214.9 9379.5 9396.3 12092.2 12096.5 12473.1 1777.1 1787.2 1790.8 1825.5 1882.7 55445.7 55642.2 56383.4 57362.0 57636.7 9771.1 9836.2 9881.5 9881.6 9947.2 13028.8 13132.3 13145.8 13160.3 13183.4 7037.8 7083.5 7111.3 7132.4 7174.3 6775.9 6777.2 6783.7 6822.2 6832.3 3927.4 3970.8 4078.4 4130.3 4142.7 1769.3 1802.4 1806.4 1816.1 1826.0 785.4 871.9 1012.8 1024.5 1024.6 14451.6 14767.0 15178.9 15196.7 15261.4 881.2 890.8 903.4 941.0 969.0 7793.3 8556.3 8796.5 8820.6 9694.7 468828.0 476254.0 506975.0 514462.0 515271.0 68695.0 68825.7 69213.7 71108.3 72866.6 1089.9 1090.3 1118.7 1138.8 1140.0 14867.1 14992.5 15369.5 15408.2 15433.4 33207.5 33214.8 33444.5 33449.2 33916.3 41206.4 41427.8 41769.0 41901.4 42239.4 7127.6 7261.8 7270.5 7307.3 7459.1 9276.4 11126.0 11369.3 11561.9 11642.7 9677.5 9702.0 9736.2 10021.5 10113.3 9411.2 9572.2 9913.9 9925.7 10069.3 7433.1 7552.3 9432.5 9803.8 9898.8 7383.6 9277.2 9665.0 9883.4 10119.5 9897.6 9938.6 10409.5 10438.2 10751.6 16:06:59 INFO - PROCESS | 10529 | 16:06:59 INFO - PROCESS | 10529 | [#3] mootools.html Cycles:180 Average:5424.54 Median:6352.11 stddev:2829.86 (44.5%) stddev-sans-first:2820.95 16:06:59 INFO - PROCESS | 10529 | Values: 1315.7 1466.4 1469.0 1578.7 1746.2 6948.5 7558.7 7700.5 7705.1 7718.2 7513.8 7679.0 7706.3 7710.8 7721.2 2002.6 2048.7 2054.6 2223.1 2257.5 2028.2 2289.6 2333.1 2340.0 2342.5 2253.8 2259.4 2296.7 2297.0 2302.2 2219.6 2221.5 2233.7 2236.2 2238.8 2226.6 2249.5 2251.4 2253.1 2258.4 7447.1 7520.2 7523.9 7540.1 7542.8 4587.4 4707.5 4708.2 4711.3 4735.5 2900.1 2993.3 3002.2 3004.2 3025.9 962.6 971.0 980.6 983.6 1001.2 10753.6 10947.7 10982.3 10984.9 11011.2 4392.4 4421.8 4470.5 4481.1 4481.3 9394.7 9453.0 9466.4 9468.1 9470.2 4889.1 4896.6 4898.3 4898.8 4901.3 4332.1 4341.4 4391.3 4392.3 4396.8 3494.1 3575.1 3577.0 3649.5 3690.7 1154.9 1212.3 1224.5 1230.0 1236.6 1003.4 1025.2 1026.4 1128.7 1287.3 7009.7 7083.0 7097.0 7097.2 7106.0 1190.6 1209.3 1220.2 1231.3 1245.1 5596.4 5622.2 5667.3 5671.0 5685.7 9462.3 9676.7 9809.4 9827.5 9828.4 9287.5 9440.0 9583.0 9663.4 9682.8 7057.0 7205.8 7262.1 7265.9 7288.4 6970.1 7027.3 7028.6 7077.0 7082.2 7871.5 8341.9 8492.5 8603.3 8650.8 8044.6 8274.9 8285.8 8419.5 8428.4 6614.1 6711.4 6714.3 6719.7 6719.8 6601.7 6602.0 6761.4 7258.1 7279.2 6755.8 6785.1 6831.1 6975.0 6984.8 6706.6 6822.0 6879.1 6957.8 7013.6 7034.0 7069.4 7083.7 7091.2 7093.4 6383.0 6388.6 6418.6 6442.0 6445.1 6263.6 6277.5 6296.8 6307.4 6321.2 16:06:59 INFO - PROCESS | 10529 | 16:06:59 INFO - PROCESS | 10529 | [#4] prototype.html Cycles:180 Average:5230.00 Median:5887.81 stddev:1568.37 (26.6%) stddev-sans-first:1528.77 16:06:59 INFO - PROCESS | 10529 | Values: 315.5 331.3 334.6 336.9 340.4 5811.6 5881.1 5887.6 5888.1 5896.1 5583.4 5657.3 5682.9 5803.8 5804.0 4484.6 4532.3 4538.5 4541.2 4554.5 4521.5 4526.5 4527.3 4535.5 4536.2 4268.1 4357.0 4363.6 4453.0 4468.2 4418.3 4427.1 4436.8 4449.1 4463.1 3945.9 3973.9 3975.9 3981.8 3982.3 5548.0 5565.1 5573.4 5575.6 5579.2 5135.0 5226.5 5234.5 5235.6 5238.3 6168.4 6169.0 6174.7 6178.0 6179.5 4391.3 4394.3 4399.6 4400.6 4403.7 6294.2 6457.9 6464.1 6467.2 6472.9 4517.0 4525.4 4526.5 4532.0 4534.3 4577.6 4581.3 4582.7 4584.0 4585.4 5232.0 5237.8 5240.1 5240.4 5240.6 6112.5 6226.8 6228.4 6237.5 6239.8 1604.0 1622.1 1623.7 1624.2 1625.1 1047.0 1047.2 1083.5 1098.8 1105.3 5942.1 5944.9 5959.2 5963.3 5965.8 6344.7 6408.5 6415.6 6423.3 6424.6 5704.8 5827.0 5827.4 5893.4 5964.2 3451.6 3492.2 3494.9 3499.5 3505.3 6753.6 6753.8 6768.7 6768.7 6773.6 6429.4 6583.4 6584.8 6598.8 6610.0 6755.9 6757.8 6765.1 6771.5 6782.7 6398.3 6404.4 6413.1 6418.0 6446.4 6239.0 6356.1 6376.2 6378.4 6384.2 6725.6 6742.7 6764.7 6768.4 6769.0 4444.2 4445.5 4445.6 4449.8 4450.6 6251.1 6473.9 6474.7 6490.9 6496.4 6298.6 6307.5 6314.5 6314.5 6321.6 6297.8 6300.7 6300.7 6304.2 6304.3 6010.4 6170.9 6182.0 6203.8 6207.2 6283.2 6331.0 6339.5 6349.2 6353.2 6190.7 6191.6 6194.9 6198.6 6206.0 16:06:59 INFO - PROCESS | 10529 | 16:06:59 INFO - PROCESS | 10529 | [#5] yui.html Cycles:180 Average:12832.26 Median:4278.50 stddev:14302.38 (334.3%) stddev-sans-first:14313.72 16:06:59 INFO - PROCESS | 10529 | Values: 748.7 762.8 814.7 840.5 846.6 12822.9 12964.1 12993.7 13004.2 13016.7 11612.2 11626.0 11632.8 11636.9 11639.7 644.2 649.0 768.7 773.2 780.1 776.5 782.3 786.1 786.3 786.9 822.1 822.7 826.3 826.9 827.1 664.4 670.3 803.6 814.4 816.1 600.0 605.6 606.8 607.5 607.9 12943.7 12980.7 12982.5 12983.0 13021.6 11826.2 12313.5 12319.1 12408.3 12500.8 10263.2 10301.4 10401.4 10418.1 10464.9 3529.1 3581.5 3599.4 3612.4 3730.8 41026.8 41082.6 41099.8 41108.8 41376.0 9790.3 9945.3 9976.9 9984.6 9996.2 17244.6 17349.7 17377.5 17377.5 17390.9 7202.1 7343.9 7391.0 7430.5 7462.1 4278.1 4278.9 4341.7 4410.6 4436.2 2885.4 2922.6 2923.9 2925.2 2928.3 533.3 550.4 557.5 558.5 559.2 658.5 672.3 678.3 681.0 687.2 8121.2 8180.3 8358.5 8533.4 8631.1 559.5 621.0 660.1 664.8 694.5 3865.3 3868.7 4001.7 4018.4 4053.9 55311.2 55657.0 55788.4 55919.0 56035.4 43248.0 43908.8 43973.6 44432.6 44470.6 38952.6 39431.4 39485.2 39672.8 40238.6 8494.4 8511.4 8647.7 8807.6 9091.7 32276.7 32539.8 33299.0 33720.3 33947.3 39841.4 40281.8 40787.6 40925.8 41822.6 10489.5 10608.2 10649.4 10770.7 11022.2 11874.9 12018.0 12110.5 12192.8 12624.7 10158.4 10404.4 10653.1 10902.2 10996.3 10618.2 10751.5 10881.3 10901.6 11278.8 11242.4 11384.1 11543.6 11756.2 11775.8 9001.3 9185.0 9232.4 9311.8 9755.6 9143.5 9158.1 9168.6 9194.2 9670.7 16:06:59 INFO - PROCESS | 10529 | -------- Summary: end -------- 16:06:59 INFO - PROCESS | 10529 | 16:07:00 INFO - TEST-INFO | 10529: exit 0 16:07:00 INFO - TEST-OK | dromaeo_css | took 1112575ms 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 10721 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqXAWhE/profile http://localhost:35211/getInfo.html) 16:07:04 INFO - PROCESS | 10721 | __metrics Screen width/height:1600/1200 16:07:04 INFO - PROCESS | 10721 | colorDepth:24 16:07:04 INFO - PROCESS | 10721 | Browser inner width/height: 1024/697 16:07:04 INFO - PROCESS | 10721 | __metrics 16:07:04 INFO - PROCESS | 10721 | 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 - PROCESS | 10721 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:07:05 INFO - TEST-INFO | 10721: exit 0 16:07:05 INFO - Browser initialized. 16:07:05 INFO - Running cycle 1/1 for kraken test... 16:07:05 INFO - TEST-INFO | started process 10801 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqXAWhE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:07:17 INFO - PROCESS | 10801 | RSS: Main: 148738048 16:07:17 INFO - PROCESS | 10801 | 16:07:20 INFO - PROCESS | 10801 | Cycle 1(1): loaded http://localhost:35211/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35211/tests/kraken/driver.html?testName=audio-beat-detection) 16:07:20 INFO - PROCESS | 10801 | RSS: Main: 186822656 16:07:20 INFO - PROCESS | 10801 | 16:07:23 INFO - PROCESS | 10801 | Cycle 1(1): loaded http://localhost:35211/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35211/tests/kraken/driver.html?testName=audio-dft) 16:07:23 INFO - PROCESS | 10801 | RSS: Main: 177000448 16:07:23 INFO - PROCESS | 10801 | 16:07:26 INFO - PROCESS | 10801 | Cycle 1(1): loaded http://localhost:35211/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35211/tests/kraken/driver.html?testName=audio-fft) 16:07:27 INFO - PROCESS | 10801 | RSS: Main: 159051776 16:07:27 INFO - PROCESS | 10801 | 16:07:29 INFO - PROCESS | 10801 | Cycle 1(1): loaded http://localhost:35211/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35211/tests/kraken/driver.html?testName=audio-oscillator) 16:07:29 INFO - PROCESS | 10801 | RSS: Main: 162037760 16:07:29 INFO - PROCESS | 10801 | 16:07:32 INFO - PROCESS | 10801 | Cycle 1(1): loaded http://localhost:35211/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35211/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:07:32 INFO - PROCESS | 10801 | RSS: Main: 164593664 16:07:32 INFO - PROCESS | 10801 | 16:07:35 INFO - PROCESS | 10801 | Cycle 1(1): loaded http://localhost:35211/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35211/tests/kraken/driver.html?testName=imaging-darkroom) 16:07:36 INFO - PROCESS | 10801 | RSS: Main: 163635200 16:07:36 INFO - PROCESS | 10801 | 16:07:39 INFO - PROCESS | 10801 | Cycle 1(1): loaded http://localhost:35211/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35211/tests/kraken/driver.html?testName=imaging-desaturate) 16:07:40 INFO - PROCESS | 10801 | RSS: Main: 164548608 16:07:40 INFO - PROCESS | 10801 | 16:07:42 INFO - PROCESS | 10801 | Cycle 1(1): loaded http://localhost:35211/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35211/tests/kraken/driver.html?testName=json-parse-financial) 16:07:43 INFO - PROCESS | 10801 | RSS: Main: 165003264 16:07:43 INFO - PROCESS | 10801 | 16:07:45 INFO - PROCESS | 10801 | Cycle 1(1): loaded http://localhost:35211/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35211/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:07:45 INFO - PROCESS | 10801 | RSS: Main: 175013888 16:07:45 INFO - PROCESS | 10801 | 16:07:47 INFO - PROCESS | 10801 | Cycle 1(1): loaded http://localhost:35211/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35211/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:07:48 INFO - PROCESS | 10801 | RSS: Main: 172396544 16:07:48 INFO - PROCESS | 10801 | 16:07:50 INFO - PROCESS | 10801 | Cycle 1(1): loaded http://localhost:35211/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35211/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:07:50 INFO - PROCESS | 10801 | RSS: Main: 187781120 16:07:50 INFO - PROCESS | 10801 | 16:07:53 INFO - PROCESS | 10801 | Cycle 1(1): loaded http://localhost:35211/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35211/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:07:53 INFO - PROCESS | 10801 | RSS: Main: 192208896 16:07:53 INFO - PROCESS | 10801 | 16:07:56 INFO - PROCESS | 10801 | Cycle 1(1): loaded http://localhost:35211/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35211/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:07:56 INFO - PROCESS | 10801 | RSS: Main: 192348160 16:07:56 INFO - PROCESS | 10801 | 16:07:58 INFO - PROCESS | 10801 | Cycle 1(1): loaded http://localhost:35211/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35211/tests/kraken/driver.html?testName=ai-astar) 16:07:58 INFO - PROCESS | 10801 | RSS: Main: 249274368 16:07:58 INFO - PROCESS | 10801 | 16:07:58 INFO - PROCESS | 10801 | __start_tp_report 16:07:58 INFO - PROCESS | 10801 | _x_x_mozilla_page_load 16:07:58 INFO - PROCESS | 10801 | _x_x_mozilla_page_load_details 16:07:58 INFO - PROCESS | 10801 | |i|pagename|runs| 16:07:58 INFO - PROCESS | 10801 | |0;ai-astar;110;111;106;110;111;112;100;110;111;112 16:07:58 INFO - PROCESS | 10801 | |1;audio-beat-detection;146;127;152;158;124;154;159;134;171;127 16:07:58 INFO - PROCESS | 10801 | |2;audio-dft;162;163;161;162;161;163;157;161;161;161 16:07:58 INFO - PROCESS | 10801 | |3;audio-fft;72;74;86;95;74;74;74;108;89;74 16:07:58 INFO - PROCESS | 10801 | |4;audio-oscillator;97;97;150;97;97;97;143;95;97;143 16:07:58 INFO - PROCESS | 10801 | |5;imaging-gaussian-blur;109;109;110;109;110;109;110;109;110;110 16:07:58 INFO - PROCESS | 10801 | |6;imaging-darkroom;147;146;145;145;145;145;145;146;146;146 16:07:58 INFO - PROCESS | 10801 | |7;imaging-desaturate;96;96;95;95;96;95;95;96;96;96 16:07:58 INFO - PROCESS | 10801 | |8;json-parse-financial;58;58;58;59;58;58;59;67;56;57 16:07:58 INFO - PROCESS | 10801 | |9;json-stringify-tinderbox;67;67;67;67;68;67;67;68;67;66 16:07:58 INFO - PROCESS | 10801 | |10;stanford-crypto-aes;85;87;87;87;86;89;87;87;88;86 16:07:58 INFO - PROCESS | 10801 | |11;stanford-crypto-ccm;135;125;121;116;122;120;119;119;121;120 16:07:58 INFO - PROCESS | 10801 | |12;stanford-crypto-pbkdf2;140;144;150;148;150;145;158;149;150;140 16:07:58 INFO - PROCESS | 10801 | |13;stanford-crypto-sha256-iterative;68;69;81;68;67;71;67;72;70;69 16:07:58 INFO - PROCESS | 10801 | __end_tp_report 16:07:58 INFO - PROCESS | 10801 | __start_cc_report 16:07:58 INFO - PROCESS | 10801 | _x_x_mozilla_cycle_collect,950 16:07:58 INFO - PROCESS | 10801 | __end_cc_report 16:07:58 INFO - PROCESS | 10801 | __startTimestamp1452211678792__endTimestamp 16:07:58 INFO - PROCESS | 10801 | 16:07:58 INFO - PROCESS | 10801 | ------- Summary: start ------- 16:07:58 INFO - PROCESS | 10801 | Number of tests: 14 16:07:58 INFO - PROCESS | 10801 | 16:07:58 INFO - PROCESS | 10801 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.00 stddev:3.68 (3.3%) stddev-sans-first:3.90 16:07:58 INFO - PROCESS | 10801 | Values: 110.0 111.0 106.0 110.0 111.0 112.0 100.0 110.0 111.0 112.0 16:07:58 INFO - PROCESS | 10801 | 16:07:58 INFO - PROCESS | 10801 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:153.00 stddev:16.27 (10.6%) stddev-sans-first:17.25 16:07:58 INFO - PROCESS | 10801 | Values: 146.0 127.0 152.0 158.0 124.0 154.0 159.0 134.0 171.0 127.0 16:07:58 INFO - PROCESS | 10801 | 16:07:58 INFO - PROCESS | 10801 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.69 (1.0%) stddev-sans-first:1.76 16:07:58 INFO - PROCESS | 10801 | Values: 162.0 163.0 161.0 162.0 161.0 163.0 157.0 161.0 161.0 161.0 16:07:58 INFO - PROCESS | 10801 | 16:07:58 INFO - PROCESS | 10801 | [#3] audio-fft Cycles:10 Average:82.00 Median:74.00 stddev:12.16 (16.4%) stddev-sans-first:12.34 16:07:58 INFO - PROCESS | 10801 | Values: 72.0 74.0 86.0 95.0 74.0 74.0 74.0 108.0 89.0 74.0 16:07:58 INFO - PROCESS | 10801 | 16:07:58 INFO - PROCESS | 10801 | [#4] audio-oscillator Cycles:10 Average:111.30 Median:97.00 stddev:23.57 (24.3%) stddev-sans-first:24.43 16:07:58 INFO - PROCESS | 10801 | Values: 97.0 97.0 150.0 97.0 97.0 97.0 143.0 95.0 97.0 143.0 16:07:58 INFO - PROCESS | 10801 | 16:07:58 INFO - PROCESS | 10801 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 16:07:58 INFO - PROCESS | 10801 | Values: 109.0 109.0 110.0 109.0 110.0 109.0 110.0 109.0 110.0 110.0 16:07:58 INFO - PROCESS | 10801 | 16:07:58 INFO - PROCESS | 10801 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 16:07:58 INFO - PROCESS | 10801 | Values: 147.0 146.0 145.0 145.0 145.0 145.0 145.0 146.0 146.0 146.0 16:07:58 INFO - PROCESS | 10801 | 16:07:58 INFO - PROCESS | 10801 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:07:58 INFO - PROCESS | 10801 | Values: 96.0 96.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 16:07:58 INFO - PROCESS | 10801 | 16:07:58 INFO - PROCESS | 10801 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:58.00 stddev:3.01 (5.2%) stddev-sans-first:3.18 16:07:58 INFO - PROCESS | 10801 | Values: 58.0 58.0 58.0 59.0 58.0 58.0 59.0 67.0 56.0 57.0 16:07:58 INFO - PROCESS | 10801 | 16:07:58 INFO - PROCESS | 10801 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 16:07:58 INFO - PROCESS | 10801 | Values: 67.0 67.0 67.0 67.0 68.0 67.0 67.0 68.0 67.0 66.0 16:07:58 INFO - PROCESS | 10801 | 16:07:58 INFO - PROCESS | 10801 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:87.00 stddev:1.10 (1.3%) stddev-sans-first:0.93 16:07:58 INFO - PROCESS | 10801 | Values: 85.0 87.0 87.0 87.0 86.0 89.0 87.0 87.0 88.0 86.0 16:07:58 INFO - PROCESS | 10801 | 16:07:58 INFO - PROCESS | 10801 | [#11] stanford-crypto-ccm Cycles:10 Average:121.80 Median:121.00 stddev:5.18 (4.3%) stddev-sans-first:2.45 16:07:58 INFO - PROCESS | 10801 | Values: 135.0 125.0 121.0 116.0 122.0 120.0 119.0 119.0 121.0 120.0 16:07:58 INFO - PROCESS | 10801 | 16:07:58 INFO - PROCESS | 10801 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.40 Median:149.50 stddev:5.40 (3.6%) stddev-sans-first:5.02 16:07:58 INFO - PROCESS | 10801 | Values: 140.0 144.0 150.0 148.0 150.0 145.0 158.0 149.0 150.0 140.0 16:07:58 INFO - PROCESS | 10801 | 16:07:58 INFO - PROCESS | 10801 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:69.50 stddev:4.13 (5.9%) stddev-sans-first:4.30 16:07:58 INFO - PROCESS | 10801 | Values: 68.0 69.0 81.0 68.0 67.0 71.0 67.0 72.0 70.0 69.0 16:07:58 INFO - PROCESS | 10801 | -------- Summary: end -------- 16:07:58 INFO - PROCESS | 10801 | 16:07:59 INFO - TEST-INFO | 10801: exit 0 16:07:59 INFO - TEST-OK | kraken | took 59009ms 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 11051 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWxLA1w/profile http://localhost:35211/getInfo.html) 16:08:04 INFO - PROCESS | 11051 | __metrics Screen width/height:1600/1200 16:08:04 INFO - PROCESS | 11051 | colorDepth:24 16:08:04 INFO - PROCESS | 11051 | Browser inner width/height: 1024/697 16:08:04 INFO - PROCESS | 11051 | __metrics 16:08:04 INFO - PROCESS | 11051 | 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 - PROCESS | 11051 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:08:05 INFO - TEST-INFO | 11051: exit 0 16:08:05 INFO - Browser initialized. 16:08:05 INFO - Running cycle 1/1 for v8_7 test... 16:08:05 INFO - TEST-INFO | started process 11138 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWxLA1w/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:16 INFO - PROCESS | 11138 | RSS: Main: 148758528 16:08:16 INFO - PROCESS | 11138 | 16:08:39 INFO - PROCESS | 11138 | Cycle 1(1): loaded http://localhost:35211/tests/v8_7/run.html (next: http://localhost:35211/tests/v8_7/run.html) 16:08:39 INFO - PROCESS | 11138 | RSS: Main: 521822208 16:08:39 INFO - PROCESS | 11138 | 16:08:39 INFO - PROCESS | 11138 | __start_tp_report 16:08:39 INFO - PROCESS | 11138 | _x_x_mozilla_page_load 16:08:39 INFO - PROCESS | 11138 | _x_x_mozilla_page_load_details 16:08:39 INFO - PROCESS | 11138 | |i|pagename|runs| 16:08:39 INFO - PROCESS | 11138 | |0;Richards;166.91704223001167 16:08:39 INFO - PROCESS | 11138 | |1;DeltaBlue;190.98548510313216 16:08:39 INFO - PROCESS | 11138 | |2;Encrypt;284.7380410022779 16:08:39 INFO - PROCESS | 11138 | |3;Decrypt;5202.072538860104 16:08:39 INFO - PROCESS | 11138 | |4;RayTrace;1118.5682326621925 16:08:39 INFO - PROCESS | 11138 | |5;Earley;784.3137254901961 16:08:39 INFO - PROCESS | 11138 | |6;Boyer;12096.385542168675 16:08:39 INFO - PROCESS | 11138 | |7;RegExp;42163.26530612245 16:08:39 INFO - PROCESS | 11138 | |8;Splay;573.394495412844 16:08:39 INFO - PROCESS | 11138 | |9;NavierStokes;4835.748792270531 16:08:39 INFO - PROCESS | 11138 | __end_tp_report 16:08:39 INFO - PROCESS | 11138 | __startTimestamp1452211719552__endTimestamp 16:08:39 INFO - PROCESS | 11138 | 16:08:39 INFO - PROCESS | 11138 | ------- Summary: start ------- 16:08:39 INFO - PROCESS | 11138 | Number of tests: 10 16:08:39 INFO - PROCESS | 11138 | 16:08:39 INFO - PROCESS | 11138 | [#0] Richards Cycles:1 Average:166.92 Median:166.92 stddev:0.00 (0.0%) 16:08:39 INFO - PROCESS | 11138 | Values: 166.9 16:08:39 INFO - PROCESS | 11138 | 16:08:39 INFO - PROCESS | 11138 | [#1] DeltaBlue Cycles:1 Average:190.99 Median:190.99 stddev:0.00 (0.0%) 16:08:39 INFO - PROCESS | 11138 | Values: 191.0 16:08:39 INFO - PROCESS | 11138 | 16:08:39 INFO - PROCESS | 11138 | [#2] Encrypt Cycles:1 Average:284.74 Median:284.74 stddev:0.00 (0.0%) 16:08:39 INFO - PROCESS | 11138 | Values: 284.7 16:08:39 INFO - PROCESS | 11138 | 16:08:39 INFO - PROCESS | 11138 | [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 16:08:39 INFO - PROCESS | 11138 | Values: 5202.1 16:08:39 INFO - PROCESS | 11138 | 16:08:39 INFO - PROCESS | 11138 | [#4] RayTrace Cycles:1 Average:1118.57 Median:1118.57 stddev:0.00 (0.0%) 16:08:39 INFO - PROCESS | 11138 | Values: 1118.6 16:08:39 INFO - PROCESS | 11138 | 16:08:39 INFO - PROCESS | 11138 | [#5] Earley Cycles:1 Average:784.31 Median:784.31 stddev:0.00 (0.0%) 16:08:39 INFO - PROCESS | 11138 | Values: 784.3 16:08:39 INFO - PROCESS | 11138 | 16:08:39 INFO - PROCESS | 11138 | [#6] Boyer Cycles:1 Average:12096.39 Median:12096.39 stddev:0.00 (0.0%) 16:08:39 INFO - PROCESS | 11138 | Values: 12096.4 16:08:39 INFO - PROCESS | 11138 | 16:08:39 INFO - PROCESS | 11138 | [#7] RegExp Cycles:1 Average:42163.27 Median:42163.27 stddev:0.00 (0.0%) 16:08:39 INFO - PROCESS | 11138 | Values: 42163.3 16:08:39 INFO - PROCESS | 11138 | 16:08:39 INFO - PROCESS | 11138 | [#8] Splay Cycles:1 Average:573.39 Median:573.39 stddev:0.00 (0.0%) 16:08:39 INFO - PROCESS | 11138 | Values: 573.4 16:08:39 INFO - PROCESS | 11138 | 16:08:39 INFO - PROCESS | 11138 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 16:08:39 INFO - PROCESS | 11138 | Values: 4835.7 16:08:39 INFO - PROCESS | 11138 | -------- Summary: end -------- 16:08:39 INFO - PROCESS | 11138 | 16:08:40 INFO - TEST-INFO | 11138: exit 0 16:08:40 INFO - TEST-OK | v8_7 | took 40683ms 16:08:40 INFO - SUITE-END | took 1212s 16:08:40 INFO - Completed test suite (00:20:12) 16:08:40 INFO - Working with test: dromaeo_css 16:08:40 INFO - Generating results file: dromaeo_css 16:08:40 INFO - Working with test: kraken 16:08:40 INFO - Generating results file: kraken 16:08:40 INFO - javascript benchmark 16:08:40 INFO - Working with test: v8_7 16:08:40 INFO - Generating results file: v8_7 16:08:40 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:08:40 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 16:08:40 INFO - process_Request line: dromaeo_css 6734.63 graph.html#tests=[[72,63,35]] 16:08:40 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:08:40 INFO - process_Request line: kraken 1511.90 graph.html#tests=[[232,63,35]] 16:08:40 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:08:40 INFO - process_Request line: v8_7 20105.89 graph.html#tests=[[230,63,35]] 16:08:40 INFO - RETURN: dromaeo_css: 6734.63 16:08:40 INFO - RETURN: kraken: 1511.90 16:08:40 INFO - RETURN: v8_7: 20105.89 16:08:40 INFO - javascript benchmark 16:08:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3102.379524095181, 3124.859381327843, 3164.952525712115, 3173.76196785241, 3196.8721251149955, 4971.925421118686, 5029.145045342291, 5032.723200223986, 5049.7222652754035, 5099.770510327035, 5102.515261050204, 5119.180931051023, 5158.613104017195, 5169.30214421053, 5185.844424667266, 4473.910521789562, 4580.679352445339, 4597.42532183477, 4692.038132182912, 4771.928421073687, 4630.212863813143, 4724.126036683225, 4724.291356296549, 4733.219018861883, 4849.272609108627, 4626.629869610423, 4708.199606066977, 4717.7169369837575, 4725.598324142452, 4749.548792864673, 4731.929021064687, 4742.9525704742855, 4750.239961606127, 4764.475907650156, 4838.854834354975, 4559.77201139945, 4674.135284972291, 4750.239961606127, 4758.547937945889, 4770.880727981794, 4965.255211718271, 4974.925376119361, 4988.725620090893, 4991.026749783794, 5006.224035274502, 5452.536534394581, 5456.017916774979, 5470.152126420411, 5475.5072043515875, 5480.04099282628, 5468.535174510172, 5527.39198688144, 5536.307961504812, 5536.667799932017, 5599.580031497654, 5081.339425874649, 5083.262926875619, 5084.3898732152375, 5089.440161582223, 5148.459411761749, 5489.835304940858, 5491.752871120809, 5500.339959204921, 5544.944550554524, 5600.327960644749, 5295.470452954673, 5357.7053262070185, 5390.595705322038, 5396.946030539644, 5502.009638265151, 5515.393306736256, 5534.612577119644, 5538.224648549206, 5539.058360078796, 5542.11326187808, 5484.588655850827, 5504.422035686195, 5507.0637991541535, 5510.228568000483, 5530.529904958124, 5290.5238528531845, 5392.487713667196, 5395.70323632204, 5453.809116680897, 5576.637518561281, 4065.9796701016307, 4082.408050832613, 4086.2849001425225, 4104.0970986382945, 4122.732022418533, 3706.5737440194184, 3710.350688629479, 3712.4988126603103, 3724.3110024645525, 3740.7194460415576, 4979.377577802775, 5007.173816320339, 5055.9241611375855, 5070.757664372252, 5115.437301896863, 5468.699221542774, 5485.50630443262, 5512.91730624041, 5514.145307477347, 5514.448555144453, 5049.545540901337, 5160.870978225575, 5178.559822415137, 5184.611154163377, 5227.215917612389, 4687.6249900007915, 4691.366665500182, 4724.598409135262, 4733.83431579893, 4779.569838714532, 5737.168110624019, 5759.395263497357, 5763.221965034751, 5766.826995190151, 5768.423157684198, 5320.467953204648, 5420.078586640359, 5522.0336441121835, 5524.364698059774, 5555.8888822224135, 5698.515626171822, 5723.198752174616, 5774.653520788766, 5791.276090488689, 5808.912866307093, 5279.868003299948, 5281.4190439052445, 5292.364916210079, 5302.549283310807, 5357.892842143213, 5344.786208551614, 5386.703731294817, 5448.536874365724, 5463.31708536433, 5487.478689524489, 5259.605529585373, 5268.1834315681135, 5276.34045744282, 5314.601404894725, 5335.253064571041, 5304.628675992643, 5304.893902121858, 5311.681299122065, 5320.0, 5356.0, 5060.038592667382, 5115.5396014358885, 5255.0, 5266.1574148136115, 5282.207668849704, 5357.0357335679955, 5363.919541206963, 5373.059714550016, 5391.272178255886, 5400.810971615974, 5161.200013997836, 5189.506996835295, 5191.896162076813, 5193.896122077613, 5216.139337009351], "unit": "score", "name": "dojo.html", "value": 5044.903386680261}, {"lowerIsBetter": false, "replicates": [516.2669010005792, 524.6563500906906, 528.4002656984327, 541.1152765228852, 553.8476918847316, 27643.861780691095, 28303.858480707593, 35805.10487237817, 35815.0, 35971.64028359715, 38006.619933800655, 38713.41929871054, 39051.0, 39095.21809563814, 39204.80397598008, 7299.4890357674985, 8274.83450330993, 8535.530545819978, 8558.657653693845, 8562.52906090168, 7459.179490256068, 9943.850842237336, 10106.494675266244, 10144.087032167103, 10163.085322320989, 9947.403155810638, 10004.649837255698, 10018.298719089667, 10024.949875250613, 10030.448325342104, 9861.161801246903, 9923.0, 9926.9503652482, 9938.15525680318, 9941.999999999964, 9987.750306242402, 10076.798464030751, 10100.292979491438, 10130.138938190263, 10136.645217417428, 38140.42789358162, 38569.421458678145, 38628.80685596582, 38668.80665596682, 38669.613303866885, 3147.166001009711, 3148.984255078733, 3158.478850989607, 3184.4268031754277, 3381.7125544328514, 29384.0, 29870.701292987225, 30014.699853001628, 30183.698163018307, 30487.23781905448, 3776.7545109568064, 3788.2802267569073, 3838.616138386139, 3847.961520384816, 3936.9015774605577, 270370.0, 271580.999999998, 273041.6347918268, 273223.0, 273249.0, 51791.48208517942, 52617.7369113152, 57548.42451575514, 57946.71026644924, 58998.410015899295, 52678.47321526735, 52963.47036529663, 52996.735016324674, 53132.20301695478, 53316.20025699618, 14394.280285985658, 14565.635859103608, 14575.489857854924, 14585.489507867385, 14610.853891461162, 10490.685279441628, 10623.946880265703, 10689.412082335546, 10705.30415523004, 10726.249162558703, 18621.0, 18824.24703011864, 18830.152643131092, 18916.243350265835, 18932.0, 6844.0, 7112.35988761014, 7127.92872071283, 7144.9642751785905, 7147.249538798455, 895.3463971300987, 914.1270087066836, 1000.584173394653, 1024.462157367388, 1060.3160961179997, 27468.313292167455, 28280.71719282822, 28484.0, 28699.0, 28787.42425151485, 995.6701318913777, 1043.7495001199657, 1046.7801761630144, 1066.173715370594, 1161.8257261410688, 14772.92613536947, 14914.179720115499, 14919.627009324853, 14930.776038359434, 14956.626084347978, 335546.0, 337683.0, 340977.0, 342233.0, 342703.0, 50913.49086509162, 51148.48851511512, 51339.0, 51347.0, 51366.48633513617, 1262.3751243134707, 1295.792673172288, 1309.3191540398939, 1315.3094625321783, 1318.723068155698, 27115.1865444037, 27969.52487601974, 28338.716612834432, 28564.285892852844, 29426.0, 40718.185636286515, 41297.0, 41325.1734965305, 41350.586494135874, 41423.37864931968, 252832.0, 253321.0, 256178.0, 256201.0, 256382.0, 31364.461146421065, 32119.678803212602, 32130.67869321277, 32375.51436728404, 32396.838015810714, 41761.0, 42045.78977105095, 42170.36744448897, 43012.35481467843, 43313.0, 31847.68152318447, 32037.0, 32244.820679414952, 32286.515702264955, 32532.0, 34048.82975585106, 34308.82845585756, 34998.82500587481, 35011.64988350084, 35166.0, 35100.0, 35327.470087949216, 35327.823360883034, 35338.82330588331, 36348.27303453969, 27933.58099628548, 28251.293717657223, 31454.0, 31916.202094947814, 32024.359512809147, 24137.275881723577, 25174.24477265685, 25294.747052529237, 25353.239402817944, 25465.236042918743], "unit": "score", "name": "ext.html", "value": 17996.511762818343}, {"lowerIsBetter": false, "replicates": [339.42128670616603, 355.5413516563633, 356.6736436160913, 358.290584642408, 359.1989862606388, 12544.184627999173, 15873.761893571591, 16593.83406165938, 17398.30406783727, 17419.390321338757, 14192.432302707904, 14292.213928233943, 14868.628284292898, 14885.553433396988, 14902.254887255647, 3984.8206830692543, 4060.0, 4062.573429789874, 5217.321748172732, 5411.648242864201, 5602.747876345574, 5839.649621022752, 5869.8826023479505, 5875.941240587582, 5881.235439392873, 5620.831375058755, 5912.17229587858, 5930.288365396159, 5932.37710040446, 5939.227900372945, 5780.566457515703, 5887.528997680197, 5894.322152952423, 5897.64614123154, 5932.822015339547, 5164.561012313958, 5189.091908915924, 5202.297689811865, 5208.401033881114, 5210.895782084375, 12024.0, 12519.186252893533, 19469.513262168417, 19912.303069392503, 19919.10364033622, 2061.1137210999264, 2095.8532902696816, 2151.5911976724374, 2161.4056134562966, 2214.867107973527, 9379.484128372937, 9396.308664440467, 12092.153549251556, 12096.516139354415, 12473.064520161024, 1777.1203254389031, 1787.2046939112101, 1790.8388245057877, 1825.4979880532826, 1882.7081802320663, 55445.72277138629, 55642.16536751952, 56383.43616563823, 57362.0, 57636.71181644107, 9771.120599145968, 9836.213102951746, 9881.505924703735, 9881.604735810632, 9947.154491868128, 13028.80456793149, 13132.34338283082, 13145.802812957812, 13160.341982901009, 13183.40674669623, 7037.788866334018, 7083.468739844532, 7111.288871112847, 7132.3580877720215, 7174.282571742784, 6775.898361524581, 6777.220619628806, 6783.728650853911, 6822.181338239443, 6832.282610325844, 3927.410888366711, 3970.7617542947514, 4078.4494093297026, 4130.277201489727, 4142.730722503027, 1769.3364988129451, 1802.3961972739016, 1806.3939190699703, 1816.137334766002, 1825.963480730378, 785.4227143049853, 871.8517851965181, 1012.8430093335545, 1024.4672770159625, 1024.6413755185624, 14451.638709032359, 14767.0, 15178.924105379403, 15196.696066078617, 15261.389544418322, 881.2465342132513, 890.7951171230653, 903.3947255338938, 940.9529523523796, 968.99031009689, 7793.337566306927, 8556.315494760403, 8796.516191609522, 8820.558972051373, 9694.709158725249, 468828.0, 476254.0, 506975.0, 514462.0, 515271.0, 68695.0, 68825.65587172132, 69213.65393173002, 71108.2889171112, 72866.63566682133, 1089.8692156941058, 1090.2586241355955, 1118.669992352258, 1138.7722455508765, 1140.0309736723884, 14867.107973521623, 14992.47526336573, 15369.538913832603, 15408.15255160977, 15433.382664693287, 33207.50188747219, 33214.833925830215, 33444.49833252455, 33449.16377090592, 33916.32167356589, 41206.38190427206, 41427.7928610355, 41769.0, 41901.371479428446, 42239.366409504495, 7127.572345659277, 7261.782146535613, 7270.491065625567, 7307.3058059484265, 7459.104907411145, 9276.350655454324, 11126.0, 11369.2609980351, 11561.884381156417, 11642.6507204784, 9677.516124193902, 9702.0, 9736.172425343642, 10021.498925053864, 10113.292069555355, 9411.247100232102, 9572.234221262142, 9913.900860991585, 9925.65260215889, 10069.295149339769, 7433.070866141732, 7552.320291173821, 9432.481213533321, 9803.754906127404, 9898.75253118649, 7383.593902335423, 9277.211437027658, 9665.0, 9883.357581757164, 10119.494025298853, 9897.58548208351, 9938.602455901682, 10409.531571079471, 10438.164946804389, 10751.569937202737], "unit": "score", "name": "jquery.html", "value": 8069.675335073866}, {"lowerIsBetter": false, "replicates": [1315.6973896003913, 1466.4354223623905, 1469.0377802539333, 1578.6605879735855, 1746.240385432337, 6948.548344357613, 7558.659860306286, 7700.5379677219335, 7705.113911900133, 7718.151003389623, 7513.812154696136, 7679.0, 7706.344960678349, 7710.7686769397005, 7721.150673425933, 2002.6395248855201, 2048.7439070116234, 2054.599353126141, 2223.144089525528, 2257.548490301938, 2028.2191356327846, 2289.610766169755, 2333.1367394064137, 2340.028888011473, 2342.472943587696, 2253.7971582557566, 2259.378670865517, 2296.7358753743283, 2297.023764899919, 2302.1597117052324, 2219.611567975606, 2221.5112675211426, 2233.653783663535, 2236.2173239366252, 2238.787315205061, 2226.6103431899514, 2249.5051088760447, 2251.448395143184, 2253.087499562663, 2258.435391152212, 7447.106347238312, 7520.21037791035, 7523.887141692879, 7540.057492813398, 7542.811429714301, 4587.449506059261, 4707.482176960531, 4708.152532544141, 4711.256834971048, 4735.502772208903, 2900.10096869971, 2993.3265015371585, 3002.1894088596173, 3004.173852190643, 3025.9243518911985, 962.5716556132523, 970.9951450242775, 980.568549838069, 983.5918093990986, 1001.2240513601944, 10753.623623173151, 10947.726306842313, 10982.341059536453, 10984.890151098467, 11011.174161937806, 4392.4289842320295, 4421.823127074881, 4470.463544374631, 4481.126180394792, 4481.260592002348, 9394.67118650844, 9453.0, 9466.432014079177, 9468.147866691894, 9470.195033422237, 4889.144399730104, 4896.583790377857, 4898.265260210926, 4898.828541001048, 4901.264810278415, 4332.090261045153, 4341.435613370305, 4391.297392417262, 4392.297232442794, 4396.758178300224, 3494.0915362006062, 3575.12409459684, 3576.9821150894077, 3649.4525821127045, 3690.7231957603285, 1154.8960593546453, 1212.2847519963088, 1224.4795961716236, 1229.975400491985, 1236.6166488388628, 1003.372891942536, 1025.195221750922, 1026.3892983674702, 1128.6670432222513, 1287.3241548187277, 7009.719611215596, 7083.043789088407, 7097.0, 7097.183823860322, 7106.040684507629, 1190.5832958464468, 1209.3227792436264, 1220.1885745979002, 1231.2735486063266, 1245.103525461666, 5596.4123767003875, 5622.156676498558, 5667.263255776805, 5671.0, 5685.715714214272, 9462.337636365526, 9676.661316853877, 9809.411435313905, 9827.508624568743, 9828.4102953823, 9287.535623218811, 9440.0, 9583.0, 9663.420194788336, 9682.806343873082, 7056.964715176494, 7205.819854503679, 7262.092238470192, 7265.89101163483, 7288.380487658503, 6970.093887794757, 7027.262137475696, 7028.6134262614005, 7077.044598979072, 7082.18554866197, 7871.527708337518, 8341.874871877048, 8492.532910689972, 8603.311735061305, 8650.826983460422, 8044.597770111354, 8274.882890809664, 8285.83428331442, 8419.494830310201, 8428.367872409717, 6614.140161778938, 6711.429528490133, 6714.261431242462, 6719.664016799238, 6719.798406047827, 6601.669916504059, 6601.966990165019, 6761.357671021246, 7258.12902451688, 7279.199288078413, 6755.831104222434, 6785.117934668461, 6831.11195544576, 6974.965125174342, 6984.825379365557, 6706.597604143767, 6821.965890170517, 6879.140107486564, 6957.756478523227, 7013.614251216232, 7033.964830175816, 7069.363757261871, 7083.716651334095, 7091.219965803654, 7093.397061249645, 6383.042543618494, 6388.648624325707, 6418.6469744164515, 6441.967790161019, 6445.065465507381, 6263.56155069159, 6277.466415354746, 6296.811095667137, 6307.369263073656, 6321.1782468278825], "unit": "score", "name": "mootools.html", "value": 4456.702717397435}, {"lowerIsBetter": false, "replicates": [315.5172585943507, 331.26624526673413, 334.5600535296087, 336.8815532432325, 340.4433750817414, 5811.564132690044, 5881.059030555112, 5887.558433117512, 5888.057910734284, 5896.086106653464, 5583.413741557139, 5657.2928383952, 5682.857928551778, 5803.767849286034, 5804.042333015058, 4484.551544845505, 4532.342810292514, 4538.546145385468, 4541.227991241481, 4554.4990051094355, 4521.502634710179, 4526.547345265463, 4527.343535187396, 4535.523770004152, 4536.206163921301, 4268.082362292106, 4356.956430435686, 4363.629091527208, 4453.042595841909, 4468.218061839181, 4418.270985287424, 4427.0924460485685, 4436.778161091933, 4449.065696203768, 4463.085067561142, 3945.9013524661827, 3973.8807835764974, 3975.940360894589, 3981.820818063194, 3982.303096958021, 5547.972260138714, 5565.053940830068, 5573.359063707685, 5575.637583557056, 5579.163125531203, 5135.0, 5226.503482169188, 5234.528892399664, 5235.58115350771, 5238.345206849144, 6168.352323006065, 6168.96915515424, 6174.722137503823, 6178.0, 6179.474744646711, 4391.27543955247, 4394.318880573516, 4399.5820397062225, 4400.603945644907, 4403.735775853427, 6294.244690637152, 6457.870842583169, 6464.127342808708, 6467.191601049869, 6472.8705425891685, 4516.977415112903, 4525.366448697185, 4526.456825181, 4531.954680453153, 4534.2971839364955, 4577.588017078412, 4581.289900065495, 4582.679212455163, 4584.0, 4585.449746030497, 5232.0, 5237.790488380499, 5240.109181439165, 5240.371155461369, 5240.554552863049, 6112.541559383064, 6226.750929962751, 6228.377162283826, 6237.500999919996, 6239.812805615838, 1604.0455928722392, 1622.051100106451, 1623.6914986152829, 1624.1554391716477, 1625.089949628212, 1046.9685909422728, 1047.1727335405096, 1083.5178345636273, 1098.8022156011834, 1105.3478447715725, 5942.138389933435, 5944.8811023780145, 5959.165716799652, 5963.2844058713235, 5965.791197308074, 6344.6827658616885, 6408.487321014401, 6415.550911436248, 6423.261324947691, 6424.646644434601, 5704.828855134353, 5826.980278451254, 5827.446392592697, 5893.410658934158, 5964.224650795369, 3451.5685539307588, 3492.214251793326, 3494.8602055917477, 3499.5100685903994, 3505.2638945821154, 6753.628550429774, 6753.763618273337, 6768.69540870662, 6768.72925083001, 6773.559718618274, 6429.357064293533, 6583.407493325528, 6584.8024559263295, 6598.769043083469, 6609.966950165219, 6755.898661520081, 6757.831054223586, 6765.086713293741, 6771.4582833373215, 6782.728690852409, 6398.264199616918, 6404.359564043559, 6413.070104834679, 6418.0, 6446.387593178641, 6239.0, 6356.141920840812, 6376.202974628171, 6378.394052564999, 6384.201974753156, 6725.630090345078, 6742.6628668567355, 6764.729410823512, 6768.357006084414, 6769.0, 4444.222261104358, 4445.533219012086, 4445.644348452051, 4449.822007119679, 4450.6439484841785, 6251.093591429127, 6473.935260647333, 6474.708638111202, 6490.935090649222, 6496.350364963466, 6298.590591611531, 6307.495400367868, 6314.494840412848, 6314.53733044104, 6321.589096708699, 6297.842553936005, 6300.653464059521, 6300.716467759054, 6304.18045654062, 6304.306526282197, 6010.368911264254, 6170.876582468236, 6182.041783523561, 6203.7828675996125, 6207.16203312547, 6283.183186185766, 6331.0, 6339.4928405726505, 6349.206349206349, 6353.205849268841, 6190.699953009918, 6191.628502289877, 6194.938050619617, 6198.6280823150755, 6206.0], "unit": "score", "name": "prototype.html", "value": 4722.337859736168}, {"lowerIsBetter": false, "replicates": [748.7304570354672, 762.8451849726421, 814.7148498025691, 840.474703310431, 846.644409348074, 12822.871771282284, 12964.092513524058, 12993.740125197513, 13004.154729942547, 13016.674583135415, 11612.24520406173, 11626.0, 11632.767344653103, 11636.941815290933, 11639.6508104757, 644.1979735229646, 648.9643069631169, 768.688681084159, 773.234497847133, 780.1496368957835, 776.4991580430619, 782.3311069035977, 786.1431040166218, 786.3001928283832, 786.9291763741262, 822.0956947357919, 822.6585966823761, 826.2893911236332, 826.9462484938459, 827.0612854410258, 664.3920812456596, 670.33971538035, 803.5700900018462, 814.3810703865105, 816.1063635319316, 599.9640021598674, 605.6275390634772, 606.7997560804923, 607.5443417436923, 607.9088136779518, 12943.676408089874, 12980.675483112904, 12982.545610903573, 12983.0, 13021.609351719464, 11826.231294965799, 12313.507459701601, 12319.076069294839, 12408.255504669749, 12500.812487812691, 10263.178945684327, 10301.433421161833, 10401.427921464316, 10418.062374386342, 10464.895351046544, 3529.082438565991, 3581.516495273157, 3599.3881040223223, 3612.3678356287546, 3730.757500762442, 41026.794866025775, 41082.58917410817, 41099.7945010276, 41108.79445602753, 41376.0, 9790.314677972616, 9945.303828732063, 9976.900230997742, 9984.550695218733, 9996.150327222122, 17244.568885777706, 17349.653006939792, 17377.478675639497, 17377.47867563975, 17390.913045434692, 7202.063731714844, 7343.926560734431, 7390.96304518474, 7430.517016393917, 7462.10454745434, 4278.106892782811, 4278.893027674333, 4341.696081274344, 4410.625096866802, 4436.223660859337, 2885.422915416925, 2922.576226447196, 2923.9122826315242, 2925.2101932478536, 2928.282570770175, 533.2747463449705, 550.3753240072547, 557.4731878374978, 558.5001423725743, 559.1556749308573, 658.4863806231148, 672.2840175213382, 678.2518158605875, 680.9523333366617, 687.2474640268897, 8121.228483294078, 8180.345572354197, 8358.540280284522, 8533.359998000175, 8631.136886311318, 559.5376869465977, 620.9937900621027, 660.1411336216712, 664.7673314340046, 694.5450729771907, 3865.3042452358845, 3868.7291889568023, 4001.7398869073418, 4018.3771515415156, 4053.91892162161, 55311.17033244504, 55657.0, 55788.442115579135, 55919.0, 56035.43964560384, 43248.0, 43908.78045609751, 43973.56026439759, 44432.55567444349, 44470.55529444664, 38952.61047389547, 39431.40852887209, 39485.21029579392, 39672.80163599164, 40238.597614023485, 8494.362922780692, 8511.446755960842, 8647.654093836176, 8807.559622019002, 9091.727248182566, 32276.677233228307, 32539.837300813346, 33299.0, 33720.32559348848, 33947.32105357928, 39841.40237896492, 40281.79859100686, 40787.59212407838, 40925.795371022956, 41822.58177418308, 10489.527971241465, 10608.204384671026, 10649.414282214553, 10770.676879693621, 11022.228444008842, 11874.881251187378, 12018.0, 12110.51557937708, 12192.817107743569, 12624.684382890502, 10158.441285729356, 10404.375737455473, 10653.147748179972, 10902.236843421202, 10996.340219586851, 10618.203634727271, 10751.516181771683, 10881.347119172875, 10901.56393744273, 11278.830817537908, 11242.381669008282, 11384.089272858317, 11543.5959741412, 11756.177067605186, 11775.76448471043, 9001.279897608045, 9185.0, 9232.353735238468, 9311.813763724553, 9755.560999754885, 9143.542822858963, 9158.129977652112, 9168.587413566538, 9194.218491428304, 9670.70987870365], "unit": "score", "name": "yui.html", "value": 6050.296407699626}], "name": "dromaeo_css", "value": 6734.631237089457}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 106.0, 110.0, 111.0, 112.0, 100.0, 110.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 127.0, 152.0, 158.0, 124.0, 154.0, 159.0, 134.0, 171.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.2}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 161.0, 162.0, 161.0, 163.0, 157.0, 161.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 86.0, 95.0, 74.0, 74.0, 74.0, 108.0, 89.0, 74.0], "unit": "score", "name": "audio-fft", "value": 82.0}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 150.0, 97.0, 97.0, 97.0, 143.0, 95.0, 97.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 111.3}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 58.0, 59.0, 58.0, 58.0, 59.0, 67.0, 56.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.8}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 68.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.1}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 87.0, 87.0, 86.0, 89.0, 87.0, 87.0, 88.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.9}, {"lowerIsBetter": true, "replicates": [135.0, 125.0, 121.0, 116.0, 122.0, 120.0, 119.0, 119.0, 121.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.8}, {"lowerIsBetter": true, "replicates": [140.0, 144.0, 150.0, 148.0, 150.0, 145.0, 158.0, 149.0, 150.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.4}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 81.0, 68.0, 67.0, 71.0, 67.0, 72.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.2}], "name": "kraken", "value": 1511.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.91704223001167], "unit": "score", "name": "Richards", "value": 211.49428200000003}, {"lowerIsBetter": false, "replicates": [190.98548510313216], "unit": "score", "name": "DeltaBlue", "value": 346.19384800000006}, {"lowerIsBetter": false, "replicates": [284.7380410022779], "unit": "score", "name": "Encrypt", "value": 934.8276720000003}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1118.5682326621925], "unit": "score", "name": "RayTrace", "value": 661.550166}, {"lowerIsBetter": false, "replicates": [784.3137254901961], "unit": "score", "name": "Earley", "value": 849.7403250000002}, {"lowerIsBetter": false, "replicates": [12096.385542168675], "unit": "score", "name": "Boyer", "value": 55.096044820717125}, {"lowerIsBetter": false, "replicates": [42163.26530612245], "unit": "score", "name": "RegExp", "value": 21.60613020329139}, {"lowerIsBetter": false, "replicates": [573.394495412844], "unit": "score", "name": "Splay", "value": 142.120304}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20105.891014497236}]} 16:08:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "20105.89"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1511.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6734.63"}}} 16:08:40 INFO - Return code: 0 16:08:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:08:40 INFO - # TBPL SUCCESS # 16:08:40 INFO - Running post-action listener: _resource_record_post_action 16:08:40 INFO - Running post-run listener: _resource_record_post_run 16:08:41 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 16384; Write bytes: 318107648; Read time: 108; Write time: 167780 16:08:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1572864; Read time: 0; Write time: 72 16:08:41 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 16384; Write bytes: 316534784; Read time: 108; Write time: 167708 16:08:41 INFO - Running post-run listener: _upload_blobber_files 16:08:41 INFO - Blob upload gear active. 16:08:41 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:08:41 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:41 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:41 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:42 INFO - (blobuploader) - INFO - Open directory for files ... 16:08:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:08:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:08:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:43 INFO - (blobuploader) - INFO - Done attempting. 16:08:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 16:08:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:08:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:44 INFO - (blobuploader) - INFO - Done attempting. 16:08:44 INFO - (blobuploader) - INFO - Iteration through files over. 16:08:44 INFO - Return code: 0 16:08:44 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:08:44 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:08:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/723b76a75c26a9e4f2aba16de4ff5e1b6946e429c102912a2de0764ccf6c32113b30178f0566cffe8aca5d7a48d0759157bc481803cfdbe5b6b77bca3b11bde0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/728e258c9eb1f38ce9609dbf1a3b58591eb6a3d9ad08fc05fbfc8205b824cfa8e094faa97a65a0b360c7449b8ea79dd9fe1a406447481cb6dc47909b81b75f47"} 16:08:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:08:44 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:08:44 INFO - Contents: 16:08:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/723b76a75c26a9e4f2aba16de4ff5e1b6946e429c102912a2de0764ccf6c32113b30178f0566cffe8aca5d7a48d0759157bc481803cfdbe5b6b77bca3b11bde0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/728e258c9eb1f38ce9609dbf1a3b58591eb6a3d9ad08fc05fbfc8205b824cfa8e094faa97a65a0b360c7449b8ea79dd9fe1a406447481cb6dc47909b81b75f47"} 16:08:44 INFO - Copying logs to upload dir... 16:08:44 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1273.298150 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-07 16:08:43.927859) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 16:08:43.931511) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452204729.652686-1273173551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/723b76a75c26a9e4f2aba16de4ff5e1b6946e429c102912a2de0764ccf6c32113b30178f0566cffe8aca5d7a48d0759157bc481803cfdbe5b6b77bca3b11bde0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/728e258c9eb1f38ce9609dbf1a3b58591eb6a3d9ad08fc05fbfc8205b824cfa8e094faa97a65a0b360c7449b8ea79dd9fe1a406447481cb6dc47909b81b75f47"} 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.011427 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/723b76a75c26a9e4f2aba16de4ff5e1b6946e429c102912a2de0764ccf6c32113b30178f0566cffe8aca5d7a48d0759157bc481803cfdbe5b6b77bca3b11bde0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/728e258c9eb1f38ce9609dbf1a3b58591eb6a3d9ad08fc05fbfc8205b824cfa8e094faa97a65a0b360c7449b8ea79dd9fe1a406447481cb6dc47909b81b75f47"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 16:08:43.956960) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 16:08:43.957333) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1452204729.652686-1273173551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004598 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 16:08:44.042283) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 16:08:44.042649) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 16:08:44.042984) ========= ========= Total master_lag: 0.19 =========