builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1452323669.13 results: success (0) buildid: 20160108203155 builduid: dad139570e4849338550c02a1d27a471 revision: 19a2342819e4a868d66e258b5811d7e34ff4b15d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 23:14:29.130503) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 23:14:29.130947) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 23:14:29.131290) ========= 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=3a3620fb28aea1604ab609ef000001d2-1452323539.590212-842891496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006303 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 23:14:29.176861) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 23:14:29.177215) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 23:14:29.276506) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 23:14:29.276795) ========= 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=3a3620fb28aea1604ab609ef000001d2-1452323539.590212-842891496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004570 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 23:14:29.352559) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 23:14:29.352918) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 23:14:29.353386) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 23:14:29.353726) ========= 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=3a3620fb28aea1604ab609ef000001d2-1452323539.590212-842891496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-08 23:14:30-- 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% 222M=0s 2016-01-08 23:14:31 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100952 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 23:14:29.470909) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 23:14:29.471290) ========= 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=3a3620fb28aea1604ab609ef000001d2-1452323539.590212-842891496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019111 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 23:14:29.520753) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 23:14:29.521123) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 19a2342819e4a868d66e258b5811d7e34ff4b15d --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 19a2342819e4a868d66e258b5811d7e34ff4b15d --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=3a3620fb28aea1604ab609ef000001d2-1452323539.590212-842891496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-08 23:14:31,163 truncating revision to first 12 chars 2016-01-08 23:14:31,163 Setting DEBUG logging. 2016-01-08 23:14:31,163 attempt 1/10 2016-01-08 23:14:31,163 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/19a2342819e4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-08 23:14:31,408 unpacking tar archive at: fx-team-19a2342819e4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545589 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 23:14:30.079729) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 23:14:30.080071) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 23:14:30.087923) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 23:14:30.088277) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 23:14:30.088751) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-01-08 23:14:30.089093) ========= /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=3a3620fb28aea1604ab609ef000001d2-1452323539.590212-842891496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:14:31 INFO - MultiFileLogger online at 20160108 23:14:31 in /builds/slave/test-pgo 23:14:31 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 23:14:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 23:14:31 INFO - {'append_to_log': False, 23:14:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 23:14:31 INFO - 'blob_upload_branch': 'Fx-Team', 23:14:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 23:14:31 INFO - 'branch': 'Fx-Team', 23:14:31 INFO - 'buildbot_json_path': 'buildprops.json', 23:14:31 INFO - 'config_files': ('talos/linux_config.py',), 23:14:31 INFO - 'default_actions': ('clobber', 23:14:31 INFO - 'read-buildbot-config', 23:14:31 INFO - 'download-and-extract', 23:14:31 INFO - 'populate-webroot', 23:14:31 INFO - 'create-virtualenv', 23:14:31 INFO - 'install', 23:14:31 INFO - 'run-tests'), 23:14:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:14:31 INFO - 'download_minidump_stackwalk': True, 23:14:31 INFO - 'download_symbols': 'ondemand', 23:14:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:14:31 INFO - 'tooltool.py': '/tools/tooltool.py', 23:14:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:14:31 INFO - '/tools/misc-python/virtualenv.py')}, 23:14:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:14:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:14:31 INFO - 'installer_path': 'installer.exe', 23:14:31 INFO - 'log_level': 'info', 23:14:31 INFO - 'log_name': 'talos', 23:14:31 INFO - 'log_to_console': True, 23:14:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:14:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:14:31 INFO - 'opt_config_files': (), 23:14:31 INFO - 'pip_index': False, 23:14:31 INFO - 'sps_profile': False, 23:14:31 INFO - 'sps_profile_interval': 0, 23:14:31 INFO - 'suite': 'dromaeojs', 23:14:31 INFO - 'system_bits': '32', 23:14:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:14:31 INFO - 'title': 'talos-linux64-ix-059', 23:14:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:14:31 INFO - 'use_talos_json': True, 23:14:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 23:14:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:14:31 INFO - 'work_dir': 'build'} 23:14:31 INFO - ##### 23:14:31 INFO - ##### Running clobber step. 23:14:31 INFO - ##### 23:14:31 INFO - Running pre-action listener: _resource_record_pre_action 23:14:31 INFO - Running main action method: clobber 23:14:31 INFO - rmtree: /builds/slave/test-pgo/build 23:14:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 23:14:32 INFO - Running post-action listener: _resource_record_post_action 23:14:32 INFO - ##### 23:14:32 INFO - ##### Running read-buildbot-config step. 23:14:32 INFO - ##### 23:14:32 INFO - Running pre-action listener: _resource_record_pre_action 23:14:32 INFO - Running main action method: read_buildbot_config 23:14:32 INFO - Using buildbot properties: 23:14:32 INFO - { 23:14:32 INFO - "project": "", 23:14:32 INFO - "product": "firefox", 23:14:32 INFO - "script_repo_revision": "production", 23:14:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:14:32 INFO - "repository": "", 23:14:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:14:32 INFO - "buildid": "20160108203155", 23:14:32 INFO - "pgo_build": "True", 23:14:32 INFO - "basedir": "/builds/slave/test-pgo", 23:14:32 INFO - "buildnumber": 407, 23:14:32 INFO - "slavename": "talos-linux64-ix-059", 23:14:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:14:32 INFO - "platform": "ubuntu64_hw", 23:14:32 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:14:32 INFO - "branch": "fx-team", 23:14:32 INFO - "repo_path": "integration/fx-team", 23:14:32 INFO - "revision": "19a2342819e4a868d66e258b5811d7e34ff4b15d", 23:14:32 INFO - "stage_platform": "linux64-pgo", 23:14:32 INFO - "builduid": "dad139570e4849338550c02a1d27a471", 23:14:32 INFO - "slavebuilddir": "test" 23:14:32 INFO - } 23:14:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/VWm5cPvzQSm-von-dyEVog/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 23:14:32 INFO - Running post-action listener: _resource_record_post_action 23:14:32 INFO - ##### 23:14:32 INFO - ##### Running download-and-extract step. 23:14:32 INFO - ##### 23:14:32 INFO - Running pre-action listener: _resource_record_pre_action 23:14:32 INFO - Running main action method: download_and_extract 23:14:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 23:14:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:14:32 INFO - https://queue.taskcluster.net/v1/task/VWm5cPvzQSm-von-dyEVog/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:14:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWm5cPvzQSm-von-dyEVog/artifacts/public/build/test_packages.json 23:14:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWm5cPvzQSm-von-dyEVog/artifacts/public/build/test_packages.json 23:14:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWm5cPvzQSm-von-dyEVog/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 23:14:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWm5cPvzQSm-von-dyEVog/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 23:14:33 INFO - Downloaded 1302 bytes. 23:14:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 23:14:33 INFO - Using the following test package requirements: 23:14:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:14:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:14:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:14:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:14:33 INFO - u'jsshell-linux-x86_64.zip'], 23:14:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:14:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:14:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:14:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:14:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:14:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:14:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:14:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:14:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:14:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:14:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:14:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:14:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:14:33 INFO - https://queue.taskcluster.net/v1/task/VWm5cPvzQSm-von-dyEVog/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:14:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWm5cPvzQSm-von-dyEVog/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:14:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWm5cPvzQSm-von-dyEVog/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:14:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWm5cPvzQSm-von-dyEVog/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 23:14:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWm5cPvzQSm-von-dyEVog/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 23:14:34 INFO - Downloaded 24028296 bytes. 23:14:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 23:14:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:14:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 23:14:36 INFO - Return code: 0 23:14:36 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 23:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:14:36 INFO - https://queue.taskcluster.net/v1/task/VWm5cPvzQSm-von-dyEVog/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:14:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWm5cPvzQSm-von-dyEVog/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:14:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWm5cPvzQSm-von-dyEVog/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:14:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWm5cPvzQSm-von-dyEVog/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 23:14:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWm5cPvzQSm-von-dyEVog/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 23:14:37 INFO - Downloaded 24028296 bytes. 23:14: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 23:14:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:14: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 23:14:38 INFO - Return code: 0 23:14: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')]} 23:14:38 INFO - https://queue.taskcluster.net/v1/task/VWm5cPvzQSm-von-dyEVog/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:14:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWm5cPvzQSm-von-dyEVog/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:14:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWm5cPvzQSm-von-dyEVog/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:14:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWm5cPvzQSm-von-dyEVog/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 23:14:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWm5cPvzQSm-von-dyEVog/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 23:14:39 INFO - Downloaded 11132285 bytes. 23:14:39 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 23:14:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:14:39 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 23:14:40 INFO - Return code: 0 23:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:14:40 INFO - https://queue.taskcluster.net/v1/task/VWm5cPvzQSm-von-dyEVog/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:14:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWm5cPvzQSm-von-dyEVog/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:14:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWm5cPvzQSm-von-dyEVog/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:14:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWm5cPvzQSm-von-dyEVog/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 23:14:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VWm5cPvzQSm-von-dyEVog/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 23:14:41 INFO - Downloaded 55891718 bytes. 23:14:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VWm5cPvzQSm-von-dyEVog/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:14:41 INFO - mkdir: /builds/slave/test-pgo/properties 23:14:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 23:14:41 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 23:14:41 INFO - Contents: 23:14:41 INFO - build_url:https://queue.taskcluster.net/v1/task/VWm5cPvzQSm-von-dyEVog/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:14:41 INFO - Running post-action listener: _resource_record_post_action 23:14:41 INFO - Running post-action listener: set_extra_try_arguments 23:14:41 INFO - ##### 23:14:41 INFO - ##### Running populate-webroot step. 23:14:41 INFO - ##### 23:14:41 INFO - Running pre-action listener: _resource_record_pre_action 23:14:41 INFO - Running main action method: populate_webroot 23:14:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:14:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:14:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:14:41 INFO - '--tppagecycles', 23:14:41 INFO - '7'], 23:14:41 INFO - 'tests': ['tsvgm']}}, 23:14:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:14:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:14:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:14:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:14:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:14:41 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:14:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:14:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:14:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:14:41 INFO - 'talos_options': ['--e10s'], 23:14:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:14:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:14:41 INFO - 'tests': ['damp', 'tps']}, 23:14:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:14:41 INFO - 'talos_options': ['--e10s'], 23:14:41 INFO - 'tests': ['damp', 'tps']}, 23:14:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:14:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:14:41 INFO - 'other': {'tests': ['a11yr', 23:14:41 INFO - 'ts_paint', 23:14:41 INFO - 'tpaint', 23:14:41 INFO - 'sessionrestore', 23:14:41 INFO - 'sessionrestore_no_auto_restore']}, 23:14:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:14:41 INFO - 'tests': ['a11yr', 23:14:41 INFO - 'ts_paint', 23:14:41 INFO - 'tpaint', 23:14:41 INFO - 'sessionrestore', 23:14:41 INFO - 'sessionrestore_no_auto_restore']}, 23:14:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:14:41 INFO - 'tests': ['a11yr', 23:14:41 INFO - 'ts_paint', 23:14:41 INFO - 'tpaint', 23:14:41 INFO - 'sessionrestore', 23:14:41 INFO - 'sessionrestore_no_auto_restore']}, 23:14:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:14:41 INFO - 'tests': ['a11yr', 23:14:41 INFO - 'ts_paint', 23:14:41 INFO - 'tpaint', 23:14:41 INFO - 'sessionrestore', 23:14:41 INFO - 'sessionrestore_no_auto_restore']}, 23:14:41 INFO - 'other_l64': {'tests': ['a11yr', 23:14:41 INFO - 'ts_paint', 23:14:41 INFO - 'tpaint', 23:14:41 INFO - 'sessionrestore', 23:14:41 INFO - 'sessionrestore_no_auto_restore']}, 23:14:41 INFO - 'other_nol64': {'tests': ['a11yr', 23:14:41 INFO - 'ts_paint', 23:14:41 INFO - 'tpaint', 23:14:41 INFO - 'sessionrestore', 23:14:41 INFO - 'sessionrestore_no_auto_restore']}, 23:14:41 INFO - 'svgr': {'tests': ['tsvgx', 23:14:41 INFO - 'tsvgr_opacity', 23:14:41 INFO - 'tart', 23:14:41 INFO - 'tscrollx', 23:14:41 INFO - 'cart']}, 23:14:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:14:41 INFO - 'tests': ['tsvgx', 23:14:41 INFO - 'tsvgr_opacity', 23:14:41 INFO - 'tart', 23:14:41 INFO - 'tscrollx', 23:14:41 INFO - 'cart']}, 23:14:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:14:41 INFO - 'tests': ['tp5o']}, 23:14:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:14:41 INFO - 'talos_options': ['--e10s'], 23:14:41 INFO - 'tests': ['tp5o']}, 23:14:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:14:41 INFO - 'talos_options': ['--xperf_path', 23:14:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:14:41 INFO - 'tests': ['tp5n']}, 23:14:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:14:41 INFO - 'talos_options': ['--e10s', 23:14:41 INFO - '--xperf_path', 23:14:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:14:41 INFO - 'tests': ['tp5n']}}, 23:14:41 INFO - 'talos.zip': {'path': '', 23:14:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:14:41 INFO - Running post-action listener: _resource_record_post_action 23:14:41 INFO - ##### 23:14:41 INFO - ##### Running create-virtualenv step. 23:14:41 INFO - ##### 23:14:41 INFO - Running pre-action listener: _resource_record_pre_action 23:14:41 INFO - Running main action method: create_virtualenv 23:14:41 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 23:14:41 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 23:14:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 23:14:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:14:41 INFO - Using real prefix '/usr' 23:14:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 23:14:41 INFO - Installing distribute.............................................................................................................................................................................................done. 23:14:43 INFO - Installing pip.................done. 23:14:43 INFO - Return code: 0 23:14:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 23:14: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')]} 23:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14: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')]} 23:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14:43 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 0x7facffa75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b840>, '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 0x1a786b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a78b60>, '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': '3a3620fb28aea1604ab609ef000001d2-1452323539.590212-842891496', '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 23:14:43 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 23:14:43 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 23:14:43 INFO - Using env: {'DISPLAY': ':0', 23:14:43 INFO - 'HOME': '/home/cltbld', 23:14:43 INFO - 'LANG': 'en_US.UTF-8', 23:14:43 INFO - 'LANGUAGE': 'en_US:en', 23:14:43 INFO - 'LOGNAME': 'cltbld', 23:14:43 INFO - 'MAIL': '/var/mail/cltbld', 23:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:14:43 INFO - 'MOZ_NO_REMOTE': '1', 23:14:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:14:43 INFO - 'NO_EM_RESTART': '1', 23:14:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:14:43 INFO - 'PWD': '/builds/slave/test-pgo', 23:14:43 INFO - 'SHELL': '/bin/bash', 23:14:43 INFO - 'SHLVL': '1', 23:14:43 INFO - 'TERM': 'linux', 23:14:43 INFO - 'TMOUT': '86400', 23:14:43 INFO - 'USER': 'cltbld', 23:14:43 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452323539.590212-842891496', 23:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:14:43 INFO - '_': '/tools/buildbot/bin/python'} 23:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:14:44 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 23:14:44 INFO - Cleaning up... 23:14:44 INFO - Return code: 0 23:14:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 23:14:44 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')]} 23:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14:44 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')]} 23:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14:44 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 0x7facffa75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b840>, '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 0x1a786b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a78b60>, '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': '3a3620fb28aea1604ab609ef000001d2-1452323539.590212-842891496', '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 23:14:44 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 23:14:44 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 23:14:44 INFO - Using env: {'DISPLAY': ':0', 23:14:44 INFO - 'HOME': '/home/cltbld', 23:14:44 INFO - 'LANG': 'en_US.UTF-8', 23:14:44 INFO - 'LANGUAGE': 'en_US:en', 23:14:44 INFO - 'LOGNAME': 'cltbld', 23:14:44 INFO - 'MAIL': '/var/mail/cltbld', 23:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:14:44 INFO - 'MOZ_NO_REMOTE': '1', 23:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:14:44 INFO - 'NO_EM_RESTART': '1', 23:14:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:14:44 INFO - 'PWD': '/builds/slave/test-pgo', 23:14:44 INFO - 'SHELL': '/bin/bash', 23:14:44 INFO - 'SHLVL': '1', 23:14:44 INFO - 'TERM': 'linux', 23:14:44 INFO - 'TMOUT': '86400', 23:14:44 INFO - 'USER': 'cltbld', 23:14:44 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452323539.590212-842891496', 23:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:14:44 INFO - '_': '/tools/buildbot/bin/python'} 23:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:14:44 INFO - Downloading/unpacking psutil>=0.7.1 23:14:44 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 23:14:44 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 23:14:44 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 23:14:44 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 23:14:44 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 23:14:44 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 23:14:46 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 23:14:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 23:14:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 23:14:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:14:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:14:46 INFO - Installing collected packages: psutil 23:14:46 INFO - Running setup.py install for psutil 23:14:46 INFO - building 'psutil._psutil_linux' extension 23:14:46 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 23:14:46 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 23:14:46 INFO - building 'psutil._psutil_posix' extension 23:14:46 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 23:14:46 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 23:14:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:14:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:14:46 INFO - Successfully installed psutil 23:14:46 INFO - Cleaning up... 23:14:46 INFO - Return code: 0 23:14:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 23:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7facffa75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b840>, '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 0x1a786b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a78b60>, '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': '3a3620fb28aea1604ab609ef000001d2-1452323539.590212-842891496', '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 23:14:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 23:14:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 23:14:46 INFO - Using env: {'DISPLAY': ':0', 23:14:46 INFO - 'HOME': '/home/cltbld', 23:14:46 INFO - 'LANG': 'en_US.UTF-8', 23:14:46 INFO - 'LANGUAGE': 'en_US:en', 23:14:46 INFO - 'LOGNAME': 'cltbld', 23:14:46 INFO - 'MAIL': '/var/mail/cltbld', 23:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:14:46 INFO - 'MOZ_NO_REMOTE': '1', 23:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:14:46 INFO - 'NO_EM_RESTART': '1', 23:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:14:46 INFO - 'PWD': '/builds/slave/test-pgo', 23:14:46 INFO - 'SHELL': '/bin/bash', 23:14:46 INFO - 'SHLVL': '1', 23:14:46 INFO - 'TERM': 'linux', 23:14:46 INFO - 'TMOUT': '86400', 23:14:46 INFO - 'USER': 'cltbld', 23:14:46 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452323539.590212-842891496', 23:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:14:46 INFO - '_': '/tools/buildbot/bin/python'} 23:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:14:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:14:46 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 23:14:46 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 23:14:46 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 23:14:46 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 23:14:46 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 23:14:46 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 23:14:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:14:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 23:14:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:14:48 INFO - Installing collected packages: mozsystemmonitor 23:14:48 INFO - Running setup.py install for mozsystemmonitor 23:14:48 INFO - Successfully installed mozsystemmonitor 23:14:48 INFO - Cleaning up... 23:14:48 INFO - Return code: 0 23:14:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 23:14:48 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')]} 23:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14:48 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')]} 23:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14:48 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 0x7facffa75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b840>, '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 0x1a786b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a78b60>, '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': '3a3620fb28aea1604ab609ef000001d2-1452323539.590212-842891496', '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 23:14:48 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 23:14:48 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 23:14:48 INFO - Using env: {'DISPLAY': ':0', 23:14:48 INFO - 'HOME': '/home/cltbld', 23:14:48 INFO - 'LANG': 'en_US.UTF-8', 23:14:48 INFO - 'LANGUAGE': 'en_US:en', 23:14:48 INFO - 'LOGNAME': 'cltbld', 23:14:48 INFO - 'MAIL': '/var/mail/cltbld', 23:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:14:48 INFO - 'MOZ_NO_REMOTE': '1', 23:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:14:48 INFO - 'NO_EM_RESTART': '1', 23:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:14:48 INFO - 'PWD': '/builds/slave/test-pgo', 23:14:48 INFO - 'SHELL': '/bin/bash', 23:14:48 INFO - 'SHLVL': '1', 23:14:48 INFO - 'TERM': 'linux', 23:14:48 INFO - 'TMOUT': '86400', 23:14:48 INFO - 'USER': 'cltbld', 23:14:48 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452323539.590212-842891496', 23:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:14:48 INFO - '_': '/tools/buildbot/bin/python'} 23:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:14:49 INFO - Downloading/unpacking blobuploader==1.2.4 23:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:14:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:14:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:14:50 INFO - Downloading blobuploader-1.2.4.tar.gz 23:14:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 23:14:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:14:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:14: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 23:14: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 23:14: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 23:14: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 23:14: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 23:14: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 23:14:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 23:14:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 23:14:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:14:51 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 23:14:51 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 23:14:51 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 23:14:51 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 23:14:51 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 23:14:51 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 23:14:51 INFO - Downloading docopt-0.6.1.tar.gz 23:14:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 23:14:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 23:14:51 INFO - Installing collected packages: blobuploader, requests, docopt 23:14:51 INFO - Running setup.py install for blobuploader 23:14:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:14:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 23:14:51 INFO - Running setup.py install for requests 23:14:51 INFO - Running setup.py install for docopt 23:14:51 INFO - Successfully installed blobuploader requests docopt 23:14:51 INFO - Cleaning up... 23:14:52 INFO - Return code: 0 23:14:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:14: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')]} 23:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14: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')]} 23:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14:52 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 0x7facffa75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b840>, '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 0x1a786b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a78b60>, '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': '3a3620fb28aea1604ab609ef000001d2-1452323539.590212-842891496', '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 23:14:52 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 23:14:52 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 23:14:52 INFO - Using env: {'DISPLAY': ':0', 23:14:52 INFO - 'HOME': '/home/cltbld', 23:14:52 INFO - 'LANG': 'en_US.UTF-8', 23:14:52 INFO - 'LANGUAGE': 'en_US:en', 23:14:52 INFO - 'LOGNAME': 'cltbld', 23:14:52 INFO - 'MAIL': '/var/mail/cltbld', 23:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:14:52 INFO - 'MOZ_NO_REMOTE': '1', 23:14:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:14:52 INFO - 'NO_EM_RESTART': '1', 23:14:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:14:52 INFO - 'PWD': '/builds/slave/test-pgo', 23:14:52 INFO - 'SHELL': '/bin/bash', 23:14:52 INFO - 'SHLVL': '1', 23:14:52 INFO - 'TERM': 'linux', 23:14:52 INFO - 'TMOUT': '86400', 23:14:52 INFO - 'USER': 'cltbld', 23:14:52 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452323539.590212-842891496', 23:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:14:52 INFO - '_': '/tools/buildbot/bin/python'} 23:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:14:52 INFO - Running setup.py (path:/tmp/pip-GOXFTU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:14:52 INFO - Running setup.py (path:/tmp/pip-Ar67lp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:14:52 INFO - Running setup.py (path:/tmp/pip-E45_xB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:14:52 INFO - Running setup.py (path:/tmp/pip-t0VreF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:14:52 INFO - Running setup.py (path:/tmp/pip-mMwDAX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:14:52 INFO - Running setup.py (path:/tmp/pip-NdbxaU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:14:52 INFO - Running setup.py (path:/tmp/pip-JN8Z0h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:14:52 INFO - Running setup.py (path:/tmp/pip-z5IYZg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:14:52 INFO - Running setup.py (path:/tmp/pip-9QS9GS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:14:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:14:52 INFO - Running setup.py (path:/tmp/pip-v1wzmA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:14:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:14:53 INFO - Running setup.py (path:/tmp/pip-PGzDHp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:14:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:14:53 INFO - Running setup.py (path:/tmp/pip-oj9_vK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:14:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:14:53 INFO - Running setup.py (path:/tmp/pip-gz2CPj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:14:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:14:53 INFO - Running setup.py (path:/tmp/pip-5rRbHV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:14:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:14:53 INFO - Running setup.py (path:/tmp/pip-fps1HI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:14:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:14:53 INFO - Running setup.py (path:/tmp/pip-JMU12K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:14:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:14:53 INFO - Running setup.py (path:/tmp/pip-1aCJyK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:14:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:14:53 INFO - Running setup.py install for manifestparser 23:14:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 23:14:53 INFO - Running setup.py install for mozcrash 23:14:53 INFO - Running setup.py install for mozdebug 23:14:53 INFO - Running setup.py install for mozdevice 23:14:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 23:14:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 23:14:53 INFO - Running setup.py install for mozfile 23:14:54 INFO - Running setup.py install for mozhttpd 23:14:54 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 23:14:54 INFO - Running setup.py install for mozinfo 23:14:54 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 23:14:54 INFO - Running setup.py install for mozInstall 23:14:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 23:14:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 23:14:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 23:14:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 23:14:54 INFO - Running setup.py install for mozleak 23:14:54 INFO - Running setup.py install for mozlog 23:14:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 23:14:54 INFO - Running setup.py install for moznetwork 23:14:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 23:14:54 INFO - Running setup.py install for mozprocess 23:14:54 INFO - Running setup.py install for mozprofile 23:14:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 23:14:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 23:14:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 23:14:54 INFO - Running setup.py install for mozrunner 23:14:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 23:14:54 INFO - Running setup.py install for mozscreenshot 23:14:55 INFO - Running setup.py install for moztest 23:14:55 INFO - Running setup.py install for mozversion 23:14:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 23:14:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:14:55 INFO - Cleaning up... 23:14:55 INFO - Return code: 0 23:14:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:14: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')]} 23:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:14:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14: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')]} 23:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:14:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7facffa75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b840>, '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 0x1a786b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a78b60>, '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': '3a3620fb28aea1604ab609ef000001d2-1452323539.590212-842891496', '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 23:14:55 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 23:14:55 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 23:14:55 INFO - Using env: {'DISPLAY': ':0', 23:14:55 INFO - 'HOME': '/home/cltbld', 23:14:55 INFO - 'LANG': 'en_US.UTF-8', 23:14:55 INFO - 'LANGUAGE': 'en_US:en', 23:14:55 INFO - 'LOGNAME': 'cltbld', 23:14:55 INFO - 'MAIL': '/var/mail/cltbld', 23:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:14:55 INFO - 'MOZ_NO_REMOTE': '1', 23:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:14:55 INFO - 'NO_EM_RESTART': '1', 23:14:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:14:55 INFO - 'PWD': '/builds/slave/test-pgo', 23:14:55 INFO - 'SHELL': '/bin/bash', 23:14:55 INFO - 'SHLVL': '1', 23:14:55 INFO - 'TERM': 'linux', 23:14:55 INFO - 'TMOUT': '86400', 23:14:55 INFO - 'USER': 'cltbld', 23:14:55 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452323539.590212-842891496', 23:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:14:55 INFO - '_': '/tools/buildbot/bin/python'} 23:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:14:55 INFO - Running setup.py (path:/tmp/pip-wxrrnl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:14:55 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)) 23:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:14:55 INFO - Running setup.py (path:/tmp/pip-HYiLoC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:14:55 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)) 23:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:14:55 INFO - Running setup.py (path:/tmp/pip-Qoemkp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:14:55 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)) 23:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:14:55 INFO - Running setup.py (path:/tmp/pip-QH7udM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:14:55 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)) 23:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:14:55 INFO - Running setup.py (path:/tmp/pip-TC_yh9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:14:55 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)) 23:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:14:55 INFO - Running setup.py (path:/tmp/pip-Cs646m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:14:55 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)) 23:14:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:14:55 INFO - Running setup.py (path:/tmp/pip-Fzn8sY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:14:56 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)) 23:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:14:56 INFO - Running setup.py (path:/tmp/pip-Dzbsnp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:14:56 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)) 23:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:14:56 INFO - Running setup.py (path:/tmp/pip-YpkVWn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:14:56 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)) 23:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:14:56 INFO - Running setup.py (path:/tmp/pip-OwPZy3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:14:56 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)) 23:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:14:56 INFO - Running setup.py (path:/tmp/pip-L3yS7K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:14:56 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)) 23:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:14:56 INFO - Running setup.py (path:/tmp/pip-h3Hwh1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:14:56 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)) 23:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:14:56 INFO - Running setup.py (path:/tmp/pip-Ly2EHR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:14:56 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)) 23:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:14:56 INFO - Running setup.py (path:/tmp/pip-jKEeXJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:14:56 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)) 23:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:14:56 INFO - Running setup.py (path:/tmp/pip-1sWsze-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:14:56 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)) 23:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:14:56 INFO - Running setup.py (path:/tmp/pip-b3qLRn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:14:56 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)) 23:14:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:14:56 INFO - Running setup.py (path:/tmp/pip-QIiys7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:14:56 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)) 23:14:56 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)) 23:14:56 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)) 23:14:56 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)) 23:14:56 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)) 23:14:56 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)) 23:14:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 23:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:14:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:14:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:14:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:14:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:14:58 INFO - Downloading blessings-1.5.1.tar.gz 23:14:58 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 23:14:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 23:14:58 INFO - Installing collected packages: blessings 23:14:58 INFO - Running setup.py install for blessings 23:14:58 INFO - Successfully installed blessings 23:14:58 INFO - Cleaning up... 23:14:58 INFO - Return code: 0 23:14:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 23:14:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:14:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:14:58 INFO - Reading from file tmpfile_stdout 23:14:58 INFO - Current package versions: 23:14:58 INFO - argparse == 1.2.1 23:14:58 INFO - blessings == 1.5.1 23:14:58 INFO - blobuploader == 1.2.4 23:14:58 INFO - docopt == 0.6.1 23:14:58 INFO - manifestparser == 1.1 23:14:58 INFO - mozInstall == 1.12 23:14:58 INFO - mozcrash == 0.16 23:14:58 INFO - mozdebug == 0.1 23:14:58 INFO - mozdevice == 0.47 23:14:58 INFO - mozfile == 1.2 23:14:58 INFO - mozhttpd == 0.7 23:14:58 INFO - mozinfo == 0.9 23:14:58 INFO - mozleak == 0.1 23:14:58 INFO - mozlog == 3.1 23:14:58 INFO - moznetwork == 0.27 23:14:58 INFO - mozprocess == 0.22 23:14:58 INFO - mozprofile == 0.28 23:14:58 INFO - mozrunner == 6.11 23:14:58 INFO - mozscreenshot == 0.1 23:14:58 INFO - mozsystemmonitor == 0.0 23:14:58 INFO - moztest == 0.7 23:14:58 INFO - mozversion == 1.4 23:14:58 INFO - psutil == 3.1.1 23:14:58 INFO - requests == 1.2.3 23:14:58 INFO - wsgiref == 0.1.2 23:14:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:14: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')]} 23:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14: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')]} 23:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14: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/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 0x7facffa75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b840>, '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 0x1a786b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a78b60>, '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': '3a3620fb28aea1604ab609ef000001d2-1452323539.590212-842891496', '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 23:14: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/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 23:14: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/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 23:14:58 INFO - Using env: {'DISPLAY': ':0', 23:14:58 INFO - 'HOME': '/home/cltbld', 23:14:58 INFO - 'LANG': 'en_US.UTF-8', 23:14:58 INFO - 'LANGUAGE': 'en_US:en', 23:14:58 INFO - 'LOGNAME': 'cltbld', 23:14:58 INFO - 'MAIL': '/var/mail/cltbld', 23:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:14:58 INFO - 'MOZ_NO_REMOTE': '1', 23:14:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:14:58 INFO - 'NO_EM_RESTART': '1', 23:14:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:14:58 INFO - 'PWD': '/builds/slave/test-pgo', 23:14:58 INFO - 'SHELL': '/bin/bash', 23:14:58 INFO - 'SHLVL': '1', 23:14:58 INFO - 'TERM': 'linux', 23:14:58 INFO - 'TMOUT': '86400', 23:14:58 INFO - 'USER': 'cltbld', 23:14:58 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452323539.590212-842891496', 23:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:14:58 INFO - '_': '/tools/buildbot/bin/python'} 23:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:14:59 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)) 23:14:59 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)) 23:14:59 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)) 23:14:59 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)) 23:14:59 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)) 23:14:59 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)) 23:14:59 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)) 23:14:59 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)) 23:14:59 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)) 23:14:59 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)) 23:14:59 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)) 23:14:59 INFO - Cleaning up... 23:14:59 INFO - Return code: 0 23:14:59 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 23:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:14:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7facffa75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b840>, '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 0x1a786b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a78b60>, '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': '3a3620fb28aea1604ab609ef000001d2-1452323539.590212-842891496', '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 23:14:59 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 23:14:59 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 23:14:59 INFO - Using env: {'DISPLAY': ':0', 23:14:59 INFO - 'HOME': '/home/cltbld', 23:14:59 INFO - 'LANG': 'en_US.UTF-8', 23:14:59 INFO - 'LANGUAGE': 'en_US:en', 23:14:59 INFO - 'LOGNAME': 'cltbld', 23:14:59 INFO - 'MAIL': '/var/mail/cltbld', 23:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:14:59 INFO - 'MOZ_NO_REMOTE': '1', 23:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:14:59 INFO - 'NO_EM_RESTART': '1', 23:14:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:14:59 INFO - 'PWD': '/builds/slave/test-pgo', 23:14:59 INFO - 'SHELL': '/bin/bash', 23:14:59 INFO - 'SHLVL': '1', 23:14:59 INFO - 'TERM': 'linux', 23:14:59 INFO - 'TMOUT': '86400', 23:14:59 INFO - 'USER': 'cltbld', 23:14:59 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452323539.590212-842891496', 23:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:14:59 INFO - '_': '/tools/buildbot/bin/python'} 23:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:14:59 INFO - Downloading/unpacking jsonschema 23:14:59 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 23:14:59 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 23:14:59 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 23:14:59 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 23:14:59 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 23:14:59 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 23:15:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:15:01 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 23:15:01 INFO - Downloading/unpacking functools32 (from jsonschema) 23:15:01 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 23:15:01 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 23:15:01 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 23:15:01 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 23:15:01 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 23:15:01 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 23:15:01 INFO - Downloading functools32-3.2.3-2.tar.gz 23:15:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 23:15:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 23:15:01 INFO - warning: no files found matching '*.txt' 23:15:01 INFO - no previously-included directories found matching 'build' 23:15:01 INFO - no previously-included directories found matching 'dist' 23:15:01 INFO - no previously-included directories found matching '.git*' 23:15:01 INFO - Installing collected packages: jsonschema, functools32 23:15:01 INFO - Running setup.py install for functools32 23:15:01 INFO - warning: no files found matching '*.txt' 23:15:01 INFO - no previously-included directories found matching 'build' 23:15:01 INFO - no previously-included directories found matching 'dist' 23:15:01 INFO - no previously-included directories found matching '.git*' 23:15:01 INFO - Successfully installed jsonschema functools32 23:15:01 INFO - Cleaning up... 23:15:01 INFO - Return code: 0 23:15:01 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 23:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7facffa75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b840>, '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 0x1a786b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a78b60>, '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': '3a3620fb28aea1604ab609ef000001d2-1452323539.590212-842891496', '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 23:15:01 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 23:15:01 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 23:15:01 INFO - Using env: {'DISPLAY': ':0', 23:15:01 INFO - 'HOME': '/home/cltbld', 23:15:01 INFO - 'LANG': 'en_US.UTF-8', 23:15:01 INFO - 'LANGUAGE': 'en_US:en', 23:15:01 INFO - 'LOGNAME': 'cltbld', 23:15:01 INFO - 'MAIL': '/var/mail/cltbld', 23:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:01 INFO - 'MOZ_NO_REMOTE': '1', 23:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:01 INFO - 'NO_EM_RESTART': '1', 23:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:15:01 INFO - 'PWD': '/builds/slave/test-pgo', 23:15:01 INFO - 'SHELL': '/bin/bash', 23:15:01 INFO - 'SHLVL': '1', 23:15:01 INFO - 'TERM': 'linux', 23:15:01 INFO - 'TMOUT': '86400', 23:15:01 INFO - 'USER': 'cltbld', 23:15:01 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452323539.590212-842891496', 23:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:01 INFO - '_': '/tools/buildbot/bin/python'} 23:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:01 INFO - Downloading/unpacking flake8 23:15:01 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 23:15:01 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 23:15:01 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 23:15:01 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 23:15:01 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 23:15:01 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 23:15:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:15:03 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 23:15:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:15:03 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 23:15:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:03 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 23:15:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 23:15:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 23:15:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:15:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:15:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:15:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:15:04 INFO - no previously-included directories found matching 'docs/_build' 23:15:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:15:04 INFO - Running setup.py install for pep8 23:15:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:15:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:15:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:15:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:15:04 INFO - no previously-included directories found matching 'docs/_build' 23:15:04 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 23:15:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:15:04 INFO - Cleaning up... 23:15:04 INFO - Return code: 0 23:15:04 INFO - Running post-action listener: _resource_record_post_action 23:15:04 INFO - Running post-action listener: _start_resource_monitoring 23:15:04 INFO - Starting resource monitoring. 23:15:04 INFO - ##### 23:15:04 INFO - ##### Running install step. 23:15:04 INFO - ##### 23:15:04 INFO - Running pre-action listener: _resource_record_pre_action 23:15:04 INFO - Running main action method: install 23:15:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:15:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:15:04 INFO - Reading from file tmpfile_stdout 23:15:04 INFO - Detecting whether we're running mozinstall >=1.0... 23:15:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 23:15:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 23:15:04 INFO - Reading from file tmpfile_stdout 23:15:04 INFO - Output received: 23:15:04 INFO - Usage: mozinstall [options] installer 23:15:04 INFO - Options: 23:15:04 INFO - -h, --help show this help message and exit 23:15:04 INFO - -d DEST, --destination=DEST 23:15:04 INFO - Directory to install application into. [default: 23:15:04 INFO - "/builds/slave/test-pgo"] 23:15:04 INFO - --app=APP Application being installed. [default: firefox] 23:15:04 INFO - mkdir: /builds/slave/test-pgo/build/application 23:15:04 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'] 23:15:04 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 23:15:21 INFO - Reading from file tmpfile_stdout 23:15:21 INFO - Output received: 23:15:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 23:15:21 INFO - Running post-action listener: _resource_record_post_action 23:15:21 INFO - ##### 23:15:21 INFO - ##### Running run-tests step. 23:15:21 INFO - ##### 23:15:21 INFO - Running pre-action listener: _resource_record_pre_action 23:15:21 INFO - Running main action method: run_tests 23:15:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 23:15:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 23:15:21 INFO - Python 2.7.3 23:15:21 INFO - Return code: 0 23:15:21 INFO - grabbing minidump binary from tooltool 23:15:21 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')]} 23:15:21 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 0x1b0b840>, '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 0x1a786b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a78b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 23:15:21 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 23:15:21 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 23:15:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:15:21 INFO - Return code: 0 23:15:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 23:15:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 23:15:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 23:15:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 23:15:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 23:15:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 23:15:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 23:15:22 INFO - Return code: 0 23:15:22 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/VWm5cPvzQSm-von-dyEVog/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 23:15:22 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/VWm5cPvzQSm-von-dyEVog/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 23:15:22 INFO - Using env: {'DISPLAY': ':0', 23:15:22 INFO - 'HOME': '/home/cltbld', 23:15:22 INFO - 'LANG': 'en_US.UTF-8', 23:15:22 INFO - 'LANGUAGE': 'en_US:en', 23:15:22 INFO - 'LOGNAME': 'cltbld', 23:15:22 INFO - 'MAIL': '/var/mail/cltbld', 23:15:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:15:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 23:15:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:22 INFO - 'MOZ_NO_REMOTE': '1', 23:15:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:15:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:22 INFO - 'NO_EM_RESTART': '1', 23:15:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:15:22 INFO - 'PWD': '/builds/slave/test-pgo', 23:15:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 23:15:22 INFO - 'SHELL': '/bin/bash', 23:15:22 INFO - 'SHLVL': '1', 23:15:22 INFO - 'TERM': 'linux', 23:15:22 INFO - 'TMOUT': '86400', 23:15:22 INFO - 'USER': 'cltbld', 23:15:22 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452323539.590212-842891496', 23:15:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:22 INFO - '_': '/tools/buildbot/bin/python'} 23:15:22 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/VWm5cPvzQSm-von-dyEVog/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 23:15:22 INFO - mozversion application_buildid: 20160108203155 23:15:22 INFO - mozversion application_changeset: 19a2342819e4a868d66e258b5811d7e34ff4b15d 23:15:22 INFO - mozversion application_display_name: Nightly 23:15:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:15:22 INFO - mozversion application_name: Firefox 23:15:22 INFO - mozversion application_remotingname: firefox 23:15:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:15:22 INFO - mozversion application_vendor: Mozilla 23:15:22 INFO - mozversion application_version: 46.0a1 23:15:22 INFO - mozversion platform_buildid: 20160108203155 23:15:22 INFO - mozversion platform_changeset: 19a2342819e4a868d66e258b5811d7e34ff4b15d 23:15:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:15:22 INFO - mozversion platform_version: 46.0a1 23:15:22 INFO - using testdate: 1452323722 23:15:22 INFO - actual date: 1452323722 23:15:22 INFO - starting webserver on 'localhost:38147' 23:15:22 INFO - SUITE-START | Running 3 tests 23:15:22 INFO - TEST-START | dromaeo_css 23:15:22 INFO - operating with platform_type : linux_ 23:15:22 INFO - Initialising browser for dromaeo_css test... 23:15:22 INFO - TEST-INFO | started process 31211 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFAbA7u/profile http://localhost:38147/getInfo.html) 23:15:26 INFO - PROCESS | 31211 | __metrics Screen width/height:1600/1200 23:15:26 INFO - PROCESS | 31211 | colorDepth:24 23:15:26 INFO - PROCESS | 31211 | Browser inner width/height: 1024/697 23:15:26 INFO - PROCESS | 31211 | __metrics 23:15:26 INFO - PROCESS | 31211 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:15:26 INFO - PROCESS | 31211 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:15:27 INFO - TEST-INFO | 31211: exit 0 23:15:27 INFO - Browser initialized. 23:15:27 INFO - Running cycle 1/1 for dromaeo_css test... 23:15:27 INFO - TEST-INFO | started process 31304 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFAbA7u/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:15:39 INFO - PROCESS | 31304 | RSS: Main: 148611072 23:15:39 INFO - PROCESS | 31304 | 23:16:30 INFO - PROCESS | 31304 | 1452323790530 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] 23:18:38 INFO - PROCESS | 31304 | Cycle 1(1): loaded http://localhost:38147/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38147/tests/dromaeo/cssquery-ext.html) 23:18:39 INFO - PROCESS | 31304 | RSS: Main: 327376896 23:18:39 INFO - PROCESS | 31304 | 23:21:42 INFO - PROCESS | 31304 | Cycle 1(1): loaded http://localhost:38147/tests/dromaeo/cssquery-ext.html (next: http://localhost:38147/tests/dromaeo/cssquery-jquery.html) 23:21:43 INFO - PROCESS | 31304 | RSS: Main: 231567360 23:21:43 INFO - PROCESS | 31304 | 23:24:45 INFO - PROCESS | 31304 | Cycle 1(1): loaded http://localhost:38147/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38147/tests/dromaeo/cssquery-mootools.html) 23:24:45 INFO - PROCESS | 31304 | RSS: Main: 233992192 23:24:45 INFO - PROCESS | 31304 | 23:27:47 INFO - PROCESS | 31304 | Cycle 1(1): loaded http://localhost:38147/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38147/tests/dromaeo/cssquery-prototype.html) 23:27:48 INFO - PROCESS | 31304 | RSS: Main: 213733376 23:27:48 INFO - PROCESS | 31304 | 23:30:50 INFO - PROCESS | 31304 | Cycle 1(1): loaded http://localhost:38147/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38147/tests/dromaeo/cssquery-yui.html) 23:30:51 INFO - PROCESS | 31304 | RSS: Main: 214478848 23:30:51 INFO - PROCESS | 31304 | 23:33:54 INFO - PROCESS | 31304 | Cycle 1(1): loaded http://localhost:38147/tests/dromaeo/cssquery-yui.html (next: http://localhost:38147/tests/dromaeo/cssquery-dojo.html) 23:33:54 INFO - PROCESS | 31304 | RSS: Main: 269078528 23:33:54 INFO - PROCESS | 31304 | 23:33:54 INFO - PROCESS | 31304 | __start_tp_report 23:33:54 INFO - PROCESS | 31304 | _x_x_mozilla_page_load 23:33:54 INFO - PROCESS | 31304 | _x_x_mozilla_page_load_details 23:33:54 INFO - PROCESS | 31304 | |i|pagename|runs| 23:33:54 INFO - PROCESS | 31304 | |0;dojo.html;3067.202527342891;3121.2508997840496;3161.320316132031;3166.7783255172135;3187.04388683395;4825.638077144219;4975.776090075946;5059.291699162116;5081.872953176173;5091.923621145681;5012.548870601645;5017.874553136174;5100.285959965608;5106.719130447833;5137.332146820908;4591.931121033195;4597.126545956275;4649.51180126087;4681.812727490897;4706.505816889228;4675.906481870361;4681.180793361165;4709.293605959099;4731.503192164808;4744.217204161309;4475.70907890986;4525.660575456821;4589.265717485203;4618.468876079227;4621.353010578522;4650.581447669692;4656.301554766778;4682.719036857766;4689.132510485537;4697.506761790031;4630.143423466669;4640.048789998076;4644.58198762113;4645.953540464586;4691.929621055687;4762.642801789845;4843.128236917353;4859.125357435661;4933.161362568372;4993.800247990076;5254.474552544753;5259.631825772198;5261.316028916254;5266.131088370453;5286.444923283077;5275.472452754732;5301.840944771663;5305.628605997582;5325.068113080196;5343.919841202385;4894.388201474816;4982.327385802942;5004.649674522749;5066.569341605931;5112.897742045176;5490.69801160932;5523.613347065747;5534.05920993424;5534.612577119644;5585.022621041383;5201.973990130025;5324.254604355393;5325.227841962894;5328.094223981932;5337.599680024014;5254.264402983586;5391.32608423947;5446.455354464521;5449.373322067933;5523.972380138073;5250.527452529291;5256.842294731164;5261.973690131525;5263.131583288791;5306.734663266899;5185.170372740344;5239.1093514102695;5247.737613119329;5253.106971814801;5322.574194064466;4181.770002649822;4202.873913782591;4251.3622956556765;4268.295731204378;4283.807228674717;3801.163743976321;3801.467794508771;3803.201327721154;3827.770333779982;3843.807809609564;5033.19468884984;5033.697978121324;5036.169032109661;5039.84880453587;5045.571126454292;5264.15773476242;5376.8118115865755;5376.865578360573;5387.138057910794;5495.917561236584;5001.599872010231;5006.924896126561;5008.348914641147;5031.371078615173;5057.367829021372;4574.4510658721165;4584.404027476474;4587.288970209623;4594.173048851172;4629.953700463019;5369.382521010056;5502.0371434999515;5510.889782204334;5524.1989911462615;5576.219329293902;5323.095073837534;5378.354597448175;5378.542823860016;5396.406395296436;5455.8363249102595;5477.4248703887115;5515.365732940763;5522.66863988162;5527.640703354269;5529.474699903502;5220.765065571983;5267.236250743544;5290.576753859605;5346.064438723286;5350.732463376893;5325.840224793263;5354.491323324434;5356.143017117242;5357.303550538405;5359.973200134131;5231.738413079407;5247.396549396868;5247.711375874211;5250.89498210026;5252.527272545489;5225.555827754683;5250.159974404077;5308.230306605444;5340.359156901197;5357.973210134081;5103.617228707936;5151.2273159026445;5156.587473002076;5160.380754309507;5201.609879258995;5150.253213283978;5254.6847189168775;5262.315898933114;5288.8413347599635;5290.867728306823;5085.618578606545;5093.516115968977;5156.1750119980625;5219.399769026459;5224.634275600672 23:33:54 INFO - PROCESS | 31304 | |1;ext.html;526.51823581423;553.8061678412558;584.3718003146618;594.9881002379954;599.3227652752389;28140.437191256162;28647.57028644572;28650.28374290644;28689;28769.42461150776;36241.0939726507;36904.446433303456;36907.4463883042;36933.07667308319;36975.81512092436;8175.713850015236;8367.497950123012;8371.372147088992;8371.58142092893;8378.832423351529;7502.212267711893;7719.807004824868;8531.658733650678;8714.346424018193;9558.522073896313;10026.498675066254;10111.393316401003;10115.747106322327;10133.341332813343;10139.34094283873;9902.405855648649;9968;10016.449095299791;10021.849672254923;10024.248181386425;7434.145073316584;7634.351080158193;7642.235776422369;9572.712818615453;9808.264380171515;35193.29613407717;35870.82064589686;35871.103222419384;35881.28237435263;35926.281474370626;2746.40952195279;2836.0788041729347;2939.853007349624;3016.0499442675487;3089.1813669377634;28608.713912860814;28768;29067.273318167005;29131.70868291311;29494.26264343387;3863.729538932276;3878.3600705883496;3995.4206640037323;3995.4805875236034;4088.3049881519914;208752;212555;213113;213671;215339;55351.72324138434;60870;60890.391096089355;60936;60955;55241;56785;65353;67065.66467167634;67105;13119.278439685719;13175.868241317656;13225.537106201236;13239.536616218385;13297.268650224138;9758.853617195748;9842.163416109712;9892.65375711861;9894;9896.55465504054;19913.203471861252;20223;20292.08685609151;20304.89847550753;20314.898425507778;7819.218078192249;8208.548529830916;8347.791305217297;8449;8464;903.3902116071625;971.155095067296;977.5600979559084;997.7356000659831;1040.453761775074;28224.71775282262;28293.43413131726;28432.147035588965;28491.857540712164;28905.421891562473;1031.7884833609091;1052.710504611238;1057.471264367816;1102.8125218712837;1109.983350249747;14733.336999835034;14970.877184211009;15008.62478438026;15093;15323.387064517518;298187;302811;303499;304333;305814;50583.24125138126;51155.744221278655;51222.74388628033;51621.74189129106;51703;1279.4882047181202;1285.971223021579;1292.08262133886;1293.8641442648575;1315.1714419915393;27079;28272.71727282783;28281.074861376874;28398.574021390108;28496.85751571229;45927.77036114798;46358;46373.76813115913;46378.536214637425;46409.19885014373;236931;237152;240110;290021;290496;26924.326891827863;27142.321441964108;31823.522647160775;31891.840540797148;32013.67986320107;35770.8211458941;36511.634883650826;36893.26213475662;37009.07477313089;37329.62670373262;31515.369692606477;31827.68172318247;31853.681463185072;32074.35851283008;32308.676913230567;28150.577741334306;33380.33239335248;35530.40258033725;36106.27787444289;37044.44433333448;32495.481190768798;34836.65163348334;35192.824035879654;35351.29297413986;35454.29091418105;29254.268643283238;32202.516962246053;32593.348133036732;33034.66965330316;33084.834575826964;24790.38024049413;24932.501349973263;25014.249572512854;25276.368090797878;25484.362890927874 23:33:54 INFO - PROCESS | 31304 | |2;jquery.html;354.13414202275436;356.9964300356996;357.4941457837159;358.4873630708088;359.06642728904836;13252.403641836116;13746.312684365792;16028.358865645374;16586.170691465424;17771.733423998652;13991.230482323468;14245.358958846851;15190.772138417906;15217.315220815062;15222.08667479952;5154.639175257734;5155.587552995761;5320.1753728172;5337.759800808973;5350.170723537858;3917.2361389529055;4047.1905618876194;4055.168690418457;4066.8169932352966;5217.37391513019;5533.059379905406;5576.693281869496;5720.256366672327;5726.112452569859;5733.971330143343;5677.063284558043;5704.11586204139;5707.885842283173;5708.514776244025;5712.885742285131;4725.740084295362;4885.877853053702;4892.094962431962;5056.595472362203;5057.595392368602;10717.571297148104;10904.781904361947;10970.451477426177;17929.462116136536;18003.27986880523;1985.1662301833264;2208.1608988584235;2258.503129311549;2265.9206927757614;2310.8960096795686;8470.407071504997;8672.479651220947;8758.430702004413;10292.845607315896;12154.939225303906;1801.1084513166068;1853.8424233940132;1854.7125195594704;1898.1648074847162;1915.4253723882919;51510.48489515094;53222.73388633032;54177;54739.17891231635;55298.723506382616;9833.803323933624;9983.450910200008;10017.14854237398;10048.648297309559;10053;12833.614991550268;12840.486380544673;12853.550125745554;12865;12874.742505149845;6367.840803979845;6396.936030639634;6397.936020639827;6479.773207937699;6543.5419520633095;5717.142428635655;5719.399463056402;5764.365919748824;5765.3369862465515;5776.33572139201;4272.380504826782;4407.845725399596;4409.426774519292;4427.136708341907;4440.489343725513;1722.569357660585;1742.6079132195155;1753.4126067767186;1766.4612293250682;1820.2355010895456;825.3768404854417;846.4610880944654;850.974470765878;877.806882485852;879.1120967822545;13457.865421345858;15517.689646207013;15986.200689965455;16369.42707005249;16394.918025409796;816.9910160951221;853.6926706385697;866.8006358537446;868.4572142410993;892.6920212526668;8808.163224493663;9003.819923601492;9145.222656074175;9393.154616084585;9495.90504094964;356965;363850;365154;515065;518909;64813;70323;71182.64408677924;71347.2865271351;71669.28330716626;1008.294194064158;1033.1012019542895;1159.7738441003924;1203.205884116479;1207.6014915078003;13561.796573051215;14045.719085618435;14119.294035298399;14580.270986450847;14597;29079;29505.26236844096;29589;29877.253068673457;29892.402151956405;36612;37509;39675.60324396835;40109.1978160441;40315.596844031184;6696.397324240842;6874.312568743286;6906.309369063053;6981;7288.344049035612;9358.81282374335;10501.369917804956;10752.892471075189;10782.784344312913;10887.074598659203;8647.308215342884;9282.62869485213;9612.615495380387;9631.614735410505;9729.951350243204;8807.691730789391;9566;9577.760555986157;9658.661946831828;9725.708228753148;9868.85196722064;10076;10104.292699511258;10177.287589868934;10334.224933129895;6612.570182938093;7215.242399548182;7219.241979592067;7228.891566626399;7290.234525374972;9159.542022898962;9848.852267215854;9944.254180936314;9994.350367226107;10116.29185956976 23:33:54 INFO - PROCESS | 31304 | |3;mootools.html;1279.545761254755;1402.670372462471;1419.3754747910916;1535.838736932622;1723.6983527882626;6404.61572305662;6947.062146610206;7111.466640001995;7114.217436082034;7121;6747.190337159535;6910.619915904624;6918;6919.930800691992;6920.653967301628;2155.051777218027;2181.9781802182015;2184.377452426059;2186.8469207155504;2187.7155969723913;2150.7956744109365;2166.794154555315;2218.367765186922;2230.3309007297826;2249.3814201094665;2160.9891950540305;2173.8695678259355;2205.9227927022557;2215.29110684581;2215.556888622274;2200.537887043715;2202.5484775620957;2206.933791986243;2209.259897934186;2209.3703294561055;2194.7256592925883;2238.160689741347;2238.7649296823924;2240.3950933248093;2240.7759224077627;7298;7337.339639432424;7343.669534870944;7346.63266836656;7347.595882226476;4288.142371525676;4406.603405693503;4418.955810441887;4431.135928493945;4431.180231657121;2861.3848022675224;2880.5967164596973;2896.218021134303;2905.825650460979;2939.6913324101088;945.664289177346;958.7363475044349;977.9755506112333;986.0829428631441;992.2012779712329;9599.184069354113;9666.90333096667;9689.32174747768;9693.6122555097;9708.320417570772;3879.3017256893468;3895.8636447724193;3914.5693973662874;3935.980320098381;3988.521377434726;8395.244428001388;8395.874061889077;8403.663853445794;8418.957905210435;8423.326133909273;4351.82592696295;4353.760543170156;4353.978230108829;4357.586029327273;4358.891027724332;3499.1427100360575;3554.9822250889097;3801.9809900950318;3973.165635216579;4003.5796241394232;3526.8060256685617;3532.6997205237844;3549;3554.697850682721;3581.8209089545417;1151.0848875144113;1179.8761130081218;1186.4516805568644;1199.4122879789015;1201.9038476921826;838.8741688746737;917.9357444978921;920.8296465153968;962.2013728605241;1088.1784252889017;6423.261324947597;6573.211214654272;6584.045313429526;6601.075849381091;6604.273529911706;1032.1484775060455;1033.6227277043974;1034.2088302448633;1041.833306670929;1089.6622047165404;5148.330717006766;5193.195054766517;5202.375714914235;5209.453007434241;5218.399884013387;7987.760367188994;8277.875831862528;8343.541105239148;8443.408961372645;8515.957420212859;8415.537145456936;8470.534120623424;8481.40630155883;8494.830103397897;8522.48865068098;6374.58565193261;6480.4815614750705;6491.285958544557;6520.869582608416;6536.248331441945;6462.644554549357;6484.059811327237;6484.740610375721;6485.28661847187;6487.967560162169;7415.443841712001;7524.05949256343;7660.502067365604;7698.653560589899;7800.375969922506;7672.884906726292;7898.723544675909;7961;7965.243301886311;7986.201379861967;5943.673097979653;5965.970170149121;6005.759769609342;6011.428914253139;6012.248468941382;6548.901766473602;6567.9014814778775;6585.506087043395;6640.203175618763;6662.333766623299;6313.273973493107;6366.904496432465;6370.58591191571;6427.775027874002;6458.289588145206;5617.5505959522325;5762.798302059407;5882.470577648032;6173.32093469727;6182.474489668429;6150.354212807591;6196.969015155076;6205.596636218812;6212.968935155295;6222.62664240147;5748.856278593069;5871.647701137946;5873.853153671193;5874.324452687995;5884.529237660891;5693.5160511357;5726.513246374105;5733.971330143323;5735.025045742151;5737.5983681141915 23:33:54 INFO - PROCESS | 31304 | |4;prototype.html;323.30489447687467;326.6276444852868;331.07134487761846;334.89953014095767;335.4448387917993;5719.77120915164;5854.853628659285;5859.238299021126;5868.972929737295;5899.233099697033;5598.1602759586085;5730;5764.654120752758;5769.596128271012;5773.422657734224;4457.3091170868565;4460.464744230697;4460.620847227973;4466.687331886777;4472.306792447176;4256.808443620044;4331.30699088146;4344.348347747848;4437.5562443755525;4471.150481408538;4397.868063958086;4413.227685155101;4415.889602759925;4418.116376724652;4418.690691651585;4411.6250118739945;4418.712783669083;4422.137683151803;4428.114377124588;4432.069265454258;3878.4764056852246;3879.767213967171;3880.3403421418425;3880.708946828971;3886.2227554489214;5433.239346491494;5520.558355331604;5539.639923404966;5541.750621222055;5547.5007249347345;5113.821016264413;5117.283580298761;5118.360204974379;5120.820771273025;5123.846284611468;6063.605865618721;6079.300880398767;6083;6085.786997455112;6099.268087829444;4102.528209255944;4178.728382655148;4195.49654041517;4277.443932288783;4309.332053531708;6361.141245931786;6374.968125159391;6376.0754690570075;6378.77674281398;6390.4248617624635;4407.691461597721;4409.2724700424715;4412.801423935931;4414.690971631955;4416.116776644684;4361.302191649321;4459.264221403497;4465.218586747306;4467.329900514948;4470.128324976663;5131.7434128293435;5142.408623008327;5146.099432599355;5146.125158723026;5147.1507201312115;6090.208272924491;6138.6623735694075;6155.507559395327;6160.568760186834;6167.414095660905;1554.6579752454668;1557.914314712679;1575.054967019779;1575.968480630404;1576.2670358283224;1076.0638244726981;1087.6954452753241;1087.9564817407215;1088.2871719024051;1107.4462768615692;5772.6536407815665;5785.508231800344;5788.88422231553;5789.218455508537;5794.797182098607;6231.594946328565;6240;6243.094751261042;6248.4688801452385;6249;5764.452377024176;5779.479846813807;5779.682117483495;5790.073588225863;5791.218185544897;3332.7000569948823;3422.2128910350757;3424.383610950003;3430.3310854383158;3430.3996800559803;6561.639109848908;6567.704453299613;6570.638614876132;6570.770023049266;6574;6460.192475940507;6460.709268082947;6461.935380646133;6465.709043093072;6475.611463312216;6405.558749281375;6545.985372267306;6556.541042127101;6564.9671751640935;6567.244766851778;6149.292831324455;6289.465395441439;6304.369563043659;6310.716017779119;6311.27420346666;6147.170132032118;6184.350643182401;6235.781747638993;6281.780137695158;6287.46556542699;6558.540902136805;6621.470282377494;6630.569013014138;6632.668366581748;6635.9004614929845;4436.26801577736;4443.622292105078;4445.1776421360855;4447.3329000650165;4454.08691218293;6250.656213908097;6409.551331406757;6423.197100362455;6424.229092508929;6430.356964303533;6241.625502469867;6241.906371404341;6245.281792593728;6254.937450625617;6257.28041275241;6229.626222426669;6233.252009758858;6238.75044998195;6248.4376406123665;6249.281332646804;5994.610350327215;6127.632342059491;6136.5090792737365;6137.294211165773;6152.569320147547;6266.811995640138;6273.341299163522;6273.96863015682;6284.780032698834;6287.685615719287;6125.326214116532;6133.44798968095;6133.907991380043;6135.325114237341;6140.416660417253 23:33:54 INFO - PROCESS | 31304 | |5;yui.html;691.8685449764545;703.7888633409975;726.9236730143335;747.9850402991942;769.6959700918137;12779.424925878346;12833.743325133504;12896.484140634375;12906.354682265895;12926.482940682385;11401.315921044743;11445.542178312879;11454.656360309184;11463.19757616965;11500.252483588562;631.4190944331203;634.2547506679656;750.0886422996059;753.1376573822984;766.0386215299819;762.4967521435854;765.2309429023824;766.7623036858564;766.8964689766893;767.0641816983272;595.553334998751;595.8659301657136;596.3082823924249;596.3589141672697;596.4214711729616;661.110805965975;663.8207683925338;783.8784988326819;789.8854666073387;790.8734602463636;581.6335708503616;581.6800759582255;582.365221908118;583.833607421887;583.9065749480063;12367.690807729789;12448.81326780099;12465.252084874937;12472.064595155309;12473;11704.122190835722;11730.35483048432;12007.629568551865;12445.439955202037;12722;9687.17658998986;9839.606415743361;9921.702348929544;9949.452780097092;9966.451845148515;3545.2554963457706;3631.9273614527824;3696.094456858087;3699.2786406650443;3711.777293362407;41268.9999999997;41830.16339673189;42016.369754453706;42206.57793422057;42380.78809605963;9497.477638729799;9522.571484283224;9896.455694936847;9970;10029.899701002896;18015.27938882456;18146.364877229233;18153.63692726138;18157.909210454127;18179;7243.859343503493;7284.927150728531;7359.8160045999275;7388.7783366498015;7408.03695519579;4036.6770658347264;4061.9796901015898;4112.424260603518;4166.416701661769;4205.894852628648;2873.6551613806478;2881.4381195667065;2903.8548072596286;2904.607877936494;2905.9709402906124;480.26279660720627;498.82790437299076;504.3745755263447;516.1947362115112;529.5419462165277;477.59404506169477;494.4684464200926;494.5969035236271;520.3989392251955;542.0270614247356;7226.710931562784;7239.674214660353;7271.527350722186;7285.453590980697;7426.220246874001;451.3401939676486;462.1265807623594;466.73862636923434;470.1326053431482;484.5856792442481;3422.5379573757723;3552.0803686893837;3566.9108272292883;3620.435346176182;3823.636754508317;51426.48573514292;51642.22536661953;54317.45682543124;55166.72416637971;55494;44674.55325446769;45249.773751131695;45810.77094614506;45980.54019459763;46007.76996114998;40364.59635403608;40393.192136157115;40559.1888162241;40630.39054414186;41486.79256603698;7600.239976002576;7658.2724641159;7759.262870027338;7885.408594355561;8038.437309388287;32583.348333033682;33060.834695826365;33063.17342066467;33099.338013240085;33423.66576334303;40003;40143;40810.79594602008;42861.78569107259;43016.784916075216;9329.580168892551;9381.296402769683;9407.162622180605;9604.27967902396;10336.431496267476;10721.59800249688;10857.945710271399;11056.391898445663;11059;11235.174777652719;10186.388816671024;10332.896671033193;10392.305543361148;10481.109105726098;10672.946635266773;10079.496025198858;10256.179505639382;10547.947260263649;10761.89238107609;10837.13302935779;9832.655857044969;10195.745106372104;10310.226732994905;10455.215858810467;10482.790344193227;8757.781055473664;8778.515449508108;8960.775980600538;8979.371443998858;9190.632374704937;8935.910640893508;8996.730098097067;9159.35884488106;9216.815663686823;9291.67479138227 23:33:54 INFO - PROCESS | 31304 | __end_tp_report 23:33:54 INFO - PROCESS | 31304 | __start_cc_report 23:33:54 INFO - PROCESS | 31304 | _x_x_mozilla_cycle_collect,1440 23:33:54 INFO - PROCESS | 31304 | __end_cc_report 23:33:54 INFO - PROCESS | 31304 | __startTimestamp1452324834292__endTimestamp 23:33:54 INFO - PROCESS | 31304 | 23:33:54 INFO - PROCESS | 31304 | ------- Summary: start ------- 23:33:54 INFO - PROCESS | 31304 | Number of tests: 6 23:33:54 INFO - PROCESS | 31304 | 23:33:54 INFO - PROCESS | 31304 | [#0] dojo.html Cycles:165 Average:4998.01 Median:5160.38 stddev:507.63 (9.8%) stddev-sans-first:486.06 23:33:54 INFO - PROCESS | 31304 | Values: 3067.2 3121.3 3161.3 3166.8 3187.0 4825.6 4975.8 5059.3 5081.9 5091.9 5012.5 5017.9 5100.3 5106.7 5137.3 4591.9 4597.1 4649.5 4681.8 4706.5 4675.9 4681.2 4709.3 4731.5 4744.2 4475.7 4525.7 4589.3 4618.5 4621.4 4650.6 4656.3 4682.7 4689.1 4697.5 4630.1 4640.0 4644.6 4646.0 4691.9 4762.6 4843.1 4859.1 4933.2 4993.8 5254.5 5259.6 5261.3 5266.1 5286.4 5275.5 5301.8 5305.6 5325.1 5343.9 4894.4 4982.3 5004.6 5066.6 5112.9 5490.7 5523.6 5534.1 5534.6 5585.0 5202.0 5324.3 5325.2 5328.1 5337.6 5254.3 5391.3 5446.5 5449.4 5524.0 5250.5 5256.8 5262.0 5263.1 5306.7 5185.2 5239.1 5247.7 5253.1 5322.6 4181.8 4202.9 4251.4 4268.3 4283.8 3801.2 3801.5 3803.2 3827.8 3843.8 5033.2 5033.7 5036.2 5039.8 5045.6 5264.2 5376.8 5376.9 5387.1 5495.9 5001.6 5006.9 5008.3 5031.4 5057.4 4574.5 4584.4 4587.3 4594.2 4630.0 5369.4 5502.0 5510.9 5524.2 5576.2 5323.1 5378.4 5378.5 5396.4 5455.8 5477.4 5515.4 5522.7 5527.6 5529.5 5220.8 5267.2 5290.6 5346.1 5350.7 5325.8 5354.5 5356.1 5357.3 5360.0 5231.7 5247.4 5247.7 5250.9 5252.5 5225.6 5250.2 5308.2 5340.4 5358.0 5103.6 5151.2 5156.6 5160.4 5201.6 5150.3 5254.7 5262.3 5288.8 5290.9 5085.6 5093.5 5156.2 5219.4 5224.6 23:33:54 INFO - PROCESS | 31304 | 23:33:54 INFO - PROCESS | 31304 | [#1] ext.html Cycles:180 Average:42443.26 Median:32255.60 stddev:68245.36 (211.6%) stddev-sans-first:68364.23 23:33:54 INFO - PROCESS | 31304 | Values: 526.5 553.8 584.4 595.0 599.3 28140.4 28647.6 28650.3 28689.0 28769.4 36241.1 36904.4 36907.4 36933.1 36975.8 8175.7 8367.5 8371.4 8371.6 8378.8 7502.2 7719.8 8531.7 8714.3 9558.5 10026.5 10111.4 10115.7 10133.3 10139.3 9902.4 9968.0 10016.4 10021.8 10024.2 7434.1 7634.4 7642.2 9572.7 9808.3 35193.3 35870.8 35871.1 35881.3 35926.3 2746.4 2836.1 2939.9 3016.0 3089.2 28608.7 28768.0 29067.3 29131.7 29494.3 3863.7 3878.4 3995.4 3995.5 4088.3 208752.0 212555.0 213113.0 213671.0 215339.0 55351.7 60870.0 60890.4 60936.0 60955.0 55241.0 56785.0 65353.0 67065.7 67105.0 13119.3 13175.9 13225.5 13239.5 13297.3 9758.9 9842.2 9892.7 9894.0 9896.6 19913.2 20223.0 20292.1 20304.9 20314.9 7819.2 8208.5 8347.8 8449.0 8464.0 903.4 971.2 977.6 997.7 1040.5 28224.7 28293.4 28432.1 28491.9 28905.4 1031.8 1052.7 1057.5 1102.8 1110.0 14733.3 14970.9 15008.6 15093.0 15323.4 298187.0 302811.0 303499.0 304333.0 305814.0 50583.2 51155.7 51222.7 51621.7 51703.0 1279.5 1286.0 1292.1 1293.9 1315.2 27079.0 28272.7 28281.1 28398.6 28496.9 45927.8 46358.0 46373.8 46378.5 46409.2 236931.0 237152.0 240110.0 290021.0 290496.0 26924.3 27142.3 31823.5 31891.8 32013.7 35770.8 36511.6 36893.3 37009.1 37329.6 31515.4 31827.7 31853.7 32074.4 32308.7 28150.6 33380.3 35530.4 36106.3 37044.4 32495.5 34836.7 35192.8 35351.3 35454.3 29254.3 32202.5 32593.3 33034.7 33084.8 24790.4 24932.5 25014.2 25276.4 25484.4 23:33:54 INFO - PROCESS | 31304 | 23:33:54 INFO - PROCESS | 31304 | [#2] jquery.html Cycles:180 Average:23503.98 Median:4583.11 stddev:70552.74 (1539.4%) stddev-sans-first:70729.24 23:33:54 INFO - PROCESS | 31304 | Values: 354.1 357.0 357.5 358.5 359.1 13252.4 13746.3 16028.4 16586.2 17771.7 13991.2 14245.4 15190.8 15217.3 15222.1 5154.6 5155.6 5320.2 5337.8 5350.2 3917.2 4047.2 4055.2 4066.8 5217.4 5533.1 5576.7 5720.3 5726.1 5734.0 5677.1 5704.1 5707.9 5708.5 5712.9 4725.7 4885.9 4892.1 5056.6 5057.6 10717.6 10904.8 10970.5 17929.5 18003.3 1985.2 2208.2 2258.5 2265.9 2310.9 8470.4 8672.5 8758.4 10292.8 12154.9 1801.1 1853.8 1854.7 1898.2 1915.4 51510.5 53222.7 54177.0 54739.2 55298.7 9833.8 9983.5 10017.1 10048.6 10053.0 12833.6 12840.5 12853.6 12865.0 12874.7 6367.8 6396.9 6397.9 6479.8 6543.5 5717.1 5719.4 5764.4 5765.3 5776.3 4272.4 4407.8 4409.4 4427.1 4440.5 1722.6 1742.6 1753.4 1766.5 1820.2 825.4 846.5 851.0 877.8 879.1 13457.9 15517.7 15986.2 16369.4 16394.9 817.0 853.7 866.8 868.5 892.7 8808.2 9003.8 9145.2 9393.2 9495.9 356965.0 363850.0 365154.0 515065.0 518909.0 64813.0 70323.0 71182.6 71347.3 71669.3 1008.3 1033.1 1159.8 1203.2 1207.6 13561.8 14045.7 14119.3 14580.3 14597.0 29079.0 29505.3 29589.0 29877.3 29892.4 36612.0 37509.0 39675.6 40109.2 40315.6 6696.4 6874.3 6906.3 6981.0 7288.3 9358.8 10501.4 10752.9 10782.8 10887.1 8647.3 9282.6 9612.6 9631.6 9730.0 8807.7 9566.0 9577.8 9658.7 9725.7 9868.9 10076.0 10104.3 10177.3 10334.2 6612.6 7215.2 7219.2 7228.9 7290.2 9159.5 9848.9 9944.3 9994.4 10116.3 23:33:54 INFO - PROCESS | 31304 | 23:33:54 INFO - PROCESS | 31304 | [#3] mootools.html Cycles:180 Average:4956.92 Median:5985.86 stddev:2507.09 (41.9%) stddev-sans-first:2498.88 23:33:54 INFO - PROCESS | 31304 | Values: 1279.5 1402.7 1419.4 1535.8 1723.7 6404.6 6947.1 7111.5 7114.2 7121.0 6747.2 6910.6 6918.0 6919.9 6920.7 2155.1 2182.0 2184.4 2186.8 2187.7 2150.8 2166.8 2218.4 2230.3 2249.4 2161.0 2173.9 2205.9 2215.3 2215.6 2200.5 2202.5 2206.9 2209.3 2209.4 2194.7 2238.2 2238.8 2240.4 2240.8 7298.0 7337.3 7343.7 7346.6 7347.6 4288.1 4406.6 4419.0 4431.1 4431.2 2861.4 2880.6 2896.2 2905.8 2939.7 945.7 958.7 978.0 986.1 992.2 9599.2 9666.9 9689.3 9693.6 9708.3 3879.3 3895.9 3914.6 3936.0 3988.5 8395.2 8395.9 8403.7 8419.0 8423.3 4351.8 4353.8 4354.0 4357.6 4358.9 3499.1 3555.0 3802.0 3973.2 4003.6 3526.8 3532.7 3549.0 3554.7 3581.8 1151.1 1179.9 1186.5 1199.4 1201.9 838.9 917.9 920.8 962.2 1088.2 6423.3 6573.2 6584.0 6601.1 6604.3 1032.1 1033.6 1034.2 1041.8 1089.7 5148.3 5193.2 5202.4 5209.5 5218.4 7987.8 8277.9 8343.5 8443.4 8516.0 8415.5 8470.5 8481.4 8494.8 8522.5 6374.6 6480.5 6491.3 6520.9 6536.2 6462.6 6484.1 6484.7 6485.3 6488.0 7415.4 7524.1 7660.5 7698.7 7800.4 7672.9 7898.7 7961.0 7965.2 7986.2 5943.7 5966.0 6005.8 6011.4 6012.2 6548.9 6567.9 6585.5 6640.2 6662.3 6313.3 6366.9 6370.6 6427.8 6458.3 5617.6 5762.8 5882.5 6173.3 6182.5 6150.4 6197.0 6205.6 6213.0 6222.6 5748.9 5871.6 5873.9 5874.3 5884.5 5693.5 5726.5 5734.0 5735.0 5737.6 23:33:54 INFO - PROCESS | 31304 | 23:33:54 INFO - PROCESS | 31304 | [#4] prototype.html Cycles:180 Average:5146.92 Median:5787.20 stddev:1544.56 (26.7%) stddev-sans-first:1505.87 23:33:54 INFO - PROCESS | 31304 | Values: 323.3 326.6 331.1 334.9 335.4 5719.8 5854.9 5859.2 5869.0 5899.2 5598.2 5730.0 5764.7 5769.6 5773.4 4457.3 4460.5 4460.6 4466.7 4472.3 4256.8 4331.3 4344.3 4437.6 4471.2 4397.9 4413.2 4415.9 4418.1 4418.7 4411.6 4418.7 4422.1 4428.1 4432.1 3878.5 3879.8 3880.3 3880.7 3886.2 5433.2 5520.6 5539.6 5541.8 5547.5 5113.8 5117.3 5118.4 5120.8 5123.8 6063.6 6079.3 6083.0 6085.8 6099.3 4102.5 4178.7 4195.5 4277.4 4309.3 6361.1 6375.0 6376.1 6378.8 6390.4 4407.7 4409.3 4412.8 4414.7 4416.1 4361.3 4459.3 4465.2 4467.3 4470.1 5131.7 5142.4 5146.1 5146.1 5147.2 6090.2 6138.7 6155.5 6160.6 6167.4 1554.7 1557.9 1575.1 1576.0 1576.3 1076.1 1087.7 1088.0 1088.3 1107.4 5772.7 5785.5 5788.9 5789.2 5794.8 6231.6 6240.0 6243.1 6248.5 6249.0 5764.5 5779.5 5779.7 5790.1 5791.2 3332.7 3422.2 3424.4 3430.3 3430.4 6561.6 6567.7 6570.6 6570.8 6574.0 6460.2 6460.7 6461.9 6465.7 6475.6 6405.6 6546.0 6556.5 6565.0 6567.2 6149.3 6289.5 6304.4 6310.7 6311.3 6147.2 6184.4 6235.8 6281.8 6287.5 6558.5 6621.5 6630.6 6632.7 6635.9 4436.3 4443.6 4445.2 4447.3 4454.1 6250.7 6409.6 6423.2 6424.2 6430.4 6241.6 6241.9 6245.3 6254.9 6257.3 6229.6 6233.3 6238.8 6248.4 6249.3 5994.6 6127.6 6136.5 6137.3 6152.6 6266.8 6273.3 6274.0 6284.8 6287.7 6125.3 6133.4 6133.9 6135.3 6140.4 23:33:54 INFO - PROCESS | 31304 | 23:33:54 INFO - PROCESS | 31304 | [#5] yui.html Cycles:180 Average:12637.84 Median:45994.16 stddev:14440.71 (31.4%) stddev-sans-first:14453.36 23:33:54 INFO - PROCESS | 31304 | Values: 691.9 703.8 726.9 748.0 769.7 12779.4 12833.7 12896.5 12906.4 12926.5 11401.3 11445.5 11454.7 11463.2 11500.3 631.4 634.3 750.1 753.1 766.0 762.5 765.2 766.8 766.9 767.1 595.6 595.9 596.3 596.4 596.4 661.1 663.8 783.9 789.9 790.9 581.6 581.7 582.4 583.8 583.9 12367.7 12448.8 12465.3 12472.1 12473.0 11704.1 11730.4 12007.6 12445.4 12722.0 9687.2 9839.6 9921.7 9949.5 9966.5 3545.3 3631.9 3696.1 3699.3 3711.8 41269.0 41830.2 42016.4 42206.6 42380.8 9497.5 9522.6 9896.5 9970.0 10029.9 18015.3 18146.4 18153.6 18157.9 18179.0 7243.9 7284.9 7359.8 7388.8 7408.0 4036.7 4062.0 4112.4 4166.4 4205.9 2873.7 2881.4 2903.9 2904.6 2906.0 480.3 498.8 504.4 516.2 529.5 477.6 494.5 494.6 520.4 542.0 7226.7 7239.7 7271.5 7285.5 7426.2 451.3 462.1 466.7 470.1 484.6 3422.5 3552.1 3566.9 3620.4 3823.6 51426.5 51642.2 54317.5 55166.7 55494.0 44674.6 45249.8 45810.8 45980.5 46007.8 40364.6 40393.2 40559.2 40630.4 41486.8 7600.2 7658.3 7759.3 7885.4 8038.4 32583.3 33060.8 33063.2 33099.3 33423.7 40003.0 40143.0 40810.8 42861.8 43016.8 9329.6 9381.3 9407.2 9604.3 10336.4 10721.6 10857.9 11056.4 11059.0 11235.2 10186.4 10332.9 10392.3 10481.1 10672.9 10079.5 10256.2 10547.9 10761.9 10837.1 9832.7 10195.7 10310.2 10455.2 10482.8 8757.8 8778.5 8960.8 8979.4 9190.6 8935.9 8996.7 9159.4 9216.8 9291.7 23:33:54 INFO - PROCESS | 31304 | -------- Summary: end -------- 23:33:54 INFO - PROCESS | 31304 | 23:33:54 INFO - TEST-INFO | 31304: exit 0 23:33:55 INFO - TEST-OK | dromaeo_css | took 1112392ms 23:33:55 INFO - TEST-START | kraken 23:33:55 INFO - operating with platform_type : linux_ 23:33:55 INFO - Initialising browser for kraken test... 23:33:55 INFO - TEST-INFO | started process 31503 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFmxTOR/profile http://localhost:38147/getInfo.html) 23:33:58 INFO - PROCESS | 31503 | __metrics Screen width/height:1600/1200 23:33:58 INFO - PROCESS | 31503 | colorDepth:24 23:33:58 INFO - PROCESS | 31503 | Browser inner width/height: 1024/697 23:33:58 INFO - PROCESS | 31503 | __metrics 23:33:58 INFO - PROCESS | 31503 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:33:58 INFO - PROCESS | 31503 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:33:59 INFO - TEST-INFO | 31503: exit 0 23:33:59 INFO - Browser initialized. 23:33:59 INFO - Running cycle 1/1 for kraken test... 23:33:59 INFO - TEST-INFO | started process 31588 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFmxTOR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:34:11 INFO - PROCESS | 31588 | RSS: Main: 149250048 23:34:11 INFO - PROCESS | 31588 | 23:34:13 INFO - PROCESS | 31588 | Cycle 1(1): loaded http://localhost:38147/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38147/tests/kraken/driver.html?testName=audio-beat-detection) 23:34:14 INFO - PROCESS | 31588 | RSS: Main: 186937344 23:34:14 INFO - PROCESS | 31588 | 23:34:17 INFO - PROCESS | 31588 | Cycle 1(1): loaded http://localhost:38147/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38147/tests/kraken/driver.html?testName=audio-dft) 23:34:17 INFO - PROCESS | 31588 | RSS: Main: 176685056 23:34:17 INFO - PROCESS | 31588 | 23:34:20 INFO - PROCESS | 31588 | Cycle 1(1): loaded http://localhost:38147/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38147/tests/kraken/driver.html?testName=audio-fft) 23:34:21 INFO - PROCESS | 31588 | RSS: Main: 159842304 23:34:21 INFO - PROCESS | 31588 | 23:34:23 INFO - PROCESS | 31588 | Cycle 1(1): loaded http://localhost:38147/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38147/tests/kraken/driver.html?testName=audio-oscillator) 23:34:23 INFO - PROCESS | 31588 | RSS: Main: 163713024 23:34:23 INFO - PROCESS | 31588 | 23:34:25 INFO - PROCESS | 31588 | Cycle 1(1): loaded http://localhost:38147/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38147/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:34:26 INFO - PROCESS | 31588 | RSS: Main: 163753984 23:34:26 INFO - PROCESS | 31588 | 23:34:29 INFO - PROCESS | 31588 | Cycle 1(1): loaded http://localhost:38147/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38147/tests/kraken/driver.html?testName=imaging-darkroom) 23:34:29 INFO - PROCESS | 31588 | RSS: Main: 163815424 23:34:29 INFO - PROCESS | 31588 | 23:34:33 INFO - PROCESS | 31588 | Cycle 1(1): loaded http://localhost:38147/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38147/tests/kraken/driver.html?testName=imaging-desaturate) 23:34:33 INFO - PROCESS | 31588 | RSS: Main: 164478976 23:34:33 INFO - PROCESS | 31588 | 23:34:36 INFO - PROCESS | 31588 | Cycle 1(1): loaded http://localhost:38147/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38147/tests/kraken/driver.html?testName=json-parse-financial) 23:34:37 INFO - PROCESS | 31588 | RSS: Main: 164708352 23:34:37 INFO - PROCESS | 31588 | 23:34:38 INFO - PROCESS | 31588 | Cycle 1(1): loaded http://localhost:38147/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38147/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:34:39 INFO - PROCESS | 31588 | RSS: Main: 176181248 23:34:39 INFO - PROCESS | 31588 | 23:34:41 INFO - PROCESS | 31588 | Cycle 1(1): loaded http://localhost:38147/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38147/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:34:41 INFO - PROCESS | 31588 | RSS: Main: 173088768 23:34:41 INFO - PROCESS | 31588 | 23:34:43 INFO - PROCESS | 31588 | Cycle 1(1): loaded http://localhost:38147/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38147/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:34:44 INFO - PROCESS | 31588 | RSS: Main: 184262656 23:34:44 INFO - PROCESS | 31588 | 23:34:46 INFO - PROCESS | 31588 | Cycle 1(1): loaded http://localhost:38147/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38147/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:34:47 INFO - PROCESS | 31588 | RSS: Main: 189984768 23:34:47 INFO - PROCESS | 31588 | 23:34:49 INFO - PROCESS | 31588 | Cycle 1(1): loaded http://localhost:38147/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38147/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:34:50 INFO - PROCESS | 31588 | RSS: Main: 189321216 23:34:50 INFO - PROCESS | 31588 | 23:34:52 INFO - PROCESS | 31588 | Cycle 1(1): loaded http://localhost:38147/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38147/tests/kraken/driver.html?testName=ai-astar) 23:34:52 INFO - PROCESS | 31588 | RSS: Main: 247521280 23:34:52 INFO - PROCESS | 31588 | 23:34:52 INFO - PROCESS | 31588 | __start_tp_report 23:34:52 INFO - PROCESS | 31588 | _x_x_mozilla_page_load 23:34:52 INFO - PROCESS | 31588 | _x_x_mozilla_page_load_details 23:34:52 INFO - PROCESS | 31588 | |i|pagename|runs| 23:34:52 INFO - PROCESS | 31588 | |0;ai-astar;111;111;106;112;111;111;100;110;110;110 23:34:52 INFO - PROCESS | 31588 | |1;audio-beat-detection;149;125;154;164;124;147;156;127;169;123 23:34:52 INFO - PROCESS | 31588 | |2;audio-dft;162;161;161;162;159;163;161;162;161;162 23:34:52 INFO - PROCESS | 31588 | |3;audio-fft;71;75;80;94;71;72;82;114;91;75 23:34:52 INFO - PROCESS | 31588 | |4;audio-oscillator;96;95;152;95;96;95;141;95;96;140 23:34:52 INFO - PROCESS | 31588 | |5;imaging-gaussian-blur;109;109;109;109;110;109;109;108;109;109 23:34:52 INFO - PROCESS | 31588 | |6;imaging-darkroom;146;145;145;145;146;147;146;145;145;145 23:34:52 INFO - PROCESS | 31588 | |7;imaging-desaturate;95;96;96;98;95;96;96;95;96;95 23:34:52 INFO - PROCESS | 31588 | |8;json-parse-financial;58;61;58;56;56;56;59;65;56;55 23:34:52 INFO - PROCESS | 31588 | |9;json-stringify-tinderbox;66;68;66;68;70;67;66;67;66;66 23:34:52 INFO - PROCESS | 31588 | |10;stanford-crypto-aes;84;85;85;84;85;85;85;84;93;87 23:34:52 INFO - PROCESS | 31588 | |11;stanford-crypto-ccm;117;121;127;117;125;118;129;125;124;123 23:34:52 INFO - PROCESS | 31588 | |12;stanford-crypto-pbkdf2;141;149;150;149;145;141;155;149;148;141 23:34:52 INFO - PROCESS | 31588 | |13;stanford-crypto-sha256-iterative;70;69;66;68;69;72;70;66;67;69 23:34:52 INFO - PROCESS | 31588 | __end_tp_report 23:34:52 INFO - PROCESS | 31588 | __start_cc_report 23:34:52 INFO - PROCESS | 31588 | _x_x_mozilla_cycle_collect,961 23:34:52 INFO - PROCESS | 31588 | __end_cc_report 23:34:52 INFO - PROCESS | 31588 | __startTimestamp1452324892437__endTimestamp 23:34:52 INFO - PROCESS | 31588 | 23:34:52 INFO - PROCESS | 31588 | ------- Summary: start ------- 23:34:52 INFO - PROCESS | 31588 | Number of tests: 14 23:34:52 INFO - PROCESS | 31588 | 23:34:52 INFO - PROCESS | 31588 | [#0] ai-astar Cycles:10 Average:109.20 Median:111.00 stddev:3.61 (3.3%) stddev-sans-first:3.77 23:34:52 INFO - PROCESS | 31588 | Values: 111.0 111.0 106.0 112.0 111.0 111.0 100.0 110.0 110.0 110.0 23:34:52 INFO - PROCESS | 31588 | 23:34:52 INFO - PROCESS | 31588 | [#1] audio-beat-detection Cycles:10 Average:143.80 Median:151.50 stddev:17.62 (11.6%) stddev-sans-first:18.59 23:34:52 INFO - PROCESS | 31588 | Values: 149.0 125.0 154.0 164.0 124.0 147.0 156.0 127.0 169.0 123.0 23:34:52 INFO - PROCESS | 31588 | 23:34:52 INFO - PROCESS | 31588 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 23:34:52 INFO - PROCESS | 31588 | Values: 162.0 161.0 161.0 162.0 159.0 163.0 161.0 162.0 161.0 162.0 23:34:52 INFO - PROCESS | 31588 | 23:34:52 INFO - PROCESS | 31588 | [#3] audio-fft Cycles:10 Average:82.50 Median:77.50 stddev:13.71 (17.7%) stddev-sans-first:13.89 23:34:52 INFO - PROCESS | 31588 | Values: 71.0 75.0 80.0 94.0 71.0 72.0 82.0 114.0 91.0 75.0 23:34:52 INFO - PROCESS | 31588 | 23:34:52 INFO - PROCESS | 31588 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:95.00 stddev:23.83 (25.1%) stddev-sans-first:24.73 23:34:52 INFO - PROCESS | 31588 | Values: 96.0 95.0 152.0 95.0 96.0 95.0 141.0 95.0 96.0 140.0 23:34:52 INFO - PROCESS | 31588 | 23:34:52 INFO - PROCESS | 31588 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 23:34:52 INFO - PROCESS | 31588 | Values: 109.0 109.0 109.0 109.0 110.0 109.0 109.0 108.0 109.0 109.0 23:34:52 INFO - PROCESS | 31588 | 23:34:52 INFO - PROCESS | 31588 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 23:34:52 INFO - PROCESS | 31588 | Values: 146.0 145.0 145.0 145.0 146.0 147.0 146.0 145.0 145.0 145.0 23:34:52 INFO - PROCESS | 31588 | 23:34:52 INFO - PROCESS | 31588 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.92 (1.0%) stddev-sans-first:0.93 23:34:52 INFO - PROCESS | 31588 | Values: 95.0 96.0 96.0 98.0 95.0 96.0 96.0 95.0 96.0 95.0 23:34:52 INFO - PROCESS | 31588 | 23:34:52 INFO - PROCESS | 31588 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:58.00 stddev:3.06 (5.3%) stddev-sans-first:3.24 23:34:52 INFO - PROCESS | 31588 | Values: 58.0 61.0 58.0 56.0 56.0 56.0 59.0 65.0 56.0 55.0 23:34:52 INFO - PROCESS | 31588 | 23:34:52 INFO - PROCESS | 31588 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:1.33 (2.0%) stddev-sans-first:1.36 23:34:52 INFO - PROCESS | 31588 | Values: 66.0 68.0 66.0 68.0 70.0 67.0 66.0 67.0 66.0 66.0 23:34:52 INFO - PROCESS | 31588 | 23:34:52 INFO - PROCESS | 31588 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.00 stddev:2.71 (3.2%) stddev-sans-first:2.80 23:34:52 INFO - PROCESS | 31588 | Values: 84.0 85.0 85.0 84.0 85.0 85.0 85.0 84.0 93.0 87.0 23:34:52 INFO - PROCESS | 31588 | 23:34:52 INFO - PROCESS | 31588 | [#11] stanford-crypto-ccm Cycles:10 Average:122.60 Median:124.50 stddev:4.22 (3.4%) stddev-sans-first:3.96 23:34:52 INFO - PROCESS | 31588 | Values: 117.0 121.0 127.0 117.0 125.0 118.0 129.0 125.0 124.0 123.0 23:34:52 INFO - PROCESS | 31588 | 23:34:52 INFO - PROCESS | 31588 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.80 Median:149.00 stddev:4.69 (3.1%) stddev-sans-first:4.48 23:34:52 INFO - PROCESS | 31588 | Values: 141.0 149.0 150.0 149.0 145.0 141.0 155.0 149.0 148.0 141.0 23:34:52 INFO - PROCESS | 31588 | 23:34:52 INFO - PROCESS | 31588 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.90 (2.7%) stddev-sans-first:1.94 23:34:52 INFO - PROCESS | 31588 | Values: 70.0 69.0 66.0 68.0 69.0 72.0 70.0 66.0 67.0 69.0 23:34:52 INFO - PROCESS | 31588 | -------- Summary: end -------- 23:34:52 INFO - PROCESS | 31588 | 23:34:53 INFO - TEST-INFO | 31588: exit 0 23:34:53 INFO - TEST-OK | kraken | took 58333ms 23:34:53 INFO - TEST-START | v8_7 23:34:53 INFO - operating with platform_type : linux_ 23:34:53 INFO - Initialising browser for v8_7 test... 23:34:53 INFO - TEST-INFO | started process 31839 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6o58hL/profile http://localhost:38147/getInfo.html) 23:34:56 INFO - PROCESS | 31839 | __metrics Screen width/height:1600/1200 23:34:56 INFO - PROCESS | 31839 | colorDepth:24 23:34:56 INFO - PROCESS | 31839 | Browser inner width/height: 1024/697 23:34:56 INFO - PROCESS | 31839 | __metrics 23:34:56 INFO - PROCESS | 31839 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:34:56 INFO - PROCESS | 31839 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:34:57 INFO - TEST-INFO | 31839: exit 0 23:34:57 INFO - Browser initialized. 23:34:57 INFO - Running cycle 1/1 for v8_7 test... 23:34:57 INFO - TEST-INFO | started process 31922 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6o58hL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:35:09 INFO - PROCESS | 31922 | RSS: Main: 149254144 23:35:09 INFO - PROCESS | 31922 | 23:35:32 INFO - PROCESS | 31922 | Cycle 1(1): loaded http://localhost:38147/tests/v8_7/run.html (next: http://localhost:38147/tests/v8_7/run.html) 23:35:32 INFO - PROCESS | 31922 | RSS: Main: 547282944 23:35:32 INFO - PROCESS | 31922 | 23:35:32 INFO - PROCESS | 31922 | __start_tp_report 23:35:32 INFO - PROCESS | 31922 | _x_x_mozilla_page_load 23:35:32 INFO - PROCESS | 31922 | _x_x_mozilla_page_load_details 23:35:32 INFO - PROCESS | 31922 | |i|pagename|runs| 23:35:32 INFO - PROCESS | 31922 | |0;Richards;167.64459346186086 23:35:32 INFO - PROCESS | 31922 | |1;DeltaBlue;190.36740909956217 23:35:32 INFO - PROCESS | 31922 | |2;Encrypt;279.87685418415896 23:35:32 INFO - PROCESS | 31922 | |3;Decrypt;5284.210526315789 23:35:32 INFO - PROCESS | 31922 | |4;RayTrace;1976.2845849802372 23:35:32 INFO - PROCESS | 31922 | |5;Earley;800.8 23:35:32 INFO - PROCESS | 31922 | |6;Boyer;12304.878048780487 23:35:32 INFO - PROCESS | 31922 | |7;RegExp;42333.333333333336 23:35:32 INFO - PROCESS | 31922 | |8;Splay;571.5909090909091 23:35:32 INFO - PROCESS | 31922 | |9;NavierStokes;4830.917874396136 23:35:32 INFO - PROCESS | 31922 | __end_tp_report 23:35:32 INFO - PROCESS | 31922 | __startTimestamp1452324932362__endTimestamp 23:35:32 INFO - PROCESS | 31922 | 23:35:32 INFO - PROCESS | 31922 | ------- Summary: start ------- 23:35:32 INFO - PROCESS | 31922 | Number of tests: 10 23:35:32 INFO - PROCESS | 31922 | 23:35:32 INFO - PROCESS | 31922 | [#0] Richards Cycles:1 Average:167.64 Median:167.64 stddev:0.00 (0.0%) 23:35:32 INFO - PROCESS | 31922 | Values: 167.6 23:35:32 INFO - PROCESS | 31922 | 23:35:32 INFO - PROCESS | 31922 | [#1] DeltaBlue Cycles:1 Average:190.37 Median:190.37 stddev:0.00 (0.0%) 23:35:32 INFO - PROCESS | 31922 | Values: 190.4 23:35:32 INFO - PROCESS | 31922 | 23:35:32 INFO - PROCESS | 31922 | [#2] Encrypt Cycles:1 Average:279.88 Median:279.88 stddev:0.00 (0.0%) 23:35:32 INFO - PROCESS | 31922 | Values: 279.9 23:35:32 INFO - PROCESS | 31922 | 23:35:32 INFO - PROCESS | 31922 | [#3] Decrypt Cycles:1 Average:5284.21 Median:5284.21 stddev:0.00 (0.0%) 23:35:32 INFO - PROCESS | 31922 | Values: 5284.2 23:35:32 INFO - PROCESS | 31922 | 23:35:32 INFO - PROCESS | 31922 | [#4] RayTrace Cycles:1 Average:1976.28 Median:1976.28 stddev:0.00 (0.0%) 23:35:32 INFO - PROCESS | 31922 | Values: 1976.3 23:35:32 INFO - PROCESS | 31922 | 23:35:32 INFO - PROCESS | 31922 | [#5] Earley Cycles:1 Average:800.80 Median:800.80 stddev:0.00 (0.0%) 23:35:32 INFO - PROCESS | 31922 | Values: 800.8 23:35:32 INFO - PROCESS | 31922 | 23:35:32 INFO - PROCESS | 31922 | [#6] Boyer Cycles:1 Average:12304.88 Median:12304.88 stddev:0.00 (0.0%) 23:35:32 INFO - PROCESS | 31922 | Values: 12304.9 23:35:32 INFO - PROCESS | 31922 | 23:35:32 INFO - PROCESS | 31922 | [#7] RegExp Cycles:1 Average:42333.33 Median:42333.33 stddev:0.00 (0.0%) 23:35:32 INFO - PROCESS | 31922 | Values: 42333.3 23:35:32 INFO - PROCESS | 31922 | 23:35:32 INFO - PROCESS | 31922 | [#8] Splay Cycles:1 Average:571.59 Median:571.59 stddev:0.00 (0.0%) 23:35:32 INFO - PROCESS | 31922 | Values: 571.6 23:35:32 INFO - PROCESS | 31922 | 23:35:32 INFO - PROCESS | 31922 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 23:35:32 INFO - PROCESS | 31922 | Values: 4830.9 23:35:32 INFO - PROCESS | 31922 | -------- Summary: end -------- 23:35:32 INFO - PROCESS | 31922 | 23:35:33 INFO - TEST-INFO | 31922: exit 0 23:35:33 INFO - TEST-OK | v8_7 | took 39871ms 23:35:33 INFO - SUITE-END | took 1210s 23:35:33 INFO - Completed test suite (00:20:10) 23:35:33 INFO - Working with test: dromaeo_css 23:35:33 INFO - Generating results file: dromaeo_css 23:35:33 INFO - Working with test: kraken 23:35:33 INFO - Generating results file: kraken 23:35:33 INFO - javascript benchmark 23:35:33 INFO - Working with test: v8_7 23:35:33 INFO - Generating results file: v8_7 23:35:33 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:35:33 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 23:35:33 INFO - process_Request line: dromaeo_css 6476.07 graph.html#tests=[[72,64,35]] 23:35:33 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:35:33 INFO - process_Request line: kraken 1506.00 graph.html#tests=[[232,64,35]] 23:35:33 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:35:33 INFO - process_Request line: v8_7 18920.53 graph.html#tests=[[230,64,35]] 23:35:33 INFO - RETURN: dromaeo_css: 6476.07 23:35:33 INFO - RETURN: kraken: 1506.00 23:35:33 INFO - RETURN: v8_7: 18920.53 23:35:33 INFO - javascript benchmark 23:35:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3067.202527342891, 3121.2508997840496, 3161.320316132031, 3166.7783255172135, 3187.04388683395, 4825.638077144219, 4975.776090075946, 5059.291699162116, 5081.872953176173, 5091.923621145681, 5012.548870601645, 5017.874553136174, 5100.285959965608, 5106.719130447833, 5137.332146820908, 4591.931121033195, 4597.126545956275, 4649.51180126087, 4681.812727490897, 4706.505816889228, 4675.906481870361, 4681.180793361165, 4709.293605959099, 4731.503192164808, 4744.217204161309, 4475.70907890986, 4525.660575456821, 4589.265717485203, 4618.468876079227, 4621.353010578522, 4650.581447669692, 4656.301554766778, 4682.719036857766, 4689.132510485537, 4697.506761790031, 4630.143423466669, 4640.048789998076, 4644.58198762113, 4645.953540464586, 4691.929621055687, 4762.642801789845, 4843.128236917353, 4859.125357435661, 4933.161362568372, 4993.800247990076, 5254.474552544753, 5259.631825772198, 5261.316028916254, 5266.131088370453, 5286.444923283077, 5275.472452754732, 5301.840944771663, 5305.628605997582, 5325.068113080196, 5343.919841202385, 4894.388201474816, 4982.327385802942, 5004.649674522749, 5066.569341605931, 5112.897742045176, 5490.69801160932, 5523.613347065747, 5534.05920993424, 5534.612577119644, 5585.022621041383, 5201.973990130025, 5324.254604355393, 5325.227841962894, 5328.094223981932, 5337.599680024014, 5254.264402983586, 5391.32608423947, 5446.455354464521, 5449.373322067933, 5523.972380138073, 5250.527452529291, 5256.842294731164, 5261.973690131525, 5263.131583288791, 5306.734663266899, 5185.170372740344, 5239.1093514102695, 5247.737613119329, 5253.106971814801, 5322.574194064466, 4181.770002649822, 4202.873913782591, 4251.3622956556765, 4268.295731204378, 4283.807228674717, 3801.163743976321, 3801.467794508771, 3803.201327721154, 3827.770333779982, 3843.807809609564, 5033.19468884984, 5033.697978121324, 5036.169032109661, 5039.84880453587, 5045.571126454292, 5264.15773476242, 5376.8118115865755, 5376.865578360573, 5387.138057910794, 5495.917561236584, 5001.599872010231, 5006.924896126561, 5008.348914641147, 5031.371078615173, 5057.367829021372, 4574.4510658721165, 4584.404027476474, 4587.288970209623, 4594.173048851172, 4629.953700463019, 5369.382521010056, 5502.0371434999515, 5510.889782204334, 5524.1989911462615, 5576.219329293902, 5323.095073837534, 5378.354597448175, 5378.542823860016, 5396.406395296436, 5455.8363249102595, 5477.4248703887115, 5515.365732940763, 5522.66863988162, 5527.640703354269, 5529.474699903502, 5220.765065571983, 5267.236250743544, 5290.576753859605, 5346.064438723286, 5350.732463376893, 5325.840224793263, 5354.491323324434, 5356.143017117242, 5357.303550538405, 5359.973200134131, 5231.738413079407, 5247.396549396868, 5247.711375874211, 5250.89498210026, 5252.527272545489, 5225.555827754683, 5250.159974404077, 5308.230306605444, 5340.359156901197, 5357.973210134081, 5103.617228707936, 5151.2273159026445, 5156.587473002076, 5160.380754309507, 5201.609879258995, 5150.253213283978, 5254.6847189168775, 5262.315898933114, 5288.8413347599635, 5290.867728306823, 5085.618578606545, 5093.516115968977, 5156.1750119980625, 5219.399769026459, 5224.634275600672], "unit": "score", "name": "dojo.html", "value": 4968.262844250603}, {"lowerIsBetter": false, "replicates": [526.51823581423, 553.8061678412558, 584.3718003146618, 594.9881002379954, 599.3227652752389, 28140.437191256162, 28647.57028644572, 28650.28374290644, 28689.0, 28769.42461150776, 36241.0939726507, 36904.446433303456, 36907.4463883042, 36933.07667308319, 36975.81512092436, 8175.713850015236, 8367.497950123012, 8371.372147088992, 8371.58142092893, 8378.832423351529, 7502.212267711893, 7719.807004824868, 8531.658733650678, 8714.346424018193, 9558.522073896313, 10026.498675066254, 10111.393316401003, 10115.747106322327, 10133.341332813343, 10139.34094283873, 9902.405855648649, 9968.0, 10016.449095299791, 10021.849672254923, 10024.248181386425, 7434.145073316584, 7634.351080158193, 7642.235776422369, 9572.712818615453, 9808.264380171515, 35193.29613407717, 35870.82064589686, 35871.103222419384, 35881.28237435263, 35926.281474370626, 2746.40952195279, 2836.0788041729347, 2939.853007349624, 3016.0499442675487, 3089.1813669377634, 28608.713912860814, 28768.0, 29067.273318167005, 29131.70868291311, 29494.26264343387, 3863.729538932276, 3878.3600705883496, 3995.4206640037323, 3995.4805875236034, 4088.3049881519914, 208752.0, 212555.0, 213113.0, 213671.0, 215339.0, 55351.72324138434, 60870.0, 60890.391096089355, 60936.0, 60955.0, 55241.0, 56785.0, 65353.0, 67065.66467167634, 67105.0, 13119.278439685719, 13175.868241317656, 13225.537106201236, 13239.536616218385, 13297.268650224138, 9758.853617195748, 9842.163416109712, 9892.65375711861, 9894.0, 9896.55465504054, 19913.203471861252, 20223.0, 20292.08685609151, 20304.89847550753, 20314.898425507778, 7819.218078192249, 8208.548529830916, 8347.791305217297, 8449.0, 8464.0, 903.3902116071625, 971.155095067296, 977.5600979559084, 997.7356000659831, 1040.453761775074, 28224.71775282262, 28293.43413131726, 28432.147035588965, 28491.857540712164, 28905.421891562473, 1031.7884833609091, 1052.710504611238, 1057.471264367816, 1102.8125218712837, 1109.983350249747, 14733.336999835034, 14970.877184211009, 15008.62478438026, 15093.0, 15323.387064517518, 298187.0, 302811.0, 303499.0, 304333.0, 305814.0, 50583.24125138126, 51155.744221278655, 51222.74388628033, 51621.74189129106, 51703.0, 1279.4882047181202, 1285.971223021579, 1292.08262133886, 1293.8641442648575, 1315.1714419915393, 27079.0, 28272.71727282783, 28281.074861376874, 28398.574021390108, 28496.85751571229, 45927.77036114798, 46358.0, 46373.76813115913, 46378.536214637425, 46409.19885014373, 236931.0, 237152.0, 240110.0, 290021.0, 290496.0, 26924.326891827863, 27142.321441964108, 31823.522647160775, 31891.840540797148, 32013.67986320107, 35770.8211458941, 36511.634883650826, 36893.26213475662, 37009.07477313089, 37329.62670373262, 31515.369692606477, 31827.68172318247, 31853.681463185072, 32074.35851283008, 32308.676913230567, 28150.577741334306, 33380.33239335248, 35530.40258033725, 36106.27787444289, 37044.44433333448, 32495.481190768798, 34836.65163348334, 35192.824035879654, 35351.29297413986, 35454.29091418105, 29254.268643283238, 32202.516962246053, 32593.348133036732, 33034.66965330316, 33084.834575826964, 24790.38024049413, 24932.501349973263, 25014.249572512854, 25276.368090797878, 25484.362890927874], "unit": "score", "name": "ext.html", "value": 17642.28016002655}, {"lowerIsBetter": false, "replicates": [354.13414202275436, 356.9964300356996, 357.4941457837159, 358.4873630708088, 359.06642728904836, 13252.403641836116, 13746.312684365792, 16028.358865645374, 16586.170691465424, 17771.733423998652, 13991.230482323468, 14245.358958846851, 15190.772138417906, 15217.315220815062, 15222.08667479952, 5154.639175257734, 5155.587552995761, 5320.1753728172, 5337.759800808973, 5350.170723537858, 3917.2361389529055, 4047.1905618876194, 4055.168690418457, 4066.8169932352966, 5217.37391513019, 5533.059379905406, 5576.693281869496, 5720.256366672327, 5726.112452569859, 5733.971330143343, 5677.063284558043, 5704.11586204139, 5707.885842283173, 5708.514776244025, 5712.885742285131, 4725.740084295362, 4885.877853053702, 4892.094962431962, 5056.595472362203, 5057.595392368602, 10717.571297148104, 10904.781904361947, 10970.451477426177, 17929.462116136536, 18003.27986880523, 1985.1662301833264, 2208.1608988584235, 2258.503129311549, 2265.9206927757614, 2310.8960096795686, 8470.407071504997, 8672.479651220947, 8758.430702004413, 10292.845607315896, 12154.939225303906, 1801.1084513166068, 1853.8424233940132, 1854.7125195594704, 1898.1648074847162, 1915.4253723882919, 51510.48489515094, 53222.73388633032, 54177.0, 54739.17891231635, 55298.723506382616, 9833.803323933624, 9983.450910200008, 10017.14854237398, 10048.648297309559, 10053.0, 12833.614991550268, 12840.486380544673, 12853.550125745554, 12865.0, 12874.742505149845, 6367.840803979845, 6396.936030639634, 6397.936020639827, 6479.773207937699, 6543.5419520633095, 5717.142428635655, 5719.399463056402, 5764.365919748824, 5765.3369862465515, 5776.33572139201, 4272.380504826782, 4407.845725399596, 4409.426774519292, 4427.136708341907, 4440.489343725513, 1722.569357660585, 1742.6079132195155, 1753.4126067767186, 1766.4612293250682, 1820.2355010895456, 825.3768404854417, 846.4610880944654, 850.974470765878, 877.806882485852, 879.1120967822545, 13457.865421345858, 15517.689646207013, 15986.200689965455, 16369.42707005249, 16394.918025409796, 816.9910160951221, 853.6926706385697, 866.8006358537446, 868.4572142410993, 892.6920212526668, 8808.163224493663, 9003.819923601492, 9145.222656074175, 9393.154616084585, 9495.90504094964, 356965.0, 363850.0, 365154.0, 515065.0, 518909.0, 64813.0, 70323.0, 71182.64408677924, 71347.2865271351, 71669.28330716626, 1008.294194064158, 1033.1012019542895, 1159.7738441003924, 1203.205884116479, 1207.6014915078003, 13561.796573051215, 14045.719085618435, 14119.294035298399, 14580.270986450847, 14597.0, 29079.0, 29505.26236844096, 29589.0, 29877.253068673457, 29892.402151956405, 36612.0, 37509.0, 39675.60324396835, 40109.1978160441, 40315.596844031184, 6696.397324240842, 6874.312568743286, 6906.309369063053, 6981.0, 7288.344049035612, 9358.81282374335, 10501.369917804956, 10752.892471075189, 10782.784344312913, 10887.074598659203, 8647.308215342884, 9282.62869485213, 9612.615495380387, 9631.614735410505, 9729.951350243204, 8807.691730789391, 9566.0, 9577.760555986157, 9658.661946831828, 9725.708228753148, 9868.85196722064, 10076.0, 10104.292699511258, 10177.287589868934, 10334.224933129895, 6612.570182938093, 7215.242399548182, 7219.241979592067, 7228.891566626399, 7290.234525374972, 9159.542022898962, 9848.852267215854, 9944.254180936314, 9994.350367226107, 10116.29185956976], "unit": "score", "name": "jquery.html", "value": 7699.131594260846}, {"lowerIsBetter": false, "replicates": [1279.545761254755, 1402.670372462471, 1419.3754747910916, 1535.838736932622, 1723.6983527882626, 6404.61572305662, 6947.062146610206, 7111.466640001995, 7114.217436082034, 7121.0, 6747.190337159535, 6910.619915904624, 6918.0, 6919.930800691992, 6920.653967301628, 2155.051777218027, 2181.9781802182015, 2184.377452426059, 2186.8469207155504, 2187.7155969723913, 2150.7956744109365, 2166.794154555315, 2218.367765186922, 2230.3309007297826, 2249.3814201094665, 2160.9891950540305, 2173.8695678259355, 2205.9227927022557, 2215.29110684581, 2215.556888622274, 2200.537887043715, 2202.5484775620957, 2206.933791986243, 2209.259897934186, 2209.3703294561055, 2194.7256592925883, 2238.160689741347, 2238.7649296823924, 2240.3950933248093, 2240.7759224077627, 7298.0, 7337.339639432424, 7343.669534870944, 7346.63266836656, 7347.595882226476, 4288.142371525676, 4406.603405693503, 4418.955810441887, 4431.135928493945, 4431.180231657121, 2861.3848022675224, 2880.5967164596973, 2896.218021134303, 2905.825650460979, 2939.6913324101088, 945.664289177346, 958.7363475044349, 977.9755506112333, 986.0829428631441, 992.2012779712329, 9599.184069354113, 9666.90333096667, 9689.32174747768, 9693.6122555097, 9708.320417570772, 3879.3017256893468, 3895.8636447724193, 3914.5693973662874, 3935.980320098381, 3988.521377434726, 8395.244428001388, 8395.874061889077, 8403.663853445794, 8418.957905210435, 8423.326133909273, 4351.82592696295, 4353.760543170156, 4353.978230108829, 4357.586029327273, 4358.891027724332, 3499.1427100360575, 3554.9822250889097, 3801.9809900950318, 3973.165635216579, 4003.5796241394232, 3526.8060256685617, 3532.6997205237844, 3549.0, 3554.697850682721, 3581.8209089545417, 1151.0848875144113, 1179.8761130081218, 1186.4516805568644, 1199.4122879789015, 1201.9038476921826, 838.8741688746737, 917.9357444978921, 920.8296465153968, 962.2013728605241, 1088.1784252889017, 6423.261324947597, 6573.211214654272, 6584.045313429526, 6601.075849381091, 6604.273529911706, 1032.1484775060455, 1033.6227277043974, 1034.2088302448633, 1041.833306670929, 1089.6622047165404, 5148.330717006766, 5193.195054766517, 5202.375714914235, 5209.453007434241, 5218.399884013387, 7987.760367188994, 8277.875831862528, 8343.541105239148, 8443.408961372645, 8515.957420212859, 8415.537145456936, 8470.534120623424, 8481.40630155883, 8494.830103397897, 8522.48865068098, 6374.58565193261, 6480.4815614750705, 6491.285958544557, 6520.869582608416, 6536.248331441945, 6462.644554549357, 6484.059811327237, 6484.740610375721, 6485.28661847187, 6487.967560162169, 7415.443841712001, 7524.05949256343, 7660.502067365604, 7698.653560589899, 7800.375969922506, 7672.884906726292, 7898.723544675909, 7961.0, 7965.243301886311, 7986.201379861967, 5943.673097979653, 5965.970170149121, 6005.759769609342, 6011.428914253139, 6012.248468941382, 6548.901766473602, 6567.9014814778775, 6585.506087043395, 6640.203175618763, 6662.333766623299, 6313.273973493107, 6366.904496432465, 6370.58591191571, 6427.775027874002, 6458.289588145206, 5617.5505959522325, 5762.798302059407, 5882.470577648032, 6173.32093469727, 6182.474489668429, 6150.354212807591, 6196.969015155076, 6205.596636218812, 6212.968935155295, 6222.62664240147, 5748.856278593069, 5871.647701137946, 5873.853153671193, 5874.324452687995, 5884.529237660891, 5693.5160511357, 5726.513246374105, 5733.971330143323, 5735.025045742151, 5737.5983681141915], "unit": "score", "name": "mootools.html", "value": 4119.199600824174}, {"lowerIsBetter": false, "replicates": [323.30489447687467, 326.6276444852868, 331.07134487761846, 334.89953014095767, 335.4448387917993, 5719.77120915164, 5854.853628659285, 5859.238299021126, 5868.972929737295, 5899.233099697033, 5598.1602759586085, 5730.0, 5764.654120752758, 5769.596128271012, 5773.422657734224, 4457.3091170868565, 4460.464744230697, 4460.620847227973, 4466.687331886777, 4472.306792447176, 4256.808443620044, 4331.30699088146, 4344.348347747848, 4437.5562443755525, 4471.150481408538, 4397.868063958086, 4413.227685155101, 4415.889602759925, 4418.116376724652, 4418.690691651585, 4411.6250118739945, 4418.712783669083, 4422.137683151803, 4428.114377124588, 4432.069265454258, 3878.4764056852246, 3879.767213967171, 3880.3403421418425, 3880.708946828971, 3886.2227554489214, 5433.239346491494, 5520.558355331604, 5539.639923404966, 5541.750621222055, 5547.5007249347345, 5113.821016264413, 5117.283580298761, 5118.360204974379, 5120.820771273025, 5123.846284611468, 6063.605865618721, 6079.300880398767, 6083.0, 6085.786997455112, 6099.268087829444, 4102.528209255944, 4178.728382655148, 4195.49654041517, 4277.443932288783, 4309.332053531708, 6361.141245931786, 6374.968125159391, 6376.0754690570075, 6378.77674281398, 6390.4248617624635, 4407.691461597721, 4409.2724700424715, 4412.801423935931, 4414.690971631955, 4416.116776644684, 4361.302191649321, 4459.264221403497, 4465.218586747306, 4467.329900514948, 4470.128324976663, 5131.7434128293435, 5142.408623008327, 5146.099432599355, 5146.125158723026, 5147.1507201312115, 6090.208272924491, 6138.6623735694075, 6155.507559395327, 6160.568760186834, 6167.414095660905, 1554.6579752454668, 1557.914314712679, 1575.054967019779, 1575.968480630404, 1576.2670358283224, 1076.0638244726981, 1087.6954452753241, 1087.9564817407215, 1088.2871719024051, 1107.4462768615692, 5772.6536407815665, 5785.508231800344, 5788.88422231553, 5789.218455508537, 5794.797182098607, 6231.594946328565, 6240.0, 6243.094751261042, 6248.4688801452385, 6249.0, 5764.452377024176, 5779.479846813807, 5779.682117483495, 5790.073588225863, 5791.218185544897, 3332.7000569948823, 3422.2128910350757, 3424.383610950003, 3430.3310854383158, 3430.3996800559803, 6561.639109848908, 6567.704453299613, 6570.638614876132, 6570.770023049266, 6574.0, 6460.192475940507, 6460.709268082947, 6461.935380646133, 6465.709043093072, 6475.611463312216, 6405.558749281375, 6545.985372267306, 6556.541042127101, 6564.9671751640935, 6567.244766851778, 6149.292831324455, 6289.465395441439, 6304.369563043659, 6310.716017779119, 6311.27420346666, 6147.170132032118, 6184.350643182401, 6235.781747638993, 6281.780137695158, 6287.46556542699, 6558.540902136805, 6621.470282377494, 6630.569013014138, 6632.668366581748, 6635.9004614929845, 4436.26801577736, 4443.622292105078, 4445.1776421360855, 4447.3329000650165, 4454.08691218293, 6250.656213908097, 6409.551331406757, 6423.197100362455, 6424.229092508929, 6430.356964303533, 6241.625502469867, 6241.906371404341, 6245.281792593728, 6254.937450625617, 6257.28041275241, 6229.626222426669, 6233.252009758858, 6238.75044998195, 6248.4376406123665, 6249.281332646804, 5994.610350327215, 6127.632342059491, 6136.5090792737365, 6137.294211165773, 6152.569320147547, 6266.811995640138, 6273.341299163522, 6273.96863015682, 6284.780032698834, 6287.685615719287, 6125.326214116532, 6133.44798968095, 6133.907991380043, 6135.325114237341, 6140.416660417253], "unit": "score", "name": "prototype.html", "value": 4649.199692217571}, {"lowerIsBetter": false, "replicates": [691.8685449764545, 703.7888633409975, 726.9236730143335, 747.9850402991942, 769.6959700918137, 12779.424925878346, 12833.743325133504, 12896.484140634375, 12906.354682265895, 12926.482940682385, 11401.315921044743, 11445.542178312879, 11454.656360309184, 11463.19757616965, 11500.252483588562, 631.4190944331203, 634.2547506679656, 750.0886422996059, 753.1376573822984, 766.0386215299819, 762.4967521435854, 765.2309429023824, 766.7623036858564, 766.8964689766893, 767.0641816983272, 595.553334998751, 595.8659301657136, 596.3082823924249, 596.3589141672697, 596.4214711729616, 661.110805965975, 663.8207683925338, 783.8784988326819, 789.8854666073387, 790.8734602463636, 581.6335708503616, 581.6800759582255, 582.365221908118, 583.833607421887, 583.9065749480063, 12367.690807729789, 12448.81326780099, 12465.252084874937, 12472.064595155309, 12473.0, 11704.122190835722, 11730.35483048432, 12007.629568551865, 12445.439955202037, 12722.0, 9687.17658998986, 9839.606415743361, 9921.702348929544, 9949.452780097092, 9966.451845148515, 3545.2554963457706, 3631.9273614527824, 3696.094456858087, 3699.2786406650443, 3711.777293362407, 41268.9999999997, 41830.16339673189, 42016.369754453706, 42206.57793422057, 42380.78809605963, 9497.477638729799, 9522.571484283224, 9896.455694936847, 9970.0, 10029.899701002896, 18015.27938882456, 18146.364877229233, 18153.63692726138, 18157.909210454127, 18179.0, 7243.859343503493, 7284.927150728531, 7359.8160045999275, 7388.7783366498015, 7408.03695519579, 4036.6770658347264, 4061.9796901015898, 4112.424260603518, 4166.416701661769, 4205.894852628648, 2873.6551613806478, 2881.4381195667065, 2903.8548072596286, 2904.607877936494, 2905.9709402906124, 480.26279660720627, 498.82790437299076, 504.3745755263447, 516.1947362115112, 529.5419462165277, 477.59404506169477, 494.4684464200926, 494.5969035236271, 520.3989392251955, 542.0270614247356, 7226.710931562784, 7239.674214660353, 7271.527350722186, 7285.453590980697, 7426.220246874001, 451.3401939676486, 462.1265807623594, 466.73862636923434, 470.1326053431482, 484.5856792442481, 3422.5379573757723, 3552.0803686893837, 3566.9108272292883, 3620.435346176182, 3823.636754508317, 51426.48573514292, 51642.22536661953, 54317.45682543124, 55166.72416637971, 55494.0, 44674.55325446769, 45249.773751131695, 45810.77094614506, 45980.54019459763, 46007.76996114998, 40364.59635403608, 40393.192136157115, 40559.1888162241, 40630.39054414186, 41486.79256603698, 7600.239976002576, 7658.2724641159, 7759.262870027338, 7885.408594355561, 8038.437309388287, 32583.348333033682, 33060.834695826365, 33063.17342066467, 33099.338013240085, 33423.66576334303, 40003.0, 40143.0, 40810.79594602008, 42861.78569107259, 43016.784916075216, 9329.580168892551, 9381.296402769683, 9407.162622180605, 9604.27967902396, 10336.431496267476, 10721.59800249688, 10857.945710271399, 11056.391898445663, 11059.0, 11235.174777652719, 10186.388816671024, 10332.896671033193, 10392.305543361148, 10481.109105726098, 10672.946635266773, 10079.496025198858, 10256.179505639382, 10547.947260263649, 10761.89238107609, 10837.13302935779, 9832.655857044969, 10195.745106372104, 10310.226732994905, 10455.215858810467, 10482.790344193227, 8757.781055473664, 8778.515449508108, 8960.775980600538, 8979.371443998858, 9190.632374704937, 8935.910640893508, 8996.730098097067, 9159.35884488106, 9216.815663686823, 9291.67479138227], "unit": "score", "name": "yui.html", "value": 5707.355509121813}], "name": "dromaeo_css", "value": 6476.066952688562}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 106.0, 112.0, 111.0, 111.0, 100.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.2}, {"lowerIsBetter": true, "replicates": [149.0, 125.0, 154.0, 164.0, 124.0, 147.0, 156.0, 127.0, 169.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 143.8}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 162.0, 159.0, 163.0, 161.0, 162.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [71.0, 75.0, 80.0, 94.0, 71.0, 72.0, 82.0, 114.0, 91.0, 75.0], "unit": "score", "name": "audio-fft", "value": 82.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 152.0, 95.0, 96.0, 95.0, 141.0, 95.0, 96.0, 140.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, 108.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 146.0, 147.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 98.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [58.0, 61.0, 58.0, 56.0, 56.0, 56.0, 59.0, 65.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.0}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 66.0, 68.0, 70.0, 67.0, 66.0, 67.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.0}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 84.0, 93.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [117.0, 121.0, 127.0, 117.0, 125.0, 118.0, 129.0, 125.0, 124.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.6}, {"lowerIsBetter": true, "replicates": [141.0, 149.0, 150.0, 149.0, 145.0, 141.0, 155.0, 149.0, 148.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.8}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 66.0, 68.0, 69.0, 72.0, 70.0, 66.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1505.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.64459346186086], "unit": "score", "name": "Richards", "value": 210.57643000000002}, {"lowerIsBetter": false, "replicates": [190.36740909956217], "unit": "score", "name": "DeltaBlue", "value": 347.31785399999995}, {"lowerIsBetter": false, "replicates": [279.87685418415896], "unit": "score", "name": "Encrypt", "value": 951.0647130000004}, {"lowerIsBetter": false, "replicates": [5284.210526315789], "unit": "score", "name": "Decrypt", "value": 50.37289840637447}, {"lowerIsBetter": false, "replicates": [1976.2845849802372], "unit": "score", "name": "RayTrace", "value": 374.434434}, {"lowerIsBetter": false, "replicates": [800.8], "unit": "score", "name": "Earley", "value": 832.2465034965037}, {"lowerIsBetter": false, "replicates": [12304.878048780487], "unit": "score", "name": "Boyer", "value": 54.16250346878094}, {"lowerIsBetter": false, "replicates": [42333.333333333336], "unit": "score", "name": "RegExp", "value": 21.519330708661407}, {"lowerIsBetter": false, "replicates": [571.5909090909091], "unit": "score", "name": "Splay", "value": 142.56874751491048}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 18920.53044514946}]} 23:35:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "18920.53"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1506.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6476.07"}}} 23:35:33 INFO - Return code: 0 23:35:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:35:33 INFO - # TBPL SUCCESS # 23:35:33 INFO - Running post-action listener: _resource_record_post_action 23:35:33 INFO - Running post-run listener: _resource_record_post_run 23:35:35 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 562827264; Read time: 0; Write time: 567968 23:35:35 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 250249216; Read time: 0; Write time: 319384 23:35:35 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 312397824; Read time: 0; Write time: 248568 23:35:35 INFO - Running post-run listener: _upload_blobber_files 23:35:35 INFO - Blob upload gear active. 23:35:35 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:35:35 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 23:35:35 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'] 23:35:35 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 23:35:35 INFO - (blobuploader) - INFO - Open directory for files ... 23:35:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:35:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:35:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:35:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:35:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:35:36 INFO - (blobuploader) - INFO - Done attempting. 23:35:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:35:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:35:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:35:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:35:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:35:37 INFO - (blobuploader) - INFO - Done attempting. 23:35:37 INFO - (blobuploader) - INFO - Iteration through files over. 23:35:37 INFO - Return code: 0 23:35:37 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:35:37 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:35:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/884b9bfd6e85e863fa3d0bd7a082b922642a1fe64f07a35ae3341aa100b8bd5beac43caec99ac3c8892f89b48262183bdbb48942c4c2bceb6516b57472493cf9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e93bae857bcad834669c658c36e7043bf485d7f39199ec660354efcc8d3e1dc3e59a3b7212af02a7d871f7ee9f7165f1b08598679949c999cc7e66ffe7919ad9"} 23:35:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:35:37 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:35:37 INFO - Contents: 23:35:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/884b9bfd6e85e863fa3d0bd7a082b922642a1fe64f07a35ae3341aa100b8bd5beac43caec99ac3c8892f89b48262183bdbb48942c4c2bceb6516b57472493cf9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e93bae857bcad834669c658c36e7043bf485d7f39199ec660354efcc8d3e1dc3e59a3b7212af02a7d871f7ee9f7165f1b08598679949c999cc7e66ffe7919ad9"} 23:35:37 INFO - Copying logs to upload dir... 23:35:37 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1265.553813 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-01-08 23:35:35.639219) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 23:35:35.642574) ========= 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=3a3620fb28aea1604ab609ef000001d2-1452323539.590212-842891496 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/884b9bfd6e85e863fa3d0bd7a082b922642a1fe64f07a35ae3341aa100b8bd5beac43caec99ac3c8892f89b48262183bdbb48942c4c2bceb6516b57472493cf9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e93bae857bcad834669c658c36e7043bf485d7f39199ec660354efcc8d3e1dc3e59a3b7212af02a7d871f7ee9f7165f1b08598679949c999cc7e66ffe7919ad9"} build_url:https://queue.taskcluster.net/v1/task/VWm5cPvzQSm-von-dyEVog/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011403 build_url: 'https://queue.taskcluster.net/v1/task/VWm5cPvzQSm-von-dyEVog/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/884b9bfd6e85e863fa3d0bd7a082b922642a1fe64f07a35ae3341aa100b8bd5beac43caec99ac3c8892f89b48262183bdbb48942c4c2bceb6516b57472493cf9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e93bae857bcad834669c658c36e7043bf485d7f39199ec660354efcc8d3e1dc3e59a3b7212af02a7d871f7ee9f7165f1b08598679949c999cc7e66ffe7919ad9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 23:35:35.667429) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 23:35:35.667775) ========= 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=3a3620fb28aea1604ab609ef000001d2-1452323539.590212-842891496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 23:35:35.753333) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 23:35:35.753688) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 23:35:35.754051) ========= ========= Total master_lag: 0.26 =========