builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-049 starttime: 1452852351.22 results: success (0) buildid: 20160114233004 builduid: 651abf9b5059498aad92db9ab20b2b1a revision: 08cf4f9b73f7a3c4509cbd1b846c3459fbb9e246 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 02:05:51.223837) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 02:05:51.224316) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 02:05:51.224619) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1452852203.449501-145351206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006352 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 02:05:51.251260) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 02:05:51.251617) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 02:05:51.280931) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 02:05:51.281243) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1452852203.449501-145351206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.039737 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 02:05:51.334289) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 02:05:51.334618) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 02:05:51.334992) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 02:05:51.335307) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1452852203.449501-145351206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-15 02:05:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 51.5M=0s 2016-01-15 02:05:51 (51.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148724 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 02:05:51.496511) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 02:05:51.496831) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1452852203.449501-145351206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.107778 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 02:05:51.615638) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 02:05:51.616002) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 08cf4f9b73f7a3c4509cbd1b846c3459fbb9e246 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 08cf4f9b73f7a3c4509cbd1b846c3459fbb9e246 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1452852203.449501-145351206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-15 02:05:51,707 truncating revision to first 12 chars 2016-01-15 02:05:51,707 Setting DEBUG logging. 2016-01-15 02:05:51,707 attempt 1/10 2016-01-15 02:05:51,707 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/08cf4f9b73f7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-15 02:05:52,053 unpacking tar archive at: b2g-inbound-08cf4f9b73f7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.717368 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 02:05:52.346119) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 02:05:52.346437) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 02:05:52.356097) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 02:05:52.356413) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 02:05:52.356887) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-15 02:05:52.357276) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1452852203.449501-145351206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:05:52 INFO - MultiFileLogger online at 20160115 02:05:52 in /builds/slave/test-pgo 02:05:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 02:05:52 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 02:05:52 INFO - {'append_to_log': False, 02:05:52 INFO - 'base_work_dir': '/builds/slave/test-pgo', 02:05:52 INFO - 'blob_upload_branch': 'B2G-Inbound', 02:05:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 02:05:52 INFO - 'branch': 'B2G-Inbound', 02:05:52 INFO - 'buildbot_json_path': 'buildprops.json', 02:05:52 INFO - 'config_files': ('talos/linux_config.py',), 02:05:52 INFO - 'default_actions': ('clobber', 02:05:52 INFO - 'read-buildbot-config', 02:05:52 INFO - 'download-and-extract', 02:05:52 INFO - 'populate-webroot', 02:05:52 INFO - 'create-virtualenv', 02:05:52 INFO - 'install', 02:05:52 INFO - 'run-tests'), 02:05:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:05:52 INFO - 'download_minidump_stackwalk': True, 02:05:52 INFO - 'download_symbols': 'ondemand', 02:05:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:05:52 INFO - 'tooltool.py': '/tools/tooltool.py', 02:05:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:05:52 INFO - '/tools/misc-python/virtualenv.py')}, 02:05:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:05:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:05:52 INFO - 'installer_path': 'installer.exe', 02:05:52 INFO - 'log_level': 'info', 02:05:52 INFO - 'log_name': 'talos', 02:05:52 INFO - 'log_to_console': True, 02:05:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:05:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:05:52 INFO - 'opt_config_files': (), 02:05:52 INFO - 'pip_index': False, 02:05:52 INFO - 'sps_profile': False, 02:05:52 INFO - 'sps_profile_interval': 0, 02:05:52 INFO - 'suite': 'dromaeojs', 02:05:52 INFO - 'system_bits': '32', 02:05:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:05:52 INFO - 'title': 'talos-linux64-ix-049', 02:05:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:05:52 INFO - 'use_talos_json': True, 02:05:52 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 02:05:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:05:52 INFO - 'work_dir': 'build'} 02:05:52 INFO - ##### 02:05:52 INFO - ##### Running clobber step. 02:05:52 INFO - ##### 02:05:52 INFO - Running pre-action listener: _resource_record_pre_action 02:05:52 INFO - Running main action method: clobber 02:05:52 INFO - rmtree: /builds/slave/test-pgo/build 02:05:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 02:05:53 INFO - Running post-action listener: _resource_record_post_action 02:05:53 INFO - ##### 02:05:53 INFO - ##### Running read-buildbot-config step. 02:05:53 INFO - ##### 02:05:53 INFO - Running pre-action listener: _resource_record_pre_action 02:05:53 INFO - Running main action method: read_buildbot_config 02:05:53 INFO - Using buildbot properties: 02:05:53 INFO - { 02:05:53 INFO - "project": "", 02:05:53 INFO - "product": "firefox", 02:05:53 INFO - "script_repo_revision": "production", 02:05:53 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 02:05:53 INFO - "repository": "", 02:05:53 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 02:05:53 INFO - "buildid": "20160114233004", 02:05:53 INFO - "pgo_build": "True", 02:05:53 INFO - "basedir": "/builds/slave/test-pgo", 02:05:53 INFO - "buildnumber": 1115, 02:05:53 INFO - "slavename": "talos-linux64-ix-049", 02:05:53 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:05:53 INFO - "platform": "ubuntu64_hw", 02:05:53 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 02:05:53 INFO - "branch": "b2g-inbound", 02:05:53 INFO - "repo_path": "integration/b2g-inbound", 02:05:53 INFO - "revision": "08cf4f9b73f7a3c4509cbd1b846c3459fbb9e246", 02:05:53 INFO - "stage_platform": "linux64-pgo", 02:05:53 INFO - "builduid": "651abf9b5059498aad92db9ab20b2b1a", 02:05:53 INFO - "slavebuilddir": "test" 02:05:53 INFO - } 02:05:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/HTFYYCzKTEOtseNi6f8Jsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 02:05:53 INFO - Running post-action listener: _resource_record_post_action 02:05:53 INFO - ##### 02:05:53 INFO - ##### Running download-and-extract step. 02:05:53 INFO - ##### 02:05:53 INFO - Running pre-action listener: _resource_record_pre_action 02:05:53 INFO - Running main action method: download_and_extract 02:05:53 INFO - mkdir: /builds/slave/test-pgo/build/tests 02:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:05:53 INFO - https://queue.taskcluster.net/v1/task/HTFYYCzKTEOtseNi6f8Jsw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:05:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTFYYCzKTEOtseNi6f8Jsw/artifacts/public/build/test_packages.json 02:05:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTFYYCzKTEOtseNi6f8Jsw/artifacts/public/build/test_packages.json 02:05:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTFYYCzKTEOtseNi6f8Jsw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 02:05:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTFYYCzKTEOtseNi6f8Jsw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 02:05:55 INFO - Downloaded 1448 bytes. 02:05:55 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 02:05:55 INFO - Using the following test package requirements: 02:05:55 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:05:55 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:05:55 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:05:55 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:55 INFO - u'jsshell-linux-x86_64.zip'], 02:05:55 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:05:55 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:05:55 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:05:55 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:05:55 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:05:55 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:05:55 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:05:55 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:05: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')]} 02:05:55 INFO - https://queue.taskcluster.net/v1/task/HTFYYCzKTEOtseNi6f8Jsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:05:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTFYYCzKTEOtseNi6f8Jsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:05:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTFYYCzKTEOtseNi6f8Jsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:05:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTFYYCzKTEOtseNi6f8Jsw/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 02:05:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTFYYCzKTEOtseNi6f8Jsw/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 02:05:58 INFO - Downloaded 24030895 bytes. 02:05:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 02:05:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 02:05:59 INFO - Return code: 0 02:05:59 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 02:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:05:59 INFO - https://queue.taskcluster.net/v1/task/HTFYYCzKTEOtseNi6f8Jsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:05:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTFYYCzKTEOtseNi6f8Jsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:05:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTFYYCzKTEOtseNi6f8Jsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:05:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTFYYCzKTEOtseNi6f8Jsw/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 02:05:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTFYYCzKTEOtseNi6f8Jsw/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 02:06:02 INFO - Downloaded 24030895 bytes. 02:06:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 02:06:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 02:06:03 INFO - Return code: 0 02:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:03 INFO - https://queue.taskcluster.net/v1/task/HTFYYCzKTEOtseNi6f8Jsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:06:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTFYYCzKTEOtseNi6f8Jsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:06:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTFYYCzKTEOtseNi6f8Jsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:06:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTFYYCzKTEOtseNi6f8Jsw/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 02:06:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTFYYCzKTEOtseNi6f8Jsw/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 02:06:06 INFO - Downloaded 11132144 bytes. 02:06:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 02:06:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 02:06:06 INFO - Return code: 0 02:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:06 INFO - https://queue.taskcluster.net/v1/task/HTFYYCzKTEOtseNi6f8Jsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:06:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTFYYCzKTEOtseNi6f8Jsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:06:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTFYYCzKTEOtseNi6f8Jsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:06:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTFYYCzKTEOtseNi6f8Jsw/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 02:06:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HTFYYCzKTEOtseNi6f8Jsw/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 02:06:09 INFO - Downloaded 55878316 bytes. 02:06:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HTFYYCzKTEOtseNi6f8Jsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:06:09 INFO - mkdir: /builds/slave/test-pgo/properties 02:06:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 02:06:09 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 02:06:09 INFO - Contents: 02:06:09 INFO - build_url:https://queue.taskcluster.net/v1/task/HTFYYCzKTEOtseNi6f8Jsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:06:09 INFO - Running post-action listener: _resource_record_post_action 02:06:09 INFO - Running post-action listener: set_extra_try_arguments 02:06:09 INFO - ##### 02:06:09 INFO - ##### Running populate-webroot step. 02:06:09 INFO - ##### 02:06:09 INFO - Running pre-action listener: _resource_record_pre_action 02:06:09 INFO - Running main action method: populate_webroot 02:06:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:06:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:06:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:06:09 INFO - '--tppagecycles', 02:06:09 INFO - '7'], 02:06:09 INFO - 'tests': ['tsvgm']}}, 02:06:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:06:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:06:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:06:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:06:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:06:09 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:06:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:06:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:09 INFO - 'talos_options': ['--e10s'], 02:06:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:06:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:09 INFO - 'tests': ['damp', 'tps']}, 02:06:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:09 INFO - 'talos_options': ['--e10s'], 02:06:09 INFO - 'tests': ['damp', 'tps']}, 02:06:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:06:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:06:09 INFO - 'other': {'tests': ['a11yr', 02:06:09 INFO - 'ts_paint', 02:06:09 INFO - 'tpaint', 02:06:09 INFO - 'sessionrestore', 02:06:09 INFO - 'sessionrestore_no_auto_restore']}, 02:06:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:06:09 INFO - 'tests': ['a11yr', 02:06:09 INFO - 'ts_paint', 02:06:09 INFO - 'tpaint', 02:06:09 INFO - 'sessionrestore', 02:06:09 INFO - 'sessionrestore_no_auto_restore']}, 02:06:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:06:09 INFO - 'tests': ['a11yr', 02:06:09 INFO - 'ts_paint', 02:06:09 INFO - 'tpaint', 02:06:09 INFO - 'sessionrestore', 02:06:09 INFO - 'sessionrestore_no_auto_restore']}, 02:06:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:06:09 INFO - 'tests': ['a11yr', 02:06:09 INFO - 'ts_paint', 02:06:09 INFO - 'tpaint', 02:06:09 INFO - 'sessionrestore', 02:06:09 INFO - 'sessionrestore_no_auto_restore']}, 02:06:09 INFO - 'other_l64': {'tests': ['a11yr', 02:06:09 INFO - 'ts_paint', 02:06:09 INFO - 'tpaint', 02:06:09 INFO - 'sessionrestore', 02:06:09 INFO - 'sessionrestore_no_auto_restore']}, 02:06:09 INFO - 'other_nol64': {'tests': ['a11yr', 02:06:09 INFO - 'ts_paint', 02:06:09 INFO - 'tpaint', 02:06:09 INFO - 'sessionrestore', 02:06:09 INFO - 'sessionrestore_no_auto_restore']}, 02:06:09 INFO - 'svgr': {'tests': ['tsvgx', 02:06:09 INFO - 'tsvgr_opacity', 02:06:09 INFO - 'tart', 02:06:09 INFO - 'tscrollx', 02:06:09 INFO - 'cart']}, 02:06:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:06:09 INFO - 'tests': ['tsvgx', 02:06:09 INFO - 'tsvgr_opacity', 02:06:09 INFO - 'tart', 02:06:09 INFO - 'tscrollx', 02:06:09 INFO - 'cart']}, 02:06:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:09 INFO - 'tests': ['tp5o']}, 02:06:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:09 INFO - 'talos_options': ['--e10s'], 02:06:09 INFO - 'tests': ['tp5o']}, 02:06:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:09 INFO - 'talos_options': ['--xperf_path', 02:06:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:06:09 INFO - 'tests': ['tp5n']}, 02:06:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:09 INFO - 'talos_options': ['--e10s', 02:06:09 INFO - '--xperf_path', 02:06:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:06:09 INFO - 'tests': ['tp5n']}}, 02:06:09 INFO - 'talos.zip': {'path': '', 02:06:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:06:09 INFO - Running post-action listener: _resource_record_post_action 02:06:09 INFO - ##### 02:06:09 INFO - ##### Running create-virtualenv step. 02:06:09 INFO - ##### 02:06:09 INFO - Running pre-action listener: _resource_record_pre_action 02:06:09 INFO - Running main action method: create_virtualenv 02:06:09 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 02:06:09 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 02:06:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 02:06:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:06:09 INFO - Using real prefix '/usr' 02:06:09 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 02:06:10 INFO - Installing distribute.............................................................................................................................................................................................done. 02:06:12 INFO - Installing pip.................done. 02:06:12 INFO - Return code: 0 02:06:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 02:06:12 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')]} 02:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:12 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')]} 02:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:12 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 0x7fae007ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd9840>, '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 0x1d466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d46b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452852203.449501-145351206', '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 02:06:12 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 02:06:12 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 02:06:12 INFO - Using env: {'DISPLAY': ':0', 02:06:12 INFO - 'HOME': '/home/cltbld', 02:06:12 INFO - 'LANG': 'en_US.UTF-8', 02:06:12 INFO - 'LANGUAGE': 'en_US:en', 02:06:12 INFO - 'LOGNAME': 'cltbld', 02:06:12 INFO - 'MAIL': '/var/mail/cltbld', 02:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:12 INFO - 'MOZ_NO_REMOTE': '1', 02:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:12 INFO - 'NO_EM_RESTART': '1', 02:06:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:12 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:12 INFO - 'SHELL': '/bin/bash', 02:06:12 INFO - 'SHLVL': '1', 02:06:12 INFO - 'TERM': 'linux', 02:06:12 INFO - 'TMOUT': '86400', 02:06:12 INFO - 'USER': 'cltbld', 02:06:12 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452852203.449501-145351206', 02:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:12 INFO - '_': '/tools/buildbot/bin/python'} 02:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:12 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 02:06:12 INFO - Cleaning up... 02:06:12 INFO - Return code: 0 02:06:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 02:06:12 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')]} 02:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:12 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')]} 02:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:12 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 0x7fae007ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd9840>, '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 0x1d466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d46b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452852203.449501-145351206', '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 02:06:12 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 02:06:12 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 02:06:12 INFO - Using env: {'DISPLAY': ':0', 02:06:12 INFO - 'HOME': '/home/cltbld', 02:06:12 INFO - 'LANG': 'en_US.UTF-8', 02:06:12 INFO - 'LANGUAGE': 'en_US:en', 02:06:12 INFO - 'LOGNAME': 'cltbld', 02:06:12 INFO - 'MAIL': '/var/mail/cltbld', 02:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:12 INFO - 'MOZ_NO_REMOTE': '1', 02:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:12 INFO - 'NO_EM_RESTART': '1', 02:06:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:12 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:12 INFO - 'SHELL': '/bin/bash', 02:06:12 INFO - 'SHLVL': '1', 02:06:12 INFO - 'TERM': 'linux', 02:06:12 INFO - 'TMOUT': '86400', 02:06:12 INFO - 'USER': 'cltbld', 02:06:12 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452852203.449501-145351206', 02:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:12 INFO - '_': '/tools/buildbot/bin/python'} 02:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:12 INFO - Downloading/unpacking psutil>=0.7.1 02:06:12 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 02:06:12 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 02:06:12 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 02:06:12 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 02:06:12 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 02:06:12 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 02:06:14 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 02:06:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:06:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 02:06:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:06:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:06:14 INFO - Installing collected packages: psutil 02:06:14 INFO - Running setup.py install for psutil 02:06:14 INFO - building 'psutil._psutil_linux' extension 02:06:14 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 02:06:14 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 02:06:14 INFO - building 'psutil._psutil_posix' extension 02:06:14 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 02:06:14 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 02:06:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:06:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:06:14 INFO - Successfully installed psutil 02:06:14 INFO - Cleaning up... 02:06:15 INFO - Return code: 0 02:06:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 02:06:15 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')]} 02:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:15 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')]} 02:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:15 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 0x7fae007ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd9840>, '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 0x1d466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d46b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452852203.449501-145351206', '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 02:06:15 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 02:06:15 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 02:06:15 INFO - Using env: {'DISPLAY': ':0', 02:06:15 INFO - 'HOME': '/home/cltbld', 02:06:15 INFO - 'LANG': 'en_US.UTF-8', 02:06:15 INFO - 'LANGUAGE': 'en_US:en', 02:06:15 INFO - 'LOGNAME': 'cltbld', 02:06:15 INFO - 'MAIL': '/var/mail/cltbld', 02:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:15 INFO - 'MOZ_NO_REMOTE': '1', 02:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:15 INFO - 'NO_EM_RESTART': '1', 02:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:15 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:15 INFO - 'SHELL': '/bin/bash', 02:06:15 INFO - 'SHLVL': '1', 02:06:15 INFO - 'TERM': 'linux', 02:06:15 INFO - 'TMOUT': '86400', 02:06:15 INFO - 'USER': 'cltbld', 02:06:15 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452852203.449501-145351206', 02:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:15 INFO - '_': '/tools/buildbot/bin/python'} 02:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:06:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:06:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:06:16 INFO - Installing collected packages: mozsystemmonitor 02:06:16 INFO - Running setup.py install for mozsystemmonitor 02:06:17 INFO - Successfully installed mozsystemmonitor 02:06:17 INFO - Cleaning up... 02:06:17 INFO - Return code: 0 02:06:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 02:06:17 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')]} 02:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:17 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')]} 02:06:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:17 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 0x7fae007ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd9840>, '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 0x1d466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d46b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452852203.449501-145351206', '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 02:06:17 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 02:06:17 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 02:06:17 INFO - Using env: {'DISPLAY': ':0', 02:06:17 INFO - 'HOME': '/home/cltbld', 02:06:17 INFO - 'LANG': 'en_US.UTF-8', 02:06:17 INFO - 'LANGUAGE': 'en_US:en', 02:06:17 INFO - 'LOGNAME': 'cltbld', 02:06:17 INFO - 'MAIL': '/var/mail/cltbld', 02:06:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:17 INFO - 'MOZ_NO_REMOTE': '1', 02:06:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:17 INFO - 'NO_EM_RESTART': '1', 02:06:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:17 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:17 INFO - 'SHELL': '/bin/bash', 02:06:17 INFO - 'SHLVL': '1', 02:06:17 INFO - 'TERM': 'linux', 02:06:17 INFO - 'TMOUT': '86400', 02:06:17 INFO - 'USER': 'cltbld', 02:06:17 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452852203.449501-145351206', 02:06:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:17 INFO - '_': '/tools/buildbot/bin/python'} 02:06:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:17 INFO - Downloading/unpacking blobuploader==1.2.4 02:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:19 INFO - Downloading blobuploader-1.2.4.tar.gz 02:06:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:06:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:06:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:06:19 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 02:06:19 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 02:06:19 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 02:06:19 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 02:06:19 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 02:06:19 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 02:06:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:06:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 02:06:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:06:19 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 02:06:19 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 02:06:19 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 02:06:19 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 02:06:19 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 02:06:19 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 02:06:19 INFO - Downloading docopt-0.6.1.tar.gz 02:06:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:06:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 02:06:19 INFO - Installing collected packages: blobuploader, requests, docopt 02:06:19 INFO - Running setup.py install for blobuploader 02:06:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:06:19 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 02:06:19 INFO - Running setup.py install for requests 02:06:20 INFO - Running setup.py install for docopt 02:06:20 INFO - Successfully installed blobuploader requests docopt 02:06:20 INFO - Cleaning up... 02:06:20 INFO - Return code: 0 02:06:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:06:20 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')]} 02:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:20 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')]} 02:06:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:20 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 0x7fae007ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd9840>, '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 0x1d466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d46b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452852203.449501-145351206', '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 02:06:20 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 02:06:20 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 02:06:20 INFO - Using env: {'DISPLAY': ':0', 02:06:20 INFO - 'HOME': '/home/cltbld', 02:06:20 INFO - 'LANG': 'en_US.UTF-8', 02:06:20 INFO - 'LANGUAGE': 'en_US:en', 02:06:20 INFO - 'LOGNAME': 'cltbld', 02:06:20 INFO - 'MAIL': '/var/mail/cltbld', 02:06:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:20 INFO - 'MOZ_NO_REMOTE': '1', 02:06:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:20 INFO - 'NO_EM_RESTART': '1', 02:06:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:20 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:20 INFO - 'SHELL': '/bin/bash', 02:06:20 INFO - 'SHLVL': '1', 02:06:20 INFO - 'TERM': 'linux', 02:06:20 INFO - 'TMOUT': '86400', 02:06:20 INFO - 'USER': 'cltbld', 02:06:20 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452852203.449501-145351206', 02:06:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:20 INFO - '_': '/tools/buildbot/bin/python'} 02:06:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:06:20 INFO - Running setup.py (path:/tmp/pip-nj0OXF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:06:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:06:20 INFO - Running setup.py (path:/tmp/pip-ZAHyXy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:06:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:06:20 INFO - Running setup.py (path:/tmp/pip-NFEKyi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:06:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:06:20 INFO - Running setup.py (path:/tmp/pip-C59m4U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:06:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:06:20 INFO - Running setup.py (path:/tmp/pip-0Y4Mpf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:06:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:06:20 INFO - Running setup.py (path:/tmp/pip-06OCLs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:06:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:06:20 INFO - Running setup.py (path:/tmp/pip-7EqthX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:06:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:06:21 INFO - Running setup.py (path:/tmp/pip-G_JmV7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:06:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:06:21 INFO - Running setup.py (path:/tmp/pip-C12dhb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:06:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:06:21 INFO - Running setup.py (path:/tmp/pip-PNEFDE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:06:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:06:21 INFO - Running setup.py (path:/tmp/pip-pgDrFf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:06:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:06:21 INFO - Running setup.py (path:/tmp/pip-T5MiOL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:06:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:06:21 INFO - Running setup.py (path:/tmp/pip-z13kpV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:06:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:06:21 INFO - Running setup.py (path:/tmp/pip-cKhRHS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:06:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:06:21 INFO - Running setup.py (path:/tmp/pip-CxcDNp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:06:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:06:21 INFO - Running setup.py (path:/tmp/pip-AdIEg_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:06:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:06:21 INFO - Running setup.py (path:/tmp/pip-jkIcG2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:06:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:06:21 INFO - Running setup.py install for manifestparser 02:06:21 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 02:06:21 INFO - Running setup.py install for mozcrash 02:06:21 INFO - Running setup.py install for mozdebug 02:06:22 INFO - Running setup.py install for mozdevice 02:06:22 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 02:06:22 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 02:06:22 INFO - Running setup.py install for mozfile 02:06:22 INFO - Running setup.py install for mozhttpd 02:06:22 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 02:06:22 INFO - Running setup.py install for mozinfo 02:06:22 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 02:06:22 INFO - Running setup.py install for mozInstall 02:06:22 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 02:06:22 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 02:06:22 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 02:06:22 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 02:06:22 INFO - Running setup.py install for mozleak 02:06:22 INFO - Running setup.py install for mozlog 02:06:22 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 02:06:22 INFO - Running setup.py install for moznetwork 02:06:22 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 02:06:22 INFO - Running setup.py install for mozprocess 02:06:22 INFO - Running setup.py install for mozprofile 02:06:23 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 02:06:23 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 02:06:23 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 02:06:23 INFO - Running setup.py install for mozrunner 02:06:23 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 02:06:23 INFO - Running setup.py install for mozscreenshot 02:06:23 INFO - Running setup.py install for moztest 02:06:23 INFO - Running setup.py install for mozversion 02:06:23 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 02:06:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:06:23 INFO - Cleaning up... 02:06:23 INFO - Return code: 0 02:06:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fae007ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd9840>, '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 0x1d466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d46b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452852203.449501-145351206', '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 02:06:23 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 02:06:23 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 02:06:23 INFO - Using env: {'DISPLAY': ':0', 02:06:23 INFO - 'HOME': '/home/cltbld', 02:06:23 INFO - 'LANG': 'en_US.UTF-8', 02:06:23 INFO - 'LANGUAGE': 'en_US:en', 02:06:23 INFO - 'LOGNAME': 'cltbld', 02:06:23 INFO - 'MAIL': '/var/mail/cltbld', 02:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:23 INFO - 'MOZ_NO_REMOTE': '1', 02:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:23 INFO - 'NO_EM_RESTART': '1', 02:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:23 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:23 INFO - 'SHELL': '/bin/bash', 02:06:23 INFO - 'SHLVL': '1', 02:06:23 INFO - 'TERM': 'linux', 02:06:23 INFO - 'TMOUT': '86400', 02:06:23 INFO - 'USER': 'cltbld', 02:06:23 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452852203.449501-145351206', 02:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:23 INFO - '_': '/tools/buildbot/bin/python'} 02:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:06:23 INFO - Running setup.py (path:/tmp/pip-QkB8UC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:06:23 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)) 02:06:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:06:23 INFO - Running setup.py (path:/tmp/pip-DPMhHZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:06:23 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)) 02:06:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:06:23 INFO - Running setup.py (path:/tmp/pip-EBproW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:06:23 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)) 02:06:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:06:23 INFO - Running setup.py (path:/tmp/pip-KwCL0i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 02:06:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:06:24 INFO - Running setup.py (path:/tmp/pip-CDUZfW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:06:24 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)) 02:06:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:06:24 INFO - Running setup.py (path:/tmp/pip-xUMx9q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:06:24 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)) 02:06:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:06:24 INFO - Running setup.py (path:/tmp/pip-itnOde-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:06:24 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)) 02:06:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:06:24 INFO - Running setup.py (path:/tmp/pip-ZoWV2J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:06:24 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)) 02:06:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:06:24 INFO - Running setup.py (path:/tmp/pip-oI_Q4V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:06:24 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)) 02:06:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:06:24 INFO - Running setup.py (path:/tmp/pip-WVxt2T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:06:24 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)) 02:06:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:06:24 INFO - Running setup.py (path:/tmp/pip-uw2kny-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:06:24 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)) 02:06:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:06:24 INFO - Running setup.py (path:/tmp/pip-KhxO_W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:06:24 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)) 02:06:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:06:24 INFO - Running setup.py (path:/tmp/pip-QsEgs8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:06:24 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)) 02:06:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:06:24 INFO - Running setup.py (path:/tmp/pip-mqSYKg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:06:24 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)) 02:06:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:06:24 INFO - Running setup.py (path:/tmp/pip-_AxwnV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:06:24 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)) 02:06:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:06:24 INFO - Running setup.py (path:/tmp/pip-L16EzS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:06:24 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)) 02:06:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:06:24 INFO - Running setup.py (path:/tmp/pip-diyRYc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:06:24 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)) 02:06:24 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)) 02:06:24 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)) 02:06:24 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)) 02:06:24 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 02:06:24 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 02:06:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 02:06:24 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 02:06:24 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 02:06:24 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 02:06:24 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 02:06:24 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 02:06:24 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 02:06:26 INFO - Downloading blessings-1.5.1.tar.gz 02:06:26 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 02:06:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 02:06:26 INFO - Installing collected packages: blessings 02:06:26 INFO - Running setup.py install for blessings 02:06:27 INFO - Successfully installed blessings 02:06:27 INFO - Cleaning up... 02:06:27 INFO - Return code: 0 02:06:27 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 02:06:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:06:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:06:27 INFO - Reading from file tmpfile_stdout 02:06:27 INFO - Current package versions: 02:06:27 INFO - argparse == 1.2.1 02:06:27 INFO - blessings == 1.5.1 02:06:27 INFO - blobuploader == 1.2.4 02:06:27 INFO - docopt == 0.6.1 02:06:27 INFO - manifestparser == 1.1 02:06:27 INFO - mozInstall == 1.12 02:06:27 INFO - mozcrash == 0.16 02:06:27 INFO - mozdebug == 0.1 02:06:27 INFO - mozdevice == 0.48 02:06:27 INFO - mozfile == 1.2 02:06:27 INFO - mozhttpd == 0.7 02:06:27 INFO - mozinfo == 0.9 02:06:27 INFO - mozleak == 0.1 02:06:27 INFO - mozlog == 3.1 02:06:27 INFO - moznetwork == 0.27 02:06:27 INFO - mozprocess == 0.22 02:06:27 INFO - mozprofile == 0.28 02:06:27 INFO - mozrunner == 6.11 02:06:27 INFO - mozscreenshot == 0.1 02:06:27 INFO - mozsystemmonitor == 0.0 02:06:27 INFO - moztest == 0.7 02:06:27 INFO - mozversion == 1.4 02:06:27 INFO - psutil == 3.1.1 02:06:27 INFO - requests == 1.2.3 02:06:27 INFO - wsgiref == 0.1.2 02:06:27 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:06:27 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')]} 02:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:27 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')]} 02:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:27 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 0x7fae007ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd9840>, '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 0x1d466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d46b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452852203.449501-145351206', '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 02:06:27 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 02:06:27 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 02:06:27 INFO - Using env: {'DISPLAY': ':0', 02:06:27 INFO - 'HOME': '/home/cltbld', 02:06:27 INFO - 'LANG': 'en_US.UTF-8', 02:06:27 INFO - 'LANGUAGE': 'en_US:en', 02:06:27 INFO - 'LOGNAME': 'cltbld', 02:06:27 INFO - 'MAIL': '/var/mail/cltbld', 02:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:27 INFO - 'MOZ_NO_REMOTE': '1', 02:06:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:27 INFO - 'NO_EM_RESTART': '1', 02:06:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:27 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:27 INFO - 'SHELL': '/bin/bash', 02:06:27 INFO - 'SHLVL': '1', 02:06:27 INFO - 'TERM': 'linux', 02:06:27 INFO - 'TMOUT': '86400', 02:06:27 INFO - 'USER': 'cltbld', 02:06:27 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452852203.449501-145351206', 02:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:27 INFO - '_': '/tools/buildbot/bin/python'} 02:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:27 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)) 02:06:27 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)) 02:06:27 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)) 02:06:27 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)) 02:06:27 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)) 02:06:27 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)) 02:06:27 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)) 02:06:27 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)) 02:06:27 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)) 02:06:27 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)) 02:06:27 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)) 02:06:27 INFO - Cleaning up... 02:06:27 INFO - Return code: 0 02:06:27 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 02:06:27 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')]} 02:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:27 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')]} 02:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:27 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 0x7fae007ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd9840>, '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 0x1d466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d46b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452852203.449501-145351206', '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 02:06:27 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 02:06:27 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 02:06:27 INFO - Using env: {'DISPLAY': ':0', 02:06:27 INFO - 'HOME': '/home/cltbld', 02:06:27 INFO - 'LANG': 'en_US.UTF-8', 02:06:27 INFO - 'LANGUAGE': 'en_US:en', 02:06:27 INFO - 'LOGNAME': 'cltbld', 02:06:27 INFO - 'MAIL': '/var/mail/cltbld', 02:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:27 INFO - 'MOZ_NO_REMOTE': '1', 02:06:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:27 INFO - 'NO_EM_RESTART': '1', 02:06:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:27 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:27 INFO - 'SHELL': '/bin/bash', 02:06:27 INFO - 'SHLVL': '1', 02:06:27 INFO - 'TERM': 'linux', 02:06:27 INFO - 'TMOUT': '86400', 02:06:27 INFO - 'USER': 'cltbld', 02:06:27 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452852203.449501-145351206', 02:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:27 INFO - '_': '/tools/buildbot/bin/python'} 02:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:27 INFO - Downloading/unpacking jsonschema 02:06:27 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 02:06:27 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 02:06:27 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 02:06:27 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 02:06:27 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 02:06:27 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 02:06:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:06:29 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 02:06:29 INFO - Downloading/unpacking functools32 (from jsonschema) 02:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:29 INFO - Downloading functools32-3.2.3-2.tar.gz 02:06:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 02:06:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 02:06:29 INFO - warning: no files found matching '*.txt' 02:06:29 INFO - no previously-included directories found matching 'build' 02:06:29 INFO - no previously-included directories found matching 'dist' 02:06:29 INFO - no previously-included directories found matching '.git*' 02:06:29 INFO - Installing collected packages: jsonschema, functools32 02:06:29 INFO - Running setup.py install for functools32 02:06:29 INFO - warning: no files found matching '*.txt' 02:06:29 INFO - no previously-included directories found matching 'build' 02:06:29 INFO - no previously-included directories found matching 'dist' 02:06:29 INFO - no previously-included directories found matching '.git*' 02:06:29 INFO - Successfully installed jsonschema functools32 02:06:29 INFO - Cleaning up... 02:06:29 INFO - Return code: 0 02:06:29 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 02:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae007ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd9840>, '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 0x1d466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d46b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452852203.449501-145351206', '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 02:06:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 02:06:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:06:29 INFO - Using env: {'DISPLAY': ':0', 02:06:29 INFO - 'HOME': '/home/cltbld', 02:06:29 INFO - 'LANG': 'en_US.UTF-8', 02:06:29 INFO - 'LANGUAGE': 'en_US:en', 02:06:29 INFO - 'LOGNAME': 'cltbld', 02:06:29 INFO - 'MAIL': '/var/mail/cltbld', 02:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:29 INFO - 'MOZ_NO_REMOTE': '1', 02:06:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:29 INFO - 'NO_EM_RESTART': '1', 02:06:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:29 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:29 INFO - 'SHELL': '/bin/bash', 02:06:29 INFO - 'SHLVL': '1', 02:06:29 INFO - 'TERM': 'linux', 02:06:29 INFO - 'TMOUT': '86400', 02:06:29 INFO - 'USER': 'cltbld', 02:06:29 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452852203.449501-145351206', 02:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:29 INFO - '_': '/tools/buildbot/bin/python'} 02:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:30 INFO - Downloading/unpacking flake8 02:06:30 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 02:06:30 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 02:06:30 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 02:06:30 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 02:06:30 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 02:06:30 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 02:06:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:06:31 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 02:06:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:06:32 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 02:06:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:06:32 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 02:06:32 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 02:06:32 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 02:06:32 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 02:06:32 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 02:06:32 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 02:06:32 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 02:06:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:06:32 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 02:06:32 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 02:06:32 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 02:06:32 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 02:06:32 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 02:06:32 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 02:06:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 02:06:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 02:06:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:06:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:06:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:06:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:06:32 INFO - no previously-included directories found matching 'docs/_build' 02:06:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:06:32 INFO - Running setup.py install for pep8 02:06:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:06:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:06:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:06:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:06:32 INFO - no previously-included directories found matching 'docs/_build' 02:06:32 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 02:06:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:06:32 INFO - Cleaning up... 02:06:32 INFO - Return code: 0 02:06:32 INFO - Running post-action listener: _resource_record_post_action 02:06:32 INFO - Running post-action listener: _start_resource_monitoring 02:06:32 INFO - Starting resource monitoring. 02:06:32 INFO - ##### 02:06:32 INFO - ##### Running install step. 02:06:32 INFO - ##### 02:06:32 INFO - Running pre-action listener: _resource_record_pre_action 02:06:32 INFO - Running main action method: install 02:06:32 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:06:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:06:32 INFO - Reading from file tmpfile_stdout 02:06:32 INFO - Detecting whether we're running mozinstall >=1.0... 02:06:32 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 02:06:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 02:06:33 INFO - Reading from file tmpfile_stdout 02:06:33 INFO - Output received: 02:06:33 INFO - Usage: mozinstall [options] installer 02:06:33 INFO - Options: 02:06:33 INFO - -h, --help show this help message and exit 02:06:33 INFO - -d DEST, --destination=DEST 02:06:33 INFO - Directory to install application into. [default: 02:06:33 INFO - "/builds/slave/test-pgo"] 02:06:33 INFO - --app=APP Application being installed. [default: firefox] 02:06:33 INFO - mkdir: /builds/slave/test-pgo/build/application 02:06:33 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'] 02:06:33 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 02:06:49 INFO - Reading from file tmpfile_stdout 02:06:49 INFO - Output received: 02:06:49 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 02:06:49 INFO - Running post-action listener: _resource_record_post_action 02:06:49 INFO - ##### 02:06:49 INFO - ##### Running run-tests step. 02:06:49 INFO - ##### 02:06:49 INFO - Running pre-action listener: _resource_record_pre_action 02:06:49 INFO - Running main action method: run_tests 02:06:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 02:06:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 02:06:49 INFO - Python 2.7.3 02:06:49 INFO - Return code: 0 02:06:49 INFO - grabbing minidump binary from tooltool 02:06: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')]} 02:06:49 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 0x1dd9840>, '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 0x1d466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d46b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 02:06:49 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 02:06:49 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 02:06:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:06:49 INFO - Return code: 0 02:06:49 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 02:06:49 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 02:06:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 02:06:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 02:06:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 02:06:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 02:06:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 02:06:50 INFO - Return code: 0 02:06:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HTFYYCzKTEOtseNi6f8Jsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 02:06:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HTFYYCzKTEOtseNi6f8Jsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 02:06:50 INFO - Using env: {'DISPLAY': ':0', 02:06:50 INFO - 'HOME': '/home/cltbld', 02:06:50 INFO - 'LANG': 'en_US.UTF-8', 02:06:50 INFO - 'LANGUAGE': 'en_US:en', 02:06:50 INFO - 'LOGNAME': 'cltbld', 02:06:50 INFO - 'MAIL': '/var/mail/cltbld', 02:06:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:06:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 02:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:50 INFO - 'MOZ_NO_REMOTE': '1', 02:06:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:50 INFO - 'NO_EM_RESTART': '1', 02:06:50 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:50 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:50 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 02:06:50 INFO - 'SHELL': '/bin/bash', 02:06:50 INFO - 'SHLVL': '1', 02:06:50 INFO - 'TERM': 'linux', 02:06:50 INFO - 'TMOUT': '86400', 02:06:50 INFO - 'USER': 'cltbld', 02:06:50 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1452852203.449501-145351206', 02:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:50 INFO - '_': '/tools/buildbot/bin/python'} 02:06:50 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HTFYYCzKTEOtseNi6f8Jsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:06:50 INFO - mozversion application_buildid: 20160114233004 02:06:50 INFO - mozversion application_changeset: 08cf4f9b73f7a3c4509cbd1b846c3459fbb9e246 02:06:50 INFO - mozversion application_display_name: Nightly 02:06:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:06:50 INFO - mozversion application_name: Firefox 02:06:50 INFO - mozversion application_remotingname: firefox 02:06:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 02:06:50 INFO - mozversion application_vendor: Mozilla 02:06:50 INFO - mozversion application_version: 46.0a1 02:06:50 INFO - mozversion platform_buildid: 20160114233004 02:06:50 INFO - mozversion platform_changeset: 08cf4f9b73f7a3c4509cbd1b846c3459fbb9e246 02:06:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 02:06:50 INFO - mozversion platform_version: 46.0a1 02:06:50 INFO - using testdate: 1452852410 02:06:50 INFO - actual date: 1452852410 02:06:50 INFO - starting webserver on 'localhost:50202' 02:06:50 INFO - SUITE-START | Running 3 tests 02:06:50 INFO - TEST-START | dromaeo_css 02:06:50 INFO - operating with platform_type : linux_ 02:06:50 INFO - Initialising browser for dromaeo_css test... 02:06:50 INFO - TEST-INFO | started process 20518 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpB3BqAr/profile http://localhost:50202/getInfo.html) 02:06:54 INFO - PROCESS | 20518 | __metrics Screen width/height:1600/1200 02:06:54 INFO - PROCESS | 20518 | colorDepth:24 02:06:54 INFO - PROCESS | 20518 | Browser inner width/height: 1024/697 02:06:54 INFO - PROCESS | 20518 | __metrics 02:06:54 INFO - PROCESS | 20518 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:06:54 INFO - PROCESS | 20518 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:06:55 INFO - TEST-INFO | 20518: exit 0 02:06:55 INFO - Browser initialized. 02:06:55 INFO - Running cycle 1/1 for dromaeo_css test... 02:06:55 INFO - TEST-INFO | started process 20614 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpB3BqAr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:07:07 INFO - PROCESS | 20614 | RSS: Main: 150351872 02:07:07 INFO - PROCESS | 20614 | 02:07:58 INFO - PROCESS | 20614 | 1452852478855 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] 02:10:07 INFO - PROCESS | 20614 | Cycle 1(1): loaded http://localhost:50202/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50202/tests/dromaeo/cssquery-ext.html) 02:10:08 INFO - PROCESS | 20614 | RSS: Main: 231694336 02:10:08 INFO - PROCESS | 20614 | 02:13:10 INFO - PROCESS | 20614 | Cycle 1(1): loaded http://localhost:50202/tests/dromaeo/cssquery-ext.html (next: http://localhost:50202/tests/dromaeo/cssquery-jquery.html) 02:13:11 INFO - PROCESS | 20614 | RSS: Main: 229347328 02:13:11 INFO - PROCESS | 20614 | 02:16:13 INFO - PROCESS | 20614 | Cycle 1(1): loaded http://localhost:50202/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50202/tests/dromaeo/cssquery-mootools.html) 02:16:13 INFO - PROCESS | 20614 | RSS: Main: 236834816 02:16:13 INFO - PROCESS | 20614 | 02:19:15 INFO - PROCESS | 20614 | Cycle 1(1): loaded http://localhost:50202/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50202/tests/dromaeo/cssquery-prototype.html) 02:19:16 INFO - PROCESS | 20614 | RSS: Main: 211374080 02:19:16 INFO - PROCESS | 20614 | 02:22:18 INFO - PROCESS | 20614 | Cycle 1(1): loaded http://localhost:50202/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50202/tests/dromaeo/cssquery-yui.html) 02:22:19 INFO - PROCESS | 20614 | RSS: Main: 216854528 02:22:19 INFO - PROCESS | 20614 | 02:25:22 INFO - PROCESS | 20614 | Cycle 1(1): loaded http://localhost:50202/tests/dromaeo/cssquery-yui.html (next: http://localhost:50202/tests/dromaeo/cssquery-dojo.html) 02:25:22 INFO - PROCESS | 20614 | RSS: Main: 300281856 02:25:22 INFO - PROCESS | 20614 | 02:25:22 INFO - PROCESS | 20614 | __start_tp_report 02:25:22 INFO - PROCESS | 20614 | _x_x_mozilla_page_load 02:25:22 INFO - PROCESS | 20614 | _x_x_mozilla_page_load_details 02:25:22 INFO - PROCESS | 20614 | |i|pagename|runs| 02:25:22 INFO - PROCESS | 20614 | |0;dojo.html;3088.567600535924;3101.255698632328;3139.654637989821;3153.0068028571;3165.1137681449195;4985.476524964881;5043.36957880265;5136.845894623162;5144.20264858947;5173.715445650492;5013.473585273548;5030.346055012852;5072.416672082712;5087.898242035157;5090.134677104892;4443.133588950156;4597;4681.227597446417;4759.762011899408;4789.233722604384;4567.954320456786;4653.278741795028;4757.571818536331;4768.97615511922;4866.148424025799;4653.581177694007;4676.719396836201;4692.131955588227;4703.835365762182;4738.099761045425;4655.4180727409075;4677.228257337535;4683;4692.436907571079;4731.195696731564;4627.953720462786;4634.95365046352;4669.066186762661;4687.226607609774;4695.929561056587;4912.410510738734;4959.330490383824;4972.353594032753;4980.551750342486;5020.2720605511995;5383.542398896098;5394.649347792381;5401.43284955078;5438.945610543883;5452.727363631842;5328.8401347959625;5428.45715428458;5430.185472179165;5489.917651235235;5539.501444869981;5136.794528218867;5152.175651895679;5208.687478751249;5210.921836172461;5231.738413079331;5532.75102620383;5536.141898005815;5537.1140617501815;5540.030494663418;5594.0769772987815;5320.1753728171425;5363.088274993261;5364.088105022156;5372.1941708744;5401.432849550741;5441.183822426668;5533.529649979797;5568.832935011957;5571.972140139354;5618.129189975561;5403.83788486346;5422.6475279106735;5422.864428389322;5425.430329815392;5431.6740995540395;5386.353637563439;5419.647722897999;5440.564754819605;5453;5467.726613669301;4262.211490874198;4297.247981603207;4303.849365272201;4324.805383757738;4333.8699839004885;3841.3277676407074;3854.5181852268465;3855.0747820523434;3879.2241551689212;3882.8835134946;5013.323201367842;5079.6952182869145;5114.820981265638;5173.120569503193;5218.817341393033;5388.0570900092325;5429.321334833146;5437.972810135924;5458.5087342139395;5503.036968530491;5105.489451054865;5123.846284611468;5130.1535246684625;5139.434662187156;5191.8182863599595;4680.3447517347595;4742.1227072991605;4751.572358487752;4769.30845027476;4782.569568738761;5684.545236381162;5696.800611978644;5697.857553561194;5699.4585514376895;5716.171155182476;5505.587080968863;5519.972400137974;5525.4474552544425;5529.22590837275;5533.916991245215;5530.778768849362;5641.26663533738;5679;5736.827895163152;5769.394213607511;5398.46015398457;5405.702686352289;5406.0809662356705;5412.7564259607625;5413.729313534386;5423.83728488146;5472.315960504937;5473.753681084281;5494.36814766307;5537.750801214036;5271.630985830955;5355.062863998707;5404.405515393225;5517.475839795213;5564.332280126248;5354.250404943389;5356.303680521507;5359.3032905722;5362.1420572708175;5376.489233522809;5177.922331165111;5278.4721527846905;5279.709615971158;5280.234366016983;5327.067763141512;5362.276092727432;5379.381371142369;5447;5509.283793106871;5514.476124768141;5297.682139071668;5333.280007199133;5351.839444816506;5351.973240133774;5362.570994320523 02:25:22 INFO - PROCESS | 20614 | |1;ext.html;515.7498613172613;527.6675694312582;530.9389420216675;532.5473347654492;551.6221388348984;28730.425391492183;29343.853280733594;38430.23139537207;38743.225135497276;38837.41743873844;43059.56940430595;43488.347674784905;43576;43605.345919811225;43649.7817510912;8531.104234055429;8725.738227853175;8735.825283494327;8736.21374076333;8739.126087391242;8452.366072544553;8484.151584841527;8487.915120848806;8490.575471226413;8498.065212826585;8485.787855303635;8563.35774816888;8563.529005904673;8564.357673174536;8564.785880352978;8442.873356899652;8519;8520.147985201493;8520.659173633108;8523.232909038185;8408.453450525696;8574.871376929352;8577.442466239736;8580.056193818675;8582.485050896967;38949;39163.60836391628;39425.211495770214;39563;39564.80217598922;3147.937041259162;3167.9366412671616;3175.6506784253716;3289.654586268431;3487.354839354702;29305.85347073251;29525.261868453246;29765;30067;30257.09228723142;3268.526063720771;3279.7868138570916;3304.2235074757414;3308.586426696663;3324.1024923270584;258968;259586;259810;260583;260682.69658651776;50934;56075;56383.71808140933;56388;56573;46247.53143514183;46477.535224647996;46490.5350946493;46505.5349446508;60627.393726063056;14221.217833019076;14334.426622934965;14351.210683412304;14446.133232006114;14462.855371446361;10624.096951759188;10711.25021248505;10719.303245289188;10721.035106840422;10725.03474687282;17127.400540981005;17606.735898961524;17611.647767044844;17614;19048.14283357252;7183.5330703504105;7287.599182045038;7467.813304667427;7493.3630641395;7511.136219334847;934.7756538430727;948.6395169835419;981.7938232971156;1014.8731408573929;1054.651964851597;25924.481510369686;26381.34046648849;26465.206043818333;26603.600945985825;28540.429191416057;1009.3237530854345;1014;1051.805415998043;1058.439027315524;1103.4041617526445;14959;15581.688366232613;15626.921865390828;15721.68556628884;15860.20698965047;331689;339541;339675;339695;340731;45626.77186614046;45933.08133837304;45952.77023614861;46036.5396346039;46082;1211.5335595795682;1237.1216436330126;1242.167747609104;1243.608263397027;1334.546254273571;24712.25863224106;25547;25793.742062579884;26031.609525857508;26061.478770424863;37867.431988520744;38343.42484862785;38437;38712;40750.1849963005;188669;401779;408036;410128;411474;30041.69958300389;30695.846520767253;30757.23106922345;30789.692103078683;30798.384032319675;40088;41384.58615413807;41422;41739.79130104451;42733.93165170771;34488.79289224865;34811.825940870134;34845.477317839745;35279.64720352764;35740.46389304214;35136.64863351334;35426.82286588551;35660.79052885253;36037;36198.45702314415;34780;35124;35181.648183517835;35339.116522087155;35524;29651.555226671186;32221.355572887944;32524.186895327806;32528.83735581307;32655.673443265263;24336.269911902673;32637.673623264414;32689.673103269615;32893.67106329002;33478.66521334756 02:25:22 INFO - PROCESS | 20614 | |2;jquery.html;359.76255671256973;362.10018105009067;365.5321188878237;366.04279808301294;366.8715949417704;13715.65710857229;13903.443862245498;16163.515094547167;17328.65342693147;18266.90866545667;15771.447999320026;15990.76013859793;16007.519774406786;16041.117738524377;16877.324907003705;5357.705326207067;5549.084401073818;5549.112142057272;5557.249771280865;5561.805336813212;4015.959840401588;4125.608067233608;5481.972590137064;5796.391378905218;6005.069214271773;5682.147677848315;5926.199963004982;5972;5978.581499295051;6055.424734650223;5935.52515798735;5968.820935371946;5973.8805223895715;5981.371955944606;6003.189569408118;5142.357205349332;5361.678299302015;5361.705106219157;5378.139497680352;5378.865528361783;19956.401307960783;20033.298834540867;20081.497962550908;20142.597148056957;20321.18715251388;1999.5001249687577;2141.379000089972;2195.067096483988;2214.568159208955;2220.222921977311;12704.618861434172;12824.166429182167;12872.485100595964;13051.282179480124;13086.607401777961;1795.3177792438921;1802.6845302072086;1817.872748907577;1837;1866.6266746650724;53687.731561342334;55405.72297138489;55777;56233;57157;9161.77095572616;9380.827396575429;9713.465759383302;9739.123478886933;9787.168090712226;12069.939650301692;12070.215435996632;12117.212381195193;12124.211926224943;12133.575324863587;7026.9648651756415;7031.507794454441;7195.100612423447;7406;7445.85108297831;7095.929040709527;7114.110736157981;7167.390771784457;7167.92832071683;7174.569525828467;5375.5162035416215;5764.308283006066;5859;5866.823995280149;5964.075568286922;1695.3557648093893;1713.9742903856452;1773.2995466790546;1783.777027871516;1794.8564114870778;419.3248869320392;885.964561417549;887.6405055952349;909.2862103248918;1073.1254027967182;9656.855147172799;10207.591696332063;10454.790904181873;10631.84052239217;15477.767833482507;911.8541033434751;916.5875356089653;966.8018056298442;973.9318247722733;982.4792859784326;9259.814803703888;9266.44401335922;9292.860607090899;9351.859722104175;9461.810763784686;365325.1362023324;461731;466126;476711;529720;43906.12187756227;44590.10819783586;44628.55371446309;52220;70160.94758578626;1100.6202860013282;1148.471703016605;1149.230015889356;1154.7113221694576;1155.9075273978062;14459.204743739196;14601.196934168724;14682.55952321432;14764.48324308644;14883.10701357922;30558.541621876135;30637;32034;33173.336533269685;33746;37897.4315385275;44650;44972.55027449683;45170.77414612906;47895.76052119717;9249.953750231205;9750.512474376395;9863.654772082942;9917;10010.499475026365;11134.498947547218;11382.829257560978;11469.19715619932;11565.306081635128;11849.111316651113;9692.806143876942;9879.259055571005;10094.394336339843;10101.292909496558;10121.59513619447;3108.7202151806446;8031.55826429552;9813.675153854138;10084;10087.7478063049;7132.072830531998;7287.052683151156;7316.268373162641;9571.712848614274;9863.852042219516;9612.327137100336;9681.51592420362;9684;9783.559739811868;10099.848502272618;3027.2885871820545;3034.30211051455;6526.869462610816;9099.3611852562;9426.811463770824 02:25:22 INFO - PROCESS | 20614 | |3;mootools.html;1300.0574583427021;1447.413797412048;1462.7074585082987;1640.2126979050056;1835.605344850857;6885.380315771579;7534.924650753498;7697.769066927987;7699.384049276058;7710.57591832449;7464.589447580381;7624.466287359887;7635.961820190905;7638.236176382373;7645.61771911405;2014.879107253562;2052.8152466278034;2272.1933713531707;2293.117149897293;2316.0041182291607;2324.7210334759766;2339.1345202275184;2339.333290012347;2341.531693661266;2342.074880422232;2223.8888055597154;2281.6235321171985;2283.7602051784575;2285.2572913802996;2287.645414960684;2266.093562574975;2295.4376177836452;2325.337278875529;2331.0908745589236;2337.5091230841545;2273.977260227393;2285.7599952005135;2294.2543673306077;2295.517941232343;2345.906163753448;7746.961265193694;7808.843823123506;7809.453338266324;7810.336121429686;7819.139894611645;4756;4834.661573689843;4848.927266091011;4861.586765124968;4877.731724755137;3019.9396012079637;3053.740432063255;3105.45654510462;3149.9527507087414;3163.984180079108;989.9554520046543;1012.8531362952405;1013.3008224325192;1055.8732952045805;1069.6416700405373;10499.370037797757;10602.681919542427;10622.681319560348;10641.78716425675;10642.733931651694;4348.717333373321;4417.359482875029;4480.865574032719;4513.571210734975;4521.59305662492;9113.3165012623;9215.262778977665;9215.631374744935;9216.400933939407;9227.76930576741;4954.157793175169;4957.851264462072;4960.379952505937;4961.4294356148785;4962.181240095344;4532.9093418132115;4543.250363689954;4546.0680560485025;4548.249538826123;4550.954490455053;3456.6197718250974;3532.717382609385;3710.703143748494;3752.1932784451474;3781.5084039075296;1197.2098415046028;1232.7657745028416;1243.322389297835;1250.881166289201;1259.9685007874693;954.9618015279311;977.6627063663025;979.1823827104305;1084.8915108489089;1351.2568087551808;7323.487355885037;7345.265473452719;7349.595772232472;7367.631618419057;7367.81580460482;1186.306010983567;1187.441902305915;1200.1778781534676;1232.4146030635377;1253.4108968784656;5729.828105156852;5804.477597016289;5866.7653293868625;5868.706564671749;5877.206577112121;9003.369764116449;9353.204977576846;9365.531723413802;9379.812403751886;9382.296327775444;9101.81796364069;9152.496612686366;9263.629454821867;9266.073392660815;9272;7210.315020073084;7365.631718414058;7376.7049318026675;7457.216992215847;7474.289942455567;6868.484863635347;7125.216226215216;7162.641867906688;7179.569225846466;7193.388561972291;8327.125651806715;8336.541490218096;8508.446950948168;8596.871046934177;8683.522406267715;8562.48625082472;8796.164364385373;8820.955895220482;8955.910440895768;8994.145556172152;5856.092305692625;6698.2631910488835;6804.319568043156;6814;6818.18181818185;6881.862362752817;7134.964325178341;7291.927080729125;7292.671829767567;7310.086239220098;6751;6851.38337549603;6887.449004079762;6943.6875340608785;6975.686094125675;6794.218664853605;6800.455963523005;7042.330978557029;7078.823029424306;7085.0435191248525;7022.754203602849;7053.294670532906;7062.258462861531;7066.470014748812;7112.466565007749;6501.05734668461;6553.836154096186;6557.475401967927;6557.901631475627;6565.474762018932;6465.062565928009;6477.963525835844;6500.837479063061;6504.056911747675;6507.544471887112 02:25:22 INFO - PROCESS | 20614 | |4;prototype.html;323.88663967611336;332.42822345565634;342.4725922079997;342.9759916805823;351.91554027033504;5639.8590035249135;5727.11229759388;5733.168690539869;5750.223719797826;5774.249347584813;5516.14499752538;5632.746526406311;5642.661440313574;5645.661260324373;5674.574406919487;4487.596116349528;4497.10057988402;4497.527759585229;4499.302608095751;4510.661700372477;4334.913301733964;4406.162829062468;4446.933296000562;4516.4806047304655;4521.773911304438;4438.201123797715;4472.329150627399;4476.082403107355;4488.798004089824;4491.056878055612;4482.843100491484;4483.484399294074;4487;4495.145922274757;4501.909961800779;3998.420229066798;4006.198760247962;4006.6794656427705;4009.3184158693093;4012.598740125993;5337.5996800239745;5489.1217405214975;5500.50495455407;5502.202180683778;5514.310711161105;5129.487051294878;5141.897162056738;5145.897082058338;5146.176611742141;5147.794088236466;5738.282714660668;6069.817905462844;6073.453389194994;6075.665838378887;6078.057901025348;4173.686973476971;4177.8537751178565;4290.163418133465;4302.806373713191;4304.418903448026;6241.126242326078;6290.811275661737;6296.559240853142;6303.338149494329;6313.273973493061;4405.185040767468;4408.184485870124;4409.36064270679;4409.889752756207;4410.360497727812;4304;4466.905608125965;4467.642588592969;4469.776511174493;4472.664550158686;5107.514786095315;5107.948920510822;5108.361454818148;5110.744462776846;5119.155339368963;6084.117802918552;6091.604045737013;6092.51259899207;6096.055111457731;6096.207493025879;1525.3288553036627;1526.3055309833999;1527.557008467532;1528.808898887639;1532.762421824619;1050.3907733514695;1062.7768168684663;1068.108129711684;1077.380506208933;1081.1512962324537;5745.052066408995;5752.137179423036;5758.193852860602;5762.1068734346245;5764.07774756037;6200.720967556471;6203.47270482005;6209.316975132731;6219.191505104308;6224.128621992924;5748.6838223898085;5753.59724819267;5760.913586296209;5766.394528574523;5766.538676905838;3262.510623406508;3364.4616861302075;3365.5793025871767;3370.764046516769;3371.005553361764;6494.220693516808;6494.6103233806125;6498.317676643885;6498.610083395011;6503.122078519339;6353;6363.649999249993;6389.456896163785;6406.967965160145;6415.390537898986;6348.682565871688;6409.711562979677;6463.7737679181;6476.481881449473;6476.676166191672;6042.274927008787;6162.599431036968;6200.844978875564;6219.191505104308;6222.906656400248;6108.236470441195;6209.348018457997;6217.502599792097;6233.407826256498;6238.126662267377;6479.4816414685765;6519.250286216956;6523.967380163069;6526.902096468461;6528.477721782151;4266.5093514246255;4380.321050237091;4388.188185185623;4392.780360982002;4396.164728701537;6287.245530536365;6290.874182516415;6293.37066293367;6296.779612713533;6302.432781049728;6089.5737298388685;6141.969290153521;6143.815685529441;6148.016317389196;6150.04674275488;5967.403259673998;6101.206843110367;6132.63204207749;6134.4172303631085;6139.693015349126;6005.969970150121;6014.248218972629;6021.458068773832;6026.15633811258;6029.3669164737075;6107.175531303395;6137.478314343331;6158.661273629993;6161.876762464815;6162.876742465215;5903.970480147572;5994.88010239784;6002.309734380602;6013.218281623361;6020.488258498077 02:25:22 INFO - PROCESS | 20614 | |5;yui.html;853.906070332263;856.7215654912154;856.7258477287266;871.2942516561585;883.3330835219413;12548.309842958644;12845.293508857008;12861.678458038554;12864.871351286485;12868.163569367984;12764.042696797731;12833.101682882201;12840.74318513629;12844;12869.4208760606;811.9971834784037;813.8290958898639;814.0434988888062;814.1898810683379;815.5269943432795;661.7551505942783;814.6130587970696;817.791463176889;819.6311659753105;819.8114433680257;705.0833915909323;839.2991851803721;853.6116067189414;857.4126723194631;858.159004175908;835.5488036460304;848.325581162977;848.7878030492377;851.1360968616859;852.4246133859651;511.9334486516766;516.1844286028066;631.5705320382139;631.9210098737658;633.1420924647083;13134.277614731185;13377.53178638743;13472.25902575358;13518.188908665512;13525.797113043312;12445.751084978341;12781.424835882408;12828.743425131539;13264.40310186044;13310.733785324335;9810.166135878459;10100.090991810772;10218.335808172445;10269.229807764374;10346.844797328045;3313.9171520711934;3403;3419.760616756828;3449.1549570355173;3492.301539692072;45145.774271128765;45369.54630453686;45724.771376142904;45782.31326530105;46545.06909861784;9502.097300756417;9590.808183836285;9603.327767056378;9801.509924503745;10078.14335781452;19332.90333548323;19444;19449.51376215606;19484.02579871001;19487.415377538695;7844.725434609762;7885.645145968445;7979.880301795478;8054.3556515479795;8157.428979971345;4388.868333949987;4405.31717583775;4433.401490798766;4476.574725401082;4517.728936263835;3122.328699329655;3157.747380209578;3166.7149956503563;3172.6510083890753;3174.6349169845303;565.0817421689754;581.1718301420459;584.260909948915;612.7732738886551;615.3538784276582;511.81574633132044;570.3697414357158;611.1482208907019;677.0264678462228;731.5939653492363;8720.215180633773;8757.21185093332;8779.12208779117;8881.467111973303;9070.86393704095;511.71088335090553;554.1687468796805;641.2657507154282;651.8859199640044;680.2007641021779;3936;4026.565803972967;4221.9125953226285;4252.064545799919;4364.890877728082;55183;56109;56943.43056569464;57013;57377;46978.76510617425;47155.5284447158;47258;48449.51550484521;50921;44031.779841100586;44686.32970505445;44865;45200;45247.547524524336;8086.353091752763;8192.303654189222;8194.918050819415;8309.95845020771;8385;32365.676343236268;32579.02262932116;33140.502892457116;33216.83391583027;33477.83261083679;39448.605513944494;40218;44378.55621443744;45403.54596453993;49472.75263623659;10539.473026348805;10764.730881728019;10830.048182216182;11155.888441115809;11343.773124537298;11497.82753258685;11556.47995840206;12103.576374826838;12787;12913.548025819051;10543.578256869947;10998.34009959373;11014.229003969966;11071.058959988492;11498.25261358009;11150.54333156724;11176.497057632589;11553.075753939833;11698.649040528799;11957.342346171044;8455.74632761018;10114.735658042744;10595.682129536126;10841.457927103771;10883.619073332395;8875.289976801969;8895.876905429352;9006;9456.952715236379;9507.619695212114;8441.87337189955;9275.350725449154;9613.51932403363;9649.083337082966;9768.951155244178 02:25:22 INFO - PROCESS | 20614 | __end_tp_report 02:25:22 INFO - PROCESS | 20614 | __start_cc_report 02:25:22 INFO - PROCESS | 20614 | _x_x_mozilla_cycle_collect,711 02:25:22 INFO - PROCESS | 20614 | __end_cc_report 02:25:22 INFO - PROCESS | 20614 | __startTimestamp1452853522265__endTimestamp 02:25:22 INFO - PROCESS | 20614 | 02:25:22 INFO - PROCESS | 20614 | ------- Summary: start ------- 02:25:22 INFO - PROCESS | 20614 | Number of tests: 6 02:25:22 INFO - PROCESS | 20614 | 02:25:22 INFO - PROCESS | 20614 | [#0] dojo.html Cycles:165 Average:5098.90 Median:5327.07 stddev:542.48 (10.2%) stddev-sans-first:520.71 02:25:22 INFO - PROCESS | 20614 | Values: 3088.6 3101.3 3139.7 3153.0 3165.1 4985.5 5043.4 5136.8 5144.2 5173.7 5013.5 5030.3 5072.4 5087.9 5090.1 4443.1 4597.0 4681.2 4759.8 4789.2 4568.0 4653.3 4757.6 4769.0 4866.1 4653.6 4676.7 4692.1 4703.8 4738.1 4655.4 4677.2 4683.0 4692.4 4731.2 4628.0 4635.0 4669.1 4687.2 4695.9 4912.4 4959.3 4972.4 4980.6 5020.3 5383.5 5394.6 5401.4 5438.9 5452.7 5328.8 5428.5 5430.2 5489.9 5539.5 5136.8 5152.2 5208.7 5210.9 5231.7 5532.8 5536.1 5537.1 5540.0 5594.1 5320.2 5363.1 5364.1 5372.2 5401.4 5441.2 5533.5 5568.8 5572.0 5618.1 5403.8 5422.6 5422.9 5425.4 5431.7 5386.4 5419.6 5440.6 5453.0 5467.7 4262.2 4297.2 4303.8 4324.8 4333.9 3841.3 3854.5 3855.1 3879.2 3882.9 5013.3 5079.7 5114.8 5173.1 5218.8 5388.1 5429.3 5438.0 5458.5 5503.0 5105.5 5123.8 5130.2 5139.4 5191.8 4680.3 4742.1 4751.6 4769.3 4782.6 5684.5 5696.8 5697.9 5699.5 5716.2 5505.6 5520.0 5525.4 5529.2 5533.9 5530.8 5641.3 5679.0 5736.8 5769.4 5398.5 5405.7 5406.1 5412.8 5413.7 5423.8 5472.3 5473.8 5494.4 5537.8 5271.6 5355.1 5404.4 5517.5 5564.3 5354.3 5356.3 5359.3 5362.1 5376.5 5177.9 5278.5 5279.7 5280.2 5327.1 5362.3 5379.4 5447.0 5509.3 5514.5 5297.7 5333.3 5351.8 5352.0 5362.6 02:25:22 INFO - PROCESS | 20614 | 02:25:22 INFO - PROCESS | 20614 | [#1] ext.html Cycles:180 Average:47538.82 Median:35159.15 stddev:86303.10 (245.5%) stddev-sans-first:86472.99 02:25:22 INFO - PROCESS | 20614 | Values: 515.7 527.7 530.9 532.5 551.6 28730.4 29343.9 38430.2 38743.2 38837.4 43059.6 43488.3 43576.0 43605.3 43649.8 8531.1 8725.7 8735.8 8736.2 8739.1 8452.4 8484.2 8487.9 8490.6 8498.1 8485.8 8563.4 8563.5 8564.4 8564.8 8442.9 8519.0 8520.1 8520.7 8523.2 8408.5 8574.9 8577.4 8580.1 8582.5 38949.0 39163.6 39425.2 39563.0 39564.8 3147.9 3167.9 3175.7 3289.7 3487.4 29305.9 29525.3 29765.0 30067.0 30257.1 3268.5 3279.8 3304.2 3308.6 3324.1 258968.0 259586.0 259810.0 260583.0 260682.7 50934.0 56075.0 56383.7 56388.0 56573.0 46247.5 46477.5 46490.5 46505.5 60627.4 14221.2 14334.4 14351.2 14446.1 14462.9 10624.1 10711.3 10719.3 10721.0 10725.0 17127.4 17606.7 17611.6 17614.0 19048.1 7183.5 7287.6 7467.8 7493.4 7511.1 934.8 948.6 981.8 1014.9 1054.7 25924.5 26381.3 26465.2 26603.6 28540.4 1009.3 1014.0 1051.8 1058.4 1103.4 14959.0 15581.7 15626.9 15721.7 15860.2 331689.0 339541.0 339675.0 339695.0 340731.0 45626.8 45933.1 45952.8 46036.5 46082.0 1211.5 1237.1 1242.2 1243.6 1334.5 24712.3 25547.0 25793.7 26031.6 26061.5 37867.4 38343.4 38437.0 38712.0 40750.2 188669.0 401779.0 408036.0 410128.0 411474.0 30041.7 30695.8 30757.2 30789.7 30798.4 40088.0 41384.6 41422.0 41739.8 42733.9 34488.8 34811.8 34845.5 35279.6 35740.5 35136.6 35426.8 35660.8 36037.0 36198.5 34780.0 35124.0 35181.6 35339.1 35524.0 29651.6 32221.4 32524.2 32528.8 32655.7 24336.3 32637.7 32689.7 32893.7 33478.7 02:25:22 INFO - PROCESS | 20614 | 02:25:22 INFO - PROCESS | 20614 | [#2] jquery.html Cycles:180 Average:24595.68 Median:253450.89 stddev:75497.05 (29.8%) stddev-sans-first:75686.90 02:25:22 INFO - PROCESS | 20614 | Values: 359.8 362.1 365.5 366.0 366.9 13715.7 13903.4 16163.5 17328.7 18266.9 15771.4 15990.8 16007.5 16041.1 16877.3 5357.7 5549.1 5549.1 5557.2 5561.8 4016.0 4125.6 5482.0 5796.4 6005.1 5682.1 5926.2 5972.0 5978.6 6055.4 5935.5 5968.8 5973.9 5981.4 6003.2 5142.4 5361.7 5361.7 5378.1 5378.9 19956.4 20033.3 20081.5 20142.6 20321.2 1999.5 2141.4 2195.1 2214.6 2220.2 12704.6 12824.2 12872.5 13051.3 13086.6 1795.3 1802.7 1817.9 1837.0 1866.6 53687.7 55405.7 55777.0 56233.0 57157.0 9161.8 9380.8 9713.5 9739.1 9787.2 12069.9 12070.2 12117.2 12124.2 12133.6 7027.0 7031.5 7195.1 7406.0 7445.9 7095.9 7114.1 7167.4 7167.9 7174.6 5375.5 5764.3 5859.0 5866.8 5964.1 1695.4 1714.0 1773.3 1783.8 1794.9 419.3 886.0 887.6 909.3 1073.1 9656.9 10207.6 10454.8 10631.8 15477.8 911.9 916.6 966.8 973.9 982.5 9259.8 9266.4 9292.9 9351.9 9461.8 365325.1 461731.0 466126.0 476711.0 529720.0 43906.1 44590.1 44628.6 52220.0 70160.9 1100.6 1148.5 1149.2 1154.7 1155.9 14459.2 14601.2 14682.6 14764.5 14883.1 30558.5 30637.0 32034.0 33173.3 33746.0 37897.4 44650.0 44972.6 45170.8 47895.8 9250.0 9750.5 9863.7 9917.0 10010.5 11134.5 11382.8 11469.2 11565.3 11849.1 9692.8 9879.3 10094.4 10101.3 10121.6 3108.7 8031.6 9813.7 10084.0 10087.7 7132.1 7287.1 7316.3 9571.7 9863.9 9612.3 9681.5 9684.0 9783.6 10099.8 3027.3 3034.3 6526.9 9099.4 9426.8 02:25:22 INFO - PROCESS | 20614 | 02:25:22 INFO - PROCESS | 20614 | [#3] mootools.html Cycles:180 Average:5470.89 Median:6502.56 stddev:2796.38 (43.0%) stddev-sans-first:2786.64 02:25:22 INFO - PROCESS | 20614 | Values: 1300.1 1447.4 1462.7 1640.2 1835.6 6885.4 7534.9 7697.8 7699.4 7710.6 7464.6 7624.5 7636.0 7638.2 7645.6 2014.9 2052.8 2272.2 2293.1 2316.0 2324.7 2339.1 2339.3 2341.5 2342.1 2223.9 2281.6 2283.8 2285.3 2287.6 2266.1 2295.4 2325.3 2331.1 2337.5 2274.0 2285.8 2294.3 2295.5 2345.9 7747.0 7808.8 7809.5 7810.3 7819.1 4756.0 4834.7 4848.9 4861.6 4877.7 3019.9 3053.7 3105.5 3150.0 3164.0 990.0 1012.9 1013.3 1055.9 1069.6 10499.4 10602.7 10622.7 10641.8 10642.7 4348.7 4417.4 4480.9 4513.6 4521.6 9113.3 9215.3 9215.6 9216.4 9227.8 4954.2 4957.9 4960.4 4961.4 4962.2 4532.9 4543.3 4546.1 4548.2 4551.0 3456.6 3532.7 3710.7 3752.2 3781.5 1197.2 1232.8 1243.3 1250.9 1260.0 955.0 977.7 979.2 1084.9 1351.3 7323.5 7345.3 7349.6 7367.6 7367.8 1186.3 1187.4 1200.2 1232.4 1253.4 5729.8 5804.5 5866.8 5868.7 5877.2 9003.4 9353.2 9365.5 9379.8 9382.3 9101.8 9152.5 9263.6 9266.1 9272.0 7210.3 7365.6 7376.7 7457.2 7474.3 6868.5 7125.2 7162.6 7179.6 7193.4 8327.1 8336.5 8508.4 8596.9 8683.5 8562.5 8796.2 8821.0 8955.9 8994.1 5856.1 6698.3 6804.3 6814.0 6818.2 6881.9 7135.0 7291.9 7292.7 7310.1 6751.0 6851.4 6887.4 6943.7 6975.7 6794.2 6800.5 7042.3 7078.8 7085.0 7022.8 7053.3 7062.3 7066.5 7112.5 6501.1 6553.8 6557.5 6557.9 6565.5 6465.1 6478.0 6500.8 6504.1 6507.5 02:25:22 INFO - PROCESS | 20614 | 02:25:22 INFO - PROCESS | 20614 | [#4] prototype.html Cycles:180 Average:5103.33 Median:5749.45 stddev:1511.96 (26.3%) stddev-sans-first:1473.03 02:25:22 INFO - PROCESS | 20614 | Values: 323.9 332.4 342.5 343.0 351.9 5639.9 5727.1 5733.2 5750.2 5774.2 5516.1 5632.7 5642.7 5645.7 5674.6 4487.6 4497.1 4497.5 4499.3 4510.7 4334.9 4406.2 4446.9 4516.5 4521.8 4438.2 4472.3 4476.1 4488.8 4491.1 4482.8 4483.5 4487.0 4495.1 4501.9 3998.4 4006.2 4006.7 4009.3 4012.6 5337.6 5489.1 5500.5 5502.2 5514.3 5129.5 5141.9 5145.9 5146.2 5147.8 5738.3 6069.8 6073.5 6075.7 6078.1 4173.7 4177.9 4290.2 4302.8 4304.4 6241.1 6290.8 6296.6 6303.3 6313.3 4405.2 4408.2 4409.4 4409.9 4410.4 4304.0 4466.9 4467.6 4469.8 4472.7 5107.5 5107.9 5108.4 5110.7 5119.2 6084.1 6091.6 6092.5 6096.1 6096.2 1525.3 1526.3 1527.6 1528.8 1532.8 1050.4 1062.8 1068.1 1077.4 1081.2 5745.1 5752.1 5758.2 5762.1 5764.1 6200.7 6203.5 6209.3 6219.2 6224.1 5748.7 5753.6 5760.9 5766.4 5766.5 3262.5 3364.5 3365.6 3370.8 3371.0 6494.2 6494.6 6498.3 6498.6 6503.1 6353.0 6363.6 6389.5 6407.0 6415.4 6348.7 6409.7 6463.8 6476.5 6476.7 6042.3 6162.6 6200.8 6219.2 6222.9 6108.2 6209.3 6217.5 6233.4 6238.1 6479.5 6519.3 6524.0 6526.9 6528.5 4266.5 4380.3 4388.2 4392.8 4396.2 6287.2 6290.9 6293.4 6296.8 6302.4 6089.6 6142.0 6143.8 6148.0 6150.0 5967.4 6101.2 6132.6 6134.4 6139.7 6006.0 6014.2 6021.5 6026.2 6029.4 6107.2 6137.5 6158.7 6161.9 6162.9 5904.0 5994.9 6002.3 6013.2 6020.5 02:25:22 INFO - PROCESS | 20614 | 02:25:22 INFO - PROCESS | 20614 | [#5] yui.html Cycles:180 Average:13452.42 Median:45753.54 stddev:15352.67 (33.6%) stddev-sans-first:15366.59 02:25:22 INFO - PROCESS | 20614 | Values: 853.9 856.7 856.7 871.3 883.3 12548.3 12845.3 12861.7 12864.9 12868.2 12764.0 12833.1 12840.7 12844.0 12869.4 812.0 813.8 814.0 814.2 815.5 661.8 814.6 817.8 819.6 819.8 705.1 839.3 853.6 857.4 858.2 835.5 848.3 848.8 851.1 852.4 511.9 516.2 631.6 631.9 633.1 13134.3 13377.5 13472.3 13518.2 13525.8 12445.8 12781.4 12828.7 13264.4 13310.7 9810.2 10100.1 10218.3 10269.2 10346.8 3313.9 3403.0 3419.8 3449.2 3492.3 45145.8 45369.5 45724.8 45782.3 46545.1 9502.1 9590.8 9603.3 9801.5 10078.1 19332.9 19444.0 19449.5 19484.0 19487.4 7844.7 7885.6 7979.9 8054.4 8157.4 4388.9 4405.3 4433.4 4476.6 4517.7 3122.3 3157.7 3166.7 3172.7 3174.6 565.1 581.2 584.3 612.8 615.4 511.8 570.4 611.1 677.0 731.6 8720.2 8757.2 8779.1 8881.5 9070.9 511.7 554.2 641.3 651.9 680.2 3936.0 4026.6 4221.9 4252.1 4364.9 55183.0 56109.0 56943.4 57013.0 57377.0 46978.8 47155.5 47258.0 48449.5 50921.0 44031.8 44686.3 44865.0 45200.0 45247.5 8086.4 8192.3 8194.9 8310.0 8385.0 32365.7 32579.0 33140.5 33216.8 33477.8 39448.6 40218.0 44378.6 45403.5 49472.8 10539.5 10764.7 10830.0 11155.9 11343.8 11497.8 11556.5 12103.6 12787.0 12913.5 10543.6 10998.3 11014.2 11071.1 11498.3 11150.5 11176.5 11553.1 11698.6 11957.3 8455.7 10114.7 10595.7 10841.5 10883.6 8875.3 8895.9 9006.0 9457.0 9507.6 8441.9 9275.4 9613.5 9649.1 9769.0 02:25:22 INFO - PROCESS | 20614 | -------- Summary: end -------- 02:25:22 INFO - PROCESS | 20614 | 02:25:22 INFO - TEST-INFO | 20614: exit 0 02:25:22 INFO - TEST-OK | dromaeo_css | took 1112546ms 02:25:22 INFO - TEST-START | kraken 02:25:22 INFO - operating with platform_type : linux_ 02:25:22 INFO - Initialising browser for kraken test... 02:25:22 INFO - TEST-INFO | started process 20805 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpO8zRcr/profile http://localhost:50202/getInfo.html) 02:25:26 INFO - PROCESS | 20805 | __metrics Screen width/height:1600/1200 02:25:26 INFO - PROCESS | 20805 | colorDepth:24 02:25:26 INFO - PROCESS | 20805 | Browser inner width/height: 1024/697 02:25:26 INFO - PROCESS | 20805 | __metrics 02:25:26 INFO - PROCESS | 20805 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:25:26 INFO - PROCESS | 20805 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:25:27 INFO - TEST-INFO | 20805: exit 0 02:25:27 INFO - Browser initialized. 02:25:27 INFO - Running cycle 1/1 for kraken test... 02:25:27 INFO - TEST-INFO | started process 20890 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpO8zRcr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:25:39 INFO - PROCESS | 20890 | RSS: Main: 149958656 02:25:39 INFO - PROCESS | 20890 | 02:25:41 INFO - PROCESS | 20890 | Cycle 1(1): loaded http://localhost:50202/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50202/tests/kraken/driver.html?testName=audio-beat-detection) 02:25:42 INFO - PROCESS | 20890 | RSS: Main: 187994112 02:25:42 INFO - PROCESS | 20890 | 02:25:45 INFO - PROCESS | 20890 | Cycle 1(1): loaded http://localhost:50202/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50202/tests/kraken/driver.html?testName=audio-dft) 02:25:45 INFO - PROCESS | 20890 | RSS: Main: 176865280 02:25:45 INFO - PROCESS | 20890 | 02:25:48 INFO - PROCESS | 20890 | Cycle 1(1): loaded http://localhost:50202/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50202/tests/kraken/driver.html?testName=audio-fft) 02:25:49 INFO - PROCESS | 20890 | RSS: Main: 162574336 02:25:49 INFO - PROCESS | 20890 | 02:25:51 INFO - PROCESS | 20890 | Cycle 1(1): loaded http://localhost:50202/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50202/tests/kraken/driver.html?testName=audio-oscillator) 02:25:51 INFO - PROCESS | 20890 | RSS: Main: 165404672 02:25:51 INFO - PROCESS | 20890 | 02:25:53 INFO - PROCESS | 20890 | Cycle 1(1): loaded http://localhost:50202/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50202/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:25:54 INFO - PROCESS | 20890 | RSS: Main: 164982784 02:25:54 INFO - PROCESS | 20890 | 02:25:57 INFO - PROCESS | 20890 | Cycle 1(1): loaded http://localhost:50202/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50202/tests/kraken/driver.html?testName=imaging-darkroom) 02:25:58 INFO - PROCESS | 20890 | RSS: Main: 166973440 02:25:58 INFO - PROCESS | 20890 | 02:26:01 INFO - PROCESS | 20890 | Cycle 1(1): loaded http://localhost:50202/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50202/tests/kraken/driver.html?testName=imaging-desaturate) 02:26:01 INFO - PROCESS | 20890 | RSS: Main: 167481344 02:26:01 INFO - PROCESS | 20890 | 02:26:04 INFO - PROCESS | 20890 | Cycle 1(1): loaded http://localhost:50202/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50202/tests/kraken/driver.html?testName=json-parse-financial) 02:26:05 INFO - PROCESS | 20890 | RSS: Main: 167583744 02:26:05 INFO - PROCESS | 20890 | 02:26:06 INFO - PROCESS | 20890 | Cycle 1(1): loaded http://localhost:50202/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50202/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:26:07 INFO - PROCESS | 20890 | RSS: Main: 175226880 02:26:07 INFO - PROCESS | 20890 | 02:26:09 INFO - PROCESS | 20890 | Cycle 1(1): loaded http://localhost:50202/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50202/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:26:09 INFO - PROCESS | 20890 | RSS: Main: 174895104 02:26:09 INFO - PROCESS | 20890 | 02:26:11 INFO - PROCESS | 20890 | Cycle 1(1): loaded http://localhost:50202/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50202/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:26:12 INFO - PROCESS | 20890 | RSS: Main: 183463936 02:26:12 INFO - PROCESS | 20890 | 02:26:14 INFO - PROCESS | 20890 | Cycle 1(1): loaded http://localhost:50202/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50202/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:26:15 INFO - PROCESS | 20890 | RSS: Main: 191098880 02:26:15 INFO - PROCESS | 20890 | 02:26:17 INFO - PROCESS | 20890 | Cycle 1(1): loaded http://localhost:50202/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50202/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:26:18 INFO - PROCESS | 20890 | RSS: Main: 187817984 02:26:18 INFO - PROCESS | 20890 | 02:26:19 INFO - PROCESS | 20890 | Cycle 1(1): loaded http://localhost:50202/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50202/tests/kraken/driver.html?testName=ai-astar) 02:26:20 INFO - PROCESS | 20890 | RSS: Main: 247300096 02:26:20 INFO - PROCESS | 20890 | 02:26:20 INFO - PROCESS | 20890 | __start_tp_report 02:26:20 INFO - PROCESS | 20890 | _x_x_mozilla_page_load 02:26:20 INFO - PROCESS | 20890 | _x_x_mozilla_page_load_details 02:26:20 INFO - PROCESS | 20890 | |i|pagename|runs| 02:26:20 INFO - PROCESS | 20890 | |0;ai-astar;109;110;106;110;111;110;98;111;110;110 02:26:20 INFO - PROCESS | 20890 | |1;audio-beat-detection;150;125;149;163;127;153;144;123;162;127 02:26:20 INFO - PROCESS | 20890 | |2;audio-dft;160;160;161;160;162;161;160;162;163;162 02:26:20 INFO - PROCESS | 20890 | |3;audio-fft;73;75;89;94;74;71;72;130;91;71 02:26:20 INFO - PROCESS | 20890 | |4;audio-oscillator;96;96;138;96;96;95;138;96;96;137 02:26:20 INFO - PROCESS | 20890 | |5;imaging-gaussian-blur;109;110;109;109;110;109;109;109;109;109 02:26:20 INFO - PROCESS | 20890 | |6;imaging-darkroom;146;145;145;146;145;145;146;146;145;145 02:26:20 INFO - PROCESS | 20890 | |7;imaging-desaturate;95;96;95;96;98;95;95;95;95;96 02:26:20 INFO - PROCESS | 20890 | |8;json-parse-financial;57;55;55;55;56;56;56;64;54;55 02:26:20 INFO - PROCESS | 20890 | |9;json-stringify-tinderbox;68;68;68;67;68;68;67;67;67;67 02:26:20 INFO - PROCESS | 20890 | |10;stanford-crypto-aes;81;83;81;83;83;83;83;83;82;82 02:26:20 INFO - PROCESS | 20890 | |11;stanford-crypto-ccm;121;115;118;116;111;117;116;111;114;123 02:26:20 INFO - PROCESS | 20890 | |12;stanford-crypto-pbkdf2;131;140;140;137;139;127;139;138;139;138 02:26:20 INFO - PROCESS | 20890 | |13;stanford-crypto-sha256-iterative;66;69;67;70;67;65;72;67;65;64 02:26:20 INFO - PROCESS | 20890 | __end_tp_report 02:26:20 INFO - PROCESS | 20890 | __start_cc_report 02:26:20 INFO - PROCESS | 20890 | _x_x_mozilla_cycle_collect,946 02:26:20 INFO - PROCESS | 20890 | __end_cc_report 02:26:20 INFO - PROCESS | 20890 | __startTimestamp1452853580242__endTimestamp 02:26:20 INFO - PROCESS | 20890 | 02:26:20 INFO - PROCESS | 20890 | ------- Summary: start ------- 02:26:20 INFO - PROCESS | 20890 | Number of tests: 14 02:26:20 INFO - PROCESS | 20890 | 02:26:20 INFO - PROCESS | 20890 | [#0] ai-astar Cycles:10 Average:108.50 Median:110.00 stddev:3.95 (3.6%) stddev-sans-first:4.19 02:26:20 INFO - PROCESS | 20890 | Values: 109.0 110.0 106.0 110.0 111.0 110.0 98.0 111.0 110.0 110.0 02:26:20 INFO - PROCESS | 20890 | 02:26:20 INFO - PROCESS | 20890 | [#1] audio-beat-detection Cycles:10 Average:142.30 Median:149.50 stddev:15.56 (10.4%) stddev-sans-first:16.25 02:26:20 INFO - PROCESS | 20890 | Values: 150.0 125.0 149.0 163.0 127.0 153.0 144.0 123.0 162.0 127.0 02:26:20 INFO - PROCESS | 20890 | 02:26:20 INFO - PROCESS | 20890 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.10 (0.7%) stddev-sans-first:1.09 02:26:20 INFO - PROCESS | 20890 | Values: 160.0 160.0 161.0 160.0 162.0 161.0 160.0 162.0 163.0 162.0 02:26:20 INFO - PROCESS | 20890 | 02:26:20 INFO - PROCESS | 20890 | [#3] audio-fft Cycles:10 Average:84.00 Median:74.50 stddev:18.48 (24.8%) stddev-sans-first:19.17 02:26:20 INFO - PROCESS | 20890 | Values: 73.0 75.0 89.0 94.0 74.0 71.0 72.0 130.0 91.0 71.0 02:26:20 INFO - PROCESS | 20890 | 02:26:20 INFO - PROCESS | 20890 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:96.00 stddev:20.20 (21.0%) stddev-sans-first:20.92 02:26:20 INFO - PROCESS | 20890 | Values: 96.0 96.0 138.0 96.0 96.0 95.0 138.0 96.0 96.0 137.0 02:26:20 INFO - PROCESS | 20890 | 02:26:20 INFO - PROCESS | 20890 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:26:20 INFO - PROCESS | 20890 | Values: 109.0 110.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 02:26:20 INFO - PROCESS | 20890 | 02:26:20 INFO - PROCESS | 20890 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 02:26:20 INFO - PROCESS | 20890 | Values: 146.0 145.0 145.0 146.0 145.0 145.0 146.0 146.0 145.0 145.0 02:26:20 INFO - PROCESS | 20890 | 02:26:20 INFO - PROCESS | 20890 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.50 stddev:0.97 (1.0%) stddev-sans-first:1.00 02:26:20 INFO - PROCESS | 20890 | Values: 95.0 96.0 95.0 96.0 98.0 95.0 95.0 95.0 95.0 96.0 02:26:20 INFO - PROCESS | 20890 | 02:26:20 INFO - PROCESS | 20890 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.00 stddev:2.83 (5.1%) stddev-sans-first:2.99 02:26:20 INFO - PROCESS | 20890 | Values: 57.0 55.0 55.0 55.0 56.0 56.0 56.0 64.0 54.0 55.0 02:26:20 INFO - PROCESS | 20890 | 02:26:20 INFO - PROCESS | 20890 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:68.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 02:26:20 INFO - PROCESS | 20890 | Values: 68.0 68.0 68.0 67.0 68.0 68.0 67.0 67.0 67.0 67.0 02:26:20 INFO - PROCESS | 20890 | 02:26:20 INFO - PROCESS | 20890 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:83.00 stddev:0.84 (1.0%) stddev-sans-first:0.73 02:26:20 INFO - PROCESS | 20890 | Values: 81.0 83.0 81.0 83.0 83.0 83.0 83.0 83.0 82.0 82.0 02:26:20 INFO - PROCESS | 20890 | 02:26:20 INFO - PROCESS | 20890 | [#11] stanford-crypto-ccm Cycles:10 Average:116.20 Median:116.50 stddev:3.85 (3.3%) stddev-sans-first:3.67 02:26:20 INFO - PROCESS | 20890 | Values: 121.0 115.0 118.0 116.0 111.0 117.0 116.0 111.0 114.0 123.0 02:26:20 INFO - PROCESS | 20890 | 02:26:20 INFO - PROCESS | 20890 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.80 Median:139.00 stddev:4.32 (3.1%) stddev-sans-first:4.03 02:26:20 INFO - PROCESS | 20890 | Values: 131.0 140.0 140.0 137.0 139.0 127.0 139.0 138.0 139.0 138.0 02:26:20 INFO - PROCESS | 20890 | 02:26:20 INFO - PROCESS | 20890 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:2.49 (3.7%) stddev-sans-first:2.60 02:26:20 INFO - PROCESS | 20890 | Values: 66.0 69.0 67.0 70.0 67.0 65.0 72.0 67.0 65.0 64.0 02:26:20 INFO - PROCESS | 20890 | -------- Summary: end -------- 02:26:20 INFO - PROCESS | 20890 | 02:26:21 INFO - TEST-INFO | 20890: exit 0 02:26:21 INFO - TEST-OK | kraken | took 58206ms 02:26:21 INFO - TEST-START | v8_7 02:26:21 INFO - operating with platform_type : linux_ 02:26:21 INFO - Initialising browser for v8_7 test... 02:26:21 INFO - TEST-INFO | started process 21138 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIeyICz/profile http://localhost:50202/getInfo.html) 02:26:24 INFO - PROCESS | 21138 | __metrics Screen width/height:1600/1200 02:26:24 INFO - PROCESS | 21138 | colorDepth:24 02:26:24 INFO - PROCESS | 21138 | Browser inner width/height: 1024/697 02:26:24 INFO - PROCESS | 21138 | __metrics 02:26:24 INFO - PROCESS | 21138 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:26:24 INFO - PROCESS | 21138 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:26:25 INFO - TEST-INFO | 21138: exit 0 02:26:25 INFO - Browser initialized. 02:26:25 INFO - Running cycle 1/1 for v8_7 test... 02:26:25 INFO - TEST-INFO | started process 21221 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIeyICz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:26:37 INFO - PROCESS | 21221 | RSS: Main: 149762048 02:26:37 INFO - PROCESS | 21221 | 02:27:00 INFO - PROCESS | 21221 | Cycle 1(1): loaded http://localhost:50202/tests/v8_7/run.html (next: http://localhost:50202/tests/v8_7/run.html) 02:27:00 INFO - PROCESS | 21221 | RSS: Main: 570183680 02:27:00 INFO - PROCESS | 21221 | 02:27:00 INFO - PROCESS | 21221 | __start_tp_report 02:27:00 INFO - PROCESS | 21221 | _x_x_mozilla_page_load 02:27:00 INFO - PROCESS | 21221 | _x_x_mozilla_page_load_details 02:27:00 INFO - PROCESS | 21221 | |i|pagename|runs| 02:27:00 INFO - PROCESS | 21221 | |0;Richards;166.05778811026238 02:27:00 INFO - PROCESS | 21221 | |1;DeltaBlue;188.89308651303364 02:27:00 INFO - PROCESS | 21221 | |2;Encrypt;279.56388034665923 02:27:00 INFO - PROCESS | 21221 | |3;Decrypt;5223.958333333333 02:27:00 INFO - PROCESS | 21221 | |4;RayTrace;1141.552511415525 02:27:00 INFO - PROCESS | 21221 | |5;Earley;783.6990595611285 02:27:00 INFO - PROCESS | 21221 | |6;Boyer;12219.512195121952 02:27:00 INFO - PROCESS | 21221 | |7;RegExp;42729.166666666664 02:27:00 INFO - PROCESS | 21221 | |8;Splay;587.4780573434757 02:27:00 INFO - PROCESS | 21221 | |9;NavierStokes;4830.917874396136 02:27:00 INFO - PROCESS | 21221 | __end_tp_report 02:27:00 INFO - PROCESS | 21221 | __startTimestamp1452853620324__endTimestamp 02:27:00 INFO - PROCESS | 21221 | 02:27:00 INFO - PROCESS | 21221 | ------- Summary: start ------- 02:27:00 INFO - PROCESS | 21221 | Number of tests: 10 02:27:00 INFO - PROCESS | 21221 | 02:27:00 INFO - PROCESS | 21221 | [#0] Richards Cycles:1 Average:166.06 Median:166.06 stddev:0.00 (0.0%) 02:27:00 INFO - PROCESS | 21221 | Values: 166.1 02:27:00 INFO - PROCESS | 21221 | 02:27:00 INFO - PROCESS | 21221 | [#1] DeltaBlue Cycles:1 Average:188.89 Median:188.89 stddev:0.00 (0.0%) 02:27:00 INFO - PROCESS | 21221 | Values: 188.9 02:27:00 INFO - PROCESS | 21221 | 02:27:00 INFO - PROCESS | 21221 | [#2] Encrypt Cycles:1 Average:279.56 Median:279.56 stddev:0.00 (0.0%) 02:27:00 INFO - PROCESS | 21221 | Values: 279.6 02:27:00 INFO - PROCESS | 21221 | 02:27:00 INFO - PROCESS | 21221 | [#3] Decrypt Cycles:1 Average:5223.96 Median:5223.96 stddev:0.00 (0.0%) 02:27:00 INFO - PROCESS | 21221 | Values: 5224.0 02:27:00 INFO - PROCESS | 21221 | 02:27:00 INFO - PROCESS | 21221 | [#4] RayTrace Cycles:1 Average:1141.55 Median:1141.55 stddev:0.00 (0.0%) 02:27:00 INFO - PROCESS | 21221 | Values: 1141.6 02:27:00 INFO - PROCESS | 21221 | 02:27:00 INFO - PROCESS | 21221 | [#5] Earley Cycles:1 Average:783.70 Median:783.70 stddev:0.00 (0.0%) 02:27:00 INFO - PROCESS | 21221 | Values: 783.7 02:27:00 INFO - PROCESS | 21221 | 02:27:00 INFO - PROCESS | 21221 | [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 02:27:00 INFO - PROCESS | 21221 | Values: 12219.5 02:27:00 INFO - PROCESS | 21221 | 02:27:00 INFO - PROCESS | 21221 | [#7] RegExp Cycles:1 Average:42729.17 Median:42729.17 stddev:0.00 (0.0%) 02:27:00 INFO - PROCESS | 21221 | Values: 42729.2 02:27:00 INFO - PROCESS | 21221 | 02:27:00 INFO - PROCESS | 21221 | [#8] Splay Cycles:1 Average:587.48 Median:587.48 stddev:0.00 (0.0%) 02:27:00 INFO - PROCESS | 21221 | Values: 587.5 02:27:00 INFO - PROCESS | 21221 | 02:27:00 INFO - PROCESS | 21221 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 02:27:00 INFO - PROCESS | 21221 | Values: 4830.9 02:27:00 INFO - PROCESS | 21221 | -------- Summary: end -------- 02:27:00 INFO - PROCESS | 21221 | 02:27:01 INFO - TEST-INFO | 21221: exit 0 02:27:01 INFO - TEST-OK | v8_7 | took 40091ms 02:27:01 INFO - SUITE-END | took 1210s 02:27:01 INFO - Completed test suite (00:20:10) 02:27:01 INFO - Working with test: dromaeo_css 02:27:01 INFO - Generating results file: dromaeo_css 02:27:01 INFO - Working with test: kraken 02:27:01 INFO - Generating results file: kraken 02:27:01 INFO - javascript benchmark 02:27:01 INFO - Working with test: v8_7 02:27:01 INFO - Generating results file: v8_7 02:27:01 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:27:01 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 02:27:01 INFO - process_Request line: dromaeo_css 6743.53 graph.html#tests=[[72,201,35]] 02:27:01 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:27:01 INFO - process_Request line: kraken 1480.90 graph.html#tests=[[232,201,35]] 02:27:01 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:27:01 INFO - process_Request line: v8_7 20035.33 graph.html#tests=[[230,201,35]] 02:27:01 INFO - RETURN: dromaeo_css: 6743.53 02:27:01 INFO - RETURN: kraken: 1480.90 02:27:01 INFO - RETURN: v8_7: 20035.33 02:27:01 INFO - javascript benchmark 02:27:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3088.567600535924, 3101.255698632328, 3139.654637989821, 3153.0068028571, 3165.1137681449195, 4985.476524964881, 5043.36957880265, 5136.845894623162, 5144.20264858947, 5173.715445650492, 5013.473585273548, 5030.346055012852, 5072.416672082712, 5087.898242035157, 5090.134677104892, 4443.133588950156, 4597.0, 4681.227597446417, 4759.762011899408, 4789.233722604384, 4567.954320456786, 4653.278741795028, 4757.571818536331, 4768.97615511922, 4866.148424025799, 4653.581177694007, 4676.719396836201, 4692.131955588227, 4703.835365762182, 4738.099761045425, 4655.4180727409075, 4677.228257337535, 4683.0, 4692.436907571079, 4731.195696731564, 4627.953720462786, 4634.95365046352, 4669.066186762661, 4687.226607609774, 4695.929561056587, 4912.410510738734, 4959.330490383824, 4972.353594032753, 4980.551750342486, 5020.2720605511995, 5383.542398896098, 5394.649347792381, 5401.43284955078, 5438.945610543883, 5452.727363631842, 5328.8401347959625, 5428.45715428458, 5430.185472179165, 5489.917651235235, 5539.501444869981, 5136.794528218867, 5152.175651895679, 5208.687478751249, 5210.921836172461, 5231.738413079331, 5532.75102620383, 5536.141898005815, 5537.1140617501815, 5540.030494663418, 5594.0769772987815, 5320.1753728171425, 5363.088274993261, 5364.088105022156, 5372.1941708744, 5401.432849550741, 5441.183822426668, 5533.529649979797, 5568.832935011957, 5571.972140139354, 5618.129189975561, 5403.83788486346, 5422.6475279106735, 5422.864428389322, 5425.430329815392, 5431.6740995540395, 5386.353637563439, 5419.647722897999, 5440.564754819605, 5453.0, 5467.726613669301, 4262.211490874198, 4297.247981603207, 4303.849365272201, 4324.805383757738, 4333.8699839004885, 3841.3277676407074, 3854.5181852268465, 3855.0747820523434, 3879.2241551689212, 3882.8835134946, 5013.323201367842, 5079.6952182869145, 5114.820981265638, 5173.120569503193, 5218.817341393033, 5388.0570900092325, 5429.321334833146, 5437.972810135924, 5458.5087342139395, 5503.036968530491, 5105.489451054865, 5123.846284611468, 5130.1535246684625, 5139.434662187156, 5191.8182863599595, 4680.3447517347595, 4742.1227072991605, 4751.572358487752, 4769.30845027476, 4782.569568738761, 5684.545236381162, 5696.800611978644, 5697.857553561194, 5699.4585514376895, 5716.171155182476, 5505.587080968863, 5519.972400137974, 5525.4474552544425, 5529.22590837275, 5533.916991245215, 5530.778768849362, 5641.26663533738, 5679.0, 5736.827895163152, 5769.394213607511, 5398.46015398457, 5405.702686352289, 5406.0809662356705, 5412.7564259607625, 5413.729313534386, 5423.83728488146, 5472.315960504937, 5473.753681084281, 5494.36814766307, 5537.750801214036, 5271.630985830955, 5355.062863998707, 5404.405515393225, 5517.475839795213, 5564.332280126248, 5354.250404943389, 5356.303680521507, 5359.3032905722, 5362.1420572708175, 5376.489233522809, 5177.922331165111, 5278.4721527846905, 5279.709615971158, 5280.234366016983, 5327.067763141512, 5362.276092727432, 5379.381371142369, 5447.0, 5509.283793106871, 5514.476124768141, 5297.682139071668, 5333.280007199133, 5351.839444816506, 5351.973240133774, 5362.570994320523], "unit": "score", "name": "dojo.html", "value": 5065.4646719655975}, {"lowerIsBetter": false, "replicates": [515.7498613172613, 527.6675694312582, 530.9389420216675, 532.5473347654492, 551.6221388348984, 28730.425391492183, 29343.853280733594, 38430.23139537207, 38743.225135497276, 38837.41743873844, 43059.56940430595, 43488.347674784905, 43576.0, 43605.345919811225, 43649.7817510912, 8531.104234055429, 8725.738227853175, 8735.825283494327, 8736.21374076333, 8739.126087391242, 8452.366072544553, 8484.151584841527, 8487.915120848806, 8490.575471226413, 8498.065212826585, 8485.787855303635, 8563.35774816888, 8563.529005904673, 8564.357673174536, 8564.785880352978, 8442.873356899652, 8519.0, 8520.147985201493, 8520.659173633108, 8523.232909038185, 8408.453450525696, 8574.871376929352, 8577.442466239736, 8580.056193818675, 8582.485050896967, 38949.0, 39163.60836391628, 39425.211495770214, 39563.0, 39564.80217598922, 3147.937041259162, 3167.9366412671616, 3175.6506784253716, 3289.654586268431, 3487.354839354702, 29305.85347073251, 29525.261868453246, 29765.0, 30067.0, 30257.09228723142, 3268.526063720771, 3279.7868138570916, 3304.2235074757414, 3308.586426696663, 3324.1024923270584, 258968.0, 259586.0, 259810.0, 260583.0, 260682.69658651776, 50934.0, 56075.0, 56383.71808140933, 56388.0, 56573.0, 46247.53143514183, 46477.535224647996, 46490.5350946493, 46505.5349446508, 60627.393726063056, 14221.217833019076, 14334.426622934965, 14351.210683412304, 14446.133232006114, 14462.855371446361, 10624.096951759188, 10711.25021248505, 10719.303245289188, 10721.035106840422, 10725.03474687282, 17127.400540981005, 17606.735898961524, 17611.647767044844, 17614.0, 19048.14283357252, 7183.5330703504105, 7287.599182045038, 7467.813304667427, 7493.3630641395, 7511.136219334847, 934.7756538430727, 948.6395169835419, 981.7938232971156, 1014.8731408573929, 1054.651964851597, 25924.481510369686, 26381.34046648849, 26465.206043818333, 26603.600945985825, 28540.429191416057, 1009.3237530854345, 1014.0, 1051.805415998043, 1058.439027315524, 1103.4041617526445, 14959.0, 15581.688366232613, 15626.921865390828, 15721.68556628884, 15860.20698965047, 331689.0, 339541.0, 339675.0, 339695.0, 340731.0, 45626.77186614046, 45933.08133837304, 45952.77023614861, 46036.5396346039, 46082.0, 1211.5335595795682, 1237.1216436330126, 1242.167747609104, 1243.608263397027, 1334.546254273571, 24712.25863224106, 25547.0, 25793.742062579884, 26031.609525857508, 26061.478770424863, 37867.431988520744, 38343.42484862785, 38437.0, 38712.0, 40750.1849963005, 188669.0, 401779.0, 408036.0, 410128.0, 411474.0, 30041.69958300389, 30695.846520767253, 30757.23106922345, 30789.692103078683, 30798.384032319675, 40088.0, 41384.58615413807, 41422.0, 41739.79130104451, 42733.93165170771, 34488.79289224865, 34811.825940870134, 34845.477317839745, 35279.64720352764, 35740.46389304214, 35136.64863351334, 35426.82286588551, 35660.79052885253, 36037.0, 36198.45702314415, 34780.0, 35124.0, 35181.648183517835, 35339.116522087155, 35524.0, 29651.555226671186, 32221.355572887944, 32524.186895327806, 32528.83735581307, 32655.673443265263, 24336.269911902673, 32637.673623264414, 32689.673103269615, 32893.67106329002, 33478.66521334756], "unit": "score", "name": "ext.html", "value": 17841.496508210956}, {"lowerIsBetter": false, "replicates": [359.76255671256973, 362.10018105009067, 365.5321188878237, 366.04279808301294, 366.8715949417704, 13715.65710857229, 13903.443862245498, 16163.515094547167, 17328.65342693147, 18266.90866545667, 15771.447999320026, 15990.76013859793, 16007.519774406786, 16041.117738524377, 16877.324907003705, 5357.705326207067, 5549.084401073818, 5549.112142057272, 5557.249771280865, 5561.805336813212, 4015.959840401588, 4125.608067233608, 5481.972590137064, 5796.391378905218, 6005.069214271773, 5682.147677848315, 5926.199963004982, 5972.0, 5978.581499295051, 6055.424734650223, 5935.52515798735, 5968.820935371946, 5973.8805223895715, 5981.371955944606, 6003.189569408118, 5142.357205349332, 5361.678299302015, 5361.705106219157, 5378.139497680352, 5378.865528361783, 19956.401307960783, 20033.298834540867, 20081.497962550908, 20142.597148056957, 20321.18715251388, 1999.5001249687577, 2141.379000089972, 2195.067096483988, 2214.568159208955, 2220.222921977311, 12704.618861434172, 12824.166429182167, 12872.485100595964, 13051.282179480124, 13086.607401777961, 1795.3177792438921, 1802.6845302072086, 1817.872748907577, 1837.0, 1866.6266746650724, 53687.731561342334, 55405.72297138489, 55777.0, 56233.0, 57157.0, 9161.77095572616, 9380.827396575429, 9713.465759383302, 9739.123478886933, 9787.168090712226, 12069.939650301692, 12070.215435996632, 12117.212381195193, 12124.211926224943, 12133.575324863587, 7026.9648651756415, 7031.507794454441, 7195.100612423447, 7406.0, 7445.85108297831, 7095.929040709527, 7114.110736157981, 7167.390771784457, 7167.92832071683, 7174.569525828467, 5375.5162035416215, 5764.308283006066, 5859.0, 5866.823995280149, 5964.075568286922, 1695.3557648093893, 1713.9742903856452, 1773.2995466790546, 1783.777027871516, 1794.8564114870778, 419.3248869320392, 885.964561417549, 887.6405055952349, 909.2862103248918, 1073.1254027967182, 9656.855147172799, 10207.591696332063, 10454.790904181873, 10631.84052239217, 15477.767833482507, 911.8541033434751, 916.5875356089653, 966.8018056298442, 973.9318247722733, 982.4792859784326, 9259.814803703888, 9266.44401335922, 9292.860607090899, 9351.859722104175, 9461.810763784686, 365325.1362023324, 461731.0, 466126.0, 476711.0, 529720.0, 43906.12187756227, 44590.10819783586, 44628.55371446309, 52220.0, 70160.94758578626, 1100.6202860013282, 1148.471703016605, 1149.230015889356, 1154.7113221694576, 1155.9075273978062, 14459.204743739196, 14601.196934168724, 14682.55952321432, 14764.48324308644, 14883.10701357922, 30558.541621876135, 30637.0, 32034.0, 33173.336533269685, 33746.0, 37897.4315385275, 44650.0, 44972.55027449683, 45170.77414612906, 47895.76052119717, 9249.953750231205, 9750.512474376395, 9863.654772082942, 9917.0, 10010.499475026365, 11134.498947547218, 11382.829257560978, 11469.19715619932, 11565.306081635128, 11849.111316651113, 9692.806143876942, 9879.259055571005, 10094.394336339843, 10101.292909496558, 10121.59513619447, 3108.7202151806446, 8031.55826429552, 9813.675153854138, 10084.0, 10087.7478063049, 7132.072830531998, 7287.052683151156, 7316.268373162641, 9571.712848614274, 9863.852042219516, 9612.327137100336, 9681.51592420362, 9684.0, 9783.559739811868, 10099.848502272618, 3027.2885871820545, 3034.30211051455, 6526.869462610816, 9099.3611852562, 9426.811463770824], "unit": "score", "name": "jquery.html", "value": 8024.877998877582}, {"lowerIsBetter": false, "replicates": [1300.0574583427021, 1447.413797412048, 1462.7074585082987, 1640.2126979050056, 1835.605344850857, 6885.380315771579, 7534.924650753498, 7697.769066927987, 7699.384049276058, 7710.57591832449, 7464.589447580381, 7624.466287359887, 7635.961820190905, 7638.236176382373, 7645.61771911405, 2014.879107253562, 2052.8152466278034, 2272.1933713531707, 2293.117149897293, 2316.0041182291607, 2324.7210334759766, 2339.1345202275184, 2339.333290012347, 2341.531693661266, 2342.074880422232, 2223.8888055597154, 2281.6235321171985, 2283.7602051784575, 2285.2572913802996, 2287.645414960684, 2266.093562574975, 2295.4376177836452, 2325.337278875529, 2331.0908745589236, 2337.5091230841545, 2273.977260227393, 2285.7599952005135, 2294.2543673306077, 2295.517941232343, 2345.906163753448, 7746.961265193694, 7808.843823123506, 7809.453338266324, 7810.336121429686, 7819.139894611645, 4756.0, 4834.661573689843, 4848.927266091011, 4861.586765124968, 4877.731724755137, 3019.9396012079637, 3053.740432063255, 3105.45654510462, 3149.9527507087414, 3163.984180079108, 989.9554520046543, 1012.8531362952405, 1013.3008224325192, 1055.8732952045805, 1069.6416700405373, 10499.370037797757, 10602.681919542427, 10622.681319560348, 10641.78716425675, 10642.733931651694, 4348.717333373321, 4417.359482875029, 4480.865574032719, 4513.571210734975, 4521.59305662492, 9113.3165012623, 9215.262778977665, 9215.631374744935, 9216.400933939407, 9227.76930576741, 4954.157793175169, 4957.851264462072, 4960.379952505937, 4961.4294356148785, 4962.181240095344, 4532.9093418132115, 4543.250363689954, 4546.0680560485025, 4548.249538826123, 4550.954490455053, 3456.6197718250974, 3532.717382609385, 3710.703143748494, 3752.1932784451474, 3781.5084039075296, 1197.2098415046028, 1232.7657745028416, 1243.322389297835, 1250.881166289201, 1259.9685007874693, 954.9618015279311, 977.6627063663025, 979.1823827104305, 1084.8915108489089, 1351.2568087551808, 7323.487355885037, 7345.265473452719, 7349.595772232472, 7367.631618419057, 7367.81580460482, 1186.306010983567, 1187.441902305915, 1200.1778781534676, 1232.4146030635377, 1253.4108968784656, 5729.828105156852, 5804.477597016289, 5866.7653293868625, 5868.706564671749, 5877.206577112121, 9003.369764116449, 9353.204977576846, 9365.531723413802, 9379.812403751886, 9382.296327775444, 9101.81796364069, 9152.496612686366, 9263.629454821867, 9266.073392660815, 9272.0, 7210.315020073084, 7365.631718414058, 7376.7049318026675, 7457.216992215847, 7474.289942455567, 6868.484863635347, 7125.216226215216, 7162.641867906688, 7179.569225846466, 7193.388561972291, 8327.125651806715, 8336.541490218096, 8508.446950948168, 8596.871046934177, 8683.522406267715, 8562.48625082472, 8796.164364385373, 8820.955895220482, 8955.910440895768, 8994.145556172152, 5856.092305692625, 6698.2631910488835, 6804.319568043156, 6814.0, 6818.18181818185, 6881.862362752817, 7134.964325178341, 7291.927080729125, 7292.671829767567, 7310.086239220098, 6751.0, 6851.38337549603, 6887.449004079762, 6943.6875340608785, 6975.686094125675, 6794.218664853605, 6800.455963523005, 7042.330978557029, 7078.823029424306, 7085.0435191248525, 7022.754203602849, 7053.294670532906, 7062.258462861531, 7066.470014748812, 7112.466565007749, 6501.05734668461, 6553.836154096186, 6557.475401967927, 6557.901631475627, 6565.474762018932, 6465.062565928009, 6477.963525835844, 6500.837479063061, 6504.056911747675, 6507.544471887112], "unit": "score", "name": "mootools.html", "value": 4514.210544709013}, {"lowerIsBetter": false, "replicates": [323.88663967611336, 332.42822345565634, 342.4725922079997, 342.9759916805823, 351.91554027033504, 5639.8590035249135, 5727.11229759388, 5733.168690539869, 5750.223719797826, 5774.249347584813, 5516.14499752538, 5632.746526406311, 5642.661440313574, 5645.661260324373, 5674.574406919487, 4487.596116349528, 4497.10057988402, 4497.527759585229, 4499.302608095751, 4510.661700372477, 4334.913301733964, 4406.162829062468, 4446.933296000562, 4516.4806047304655, 4521.773911304438, 4438.201123797715, 4472.329150627399, 4476.082403107355, 4488.798004089824, 4491.056878055612, 4482.843100491484, 4483.484399294074, 4487.0, 4495.145922274757, 4501.909961800779, 3998.420229066798, 4006.198760247962, 4006.6794656427705, 4009.3184158693093, 4012.598740125993, 5337.5996800239745, 5489.1217405214975, 5500.50495455407, 5502.202180683778, 5514.310711161105, 5129.487051294878, 5141.897162056738, 5145.897082058338, 5146.176611742141, 5147.794088236466, 5738.282714660668, 6069.817905462844, 6073.453389194994, 6075.665838378887, 6078.057901025348, 4173.686973476971, 4177.8537751178565, 4290.163418133465, 4302.806373713191, 4304.418903448026, 6241.126242326078, 6290.811275661737, 6296.559240853142, 6303.338149494329, 6313.273973493061, 4405.185040767468, 4408.184485870124, 4409.36064270679, 4409.889752756207, 4410.360497727812, 4304.0, 4466.905608125965, 4467.642588592969, 4469.776511174493, 4472.664550158686, 5107.514786095315, 5107.948920510822, 5108.361454818148, 5110.744462776846, 5119.155339368963, 6084.117802918552, 6091.604045737013, 6092.51259899207, 6096.055111457731, 6096.207493025879, 1525.3288553036627, 1526.3055309833999, 1527.557008467532, 1528.808898887639, 1532.762421824619, 1050.3907733514695, 1062.7768168684663, 1068.108129711684, 1077.380506208933, 1081.1512962324537, 5745.052066408995, 5752.137179423036, 5758.193852860602, 5762.1068734346245, 5764.07774756037, 6200.720967556471, 6203.47270482005, 6209.316975132731, 6219.191505104308, 6224.128621992924, 5748.6838223898085, 5753.59724819267, 5760.913586296209, 5766.394528574523, 5766.538676905838, 3262.510623406508, 3364.4616861302075, 3365.5793025871767, 3370.764046516769, 3371.005553361764, 6494.220693516808, 6494.6103233806125, 6498.317676643885, 6498.610083395011, 6503.122078519339, 6353.0, 6363.649999249993, 6389.456896163785, 6406.967965160145, 6415.390537898986, 6348.682565871688, 6409.711562979677, 6463.7737679181, 6476.481881449473, 6476.676166191672, 6042.274927008787, 6162.599431036968, 6200.844978875564, 6219.191505104308, 6222.906656400248, 6108.236470441195, 6209.348018457997, 6217.502599792097, 6233.407826256498, 6238.126662267377, 6479.4816414685765, 6519.250286216956, 6523.967380163069, 6526.902096468461, 6528.477721782151, 4266.5093514246255, 4380.321050237091, 4388.188185185623, 4392.780360982002, 4396.164728701537, 6287.245530536365, 6290.874182516415, 6293.37066293367, 6296.779612713533, 6302.432781049728, 6089.5737298388685, 6141.969290153521, 6143.815685529441, 6148.016317389196, 6150.04674275488, 5967.403259673998, 6101.206843110367, 6132.63204207749, 6134.4172303631085, 6139.693015349126, 6005.969970150121, 6014.248218972629, 6021.458068773832, 6026.15633811258, 6029.3669164737075, 6107.175531303395, 6137.478314343331, 6158.661273629993, 6161.876762464815, 6162.876742465215, 5903.970480147572, 5994.88010239784, 6002.309734380602, 6013.218281623361, 6020.488258498077], "unit": "score", "name": "prototype.html", "value": 4616.70019071042}, {"lowerIsBetter": false, "replicates": [853.906070332263, 856.7215654912154, 856.7258477287266, 871.2942516561585, 883.3330835219413, 12548.309842958644, 12845.293508857008, 12861.678458038554, 12864.871351286485, 12868.163569367984, 12764.042696797731, 12833.101682882201, 12840.74318513629, 12844.0, 12869.4208760606, 811.9971834784037, 813.8290958898639, 814.0434988888062, 814.1898810683379, 815.5269943432795, 661.7551505942783, 814.6130587970696, 817.791463176889, 819.6311659753105, 819.8114433680257, 705.0833915909323, 839.2991851803721, 853.6116067189414, 857.4126723194631, 858.159004175908, 835.5488036460304, 848.325581162977, 848.7878030492377, 851.1360968616859, 852.4246133859651, 511.9334486516766, 516.1844286028066, 631.5705320382139, 631.9210098737658, 633.1420924647083, 13134.277614731185, 13377.53178638743, 13472.25902575358, 13518.188908665512, 13525.797113043312, 12445.751084978341, 12781.424835882408, 12828.743425131539, 13264.40310186044, 13310.733785324335, 9810.166135878459, 10100.090991810772, 10218.335808172445, 10269.229807764374, 10346.844797328045, 3313.9171520711934, 3403.0, 3419.760616756828, 3449.1549570355173, 3492.301539692072, 45145.774271128765, 45369.54630453686, 45724.771376142904, 45782.31326530105, 46545.06909861784, 9502.097300756417, 9590.808183836285, 9603.327767056378, 9801.509924503745, 10078.14335781452, 19332.90333548323, 19444.0, 19449.51376215606, 19484.02579871001, 19487.415377538695, 7844.725434609762, 7885.645145968445, 7979.880301795478, 8054.3556515479795, 8157.428979971345, 4388.868333949987, 4405.31717583775, 4433.401490798766, 4476.574725401082, 4517.728936263835, 3122.328699329655, 3157.747380209578, 3166.7149956503563, 3172.6510083890753, 3174.6349169845303, 565.0817421689754, 581.1718301420459, 584.260909948915, 612.7732738886551, 615.3538784276582, 511.81574633132044, 570.3697414357158, 611.1482208907019, 677.0264678462228, 731.5939653492363, 8720.215180633773, 8757.21185093332, 8779.12208779117, 8881.467111973303, 9070.86393704095, 511.71088335090553, 554.1687468796805, 641.2657507154282, 651.8859199640044, 680.2007641021779, 3936.0, 4026.565803972967, 4221.9125953226285, 4252.064545799919, 4364.890877728082, 55183.0, 56109.0, 56943.43056569464, 57013.0, 57377.0, 46978.76510617425, 47155.5284447158, 47258.0, 48449.51550484521, 50921.0, 44031.779841100586, 44686.32970505445, 44865.0, 45200.0, 45247.547524524336, 8086.353091752763, 8192.303654189222, 8194.918050819415, 8309.95845020771, 8385.0, 32365.676343236268, 32579.02262932116, 33140.502892457116, 33216.83391583027, 33477.83261083679, 39448.605513944494, 40218.0, 44378.55621443744, 45403.54596453993, 49472.75263623659, 10539.473026348805, 10764.730881728019, 10830.048182216182, 11155.888441115809, 11343.773124537298, 11497.82753258685, 11556.47995840206, 12103.576374826838, 12787.0, 12913.548025819051, 10543.578256869947, 10998.34009959373, 11014.229003969966, 11071.058959988492, 11498.25261358009, 11150.54333156724, 11176.497057632589, 11553.075753939833, 11698.649040528799, 11957.342346171044, 8455.74632761018, 10114.735658042744, 10595.682129536126, 10841.457927103771, 10883.619073332395, 8875.289976801969, 8895.876905429352, 9006.0, 9456.952715236379, 9507.619695212114, 8441.87337189955, 9275.350725449154, 9613.51932403363, 9649.083337082966, 9768.951155244178], "unit": "score", "name": "yui.html", "value": 6221.324869336672}], "name": "dromaeo_css", "value": 6743.528625642271}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 106.0, 110.0, 111.0, 110.0, 98.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.5}, {"lowerIsBetter": true, "replicates": [150.0, 125.0, 149.0, 163.0, 127.0, 153.0, 144.0, 123.0, 162.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 142.3}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 161.0, 160.0, 162.0, 161.0, 160.0, 162.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 89.0, 94.0, 74.0, 71.0, 72.0, 130.0, 91.0, 71.0], "unit": "score", "name": "audio-fft", "value": 84.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 138.0, 96.0, 96.0, 95.0, 138.0, 96.0, 96.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 108.4}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 98.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 55.0, 55.0, 56.0, 56.0, 56.0, 64.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.3}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 67.0, 68.0, 68.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 81.0, 83.0, 83.0, 83.0, 83.0, 83.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [121.0, 115.0, 118.0, 116.0, 111.0, 117.0, 116.0, 111.0, 114.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.2}, {"lowerIsBetter": true, "replicates": [131.0, 140.0, 140.0, 137.0, 139.0, 127.0, 139.0, 138.0, 139.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.8}, {"lowerIsBetter": true, "replicates": [66.0, 69.0, 67.0, 70.0, 67.0, 65.0, 72.0, 67.0, 65.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1480.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.05778811026238], "unit": "score", "name": "Richards", "value": 212.58864400000002}, {"lowerIsBetter": false, "replicates": [188.89308651303364], "unit": "score", "name": "DeltaBlue", "value": 350.02869200000004}, {"lowerIsBetter": false, "replicates": [279.56388034665923], "unit": "score", "name": "Encrypt", "value": 952.1294369999999}, {"lowerIsBetter": false, "replicates": [5223.958333333333], "unit": "score", "name": "Decrypt", "value": 50.95389032901295}, {"lowerIsBetter": false, "replicates": [1141.552511415525], "unit": "score", "name": "RayTrace", "value": 648.2303639999998}, {"lowerIsBetter": false, "replicates": [783.6990595611285], "unit": "score", "name": "Earley", "value": 850.4067880000003}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [42729.166666666664], "unit": "score", "name": "RegExp", "value": 21.319980497318397}, {"lowerIsBetter": false, "replicates": [587.4780573434757], "unit": "score", "name": "Splay", "value": 138.71326593625494}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20035.325895401522}]} 02:27:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20035.33"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1480.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6743.53"}}} 02:27:01 INFO - Return code: 0 02:27:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:27:01 INFO - # TBPL SUCCESS # 02:27:01 INFO - Running post-action listener: _resource_record_post_action 02:27:01 INFO - Running post-run listener: _resource_record_post_run 02:27:02 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 40960; Write bytes: 543440896; Read time: 44; Write time: 505124 02:27:02 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 239403008; Read time: 0; Write time: 251148 02:27:02 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 40960; Write bytes: 304037888; Read time: 44; Write time: 253976 02:27:02 INFO - Running post-run listener: _upload_blobber_files 02:27:02 INFO - Blob upload gear active. 02:27:02 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:27:02 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 02:27:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 02:27:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 02:27:03 INFO - (blobuploader) - INFO - Open directory for files ... 02:27:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 02:27:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:27:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:04 INFO - (blobuploader) - INFO - Done attempting. 02:27:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:27:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:27:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:04 INFO - (blobuploader) - INFO - Done attempting. 02:27:04 INFO - (blobuploader) - INFO - Iteration through files over. 02:27:04 INFO - Return code: 0 02:27:04 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:27:04 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:27:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/427fbc20b4aad79e55deea5ced349a13a880ed8f76095466e8328c5480f924fdc5c4fbf421c2475be1d29908fca00231bac408a454760dcccb532a50f4e8442b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/6caf3a9efa23e34ca255ee49cb6dd2d583d1e50614f18242a9b575df3003dad1fd48997b0fd70e93f051f2b5ee8f6421b110fdb07f56be606cd19f54c3a47800"} 02:27:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:27:04 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:27:04 INFO - Contents: 02:27:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/427fbc20b4aad79e55deea5ced349a13a880ed8f76095466e8328c5480f924fdc5c4fbf421c2475be1d29908fca00231bac408a454760dcccb532a50f4e8442b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/6caf3a9efa23e34ca255ee49cb6dd2d583d1e50614f18242a9b575df3003dad1fd48997b0fd70e93f051f2b5ee8f6421b110fdb07f56be606cd19f54c3a47800"} 02:27:04 INFO - Copying logs to upload dir... 02:27:04 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1272.620953 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-15 02:27:04.995913) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 02:27:04.999711) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1452852203.449501-145351206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/427fbc20b4aad79e55deea5ced349a13a880ed8f76095466e8328c5480f924fdc5c4fbf421c2475be1d29908fca00231bac408a454760dcccb532a50f4e8442b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/6caf3a9efa23e34ca255ee49cb6dd2d583d1e50614f18242a9b575df3003dad1fd48997b0fd70e93f051f2b5ee8f6421b110fdb07f56be606cd19f54c3a47800"} build_url:https://queue.taskcluster.net/v1/task/HTFYYCzKTEOtseNi6f8Jsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011381 build_url: 'https://queue.taskcluster.net/v1/task/HTFYYCzKTEOtseNi6f8Jsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/427fbc20b4aad79e55deea5ced349a13a880ed8f76095466e8328c5480f924fdc5c4fbf421c2475be1d29908fca00231bac408a454760dcccb532a50f4e8442b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/6caf3a9efa23e34ca255ee49cb6dd2d583d1e50614f18242a9b575df3003dad1fd48997b0fd70e93f051f2b5ee8f6421b110fdb07f56be606cd19f54c3a47800"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 02:27:05.025152) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 02:27:05.025481) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c719f637fb0c43bc4e5671e000001d0-1452852203.449501-145351206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 02:27:05.111121) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 02:27:05.111435) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 02:27:05.111739) ========= ========= Total master_lag: 0.18 =========