builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-056 starttime: 1450788329.26 results: success (0) buildid: 20151222023004 builduid: aba6f30109bc471da4bea6a9419807e4 revision: 63f78eaa94e88c96ba58068ab69dd7fd4d8b9cac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.262417) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.262949) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.263280) ========= 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=0ae9de487587ba4b94dd3100000001b5-1450786282.479835-1387323542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006347 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.303732) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.304100) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.349263) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.349589) ========= 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=0ae9de487587ba4b94dd3100000001b5-1450786282.479835-1387323542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.025412 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.410742) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.411080) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.411532) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.411848) ========= 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=0ae9de487587ba4b94dd3100000001b5-1450786282.479835-1387323542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-22 04:45:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 44.1M=0s 2015-12-22 04:45:29 (44.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098981 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.531071) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.531442) ========= 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=0ae9de487587ba4b94dd3100000001b5-1450786282.479835-1387323542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.088674 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.635161) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:29.635555) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 63f78eaa94e88c96ba58068ab69dd7fd4d8b9cac --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/fx-team --rev 63f78eaa94e88c96ba58068ab69dd7fd4d8b9cac --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=0ae9de487587ba4b94dd3100000001b5-1450786282.479835-1387323542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-22 04:45:29,935 truncating revision to first 12 chars 2015-12-22 04:45:29,935 Setting DEBUG logging. 2015-12-22 04:45:29,935 attempt 1/10 2015-12-22 04:45:29,936 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/63f78eaa94e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-22 04:45:30,192 unpacking tar archive at: fx-team-63f78eaa94e8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.555047 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:30.204100) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:30.204705) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:30.219541) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:30.219832) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 04:45:30.220249) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-22 04:45:30.220622) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=0ae9de487587ba4b94dd3100000001b5-1450786282.479835-1387323542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:45:30 INFO - MultiFileLogger online at 20151222 04:45:30 in /builds/slave/test-pgo 04:45:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:45:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:45:30 INFO - {'append_to_log': False, 04:45:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:45:30 INFO - 'blob_upload_branch': 'Fx-Team', 04:45:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:45:30 INFO - 'branch': 'Fx-Team', 04:45:30 INFO - 'buildbot_json_path': 'buildprops.json', 04:45:30 INFO - 'config_files': ('talos/linux_config.py',), 04:45:30 INFO - 'default_actions': ('clobber', 04:45:30 INFO - 'read-buildbot-config', 04:45:30 INFO - 'download-and-extract', 04:45:30 INFO - 'populate-webroot', 04:45:30 INFO - 'create-virtualenv', 04:45:30 INFO - 'install', 04:45:30 INFO - 'run-tests'), 04:45:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:45:30 INFO - 'download_minidump_stackwalk': True, 04:45:30 INFO - 'download_symbols': 'ondemand', 04:45:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:45:30 INFO - 'tooltool.py': '/tools/tooltool.py', 04:45:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:45:30 INFO - '/tools/misc-python/virtualenv.py')}, 04:45:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:45:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:45:30 INFO - 'installer_path': 'installer.exe', 04:45:30 INFO - 'log_level': 'info', 04:45:30 INFO - 'log_name': 'talos', 04:45:30 INFO - 'log_to_console': True, 04:45:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:45:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:45:30 INFO - 'opt_config_files': (), 04:45:30 INFO - 'pip_index': False, 04:45:30 INFO - 'sps_profile': False, 04:45:30 INFO - 'sps_profile_interval': 0, 04:45:30 INFO - 'suite': 'dromaeojs-e10s', 04:45:30 INFO - 'system_bits': '64', 04:45:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:45:30 INFO - 'title': 'talos-linux64-ix-056', 04:45:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:45:30 INFO - 'use_talos_json': True, 04:45:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:45:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:45:30 INFO - 'work_dir': 'build'} 04:45:30 INFO - ##### 04:45:30 INFO - ##### Running clobber step. 04:45:30 INFO - ##### 04:45:30 INFO - Running pre-action listener: _resource_record_pre_action 04:45:30 INFO - Running main action method: clobber 04:45:30 INFO - rmtree: /builds/slave/test-pgo/build 04:45:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:45:31 INFO - Running post-action listener: _resource_record_post_action 04:45:31 INFO - ##### 04:45:31 INFO - ##### Running read-buildbot-config step. 04:45:31 INFO - ##### 04:45:31 INFO - Running pre-action listener: _resource_record_pre_action 04:45:31 INFO - Running main action method: read_buildbot_config 04:45:31 INFO - Using buildbot properties: 04:45:31 INFO - { 04:45:31 INFO - "project": "", 04:45:31 INFO - "product": "firefox", 04:45:31 INFO - "script_repo_revision": "production", 04:45:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:45:31 INFO - "repository": "", 04:45:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 04:45:31 INFO - "buildid": "20151222023004", 04:45:31 INFO - "pgo_build": "True", 04:45:31 INFO - "basedir": "/builds/slave/test-pgo", 04:45:31 INFO - "buildnumber": 153, 04:45:31 INFO - "slavename": "talos-linux64-ix-056", 04:45:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:45:31 INFO - "platform": "ubuntu64_hw", 04:45:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:45:31 INFO - "branch": "fx-team", 04:45:31 INFO - "repo_path": "integration/fx-team", 04:45:31 INFO - "revision": "63f78eaa94e88c96ba58068ab69dd7fd4d8b9cac", 04:45:31 INFO - "stage_platform": "linux64-pgo", 04:45:31 INFO - "builduid": "aba6f30109bc471da4bea6a9419807e4", 04:45:31 INFO - "slavebuilddir": "test" 04:45:31 INFO - } 04:45:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:45:31 INFO - Running post-action listener: _resource_record_post_action 04:45:31 INFO - ##### 04:45:31 INFO - ##### Running download-and-extract step. 04:45:31 INFO - ##### 04:45:31 INFO - Running pre-action listener: _resource_record_pre_action 04:45:31 INFO - Running main action method: download_and_extract 04:45:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:31 INFO - https://queue.taskcluster.net/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:45:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/test_packages.json 04:45:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/test_packages.json 04:45:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:45:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:45:36 INFO - Downloaded 1302 bytes. 04:45:36 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:45:36 INFO - Using the following test package requirements: 04:45:36 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:45:36 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:45:36 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:36 INFO - u'jsshell-linux-x86_64.zip'], 04:45:36 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:45:36 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:45:36 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:45:36 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:45:36 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:45:36 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:45:36 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:45:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:45:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:45:36 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')]} 04:45:36 INFO - https://queue.taskcluster.net/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:45:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:45:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:45:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/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 04:45:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/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 04:45:37 INFO - Downloaded 23175542 bytes. 04:45:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:45:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:45:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:45:39 INFO - Return code: 0 04:45:39 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 04:45:39 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')]} 04:45:39 INFO - https://queue.taskcluster.net/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:45:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:45:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:45:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/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 04:45:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/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 04:45:40 INFO - Downloaded 23175542 bytes. 04:45:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:45:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:45:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:45:42 INFO - Return code: 0 04:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:42 INFO - https://queue.taskcluster.net/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:45:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:45:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:45:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/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 04:45:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/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 04:45:43 INFO - Downloaded 11132277 bytes. 04:45:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 04:45:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:45:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:45:43 INFO - Return code: 0 04:45:43 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')]} 04:45:43 INFO - https://queue.taskcluster.net/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:45:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:45:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:45:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/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 04:45:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/baDmyByETJyFend27IV-Og/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 04:45:46 INFO - Downloaded 54887089 bytes. 04:45:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:45:46 INFO - mkdir: /builds/slave/test-pgo/properties 04:45:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:45:46 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:45:46 INFO - Contents: 04:45:46 INFO - build_url:https://queue.taskcluster.net/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:45:46 INFO - Running post-action listener: _resource_record_post_action 04:45:46 INFO - Running post-action listener: set_extra_try_arguments 04:45:46 INFO - ##### 04:45:46 INFO - ##### Running populate-webroot step. 04:45:46 INFO - ##### 04:45:46 INFO - Running pre-action listener: _resource_record_pre_action 04:45:46 INFO - Running main action method: populate_webroot 04:45:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:45:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:45:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:45:46 INFO - '--tppagecycles', 04:45:46 INFO - '7'], 04:45:46 INFO - 'tests': ['tsvgm']}}, 04:45:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:45:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:45:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:45:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:45:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:45:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:45:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:45:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:46 INFO - 'talos_options': ['--e10s'], 04:45:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:45:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:46 INFO - 'tests': ['damp', 'tps']}, 04:45:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:46 INFO - 'talos_options': ['--e10s'], 04:45:46 INFO - 'tests': ['damp', 'tps']}, 04:45:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:45:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:45:46 INFO - 'other': {'tests': ['a11yr', 04:45:46 INFO - 'ts_paint', 04:45:46 INFO - 'tpaint', 04:45:46 INFO - 'sessionrestore', 04:45:46 INFO - 'sessionrestore_no_auto_restore']}, 04:45:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:45:46 INFO - 'tests': ['a11yr', 04:45:46 INFO - 'ts_paint', 04:45:46 INFO - 'tpaint', 04:45:46 INFO - 'sessionrestore', 04:45:46 INFO - 'sessionrestore_no_auto_restore']}, 04:45:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:45:46 INFO - 'tests': ['a11yr', 04:45:46 INFO - 'ts_paint', 04:45:46 INFO - 'tpaint', 04:45:46 INFO - 'sessionrestore', 04:45:46 INFO - 'sessionrestore_no_auto_restore']}, 04:45:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:45:46 INFO - 'tests': ['a11yr', 04:45:46 INFO - 'ts_paint', 04:45:46 INFO - 'tpaint', 04:45:46 INFO - 'sessionrestore', 04:45:46 INFO - 'sessionrestore_no_auto_restore']}, 04:45:46 INFO - 'other_l64': {'tests': ['a11yr', 04:45:46 INFO - 'ts_paint', 04:45:46 INFO - 'tpaint', 04:45:46 INFO - 'sessionrestore', 04:45:46 INFO - 'sessionrestore_no_auto_restore']}, 04:45:46 INFO - 'other_nol64': {'tests': ['a11yr', 04:45:46 INFO - 'ts_paint', 04:45:46 INFO - 'tpaint', 04:45:46 INFO - 'sessionrestore', 04:45:46 INFO - 'sessionrestore_no_auto_restore']}, 04:45:46 INFO - 'svgr': {'tests': ['tsvgx', 04:45:46 INFO - 'tsvgr_opacity', 04:45:46 INFO - 'tart', 04:45:46 INFO - 'tscrollx', 04:45:46 INFO - 'cart']}, 04:45:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:45:46 INFO - 'tests': ['tsvgx', 04:45:46 INFO - 'tsvgr_opacity', 04:45:46 INFO - 'tart', 04:45:46 INFO - 'tscrollx', 04:45:46 INFO - 'cart']}, 04:45:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:46 INFO - 'tests': ['tp5o']}, 04:45:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:46 INFO - 'talos_options': ['--e10s'], 04:45:46 INFO - 'tests': ['tp5o']}, 04:45:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:46 INFO - 'talos_options': ['--xperf_path', 04:45:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:45:46 INFO - 'tests': ['tp5n']}, 04:45:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:46 INFO - 'talos_options': ['--e10s', 04:45:46 INFO - '--xperf_path', 04:45:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:45:46 INFO - 'tests': ['tp5n']}}, 04:45:46 INFO - 'talos.zip': {'path': '', 04:45:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:45:46 INFO - Running post-action listener: _resource_record_post_action 04:45:46 INFO - ##### 04:45:46 INFO - ##### Running create-virtualenv step. 04:45:46 INFO - ##### 04:45:46 INFO - Running pre-action listener: _resource_record_pre_action 04:45:46 INFO - Running main action method: create_virtualenv 04:45:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:45:46 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 04:45:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:45:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:45:46 INFO - Using real prefix '/usr' 04:45:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:45:47 INFO - Installing distribute.............................................................................................................................................................................................done. 04:45:49 INFO - Installing pip.................done. 04:45:49 INFO - Return code: 0 04:45:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:45: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')]} 04:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f59baa6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a36630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac7840>, '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 0x1a346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a34b60>, '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': '0ae9de487587ba4b94dd3100000001b5-1450786282.479835-1387323542', '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 04:45:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 04:45:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:45:49 INFO - Using env: {'DISPLAY': ':0', 04:45:49 INFO - 'HOME': '/home/cltbld', 04:45:49 INFO - 'LANG': 'en_US.UTF-8', 04:45:49 INFO - 'LANGUAGE': 'en_US:en', 04:45:49 INFO - 'LOGNAME': 'cltbld', 04:45:49 INFO - 'MAIL': '/var/mail/cltbld', 04:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:49 INFO - 'MOZ_NO_REMOTE': '1', 04:45:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:49 INFO - 'NO_EM_RESTART': '1', 04:45:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:45:49 INFO - 'PWD': '/builds/slave/test-pgo', 04:45:49 INFO - 'SHELL': '/bin/bash', 04:45:49 INFO - 'SHLVL': '1', 04:45:49 INFO - 'TERM': 'linux', 04:45:49 INFO - 'TMOUT': '86400', 04:45:49 INFO - 'USER': 'cltbld', 04:45:49 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450786282.479835-1387323542', 04:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:49 INFO - '_': '/tools/buildbot/bin/python'} 04:45:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:49 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 04:45:49 INFO - Cleaning up... 04:45:49 INFO - Return code: 0 04:45:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:45: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')]} 04:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f59baa6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a36630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac7840>, '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 0x1a346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a34b60>, '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': '0ae9de487587ba4b94dd3100000001b5-1450786282.479835-1387323542', '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 04:45:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 04:45:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:45:49 INFO - Using env: {'DISPLAY': ':0', 04:45:49 INFO - 'HOME': '/home/cltbld', 04:45:49 INFO - 'LANG': 'en_US.UTF-8', 04:45:49 INFO - 'LANGUAGE': 'en_US:en', 04:45:49 INFO - 'LOGNAME': 'cltbld', 04:45:49 INFO - 'MAIL': '/var/mail/cltbld', 04:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:49 INFO - 'MOZ_NO_REMOTE': '1', 04:45:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:49 INFO - 'NO_EM_RESTART': '1', 04:45:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:45:49 INFO - 'PWD': '/builds/slave/test-pgo', 04:45:49 INFO - 'SHELL': '/bin/bash', 04:45:49 INFO - 'SHLVL': '1', 04:45:49 INFO - 'TERM': 'linux', 04:45:49 INFO - 'TMOUT': '86400', 04:45:49 INFO - 'USER': 'cltbld', 04:45:49 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450786282.479835-1387323542', 04:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:49 INFO - '_': '/tools/buildbot/bin/python'} 04:45:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:49 INFO - Downloading/unpacking psutil>=0.7.1 04:45:49 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 04:45:49 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 04:45:49 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 04:45:49 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 04:45:49 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 04:45:49 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 04:45:51 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:45:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:45:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:45:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:45:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:45:51 INFO - Installing collected packages: psutil 04:45:51 INFO - Running setup.py install for psutil 04:45:51 INFO - building 'psutil._psutil_linux' extension 04:45:51 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 04:45:51 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 04:45:51 INFO - building 'psutil._psutil_posix' extension 04:45:51 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 04:45:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:45:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:45:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:45:52 INFO - Successfully installed psutil 04:45:52 INFO - Cleaning up... 04:45:52 INFO - Return code: 0 04:45:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f59baa6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a36630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac7840>, '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 0x1a346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a34b60>, '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': '0ae9de487587ba4b94dd3100000001b5-1450786282.479835-1387323542', '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 04:45:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 04:45:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:45:52 INFO - Using env: {'DISPLAY': ':0', 04:45:52 INFO - 'HOME': '/home/cltbld', 04:45:52 INFO - 'LANG': 'en_US.UTF-8', 04:45:52 INFO - 'LANGUAGE': 'en_US:en', 04:45:52 INFO - 'LOGNAME': 'cltbld', 04:45:52 INFO - 'MAIL': '/var/mail/cltbld', 04:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:52 INFO - 'MOZ_NO_REMOTE': '1', 04:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:52 INFO - 'NO_EM_RESTART': '1', 04:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:45:52 INFO - 'PWD': '/builds/slave/test-pgo', 04:45:52 INFO - 'SHELL': '/bin/bash', 04:45:52 INFO - 'SHLVL': '1', 04:45:52 INFO - 'TERM': 'linux', 04:45:52 INFO - 'TMOUT': '86400', 04:45:52 INFO - 'USER': 'cltbld', 04:45:52 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450786282.479835-1387323542', 04:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:52 INFO - '_': '/tools/buildbot/bin/python'} 04:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:45:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:45:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:45:54 INFO - Installing collected packages: mozsystemmonitor 04:45:54 INFO - Running setup.py install for mozsystemmonitor 04:45:54 INFO - Successfully installed mozsystemmonitor 04:45:54 INFO - Cleaning up... 04:45:54 INFO - Return code: 0 04:45:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:54 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 0x7f59baa6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a36630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac7840>, '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 0x1a346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a34b60>, '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': '0ae9de487587ba4b94dd3100000001b5-1450786282.479835-1387323542', '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 04:45:54 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 04:45:54 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 04:45:54 INFO - Using env: {'DISPLAY': ':0', 04:45:54 INFO - 'HOME': '/home/cltbld', 04:45:54 INFO - 'LANG': 'en_US.UTF-8', 04:45:54 INFO - 'LANGUAGE': 'en_US:en', 04:45:54 INFO - 'LOGNAME': 'cltbld', 04:45:54 INFO - 'MAIL': '/var/mail/cltbld', 04:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:54 INFO - 'MOZ_NO_REMOTE': '1', 04:45:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:54 INFO - 'NO_EM_RESTART': '1', 04:45:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:45:54 INFO - 'PWD': '/builds/slave/test-pgo', 04:45:54 INFO - 'SHELL': '/bin/bash', 04:45:54 INFO - 'SHLVL': '1', 04:45:54 INFO - 'TERM': 'linux', 04:45:54 INFO - 'TMOUT': '86400', 04:45:54 INFO - 'USER': 'cltbld', 04:45:54 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450786282.479835-1387323542', 04:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:54 INFO - '_': '/tools/buildbot/bin/python'} 04:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:54 INFO - Downloading/unpacking blobuploader==1.2.4 04:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:56 INFO - Downloading blobuploader-1.2.4.tar.gz 04:45:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:45:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:45:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:45:56 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 04:45:56 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 04:45:56 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 04:45:56 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 04:45:56 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 04:45:56 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 04:45:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:45:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:45:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:45:56 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 04:45:56 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 04:45:56 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 04:45:56 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 04:45:56 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 04:45:56 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 04:45:56 INFO - Downloading docopt-0.6.1.tar.gz 04:45:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:45:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:45:56 INFO - Installing collected packages: blobuploader, requests, docopt 04:45:56 INFO - Running setup.py install for blobuploader 04:45:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:45:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:45:57 INFO - Running setup.py install for requests 04:45:57 INFO - Running setup.py install for docopt 04:45:57 INFO - Successfully installed blobuploader requests docopt 04:45:57 INFO - Cleaning up... 04:45:57 INFO - Return code: 0 04:45:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:45:57 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')]} 04:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:57 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')]} 04:45:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:57 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 0x7f59baa6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a36630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac7840>, '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 0x1a346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a34b60>, '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': '0ae9de487587ba4b94dd3100000001b5-1450786282.479835-1387323542', '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 04:45:57 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 04:45:57 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 04:45:57 INFO - Using env: {'DISPLAY': ':0', 04:45:57 INFO - 'HOME': '/home/cltbld', 04:45:57 INFO - 'LANG': 'en_US.UTF-8', 04:45:57 INFO - 'LANGUAGE': 'en_US:en', 04:45:57 INFO - 'LOGNAME': 'cltbld', 04:45:57 INFO - 'MAIL': '/var/mail/cltbld', 04:45:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:57 INFO - 'MOZ_NO_REMOTE': '1', 04:45:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:57 INFO - 'NO_EM_RESTART': '1', 04:45:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:45:57 INFO - 'PWD': '/builds/slave/test-pgo', 04:45:57 INFO - 'SHELL': '/bin/bash', 04:45:57 INFO - 'SHLVL': '1', 04:45:57 INFO - 'TERM': 'linux', 04:45:57 INFO - 'TMOUT': '86400', 04:45:57 INFO - 'USER': 'cltbld', 04:45:57 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450786282.479835-1387323542', 04:45:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:57 INFO - '_': '/tools/buildbot/bin/python'} 04:45:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:45:57 INFO - Running setup.py (path:/tmp/pip-run6Al-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:45:57 INFO - Running setup.py (path:/tmp/pip-u3VuLO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:45:57 INFO - Running setup.py (path:/tmp/pip-GTx4Uv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:45:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:45:58 INFO - Running setup.py (path:/tmp/pip-7MI3I1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:45:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:45:58 INFO - Running setup.py (path:/tmp/pip-DTskNL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:45:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:45:58 INFO - Running setup.py (path:/tmp/pip-atmnze-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:45:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:45:58 INFO - Running setup.py (path:/tmp/pip-LdnYny-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:45:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:45:58 INFO - Running setup.py (path:/tmp/pip-2bW0HY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:45:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:45:58 INFO - Running setup.py (path:/tmp/pip-S6dUlf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:45:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:45:58 INFO - Running setup.py (path:/tmp/pip-KSmzCc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:45:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:45:58 INFO - Running setup.py (path:/tmp/pip-BYCYCC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:45:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:45:58 INFO - Running setup.py (path:/tmp/pip-mA5uiW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:45:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:45:58 INFO - Running setup.py (path:/tmp/pip-_bTDbj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:45:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:45:58 INFO - Running setup.py (path:/tmp/pip-kUZewA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:45:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:45:58 INFO - Running setup.py (path:/tmp/pip-CGB_2Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:45:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:45:58 INFO - Running setup.py (path:/tmp/pip-MPIo0N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:45:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:45:58 INFO - Running setup.py (path:/tmp/pip-I9o2Zp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:45:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:45:59 INFO - Running setup.py install for manifestparser 04:45:59 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:45:59 INFO - Running setup.py install for mozcrash 04:45:59 INFO - Running setup.py install for mozdebug 04:45:59 INFO - Running setup.py install for mozdevice 04:45:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:45:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:45:59 INFO - Running setup.py install for mozfile 04:45:59 INFO - Running setup.py install for mozhttpd 04:45:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:45:59 INFO - Running setup.py install for mozinfo 04:45:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:45:59 INFO - Running setup.py install for mozInstall 04:45:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:45:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:45:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:45:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:45:59 INFO - Running setup.py install for mozleak 04:45:59 INFO - Running setup.py install for mozlog 04:46:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:46:00 INFO - Running setup.py install for moznetwork 04:46:00 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:46:00 INFO - Running setup.py install for mozprocess 04:46:00 INFO - Running setup.py install for mozprofile 04:46:00 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:46:00 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:46:00 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:46:00 INFO - Running setup.py install for mozrunner 04:46:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:46:00 INFO - Running setup.py install for mozscreenshot 04:46:00 INFO - Running setup.py install for moztest 04:46:00 INFO - Running setup.py install for mozversion 04:46:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:46:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:46:00 INFO - Cleaning up... 04:46:00 INFO - Return code: 0 04:46:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:46:00 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')]} 04:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:00 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')]} 04:46:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:00 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 0x7f59baa6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a36630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac7840>, '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 0x1a346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a34b60>, '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': '0ae9de487587ba4b94dd3100000001b5-1450786282.479835-1387323542', '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 04:46:00 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 04:46:00 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 04:46:00 INFO - Using env: {'DISPLAY': ':0', 04:46:00 INFO - 'HOME': '/home/cltbld', 04:46:00 INFO - 'LANG': 'en_US.UTF-8', 04:46:00 INFO - 'LANGUAGE': 'en_US:en', 04:46:00 INFO - 'LOGNAME': 'cltbld', 04:46:00 INFO - 'MAIL': '/var/mail/cltbld', 04:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:00 INFO - 'MOZ_NO_REMOTE': '1', 04:46:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:00 INFO - 'NO_EM_RESTART': '1', 04:46:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:46:00 INFO - 'PWD': '/builds/slave/test-pgo', 04:46:00 INFO - 'SHELL': '/bin/bash', 04:46:00 INFO - 'SHLVL': '1', 04:46:00 INFO - 'TERM': 'linux', 04:46:00 INFO - 'TMOUT': '86400', 04:46:00 INFO - 'USER': 'cltbld', 04:46:00 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450786282.479835-1387323542', 04:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:00 INFO - '_': '/tools/buildbot/bin/python'} 04:46:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:46:01 INFO - Running setup.py (path:/tmp/pip-yN5tCz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 04:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:46:01 INFO - Running setup.py (path:/tmp/pip-F5I714-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:46:01 INFO - Running setup.py (path:/tmp/pip-aCDCWX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:46:01 INFO - Running setup.py (path:/tmp/pip-9CMbn5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:46:01 INFO - Running setup.py (path:/tmp/pip-uhnacE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:46:01 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)) 04:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:46:01 INFO - Running setup.py (path:/tmp/pip-QIarmD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:46:01 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)) 04:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:46:01 INFO - Running setup.py (path:/tmp/pip-b_Qmzs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:46:01 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)) 04:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:46:01 INFO - Running setup.py (path:/tmp/pip-oj9kWa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:46:01 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)) 04:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:46:01 INFO - Running setup.py (path:/tmp/pip-byBReN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:46:01 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)) 04:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:46:01 INFO - Running setup.py (path:/tmp/pip-TOsFus-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:46:01 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)) 04:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:46:01 INFO - Running setup.py (path:/tmp/pip-03iTDF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:46:01 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)) 04:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:46:01 INFO - Running setup.py (path:/tmp/pip-RaC0X3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:46:01 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)) 04:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:46:01 INFO - Running setup.py (path:/tmp/pip-WqNTy4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:46:01 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)) 04:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:46:01 INFO - Running setup.py (path:/tmp/pip-AHDrtV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 04:46:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:46:02 INFO - Running setup.py (path:/tmp/pip-PbdO2g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 04:46:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:46:02 INFO - Running setup.py (path:/tmp/pip-8mkf4C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 04:46:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:46:02 INFO - Running setup.py (path:/tmp/pip-jyQDsE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 04:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:46:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:46:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:03 INFO - Downloading blessings-1.5.1.tar.gz 04:46:03 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 04:46:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:46:04 INFO - Installing collected packages: blessings 04:46:04 INFO - Running setup.py install for blessings 04:46:04 INFO - Successfully installed blessings 04:46:04 INFO - Cleaning up... 04:46:04 INFO - Return code: 0 04:46:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:46:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:46:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:46:04 INFO - Reading from file tmpfile_stdout 04:46:04 INFO - Current package versions: 04:46:04 INFO - argparse == 1.2.1 04:46:04 INFO - blessings == 1.5.1 04:46:04 INFO - blobuploader == 1.2.4 04:46:04 INFO - docopt == 0.6.1 04:46:04 INFO - manifestparser == 1.1 04:46:04 INFO - mozInstall == 1.12 04:46:04 INFO - mozcrash == 0.16 04:46:04 INFO - mozdebug == 0.1 04:46:04 INFO - mozdevice == 0.47 04:46:04 INFO - mozfile == 1.2 04:46:04 INFO - mozhttpd == 0.7 04:46:04 INFO - mozinfo == 0.9 04:46:04 INFO - mozleak == 0.1 04:46:04 INFO - mozlog == 3.1 04:46:04 INFO - moznetwork == 0.27 04:46:04 INFO - mozprocess == 0.22 04:46:04 INFO - mozprofile == 0.28 04:46:04 INFO - mozrunner == 6.11 04:46:04 INFO - mozscreenshot == 0.1 04:46:04 INFO - mozsystemmonitor == 0.0 04:46:04 INFO - moztest == 0.7 04:46:04 INFO - mozversion == 1.4 04:46:04 INFO - psutil == 3.1.1 04:46:04 INFO - requests == 1.2.3 04:46:04 INFO - wsgiref == 0.1.2 04:46:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:46:04 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')]} 04:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:04 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')]} 04:46:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:04 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 0x7f59baa6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a36630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac7840>, '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 0x1a346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a34b60>, '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': '0ae9de487587ba4b94dd3100000001b5-1450786282.479835-1387323542', '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 04:46:04 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 04:46:04 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 04:46:04 INFO - Using env: {'DISPLAY': ':0', 04:46:04 INFO - 'HOME': '/home/cltbld', 04:46:04 INFO - 'LANG': 'en_US.UTF-8', 04:46:04 INFO - 'LANGUAGE': 'en_US:en', 04:46:04 INFO - 'LOGNAME': 'cltbld', 04:46:04 INFO - 'MAIL': '/var/mail/cltbld', 04:46:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:04 INFO - 'MOZ_NO_REMOTE': '1', 04:46:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:04 INFO - 'NO_EM_RESTART': '1', 04:46:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:46:04 INFO - 'PWD': '/builds/slave/test-pgo', 04:46:04 INFO - 'SHELL': '/bin/bash', 04:46:04 INFO - 'SHLVL': '1', 04:46:04 INFO - 'TERM': 'linux', 04:46:04 INFO - 'TMOUT': '86400', 04:46:04 INFO - 'USER': 'cltbld', 04:46:04 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450786282.479835-1387323542', 04:46:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:04 INFO - '_': '/tools/buildbot/bin/python'} 04:46:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:04 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)) 04:46:04 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)) 04:46:04 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)) 04:46:04 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)) 04:46:04 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)) 04:46:04 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)) 04:46:04 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)) 04:46:04 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)) 04:46:04 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)) 04:46:04 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)) 04:46:04 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)) 04:46:04 INFO - Cleaning up... 04:46:04 INFO - Return code: 0 04:46:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:46:04 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')]} 04:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:04 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')]} 04:46:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:04 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 0x7f59baa6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a36630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac7840>, '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 0x1a346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a34b60>, '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': '0ae9de487587ba4b94dd3100000001b5-1450786282.479835-1387323542', '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 04:46:04 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 04:46:04 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 04:46:04 INFO - Using env: {'DISPLAY': ':0', 04:46:04 INFO - 'HOME': '/home/cltbld', 04:46:04 INFO - 'LANG': 'en_US.UTF-8', 04:46:04 INFO - 'LANGUAGE': 'en_US:en', 04:46:04 INFO - 'LOGNAME': 'cltbld', 04:46:04 INFO - 'MAIL': '/var/mail/cltbld', 04:46:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:04 INFO - 'MOZ_NO_REMOTE': '1', 04:46:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:04 INFO - 'NO_EM_RESTART': '1', 04:46:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:46:04 INFO - 'PWD': '/builds/slave/test-pgo', 04:46:04 INFO - 'SHELL': '/bin/bash', 04:46:04 INFO - 'SHLVL': '1', 04:46:04 INFO - 'TERM': 'linux', 04:46:04 INFO - 'TMOUT': '86400', 04:46:04 INFO - 'USER': 'cltbld', 04:46:04 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450786282.479835-1387323542', 04:46:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:04 INFO - '_': '/tools/buildbot/bin/python'} 04:46:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:04 INFO - Downloading/unpacking jsonschema 04:46:04 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 04:46:04 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 04:46:04 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 04:46:04 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 04:46:04 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 04:46:04 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 04:46:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:46:06 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 04:46:06 INFO - Downloading/unpacking functools32 (from jsonschema) 04:46:06 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 04:46:06 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 04:46:06 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 04:46:06 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 04:46:06 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 04:46:06 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 04:46:06 INFO - Downloading functools32-3.2.3-2.tar.gz 04:46:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:46:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:46:06 INFO - warning: no files found matching '*.txt' 04:46:06 INFO - no previously-included directories found matching 'build' 04:46:06 INFO - no previously-included directories found matching 'dist' 04:46:06 INFO - no previously-included directories found matching '.git*' 04:46:06 INFO - Installing collected packages: jsonschema, functools32 04:46:06 INFO - Running setup.py install for functools32 04:46:06 INFO - warning: no files found matching '*.txt' 04:46:06 INFO - no previously-included directories found matching 'build' 04:46:06 INFO - no previously-included directories found matching 'dist' 04:46:06 INFO - no previously-included directories found matching '.git*' 04:46:06 INFO - Successfully installed jsonschema functools32 04:46:06 INFO - Cleaning up... 04:46:07 INFO - Return code: 0 04:46:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:46:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f59baa6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a36630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac7840>, '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 0x1a346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a34b60>, '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': '0ae9de487587ba4b94dd3100000001b5-1450786282.479835-1387323542', '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 04:46:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 04:46:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:46:07 INFO - Using env: {'DISPLAY': ':0', 04:46:07 INFO - 'HOME': '/home/cltbld', 04:46:07 INFO - 'LANG': 'en_US.UTF-8', 04:46:07 INFO - 'LANGUAGE': 'en_US:en', 04:46:07 INFO - 'LOGNAME': 'cltbld', 04:46:07 INFO - 'MAIL': '/var/mail/cltbld', 04:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:07 INFO - 'MOZ_NO_REMOTE': '1', 04:46:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:07 INFO - 'NO_EM_RESTART': '1', 04:46:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:46:07 INFO - 'PWD': '/builds/slave/test-pgo', 04:46:07 INFO - 'SHELL': '/bin/bash', 04:46:07 INFO - 'SHLVL': '1', 04:46:07 INFO - 'TERM': 'linux', 04:46:07 INFO - 'TMOUT': '86400', 04:46:07 INFO - 'USER': 'cltbld', 04:46:07 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450786282.479835-1387323542', 04:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:07 INFO - '_': '/tools/buildbot/bin/python'} 04:46:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:07 INFO - Downloading/unpacking flake8 04:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:46:08 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 04:46:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:46:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:46:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:09 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 04:46:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:46:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:46:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:46:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:46:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:46:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:46:09 INFO - no previously-included directories found matching 'docs/_build' 04:46:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:46:09 INFO - Running setup.py install for pep8 04:46:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:46:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:46:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:46:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:46:09 INFO - no previously-included directories found matching 'docs/_build' 04:46:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:46:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:46:09 INFO - Cleaning up... 04:46:09 INFO - Return code: 0 04:46:09 INFO - Running post-action listener: _resource_record_post_action 04:46:09 INFO - Running post-action listener: _start_resource_monitoring 04:46:09 INFO - Starting resource monitoring. 04:46:09 INFO - ##### 04:46:09 INFO - ##### Running install step. 04:46:09 INFO - ##### 04:46:09 INFO - Running pre-action listener: _resource_record_pre_action 04:46:09 INFO - Running main action method: install 04:46:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:46:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:46:10 INFO - Reading from file tmpfile_stdout 04:46:10 INFO - Detecting whether we're running mozinstall >=1.0... 04:46:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:46:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:46:10 INFO - Reading from file tmpfile_stdout 04:46:10 INFO - Output received: 04:46:10 INFO - Usage: mozinstall [options] installer 04:46:10 INFO - Options: 04:46:10 INFO - -h, --help show this help message and exit 04:46:10 INFO - -d DEST, --destination=DEST 04:46:10 INFO - Directory to install application into. [default: 04:46:10 INFO - "/builds/slave/test-pgo"] 04:46:10 INFO - --app=APP Application being installed. [default: firefox] 04:46:10 INFO - mkdir: /builds/slave/test-pgo/build/application 04:46:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 04:46:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 04:46:25 INFO - Reading from file tmpfile_stdout 04:46:25 INFO - Output received: 04:46:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:46:25 INFO - Running post-action listener: _resource_record_post_action 04:46:25 INFO - ##### 04:46:25 INFO - ##### Running run-tests step. 04:46:25 INFO - ##### 04:46:25 INFO - Running pre-action listener: _resource_record_pre_action 04:46:25 INFO - Running main action method: run_tests 04:46:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:46:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:46:25 INFO - Python 2.7.3 04:46:25 INFO - Return code: 0 04:46:25 INFO - grabbing minidump binary from tooltool 04:46:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac7840>, '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 0x1a346b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a34b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:46:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 04:46:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:46:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:46:26 INFO - Return code: 0 04:46:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:46:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:46:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:46:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:46:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:46:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:46:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:46:26 INFO - Return code: 0 04:46:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 04:46:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:46:26 INFO - Using env: {'DISPLAY': ':0', 04:46:26 INFO - 'HOME': '/home/cltbld', 04:46:26 INFO - 'LANG': 'en_US.UTF-8', 04:46:26 INFO - 'LANGUAGE': 'en_US:en', 04:46:26 INFO - 'LOGNAME': 'cltbld', 04:46:26 INFO - 'MAIL': '/var/mail/cltbld', 04:46:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:46:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:26 INFO - 'MOZ_NO_REMOTE': '1', 04:46:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:46:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:26 INFO - 'NO_EM_RESTART': '1', 04:46:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:46:26 INFO - 'PWD': '/builds/slave/test-pgo', 04:46:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:46:26 INFO - 'SHELL': '/bin/bash', 04:46:26 INFO - 'SHLVL': '1', 04:46:26 INFO - 'TERM': 'linux', 04:46:26 INFO - 'TMOUT': '86400', 04:46:26 INFO - 'USER': 'cltbld', 04:46:26 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1450786282.479835-1387323542', 04:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:26 INFO - '_': '/tools/buildbot/bin/python'} 04:46:26 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:46:27 INFO - mozversion application_buildid: 20151222023004 04:46:27 INFO - mozversion application_changeset: 63f78eaa94e88c96ba58068ab69dd7fd4d8b9cac 04:46:27 INFO - mozversion application_display_name: Nightly 04:46:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:46:27 INFO - mozversion application_name: Firefox 04:46:27 INFO - mozversion application_remotingname: firefox 04:46:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:46:27 INFO - mozversion application_vendor: Mozilla 04:46:27 INFO - mozversion application_version: 46.0a1 04:46:27 INFO - mozversion platform_buildid: 20151222023004 04:46:27 INFO - mozversion platform_changeset: 63f78eaa94e88c96ba58068ab69dd7fd4d8b9cac 04:46:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:46:27 INFO - mozversion platform_version: 46.0a1 04:46:27 INFO - using testdate: 1450788387 04:46:27 INFO - actual date: 1450788387 04:46:27 INFO - starting webserver on 'localhost:53787' 04:46:27 INFO - SUITE-START | Running 3 tests 04:46:27 INFO - TEST-START | dromaeo_css 04:46:27 INFO - operating with platform_type : linux_ 04:46:27 INFO - Initialising browser for dromaeo_css test... 04:46:27 INFO - TEST-INFO | started process 32229 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3SjA1N/profile http://localhost:53787/getInfo.html) 04:46:31 INFO - PROCESS | 32229 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 04:46:32 INFO - PROCESS | 32229 | __metrics Screen width/height:1600/1200 04:46:32 INFO - PROCESS | 32229 | colorDepth:24 04:46:32 INFO - PROCESS | 32229 | Browser inner width/height: 1024/697 04:46:32 INFO - PROCESS | 32229 | __metrics 04:46:32 INFO - PROCESS | 32229 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:46:33 INFO - TEST-INFO | 32229: exit 0 04:46:33 INFO - Browser initialized. 04:46:33 INFO - Running cycle 1/1 for dromaeo_css test... 04:46:33 INFO - TEST-INFO | started process 32364 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3SjA1N/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:46:45 INFO - PROCESS | 32364 | RSS: Main: 151322624 04:46:45 INFO - PROCESS | 32364 | 04:47:34 INFO - PROCESS | 32364 | 1450788454795 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] 04:49:42 INFO - PROCESS | 32364 | Cycle 1(1): loaded http://localhost:53787/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53787/tests/dromaeo/cssquery-ext.html) 04:49:44 INFO - PROCESS | 32364 | RSS: Main: 158121984 04:49:44 INFO - PROCESS | 32364 | 04:52:45 INFO - PROCESS | 32364 | Cycle 1(1): loaded http://localhost:53787/tests/dromaeo/cssquery-ext.html (next: http://localhost:53787/tests/dromaeo/cssquery-jquery.html) 04:52:46 INFO - PROCESS | 32364 | RSS: Main: 152567808 04:52:46 INFO - PROCESS | 32364 | 04:55:48 INFO - PROCESS | 32364 | Cycle 1(1): loaded http://localhost:53787/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53787/tests/dromaeo/cssquery-mootools.html) 04:55:48 INFO - PROCESS | 32364 | RSS: Main: 154701824 04:55:48 INFO - PROCESS | 32364 | 04:58:50 INFO - PROCESS | 32364 | Cycle 1(1): loaded http://localhost:53787/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53787/tests/dromaeo/cssquery-prototype.html) 04:58:51 INFO - PROCESS | 32364 | RSS: Main: 151609344 04:58:51 INFO - PROCESS | 32364 | 05:01:53 INFO - PROCESS | 32364 | Cycle 1(1): loaded http://localhost:53787/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53787/tests/dromaeo/cssquery-yui.html) 05:01:53 INFO - PROCESS | 32364 | RSS: Main: 153288704 05:01:53 INFO - PROCESS | 32364 | 05:04:56 INFO - PROCESS | 32364 | Cycle 1(1): loaded http://localhost:53787/tests/dromaeo/cssquery-yui.html (next: http://localhost:53787/tests/dromaeo/cssquery-dojo.html) 05:04:56 INFO - PROCESS | 32364 | RSS: Main: 156594176 05:04:56 INFO - PROCESS | 32364 | 05:04:56 INFO - PROCESS | 32364 | __start_tp_report 05:04:56 INFO - PROCESS | 32364 | _x_x_mozilla_page_load 05:04:56 INFO - PROCESS | 32364 | _x_x_mozilla_page_load_details 05:04:56 INFO - PROCESS | 32364 | |i|pagename|runs| 05:04:56 INFO - PROCESS | 32364 | |0;dojo.html;3178.6980236877494;3224.5969253843255;3246.5130230465443;3265.3142840003597;3276.983615081924;5161.767720452579;5404.540614047811;5425.430329815367;5432.538234250089;5449.836504904854;5214.296070030545;5291.444398338177;5360.731963401824;5390.6226564140525;5465;4909.312696222522;4994.77523511441;5063.367079115111;5073.746312684351;5132.717700526469;257.3322920699138;4859.2225243960975;4859.805607775685;4882.902341953177;4994.175960966436;4923.483034281403;5012.498750124995;5014.473480284572;5020.297158397827;5072.82245121419;5017.9247311290355;5026;5028.547430731215;5040.16837221858;5076.213186956028;4812.831550895737;4857.295692124622;4897.314375987365;4962.354893863775;5026.497350264981;5301.098813201726;5313.9734301328635;5319.202119682079;5359.705216213107;5365.973170134163;5859.882802343929;5927.347991720907;5959.940400596025;5961;5964.343922168558;5799.971000145015;5837.211976383176;5903.940960590382;5920.851978700523;5930.258717660293;5526.751296191641;5537.556995440355;5551.805686800943;5555.916661250085;5559.749811258503;5854.121881717691;5958.225430693982;6023.789167379121;6034.366391528914;6034.758609655652;5730.140478928194;5744.310682718101;5859.2090067841145;5869.35437101927;5914.615549989237;5846.7076646167525;5851.824445266649;5855.736491857877;5862.941370586324;5891.322497912709;5551.167324901297;5663.971680141655;5753.223314852441;5777.797777077866;5816.76732930678;5831.096180092092;5884.08796636522;5888.293404791367;5918.141869428995;5927.555433342516;4547.681662283609;4566.246569316092;4568.269076947672;4579.107074120515;4634.652401069933;3971.4638523799495;3985.123272879962;4089.20260549196;4101.938470922939;4136.338185890303;5619.213310136584;5649.265595472562;5667.518260947783;5677.489025987598;5703.144528320785;5942.465178133989;5958.582899197015;5960.0761881908375;5987.6108052976415;5987.760489580455;5423.186522021729;5430.104032834538;5500;5547.140193270049;5644.322681278273;5035.395752509649;5122.052420302256;5139.229115632685;5146.922796158061;5151.896962060813;6022.337542870281;6044.093385992136;6044.557250420937;6045.546584006217;6111.35830737775;5798.362180160179;5833.533317334688;5877.441643043904;5915.970420147872;5965.850853728518;5881.17663527098;5951.553633477593;5957.076653118774;5959.791407300723;6015.12780646795;5627.18405831144;5639.3232812062815;5725.541956643542;5725.942740572541;5727.942720572908;5757.136429535436;5762.4525670061275;5841.824745257649;5859.794907178229;5870.765169393177;5737.540996720169;5750.424957504216;5751.1085781703905;5757.7121143941795;5777.2200752897825;5707.68607726579;5710.971445142748;5726.169705392778;5739.167820666064;5755.683437410815;5463.180522921593;5569.415211402745;5589.245451863946;5664.85837854057;5713.171590119493;5688.943110568841;5762.135679648086;5820.243368362086;5840.707964601838;5862.794802181903;5389.676619402849;5696.487316141567;5716.114002329646;5730.08318669011;5730.398308177581 05:04:56 INFO - PROCESS | 32364 | |1;ext.html;572.8166986564302;592.858746912194;602.6354055796246;603.3182503770738;603.3935894426102;29437.2640683983;30018;37848.24303513928;38141.04647383817;38309.808450957775;42475.57524424755;42540.36189457153;42583.148337033315;42779.572204277945;42867.57132428675;8630.136986301351;8879.689210877621;8902.198802107809;8907.931048274217;8924.687635932743;8594.914050859505;8756.299496040334;8759.95620021899;8770.12298770121;8774.341924355667;8764.693235736751;8785.38502304839;8801.647934082628;8849;8865.911340886572;8644.524551149685;8746.256568191711;8763.167499087576;8784.692535761282;8785.56072196394;8649.740507784776;8722.34582406322;8745.125487451267;8759.080296568833;8761.255293300013;39319;39816.20367592661;39836;39861.60138398608;39925.20149597021;3069.89255376063;3358.815265160415;3387.3902697514436;3726.795026273554;3936.481987280447;29652.70347296521;30464.238394040105;30498.390032199233;30564;30586.847065764752;3421.555197824292;3470.9479357809655;3671.908202294964;3725.9068523286865;3725.9441108383394;265732;269010;269099;269679.1676457794;269722.65138674376;60144.39855601388;60774.39225607687;61088.64012479268;61343.999999999105;61412;61637.69181154066;62766;65629;65818;71409.6429517849;16431.589210269838;16493.917530412273;16546.83453165477;16642.667146657;16659.750103748454;12446.937765311297;12449.004079673785;12479.064070194772;12511.061670374758;12520.1235913487;20877;21157.471063223544;21212.469688257916;21214;21259.574808504054;8104;8258.42191046621;8297.668093276201;8380.16198380157;8409.243168114777;970.7524581231881;982.6069572171045;985.9507024648739;1095.611058074388;1155.1682788392345;29108;29194.41611167765;29246.26884327909;29278.268043298664;29500.704992949795;1052.2160990062453;1087.8422628718793;1108.1135091926426;1109.8557187565564;1156.3408856951457;15168;15280.46518371874;15330.310136043905;15447.922760386125;15489.457868974532;324853;327695;329180;329308;330520;52837;53179.468205318226;53198.468015319355;53323.20015199775;53349;1319.3930791835671;1322.4974509686258;1326.8208791813174;1328.5150919914356;1344.4890941442188;28020.29949251285;28989.85505072461;28990.56514152247;29025.85487072551;29361.11916642504;48051.75974120107;48121.518784811706;48504;48600.75699621479;48636.51363486461;303774;305470;307701;308391;309335;28301.858490707415;28625.856870715514;31628.367432650757;32687.34625307528;33280;38121.61878381292;38686.613133868304;39225.2154956905;39784.80107599444;42423.36364954466;35596.466053008706;36202.63797361992;36518.26963460663;36703.81648091743;36734.44898326581;35025;35301.29397412089;35884.28231435409;36226.8188659055;36282.455763163045;34975.65024349724;35499.290014199054;35672.821635892695;35968.460473093444;36024.459633106046;30912.845435772677;32652.51021234636;32953;33063.33873322568;33333.333333333685;24377;24387.26838194857;24761.25716228516;24907.50184996326;24945.75054249507 05:04:56 INFO - PROCESS | 32364 | |2;jquery.html;342.6950014487107;352.4097137295033;354.7676272041813;355.3266559869048;357.47094300435344;16446.34214631415;16913.830861691396;17606.38377656782;17789.7331540027;18401.539961500937;13504.12223205491;15875.206239688026;16027.278772455238;16092.919535402336;16305.83694163058;4752.239641657344;4883.438404583465;4884.804607815701;4898.314236006944;4920.827771027997;4862.756862156895;4876.926846097312;4895.804167833282;4903.289023091649;4930.211166213407;4829.22732362822;4973.701577905319;5084.51697088776;5229.843104706865;5232.058229518685;5089.491050894918;5122.154844450662;5140.4859514048485;5161.535461808437;5527.419620939824;5331.706756128411;5336.946630533723;5345.037893179227;5363.329583802025;5363.410024897258;11275.774484510346;11335.943320283346;11486.942565287203;11635.534578616845;11680.94871461564;1982.7556114078182;2019.6869485229813;2160.967585486219;2174.24988379009;2194.7476040255415;8755.956220218923;9183.357164998453;9726.36778609388;10005.449700266483;13196.340182990909;1708.7693161423174;1710.8802383833136;1722.6124122072558;1742.4249997500795;1814.5826459914294;58592.414075859124;58616.413835861524;62749;62799;63438;9757.951210243904;10121.392716437038;10332.328398654063;10429.5828166874;10450.843237351446;13259;13286.601401957956;13351.799723004162;13396.062275640807;13517.86482135166;7639.541627502256;7659.23837517363;7688.923110768933;7714.267144621252;7893.329067029252;7427.62861856905;7477.962610186914;7480.476366654282;7506.249375062559;7521.05986751656;4462.687611867138;4543.159515489645;4548.226801443762;4557.6581756368405;4559.38448309474;1650.9763946353337;1719.6560687862477;1734.1415999080536;1789.4142963417996;1797.730340448943;843.8776377425239;882.2236431939851;888.8355654203864;924.7126465415379;974.3131092579714;16722.414715484898;16745.748813767805;16968.23642936071;17396.65206695859;17723.911380443016;905.6467977488785;916.9587368568431;932.305432452827;986.2849434160177;1077.7682798198425;9135.132162444557;9720.805583888425;10450.320729152581;10639.787204255872;10721.195910306758;552092;560906;563060;565641;572926;83776.58111709403;85370.57314713387;86658.56670716606;88228.55885720531;88951;1162.081955255339;1175.0951767139425;1175.2948231061466;1181.7813704464872;1182.6274723462082;15107.39570417215;15604.297806598957;15692.76460853111;16121.742955985937;16170.514884553482;34379.14052148616;34430.65569344375;34991.82504087565;35182.64817351794;35694.64305357017;41532.1693566133;41676.37485437781;42516.36225456559;43229.783851080545;44779;8803.647854085764;9463.290253230898;9587.808243835223;9601.32790704672;9607.951960240154;11069.557217711523;11191.99272065518;15411.61470963235;17713.380031698827;18475.630487390445;13845.307734613027;14225.573232803032;14260.643483912985;14693.706125877636;14748.852511474748;14011.43954241819;14331.785023224451;14451.132932024113;14785.704285914006;14943.327550260481;14241.430342786587;14435.494757683431;14443.35004924802;14809.963302568716;14817.481388151364;8651.394402391772;8825.735227943173;8924.776880577778;9168.954155229181;9221.17009469151;9288.396254243453;9309.57950932776;9337.486438245962;14585.416583336548;14798 05:04:56 INFO - PROCESS | 32364 | |3;mootools.html;1496.2967405319496;1698.3291599818072;1723.0953749281634;1734.835190656887;1776.5736223306405;7572.12920514141;7724.884126738089;7861.213878612136;7932.048154221494;7988.440809143348;7935.206479352062;7951.125376208613;8021.077576078753;8074.838503229947;8090.474119182249;2241.0363543676253;2279.87460689662;2281.0533628544217;2281.931542053741;2284.20052981456;2276.7040284762957;2308.9307320780317;2310.722713274409;2314.028108194554;2319.9420014499606;2251.5046689728315;2264.411253074196;2265.614845476273;2270.738865030518;2283.7602051784575;2163.318554655294;2196.9450763730874;2221.8222542196586;2226.5101677630896;2251.223327951846;2250.054976909702;2276.237460450751;2277.396489930153;2285.3600991722346;2287.0508738873345;7630.4658673892845;7706.807329816744;7734.342580880632;7740.535567865946;7746.147923728386;4672.836450724209;4704.529547045302;4707.223308154151;4732.077244937239;4740.265258884879;2952.2914500519937;2987.3195804404672;3035.681253468398;3050.8474576271096;3053.0230326295596;927.8376284150247;930.2000279759402;930.9767255818658;932.3939439364467;977.462395682379;10598.986192623377;10614.203934704929;10616.150707943347;10676.306040107369;10729.624463143753;3844.7116466265143;3887.8250478728523;3895.02624343914;3902.921941561153;4152.647025002848;8485.193906578865;8531;8533.573321333908;8558.272546833588;8647.740567782977;4510.887227819265;4533.070720502289;4538.319252112209;4539.477960034638;4546.318052292183;4108.50697916246;4141.4616099907425;4144.979275103605;4176.18564379943;4177.56135605757;3293.92947292131;3304.0253125328086;3322.6178989416044;3323.4350160472777;3381.4758712399616;1055.0978913029403;1057.391999600233;1059.8516207730925;1062.2988827373897;1071.7856428714288;957.8371676814958;1012.9088382045651;1015.7359086637528;1127.3179726265655;1276.974460510803;7143.857122857514;7146.213916469184;7211.062561867028;7240.167380751176;7265.745698900513;1194.707296712311;1229.3484453239798;1234.5000274888685;1237.3874931908763;1237.9442925068392;5694.174344719992;5865.2961644602065;5887.941120588825;5893.440123188376;5909.438603332676;9269.073092690676;9333.533323333806;9562.235021198287;9565.282603804742;9591.376560523544;9299.256059515223;9326.860097098548;9338.953305233566;9356.625734970525;9484.573194206278;7125.92874071263;7208.819779505554;7251.274872512707;7307.1231452226075;7375.704971801175;7000;7024.121984751906;7043.647817608997;7052.188998265266;7060.929390706233;8160.061592916891;8386.161383861809;8386.538740369338;8438.240558349533;8529.658813647384;8404.579771011302;8583.098774628574;8618.008928973248;8677.349198809989;8711.303095752452;6956.40870526011;7004.474664400293;7011.474139439664;7037.648117593997;7100.112485939258;7346.6326683666675;7388.741394051182;7408.073990751156;7429.628518574158;7475.7009719610605;6740.292269311652;6833.4191593715095;6910.239873613999;6928.1339832520935;7151.070360853056;6828.5902845829405;6944.791656250321;6966.3730264276455;7004.579725216503;7098.893516597152;6862.691178896862;6881.724731010703;6917.100776898971;6960.721571137098;6961.37347638715;6424.743010279536;6445.065465507569;6454.838629034311;6474.514411419068;6480.254770701241;6171.043488259327;6259.092431597484;6324.873502530016;6377.23473183221;6457.0637257596445 05:04:56 INFO - PROCESS | 32364 | |4;prototype.html;321.67189466743935;325.78335406954375;333.4331636218429;334.5049326996046;340.10043435114113;6252.593581417204;6289.7484100635975;6298.0552917062405;6316.368363163681;6319.6524191169465;6125.479334256594;6239.532035097363;6263.7494500220055;6269.185005949232;6278.686065696708;4752.643551733617;4769.236922092466;4777.092352453023;4778.450478195;4796.880077998052;4774.140654682155;4775.594074503671;4780.976095119519;4782.330473733663;4806.038792241566;4651.767411629422;4749.952500475003;4767.713937163781;4773.212419950704;4775.021120670272;4714.622830173578;4741.573258406743;4743;4743.928841067404;4749.358836557055;4124.05146816234;4134.028503301722;4135.152293779768;4145.233131870584;4163.3130533461945;5970.791022314198;5981.9401805981815;5999.400059994009;6005.369436209223;6033.366496517846;5345.4387289334445;5516.531094856942;5529.391766905637;5537.390887002467;5547.306586676666;6658.966705166443;6665.200175978914;6673.599584024974;6679.632620205887;6684.331566843277;4585.082983403299;4585.380973568559;4586.1744885920525;4588.426446694163;4594.2419500782335;6810.489213309022;6960.825979350506;6972.058772065757;6972.686229119651;6974.686139123752;4676.392069031004;4678.461976872635;4681.087187998308;4684.976575117103;4710.81156753726;4730.337752714623;4730.929036064462;4735.337052812609;4742.170120228946;4768.022555376139;5519.475649813261;5522.006038912954;5528.364238112588;5529.944700553024;5536.474034966672;6612.801615951529;6615.305392933769;6631.502637302222;6691.364320389555;6699.732010719614;1593.8884278100654;1626.4470080172798;1631.600257936813;1633.8937969031974;1663.193351224655;1067.7384040910026;1071.464267866067;1075.0593230922943;1079.3416016230094;1089.2429761315968;6383.138276332728;6414.775482858171;6431;6451.387118223761;6459.354064593597;6780.1524809398825;6784.966075169593;6813.965930170417;6850.623215723183;6851.07510486088;6309.652969086745;6351.333110023381;6381.1704478417505;6419.871602567922;6420.678966051679;3759.7180211484247;3778.3576791945434;3780.773153610737;3783.754055986352;3790.7156963227867;7164.749233776793;7181.856362872713;7193.208747037822;7201.4238860891;7212.062431883926;7045.577265364094;7184.389326907271;7193.352598266181;7196.64016799158;7219.169795473483;7157.821054473679;7178.425725941807;7178.60517671533;7180.856382872418;7183.62940229723;6934;6981.127359080115;6984.301569842975;6990.720371185095;7001.474889383215;6800.115984921928;6876.518643694893;6884.4148247399535;6922.10012698346;6941.791746247621;7152.821179470555;7172.211056783854;7215.963920180366;7217.67520461591;7223.061002069908;4573.5426457354;4589.495155532822;4618.815247390066;4638.93041604383;4642.883927901695;6862.622555759481;6957.060796792368;6965.65171741421;6975.581465112109;6984.755533556301;6787.287334829772;6790.66046697673;6790.72837086511;6796.116504854337;6807.523473356818;6681.164854393201;6709.329067093252;6752.426043786137;6759.222689390586;6770.966145169243;6535.052417399545;6611.669416529058;6642.767503137367;6645.60126392418;6657.966710166418;6783.18601767791;6785.830354240986;6793;6794.082798822095;6806.353396427331;6626.469882409492;6653.367930046637;6664.500162487736;6666.83332916681;6683.7660681875905 05:04:56 INFO - PROCESS | 32364 | |5;yui.html;726.749271501332;783.9137694853565;809.2433574607742;836.6736972580699;873.4453621950064;12464.127511074217;12729.045321600894;12734.490620375196;12764.297963612009;12780.744385112304;12659.430325635345;13017.28404937728;13037.804432933513;14647.414103435849;14658.047226930243;797.4617133434923;810.8094597769519;811.0267678785451;813.9064007639138;814.2997022560593;799.5003123048095;808.454293351988;810.3881569415083;810.8256724804166;811.6509900742678;851.7061613743249;858.8582883824162;867.4491697771929;867.6312567158964;870.412471581683;851.7402192331336;852.5055467828676;854.171453689926;855.8545047341936;857.6269322844582;627.6579264300967;634.2294112653102;635.8156134720925;636.0776873533349;636.4208570201095;12498.125131240817;12601.810972835416;12662.873371266354;12686.302253376061;12697.365131743376;11582.18924675273;11593.420328983602;11926.224795388272;12308.199967002205;12373.381330933418;9639.228861691117;9666.854997175047;9724.854127188099;9771.267154963407;9789.21686265097;3316.303576248991;3418.538497302882;3452.7928324300624;3483.825808709554;3555.9111022224392;41562;43709.34435983463;44432.111357772665;47999.28001079986;48093;8979.820403591892;9141.405808622418;9341.626334946663;9396.859047114298;9510.572024258925;19199.616007680048;19577;19868.205271788967;19903;19904;6959.4432445404245;6991.405730512862;7273.818154546178;7522.473426860177;7591.316781489692;3780.1494663700996;3845.7115716321387;3860.1121741998936;3864.806759662006;3927.489426374553;3025.9848700756797;3040.5439184122115;3066.632004159515;3067.693230676959;3069.1713237426216;534.599050711966;544.6214880657984;545.6671430427436;547.7507733981029;548.4131978782744;633.8922383194868;686.145748543067;690.102866273842;702.5363260248314;712.3287671232877;8157;8694.565271736388;8857.468551886908;9135.954320228357;9235.215006724504;626.8119564130742;684.1967362233733;690.4890381117937;698.4063545985973;702.367868917978;3923.1708228494217;3993.5806740292433;4058.370952502367;4073.714839961174;4121.340585506305;54574.72712636491;54748.45251547513;54753.45246547484;54829;55846;49195.50804491981;50013.74993125011;50505.74747126241;50621.240681389805;50639.49360506421;44571.77714111473;46738.532614674776;48045.75977120092;49655.034496550055;51177;7966.3626909848235;8320.334373250247;8357.791055223424;8479.32165426752;8491.448055876348;34638.65361346455;34705.13237169091;35630.821845890605;35867.28265434624;35880.820595896854;40583.1883362337;44052.55947440613;44664.77667611641;45347.54652453433;45405;11194.83207751868;11207.831882521932;11440.771184576428;11685.591004315149;11850.348230847387;11331.603393881174;11526.962573368437;11584.304941703525;12190.51237950472;12310.630681079581;10403.375797452178;10414.687559373231;10641.840372394265;10720.892791072301;10740;10576.735581610521;10594.152467802403;10614.043775378703;10784.299020563638;10859.837102443627;10549;10746.408947507962;10754.085902698045;10781.460926953465;10917.344959302149;8731.956340218258;8868.423552469068;8953.507557084162;9015.14356136166;9395.906040939502;8564.186402291773;8687.348448866234;8696.78258043554;8824.647014119364;8974.506402147945 05:04:56 INFO - PROCESS | 32364 | __end_tp_report 05:04:56 INFO - PROCESS | 32364 | __start_cc_report 05:04:56 INFO - PROCESS | 32364 | _x_x_mozilla_cycle_collect,306 05:04:56 INFO - PROCESS | 32364 | __end_cc_report 05:04:56 INFO - PROCESS | 32364 | __startTimestamp1450789496508__endTimestamp 05:04:56 INFO - PROCESS | 32364 | 05:04:56 INFO - PROCESS | 32364 | ------- Summary: start ------- 05:04:56 INFO - PROCESS | 32364 | Number of tests: 6 05:04:56 INFO - PROCESS | 32364 | 05:04:56 INFO - PROCESS | 32364 | [#0] dojo.html Cycles:165 Average:5415.09 Median:5677.49 stddev:724.45 (12.8%) stddev-sans-first:705.11 05:04:56 INFO - PROCESS | 32364 | Values: 3178.7 3224.6 3246.5 3265.3 3277.0 5161.8 5404.5 5425.4 5432.5 5449.8 5214.3 5291.4 5360.7 5390.6 5465.0 4909.3 4994.8 5063.4 5073.7 5132.7 257.3 4859.2 4859.8 4882.9 4994.2 4923.5 5012.5 5014.5 5020.3 5072.8 5017.9 5026.0 5028.5 5040.2 5076.2 4812.8 4857.3 4897.3 4962.4 5026.5 5301.1 5314.0 5319.2 5359.7 5366.0 5859.9 5927.3 5959.9 5961.0 5964.3 5800.0 5837.2 5903.9 5920.9 5930.3 5526.8 5537.6 5551.8 5555.9 5559.7 5854.1 5958.2 6023.8 6034.4 6034.8 5730.1 5744.3 5859.2 5869.4 5914.6 5846.7 5851.8 5855.7 5862.9 5891.3 5551.2 5664.0 5753.2 5777.8 5816.8 5831.1 5884.1 5888.3 5918.1 5927.6 4547.7 4566.2 4568.3 4579.1 4634.7 3971.5 3985.1 4089.2 4101.9 4136.3 5619.2 5649.3 5667.5 5677.5 5703.1 5942.5 5958.6 5960.1 5987.6 5987.8 5423.2 5430.1 5500.0 5547.1 5644.3 5035.4 5122.1 5139.2 5146.9 5151.9 6022.3 6044.1 6044.6 6045.5 6111.4 5798.4 5833.5 5877.4 5916.0 5965.9 5881.2 5951.6 5957.1 5959.8 6015.1 5627.2 5639.3 5725.5 5725.9 5727.9 5757.1 5762.5 5841.8 5859.8 5870.8 5737.5 5750.4 5751.1 5757.7 5777.2 5707.7 5711.0 5726.2 5739.2 5755.7 5463.2 5569.4 5589.2 5664.9 5713.2 5688.9 5762.1 5820.2 5840.7 5862.8 5389.7 5696.5 5716.1 5730.1 5730.4 05:04:56 INFO - PROCESS | 32364 | 05:04:56 INFO - PROCESS | 32364 | [#1] ext.html Cycles:180 Average:47274.57 Median:35926.37 stddev:79067.24 (220.1%) stddev-sans-first:79211.29 05:04:56 INFO - PROCESS | 32364 | Values: 572.8 592.9 602.6 603.3 603.4 29437.3 30018.0 37848.2 38141.0 38309.8 42475.6 42540.4 42583.1 42779.6 42867.6 8630.1 8879.7 8902.2 8907.9 8924.7 8594.9 8756.3 8760.0 8770.1 8774.3 8764.7 8785.4 8801.6 8849.0 8865.9 8644.5 8746.3 8763.2 8784.7 8785.6 8649.7 8722.3 8745.1 8759.1 8761.3 39319.0 39816.2 39836.0 39861.6 39925.2 3069.9 3358.8 3387.4 3726.8 3936.5 29652.7 30464.2 30498.4 30564.0 30586.8 3421.6 3470.9 3671.9 3725.9 3725.9 265732.0 269010.0 269099.0 269679.2 269722.7 60144.4 60774.4 61088.6 61344.0 61412.0 61637.7 62766.0 65629.0 65818.0 71409.6 16431.6 16493.9 16546.8 16642.7 16659.8 12446.9 12449.0 12479.1 12511.1 12520.1 20877.0 21157.5 21212.5 21214.0 21259.6 8104.0 8258.4 8297.7 8380.2 8409.2 970.8 982.6 986.0 1095.6 1155.2 29108.0 29194.4 29246.3 29278.3 29500.7 1052.2 1087.8 1108.1 1109.9 1156.3 15168.0 15280.5 15330.3 15447.9 15489.5 324853.0 327695.0 329180.0 329308.0 330520.0 52837.0 53179.5 53198.5 53323.2 53349.0 1319.4 1322.5 1326.8 1328.5 1344.5 28020.3 28989.9 28990.6 29025.9 29361.1 48051.8 48121.5 48504.0 48600.8 48636.5 303774.0 305470.0 307701.0 308391.0 309335.0 28301.9 28625.9 31628.4 32687.3 33280.0 38121.6 38686.6 39225.2 39784.8 42423.4 35596.5 36202.6 36518.3 36703.8 36734.4 35025.0 35301.3 35884.3 36226.8 36282.5 34975.7 35499.3 35672.8 35968.5 36024.5 30912.8 32652.5 32953.0 33063.3 33333.3 24377.0 24387.3 24761.3 24907.5 24945.8 05:04:56 INFO - PROCESS | 32364 | 05:04:56 INFO - PROCESS | 32364 | [#2] jquery.html Cycles:180 Average:29216.03 Median:18026.06 stddev:92099.01 (510.9%) stddev-sans-first:92331.85 05:04:56 INFO - PROCESS | 32364 | Values: 342.7 352.4 354.8 355.3 357.5 16446.3 16913.8 17606.4 17789.7 18401.5 13504.1 15875.2 16027.3 16092.9 16305.8 4752.2 4883.4 4884.8 4898.3 4920.8 4862.8 4876.9 4895.8 4903.3 4930.2 4829.2 4973.7 5084.5 5229.8 5232.1 5089.5 5122.2 5140.5 5161.5 5527.4 5331.7 5336.9 5345.0 5363.3 5363.4 11275.8 11335.9 11486.9 11635.5 11680.9 1982.8 2019.7 2161.0 2174.2 2194.7 8756.0 9183.4 9726.4 10005.4 13196.3 1708.8 1710.9 1722.6 1742.4 1814.6 58592.4 58616.4 62749.0 62799.0 63438.0 9758.0 10121.4 10332.3 10429.6 10450.8 13259.0 13286.6 13351.8 13396.1 13517.9 7639.5 7659.2 7688.9 7714.3 7893.3 7427.6 7478.0 7480.5 7506.2 7521.1 4462.7 4543.2 4548.2 4557.7 4559.4 1651.0 1719.7 1734.1 1789.4 1797.7 843.9 882.2 888.8 924.7 974.3 16722.4 16745.7 16968.2 17396.7 17723.9 905.6 917.0 932.3 986.3 1077.8 9135.1 9720.8 10450.3 10639.8 10721.2 552092.0 560906.0 563060.0 565641.0 572926.0 83776.6 85370.6 86658.6 88228.6 88951.0 1162.1 1175.1 1175.3 1181.8 1182.6 15107.4 15604.3 15692.8 16121.7 16170.5 34379.1 34430.7 34991.8 35182.6 35694.6 41532.2 41676.4 42516.4 43229.8 44779.0 8803.6 9463.3 9587.8 9601.3 9608.0 11069.6 11192.0 15411.6 17713.4 18475.6 13845.3 14225.6 14260.6 14693.7 14748.9 14011.4 14331.8 14451.1 14785.7 14943.3 14241.4 14435.5 14443.4 14810.0 14817.5 8651.4 8825.7 8924.8 9169.0 9221.2 9288.4 9309.6 9337.5 14585.4 14798.0 05:04:56 INFO - PROCESS | 32364 | 05:04:56 INFO - PROCESS | 32364 | [#3] mootools.html Cycles:180 Average:5413.55 Median:6455.95 stddev:2820.66 (43.7%) stddev-sans-first:2813.20 05:04:56 INFO - PROCESS | 32364 | Values: 1496.3 1698.3 1723.1 1734.8 1776.6 7572.1 7724.9 7861.2 7932.0 7988.4 7935.2 7951.1 8021.1 8074.8 8090.5 2241.0 2279.9 2281.1 2281.9 2284.2 2276.7 2308.9 2310.7 2314.0 2319.9 2251.5 2264.4 2265.6 2270.7 2283.8 2163.3 2196.9 2221.8 2226.5 2251.2 2250.1 2276.2 2277.4 2285.4 2287.1 7630.5 7706.8 7734.3 7740.5 7746.1 4672.8 4704.5 4707.2 4732.1 4740.3 2952.3 2987.3 3035.7 3050.8 3053.0 927.8 930.2 931.0 932.4 977.5 10599.0 10614.2 10616.2 10676.3 10729.6 3844.7 3887.8 3895.0 3902.9 4152.6 8485.2 8531.0 8533.6 8558.3 8647.7 4510.9 4533.1 4538.3 4539.5 4546.3 4108.5 4141.5 4145.0 4176.2 4177.6 3293.9 3304.0 3322.6 3323.4 3381.5 1055.1 1057.4 1059.9 1062.3 1071.8 957.8 1012.9 1015.7 1127.3 1277.0 7143.9 7146.2 7211.1 7240.2 7265.7 1194.7 1229.3 1234.5 1237.4 1237.9 5694.2 5865.3 5887.9 5893.4 5909.4 9269.1 9333.5 9562.2 9565.3 9591.4 9299.3 9326.9 9339.0 9356.6 9484.6 7125.9 7208.8 7251.3 7307.1 7375.7 7000.0 7024.1 7043.6 7052.2 7060.9 8160.1 8386.2 8386.5 8438.2 8529.7 8404.6 8583.1 8618.0 8677.3 8711.3 6956.4 7004.5 7011.5 7037.6 7100.1 7346.6 7388.7 7408.1 7429.6 7475.7 6740.3 6833.4 6910.2 6928.1 7151.1 6828.6 6944.8 6966.4 7004.6 7098.9 6862.7 6881.7 6917.1 6960.7 6961.4 6424.7 6445.1 6454.8 6474.5 6480.3 6171.0 6259.1 6324.9 6377.2 6457.1 05:04:56 INFO - PROCESS | 32364 | 05:04:56 INFO - PROCESS | 32364 | [#4] prototype.html Cycles:180 Average:5588.90 Median:6335.49 stddev:1716.00 (27.1%) stddev-sans-first:1674.65 05:04:56 INFO - PROCESS | 32364 | Values: 321.7 325.8 333.4 334.5 340.1 6252.6 6289.7 6298.1 6316.4 6319.7 6125.5 6239.5 6263.7 6269.2 6278.7 4752.6 4769.2 4777.1 4778.5 4796.9 4774.1 4775.6 4781.0 4782.3 4806.0 4651.8 4750.0 4767.7 4773.2 4775.0 4714.6 4741.6 4743.0 4743.9 4749.4 4124.1 4134.0 4135.2 4145.2 4163.3 5970.8 5981.9 5999.4 6005.4 6033.4 5345.4 5516.5 5529.4 5537.4 5547.3 6659.0 6665.2 6673.6 6679.6 6684.3 4585.1 4585.4 4586.2 4588.4 4594.2 6810.5 6960.8 6972.1 6972.7 6974.7 4676.4 4678.5 4681.1 4685.0 4710.8 4730.3 4730.9 4735.3 4742.2 4768.0 5519.5 5522.0 5528.4 5529.9 5536.5 6612.8 6615.3 6631.5 6691.4 6699.7 1593.9 1626.4 1631.6 1633.9 1663.2 1067.7 1071.5 1075.1 1079.3 1089.2 6383.1 6414.8 6431.0 6451.4 6459.4 6780.2 6785.0 6814.0 6850.6 6851.1 6309.7 6351.3 6381.2 6419.9 6420.7 3759.7 3778.4 3780.8 3783.8 3790.7 7164.7 7181.9 7193.2 7201.4 7212.1 7045.6 7184.4 7193.4 7196.6 7219.2 7157.8 7178.4 7178.6 7180.9 7183.6 6934.0 6981.1 6984.3 6990.7 7001.5 6800.1 6876.5 6884.4 6922.1 6941.8 7152.8 7172.2 7216.0 7217.7 7223.1 4573.5 4589.5 4618.8 4638.9 4642.9 6862.6 6957.1 6965.7 6975.6 6984.8 6787.3 6790.7 6790.7 6796.1 6807.5 6681.2 6709.3 6752.4 6759.2 6771.0 6535.1 6611.7 6642.8 6645.6 6658.0 6783.2 6785.8 6793.0 6794.1 6806.4 6626.5 6653.4 6664.5 6666.8 6683.8 05:04:56 INFO - PROCESS | 32364 | 05:04:56 INFO - PROCESS | 32364 | [#5] yui.html Cycles:180 Average:13493.68 Median:50259.75 stddev:15659.24 (31.2%) stddev-sans-first:15673.82 05:04:56 INFO - PROCESS | 32364 | Values: 726.7 783.9 809.2 836.7 873.4 12464.1 12729.0 12734.5 12764.3 12780.7 12659.4 13017.3 13037.8 14647.4 14658.0 797.5 810.8 811.0 813.9 814.3 799.5 808.5 810.4 810.8 811.7 851.7 858.9 867.4 867.6 870.4 851.7 852.5 854.2 855.9 857.6 627.7 634.2 635.8 636.1 636.4 12498.1 12601.8 12662.9 12686.3 12697.4 11582.2 11593.4 11926.2 12308.2 12373.4 9639.2 9666.9 9724.9 9771.3 9789.2 3316.3 3418.5 3452.8 3483.8 3555.9 41562.0 43709.3 44432.1 47999.3 48093.0 8979.8 9141.4 9341.6 9396.9 9510.6 19199.6 19577.0 19868.2 19903.0 19904.0 6959.4 6991.4 7273.8 7522.5 7591.3 3780.1 3845.7 3860.1 3864.8 3927.5 3026.0 3040.5 3066.6 3067.7 3069.2 534.6 544.6 545.7 547.8 548.4 633.9 686.1 690.1 702.5 712.3 8157.0 8694.6 8857.5 9136.0 9235.2 626.8 684.2 690.5 698.4 702.4 3923.2 3993.6 4058.4 4073.7 4121.3 54574.7 54748.5 54753.5 54829.0 55846.0 49195.5 50013.7 50505.7 50621.2 50639.5 44571.8 46738.5 48045.8 49655.0 51177.0 7966.4 8320.3 8357.8 8479.3 8491.4 34638.7 34705.1 35630.8 35867.3 35880.8 40583.2 44052.6 44664.8 45347.5 45405.0 11194.8 11207.8 11440.8 11685.6 11850.3 11331.6 11527.0 11584.3 12190.5 12310.6 10403.4 10414.7 10641.8 10720.9 10740.0 10576.7 10594.2 10614.0 10784.3 10859.8 10549.0 10746.4 10754.1 10781.5 10917.3 8732.0 8868.4 8953.5 9015.1 9395.9 8564.2 8687.3 8696.8 8824.6 8974.5 05:04:56 INFO - PROCESS | 32364 | -------- Summary: end -------- 05:04:56 INFO - PROCESS | 32364 | 05:04:57 INFO - TEST-INFO | 32364: exit 0 05:04:57 INFO - TEST-OK | dromaeo_css | took 1110005ms 05:04:57 INFO - TEST-START | kraken 05:04:57 INFO - operating with platform_type : linux_ 05:04:57 INFO - Initialising browser for kraken test... 05:04:57 INFO - TEST-INFO | started process 32604 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5dICyz/profile http://localhost:53787/getInfo.html) 05:05:01 INFO - PROCESS | 32604 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 05:05:02 INFO - PROCESS | 32604 | __metrics Screen width/height:1600/1200 05:05:02 INFO - PROCESS | 32604 | colorDepth:24 05:05:02 INFO - PROCESS | 32604 | Browser inner width/height: 1024/697 05:05:02 INFO - PROCESS | 32604 | __metrics 05:05:02 INFO - PROCESS | 32604 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:05:02 INFO - PROCESS | 32604 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 05:05:03 INFO - TEST-INFO | 32604: exit 0 05:05:03 INFO - Browser initialized. 05:05:03 INFO - Running cycle 1/1 for kraken test... 05:05:03 INFO - TEST-INFO | started process 32726 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5dICyz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:05:15 INFO - PROCESS | 32726 | RSS: Main: 151392256 05:05:15 INFO - PROCESS | 32726 | 05:05:17 INFO - PROCESS | 32726 | Cycle 1(1): loaded http://localhost:53787/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53787/tests/kraken/driver.html?testName=audio-beat-detection) 05:05:18 INFO - PROCESS | 32726 | RSS: Main: 152186880 05:05:18 INFO - PROCESS | 32726 | 05:05:20 INFO - PROCESS | 32726 | Cycle 1(1): loaded http://localhost:53787/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53787/tests/kraken/driver.html?testName=audio-dft) 05:05:21 INFO - PROCESS | 32726 | RSS: Main: 152297472 05:05:21 INFO - PROCESS | 32726 | 05:05:24 INFO - PROCESS | 32726 | Cycle 1(1): loaded http://localhost:53787/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53787/tests/kraken/driver.html?testName=audio-fft) 05:05:24 INFO - PROCESS | 32726 | RSS: Main: 147574784 05:05:24 INFO - PROCESS | 32726 | 05:05:26 INFO - PROCESS | 32726 | Cycle 1(1): loaded http://localhost:53787/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53787/tests/kraken/driver.html?testName=audio-oscillator) 05:05:27 INFO - PROCESS | 32726 | RSS: Main: 145715200 05:05:27 INFO - PROCESS | 32726 | 05:05:29 INFO - PROCESS | 32726 | Cycle 1(1): loaded http://localhost:53787/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53787/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:05:30 INFO - PROCESS | 32726 | RSS: Main: 146546688 05:05:30 INFO - PROCESS | 32726 | 05:05:33 INFO - PROCESS | 32726 | Cycle 1(1): loaded http://localhost:53787/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53787/tests/kraken/driver.html?testName=imaging-darkroom) 05:05:33 INFO - PROCESS | 32726 | RSS: Main: 147562496 05:05:33 INFO - PROCESS | 32726 | 05:05:37 INFO - PROCESS | 32726 | Cycle 1(1): loaded http://localhost:53787/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53787/tests/kraken/driver.html?testName=imaging-desaturate) 05:05:37 INFO - PROCESS | 32726 | RSS: Main: 148758528 05:05:37 INFO - PROCESS | 32726 | 05:05:40 INFO - PROCESS | 32726 | Cycle 1(1): loaded http://localhost:53787/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53787/tests/kraken/driver.html?testName=json-parse-financial) 05:05:41 INFO - PROCESS | 32726 | RSS: Main: 148791296 05:05:41 INFO - PROCESS | 32726 | 05:05:42 INFO - PROCESS | 32726 | Cycle 1(1): loaded http://localhost:53787/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53787/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:05:43 INFO - PROCESS | 32726 | RSS: Main: 148144128 05:05:43 INFO - PROCESS | 32726 | 05:05:45 INFO - PROCESS | 32726 | Cycle 1(1): loaded http://localhost:53787/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53787/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:05:45 INFO - PROCESS | 32726 | RSS: Main: 148672512 05:05:45 INFO - PROCESS | 32726 | 05:05:47 INFO - PROCESS | 32726 | Cycle 1(1): loaded http://localhost:53787/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53787/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:05:48 INFO - PROCESS | 32726 | RSS: Main: 148762624 05:05:48 INFO - PROCESS | 32726 | 05:05:50 INFO - PROCESS | 32726 | Cycle 1(1): loaded http://localhost:53787/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53787/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:05:51 INFO - PROCESS | 32726 | RSS: Main: 149114880 05:05:51 INFO - PROCESS | 32726 | 05:05:54 INFO - PROCESS | 32726 | Cycle 1(1): loaded http://localhost:53787/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53787/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:05:54 INFO - PROCESS | 32726 | RSS: Main: 148152320 05:05:54 INFO - PROCESS | 32726 | 05:05:56 INFO - PROCESS | 32726 | Cycle 1(1): loaded http://localhost:53787/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53787/tests/kraken/driver.html?testName=ai-astar) 05:05:56 INFO - PROCESS | 32726 | RSS: Main: 148983808 05:05:56 INFO - PROCESS | 32726 | 05:05:56 INFO - PROCESS | 32726 | __start_tp_report 05:05:56 INFO - PROCESS | 32726 | _x_x_mozilla_page_load 05:05:56 INFO - PROCESS | 32726 | _x_x_mozilla_page_load_details 05:05:56 INFO - PROCESS | 32726 | |i|pagename|runs| 05:05:56 INFO - PROCESS | 32726 | |0;ai-astar;112;106;111;112;111;124;110;110;113;111 05:05:56 INFO - PROCESS | 32726 | |1;audio-beat-detection;155;122;150;166;127;155;156;126;166;124 05:05:56 INFO - PROCESS | 32726 | |2;audio-dft;164;162;163;164;164;165;162;165;168;166 05:05:56 INFO - PROCESS | 32726 | |3;audio-fft;71;71;73;79;71;129;72;77;71;82 05:05:56 INFO - PROCESS | 32726 | |4;audio-oscillator;93;95;145;95;94;94;141;94;94;137 05:05:56 INFO - PROCESS | 32726 | |5;imaging-gaussian-blur;110;110;111;110;111;110;110;110;111;110 05:05:56 INFO - PROCESS | 32726 | |6;imaging-darkroom;149;147;146;147;147;147;148;146;146;147 05:05:56 INFO - PROCESS | 32726 | |7;imaging-desaturate;95;97;100;96;97;96;97;98;96;96 05:05:56 INFO - PROCESS | 32726 | |8;json-parse-financial;60;60;60;59;61;61;63;59;56;57 05:05:56 INFO - PROCESS | 32726 | |9;json-stringify-tinderbox;68;67;66;67;67;69;67;68;67;66 05:05:56 INFO - PROCESS | 32726 | |10;stanford-crypto-aes;84;84;86;86;93;85;84;84;93;86 05:05:56 INFO - PROCESS | 32726 | |11;stanford-crypto-ccm;117;118;122;120;116;117;131;116;116;123 05:05:56 INFO - PROCESS | 32726 | |12;stanford-crypto-pbkdf2;142;153;151;161;152;149;160;158;156;140 05:05:56 INFO - PROCESS | 32726 | |13;stanford-crypto-sha256-iterative;67;82;68;68;68;69;68;69;66;67 05:05:56 INFO - PROCESS | 32726 | __end_tp_report 05:05:56 INFO - PROCESS | 32726 | __start_cc_report 05:05:56 INFO - PROCESS | 32726 | _x_x_mozilla_cycle_collect,732 05:05:56 INFO - PROCESS | 32726 | __end_cc_report 05:05:56 INFO - PROCESS | 32726 | __startTimestamp1450789556592__endTimestamp 05:05:56 INFO - PROCESS | 32726 | 05:05:56 INFO - PROCESS | 32726 | ------- Summary: start ------- 05:05:56 INFO - PROCESS | 32726 | Number of tests: 14 05:05:56 INFO - PROCESS | 32726 | 05:05:56 INFO - PROCESS | 32726 | [#0] ai-astar Cycles:10 Average:112.00 Median:111.50 stddev:4.62 (4.1%) stddev-sans-first:4.90 05:05:56 INFO - PROCESS | 32726 | Values: 112.0 106.0 111.0 112.0 111.0 124.0 110.0 110.0 113.0 111.0 05:05:56 INFO - PROCESS | 32726 | 05:05:56 INFO - PROCESS | 32726 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:155.00 stddev:17.90 (11.5%) stddev-sans-first:18.59 05:05:56 INFO - PROCESS | 32726 | Values: 155.0 122.0 150.0 166.0 127.0 155.0 156.0 126.0 166.0 124.0 05:05:56 INFO - PROCESS | 32726 | 05:05:56 INFO - PROCESS | 32726 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.50 stddev:1.83 (1.1%) stddev-sans-first:1.94 05:05:56 INFO - PROCESS | 32726 | Values: 164.0 162.0 163.0 164.0 164.0 165.0 162.0 165.0 168.0 166.0 05:05:56 INFO - PROCESS | 32726 | 05:05:56 INFO - PROCESS | 32726 | [#3] audio-fft Cycles:10 Average:79.60 Median:72.50 stddev:17.80 (24.5%) stddev-sans-first:18.60 05:05:56 INFO - PROCESS | 32726 | Values: 71.0 71.0 73.0 79.0 71.0 129.0 72.0 77.0 71.0 82.0 05:05:56 INFO - PROCESS | 32726 | 05:05:56 INFO - PROCESS | 32726 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:94.00 stddev:22.72 (24.2%) stddev-sans-first:23.42 05:05:56 INFO - PROCESS | 32726 | Values: 93.0 95.0 145.0 95.0 94.0 94.0 141.0 94.0 94.0 137.0 05:05:56 INFO - PROCESS | 32726 | 05:05:56 INFO - PROCESS | 32726 | [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 05:05:56 INFO - PROCESS | 32726 | Values: 110.0 110.0 111.0 110.0 111.0 110.0 110.0 110.0 111.0 110.0 05:05:56 INFO - PROCESS | 32726 | 05:05:56 INFO - PROCESS | 32726 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.94 (0.6%) stddev-sans-first:0.67 05:05:56 INFO - PROCESS | 32726 | Values: 149.0 147.0 146.0 147.0 147.0 147.0 148.0 146.0 146.0 147.0 05:05:56 INFO - PROCESS | 32726 | 05:05:56 INFO - PROCESS | 32726 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.50 stddev:1.40 (1.4%) stddev-sans-first:1.32 05:05:56 INFO - PROCESS | 32726 | Values: 95.0 97.0 100.0 96.0 97.0 96.0 97.0 98.0 96.0 96.0 05:05:56 INFO - PROCESS | 32726 | 05:05:56 INFO - PROCESS | 32726 | [#8] json-parse-financial Cycles:10 Average:59.60 Median:60.00 stddev:2.01 (3.4%) stddev-sans-first:2.13 05:05:56 INFO - PROCESS | 32726 | Values: 60.0 60.0 60.0 59.0 61.0 61.0 63.0 59.0 56.0 57.0 05:05:56 INFO - PROCESS | 32726 | 05:05:56 INFO - PROCESS | 32726 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 05:05:56 INFO - PROCESS | 32726 | Values: 68.0 67.0 66.0 67.0 67.0 69.0 67.0 68.0 67.0 66.0 05:05:56 INFO - PROCESS | 32726 | 05:05:56 INFO - PROCESS | 32726 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.00 stddev:3.54 (4.1%) stddev-sans-first:3.63 05:05:56 INFO - PROCESS | 32726 | Values: 84.0 84.0 86.0 86.0 93.0 85.0 84.0 84.0 93.0 86.0 05:05:56 INFO - PROCESS | 32726 | 05:05:56 INFO - PROCESS | 32726 | [#11] stanford-crypto-ccm Cycles:10 Average:119.60 Median:119.00 stddev:4.74 (4.0%) stddev-sans-first:4.94 05:05:56 INFO - PROCESS | 32726 | Values: 117.0 118.0 122.0 120.0 116.0 117.0 131.0 116.0 116.0 123.0 05:05:56 INFO - PROCESS | 32726 | 05:05:56 INFO - PROCESS | 32726 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.20 Median:154.50 stddev:7.08 (4.6%) stddev-sans-first:6.48 05:05:56 INFO - PROCESS | 32726 | Values: 142.0 153.0 151.0 161.0 152.0 149.0 160.0 158.0 156.0 140.0 05:05:56 INFO - PROCESS | 32726 | 05:05:56 INFO - PROCESS | 32726 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:68.00 stddev:4.59 (6.7%) stddev-sans-first:4.80 05:05:56 INFO - PROCESS | 32726 | Values: 67.0 82.0 68.0 68.0 68.0 69.0 68.0 69.0 66.0 67.0 05:05:56 INFO - PROCESS | 32726 | -------- Summary: end -------- 05:05:56 INFO - PROCESS | 32726 | 05:05:57 INFO - TEST-INFO | 32726: exit 0 05:05:57 INFO - TEST-OK | kraken | took 60304ms 05:05:57 INFO - TEST-START | v8_7 05:05:57 INFO - operating with platform_type : linux_ 05:05:57 INFO - Initialising browser for v8_7 test... 05:05:57 INFO - TEST-INFO | started process 550 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgUAAun/profile http://localhost:53787/getInfo.html) 05:06:01 INFO - PROCESS | 550 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 05:06:02 INFO - PROCESS | 550 | __metrics Screen width/height:1600/1200 05:06:02 INFO - PROCESS | 550 | colorDepth:24 05:06:02 INFO - PROCESS | 550 | Browser inner width/height: 1024/697 05:06:02 INFO - PROCESS | 550 | __metrics 05:06:02 INFO - PROCESS | 550 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:06:03 INFO - TEST-INFO | 550: exit 0 05:06:03 INFO - Browser initialized. 05:06:03 INFO - Running cycle 1/1 for v8_7 test... 05:06:03 INFO - TEST-INFO | started process 673 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgUAAun/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:15 INFO - PROCESS | 673 | RSS: Main: 151040000 05:06:15 INFO - PROCESS | 673 | 05:06:36 INFO - PROCESS | 673 | Cycle 1(1): loaded http://localhost:53787/tests/v8_7/run.html (next: http://localhost:53787/tests/v8_7/run.html) 05:06:37 INFO - PROCESS | 673 | RSS: Main: 147128320 05:06:37 INFO - PROCESS | 673 | 05:06:37 INFO - PROCESS | 673 | __start_tp_report 05:06:37 INFO - PROCESS | 673 | _x_x_mozilla_page_load 05:06:37 INFO - PROCESS | 673 | _x_x_mozilla_page_load_details 05:06:37 INFO - PROCESS | 673 | |i|pagename|runs| 05:06:37 INFO - PROCESS | 673 | |0;Richards;164.74464579901152 05:06:37 INFO - PROCESS | 673 | |1;DeltaBlue;187.33608092918695 05:06:37 INFO - PROCESS | 673 | |2;Encrypt;279.6420581655481 05:06:37 INFO - PROCESS | 673 | |3;Decrypt;5133.333333333333 05:06:37 INFO - PROCESS | 673 | |4;RayTrace;1062.6992561105208 05:06:37 INFO - PROCESS | 673 | |5;Earley;718.3908045977012 05:06:37 INFO - PROCESS | 673 | |6;Boyer;12072.289156626506 05:06:37 INFO - PROCESS | 673 | |7;RegExp;25250 05:06:37 INFO - PROCESS | 673 | |8;Splay;599.2040932347925 05:06:37 INFO - PROCESS | 673 | |9;NavierStokes;4845.410628019324 05:06:37 INFO - PROCESS | 673 | __end_tp_report 05:06:37 INFO - PROCESS | 673 | __startTimestamp1450789597046__endTimestamp 05:06:37 INFO - PROCESS | 673 | 05:06:37 INFO - PROCESS | 673 | ------- Summary: start ------- 05:06:37 INFO - PROCESS | 673 | Number of tests: 10 05:06:37 INFO - PROCESS | 673 | 05:06:37 INFO - PROCESS | 673 | [#0] Richards Cycles:1 Average:164.74 Median:164.74 stddev:0.00 (0.0%) 05:06:37 INFO - PROCESS | 673 | Values: 164.7 05:06:37 INFO - PROCESS | 673 | 05:06:37 INFO - PROCESS | 673 | [#1] DeltaBlue Cycles:1 Average:187.34 Median:187.34 stddev:0.00 (0.0%) 05:06:37 INFO - PROCESS | 673 | Values: 187.3 05:06:37 INFO - PROCESS | 673 | 05:06:37 INFO - PROCESS | 673 | [#2] Encrypt Cycles:1 Average:279.64 Median:279.64 stddev:0.00 (0.0%) 05:06:37 INFO - PROCESS | 673 | Values: 279.6 05:06:37 INFO - PROCESS | 673 | 05:06:37 INFO - PROCESS | 673 | [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 05:06:37 INFO - PROCESS | 673 | Values: 5133.3 05:06:37 INFO - PROCESS | 673 | 05:06:37 INFO - PROCESS | 673 | [#4] RayTrace Cycles:1 Average:1062.70 Median:1062.70 stddev:0.00 (0.0%) 05:06:37 INFO - PROCESS | 673 | Values: 1062.7 05:06:37 INFO - PROCESS | 673 | 05:06:37 INFO - PROCESS | 673 | [#5] Earley Cycles:1 Average:718.39 Median:718.39 stddev:0.00 (0.0%) 05:06:37 INFO - PROCESS | 673 | Values: 718.4 05:06:37 INFO - PROCESS | 673 | 05:06:37 INFO - PROCESS | 673 | [#6] Boyer Cycles:1 Average:12072.29 Median:12072.29 stddev:0.00 (0.0%) 05:06:37 INFO - PROCESS | 673 | Values: 12072.3 05:06:37 INFO - PROCESS | 673 | 05:06:37 INFO - PROCESS | 673 | [#7] RegExp Cycles:1 Average:25250.00 Median:25250.00 stddev:0.00 (0.0%) 05:06:37 INFO - PROCESS | 673 | Values: 25250.0 05:06:37 INFO - PROCESS | 673 | 05:06:37 INFO - PROCESS | 673 | [#8] Splay Cycles:1 Average:599.20 Median:599.20 stddev:0.00 (0.0%) 05:06:37 INFO - PROCESS | 673 | Values: 599.2 05:06:37 INFO - PROCESS | 673 | 05:06:37 INFO - PROCESS | 673 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 05:06:37 INFO - PROCESS | 673 | Values: 4845.4 05:06:37 INFO - PROCESS | 673 | -------- Summary: end -------- 05:06:37 INFO - PROCESS | 673 | 05:06:37 INFO - TEST-INFO | 673: exit 0 05:06:37 INFO - TEST-OK | v8_7 | took 40359ms 05:06:37 INFO - SUITE-END | took 1210s 05:06:38 INFO - Completed test suite (00:20:10) 05:06:38 INFO - Working with test: dromaeo_css 05:06:38 INFO - Generating results file: dromaeo_css 05:06:38 INFO - Working with test: kraken 05:06:38 INFO - Generating results file: kraken 05:06:38 INFO - javascript benchmark 05:06:38 INFO - Working with test: v8_7 05:06:38 INFO - Generating results file: v8_7 05:06:38 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:06:38 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 05:06:38 INFO - process_Request line: dromaeo_css 7015.70 graph.html#tests=[[72,64,43]] 05:06:38 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:06:38 INFO - process_Request line: kraken 1517.20 graph.html#tests=[[232,64,43]] 05:06:38 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:06:38 INFO - process_Request line: v8_7 21470.01 graph.html#tests=[[230,64,43]] 05:06:38 INFO - RETURN: dromaeo_css: 7015.70 05:06:38 INFO - RETURN: kraken: 1517.20 05:06:38 INFO - RETURN: v8_7: 21470.01 05:06:38 INFO - javascript benchmark 05:06:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3178.6980236877494, 3224.5969253843255, 3246.5130230465443, 3265.3142840003597, 3276.983615081924, 5161.767720452579, 5404.540614047811, 5425.430329815367, 5432.538234250089, 5449.836504904854, 5214.296070030545, 5291.444398338177, 5360.731963401824, 5390.6226564140525, 5465.0, 4909.312696222522, 4994.77523511441, 5063.367079115111, 5073.746312684351, 5132.717700526469, 257.3322920699138, 4859.2225243960975, 4859.805607775685, 4882.902341953177, 4994.175960966436, 4923.483034281403, 5012.498750124995, 5014.473480284572, 5020.297158397827, 5072.82245121419, 5017.9247311290355, 5026.0, 5028.547430731215, 5040.16837221858, 5076.213186956028, 4812.831550895737, 4857.295692124622, 4897.314375987365, 4962.354893863775, 5026.497350264981, 5301.098813201726, 5313.9734301328635, 5319.202119682079, 5359.705216213107, 5365.973170134163, 5859.882802343929, 5927.347991720907, 5959.940400596025, 5961.0, 5964.343922168558, 5799.971000145015, 5837.211976383176, 5903.940960590382, 5920.851978700523, 5930.258717660293, 5526.751296191641, 5537.556995440355, 5551.805686800943, 5555.916661250085, 5559.749811258503, 5854.121881717691, 5958.225430693982, 6023.789167379121, 6034.366391528914, 6034.758609655652, 5730.140478928194, 5744.310682718101, 5859.2090067841145, 5869.35437101927, 5914.615549989237, 5846.7076646167525, 5851.824445266649, 5855.736491857877, 5862.941370586324, 5891.322497912709, 5551.167324901297, 5663.971680141655, 5753.223314852441, 5777.797777077866, 5816.76732930678, 5831.096180092092, 5884.08796636522, 5888.293404791367, 5918.141869428995, 5927.555433342516, 4547.681662283609, 4566.246569316092, 4568.269076947672, 4579.107074120515, 4634.652401069933, 3971.4638523799495, 3985.123272879962, 4089.20260549196, 4101.938470922939, 4136.338185890303, 5619.213310136584, 5649.265595472562, 5667.518260947783, 5677.489025987598, 5703.144528320785, 5942.465178133989, 5958.582899197015, 5960.0761881908375, 5987.6108052976415, 5987.760489580455, 5423.186522021729, 5430.104032834538, 5500.0, 5547.140193270049, 5644.322681278273, 5035.395752509649, 5122.052420302256, 5139.229115632685, 5146.922796158061, 5151.896962060813, 6022.337542870281, 6044.093385992136, 6044.557250420937, 6045.546584006217, 6111.35830737775, 5798.362180160179, 5833.533317334688, 5877.441643043904, 5915.970420147872, 5965.850853728518, 5881.17663527098, 5951.553633477593, 5957.076653118774, 5959.791407300723, 6015.12780646795, 5627.18405831144, 5639.3232812062815, 5725.541956643542, 5725.942740572541, 5727.942720572908, 5757.136429535436, 5762.4525670061275, 5841.824745257649, 5859.794907178229, 5870.765169393177, 5737.540996720169, 5750.424957504216, 5751.1085781703905, 5757.7121143941795, 5777.2200752897825, 5707.68607726579, 5710.971445142748, 5726.169705392778, 5739.167820666064, 5755.683437410815, 5463.180522921593, 5569.415211402745, 5589.245451863946, 5664.85837854057, 5713.171590119493, 5688.943110568841, 5762.135679648086, 5820.243368362086, 5840.707964601838, 5862.794802181903, 5389.676619402849, 5696.487316141567, 5716.114002329646, 5730.08318669011, 5730.398308177581], "unit": "score", "name": "dojo.html", "value": 5369.769623646243}, {"lowerIsBetter": false, "replicates": [572.8166986564302, 592.858746912194, 602.6354055796246, 603.3182503770738, 603.3935894426102, 29437.2640683983, 30018.0, 37848.24303513928, 38141.04647383817, 38309.808450957775, 42475.57524424755, 42540.36189457153, 42583.148337033315, 42779.572204277945, 42867.57132428675, 8630.136986301351, 8879.689210877621, 8902.198802107809, 8907.931048274217, 8924.687635932743, 8594.914050859505, 8756.299496040334, 8759.95620021899, 8770.12298770121, 8774.341924355667, 8764.693235736751, 8785.38502304839, 8801.647934082628, 8849.0, 8865.911340886572, 8644.524551149685, 8746.256568191711, 8763.167499087576, 8784.692535761282, 8785.56072196394, 8649.740507784776, 8722.34582406322, 8745.125487451267, 8759.080296568833, 8761.255293300013, 39319.0, 39816.20367592661, 39836.0, 39861.60138398608, 39925.20149597021, 3069.89255376063, 3358.815265160415, 3387.3902697514436, 3726.795026273554, 3936.481987280447, 29652.70347296521, 30464.238394040105, 30498.390032199233, 30564.0, 30586.847065764752, 3421.555197824292, 3470.9479357809655, 3671.908202294964, 3725.9068523286865, 3725.9441108383394, 265732.0, 269010.0, 269099.0, 269679.1676457794, 269722.65138674376, 60144.39855601388, 60774.39225607687, 61088.64012479268, 61343.999999999105, 61412.0, 61637.69181154066, 62766.0, 65629.0, 65818.0, 71409.6429517849, 16431.589210269838, 16493.917530412273, 16546.83453165477, 16642.667146657, 16659.750103748454, 12446.937765311297, 12449.004079673785, 12479.064070194772, 12511.061670374758, 12520.1235913487, 20877.0, 21157.471063223544, 21212.469688257916, 21214.0, 21259.574808504054, 8104.0, 8258.42191046621, 8297.668093276201, 8380.16198380157, 8409.243168114777, 970.7524581231881, 982.6069572171045, 985.9507024648739, 1095.611058074388, 1155.1682788392345, 29108.0, 29194.41611167765, 29246.26884327909, 29278.268043298664, 29500.704992949795, 1052.2160990062453, 1087.8422628718793, 1108.1135091926426, 1109.8557187565564, 1156.3408856951457, 15168.0, 15280.46518371874, 15330.310136043905, 15447.922760386125, 15489.457868974532, 324853.0, 327695.0, 329180.0, 329308.0, 330520.0, 52837.0, 53179.468205318226, 53198.468015319355, 53323.20015199775, 53349.0, 1319.3930791835671, 1322.4974509686258, 1326.8208791813174, 1328.5150919914356, 1344.4890941442188, 28020.29949251285, 28989.85505072461, 28990.56514152247, 29025.85487072551, 29361.11916642504, 48051.75974120107, 48121.518784811706, 48504.0, 48600.75699621479, 48636.51363486461, 303774.0, 305470.0, 307701.0, 308391.0, 309335.0, 28301.858490707415, 28625.856870715514, 31628.367432650757, 32687.34625307528, 33280.0, 38121.61878381292, 38686.613133868304, 39225.2154956905, 39784.80107599444, 42423.36364954466, 35596.466053008706, 36202.63797361992, 36518.26963460663, 36703.81648091743, 36734.44898326581, 35025.0, 35301.29397412089, 35884.28231435409, 36226.8188659055, 36282.455763163045, 34975.65024349724, 35499.290014199054, 35672.821635892695, 35968.460473093444, 36024.459633106046, 30912.845435772677, 32652.51021234636, 32953.0, 33063.33873322568, 33333.333333333685, 24377.0, 24387.26838194857, 24761.25716228516, 24907.50184996326, 24945.75054249507], "unit": "score", "name": "ext.html", "value": 18718.21206450777}, {"lowerIsBetter": false, "replicates": [342.6950014487107, 352.4097137295033, 354.7676272041813, 355.3266559869048, 357.47094300435344, 16446.34214631415, 16913.830861691396, 17606.38377656782, 17789.7331540027, 18401.539961500937, 13504.12223205491, 15875.206239688026, 16027.278772455238, 16092.919535402336, 16305.83694163058, 4752.239641657344, 4883.438404583465, 4884.804607815701, 4898.314236006944, 4920.827771027997, 4862.756862156895, 4876.926846097312, 4895.804167833282, 4903.289023091649, 4930.211166213407, 4829.22732362822, 4973.701577905319, 5084.51697088776, 5229.843104706865, 5232.058229518685, 5089.491050894918, 5122.154844450662, 5140.4859514048485, 5161.535461808437, 5527.419620939824, 5331.706756128411, 5336.946630533723, 5345.037893179227, 5363.329583802025, 5363.410024897258, 11275.774484510346, 11335.943320283346, 11486.942565287203, 11635.534578616845, 11680.94871461564, 1982.7556114078182, 2019.6869485229813, 2160.967585486219, 2174.24988379009, 2194.7476040255415, 8755.956220218923, 9183.357164998453, 9726.36778609388, 10005.449700266483, 13196.340182990909, 1708.7693161423174, 1710.8802383833136, 1722.6124122072558, 1742.4249997500795, 1814.5826459914294, 58592.414075859124, 58616.413835861524, 62749.0, 62799.0, 63438.0, 9757.951210243904, 10121.392716437038, 10332.328398654063, 10429.5828166874, 10450.843237351446, 13259.0, 13286.601401957956, 13351.799723004162, 13396.062275640807, 13517.86482135166, 7639.541627502256, 7659.23837517363, 7688.923110768933, 7714.267144621252, 7893.329067029252, 7427.62861856905, 7477.962610186914, 7480.476366654282, 7506.249375062559, 7521.05986751656, 4462.687611867138, 4543.159515489645, 4548.226801443762, 4557.6581756368405, 4559.38448309474, 1650.9763946353337, 1719.6560687862477, 1734.1415999080536, 1789.4142963417996, 1797.730340448943, 843.8776377425239, 882.2236431939851, 888.8355654203864, 924.7126465415379, 974.3131092579714, 16722.414715484898, 16745.748813767805, 16968.23642936071, 17396.65206695859, 17723.911380443016, 905.6467977488785, 916.9587368568431, 932.305432452827, 986.2849434160177, 1077.7682798198425, 9135.132162444557, 9720.805583888425, 10450.320729152581, 10639.787204255872, 10721.195910306758, 552092.0, 560906.0, 563060.0, 565641.0, 572926.0, 83776.58111709403, 85370.57314713387, 86658.56670716606, 88228.55885720531, 88951.0, 1162.081955255339, 1175.0951767139425, 1175.2948231061466, 1181.7813704464872, 1182.6274723462082, 15107.39570417215, 15604.297806598957, 15692.76460853111, 16121.742955985937, 16170.514884553482, 34379.14052148616, 34430.65569344375, 34991.82504087565, 35182.64817351794, 35694.64305357017, 41532.1693566133, 41676.37485437781, 42516.36225456559, 43229.783851080545, 44779.0, 8803.647854085764, 9463.290253230898, 9587.808243835223, 9601.32790704672, 9607.951960240154, 11069.557217711523, 11191.99272065518, 15411.61470963235, 17713.380031698827, 18475.630487390445, 13845.307734613027, 14225.573232803032, 14260.643483912985, 14693.706125877636, 14748.852511474748, 14011.43954241819, 14331.785023224451, 14451.132932024113, 14785.704285914006, 14943.327550260481, 14241.430342786587, 14435.494757683431, 14443.35004924802, 14809.963302568716, 14817.481388151364, 8651.394402391772, 8825.735227943173, 8924.776880577778, 9168.954155229181, 9221.17009469151, 9288.396254243453, 9309.57950932776, 9337.486438245962, 14585.416583336548, 14798.0], "unit": "score", "name": "jquery.html", "value": 8613.380122748044}, {"lowerIsBetter": false, "replicates": [1496.2967405319496, 1698.3291599818072, 1723.0953749281634, 1734.835190656887, 1776.5736223306405, 7572.12920514141, 7724.884126738089, 7861.213878612136, 7932.048154221494, 7988.440809143348, 7935.206479352062, 7951.125376208613, 8021.077576078753, 8074.838503229947, 8090.474119182249, 2241.0363543676253, 2279.87460689662, 2281.0533628544217, 2281.931542053741, 2284.20052981456, 2276.7040284762957, 2308.9307320780317, 2310.722713274409, 2314.028108194554, 2319.9420014499606, 2251.5046689728315, 2264.411253074196, 2265.614845476273, 2270.738865030518, 2283.7602051784575, 2163.318554655294, 2196.9450763730874, 2221.8222542196586, 2226.5101677630896, 2251.223327951846, 2250.054976909702, 2276.237460450751, 2277.396489930153, 2285.3600991722346, 2287.0508738873345, 7630.4658673892845, 7706.807329816744, 7734.342580880632, 7740.535567865946, 7746.147923728386, 4672.836450724209, 4704.529547045302, 4707.223308154151, 4732.077244937239, 4740.265258884879, 2952.2914500519937, 2987.3195804404672, 3035.681253468398, 3050.8474576271096, 3053.0230326295596, 927.8376284150247, 930.2000279759402, 930.9767255818658, 932.3939439364467, 977.462395682379, 10598.986192623377, 10614.203934704929, 10616.150707943347, 10676.306040107369, 10729.624463143753, 3844.7116466265143, 3887.8250478728523, 3895.02624343914, 3902.921941561153, 4152.647025002848, 8485.193906578865, 8531.0, 8533.573321333908, 8558.272546833588, 8647.740567782977, 4510.887227819265, 4533.070720502289, 4538.319252112209, 4539.477960034638, 4546.318052292183, 4108.50697916246, 4141.4616099907425, 4144.979275103605, 4176.18564379943, 4177.56135605757, 3293.92947292131, 3304.0253125328086, 3322.6178989416044, 3323.4350160472777, 3381.4758712399616, 1055.0978913029403, 1057.391999600233, 1059.8516207730925, 1062.2988827373897, 1071.7856428714288, 957.8371676814958, 1012.9088382045651, 1015.7359086637528, 1127.3179726265655, 1276.974460510803, 7143.857122857514, 7146.213916469184, 7211.062561867028, 7240.167380751176, 7265.745698900513, 1194.707296712311, 1229.3484453239798, 1234.5000274888685, 1237.3874931908763, 1237.9442925068392, 5694.174344719992, 5865.2961644602065, 5887.941120588825, 5893.440123188376, 5909.438603332676, 9269.073092690676, 9333.533323333806, 9562.235021198287, 9565.282603804742, 9591.376560523544, 9299.256059515223, 9326.860097098548, 9338.953305233566, 9356.625734970525, 9484.573194206278, 7125.92874071263, 7208.819779505554, 7251.274872512707, 7307.1231452226075, 7375.704971801175, 7000.0, 7024.121984751906, 7043.647817608997, 7052.188998265266, 7060.929390706233, 8160.061592916891, 8386.161383861809, 8386.538740369338, 8438.240558349533, 8529.658813647384, 8404.579771011302, 8583.098774628574, 8618.008928973248, 8677.349198809989, 8711.303095752452, 6956.40870526011, 7004.474664400293, 7011.474139439664, 7037.648117593997, 7100.112485939258, 7346.6326683666675, 7388.741394051182, 7408.073990751156, 7429.628518574158, 7475.7009719610605, 6740.292269311652, 6833.4191593715095, 6910.239873613999, 6928.1339832520935, 7151.070360853056, 6828.5902845829405, 6944.791656250321, 6966.3730264276455, 7004.579725216503, 7098.893516597152, 6862.691178896862, 6881.724731010703, 6917.100776898971, 6960.721571137098, 6961.37347638715, 6424.743010279536, 6445.065465507569, 6454.838629034311, 6474.514411419068, 6480.254770701241, 6171.043488259327, 6259.092431597484, 6324.873502530016, 6377.23473183221, 6457.0637257596445], "unit": "score", "name": "mootools.html", "value": 4438.193922353804}, {"lowerIsBetter": false, "replicates": [321.67189466743935, 325.78335406954375, 333.4331636218429, 334.5049326996046, 340.10043435114113, 6252.593581417204, 6289.7484100635975, 6298.0552917062405, 6316.368363163681, 6319.6524191169465, 6125.479334256594, 6239.532035097363, 6263.7494500220055, 6269.185005949232, 6278.686065696708, 4752.643551733617, 4769.236922092466, 4777.092352453023, 4778.450478195, 4796.880077998052, 4774.140654682155, 4775.594074503671, 4780.976095119519, 4782.330473733663, 4806.038792241566, 4651.767411629422, 4749.952500475003, 4767.713937163781, 4773.212419950704, 4775.021120670272, 4714.622830173578, 4741.573258406743, 4743.0, 4743.928841067404, 4749.358836557055, 4124.05146816234, 4134.028503301722, 4135.152293779768, 4145.233131870584, 4163.3130533461945, 5970.791022314198, 5981.9401805981815, 5999.400059994009, 6005.369436209223, 6033.366496517846, 5345.4387289334445, 5516.531094856942, 5529.391766905637, 5537.390887002467, 5547.306586676666, 6658.966705166443, 6665.200175978914, 6673.599584024974, 6679.632620205887, 6684.331566843277, 4585.082983403299, 4585.380973568559, 4586.1744885920525, 4588.426446694163, 4594.2419500782335, 6810.489213309022, 6960.825979350506, 6972.058772065757, 6972.686229119651, 6974.686139123752, 4676.392069031004, 4678.461976872635, 4681.087187998308, 4684.976575117103, 4710.81156753726, 4730.337752714623, 4730.929036064462, 4735.337052812609, 4742.170120228946, 4768.022555376139, 5519.475649813261, 5522.006038912954, 5528.364238112588, 5529.944700553024, 5536.474034966672, 6612.801615951529, 6615.305392933769, 6631.502637302222, 6691.364320389555, 6699.732010719614, 1593.8884278100654, 1626.4470080172798, 1631.600257936813, 1633.8937969031974, 1663.193351224655, 1067.7384040910026, 1071.464267866067, 1075.0593230922943, 1079.3416016230094, 1089.2429761315968, 6383.138276332728, 6414.775482858171, 6431.0, 6451.387118223761, 6459.354064593597, 6780.1524809398825, 6784.966075169593, 6813.965930170417, 6850.623215723183, 6851.07510486088, 6309.652969086745, 6351.333110023381, 6381.1704478417505, 6419.871602567922, 6420.678966051679, 3759.7180211484247, 3778.3576791945434, 3780.773153610737, 3783.754055986352, 3790.7156963227867, 7164.749233776793, 7181.856362872713, 7193.208747037822, 7201.4238860891, 7212.062431883926, 7045.577265364094, 7184.389326907271, 7193.352598266181, 7196.64016799158, 7219.169795473483, 7157.821054473679, 7178.425725941807, 7178.60517671533, 7180.856382872418, 7183.62940229723, 6934.0, 6981.127359080115, 6984.301569842975, 6990.720371185095, 7001.474889383215, 6800.115984921928, 6876.518643694893, 6884.4148247399535, 6922.10012698346, 6941.791746247621, 7152.821179470555, 7172.211056783854, 7215.963920180366, 7217.67520461591, 7223.061002069908, 4573.5426457354, 4589.495155532822, 4618.815247390066, 4638.93041604383, 4642.883927901695, 6862.622555759481, 6957.060796792368, 6965.65171741421, 6975.581465112109, 6984.755533556301, 6787.287334829772, 6790.66046697673, 6790.72837086511, 6796.116504854337, 6807.523473356818, 6681.164854393201, 6709.329067093252, 6752.426043786137, 6759.222689390586, 6770.966145169243, 6535.052417399545, 6611.669416529058, 6642.767503137367, 6645.60126392418, 6657.966710166418, 6783.18601767791, 6785.830354240986, 6793.0, 6794.082798822095, 6806.353396427331, 6626.469882409492, 6653.367930046637, 6664.500162487736, 6666.83332916681, 6683.7660681875905], "unit": "score", "name": "prototype.html", "value": 5017.31399803412}, {"lowerIsBetter": false, "replicates": [726.749271501332, 783.9137694853565, 809.2433574607742, 836.6736972580699, 873.4453621950064, 12464.127511074217, 12729.045321600894, 12734.490620375196, 12764.297963612009, 12780.744385112304, 12659.430325635345, 13017.28404937728, 13037.804432933513, 14647.414103435849, 14658.047226930243, 797.4617133434923, 810.8094597769519, 811.0267678785451, 813.9064007639138, 814.2997022560593, 799.5003123048095, 808.454293351988, 810.3881569415083, 810.8256724804166, 811.6509900742678, 851.7061613743249, 858.8582883824162, 867.4491697771929, 867.6312567158964, 870.412471581683, 851.7402192331336, 852.5055467828676, 854.171453689926, 855.8545047341936, 857.6269322844582, 627.6579264300967, 634.2294112653102, 635.8156134720925, 636.0776873533349, 636.4208570201095, 12498.125131240817, 12601.810972835416, 12662.873371266354, 12686.302253376061, 12697.365131743376, 11582.18924675273, 11593.420328983602, 11926.224795388272, 12308.199967002205, 12373.381330933418, 9639.228861691117, 9666.854997175047, 9724.854127188099, 9771.267154963407, 9789.21686265097, 3316.303576248991, 3418.538497302882, 3452.7928324300624, 3483.825808709554, 3555.9111022224392, 41562.0, 43709.34435983463, 44432.111357772665, 47999.28001079986, 48093.0, 8979.820403591892, 9141.405808622418, 9341.626334946663, 9396.859047114298, 9510.572024258925, 19199.616007680048, 19577.0, 19868.205271788967, 19903.0, 19904.0, 6959.4432445404245, 6991.405730512862, 7273.818154546178, 7522.473426860177, 7591.316781489692, 3780.1494663700996, 3845.7115716321387, 3860.1121741998936, 3864.806759662006, 3927.489426374553, 3025.9848700756797, 3040.5439184122115, 3066.632004159515, 3067.693230676959, 3069.1713237426216, 534.599050711966, 544.6214880657984, 545.6671430427436, 547.7507733981029, 548.4131978782744, 633.8922383194868, 686.145748543067, 690.102866273842, 702.5363260248314, 712.3287671232877, 8157.0, 8694.565271736388, 8857.468551886908, 9135.954320228357, 9235.215006724504, 626.8119564130742, 684.1967362233733, 690.4890381117937, 698.4063545985973, 702.367868917978, 3923.1708228494217, 3993.5806740292433, 4058.370952502367, 4073.714839961174, 4121.340585506305, 54574.72712636491, 54748.45251547513, 54753.45246547484, 54829.0, 55846.0, 49195.50804491981, 50013.74993125011, 50505.74747126241, 50621.240681389805, 50639.49360506421, 44571.77714111473, 46738.532614674776, 48045.75977120092, 49655.034496550055, 51177.0, 7966.3626909848235, 8320.334373250247, 8357.791055223424, 8479.32165426752, 8491.448055876348, 34638.65361346455, 34705.13237169091, 35630.821845890605, 35867.28265434624, 35880.820595896854, 40583.1883362337, 44052.55947440613, 44664.77667611641, 45347.54652453433, 45405.0, 11194.83207751868, 11207.831882521932, 11440.771184576428, 11685.591004315149, 11850.348230847387, 11331.603393881174, 11526.962573368437, 11584.304941703525, 12190.51237950472, 12310.630681079581, 10403.375797452178, 10414.687559373231, 10641.840372394265, 10720.892791072301, 10740.0, 10576.735581610521, 10594.152467802403, 10614.043775378703, 10784.299020563638, 10859.837102443627, 10549.0, 10746.408947507962, 10754.085902698045, 10781.460926953465, 10917.344959302149, 8731.956340218258, 8868.423552469068, 8953.507557084162, 9015.14356136166, 9395.906040939502, 8564.186402291773, 8687.348448866234, 8696.78258043554, 8824.647014119364, 8974.506402147945], "unit": "score", "name": "yui.html", "value": 6184.684736806392}], "name": "dromaeo_css", "value": 7015.701074833467}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 111.0, 112.0, 111.0, 124.0, 110.0, 110.0, 113.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.0}, {"lowerIsBetter": true, "replicates": [155.0, 122.0, 150.0, 166.0, 127.0, 155.0, 156.0, 126.0, 166.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 144.7}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 163.0, 164.0, 164.0, 165.0, 162.0, 165.0, 168.0, 166.0], "unit": "score", "name": "audio-dft", "value": 164.3}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 73.0, 79.0, 71.0, 129.0, 72.0, 77.0, 71.0, 82.0], "unit": "score", "name": "audio-fft", "value": 79.6}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 145.0, 95.0, 94.0, 94.0, 141.0, 94.0, 94.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 108.2}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 111.0, 110.0, 111.0, 110.0, 110.0, 110.0, 111.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [149.0, 147.0, 146.0, 147.0, 147.0, 147.0, 148.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 100.0, 96.0, 97.0, 96.0, 97.0, 98.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 60.0, 59.0, 61.0, 61.0, 63.0, 59.0, 56.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.6}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 66.0, 67.0, 67.0, 69.0, 67.0, 68.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 86.0, 86.0, 93.0, 85.0, 84.0, 84.0, 93.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 122.0, 120.0, 116.0, 117.0, 131.0, 116.0, 116.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.6}, {"lowerIsBetter": true, "replicates": [142.0, 153.0, 151.0, 161.0, 152.0, 149.0, 160.0, 158.0, 156.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.2}, {"lowerIsBetter": true, "replicates": [67.0, 82.0, 68.0, 68.0, 68.0, 69.0, 68.0, 69.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1517.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.74464579901152], "unit": "score", "name": "Richards", "value": 214.28313999999997}, {"lowerIsBetter": false, "replicates": [187.33608092918695], "unit": "score", "name": "DeltaBlue", "value": 352.9378840000001}, {"lowerIsBetter": false, "replicates": [279.6420581655481], "unit": "score", "name": "Encrypt", "value": 951.8632560000003}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [1062.6992561105208], "unit": "score", "name": "RayTrace", "value": 696.3296489999998}, {"lowerIsBetter": false, "replicates": [718.3908045977012], "unit": "score", "name": "Earley", "value": 927.7164960000002}, {"lowerIsBetter": false, "replicates": [12072.289156626506], "unit": "score", "name": "Boyer", "value": 55.20601696606782}, {"lowerIsBetter": false, "replicates": [25250.0], "unit": "score", "name": "RegExp", "value": 36.07861386138617}, {"lowerIsBetter": false, "replicates": [599.2040932347925], "unit": "score", "name": "Splay", "value": 135.99873719165092}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21470.013131940388}]} 05:06:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21470.01"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1517.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "7015.70"}}} 05:06:38 INFO - Return code: 0 05:06:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:06:38 INFO - # TBPL SUCCESS # 05:06:38 INFO - Running post-action listener: _resource_record_post_action 05:06:38 INFO - Running post-run listener: _resource_record_post_run 05:06:39 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 53248; Write bytes: 556662784; Read time: 276; Write time: 675376 05:06:39 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 8192; Write bytes: 234258432; Read time: 208; Write time: 311620 05:06:39 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 45056; Write bytes: 321527808; Read time: 68; Write time: 363712 05:06:39 INFO - Running post-run listener: _upload_blobber_files 05:06:39 INFO - Blob upload gear active. 05:06:39 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:06:39 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 05:06:39 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:06:39 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:06:39 INFO - (blobuploader) - INFO - Open directory for files ... 05:06:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:06:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:06:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:40 INFO - (blobuploader) - INFO - Done attempting. 05:06:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:06:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:06:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:41 INFO - (blobuploader) - INFO - Done attempting. 05:06:41 INFO - (blobuploader) - INFO - Iteration through files over. 05:06:41 INFO - Return code: 0 05:06:41 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:06:41 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:06:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/964611c50252c9333ebaf30f8bd8753ab83e0b123edb275ac1d9d5436ef470f544c2661dbfda450b8104ca0300c875117990ad8784688d81830c41769226fd92", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85e235181f0a415e8e4a5ce3918a6d32b3b8d02cb6128949c96f5e7c4341a91dc64c68246ab124bfb1032e7876958db4c4b3199514144b479a07b8377e322541"} 05:06:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:06:41 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:06:41 INFO - Contents: 05:06:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/964611c50252c9333ebaf30f8bd8753ab83e0b123edb275ac1d9d5436ef470f544c2661dbfda450b8104ca0300c875117990ad8784688d81830c41769226fd92", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85e235181f0a415e8e4a5ce3918a6d32b3b8d02cb6128949c96f5e7c4341a91dc64c68246ab124bfb1032e7876958db4c4b3199514144b479a07b8377e322541"} 05:06:41 INFO - Copying logs to upload dir... 05:06:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1271.321077 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-22 05:06:41.595382) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 05:06:41.598761) ========= 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=0ae9de487587ba4b94dd3100000001b5-1450786282.479835-1387323542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/964611c50252c9333ebaf30f8bd8753ab83e0b123edb275ac1d9d5436ef470f544c2661dbfda450b8104ca0300c875117990ad8784688d81830c41769226fd92", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85e235181f0a415e8e4a5ce3918a6d32b3b8d02cb6128949c96f5e7c4341a91dc64c68246ab124bfb1032e7876958db4c4b3199514144b479a07b8377e322541"} build_url:https://queue.taskcluster.net/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011130 build_url: 'https://queue.taskcluster.net/v1/task/baDmyByETJyFend27IV-Og/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/964611c50252c9333ebaf30f8bd8753ab83e0b123edb275ac1d9d5436ef470f544c2661dbfda450b8104ca0300c875117990ad8784688d81830c41769226fd92", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85e235181f0a415e8e4a5ce3918a6d32b3b8d02cb6128949c96f5e7c4341a91dc64c68246ab124bfb1032e7876958db4c4b3199514144b479a07b8377e322541"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 05:06:41.646195) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:06:41.646585) ========= 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=0ae9de487587ba4b94dd3100000001b5-1450786282.479835-1387323542 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 05:06:41.784106) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 05:06:41.784550) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 05:06:41.784841) ========= ========= Total master_lag: 0.34 =========