builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1451501604.71 results: success (0) buildid: 20151230083144 builduid: 627f3cd32a8e42d098d5604938d0abb2 revision: 9e210cee056b1a3d213198b4e38679612b0bb0bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:24.712498) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:24.712942) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:24.713239) ========= 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=004b26eee9c3b360c8654f40000001e1-1451500756.237345-302742272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006312 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:24.764489) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:24.764797) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:24.834592) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:24.834917) ========= 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=004b26eee9c3b360c8654f40000001e1-1451500756.237345-302742272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004582 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:24.908751) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:24.909053) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:24.909423) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:24.909913) ========= 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=004b26eee9c3b360c8654f40000001e1-1451500756.237345-302742272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-30 10:53:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2015-12-30 10:53:25 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102358 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:25.043150) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:25.043434) ========= 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=004b26eee9c3b360c8654f40000001e1-1451500756.237345-302742272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014580 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:25.093882) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:25.094301) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9e210cee056b1a3d213198b4e38679612b0bb0bc --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 9e210cee056b1a3d213198b4e38679612b0bb0bc --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=004b26eee9c3b360c8654f40000001e1-1451500756.237345-302742272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-30 10:53:25,352 truncating revision to first 12 chars 2015-12-30 10:53:25,352 Setting DEBUG logging. 2015-12-30 10:53:25,352 attempt 1/10 2015-12-30 10:53:25,352 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9e210cee056b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-30 10:53:25,790 unpacking tar archive at: fx-team-9e210cee056b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.724161 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:25.831693) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:25.832016) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:25.851952) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:25.852297) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 10:53:25.852724) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-30 10:53:25.853028) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --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', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--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=004b26eee9c3b360c8654f40000001e1-1451500756.237345-302742272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:53:26 INFO - MultiFileLogger online at 20151230 10:53:26 in /builds/slave/test-pgo 10:53:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:53:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:53:26 INFO - {'append_to_log': False, 10:53:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:53:26 INFO - 'blob_upload_branch': 'Fx-Team', 10:53:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:53:26 INFO - 'branch': 'Fx-Team', 10:53:26 INFO - 'buildbot_json_path': 'buildprops.json', 10:53:26 INFO - 'config_files': ('talos/linux_config.py',), 10:53:26 INFO - 'default_actions': ('clobber', 10:53:26 INFO - 'read-buildbot-config', 10:53:26 INFO - 'download-and-extract', 10:53:26 INFO - 'populate-webroot', 10:53:26 INFO - 'create-virtualenv', 10:53:26 INFO - 'install', 10:53:26 INFO - 'run-tests'), 10:53:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:53:26 INFO - 'download_minidump_stackwalk': True, 10:53:26 INFO - 'download_symbols': 'ondemand', 10:53:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:53:26 INFO - 'tooltool.py': '/tools/tooltool.py', 10:53:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:53:26 INFO - '/tools/misc-python/virtualenv.py')}, 10:53:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:53:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:53:26 INFO - 'installer_path': 'installer.exe', 10:53:26 INFO - 'log_level': 'info', 10:53:26 INFO - 'log_name': 'talos', 10:53:26 INFO - 'log_to_console': True, 10:53:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:53:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:53:26 INFO - 'opt_config_files': (), 10:53:26 INFO - 'pip_index': False, 10:53:26 INFO - 'sps_profile': False, 10:53:26 INFO - 'sps_profile_interval': 0, 10:53:26 INFO - 'suite': 'dromaeojs', 10:53:26 INFO - 'system_bits': '32', 10:53:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:53:26 INFO - 'title': 'talos-linux64-ix-066', 10:53:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:53:26 INFO - 'use_talos_json': True, 10:53:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:53:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:53:26 INFO - 'work_dir': 'build'} 10:53:26 INFO - ##### 10:53:26 INFO - ##### Running clobber step. 10:53:26 INFO - ##### 10:53:26 INFO - Running pre-action listener: _resource_record_pre_action 10:53:26 INFO - Running main action method: clobber 10:53:26 INFO - rmtree: /builds/slave/test-pgo/build 10:53:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:53:26 INFO - Running post-action listener: _resource_record_post_action 10:53:26 INFO - ##### 10:53:26 INFO - ##### Running read-buildbot-config step. 10:53:26 INFO - ##### 10:53:26 INFO - Running pre-action listener: _resource_record_pre_action 10:53:26 INFO - Running main action method: read_buildbot_config 10:53:26 INFO - Using buildbot properties: 10:53:26 INFO - { 10:53:26 INFO - "project": "", 10:53:26 INFO - "product": "firefox", 10:53:26 INFO - "script_repo_revision": "production", 10:53:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:53:26 INFO - "repository": "", 10:53:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 10:53:26 INFO - "buildid": "20151230083144", 10:53:26 INFO - "pgo_build": "True", 10:53:26 INFO - "basedir": "/builds/slave/test-pgo", 10:53:26 INFO - "buildnumber": 861, 10:53:26 INFO - "slavename": "talos-linux64-ix-066", 10:53:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:53:26 INFO - "platform": "ubuntu64_hw", 10:53:26 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:53:26 INFO - "branch": "fx-team", 10:53:26 INFO - "repo_path": "integration/fx-team", 10:53:26 INFO - "revision": "9e210cee056b1a3d213198b4e38679612b0bb0bc", 10:53:26 INFO - "stage_platform": "linux64-pgo", 10:53:26 INFO - "builduid": "627f3cd32a8e42d098d5604938d0abb2", 10:53:26 INFO - "slavebuilddir": "test" 10:53:26 INFO - } 10:53:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:53:26 INFO - Running post-action listener: _resource_record_post_action 10:53:26 INFO - ##### 10:53:26 INFO - ##### Running download-and-extract step. 10:53:26 INFO - ##### 10:53:26 INFO - Running pre-action listener: _resource_record_pre_action 10:53:26 INFO - Running main action method: download_and_extract 10:53:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:26 INFO - https://queue.taskcluster.net/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:53:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/test_packages.json 10:53:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/test_packages.json 10:53:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:53:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:53:35 INFO - Downloaded 1302 bytes. 10:53:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:53:35 INFO - Using the following test package requirements: 10:53:35 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:53:35 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:53:35 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:35 INFO - u'jsshell-linux-x86_64.zip'], 10:53:35 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:53:35 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:53:35 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:53:35 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:53:35 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:53:35 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:53:35 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:53:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:53:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:35 INFO - https://queue.taskcluster.net/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:53:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:53:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:53:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:53:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:53:37 INFO - Downloaded 23202480 bytes. 10:53: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 10:53:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:53: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 10:53:38 INFO - Return code: 0 10:53:38 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:38 INFO - https://queue.taskcluster.net/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:53:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:53:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:53:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:53:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:53:41 INFO - Downloaded 23202480 bytes. 10:53:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:53:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:53:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:53:42 INFO - Return code: 0 10:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:42 INFO - https://queue.taskcluster.net/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:53:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:53:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:53:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:53:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:53:43 INFO - Downloaded 11132285 bytes. 10:53: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 10:53:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:53: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 10:53:43 INFO - Return code: 0 10:53: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')]} 10:53:43 INFO - https://queue.taskcluster.net/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:53:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:53:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:53:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:53:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:53:44 INFO - Downloaded 54953841 bytes. 10:53:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:53:44 INFO - mkdir: /builds/slave/test-pgo/properties 10:53:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:53:44 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:53:44 INFO - Contents: 10:53:44 INFO - build_url:https://queue.taskcluster.net/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:53:44 INFO - Running post-action listener: _resource_record_post_action 10:53:44 INFO - Running post-action listener: set_extra_try_arguments 10:53:44 INFO - ##### 10:53:44 INFO - ##### Running populate-webroot step. 10:53:44 INFO - ##### 10:53:44 INFO - Running pre-action listener: _resource_record_pre_action 10:53:44 INFO - Running main action method: populate_webroot 10:53:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:53:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:53:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:53:44 INFO - '--tppagecycles', 10:53:44 INFO - '7'], 10:53:44 INFO - 'tests': ['tsvgm']}}, 10:53:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:53:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:53:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:53:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:53:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:53:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:53:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:44 INFO - 'talos_options': ['--e10s'], 10:53:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:44 INFO - 'tests': ['damp', 'tps']}, 10:53:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:44 INFO - 'talos_options': ['--e10s'], 10:53:44 INFO - 'tests': ['damp', 'tps']}, 10:53:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:53:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:53:44 INFO - 'other': {'tests': ['a11yr', 10:53:44 INFO - 'ts_paint', 10:53:44 INFO - 'tpaint', 10:53:44 INFO - 'sessionrestore', 10:53:44 INFO - 'sessionrestore_no_auto_restore']}, 10:53:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:53:44 INFO - 'tests': ['a11yr', 10:53:44 INFO - 'ts_paint', 10:53:44 INFO - 'tpaint', 10:53:44 INFO - 'sessionrestore', 10:53:44 INFO - 'sessionrestore_no_auto_restore']}, 10:53:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:53:44 INFO - 'tests': ['a11yr', 10:53:44 INFO - 'ts_paint', 10:53:44 INFO - 'tpaint', 10:53:44 INFO - 'sessionrestore', 10:53:44 INFO - 'sessionrestore_no_auto_restore']}, 10:53:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:53:44 INFO - 'tests': ['a11yr', 10:53:44 INFO - 'ts_paint', 10:53:44 INFO - 'tpaint', 10:53:44 INFO - 'sessionrestore', 10:53:44 INFO - 'sessionrestore_no_auto_restore']}, 10:53:44 INFO - 'other_l64': {'tests': ['a11yr', 10:53:44 INFO - 'ts_paint', 10:53:44 INFO - 'tpaint', 10:53:44 INFO - 'sessionrestore', 10:53:44 INFO - 'sessionrestore_no_auto_restore']}, 10:53:44 INFO - 'other_nol64': {'tests': ['a11yr', 10:53:44 INFO - 'ts_paint', 10:53:44 INFO - 'tpaint', 10:53:44 INFO - 'sessionrestore', 10:53:44 INFO - 'sessionrestore_no_auto_restore']}, 10:53:44 INFO - 'svgr': {'tests': ['tsvgx', 10:53:44 INFO - 'tsvgr_opacity', 10:53:44 INFO - 'tart', 10:53:44 INFO - 'tscrollx', 10:53:44 INFO - 'cart']}, 10:53:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:53:44 INFO - 'tests': ['tsvgx', 10:53:44 INFO - 'tsvgr_opacity', 10:53:44 INFO - 'tart', 10:53:44 INFO - 'tscrollx', 10:53:44 INFO - 'cart']}, 10:53:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:44 INFO - 'tests': ['tp5o']}, 10:53:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:44 INFO - 'talos_options': ['--e10s'], 10:53:44 INFO - 'tests': ['tp5o']}, 10:53:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:44 INFO - 'talos_options': ['--xperf_path', 10:53:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:44 INFO - 'tests': ['tp5n']}, 10:53:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:44 INFO - 'talos_options': ['--e10s', 10:53:44 INFO - '--xperf_path', 10:53:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:44 INFO - 'tests': ['tp5n']}}, 10:53:44 INFO - 'talos.zip': {'path': '', 10:53:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:53:44 INFO - Running post-action listener: _resource_record_post_action 10:53:44 INFO - ##### 10:53:44 INFO - ##### Running create-virtualenv step. 10:53:44 INFO - ##### 10:53:44 INFO - Running pre-action listener: _resource_record_pre_action 10:53:44 INFO - Running main action method: create_virtualenv 10:53:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:53:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 10:53:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:53:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:53:45 INFO - Using real prefix '/usr' 10:53:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:53:45 INFO - Installing distribute.............................................................................................................................................................................................done. 10:53:47 INFO - Installing pip.................done. 10:53:47 INFO - Return code: 0 10:53:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab3dfecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ce630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115f840>, '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 0x10cc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccb60>, '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': '004b26eee9c3b360c8654f40000001e1-1451500756.237345-302742272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:53:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 10:53:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:53:47 INFO - Using env: {'DISPLAY': ':0', 10:53:47 INFO - 'HOME': '/home/cltbld', 10:53:47 INFO - 'LANG': 'en_US.UTF-8', 10:53:47 INFO - 'LANGUAGE': 'en_US:en', 10:53:47 INFO - 'LOGNAME': 'cltbld', 10:53:47 INFO - 'MAIL': '/var/mail/cltbld', 10:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:47 INFO - 'MOZ_NO_REMOTE': '1', 10:53:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:47 INFO - 'NO_EM_RESTART': '1', 10:53:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:47 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:47 INFO - 'SHELL': '/bin/bash', 10:53:47 INFO - 'SHLVL': '1', 10:53:47 INFO - 'TERM': 'linux', 10:53:47 INFO - 'TMOUT': '86400', 10:53:47 INFO - 'USER': 'cltbld', 10:53:47 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1451500756.237345-302742272', 10:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:47 INFO - '_': '/tools/buildbot/bin/python'} 10:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:53:47 INFO - Cleaning up... 10:53:47 INFO - Return code: 0 10:53:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab3dfecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ce630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115f840>, '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 0x10cc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccb60>, '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': '004b26eee9c3b360c8654f40000001e1-1451500756.237345-302742272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:53:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 10:53:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:53:47 INFO - Using env: {'DISPLAY': ':0', 10:53:47 INFO - 'HOME': '/home/cltbld', 10:53:47 INFO - 'LANG': 'en_US.UTF-8', 10:53:47 INFO - 'LANGUAGE': 'en_US:en', 10:53:47 INFO - 'LOGNAME': 'cltbld', 10:53:47 INFO - 'MAIL': '/var/mail/cltbld', 10:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:47 INFO - 'MOZ_NO_REMOTE': '1', 10:53:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:47 INFO - 'NO_EM_RESTART': '1', 10:53:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:47 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:47 INFO - 'SHELL': '/bin/bash', 10:53:47 INFO - 'SHLVL': '1', 10:53:47 INFO - 'TERM': 'linux', 10:53:47 INFO - 'TMOUT': '86400', 10:53:47 INFO - 'USER': 'cltbld', 10:53:47 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1451500756.237345-302742272', 10:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:47 INFO - '_': '/tools/buildbot/bin/python'} 10:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:47 INFO - Downloading/unpacking psutil>=0.7.1 10:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:49 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:53:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:53:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:53:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:53:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:53:49 INFO - Installing collected packages: psutil 10:53:49 INFO - Running setup.py install for psutil 10:53:49 INFO - building 'psutil._psutil_linux' extension 10:53:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:53:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:53:50 INFO - building 'psutil._psutil_posix' extension 10:53:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:53:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:53:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:53:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:53:50 INFO - Successfully installed psutil 10:53:50 INFO - Cleaning up... 10:53:50 INFO - Return code: 0 10:53:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab3dfecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ce630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115f840>, '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 0x10cc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccb60>, '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': '004b26eee9c3b360c8654f40000001e1-1451500756.237345-302742272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:53:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:53:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:53:50 INFO - Using env: {'DISPLAY': ':0', 10:53:50 INFO - 'HOME': '/home/cltbld', 10:53:50 INFO - 'LANG': 'en_US.UTF-8', 10:53:50 INFO - 'LANGUAGE': 'en_US:en', 10:53:50 INFO - 'LOGNAME': 'cltbld', 10:53:50 INFO - 'MAIL': '/var/mail/cltbld', 10:53:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:50 INFO - 'MOZ_NO_REMOTE': '1', 10:53:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:50 INFO - 'NO_EM_RESTART': '1', 10:53:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:50 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:50 INFO - 'SHELL': '/bin/bash', 10:53:50 INFO - 'SHLVL': '1', 10:53:50 INFO - 'TERM': 'linux', 10:53:50 INFO - 'TMOUT': '86400', 10:53:50 INFO - 'USER': 'cltbld', 10:53:50 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1451500756.237345-302742272', 10:53:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:50 INFO - '_': '/tools/buildbot/bin/python'} 10:53:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:53:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:53:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:53:52 INFO - Installing collected packages: mozsystemmonitor 10:53:52 INFO - Running setup.py install for mozsystemmonitor 10:53:52 INFO - Successfully installed mozsystemmonitor 10:53:52 INFO - Cleaning up... 10:53:52 INFO - Return code: 0 10:53:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:53: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')]} 10:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53: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')]} 10:53:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab3dfecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ce630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115f840>, '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 0x10cc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccb60>, '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': '004b26eee9c3b360c8654f40000001e1-1451500756.237345-302742272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:53:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 10:53:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:53:52 INFO - Using env: {'DISPLAY': ':0', 10:53:52 INFO - 'HOME': '/home/cltbld', 10:53:52 INFO - 'LANG': 'en_US.UTF-8', 10:53:52 INFO - 'LANGUAGE': 'en_US:en', 10:53:52 INFO - 'LOGNAME': 'cltbld', 10:53:52 INFO - 'MAIL': '/var/mail/cltbld', 10:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:52 INFO - 'MOZ_NO_REMOTE': '1', 10:53:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:52 INFO - 'NO_EM_RESTART': '1', 10:53:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:52 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:52 INFO - 'SHELL': '/bin/bash', 10:53:52 INFO - 'SHLVL': '1', 10:53:52 INFO - 'TERM': 'linux', 10:53:52 INFO - 'TMOUT': '86400', 10:53:52 INFO - 'USER': 'cltbld', 10:53:52 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1451500756.237345-302742272', 10:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:52 INFO - '_': '/tools/buildbot/bin/python'} 10:53:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:52 INFO - Downloading/unpacking blobuploader==1.2.4 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53:54 INFO - Downloading blobuploader-1.2.4.tar.gz 10:53:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:53:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:53:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:53:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:53:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53:54 INFO - Downloading docopt-0.6.1.tar.gz 10:53:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:53:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:53:55 INFO - Installing collected packages: blobuploader, requests, docopt 10:53:55 INFO - Running setup.py install for blobuploader 10:53:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:53:55 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:53:55 INFO - Running setup.py install for requests 10:53:55 INFO - Running setup.py install for docopt 10:53:55 INFO - Successfully installed blobuploader requests docopt 10:53:55 INFO - Cleaning up... 10:53:55 INFO - Return code: 0 10:53:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:55 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 0x7fab3dfecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ce630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115f840>, '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 0x10cc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccb60>, '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': '004b26eee9c3b360c8654f40000001e1-1451500756.237345-302742272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:53:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 10:53:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:53:55 INFO - Using env: {'DISPLAY': ':0', 10:53:55 INFO - 'HOME': '/home/cltbld', 10:53:55 INFO - 'LANG': 'en_US.UTF-8', 10:53:55 INFO - 'LANGUAGE': 'en_US:en', 10:53:55 INFO - 'LOGNAME': 'cltbld', 10:53:55 INFO - 'MAIL': '/var/mail/cltbld', 10:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:55 INFO - 'MOZ_NO_REMOTE': '1', 10:53:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:55 INFO - 'NO_EM_RESTART': '1', 10:53:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:55 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:55 INFO - 'SHELL': '/bin/bash', 10:53:55 INFO - 'SHLVL': '1', 10:53:55 INFO - 'TERM': 'linux', 10:53:55 INFO - 'TMOUT': '86400', 10:53:55 INFO - 'USER': 'cltbld', 10:53:55 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1451500756.237345-302742272', 10:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:55 INFO - '_': '/tools/buildbot/bin/python'} 10:53:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:53:55 INFO - Running setup.py (path:/tmp/pip-i0vAZU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:53:55 INFO - Running setup.py (path:/tmp/pip-wY_KgF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:53:55 INFO - Running setup.py (path:/tmp/pip-CnUioH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:53:56 INFO - Running setup.py (path:/tmp/pip-mJ_8KN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:53:56 INFO - Running setup.py (path:/tmp/pip-4TNII_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:53:56 INFO - Running setup.py (path:/tmp/pip-ugMN_l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:53:56 INFO - Running setup.py (path:/tmp/pip-AnVPwo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:53:56 INFO - Running setup.py (path:/tmp/pip-D0uxo7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:53:56 INFO - Running setup.py (path:/tmp/pip-c8_R3D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:53:56 INFO - Running setup.py (path:/tmp/pip-4i5pkn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:53:56 INFO - Running setup.py (path:/tmp/pip-ztrtS2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:53:56 INFO - Running setup.py (path:/tmp/pip-9MLwDv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:53:56 INFO - Running setup.py (path:/tmp/pip-4eBpu4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:53:56 INFO - Running setup.py (path:/tmp/pip-6md1b3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:53:56 INFO - Running setup.py (path:/tmp/pip-Mz2beW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:53:56 INFO - Running setup.py (path:/tmp/pip-zG_blr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:53:56 INFO - Running setup.py (path:/tmp/pip-4kQe4g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:53:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:53:57 INFO - Running setup.py install for manifestparser 10:53:57 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:53:57 INFO - Running setup.py install for mozcrash 10:53:57 INFO - Running setup.py install for mozdebug 10:53:57 INFO - Running setup.py install for mozdevice 10:53:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:53:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:53:57 INFO - Running setup.py install for mozfile 10:53:57 INFO - Running setup.py install for mozhttpd 10:53:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:53:57 INFO - Running setup.py install for mozinfo 10:53:57 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:53:57 INFO - Running setup.py install for mozInstall 10:53:57 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:53:57 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:53:57 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:53:57 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:53:57 INFO - Running setup.py install for mozleak 10:53:57 INFO - Running setup.py install for mozlog 10:53:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:53:58 INFO - Running setup.py install for moznetwork 10:53:58 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:53:58 INFO - Running setup.py install for mozprocess 10:53:58 INFO - Running setup.py install for mozprofile 10:53:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:53:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:53:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:53:58 INFO - Running setup.py install for mozrunner 10:53:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:53:58 INFO - Running setup.py install for mozscreenshot 10:53:58 INFO - Running setup.py install for moztest 10:53:58 INFO - Running setup.py install for mozversion 10:53:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:53:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:53:58 INFO - Cleaning up... 10:53:58 INFO - Return code: 0 10:53:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fab3dfecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ce630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115f840>, '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 0x10cc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccb60>, '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': '004b26eee9c3b360c8654f40000001e1-1451500756.237345-302742272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:53:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 10:53:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:53:58 INFO - Using env: {'DISPLAY': ':0', 10:53:58 INFO - 'HOME': '/home/cltbld', 10:53:58 INFO - 'LANG': 'en_US.UTF-8', 10:53:58 INFO - 'LANGUAGE': 'en_US:en', 10:53:58 INFO - 'LOGNAME': 'cltbld', 10:53:58 INFO - 'MAIL': '/var/mail/cltbld', 10:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:58 INFO - 'MOZ_NO_REMOTE': '1', 10:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:58 INFO - 'NO_EM_RESTART': '1', 10:53:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:58 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:58 INFO - 'SHELL': '/bin/bash', 10:53:58 INFO - 'SHLVL': '1', 10:53:58 INFO - 'TERM': 'linux', 10:53:58 INFO - 'TMOUT': '86400', 10:53:58 INFO - 'USER': 'cltbld', 10:53:58 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1451500756.237345-302742272', 10:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:58 INFO - '_': '/tools/buildbot/bin/python'} 10:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:53:59 INFO - Running setup.py (path:/tmp/pip-kf3H7I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 10:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:53:59 INFO - Running setup.py (path:/tmp/pip-Q0ZurV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:53:59 INFO - Running setup.py (path:/tmp/pip-epzfJK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 10:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:53:59 INFO - Running setup.py (path:/tmp/pip-_mUZrx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:53:59 INFO - Running setup.py (path:/tmp/pip-16VjSg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 10:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:53:59 INFO - Running setup.py (path:/tmp/pip-5ED6wA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 10:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:53:59 INFO - Running setup.py (path:/tmp/pip-Ph8CX0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 10:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:53:59 INFO - Running setup.py (path:/tmp/pip-U5d8nq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 10:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:53:59 INFO - Running setup.py (path:/tmp/pip-_3zhNB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 10:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:53:59 INFO - Running setup.py (path:/tmp/pip-aTyq6F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:53:59 INFO - Running setup.py (path:/tmp/pip-P9G6F_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 10:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:53:59 INFO - Running setup.py (path:/tmp/pip-6C9r7G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 10:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:53:59 INFO - Running setup.py (path:/tmp/pip-lhEtRC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 10:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:53:59 INFO - Running setup.py (path:/tmp/pip-i7phAH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 10:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:54:00 INFO - Running setup.py (path:/tmp/pip-D2s_y8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 10:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:54:00 INFO - Running setup.py (path:/tmp/pip-LKjPZG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 10:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:54:00 INFO - Running setup.py (path:/tmp/pip-v6uPUi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 10:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 10:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:54:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:01 INFO - Downloading blessings-1.5.1.tar.gz 10:54:01 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 10:54:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:54:02 INFO - Installing collected packages: blessings 10:54:02 INFO - Running setup.py install for blessings 10:54:02 INFO - Successfully installed blessings 10:54:02 INFO - Cleaning up... 10:54:02 INFO - Return code: 0 10:54:02 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:54:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:54:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:54:02 INFO - Reading from file tmpfile_stdout 10:54:02 INFO - Current package versions: 10:54:02 INFO - argparse == 1.2.1 10:54:02 INFO - blessings == 1.5.1 10:54:02 INFO - blobuploader == 1.2.4 10:54:02 INFO - docopt == 0.6.1 10:54:02 INFO - manifestparser == 1.1 10:54:02 INFO - mozInstall == 1.12 10:54:02 INFO - mozcrash == 0.16 10:54:02 INFO - mozdebug == 0.1 10:54:02 INFO - mozdevice == 0.47 10:54:02 INFO - mozfile == 1.2 10:54:02 INFO - mozhttpd == 0.7 10:54:02 INFO - mozinfo == 0.9 10:54:02 INFO - mozleak == 0.1 10:54:02 INFO - mozlog == 3.1 10:54:02 INFO - moznetwork == 0.27 10:54:02 INFO - mozprocess == 0.22 10:54:02 INFO - mozprofile == 0.28 10:54:02 INFO - mozrunner == 6.11 10:54:02 INFO - mozscreenshot == 0.1 10:54:02 INFO - mozsystemmonitor == 0.0 10:54:02 INFO - moztest == 0.7 10:54:02 INFO - mozversion == 1.4 10:54:02 INFO - psutil == 3.1.1 10:54:02 INFO - requests == 1.2.3 10:54:02 INFO - wsgiref == 0.1.2 10:54:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:02 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 0x7fab3dfecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ce630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115f840>, '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 0x10cc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccb60>, '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': '004b26eee9c3b360c8654f40000001e1-1451500756.237345-302742272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:54:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 10:54:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:54:02 INFO - Using env: {'DISPLAY': ':0', 10:54:02 INFO - 'HOME': '/home/cltbld', 10:54:02 INFO - 'LANG': 'en_US.UTF-8', 10:54:02 INFO - 'LANGUAGE': 'en_US:en', 10:54:02 INFO - 'LOGNAME': 'cltbld', 10:54:02 INFO - 'MAIL': '/var/mail/cltbld', 10:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:02 INFO - 'MOZ_NO_REMOTE': '1', 10:54:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:02 INFO - 'NO_EM_RESTART': '1', 10:54:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:54:02 INFO - 'PWD': '/builds/slave/test-pgo', 10:54:02 INFO - 'SHELL': '/bin/bash', 10:54:02 INFO - 'SHLVL': '1', 10:54:02 INFO - 'TERM': 'linux', 10:54:02 INFO - 'TMOUT': '86400', 10:54:02 INFO - 'USER': 'cltbld', 10:54:02 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1451500756.237345-302742272', 10:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:02 INFO - '_': '/tools/buildbot/bin/python'} 10:54:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:54:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 10:54:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 10:54:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 10:54:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 10:54:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 10:54:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 10:54:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 10:54:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 10:54:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:54: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 mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 10:54:02 INFO - Cleaning up... 10:54:02 INFO - Return code: 0 10:54:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:02 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 0x7fab3dfecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ce630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115f840>, '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 0x10cc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccb60>, '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': '004b26eee9c3b360c8654f40000001e1-1451500756.237345-302742272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:54:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 10:54:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:54:02 INFO - Using env: {'DISPLAY': ':0', 10:54:02 INFO - 'HOME': '/home/cltbld', 10:54:02 INFO - 'LANG': 'en_US.UTF-8', 10:54:02 INFO - 'LANGUAGE': 'en_US:en', 10:54:02 INFO - 'LOGNAME': 'cltbld', 10:54:02 INFO - 'MAIL': '/var/mail/cltbld', 10:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:02 INFO - 'MOZ_NO_REMOTE': '1', 10:54:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:02 INFO - 'NO_EM_RESTART': '1', 10:54:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:54:02 INFO - 'PWD': '/builds/slave/test-pgo', 10:54:02 INFO - 'SHELL': '/bin/bash', 10:54:02 INFO - 'SHLVL': '1', 10:54:02 INFO - 'TERM': 'linux', 10:54:02 INFO - 'TMOUT': '86400', 10:54:02 INFO - 'USER': 'cltbld', 10:54:02 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1451500756.237345-302742272', 10:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:02 INFO - '_': '/tools/buildbot/bin/python'} 10:54:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:02 INFO - Downloading/unpacking jsonschema 10:54: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 10:54: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 10:54: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 10:54: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 10:54: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 10:54: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 10:54:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:54:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 10:54:04 INFO - Downloading/unpacking functools32 (from jsonschema) 10:54: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 10:54: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 10:54: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 10:54: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 10:54: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 10:54: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 10:54:04 INFO - Downloading functools32-3.2.3-2.tar.gz 10:54:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:54:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:54:04 INFO - warning: no files found matching '*.txt' 10:54:04 INFO - no previously-included directories found matching 'build' 10:54:04 INFO - no previously-included directories found matching 'dist' 10:54:04 INFO - no previously-included directories found matching '.git*' 10:54:04 INFO - Installing collected packages: jsonschema, functools32 10:54:04 INFO - Running setup.py install for functools32 10:54:05 INFO - warning: no files found matching '*.txt' 10:54:05 INFO - no previously-included directories found matching 'build' 10:54:05 INFO - no previously-included directories found matching 'dist' 10:54:05 INFO - no previously-included directories found matching '.git*' 10:54:05 INFO - Successfully installed jsonschema functools32 10:54:05 INFO - Cleaning up... 10:54:05 INFO - Return code: 0 10:54:05 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab3dfecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ce630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115f840>, '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 0x10cc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccb60>, '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': '004b26eee9c3b360c8654f40000001e1-1451500756.237345-302742272', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:54:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 10:54:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:54:05 INFO - Using env: {'DISPLAY': ':0', 10:54:05 INFO - 'HOME': '/home/cltbld', 10:54:05 INFO - 'LANG': 'en_US.UTF-8', 10:54:05 INFO - 'LANGUAGE': 'en_US:en', 10:54:05 INFO - 'LOGNAME': 'cltbld', 10:54:05 INFO - 'MAIL': '/var/mail/cltbld', 10:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:05 INFO - 'MOZ_NO_REMOTE': '1', 10:54:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:05 INFO - 'NO_EM_RESTART': '1', 10:54:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:54:05 INFO - 'PWD': '/builds/slave/test-pgo', 10:54:05 INFO - 'SHELL': '/bin/bash', 10:54:05 INFO - 'SHLVL': '1', 10:54:05 INFO - 'TERM': 'linux', 10:54:05 INFO - 'TMOUT': '86400', 10:54:05 INFO - 'USER': 'cltbld', 10:54:05 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1451500756.237345-302742272', 10:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:05 INFO - '_': '/tools/buildbot/bin/python'} 10:54:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:05 INFO - Downloading/unpacking flake8 10:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:54:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 10:54:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:54: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 10:54: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 10:54: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 10:54: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 10:54: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 10:54: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 10:54:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:54:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 10:54:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:54: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 10:54: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 10:54: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 10:54: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 10:54: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 10:54: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 10:54:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 10:54:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:54: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 10:54: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 10:54: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 10:54: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 10:54: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 10:54: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 10:54:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:54:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:54:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:54:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:54:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:54:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:54:07 INFO - no previously-included directories found matching 'docs/_build' 10:54:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:54:07 INFO - Running setup.py install for pep8 10:54:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:54:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:54:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:54:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:54:07 INFO - no previously-included directories found matching 'docs/_build' 10:54:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:54:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:54:07 INFO - Cleaning up... 10:54:07 INFO - Return code: 0 10:54:07 INFO - Running post-action listener: _resource_record_post_action 10:54:07 INFO - Running post-action listener: _start_resource_monitoring 10:54:07 INFO - Starting resource monitoring. 10:54:07 INFO - ##### 10:54:07 INFO - ##### Running install step. 10:54:07 INFO - ##### 10:54:07 INFO - Running pre-action listener: _resource_record_pre_action 10:54:07 INFO - Running main action method: install 10:54:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:54:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:54:08 INFO - Reading from file tmpfile_stdout 10:54:08 INFO - Detecting whether we're running mozinstall >=1.0... 10:54:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:54:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:54:08 INFO - Reading from file tmpfile_stdout 10:54:08 INFO - Output received: 10:54:08 INFO - Usage: mozinstall [options] installer 10:54:08 INFO - Options: 10:54:08 INFO - -h, --help show this help message and exit 10:54:08 INFO - -d DEST, --destination=DEST 10:54:08 INFO - Directory to install application into. [default: 10:54:08 INFO - "/builds/slave/test-pgo"] 10:54:08 INFO - --app=APP Application being installed. [default: firefox] 10:54:08 INFO - mkdir: /builds/slave/test-pgo/build/application 10:54:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 10:54:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 10:54:24 INFO - Reading from file tmpfile_stdout 10:54:24 INFO - Output received: 10:54:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:54:24 INFO - Running post-action listener: _resource_record_post_action 10:54:24 INFO - ##### 10:54:24 INFO - ##### Running run-tests step. 10:54:24 INFO - ##### 10:54:24 INFO - Running pre-action listener: _resource_record_pre_action 10:54:24 INFO - Running main action method: run_tests 10:54:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:54:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:54:24 INFO - Python 2.7.3 10:54:24 INFO - Return code: 0 10:54:24 INFO - grabbing minidump binary from tooltool 10:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:24 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 0x115f840>, '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 0x10cc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ccb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:54:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 10:54:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:54:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:54:24 INFO - Return code: 0 10:54:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:54:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:54:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:54:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:54:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:54:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:54:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:54:25 INFO - Return code: 0 10:54:25 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 10:54:25 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 10:54:25 INFO - Using env: {'DISPLAY': ':0', 10:54:25 INFO - 'HOME': '/home/cltbld', 10:54:25 INFO - 'LANG': 'en_US.UTF-8', 10:54:25 INFO - 'LANGUAGE': 'en_US:en', 10:54:25 INFO - 'LOGNAME': 'cltbld', 10:54:25 INFO - 'MAIL': '/var/mail/cltbld', 10:54:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:54:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:54:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:25 INFO - 'MOZ_NO_REMOTE': '1', 10:54:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:54:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:54:25 INFO - 'NO_EM_RESTART': '1', 10:54:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:54:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:54:25 INFO - 'PWD': '/builds/slave/test-pgo', 10:54:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:54:25 INFO - 'SHELL': '/bin/bash', 10:54:25 INFO - 'SHLVL': '1', 10:54:25 INFO - 'TERM': 'linux', 10:54:25 INFO - 'TMOUT': '86400', 10:54:25 INFO - 'USER': 'cltbld', 10:54:25 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1451500756.237345-302742272', 10:54:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:25 INFO - '_': '/tools/buildbot/bin/python'} 10:54:25 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:54:25 INFO - mozversion application_buildid: 20151230083144 10:54:25 INFO - mozversion application_changeset: 9e210cee056b1a3d213198b4e38679612b0bb0bc 10:54:25 INFO - mozversion application_display_name: Nightly 10:54:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:54:25 INFO - mozversion application_name: Firefox 10:54:25 INFO - mozversion application_remotingname: firefox 10:54:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:54:25 INFO - mozversion application_vendor: Mozilla 10:54:25 INFO - mozversion application_version: 46.0a1 10:54:25 INFO - mozversion platform_buildid: 20151230083144 10:54:25 INFO - mozversion platform_changeset: 9e210cee056b1a3d213198b4e38679612b0bb0bc 10:54:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:54:25 INFO - mozversion platform_version: 46.0a1 10:54:25 INFO - using testdate: 1451501665 10:54:25 INFO - actual date: 1451501665 10:54:25 INFO - starting webserver on 'localhost:56807' 10:54:25 INFO - SUITE-START | Running 3 tests 10:54:25 INFO - TEST-START | dromaeo_css 10:54:25 INFO - operating with platform_type : linux_ 10:54:25 INFO - Initialising browser for dromaeo_css test... 10:54:25 INFO - TEST-INFO | started process 6817 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqTOslW/profile http://localhost:56807/getInfo.html) 10:54:29 INFO - PROCESS | 6817 | __metrics Screen width/height:1600/1200 10:54:29 INFO - PROCESS | 6817 | colorDepth:24 10:54:29 INFO - PROCESS | 6817 | Browser inner width/height: 1024/697 10:54:29 INFO - PROCESS | 6817 | __metrics 10:54:29 INFO - PROCESS | 6817 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:54:29 INFO - PROCESS | 6817 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:54:30 INFO - TEST-INFO | 6817: exit 0 10:54:30 INFO - Browser initialized. 10:54:30 INFO - Running cycle 1/1 for dromaeo_css test... 10:54:30 INFO - TEST-INFO | started process 6912 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqTOslW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:54:42 INFO - PROCESS | 6912 | RSS: Main: 149544960 10:54:42 INFO - PROCESS | 6912 | 10:55:33 INFO - PROCESS | 6912 | 1451501733886 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:57:42 INFO - PROCESS | 6912 | Cycle 1(1): loaded http://localhost:56807/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56807/tests/dromaeo/cssquery-ext.html) 10:57:43 INFO - PROCESS | 6912 | RSS: Main: 266756096 10:57:43 INFO - PROCESS | 6912 | 11:00:45 INFO - PROCESS | 6912 | Cycle 1(1): loaded http://localhost:56807/tests/dromaeo/cssquery-ext.html (next: http://localhost:56807/tests/dromaeo/cssquery-jquery.html) 11:00:46 INFO - PROCESS | 6912 | RSS: Main: 237187072 11:00:46 INFO - PROCESS | 6912 | 11:03:48 INFO - PROCESS | 6912 | Cycle 1(1): loaded http://localhost:56807/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56807/tests/dromaeo/cssquery-mootools.html) 11:03:48 INFO - PROCESS | 6912 | RSS: Main: 230686720 11:03:48 INFO - PROCESS | 6912 | 11:06:50 INFO - PROCESS | 6912 | Cycle 1(1): loaded http://localhost:56807/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56807/tests/dromaeo/cssquery-prototype.html) 11:06:51 INFO - PROCESS | 6912 | RSS: Main: 214548480 11:06:51 INFO - PROCESS | 6912 | 11:09:53 INFO - PROCESS | 6912 | Cycle 1(1): loaded http://localhost:56807/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56807/tests/dromaeo/cssquery-yui.html) 11:09:54 INFO - PROCESS | 6912 | RSS: Main: 196681728 11:09:54 INFO - PROCESS | 6912 | 11:12:56 INFO - PROCESS | 6912 | Cycle 1(1): loaded http://localhost:56807/tests/dromaeo/cssquery-yui.html (next: http://localhost:56807/tests/dromaeo/cssquery-dojo.html) 11:12:57 INFO - PROCESS | 6912 | RSS: Main: 250281984 11:12:57 INFO - PROCESS | 6912 | 11:12:57 INFO - PROCESS | 6912 | __start_tp_report 11:12:57 INFO - PROCESS | 6912 | _x_x_mozilla_page_load 11:12:57 INFO - PROCESS | 6912 | _x_x_mozilla_page_load_details 11:12:57 INFO - PROCESS | 6912 | |i|pagename|runs| 11:12:57 INFO - PROCESS | 6912 | |0;dojo.html;3031.9696803031966;3051.176182430745;3094.922626934326;3096.7212950834432;3119.7192252697255;5135.332406787122;5267.130923397634;5271.262023316739;5280.5247527722495;5308.575313974882;5210.452902445246;5287.074761916669;5293.047251494739;5316.4683531646815;5403.054465468537;4803.9279410808695;4807.206810876201;4839.879003024917;4900.362952816146;4909.337239472661;4762.880927976811;4903.82836600719;4933.481984391641;4943.950560494403;4985.950140498603;4743.573078422924;4834.6374021948495;4848.369711937461;4882.926756098625;4915.090708218973;4796.664233503656;4799.448063472711;4803.327534145223;4813.446453657839;4828.782704778258;4767.451743049559;4772.188727916263;4781.211100168468;4803.95196048042;4810.470848206694;5035.320231768701;5118.6416950813455;5164.612654050924;5208.661437006583;5239;5653.180288858133;5659.8585035374035;5677.403872593401;5707.77168913243;5716.314042314907;5463.672179669193;5645.858853528694;5668.404817494145;5674.460926212003;5679.460451257165;5237.162054071368;5242.606804489678;5265.815696450644;5323.600729945192;5349.0639138151055;5726.226959360433;5727.742251598688;5730.5129064030025;5733.655980641175;5740.799072032459;5334.973325133349;5534.308211473566;5535.114381698909;5538.695371754511;5571.860703482445;5453.672779633234;5473.8357849264585;5670.858228544319;5729.226554415184;5765.106408506688;5488.368837583729;5510.338759348823;5510.448955104457;5516.503514683698;5518.834434966958;5460.34475862899;5536.944630553723;5537.8061767837935;5548.472895074961;5574.693391863487;4333.566643335705;4353.281708518122;4358.738475691469;4369.584889435499;4414.117176564636;3826.445165450994;3836.271108489378;3855.8650447234213;3877.941830872539;3904.648581627667;5146.25379320004;5191.299174611455;5205.6356055075785;5207.6875387476875;5251.238570407269;5633.070543360382;5633.464820842013;5663.518600918886;5665.291838520185;5710.685912274865;5260.842174734764;5261.605379596545;5262.55268302191;5305;5305.363356397257;4888.780004899788;4891.5353041461;4893.681910675795;4907.975460122677;4940.481249468826;5633.718314084279;5687.60186786921;5758.884822303614;5850.502707269845;5852.795152169739;5610.382857885711;5675.26221591207;5676.716164191691;5678.346990096192;5720.141978703228;5816;5821.592488525763;5830.358660547421;5832.387599302012;5836.416358364299;5460.126379779216;5524.889502210013;5572.498475137257;5575.637583557056;5583.720813959367;5644.520215781705;5681.488666020078;5709.143628455765;5718.599698021098;5770.365259821332;5499.422560631237;5534.308211473566;5538.44615538459;5538.806141785019;5544.029794785815;5361.115415956324;5440.102383106743;5465.945340546703;5522.751476183501;5524.917126243029;5435.755391007493;5443.945560544344;5444.8366549003595;5445.319335083114;5470.288862447856;5520.06158952971;5540.168974653834;5551.417101204315;5552.083906155439;5592.972035139798;5267.78928842842;5315.069862774077;5362.329708786402;5380.892382152413;5418.431064738145 11:12:57 INFO - PROCESS | 6912 | |1;ext.html;537.1405750798723;538.0557122250452;553.7259056766901;559.4433538629065;575.9517677826356;28658.283542911413;29293.56059659104;35885.82057089711;36193.0951726207;36244;38625;38938.8053059735;39130.8043459783;39171.21657566847;39203;7405.148407933103;8369.079401265855;8527.658893644279;8549.914500854975;8551.358648101386;7499.062617172854;9846.55690493926;10031.69904902854;10034.147097496721;10035.096841284283;9893.505324733735;10019.148372388356;10021.649242276522;10021.949890250575;10029.348092373972;7566.924330756732;7722.768316950444;9765.951170244174;9974.900250997469;9983.351082179672;9739.853902191473;9859.605615775361;9888.703338899773;9897.059779320953;9898.406095634286;35432.82283588591;35974.64025359739;35988;36000.63999359999;36052.63947360545;3007.0377479206663;3070.631524217108;3162.604674415698;3465.0297916583395;3859.6526312631718;29893.103206903827;30309.393812123635;30394;30414.087577372713;30592.082237532908;3874.9612503874882;3881.825317860703;3882.3788193889127;3911.9608803911883;3926.1558764865404;255289;255681;256141;257573;258839;49328;55568;55886;55982.72008640012;56030.71984640132;45544;45654.54345456503;45729.771351143034;45740.771296143306;59815.401845981854;15270.847291527165;15349.769753453707;15374.38502459889;15475;15479.845201548065;11899.345535995604;11969.521219151311;12048;12055.276683399024;12060.517579296906;17932.9103354485;18077.909610452127;18125.18436670353;18136.45590632283;18170.364037258634;7292.8906066409045;7546.471746977659;7612.2387761224545;7616.466847320745;7778.611069446618;910.5583791860943;936.6628013914985;1020.7634833305098;1035.4098164046572;1066.2749330455365;27425.31436714098;28478.572821407695;28612.856935715186;31004;31059.68940310568;1017.5777052523268;1018.592562974816;1026.296986564206;1057.7567159553346;1115.5370521233597;12932.547360842513;13197.868021319857;13264.403101860247;13307.733845323039;13400.12899161571;292030;296811;297227;298083;298765;49775;50076.248856267186;50189.74905125524;50203.497965020615;50224.246636300486;1250.9499620015097;1351.8986076044337;1370.239517068017;1370.3011464153153;1371.3074897177062;23711.644325335477;24697.62953555662;25552.23343299704;25577.232683019538;28204;39376.803115985385;39472.802635986634;39528.40707389449;39572.40641390439;39612;228568;229218;229831;230989;231188;26733.86633066822;27487.86256068707;30606;30971.845140774152;31160.22099447532;34442.311153777286;35251.82374088113;35351.46972795359;35354;35707.28585428329;29420.117396477282;30693.693063069084;31242;31388;31721.8413907929;32917;32920.506192406654;33725.15687107842;33873.49189762205;33955;31987.6801231994;32702.182445439055;32718.182045449055;33059.50410743889;33127.83436082804;28882.855585721936;30238.84880575583;30418.391632167677;30752.846235768677;30788.230294241926;23174.553979815068;23229.3031209064;23423.76576234216;23485.41286467852;23527.176548821393 11:12:57 INFO - PROCESS | 6912 | |2;jquery.html;341.7710134210079;342.6915775801778;344.6484585722563;344.844819831076;344.89997900608824;13984.720305593908;14430.711385772305;16139.838601613981;16283.348666053358;17315.480535583938;14447.638809029753;15976;16313.755293670574;16359.672806543891;16377.83622163778;5185.144451165553;5322.308099947021;5324.227986941891;5329.760160792774;5330.280412144369;3975.8210880510446;4089.9182016359655;5256.5794736421185;5305.761240744157;5676.290463692038;5766.106253530688;5798.623089499169;5801.767929282823;5829.562782791287;5850.414958504158;5617.747201375927;5720.856978575527;5725.599208055438;5734.598578099534;5788.160716696077;5053.797848086072;5056.721880296583;5056.82301119459;5070.416902056237;5071.137906555858;20095.698564521397;20677.5864482711;20769.27307544229;20828.375148745563;21129.5774084519;2074.201432448503;2100.5588826346484;2101.369589123257;2107.2097963263777;2194.462356722613;13208.801867971988;13213;13292.26892520911;13362.933185334108;13487.86512134876;1689.6874078295555;1770.4069136839175;1829.5609053827118;1834.7156190790315;1954.1011134877974;51981;53039.841689969486;55059.44940550583;55176.172357414674;56090.719546402004;8906;9551.331406801457;9555.569999349907;9559.94840567551;9599.184069354043;11432.913873182035;11500.194986350874;11502.94248528752;11508.654740357802;11509.942450287863;7450.515716478411;7507.474476786681;7570.205128461433;7609.467337286447;7627.656755446018;7185.928140718631;7206.531575447579;7264.091988501437;7273.709051637981;7584.810379740551;5553.527950124285;5737.827865163968;5766.596338256366;5805.651660900359;5826.679532625746;1499.4452052740337;1581.122477025239;1614.8869579129582;1623.2695287120844;1633.2405431474422;938.2212763406357;945.1965829045394;949.5015117063597;953.7281874665825;1039.714078628368;15889.841101589067;16100.677986440205;16355.34578616842;16456.341746330014;16735.330586776636;957.875476188105;967.1295833749541;975.1321324021626;997.9201663866874;1006.0090810551601;9683.951580242054;10115.696529104138;10163.44101074448;10180.440075795903;10248.538815753309;380774;387252;515684;525439;525841;42657.57342426598;42779.35830962538;46315;71481.6425917867;81440.65086155167;1133.6485689436302;1137.3460260350332;1178.8997935175435;1198.0954379443638;1214.6173955204083;15195.392184312946;15210.16344101085;15477.303521341792;15519.146446945526;15800.446984355493;31702;32996.1750956228;33009.50485742764;33082.33835323328;33264;40186.39720404255;43385.3492197611;46007.53992460033;46345.76827115843;47164;9115.134062264075;9377.765555861159;9542.379745316532;9595.328327017041;9681.757956051155;11315.943420283174;11329.206955513035;11429.257098288585;15934.442294519637;16992.405265815636;13937.1296954981;13947.442102315794;14057.297135143406;14390.424383024561;14850;13860.861391385957;14055.367508462348;14355.138691678532;14402.42390304376;14439.989200755846;13939.303034848013;14015.439382424589;14018.789718154032;14165.22091284948;14905.180215088274;9507.239420846177;9551.379160354554;9654.71035868925;9866.55600497965;9873.605055797687;10000.649977250761;10113.14038306752;13434.462621495422;13479.932600336935;14663.780043299146 11:12:57 INFO - PROCESS | 6912 | |3;mootools.html;1309.155594641457;1421.438531779947;1434.2541878223324;1569.4193148535037;1763.91180440978;6229.252489701236;6829.317068293174;6935.757248496304;6945.444364450845;6960.269171736971;6852;7028.121484814398;7053.329933656307;7054.541454805434;7056.047433596463;2163.5023944492814;2187.442202238427;2197.8241740660787;2201.7027701260286;2204.0853045985896;2177.3032629558547;2202.933911982643;2261.6381378979368;2264.739554951177;2274.613315736329;2158.9784102158933;2164.361513353557;2189.9452513687206;2191.1454532732246;2227.8106360959255;2176.7170267865154;2190.535851007761;2206.6138425775584;2206.8896555172178;2209.4476380904775;2193.561287742442;2222.29997550771;2223.666450032492;2225.043231410493;2228.3315005498284;6948.166220053626;7022.613756243404;7028.824279393056;7034.92965070353;7045.506814522985;4244.533101358848;4303.892402689927;4342.956570434287;4343.9348409773875;4381.671374646914;2737.9589306160424;2759.862006899647;2813.7326953939546;2815.873285702148;2821.2241633550734;855.6962278391206;895.7268033249857;895.9148880856309;1846.556826361677;1876.5121068522146;9335.579898904498;9385.530723463868;9429.387089839138;9429.434233945985;9434.85847712278;3607.603163651996;3735.1782607826235;3753.6997040236715;3800.049987503124;3800.410936304822;7465.514741541782;7473.51422157558;7485.663145158372;7488.812779680552;7496.7376141834775;4184.28867092595;4214.557471465513;4236.745795252295;4237.5762423758;4239.533651298355;3642.307961487309;3749.6062913393703;3912.158885839558;3914.8042597870563;3915.2169566086895;3235.9514607280908;3241.789283696552;3276.3447310537986;3302.5211344354934;3306.8015919044933;966.3187452845867;966.6568368229177;972.3145182646217;982.1455333859445;994.6916455898549;1008.7602867002811;1050.1179009631946;1080.4651697409834;1363.3047145955634;1364.4746772492463;6550.70521826519;6617.371349721769;6671.833204169935;6803.251642319341;6812.386885180357;603.9969800151059;611.8868009418183;613.1048668943304;615.4614712126889;753.2881427051384;5113.335266415343;5430.294061772023;5518.144687573433;5554.166874968787;5554.750036248379;8322.70870519529;8542.145785421408;8563.400561960727;8569.614367353484;8571.314294856396;8419.242268195769;8437.451565648213;8442.577871106543;8458.492490450593;8462.449940753831;6726.596404215665;6873.896891546631;6888.380045795802;6900.274931267284;6942.271061538567;6640.568363056386;6660.966695166493;6661.666916654245;6666.799996000128;6697.933020669926;7516.210797866145;7797.064352277536;7803.414743894117;7819.257170568787;7822.139564647998;7276.636168191463;7384.741534046498;7394.741184058532;7489.925100748923;7492.587907665131;5934.139549765174;6091.7258723358445;6323.083152942706;6332.810015699536;6394.552381333262;6909.1018167637885;6923.238443771282;6970.686319115754;6987.790366289019;6997.965010174917;6459;6512.967435162794;6606.735730570916;6610.140681711347;6633;6405.903911441425;6418.582792118684;6436.935630643821;6529.771457998947;6580.670966451563;6503.252126005381;6550.213974322921;6560.40956313934;6561.245456772533;6562.114114594468;5947.762089516371;6095.9390406097145;6105.236845394325;6138.754449821957;6162.014077747718;5990.910136347871;6081.969590152021;6115.388461154027;6141.355157708376;6142.447179753844 11:12:57 INFO - PROCESS | 6912 | |4;prototype.html;324.8392045937261;326.40105406578925;328.73865277104727;329.96205436374817;334.5583829345262;5924.496417804487;5960.850978725529;6000.609960352579;6012.939870601293;6026.4576188143055;5656.349519805223;5732.770689172438;5810.215620891189;5872.4127587241255;5933.258342707161;4547.386102876119;4558.954410455903;4559.680822342446;4569.04050149469;4588.908221835562;4320.719153255044;4530.909381812362;4539.160255352754;4568.565986231302;4574.451065872084;4365.388845561624;4382.057857560624;4485.52901945296;4486.080353527535;4486.327050942368;4376.606105450524;4456.17560751262;4459.509453960061;4468.396766436538;4493.303537951639;3912.8043597819997;3968.1666849961543;3977.423273625308;3978.0507551299656;3982.422548730447;5541.33503979525;5616.887662246773;5618.57860660448;5622.240997465331;5625.099984002581;5272.525472707436;5277.050130976423;5283.286756287929;5284;5294.814681486129;6263.71813268404;6264.436200741955;6270.435660790551;6273.090401891745;6275.529335299871;4396.406485124499;4424.093060922535;4425.22558552252;4427.092446048585;4438.334249862514;6384.361563843625;6548.443382312509;6549.639769812658;6558.606483610999;6595.769148079842;4533.841315554006;4547.840825571089;4549.158405694957;4550.908981820345;4559.498455169929;4596.839110631112;4598.701084429501;4600.079984003212;4601.884952876205;4605.355250264965;5280.973595132;5285.947140528546;5293.100172970604;5294.444083371268;5295.629305948623;6187.412195841388;6297.1813664223355;6329.113924050636;6347.143135676717;6351.396617321347;1591.0294720220656;1608.6621809420153;1610.2270909963283;1610.5409958161868;1610.9758353624704;1077.8167711489066;1082.1234799812178;1084.3168803653648;1097.1442275025333;1107.7618312062946;5960.7019649017375;5964;5967.880642387128;6013.729382177812;6026.427489388501;6483.4164925156965;6493;6496.6426846522945;6497.610143391412;6503.869922601616;5773.595848290579;5926.851828704231;5927.407259274124;5931.851703707355;5934.495567876779;3335.5663763710563;3467.930641387158;3485.9302813944087;3513.5256740340237;3514.3674138655288;6696.229933557704;6724;6742.157230346207;6819.829504262433;6832.555883867532;6710.825605519015;6714.496412769062;6724.66376681164;6726.529142959946;6729.596224226562;6574.276829548841;6707.228668703162;6719.260881303053;6724.159480064992;6804.727810887608;6536.901946470712;6537.803865884031;6541.509386795914;6544.607323560602;6549.443297319591;6474.449671777952;6477.935220647733;6484.837879053061;6491.318411566717;6493;6667.166604174478;6816;6821.624810635264;6824.112865327475;6825.941978993264;4478.977605112084;4479.70881892676;4481.439820022497;4481.7535035572055;4482.215612267905;6562.77030303937;6563;6563.245226798979;6563.835904102245;6564.704588293443;6212.47193988516;6349.396807303298;6352.809415717536;6359.777407790705;6396.744130234739;6369.267534233622;6370.649614271074;6372.968135159294;6381.3937675920715;6383.776567820104;6248.406656302614;6264.154339164154;6264.718087685974;6271.62370257786;6276.623402595859;6144.1398204250545;6196.225471816023;6239.719212635533;6316.305206427198;6415.454686351713;6213.068039794067;6224.066390041349;6227.408396202535;6243.313235544178;6252.124702541739 11:12:57 INFO - PROCESS | 6912 | |5;yui.html;723.6634964741396;739.2607392607391;784.9882251766221;830.6137645994611;847.1147650705012;13544.442389125254;13596.796048059263;13686.52097176599;13737.656558586015;13768.173909565421;10937.781244375108;12405.131640785148;12561.937190314058;12617.810732839014;12622.053345999064;829.2950991657103;839.3033781960958;843;843.4348986179275;843.4433274039135;829.9294559962381;830.2776584371605;830.2901019628191;830.7839961609965;831.8752187171912;866.445474896067;869.2741560796711;873.76845136039;876.1632640828026;876.3558784293539;871.9215270625674;874.6807415293404;879.7712594725353;881.3125761905724;885.583775625455;649.2987573420742;650.3204151661525;650.6909218121402;650.8926027205505;651.4657980456028;13443.193408395528;13491.797623035662;13628.454861805516;13629.931850340785;13642.658933526642;11974.401279935968;12057.336846473441;12307.753844923142;12369.319687417188;12695.936520317431;9801.656942007066;10916.454177291103;10931.398773067478;11181.552737890475;11546.826797598043;3309.2057906102364;3341.4152523308326;3364.226227967581;3439.3637177122064;3442.0362298556443;43021.35467967983;43365.34951975723;43457;43655.12689746219;43672.9081772955;9054.185123338799;9370.906290937004;9413.717588472357;9476.526173691287;9477.715668529818;17648.647027059385;17687.20407581662;17744.46766597004;17748.733768993476;17762.91118544425;7210.96394518024;7258.927410725931;7321.487495875344;7345.816354591071;7463.776086717407;4243.618074373259;4251.112209589679;4279.807408666617;4289.185054839633;4302;3059.189314831571;3103.0845900459417;3107.207662046164;3109.113902537811;3110.455670257696;501.9598432125421;512.4209643103269;516;519.3845293327419;523.9580833533308;521.3583121893571;645.7513857165026;649.2922714241499;656.5502630697987;677.6882633988421;8374.874376884352;8419.536925469036;8452.661893524313;8571;8828.690995815115;540.1924123435489;542.2327406719527;631.6652174347603;664.2361284522741;673.71367168953;3552.715782737375;3730.7948062856262;4082.408050832672;4223.809928553223;4357.128574285092;54732;55696;55743.44256557464;55926;55941;38754.80622596869;43415.131697365876;48968.51031489711;49641.255381169314;50365;38767.22465550673;44558.10883782371;45168.54831451643;46433.30350044819;46555.06889862184;8416.284615807725;8750.168733970262;9032.412893161923;9169.266458683156;9174.128457796498;33690;34478.82760586181;34640.48039279362;34649.2280617555;35142.648573513936;42029.00724431174;42031.7898410506;42863.14273714446;44843.00467052464;45084.32373514334;9629.759256018655;9892.258080644124;10024.348417352849;10256.230782691477;10344.896551034393;11196.440177991231;11354.886451135382;11357.829632555353;11452.312861228353;11486.540538378706;10710.196735245043;10760.623378181726;10790.622328218475;10860.565577376816;10941.07000904932;11202.719932001439;11266.155038372319;11269.098472122047;11278.661640150809;11278.830817537579;10827.729306767395;10973.780524389627;11012.724681883017;11020.944895275794;11055.72360690989;9479.19895219906;9857.35927164732;9900.950495247478;9908.405495669995;9945.552450139616;8375.32997360222;9379.390339627902;9389.29580281468;9510.38182518134;9590.376625519319 11:12:57 INFO - PROCESS | 6912 | __end_tp_report 11:12:57 INFO - PROCESS | 6912 | __start_cc_report 11:12:57 INFO - PROCESS | 6912 | _x_x_mozilla_cycle_collect,895 11:12:57 INFO - PROCESS | 6912 | __end_cc_report 11:12:57 INFO - PROCESS | 6912 | __startTimestamp1451502777135__endTimestamp 11:12:57 INFO - PROCESS | 6912 | 11:12:57 INFO - PROCESS | 6912 | ------- Summary: start ------- 11:12:57 INFO - PROCESS | 6912 | Number of tests: 6 11:12:57 INFO - PROCESS | 6912 | 11:12:57 INFO - PROCESS | 6912 | [#0] dojo.html Cycles:165 Average:5230.00 Median:5435.76 stddev:576.11 (10.6%) stddev-sans-first:551.47 11:12:57 INFO - PROCESS | 6912 | Values: 3032.0 3051.2 3094.9 3096.7 3119.7 5135.3 5267.1 5271.3 5280.5 5308.6 5210.5 5287.1 5293.0 5316.5 5403.1 4803.9 4807.2 4839.9 4900.4 4909.3 4762.9 4903.8 4933.5 4944.0 4986.0 4743.6 4834.6 4848.4 4882.9 4915.1 4796.7 4799.4 4803.3 4813.4 4828.8 4767.5 4772.2 4781.2 4804.0 4810.5 5035.3 5118.6 5164.6 5208.7 5239.0 5653.2 5659.9 5677.4 5707.8 5716.3 5463.7 5645.9 5668.4 5674.5 5679.5 5237.2 5242.6 5265.8 5323.6 5349.1 5726.2 5727.7 5730.5 5733.7 5740.8 5335.0 5534.3 5535.1 5538.7 5571.9 5453.7 5473.8 5670.9 5729.2 5765.1 5488.4 5510.3 5510.4 5516.5 5518.8 5460.3 5536.9 5537.8 5548.5 5574.7 4333.6 4353.3 4358.7 4369.6 4414.1 3826.4 3836.3 3855.9 3877.9 3904.6 5146.3 5191.3 5205.6 5207.7 5251.2 5633.1 5633.5 5663.5 5665.3 5710.7 5260.8 5261.6 5262.6 5305.0 5305.4 4888.8 4891.5 4893.7 4908.0 4940.5 5633.7 5687.6 5758.9 5850.5 5852.8 5610.4 5675.3 5676.7 5678.3 5720.1 5816.0 5821.6 5830.4 5832.4 5836.4 5460.1 5524.9 5572.5 5575.6 5583.7 5644.5 5681.5 5709.1 5718.6 5770.4 5499.4 5534.3 5538.4 5538.8 5544.0 5361.1 5440.1 5465.9 5522.8 5524.9 5435.8 5443.9 5444.8 5445.3 5470.3 5520.1 5540.2 5551.4 5552.1 5593.0 5267.8 5315.1 5362.3 5380.9 5418.4 11:12:57 INFO - PROCESS | 6912 | 11:12:57 INFO - PROCESS | 6912 | [#1] ext.html Cycles:180 Average:41905.20 Median:31201.11 stddev:68392.89 (219.2%) stddev-sans-first:68514.22 11:12:57 INFO - PROCESS | 6912 | Values: 537.1 538.1 553.7 559.4 576.0 28658.3 29293.6 35885.8 36193.1 36244.0 38625.0 38938.8 39130.8 39171.2 39203.0 7405.1 8369.1 8527.7 8549.9 8551.4 7499.1 9846.6 10031.7 10034.1 10035.1 9893.5 10019.1 10021.6 10021.9 10029.3 7566.9 7722.8 9766.0 9974.9 9983.4 9739.9 9859.6 9888.7 9897.1 9898.4 35432.8 35974.6 35988.0 36000.6 36052.6 3007.0 3070.6 3162.6 3465.0 3859.7 29893.1 30309.4 30394.0 30414.1 30592.1 3875.0 3881.8 3882.4 3912.0 3926.2 255289.0 255681.0 256141.0 257573.0 258839.0 49328.0 55568.0 55886.0 55982.7 56030.7 45544.0 45654.5 45729.8 45740.8 59815.4 15270.8 15349.8 15374.4 15475.0 15479.8 11899.3 11969.5 12048.0 12055.3 12060.5 17932.9 18077.9 18125.2 18136.5 18170.4 7292.9 7546.5 7612.2 7616.5 7778.6 910.6 936.7 1020.8 1035.4 1066.3 27425.3 28478.6 28612.9 31004.0 31059.7 1017.6 1018.6 1026.3 1057.8 1115.5 12932.5 13197.9 13264.4 13307.7 13400.1 292030.0 296811.0 297227.0 298083.0 298765.0 49775.0 50076.2 50189.7 50203.5 50224.2 1250.9 1351.9 1370.2 1370.3 1371.3 23711.6 24697.6 25552.2 25577.2 28204.0 39376.8 39472.8 39528.4 39572.4 39612.0 228568.0 229218.0 229831.0 230989.0 231188.0 26733.9 27487.9 30606.0 30971.8 31160.2 34442.3 35251.8 35351.5 35354.0 35707.3 29420.1 30693.7 31242.0 31388.0 31721.8 32917.0 32920.5 33725.2 33873.5 33955.0 31987.7 32702.2 32718.2 33059.5 33127.8 28882.9 30238.8 30418.4 30752.8 30788.2 23174.6 23229.3 23423.8 23485.4 23527.2 11:12:57 INFO - PROCESS | 6912 | 11:12:57 INFO - PROCESS | 6912 | [#2] jquery.html Cycles:180 Average:25772.42 Median:16802.89 stddev:76894.81 (457.6%) stddev-sans-first:77086.81 11:12:57 INFO - PROCESS | 6912 | Values: 341.8 342.7 344.6 344.8 344.9 13984.7 14430.7 16139.8 16283.3 17315.5 14447.6 15976.0 16313.8 16359.7 16377.8 5185.1 5322.3 5324.2 5329.8 5330.3 3975.8 4089.9 5256.6 5305.8 5676.3 5766.1 5798.6 5801.8 5829.6 5850.4 5617.7 5720.9 5725.6 5734.6 5788.2 5053.8 5056.7 5056.8 5070.4 5071.1 20095.7 20677.6 20769.3 20828.4 21129.6 2074.2 2100.6 2101.4 2107.2 2194.5 13208.8 13213.0 13292.3 13362.9 13487.9 1689.7 1770.4 1829.6 1834.7 1954.1 51981.0 53039.8 55059.4 55176.2 56090.7 8906.0 9551.3 9555.6 9559.9 9599.2 11432.9 11500.2 11502.9 11508.7 11509.9 7450.5 7507.5 7570.2 7609.5 7627.7 7185.9 7206.5 7264.1 7273.7 7584.8 5553.5 5737.8 5766.6 5805.7 5826.7 1499.4 1581.1 1614.9 1623.3 1633.2 938.2 945.2 949.5 953.7 1039.7 15889.8 16100.7 16355.3 16456.3 16735.3 957.9 967.1 975.1 997.9 1006.0 9684.0 10115.7 10163.4 10180.4 10248.5 380774.0 387252.0 515684.0 525439.0 525841.0 42657.6 42779.4 46315.0 71481.6 81440.7 1133.6 1137.3 1178.9 1198.1 1214.6 15195.4 15210.2 15477.3 15519.1 15800.4 31702.0 32996.2 33009.5 33082.3 33264.0 40186.4 43385.3 46007.5 46345.8 47164.0 9115.1 9377.8 9542.4 9595.3 9681.8 11315.9 11329.2 11429.3 15934.4 16992.4 13937.1 13947.4 14057.3 14390.4 14850.0 13860.9 14055.4 14355.1 14402.4 14440.0 13939.3 14015.4 14018.8 14165.2 14905.2 9507.2 9551.4 9654.7 9866.6 9873.6 10000.6 10113.1 13434.5 13479.9 14663.8 11:12:57 INFO - PROCESS | 6912 | 11:12:57 INFO - PROCESS | 6912 | [#3] mootools.html Cycles:180 Average:4977.10 Median:6363.68 stddev:2511.52 (39.5%) stddev-sans-first:2503.43 11:12:57 INFO - PROCESS | 6912 | Values: 1309.2 1421.4 1434.3 1569.4 1763.9 6229.3 6829.3 6935.8 6945.4 6960.3 6852.0 7028.1 7053.3 7054.5 7056.0 2163.5 2187.4 2197.8 2201.7 2204.1 2177.3 2202.9 2261.6 2264.7 2274.6 2159.0 2164.4 2189.9 2191.1 2227.8 2176.7 2190.5 2206.6 2206.9 2209.4 2193.6 2222.3 2223.7 2225.0 2228.3 6948.2 7022.6 7028.8 7034.9 7045.5 4244.5 4303.9 4343.0 4343.9 4381.7 2738.0 2759.9 2813.7 2815.9 2821.2 855.7 895.7 895.9 1846.6 1876.5 9335.6 9385.5 9429.4 9429.4 9434.9 3607.6 3735.2 3753.7 3800.0 3800.4 7465.5 7473.5 7485.7 7488.8 7496.7 4184.3 4214.6 4236.7 4237.6 4239.5 3642.3 3749.6 3912.2 3914.8 3915.2 3236.0 3241.8 3276.3 3302.5 3306.8 966.3 966.7 972.3 982.1 994.7 1008.8 1050.1 1080.5 1363.3 1364.5 6550.7 6617.4 6671.8 6803.3 6812.4 604.0 611.9 613.1 615.5 753.3 5113.3 5430.3 5518.1 5554.2 5554.8 8322.7 8542.1 8563.4 8569.6 8571.3 8419.2 8437.5 8442.6 8458.5 8462.4 6726.6 6873.9 6888.4 6900.3 6942.3 6640.6 6661.0 6661.7 6666.8 6697.9 7516.2 7797.1 7803.4 7819.3 7822.1 7276.6 7384.7 7394.7 7489.9 7492.6 5934.1 6091.7 6323.1 6332.8 6394.6 6909.1 6923.2 6970.7 6987.8 6998.0 6459.0 6513.0 6606.7 6610.1 6633.0 6405.9 6418.6 6436.9 6529.8 6580.7 6503.3 6550.2 6560.4 6561.2 6562.1 5947.8 6095.9 6105.2 6138.8 6162.0 5990.9 6082.0 6115.4 6141.4 6142.4 11:12:57 INFO - PROCESS | 6912 | 11:12:57 INFO - PROCESS | 6912 | [#4] prototype.html Cycles:180 Average:5276.41 Median:5947.60 stddev:1592.51 (26.8%) stddev-sans-first:1553.00 11:12:57 INFO - PROCESS | 6912 | Values: 324.8 326.4 328.7 330.0 334.6 5924.5 5960.9 6000.6 6012.9 6026.5 5656.3 5732.8 5810.2 5872.4 5933.3 4547.4 4559.0 4559.7 4569.0 4588.9 4320.7 4530.9 4539.2 4568.6 4574.5 4365.4 4382.1 4485.5 4486.1 4486.3 4376.6 4456.2 4459.5 4468.4 4493.3 3912.8 3968.2 3977.4 3978.1 3982.4 5541.3 5616.9 5618.6 5622.2 5625.1 5272.5 5277.1 5283.3 5284.0 5294.8 6263.7 6264.4 6270.4 6273.1 6275.5 4396.4 4424.1 4425.2 4427.1 4438.3 6384.4 6548.4 6549.6 6558.6 6595.8 4533.8 4547.8 4549.2 4550.9 4559.5 4596.8 4598.7 4600.1 4601.9 4605.4 5281.0 5285.9 5293.1 5294.4 5295.6 6187.4 6297.2 6329.1 6347.1 6351.4 1591.0 1608.7 1610.2 1610.5 1611.0 1077.8 1082.1 1084.3 1097.1 1107.8 5960.7 5964.0 5967.9 6013.7 6026.4 6483.4 6493.0 6496.6 6497.6 6503.9 5773.6 5926.9 5927.4 5931.9 5934.5 3335.6 3467.9 3485.9 3513.5 3514.4 6696.2 6724.0 6742.2 6819.8 6832.6 6710.8 6714.5 6724.7 6726.5 6729.6 6574.3 6707.2 6719.3 6724.2 6804.7 6536.9 6537.8 6541.5 6544.6 6549.4 6474.4 6477.9 6484.8 6491.3 6493.0 6667.2 6816.0 6821.6 6824.1 6825.9 4479.0 4479.7 4481.4 4481.8 4482.2 6562.8 6563.0 6563.2 6563.8 6564.7 6212.5 6349.4 6352.8 6359.8 6396.7 6369.3 6370.6 6373.0 6381.4 6383.8 6248.4 6264.2 6264.7 6271.6 6276.6 6144.1 6196.2 6239.7 6316.3 6415.5 6213.1 6224.1 6227.4 6243.3 6252.1 11:12:57 INFO - PROCESS | 6912 | 11:12:57 INFO - PROCESS | 6912 | [#5] yui.html Cycles:180 Average:13243.90 Median:45126.44 stddev:15042.82 (33.3%) stddev-sans-first:15055.63 11:12:57 INFO - PROCESS | 6912 | Values: 723.7 739.3 785.0 830.6 847.1 13544.4 13596.8 13686.5 13737.7 13768.2 10937.8 12405.1 12561.9 12617.8 12622.1 829.3 839.3 843.0 843.4 843.4 829.9 830.3 830.3 830.8 831.9 866.4 869.3 873.8 876.2 876.4 871.9 874.7 879.8 881.3 885.6 649.3 650.3 650.7 650.9 651.5 13443.2 13491.8 13628.5 13629.9 13642.7 11974.4 12057.3 12307.8 12369.3 12695.9 9801.7 10916.5 10931.4 11181.6 11546.8 3309.2 3341.4 3364.2 3439.4 3442.0 43021.4 43365.3 43457.0 43655.1 43672.9 9054.2 9370.9 9413.7 9476.5 9477.7 17648.6 17687.2 17744.5 17748.7 17762.9 7211.0 7258.9 7321.5 7345.8 7463.8 4243.6 4251.1 4279.8 4289.2 4302.0 3059.2 3103.1 3107.2 3109.1 3110.5 502.0 512.4 516.0 519.4 524.0 521.4 645.8 649.3 656.6 677.7 8374.9 8419.5 8452.7 8571.0 8828.7 540.2 542.2 631.7 664.2 673.7 3552.7 3730.8 4082.4 4223.8 4357.1 54732.0 55696.0 55743.4 55926.0 55941.0 38754.8 43415.1 48968.5 49641.3 50365.0 38767.2 44558.1 45168.5 46433.3 46555.1 8416.3 8750.2 9032.4 9169.3 9174.1 33690.0 34478.8 34640.5 34649.2 35142.6 42029.0 42031.8 42863.1 44843.0 45084.3 9629.8 9892.3 10024.3 10256.2 10344.9 11196.4 11354.9 11357.8 11452.3 11486.5 10710.2 10760.6 10790.6 10860.6 10941.1 11202.7 11266.2 11269.1 11278.7 11278.8 10827.7 10973.8 11012.7 11020.9 11055.7 9479.2 9857.4 9901.0 9908.4 9945.6 8375.3 9379.4 9389.3 9510.4 9590.4 11:12:57 INFO - PROCESS | 6912 | -------- Summary: end -------- 11:12:57 INFO - PROCESS | 6912 | 11:12:57 INFO - TEST-INFO | 6912: exit 0 11:12:57 INFO - TEST-OK | dromaeo_css | took 1112646ms 11:12:57 INFO - TEST-START | kraken 11:12:57 INFO - operating with platform_type : linux_ 11:12:57 INFO - Initialising browser for kraken test... 11:12:57 INFO - TEST-INFO | started process 7106 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFCJmWv/profile http://localhost:56807/getInfo.html) 11:13:01 INFO - PROCESS | 7106 | __metrics Screen width/height:1600/1200 11:13:01 INFO - PROCESS | 7106 | colorDepth:24 11:13:01 INFO - PROCESS | 7106 | Browser inner width/height: 1024/697 11:13:01 INFO - PROCESS | 7106 | __metrics 11:13:01 INFO - PROCESS | 7106 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:13:01 INFO - PROCESS | 7106 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:13:03 INFO - TEST-INFO | 7106: exit 0 11:13:03 INFO - Browser initialized. 11:13:03 INFO - Running cycle 1/1 for kraken test... 11:13:03 INFO - TEST-INFO | started process 7193 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFCJmWv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:13:14 INFO - PROCESS | 7193 | RSS: Main: 150097920 11:13:14 INFO - PROCESS | 7193 | 11:13:17 INFO - PROCESS | 7193 | Cycle 1(1): loaded http://localhost:56807/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56807/tests/kraken/driver.html?testName=audio-beat-detection) 11:13:18 INFO - PROCESS | 7193 | RSS: Main: 184700928 11:13:18 INFO - PROCESS | 7193 | 11:13:20 INFO - PROCESS | 7193 | Cycle 1(1): loaded http://localhost:56807/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56807/tests/kraken/driver.html?testName=audio-dft) 11:13:21 INFO - PROCESS | 7193 | RSS: Main: 176054272 11:13:21 INFO - PROCESS | 7193 | 11:13:24 INFO - PROCESS | 7193 | Cycle 1(1): loaded http://localhost:56807/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56807/tests/kraken/driver.html?testName=audio-fft) 11:13:24 INFO - PROCESS | 7193 | RSS: Main: 160194560 11:13:24 INFO - PROCESS | 7193 | 11:13:26 INFO - PROCESS | 7193 | Cycle 1(1): loaded http://localhost:56807/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56807/tests/kraken/driver.html?testName=audio-oscillator) 11:13:27 INFO - PROCESS | 7193 | RSS: Main: 162279424 11:13:27 INFO - PROCESS | 7193 | 11:13:29 INFO - PROCESS | 7193 | Cycle 1(1): loaded http://localhost:56807/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56807/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:13:30 INFO - PROCESS | 7193 | RSS: Main: 164270080 11:13:30 INFO - PROCESS | 7193 | 11:13:33 INFO - PROCESS | 7193 | Cycle 1(1): loaded http://localhost:56807/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56807/tests/kraken/driver.html?testName=imaging-darkroom) 11:13:33 INFO - PROCESS | 7193 | RSS: Main: 164323328 11:13:33 INFO - PROCESS | 7193 | 11:13:36 INFO - PROCESS | 7193 | Cycle 1(1): loaded http://localhost:56807/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56807/tests/kraken/driver.html?testName=imaging-desaturate) 11:13:37 INFO - PROCESS | 7193 | RSS: Main: 167399424 11:13:37 INFO - PROCESS | 7193 | 11:13:40 INFO - PROCESS | 7193 | Cycle 1(1): loaded http://localhost:56807/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56807/tests/kraken/driver.html?testName=json-parse-financial) 11:13:40 INFO - PROCESS | 7193 | RSS: Main: 166719488 11:13:40 INFO - PROCESS | 7193 | 11:13:42 INFO - PROCESS | 7193 | Cycle 1(1): loaded http://localhost:56807/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56807/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:13:42 INFO - PROCESS | 7193 | RSS: Main: 178208768 11:13:42 INFO - PROCESS | 7193 | 11:13:44 INFO - PROCESS | 7193 | Cycle 1(1): loaded http://localhost:56807/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56807/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:13:45 INFO - PROCESS | 7193 | RSS: Main: 174338048 11:13:45 INFO - PROCESS | 7193 | 11:13:47 INFO - PROCESS | 7193 | Cycle 1(1): loaded http://localhost:56807/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56807/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:13:48 INFO - PROCESS | 7193 | RSS: Main: 183996416 11:13:48 INFO - PROCESS | 7193 | 11:13:50 INFO - PROCESS | 7193 | Cycle 1(1): loaded http://localhost:56807/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56807/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:13:50 INFO - PROCESS | 7193 | RSS: Main: 190042112 11:13:50 INFO - PROCESS | 7193 | 11:13:53 INFO - PROCESS | 7193 | Cycle 1(1): loaded http://localhost:56807/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56807/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:13:54 INFO - PROCESS | 7193 | RSS: Main: 190013440 11:13:54 INFO - PROCESS | 7193 | 11:13:55 INFO - PROCESS | 7193 | Cycle 1(1): loaded http://localhost:56807/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56807/tests/kraken/driver.html?testName=ai-astar) 11:13:56 INFO - PROCESS | 7193 | RSS: Main: 247083008 11:13:56 INFO - PROCESS | 7193 | 11:13:56 INFO - PROCESS | 7193 | __start_tp_report 11:13:56 INFO - PROCESS | 7193 | _x_x_mozilla_page_load 11:13:56 INFO - PROCESS | 7193 | _x_x_mozilla_page_load_details 11:13:56 INFO - PROCESS | 7193 | |i|pagename|runs| 11:13:56 INFO - PROCESS | 7193 | |0;ai-astar;109;111;105;112;112;111;101;111;111;103 11:13:56 INFO - PROCESS | 7193 | |1;audio-beat-detection;156;127;156;169;132;157;167;138;173;123 11:13:56 INFO - PROCESS | 7193 | |2;audio-dft;162;161;162;160;161;161;161;159;162;161 11:13:56 INFO - PROCESS | 7193 | |3;audio-fft;72;73;87;90;74;71;71;93;97;74 11:13:56 INFO - PROCESS | 7193 | |4;audio-oscillator;97;96;142;97;97;96;145;96;96;139 11:13:56 INFO - PROCESS | 7193 | |5;imaging-gaussian-blur;109;109;109;109;110;109;109;109;109;109 11:13:56 INFO - PROCESS | 7193 | |6;imaging-darkroom;146;146;145;145;145;146;145;145;146;147 11:13:56 INFO - PROCESS | 7193 | |7;imaging-desaturate;96;95;96;96;96;96;96;96;96;95 11:13:56 INFO - PROCESS | 7193 | |8;json-parse-financial;60;58;57;58;58;56;56;66;54;55 11:13:56 INFO - PROCESS | 7193 | |9;json-stringify-tinderbox;69;68;69;70;69;68;68;69;68;68 11:13:56 INFO - PROCESS | 7193 | |10;stanford-crypto-aes;85;85;94;86;86;87;94;85;86;86 11:13:56 INFO - PROCESS | 7193 | |11;stanford-crypto-ccm;118;116;120;114;115;120;117;125;120;118 11:13:56 INFO - PROCESS | 7193 | |12;stanford-crypto-pbkdf2;142;153;153;150;161;142;151;150;150;143 11:13:56 INFO - PROCESS | 7193 | |13;stanford-crypto-sha256-iterative;68;75;68;69;70;70;67;67;68;68 11:13:56 INFO - PROCESS | 7193 | __end_tp_report 11:13:56 INFO - PROCESS | 7193 | __start_cc_report 11:13:56 INFO - PROCESS | 7193 | _x_x_mozilla_cycle_collect,928 11:13:56 INFO - PROCESS | 7193 | __end_cc_report 11:13:56 INFO - PROCESS | 7193 | __startTimestamp1451502836084__endTimestamp 11:13:56 INFO - PROCESS | 7193 | 11:13:56 INFO - PROCESS | 7193 | ------- Summary: start ------- 11:13:56 INFO - PROCESS | 7193 | Number of tests: 14 11:13:56 INFO - PROCESS | 7193 | 11:13:56 INFO - PROCESS | 7193 | [#0] ai-astar Cycles:10 Average:108.60 Median:111.00 stddev:4.06 (3.7%) stddev-sans-first:4.30 11:13:56 INFO - PROCESS | 7193 | Values: 109.0 111.0 105.0 112.0 112.0 111.0 101.0 111.0 111.0 103.0 11:13:56 INFO - PROCESS | 7193 | 11:13:56 INFO - PROCESS | 7193 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:156.50 stddev:18.34 (11.7%) stddev-sans-first:19.31 11:13:56 INFO - PROCESS | 7193 | Values: 156.0 127.0 156.0 169.0 132.0 157.0 167.0 138.0 173.0 123.0 11:13:56 INFO - PROCESS | 7193 | 11:13:56 INFO - PROCESS | 7193 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 11:13:56 INFO - PROCESS | 7193 | Values: 162.0 161.0 162.0 160.0 161.0 161.0 161.0 159.0 162.0 161.0 11:13:56 INFO - PROCESS | 7193 | 11:13:56 INFO - PROCESS | 7193 | [#3] audio-fft Cycles:10 Average:80.20 Median:80.50 stddev:10.29 (12.8%) stddev-sans-first:10.48 11:13:56 INFO - PROCESS | 7193 | Values: 72.0 73.0 87.0 90.0 74.0 71.0 71.0 93.0 97.0 74.0 11:13:56 INFO - PROCESS | 7193 | 11:13:56 INFO - PROCESS | 7193 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:96.00 stddev:22.06 (23.0%) stddev-sans-first:22.89 11:13:56 INFO - PROCESS | 7193 | Values: 97.0 96.0 142.0 97.0 97.0 96.0 145.0 96.0 96.0 139.0 11:13:56 INFO - PROCESS | 7193 | 11:13:56 INFO - PROCESS | 7193 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:13:56 INFO - PROCESS | 7193 | Values: 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 11:13:56 INFO - PROCESS | 7193 | 11:13:56 INFO - PROCESS | 7193 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 11:13:56 INFO - PROCESS | 7193 | Values: 146.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 146.0 147.0 11:13:56 INFO - PROCESS | 7193 | 11:13:56 INFO - PROCESS | 7193 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:13:56 INFO - PROCESS | 7193 | Values: 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 11:13:56 INFO - PROCESS | 7193 | 11:13:56 INFO - PROCESS | 7193 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:3.36 (5.8%) stddev-sans-first:3.47 11:13:56 INFO - PROCESS | 7193 | Values: 60.0 58.0 57.0 58.0 58.0 56.0 56.0 66.0 54.0 55.0 11:13:56 INFO - PROCESS | 7193 | 11:13:56 INFO - PROCESS | 7193 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 11:13:56 INFO - PROCESS | 7193 | Values: 69.0 68.0 69.0 70.0 69.0 68.0 68.0 69.0 68.0 68.0 11:13:56 INFO - PROCESS | 7193 | 11:13:56 INFO - PROCESS | 7193 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:86.00 stddev:3.53 (4.1%) stddev-sans-first:3.64 11:13:56 INFO - PROCESS | 7193 | Values: 85.0 85.0 94.0 86.0 86.0 87.0 94.0 85.0 86.0 86.0 11:13:56 INFO - PROCESS | 7193 | 11:13:56 INFO - PROCESS | 7193 | [#11] stanford-crypto-ccm Cycles:10 Average:118.30 Median:119.00 stddev:3.16 (2.7%) stddev-sans-first:3.35 11:13:56 INFO - PROCESS | 7193 | Values: 118.0 116.0 120.0 114.0 115.0 120.0 117.0 125.0 120.0 118.0 11:13:56 INFO - PROCESS | 7193 | 11:13:56 INFO - PROCESS | 7193 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.50 Median:150.50 stddev:5.91 (3.9%) stddev-sans-first:5.61 11:13:56 INFO - PROCESS | 7193 | Values: 142.0 153.0 153.0 150.0 161.0 142.0 151.0 150.0 150.0 143.0 11:13:56 INFO - PROCESS | 7193 | 11:13:56 INFO - PROCESS | 7193 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:68.50 stddev:2.36 (3.4%) stddev-sans-first:2.47 11:13:56 INFO - PROCESS | 7193 | Values: 68.0 75.0 68.0 69.0 70.0 70.0 67.0 67.0 68.0 68.0 11:13:56 INFO - PROCESS | 7193 | -------- Summary: end -------- 11:13:56 INFO - PROCESS | 7193 | 11:13:56 INFO - TEST-INFO | 7193: exit 0 11:13:56 INFO - TEST-OK | kraken | took 59064ms 11:13:56 INFO - TEST-START | v8_7 11:13:56 INFO - operating with platform_type : linux_ 11:13:56 INFO - Initialising browser for v8_7 test... 11:13:56 INFO - TEST-INFO | started process 7442 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMYuv0x/profile http://localhost:56807/getInfo.html) 11:14:01 INFO - PROCESS | 7442 | __metrics Screen width/height:1600/1200 11:14:01 INFO - PROCESS | 7442 | colorDepth:24 11:14:01 INFO - PROCESS | 7442 | Browser inner width/height: 1024/697 11:14:01 INFO - PROCESS | 7442 | __metrics 11:14:01 INFO - PROCESS | 7442 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:14:01 INFO - PROCESS | 7442 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:14:02 INFO - TEST-INFO | 7442: exit 0 11:14:02 INFO - Browser initialized. 11:14:02 INFO - Running cycle 1/1 for v8_7 test... 11:14:02 INFO - TEST-INFO | started process 7530 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMYuv0x/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:14:13 INFO - PROCESS | 7530 | RSS: Main: 149139456 11:14:13 INFO - PROCESS | 7530 | 11:14:35 INFO - PROCESS | 7530 | Cycle 1(1): loaded http://localhost:56807/tests/v8_7/run.html (next: http://localhost:56807/tests/v8_7/run.html) 11:14:35 INFO - PROCESS | 7530 | RSS: Main: 595652608 11:14:35 INFO - PROCESS | 7530 | 11:14:35 INFO - PROCESS | 7530 | __start_tp_report 11:14:35 INFO - PROCESS | 7530 | _x_x_mozilla_page_load 11:14:35 INFO - PROCESS | 7530 | _x_x_mozilla_page_load_details 11:14:35 INFO - PROCESS | 7530 | |i|pagename|runs| 11:14:35 INFO - PROCESS | 7530 | |0;Richards;168.40687100033682 11:14:35 INFO - PROCESS | 7530 | |1;DeltaBlue;193.64833462432222 11:14:35 INFO - PROCESS | 7530 | |2;Encrypt;284.0102243680773 11:14:35 INFO - PROCESS | 7530 | |3;Decrypt;5186.5284974093265 11:14:35 INFO - PROCESS | 7530 | |4;RayTrace;1145.475372279496 11:14:35 INFO - PROCESS | 7530 | |5;Earley;796.8127490039841 11:14:35 INFO - PROCESS | 7530 | |6;Boyer;12414.634146341463 11:14:35 INFO - PROCESS | 7530 | |7;RegExp;26256.410256410258 11:14:35 INFO - PROCESS | 7530 | |8;Splay;642.2607578676943 11:14:35 INFO - PROCESS | 7530 | |9;NavierStokes;4840.579710144928 11:14:35 INFO - PROCESS | 7530 | __end_tp_report 11:14:35 INFO - PROCESS | 7530 | __startTimestamp1451502875603__endTimestamp 11:14:35 INFO - PROCESS | 7530 | 11:14:35 INFO - PROCESS | 7530 | ------- Summary: start ------- 11:14:35 INFO - PROCESS | 7530 | Number of tests: 10 11:14:35 INFO - PROCESS | 7530 | 11:14:35 INFO - PROCESS | 7530 | [#0] Richards Cycles:1 Average:168.41 Median:168.41 stddev:0.00 (0.0%) 11:14:35 INFO - PROCESS | 7530 | Values: 168.4 11:14:35 INFO - PROCESS | 7530 | 11:14:35 INFO - PROCESS | 7530 | [#1] DeltaBlue Cycles:1 Average:193.65 Median:193.65 stddev:0.00 (0.0%) 11:14:35 INFO - PROCESS | 7530 | Values: 193.6 11:14:35 INFO - PROCESS | 7530 | 11:14:35 INFO - PROCESS | 7530 | [#2] Encrypt Cycles:1 Average:284.01 Median:284.01 stddev:0.00 (0.0%) 11:14:35 INFO - PROCESS | 7530 | Values: 284.0 11:14:35 INFO - PROCESS | 7530 | 11:14:35 INFO - PROCESS | 7530 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 11:14:35 INFO - PROCESS | 7530 | Values: 5186.5 11:14:35 INFO - PROCESS | 7530 | 11:14:35 INFO - PROCESS | 7530 | [#4] RayTrace Cycles:1 Average:1145.48 Median:1145.48 stddev:0.00 (0.0%) 11:14:35 INFO - PROCESS | 7530 | Values: 1145.5 11:14:35 INFO - PROCESS | 7530 | 11:14:35 INFO - PROCESS | 7530 | [#5] Earley Cycles:1 Average:796.81 Median:796.81 stddev:0.00 (0.0%) 11:14:35 INFO - PROCESS | 7530 | Values: 796.8 11:14:35 INFO - PROCESS | 7530 | 11:14:35 INFO - PROCESS | 7530 | [#6] Boyer Cycles:1 Average:12414.63 Median:12414.63 stddev:0.00 (0.0%) 11:14:35 INFO - PROCESS | 7530 | Values: 12414.6 11:14:35 INFO - PROCESS | 7530 | 11:14:35 INFO - PROCESS | 7530 | [#7] RegExp Cycles:1 Average:26256.41 Median:26256.41 stddev:0.00 (0.0%) 11:14:35 INFO - PROCESS | 7530 | Values: 26256.4 11:14:35 INFO - PROCESS | 7530 | 11:14:35 INFO - PROCESS | 7530 | [#8] Splay Cycles:1 Average:642.26 Median:642.26 stddev:0.00 (0.0%) 11:14:35 INFO - PROCESS | 7530 | Values: 642.3 11:14:35 INFO - PROCESS | 7530 | 11:14:35 INFO - PROCESS | 7530 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 11:14:35 INFO - PROCESS | 7530 | Values: 4840.6 11:14:35 INFO - PROCESS | 7530 | -------- Summary: end -------- 11:14:35 INFO - PROCESS | 7530 | 11:14:36 INFO - TEST-INFO | 7530: exit 0 11:14:36 INFO - TEST-OK | v8_7 | took 39549ms 11:14:36 INFO - SUITE-END | took 1211s 11:14:36 INFO - Completed test suite (00:20:11) 11:14:36 INFO - Working with test: dromaeo_css 11:14:36 INFO - Generating results file: dromaeo_css 11:14:36 INFO - Working with test: kraken 11:14:36 INFO - Generating results file: kraken 11:14:36 INFO - javascript benchmark 11:14:36 INFO - Working with test: v8_7 11:14:36 INFO - Generating results file: v8_7 11:14:36 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:14:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 11:14:36 INFO - process_Request line: dromaeo_css 6753.86 graph.html#tests=[[72,64,35]] 11:14:36 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:14:36 INFO - process_Request line: kraken 1510.80 graph.html#tests=[[232,64,35]] 11:14:36 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:14:36 INFO - process_Request line: v8_7 20640.31 graph.html#tests=[[230,64,35]] 11:14:36 INFO - RETURN: dromaeo_css: 6753.86 11:14:36 INFO - RETURN: kraken: 1510.80 11:14:36 INFO - RETURN: v8_7: 20640.31 11:14:36 INFO - javascript benchmark 11:14:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3031.9696803031966, 3051.176182430745, 3094.922626934326, 3096.7212950834432, 3119.7192252697255, 5135.332406787122, 5267.130923397634, 5271.262023316739, 5280.5247527722495, 5308.575313974882, 5210.452902445246, 5287.074761916669, 5293.047251494739, 5316.4683531646815, 5403.054465468537, 4803.9279410808695, 4807.206810876201, 4839.879003024917, 4900.362952816146, 4909.337239472661, 4762.880927976811, 4903.82836600719, 4933.481984391641, 4943.950560494403, 4985.950140498603, 4743.573078422924, 4834.6374021948495, 4848.369711937461, 4882.926756098625, 4915.090708218973, 4796.664233503656, 4799.448063472711, 4803.327534145223, 4813.446453657839, 4828.782704778258, 4767.451743049559, 4772.188727916263, 4781.211100168468, 4803.95196048042, 4810.470848206694, 5035.320231768701, 5118.6416950813455, 5164.612654050924, 5208.661437006583, 5239.0, 5653.180288858133, 5659.8585035374035, 5677.403872593401, 5707.77168913243, 5716.314042314907, 5463.672179669193, 5645.858853528694, 5668.404817494145, 5674.460926212003, 5679.460451257165, 5237.162054071368, 5242.606804489678, 5265.815696450644, 5323.600729945192, 5349.0639138151055, 5726.226959360433, 5727.742251598688, 5730.5129064030025, 5733.655980641175, 5740.799072032459, 5334.973325133349, 5534.308211473566, 5535.114381698909, 5538.695371754511, 5571.860703482445, 5453.672779633234, 5473.8357849264585, 5670.858228544319, 5729.226554415184, 5765.106408506688, 5488.368837583729, 5510.338759348823, 5510.448955104457, 5516.503514683698, 5518.834434966958, 5460.34475862899, 5536.944630553723, 5537.8061767837935, 5548.472895074961, 5574.693391863487, 4333.566643335705, 4353.281708518122, 4358.738475691469, 4369.584889435499, 4414.117176564636, 3826.445165450994, 3836.271108489378, 3855.8650447234213, 3877.941830872539, 3904.648581627667, 5146.25379320004, 5191.299174611455, 5205.6356055075785, 5207.6875387476875, 5251.238570407269, 5633.070543360382, 5633.464820842013, 5663.518600918886, 5665.291838520185, 5710.685912274865, 5260.842174734764, 5261.605379596545, 5262.55268302191, 5305.0, 5305.363356397257, 4888.780004899788, 4891.5353041461, 4893.681910675795, 4907.975460122677, 4940.481249468826, 5633.718314084279, 5687.60186786921, 5758.884822303614, 5850.502707269845, 5852.795152169739, 5610.382857885711, 5675.26221591207, 5676.716164191691, 5678.346990096192, 5720.141978703228, 5816.0, 5821.592488525763, 5830.358660547421, 5832.387599302012, 5836.416358364299, 5460.126379779216, 5524.889502210013, 5572.498475137257, 5575.637583557056, 5583.720813959367, 5644.520215781705, 5681.488666020078, 5709.143628455765, 5718.599698021098, 5770.365259821332, 5499.422560631237, 5534.308211473566, 5538.44615538459, 5538.806141785019, 5544.029794785815, 5361.115415956324, 5440.102383106743, 5465.945340546703, 5522.751476183501, 5524.917126243029, 5435.755391007493, 5443.945560544344, 5444.8366549003595, 5445.319335083114, 5470.288862447856, 5520.06158952971, 5540.168974653834, 5551.417101204315, 5552.083906155439, 5592.972035139798, 5267.78928842842, 5315.069862774077, 5362.329708786402, 5380.892382152413, 5418.431064738145], "unit": "score", "name": "dojo.html", "value": 5192.2805168384675}, {"lowerIsBetter": false, "replicates": [537.1405750798723, 538.0557122250452, 553.7259056766901, 559.4433538629065, 575.9517677826356, 28658.283542911413, 29293.56059659104, 35885.82057089711, 36193.0951726207, 36244.0, 38625.0, 38938.8053059735, 39130.8043459783, 39171.21657566847, 39203.0, 7405.148407933103, 8369.079401265855, 8527.658893644279, 8549.914500854975, 8551.358648101386, 7499.062617172854, 9846.55690493926, 10031.69904902854, 10034.147097496721, 10035.096841284283, 9893.505324733735, 10019.148372388356, 10021.649242276522, 10021.949890250575, 10029.348092373972, 7566.924330756732, 7722.768316950444, 9765.951170244174, 9974.900250997469, 9983.351082179672, 9739.853902191473, 9859.605615775361, 9888.703338899773, 9897.059779320953, 9898.406095634286, 35432.82283588591, 35974.64025359739, 35988.0, 36000.63999359999, 36052.63947360545, 3007.0377479206663, 3070.631524217108, 3162.604674415698, 3465.0297916583395, 3859.6526312631718, 29893.103206903827, 30309.393812123635, 30394.0, 30414.087577372713, 30592.082237532908, 3874.9612503874882, 3881.825317860703, 3882.3788193889127, 3911.9608803911883, 3926.1558764865404, 255289.0, 255681.0, 256141.0, 257573.0, 258839.0, 49328.0, 55568.0, 55886.0, 55982.72008640012, 56030.71984640132, 45544.0, 45654.54345456503, 45729.771351143034, 45740.771296143306, 59815.401845981854, 15270.847291527165, 15349.769753453707, 15374.38502459889, 15475.0, 15479.845201548065, 11899.345535995604, 11969.521219151311, 12048.0, 12055.276683399024, 12060.517579296906, 17932.9103354485, 18077.909610452127, 18125.18436670353, 18136.45590632283, 18170.364037258634, 7292.8906066409045, 7546.471746977659, 7612.2387761224545, 7616.466847320745, 7778.611069446618, 910.5583791860943, 936.6628013914985, 1020.7634833305098, 1035.4098164046572, 1066.2749330455365, 27425.31436714098, 28478.572821407695, 28612.856935715186, 31004.0, 31059.68940310568, 1017.5777052523268, 1018.592562974816, 1026.296986564206, 1057.7567159553346, 1115.5370521233597, 12932.547360842513, 13197.868021319857, 13264.403101860247, 13307.733845323039, 13400.12899161571, 292030.0, 296811.0, 297227.0, 298083.0, 298765.0, 49775.0, 50076.248856267186, 50189.74905125524, 50203.497965020615, 50224.246636300486, 1250.9499620015097, 1351.8986076044337, 1370.239517068017, 1370.3011464153153, 1371.3074897177062, 23711.644325335477, 24697.62953555662, 25552.23343299704, 25577.232683019538, 28204.0, 39376.803115985385, 39472.802635986634, 39528.40707389449, 39572.40641390439, 39612.0, 228568.0, 229218.0, 229831.0, 230989.0, 231188.0, 26733.86633066822, 27487.86256068707, 30606.0, 30971.845140774152, 31160.22099447532, 34442.311153777286, 35251.82374088113, 35351.46972795359, 35354.0, 35707.28585428329, 29420.117396477282, 30693.693063069084, 31242.0, 31388.0, 31721.8413907929, 32917.0, 32920.506192406654, 33725.15687107842, 33873.49189762205, 33955.0, 31987.6801231994, 32702.182445439055, 32718.182045449055, 33059.50410743889, 33127.83436082804, 28882.855585721936, 30238.84880575583, 30418.391632167677, 30752.846235768677, 30788.230294241926, 23174.553979815068, 23229.3031209064, 23423.76576234216, 23485.41286467852, 23527.176548821393], "unit": "score", "name": "ext.html", "value": 17498.825282361944}, {"lowerIsBetter": false, "replicates": [341.7710134210079, 342.6915775801778, 344.6484585722563, 344.844819831076, 344.89997900608824, 13984.720305593908, 14430.711385772305, 16139.838601613981, 16283.348666053358, 17315.480535583938, 14447.638809029753, 15976.0, 16313.755293670574, 16359.672806543891, 16377.83622163778, 5185.144451165553, 5322.308099947021, 5324.227986941891, 5329.760160792774, 5330.280412144369, 3975.8210880510446, 4089.9182016359655, 5256.5794736421185, 5305.761240744157, 5676.290463692038, 5766.106253530688, 5798.623089499169, 5801.767929282823, 5829.562782791287, 5850.414958504158, 5617.747201375927, 5720.856978575527, 5725.599208055438, 5734.598578099534, 5788.160716696077, 5053.797848086072, 5056.721880296583, 5056.82301119459, 5070.416902056237, 5071.137906555858, 20095.698564521397, 20677.5864482711, 20769.27307544229, 20828.375148745563, 21129.5774084519, 2074.201432448503, 2100.5588826346484, 2101.369589123257, 2107.2097963263777, 2194.462356722613, 13208.801867971988, 13213.0, 13292.26892520911, 13362.933185334108, 13487.86512134876, 1689.6874078295555, 1770.4069136839175, 1829.5609053827118, 1834.7156190790315, 1954.1011134877974, 51981.0, 53039.841689969486, 55059.44940550583, 55176.172357414674, 56090.719546402004, 8906.0, 9551.331406801457, 9555.569999349907, 9559.94840567551, 9599.184069354043, 11432.913873182035, 11500.194986350874, 11502.94248528752, 11508.654740357802, 11509.942450287863, 7450.515716478411, 7507.474476786681, 7570.205128461433, 7609.467337286447, 7627.656755446018, 7185.928140718631, 7206.531575447579, 7264.091988501437, 7273.709051637981, 7584.810379740551, 5553.527950124285, 5737.827865163968, 5766.596338256366, 5805.651660900359, 5826.679532625746, 1499.4452052740337, 1581.122477025239, 1614.8869579129582, 1623.2695287120844, 1633.2405431474422, 938.2212763406357, 945.1965829045394, 949.5015117063597, 953.7281874665825, 1039.714078628368, 15889.841101589067, 16100.677986440205, 16355.34578616842, 16456.341746330014, 16735.330586776636, 957.875476188105, 967.1295833749541, 975.1321324021626, 997.9201663866874, 1006.0090810551601, 9683.951580242054, 10115.696529104138, 10163.44101074448, 10180.440075795903, 10248.538815753309, 380774.0, 387252.0, 515684.0, 525439.0, 525841.0, 42657.57342426598, 42779.35830962538, 46315.0, 71481.6425917867, 81440.65086155167, 1133.6485689436302, 1137.3460260350332, 1178.8997935175435, 1198.0954379443638, 1214.6173955204083, 15195.392184312946, 15210.16344101085, 15477.303521341792, 15519.146446945526, 15800.446984355493, 31702.0, 32996.1750956228, 33009.50485742764, 33082.33835323328, 33264.0, 40186.39720404255, 43385.3492197611, 46007.53992460033, 46345.76827115843, 47164.0, 9115.134062264075, 9377.765555861159, 9542.379745316532, 9595.328327017041, 9681.757956051155, 11315.943420283174, 11329.206955513035, 11429.257098288585, 15934.442294519637, 16992.405265815636, 13937.1296954981, 13947.442102315794, 14057.297135143406, 14390.424383024561, 14850.0, 13860.861391385957, 14055.367508462348, 14355.138691678532, 14402.42390304376, 14439.989200755846, 13939.303034848013, 14015.439382424589, 14018.789718154032, 14165.22091284948, 14905.180215088274, 9507.239420846177, 9551.379160354554, 9654.71035868925, 9866.55600497965, 9873.605055797687, 10000.649977250761, 10113.14038306752, 13434.462621495422, 13479.932600336935, 14663.780043299146], "unit": "score", "name": "jquery.html", "value": 8657.722476746267}, {"lowerIsBetter": false, "replicates": [1309.155594641457, 1421.438531779947, 1434.2541878223324, 1569.4193148535037, 1763.91180440978, 6229.252489701236, 6829.317068293174, 6935.757248496304, 6945.444364450845, 6960.269171736971, 6852.0, 7028.121484814398, 7053.329933656307, 7054.541454805434, 7056.047433596463, 2163.5023944492814, 2187.442202238427, 2197.8241740660787, 2201.7027701260286, 2204.0853045985896, 2177.3032629558547, 2202.933911982643, 2261.6381378979368, 2264.739554951177, 2274.613315736329, 2158.9784102158933, 2164.361513353557, 2189.9452513687206, 2191.1454532732246, 2227.8106360959255, 2176.7170267865154, 2190.535851007761, 2206.6138425775584, 2206.8896555172178, 2209.4476380904775, 2193.561287742442, 2222.29997550771, 2223.666450032492, 2225.043231410493, 2228.3315005498284, 6948.166220053626, 7022.613756243404, 7028.824279393056, 7034.92965070353, 7045.506814522985, 4244.533101358848, 4303.892402689927, 4342.956570434287, 4343.9348409773875, 4381.671374646914, 2737.9589306160424, 2759.862006899647, 2813.7326953939546, 2815.873285702148, 2821.2241633550734, 855.6962278391206, 895.7268033249857, 895.9148880856309, 1846.556826361677, 1876.5121068522146, 9335.579898904498, 9385.530723463868, 9429.387089839138, 9429.434233945985, 9434.85847712278, 3607.603163651996, 3735.1782607826235, 3753.6997040236715, 3800.049987503124, 3800.410936304822, 7465.514741541782, 7473.51422157558, 7485.663145158372, 7488.812779680552, 7496.7376141834775, 4184.28867092595, 4214.557471465513, 4236.745795252295, 4237.5762423758, 4239.533651298355, 3642.307961487309, 3749.6062913393703, 3912.158885839558, 3914.8042597870563, 3915.2169566086895, 3235.9514607280908, 3241.789283696552, 3276.3447310537986, 3302.5211344354934, 3306.8015919044933, 966.3187452845867, 966.6568368229177, 972.3145182646217, 982.1455333859445, 994.6916455898549, 1008.7602867002811, 1050.1179009631946, 1080.4651697409834, 1363.3047145955634, 1364.4746772492463, 6550.70521826519, 6617.371349721769, 6671.833204169935, 6803.251642319341, 6812.386885180357, 603.9969800151059, 611.8868009418183, 613.1048668943304, 615.4614712126889, 753.2881427051384, 5113.335266415343, 5430.294061772023, 5518.144687573433, 5554.166874968787, 5554.750036248379, 8322.70870519529, 8542.145785421408, 8563.400561960727, 8569.614367353484, 8571.314294856396, 8419.242268195769, 8437.451565648213, 8442.577871106543, 8458.492490450593, 8462.449940753831, 6726.596404215665, 6873.896891546631, 6888.380045795802, 6900.274931267284, 6942.271061538567, 6640.568363056386, 6660.966695166493, 6661.666916654245, 6666.799996000128, 6697.933020669926, 7516.210797866145, 7797.064352277536, 7803.414743894117, 7819.257170568787, 7822.139564647998, 7276.636168191463, 7384.741534046498, 7394.741184058532, 7489.925100748923, 7492.587907665131, 5934.139549765174, 6091.7258723358445, 6323.083152942706, 6332.810015699536, 6394.552381333262, 6909.1018167637885, 6923.238443771282, 6970.686319115754, 6987.790366289019, 6997.965010174917, 6459.0, 6512.967435162794, 6606.735730570916, 6610.140681711347, 6633.0, 6405.903911441425, 6418.582792118684, 6436.935630643821, 6529.771457998947, 6580.670966451563, 6503.252126005381, 6550.213974322921, 6560.40956313934, 6561.245456772533, 6562.114114594468, 5947.762089516371, 6095.9390406097145, 6105.236845394325, 6138.754449821957, 6162.014077747718, 5990.910136347871, 6081.969590152021, 6115.388461154027, 6141.355157708376, 6142.447179753844], "unit": "score", "name": "mootools.html", "value": 4110.4607711964}, {"lowerIsBetter": false, "replicates": [324.8392045937261, 326.40105406578925, 328.73865277104727, 329.96205436374817, 334.5583829345262, 5924.496417804487, 5960.850978725529, 6000.609960352579, 6012.939870601293, 6026.4576188143055, 5656.349519805223, 5732.770689172438, 5810.215620891189, 5872.4127587241255, 5933.258342707161, 4547.386102876119, 4558.954410455903, 4559.680822342446, 4569.04050149469, 4588.908221835562, 4320.719153255044, 4530.909381812362, 4539.160255352754, 4568.565986231302, 4574.451065872084, 4365.388845561624, 4382.057857560624, 4485.52901945296, 4486.080353527535, 4486.327050942368, 4376.606105450524, 4456.17560751262, 4459.509453960061, 4468.396766436538, 4493.303537951639, 3912.8043597819997, 3968.1666849961543, 3977.423273625308, 3978.0507551299656, 3982.422548730447, 5541.33503979525, 5616.887662246773, 5618.57860660448, 5622.240997465331, 5625.099984002581, 5272.525472707436, 5277.050130976423, 5283.286756287929, 5284.0, 5294.814681486129, 6263.71813268404, 6264.436200741955, 6270.435660790551, 6273.090401891745, 6275.529335299871, 4396.406485124499, 4424.093060922535, 4425.22558552252, 4427.092446048585, 4438.334249862514, 6384.361563843625, 6548.443382312509, 6549.639769812658, 6558.606483610999, 6595.769148079842, 4533.841315554006, 4547.840825571089, 4549.158405694957, 4550.908981820345, 4559.498455169929, 4596.839110631112, 4598.701084429501, 4600.079984003212, 4601.884952876205, 4605.355250264965, 5280.973595132, 5285.947140528546, 5293.100172970604, 5294.444083371268, 5295.629305948623, 6187.412195841388, 6297.1813664223355, 6329.113924050636, 6347.143135676717, 6351.396617321347, 1591.0294720220656, 1608.6621809420153, 1610.2270909963283, 1610.5409958161868, 1610.9758353624704, 1077.8167711489066, 1082.1234799812178, 1084.3168803653648, 1097.1442275025333, 1107.7618312062946, 5960.7019649017375, 5964.0, 5967.880642387128, 6013.729382177812, 6026.427489388501, 6483.4164925156965, 6493.0, 6496.6426846522945, 6497.610143391412, 6503.869922601616, 5773.595848290579, 5926.851828704231, 5927.407259274124, 5931.851703707355, 5934.495567876779, 3335.5663763710563, 3467.930641387158, 3485.9302813944087, 3513.5256740340237, 3514.3674138655288, 6696.229933557704, 6724.0, 6742.157230346207, 6819.829504262433, 6832.555883867532, 6710.825605519015, 6714.496412769062, 6724.66376681164, 6726.529142959946, 6729.596224226562, 6574.276829548841, 6707.228668703162, 6719.260881303053, 6724.159480064992, 6804.727810887608, 6536.901946470712, 6537.803865884031, 6541.509386795914, 6544.607323560602, 6549.443297319591, 6474.449671777952, 6477.935220647733, 6484.837879053061, 6491.318411566717, 6493.0, 6667.166604174478, 6816.0, 6821.624810635264, 6824.112865327475, 6825.941978993264, 4478.977605112084, 4479.70881892676, 4481.439820022497, 4481.7535035572055, 4482.215612267905, 6562.77030303937, 6563.0, 6563.245226798979, 6563.835904102245, 6564.704588293443, 6212.47193988516, 6349.396807303298, 6352.809415717536, 6359.777407790705, 6396.744130234739, 6369.267534233622, 6370.649614271074, 6372.968135159294, 6381.3937675920715, 6383.776567820104, 6248.406656302614, 6264.154339164154, 6264.718087685974, 6271.62370257786, 6276.623402595859, 6144.1398204250545, 6196.225471816023, 6239.719212635533, 6316.305206427198, 6415.454686351713, 6213.068039794067, 6224.066390041349, 6227.408396202535, 6243.313235544178, 6252.124702541739], "unit": "score", "name": "prototype.html", "value": 4758.420193941121}, {"lowerIsBetter": false, "replicates": [723.6634964741396, 739.2607392607391, 784.9882251766221, 830.6137645994611, 847.1147650705012, 13544.442389125254, 13596.796048059263, 13686.52097176599, 13737.656558586015, 13768.173909565421, 10937.781244375108, 12405.131640785148, 12561.937190314058, 12617.810732839014, 12622.053345999064, 829.2950991657103, 839.3033781960958, 843.0, 843.4348986179275, 843.4433274039135, 829.9294559962381, 830.2776584371605, 830.2901019628191, 830.7839961609965, 831.8752187171912, 866.445474896067, 869.2741560796711, 873.76845136039, 876.1632640828026, 876.3558784293539, 871.9215270625674, 874.6807415293404, 879.7712594725353, 881.3125761905724, 885.583775625455, 649.2987573420742, 650.3204151661525, 650.6909218121402, 650.8926027205505, 651.4657980456028, 13443.193408395528, 13491.797623035662, 13628.454861805516, 13629.931850340785, 13642.658933526642, 11974.401279935968, 12057.336846473441, 12307.753844923142, 12369.319687417188, 12695.936520317431, 9801.656942007066, 10916.454177291103, 10931.398773067478, 11181.552737890475, 11546.826797598043, 3309.2057906102364, 3341.4152523308326, 3364.226227967581, 3439.3637177122064, 3442.0362298556443, 43021.35467967983, 43365.34951975723, 43457.0, 43655.12689746219, 43672.9081772955, 9054.185123338799, 9370.906290937004, 9413.717588472357, 9476.526173691287, 9477.715668529818, 17648.647027059385, 17687.20407581662, 17744.46766597004, 17748.733768993476, 17762.91118544425, 7210.96394518024, 7258.927410725931, 7321.487495875344, 7345.816354591071, 7463.776086717407, 4243.618074373259, 4251.112209589679, 4279.807408666617, 4289.185054839633, 4302.0, 3059.189314831571, 3103.0845900459417, 3107.207662046164, 3109.113902537811, 3110.455670257696, 501.9598432125421, 512.4209643103269, 516.0, 519.3845293327419, 523.9580833533308, 521.3583121893571, 645.7513857165026, 649.2922714241499, 656.5502630697987, 677.6882633988421, 8374.874376884352, 8419.536925469036, 8452.661893524313, 8571.0, 8828.690995815115, 540.1924123435489, 542.2327406719527, 631.6652174347603, 664.2361284522741, 673.71367168953, 3552.715782737375, 3730.7948062856262, 4082.408050832672, 4223.809928553223, 4357.128574285092, 54732.0, 55696.0, 55743.44256557464, 55926.0, 55941.0, 38754.80622596869, 43415.131697365876, 48968.51031489711, 49641.255381169314, 50365.0, 38767.22465550673, 44558.10883782371, 45168.54831451643, 46433.30350044819, 46555.06889862184, 8416.284615807725, 8750.168733970262, 9032.412893161923, 9169.266458683156, 9174.128457796498, 33690.0, 34478.82760586181, 34640.48039279362, 34649.2280617555, 35142.648573513936, 42029.00724431174, 42031.7898410506, 42863.14273714446, 44843.00467052464, 45084.32373514334, 9629.759256018655, 9892.258080644124, 10024.348417352849, 10256.230782691477, 10344.896551034393, 11196.440177991231, 11354.886451135382, 11357.829632555353, 11452.312861228353, 11486.540538378706, 10710.196735245043, 10760.623378181726, 10790.622328218475, 10860.565577376816, 10941.07000904932, 11202.719932001439, 11266.155038372319, 11269.098472122047, 11278.661640150809, 11278.830817537579, 10827.729306767395, 10973.780524389627, 11012.724681883017, 11020.944895275794, 11055.72360690989, 9479.19895219906, 9857.35927164732, 9900.950495247478, 9908.405495669995, 9945.552450139616, 8375.32997360222, 9379.390339627902, 9389.29580281468, 9510.38182518134, 9590.376625519319], "unit": "score", "name": "yui.html", "value": 6168.070029435593}], "name": "dromaeo_css", "value": 6753.862853342786}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 105.0, 112.0, 112.0, 111.0, 101.0, 111.0, 111.0, 103.0], "unit": "score", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [156.0, 127.0, 156.0, 169.0, 132.0, 157.0, 167.0, 138.0, 173.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 149.8}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 162.0, 160.0, 161.0, 161.0, 161.0, 159.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 87.0, 90.0, 74.0, 71.0, 71.0, 93.0, 97.0, 74.0], "unit": "score", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 142.0, 97.0, 97.0, 96.0, 145.0, 96.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [60.0, 58.0, 57.0, 58.0, 58.0, 56.0, 56.0, 66.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 69.0, 70.0, 69.0, 68.0, 68.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 94.0, 86.0, 86.0, 87.0, 94.0, 85.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.4}, {"lowerIsBetter": true, "replicates": [118.0, 116.0, 120.0, 114.0, 115.0, 120.0, 117.0, 125.0, 120.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.3}, {"lowerIsBetter": true, "replicates": [142.0, 153.0, 153.0, 150.0, 161.0, 142.0, 151.0, 150.0, 150.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.5}, {"lowerIsBetter": true, "replicates": [68.0, 75.0, 68.0, 69.0, 70.0, 70.0, 67.0, 67.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1510.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.40687100033682], "unit": "score", "name": "Richards", "value": 209.62327599999995}, {"lowerIsBetter": false, "replicates": [193.64833462432222], "unit": "score", "name": "DeltaBlue", "value": 341.433352}, {"lowerIsBetter": false, "replicates": [284.0102243680773], "unit": "score", "name": "Encrypt", "value": 937.2233010000001}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1145.475372279496], "unit": "score", "name": "RayTrace", "value": 646.010397}, {"lowerIsBetter": false, "replicates": [796.8127490039841], "unit": "score", "name": "Earley", "value": 836.4110649999999}, {"lowerIsBetter": false, "replicates": [12414.634146341463], "unit": "score", "name": "Boyer", "value": 53.683660117878226}, {"lowerIsBetter": false, "replicates": [26256.410256410258], "unit": "score", "name": "RegExp", "value": 34.69571777343749}, {"lowerIsBetter": false, "replicates": [642.2607578676943], "unit": "score", "name": "Splay", "value": 126.88148699999995}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20640.307421277408}]} 11:14:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20640.31"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1510.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6753.86"}}} 11:14:36 INFO - Return code: 0 11:14:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:14:36 INFO - # TBPL SUCCESS # 11:14:36 INFO - Running post-action listener: _resource_record_post_action 11:14:36 INFO - Running post-run listener: _resource_record_post_run 11:14:37 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 12288; Write bytes: 546177024; Read time: 292; Write time: 571972 11:14:37 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 235388928; Read time: 0; Write time: 393432 11:14:37 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 12288; Write bytes: 310550528; Read time: 292; Write time: 178512 11:14:37 INFO - Running post-run listener: _upload_blobber_files 11:14:37 INFO - Blob upload gear active. 11:14:37 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:14:37 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:14:37 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'] 11:14:37 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 11:14:38 INFO - (blobuploader) - INFO - Open directory for files ... 11:14:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 11:14:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:14:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:39 INFO - (blobuploader) - INFO - Done attempting. 11:14:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:14:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:14:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:39 INFO - (blobuploader) - INFO - Done attempting. 11:14:39 INFO - (blobuploader) - INFO - Iteration through files over. 11:14:39 INFO - Return code: 0 11:14:39 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:14:39 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:14:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d52a23df21036531c4d849013c7df71a62fc90640b7b46733c4481384cea3622ee30ad2920cf91a006c9bfda6409f68aa9e190a2c5fdfadf5ae5c8db67fa818f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65228026061b9e9a9e86c2f27ab6d5558c3cc2bd78f4ed19bd484451925051c4a2410c34bbf3aa255b1d6c2c5d3a96e6f395cbb6b540f50e0673c4a022d761bb"} 11:14:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:14:39 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:14:39 INFO - Contents: 11:14:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d52a23df21036531c4d849013c7df71a62fc90640b7b46733c4481384cea3622ee30ad2920cf91a006c9bfda6409f68aa9e190a2c5fdfadf5ae5c8db67fa818f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65228026061b9e9a9e86c2f27ab6d5558c3cc2bd78f4ed19bd484451925051c4a2410c34bbf3aa255b1d6c2c5d3a96e6f395cbb6b540f50e0673c4a022d761bb"} 11:14:39 INFO - Copying logs to upload dir... 11:14:39 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1273.923745 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-30 11:14:39.773312) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 11:14:39.776460) ========= 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=004b26eee9c3b360c8654f40000001e1-1451500756.237345-302742272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d52a23df21036531c4d849013c7df71a62fc90640b7b46733c4481384cea3622ee30ad2920cf91a006c9bfda6409f68aa9e190a2c5fdfadf5ae5c8db67fa818f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65228026061b9e9a9e86c2f27ab6d5558c3cc2bd78f4ed19bd484451925051c4a2410c34bbf3aa255b1d6c2c5d3a96e6f395cbb6b540f50e0673c4a022d761bb"} build_url:https://queue.taskcluster.net/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011374 build_url: 'https://queue.taskcluster.net/v1/task/NPb_gbHgSw-gk3J5ov4heQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d52a23df21036531c4d849013c7df71a62fc90640b7b46733c4481384cea3622ee30ad2920cf91a006c9bfda6409f68aa9e190a2c5fdfadf5ae5c8db67fa818f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65228026061b9e9a9e86c2f27ab6d5558c3cc2bd78f4ed19bd484451925051c4a2410c34bbf3aa255b1d6c2c5d3a96e6f395cbb6b540f50e0673c4a022d761bb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 11:14:39.801361) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 11:14:39.801732) ========= 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=004b26eee9c3b360c8654f40000001e1-1451500756.237345-302742272 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 11:14:39.885039) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 11:14:39.885354) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 11:14:39.885682) ========= ========= Total master_lag: 0.28 =========