builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1450703322.94 results: success (0) buildid: 20151221023004 builduid: 8077f643da094a69b16fadd903d2d4c4 revision: b76ea647debcadd234066150c78b3bba77a50c74 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 05:08:42.943729) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 05:08:42.944231) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 05:08:42.944594) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450703322.589020-883333102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006044 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 05:08:42.968394) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 05:08:42.968769) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 05:08:42.982985) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:08:42.983297) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450703322.589020-883333102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:08:43.032814) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 05:08:43.033136) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 05:08:43.033546) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:08:43.033864) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450703322.589020-883333102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 05:08:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2015-12-21 05:08:43 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172388 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:08:43.220032) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:08:43.220672) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450703322.589020-883333102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.101687 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:08:43.335607) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:08:43.336356) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b76ea647debcadd234066150c78b3bba77a50c74 --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 b76ea647debcadd234066150c78b3bba77a50c74 --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=b47e8c1238be48f5acbf8f2f000001bb-1450703322.589020-883333102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 05:08:43,814 truncating revision to first 12 chars 2015-12-21 05:08:43,815 Setting DEBUG logging. 2015-12-21 05:08:43,815 attempt 1/10 2015-12-21 05:08:43,815 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b76ea647debc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-21 05:08:44,067 unpacking tar archive at: fx-team-b76ea647debc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.508499 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:08:43.858405) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 05:08:43.859009) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 05:08:43.869564) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 05:08:43.869871) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 05:08:43.870343) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-21 05:08:43.870706) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1450703322.589020-883333102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:08:44 INFO - MultiFileLogger online at 20151221 05:08:44 in /builds/slave/test-pgo 05:08:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:08:44 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:08:44 INFO - {'append_to_log': False, 05:08:44 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:08:44 INFO - 'blob_upload_branch': 'Fx-Team', 05:08:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:08:44 INFO - 'branch': 'Fx-Team', 05:08:44 INFO - 'buildbot_json_path': 'buildprops.json', 05:08:44 INFO - 'config_files': ('talos/linux_config.py',), 05:08:44 INFO - 'default_actions': ('clobber', 05:08:44 INFO - 'read-buildbot-config', 05:08:44 INFO - 'download-and-extract', 05:08:44 INFO - 'populate-webroot', 05:08:44 INFO - 'create-virtualenv', 05:08:44 INFO - 'install', 05:08:44 INFO - 'run-tests'), 05:08:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:08:44 INFO - 'download_minidump_stackwalk': True, 05:08:44 INFO - 'download_symbols': 'ondemand', 05:08:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:08:44 INFO - 'tooltool.py': '/tools/tooltool.py', 05:08:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:08:44 INFO - '/tools/misc-python/virtualenv.py')}, 05:08:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:08:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:08:44 INFO - 'installer_path': 'installer.exe', 05:08:44 INFO - 'log_level': 'info', 05:08:44 INFO - 'log_name': 'talos', 05:08:44 INFO - 'log_to_console': True, 05:08:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:08:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:08:44 INFO - 'opt_config_files': (), 05:08:44 INFO - 'pip_index': False, 05:08:44 INFO - 'sps_profile': False, 05:08:44 INFO - 'sps_profile_interval': 0, 05:08:44 INFO - 'suite': 'dromaeojs', 05:08:44 INFO - 'system_bits': '64', 05:08:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:08:44 INFO - 'title': 'talos-linux64-ix-022', 05:08:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:08:44 INFO - 'use_talos_json': True, 05:08:44 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:08:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:08:44 INFO - 'work_dir': 'build'} 05:08:44 INFO - ##### 05:08:44 INFO - ##### Running clobber step. 05:08:44 INFO - ##### 05:08:44 INFO - Running pre-action listener: _resource_record_pre_action 05:08:44 INFO - Running main action method: clobber 05:08:44 INFO - rmtree: /builds/slave/test-pgo/build 05:08:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:08:49 INFO - Running post-action listener: _resource_record_post_action 05:08:49 INFO - ##### 05:08:49 INFO - ##### Running read-buildbot-config step. 05:08:49 INFO - ##### 05:08:49 INFO - Running pre-action listener: _resource_record_pre_action 05:08:49 INFO - Running main action method: read_buildbot_config 05:08:49 INFO - Using buildbot properties: 05:08:49 INFO - { 05:08:49 INFO - "project": "", 05:08:49 INFO - "product": "firefox", 05:08:49 INFO - "script_repo_revision": "production", 05:08:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:08:49 INFO - "repository": "", 05:08:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:08:49 INFO - "buildid": "20151221023004", 05:08:49 INFO - "pgo_build": "True", 05:08:49 INFO - "basedir": "/builds/slave/test-pgo", 05:08:49 INFO - "buildnumber": 379, 05:08:49 INFO - "slavename": "talos-linux64-ix-022", 05:08:49 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:08:49 INFO - "platform": "ubuntu64_hw", 05:08:49 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:08:49 INFO - "branch": "fx-team", 05:08:49 INFO - "repo_path": "integration/fx-team", 05:08:49 INFO - "revision": "b76ea647debcadd234066150c78b3bba77a50c74", 05:08:49 INFO - "stage_platform": "linux64-pgo", 05:08:49 INFO - "builduid": "8077f643da094a69b16fadd903d2d4c4", 05:08:49 INFO - "slavebuilddir": "test" 05:08:49 INFO - } 05:08:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/XSDTTqG9TySmHlfwaasy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:08:49 INFO - Running post-action listener: _resource_record_post_action 05:08:49 INFO - ##### 05:08:49 INFO - ##### Running download-and-extract step. 05:08:49 INFO - ##### 05:08:49 INFO - Running pre-action listener: _resource_record_pre_action 05:08:49 INFO - Running main action method: download_and_extract 05:08:49 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:49 INFO - https://queue.taskcluster.net/v1/task/XSDTTqG9TySmHlfwaasy3g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:08:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSDTTqG9TySmHlfwaasy3g/artifacts/public/build/test_packages.json 05:08:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSDTTqG9TySmHlfwaasy3g/artifacts/public/build/test_packages.json 05:08:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSDTTqG9TySmHlfwaasy3g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:08:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSDTTqG9TySmHlfwaasy3g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:08:50 INFO - Downloaded 1302 bytes. 05:08:50 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:08:50 INFO - Using the following test package requirements: 05:08:50 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:08:50 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:08:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:08:50 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:08:50 INFO - u'jsshell-linux-x86_64.zip'], 05:08:50 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:08:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:08:50 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:08:50 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:08:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:08:50 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:08:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:08:50 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:08:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:08:50 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:08:50 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:08:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:08:50 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:50 INFO - https://queue.taskcluster.net/v1/task/XSDTTqG9TySmHlfwaasy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:08:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSDTTqG9TySmHlfwaasy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:08:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSDTTqG9TySmHlfwaasy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:08:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSDTTqG9TySmHlfwaasy3g/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 05:08:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSDTTqG9TySmHlfwaasy3g/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 05:08:54 INFO - Downloaded 23121249 bytes. 05:08:54 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 05:08:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:08:54 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 05:08:55 INFO - Return code: 0 05:08:55 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 05:08: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')]} 05:08:55 INFO - https://queue.taskcluster.net/v1/task/XSDTTqG9TySmHlfwaasy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:08:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSDTTqG9TySmHlfwaasy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:08:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSDTTqG9TySmHlfwaasy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:08:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSDTTqG9TySmHlfwaasy3g/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 05:08:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSDTTqG9TySmHlfwaasy3g/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 05:08:57 INFO - Downloaded 23121249 bytes. 05:08:57 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 05:08:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:08:57 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 05:08:59 INFO - Return code: 0 05:08: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')]} 05:08:59 INFO - https://queue.taskcluster.net/v1/task/XSDTTqG9TySmHlfwaasy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:08:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSDTTqG9TySmHlfwaasy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:08:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSDTTqG9TySmHlfwaasy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:08:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSDTTqG9TySmHlfwaasy3g/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 05:08:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSDTTqG9TySmHlfwaasy3g/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 05:09:00 INFO - Downloaded 11132039 bytes. 05:09:00 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 05:09:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:09:00 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 05:09:00 INFO - Return code: 0 05:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:00 INFO - https://queue.taskcluster.net/v1/task/XSDTTqG9TySmHlfwaasy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:09:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSDTTqG9TySmHlfwaasy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:09:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSDTTqG9TySmHlfwaasy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:09:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSDTTqG9TySmHlfwaasy3g/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 05:09:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XSDTTqG9TySmHlfwaasy3g/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 05:09:02 INFO - Downloaded 54652663 bytes. 05:09:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XSDTTqG9TySmHlfwaasy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:09:02 INFO - mkdir: /builds/slave/test-pgo/properties 05:09:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:09:02 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:09:02 INFO - Contents: 05:09:02 INFO - build_url:https://queue.taskcluster.net/v1/task/XSDTTqG9TySmHlfwaasy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:09:02 INFO - Running post-action listener: _resource_record_post_action 05:09:02 INFO - Running post-action listener: set_extra_try_arguments 05:09:02 INFO - ##### 05:09:02 INFO - ##### Running populate-webroot step. 05:09:02 INFO - ##### 05:09:02 INFO - Running pre-action listener: _resource_record_pre_action 05:09:02 INFO - Running main action method: populate_webroot 05:09:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:09:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:09:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:09:02 INFO - '--tppagecycles', 05:09:02 INFO - '7'], 05:09:02 INFO - 'tests': ['tsvgm']}}, 05:09:02 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:09:02 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:09:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:09:02 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:09:02 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:09:02 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:09:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:02 INFO - 'talos_options': ['--e10s'], 05:09:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:02 INFO - 'tests': ['damp', 'tps']}, 05:09:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:02 INFO - 'talos_options': ['--e10s'], 05:09:02 INFO - 'tests': ['damp', 'tps']}, 05:09:02 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:09:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:09:02 INFO - 'other': {'tests': ['a11yr', 05:09:02 INFO - 'ts_paint', 05:09:02 INFO - 'tpaint', 05:09:02 INFO - 'sessionrestore', 05:09:02 INFO - 'sessionrestore_no_auto_restore']}, 05:09:02 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:09:02 INFO - 'tests': ['a11yr', 05:09:02 INFO - 'ts_paint', 05:09:02 INFO - 'tpaint', 05:09:02 INFO - 'sessionrestore', 05:09:02 INFO - 'sessionrestore_no_auto_restore']}, 05:09:02 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:09:02 INFO - 'tests': ['a11yr', 05:09:02 INFO - 'ts_paint', 05:09:02 INFO - 'tpaint', 05:09:02 INFO - 'sessionrestore', 05:09:02 INFO - 'sessionrestore_no_auto_restore']}, 05:09:02 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:09:02 INFO - 'tests': ['a11yr', 05:09:02 INFO - 'ts_paint', 05:09:02 INFO - 'tpaint', 05:09:02 INFO - 'sessionrestore', 05:09:02 INFO - 'sessionrestore_no_auto_restore']}, 05:09:02 INFO - 'other_l64': {'tests': ['a11yr', 05:09:02 INFO - 'ts_paint', 05:09:02 INFO - 'tpaint', 05:09:02 INFO - 'sessionrestore', 05:09:02 INFO - 'sessionrestore_no_auto_restore']}, 05:09:02 INFO - 'other_nol64': {'tests': ['a11yr', 05:09:02 INFO - 'ts_paint', 05:09:02 INFO - 'tpaint', 05:09:02 INFO - 'sessionrestore', 05:09:02 INFO - 'sessionrestore_no_auto_restore']}, 05:09:02 INFO - 'svgr': {'tests': ['tsvgx', 05:09:02 INFO - 'tsvgr_opacity', 05:09:02 INFO - 'tart', 05:09:02 INFO - 'tscrollx', 05:09:02 INFO - 'cart']}, 05:09:02 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:09:02 INFO - 'tests': ['tsvgx', 05:09:02 INFO - 'tsvgr_opacity', 05:09:02 INFO - 'tart', 05:09:02 INFO - 'tscrollx', 05:09:02 INFO - 'cart']}, 05:09:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:02 INFO - 'tests': ['tp5o']}, 05:09:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:02 INFO - 'talos_options': ['--e10s'], 05:09:02 INFO - 'tests': ['tp5o']}, 05:09:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:02 INFO - 'talos_options': ['--xperf_path', 05:09:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:09:02 INFO - 'tests': ['tp5n']}, 05:09:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:02 INFO - 'talos_options': ['--e10s', 05:09:02 INFO - '--xperf_path', 05:09:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:09:02 INFO - 'tests': ['tp5n']}}, 05:09:02 INFO - 'talos.zip': {'path': '', 05:09:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:09:02 INFO - Running post-action listener: _resource_record_post_action 05:09:02 INFO - ##### 05:09:02 INFO - ##### Running create-virtualenv step. 05:09:02 INFO - ##### 05:09:02 INFO - Running pre-action listener: _resource_record_pre_action 05:09:02 INFO - Running main action method: create_virtualenv 05:09:02 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:09:02 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 05:09:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:09:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:09:02 INFO - Using real prefix '/usr' 05:09:02 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:09:02 INFO - Installing distribute.............................................................................................................................................................................................done. 05:09:04 INFO - Installing pip.................done. 05:09:04 INFO - Return code: 0 05:09:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9b6fcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2148350>, '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 0x2149250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21496e0>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450703322.589020-883333102', '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 05:09:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:09:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:09:04 INFO - Using env: {'DISPLAY': ':0', 05:09:04 INFO - 'HOME': '/home/cltbld', 05:09:04 INFO - 'LANG': 'en_US.UTF-8', 05:09:04 INFO - 'LANGUAGE': 'en_US:en', 05:09:04 INFO - 'LOGNAME': 'cltbld', 05:09:04 INFO - 'MAIL': '/var/mail/cltbld', 05:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:04 INFO - 'MOZ_NO_REMOTE': '1', 05:09:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:04 INFO - 'NO_EM_RESTART': '1', 05:09:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:09:04 INFO - 'PWD': '/builds/slave/test-pgo', 05:09:04 INFO - 'SHELL': '/bin/bash', 05:09:04 INFO - 'SHLVL': '1', 05:09:04 INFO - 'TERM': 'linux', 05:09:04 INFO - 'TMOUT': '86400', 05:09:04 INFO - 'USER': 'cltbld', 05:09:04 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450703322.589020-883333102', 05:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:04 INFO - '_': '/tools/buildbot/bin/python'} 05:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:04 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 05:09:04 INFO - Cleaning up... 05:09:04 INFO - Return code: 0 05:09:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd9b6fcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2148350>, '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 0x2149250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21496e0>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450703322.589020-883333102', '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 05:09:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:09:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:09:04 INFO - Using env: {'DISPLAY': ':0', 05:09:04 INFO - 'HOME': '/home/cltbld', 05:09:04 INFO - 'LANG': 'en_US.UTF-8', 05:09:04 INFO - 'LANGUAGE': 'en_US:en', 05:09:04 INFO - 'LOGNAME': 'cltbld', 05:09:04 INFO - 'MAIL': '/var/mail/cltbld', 05:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:04 INFO - 'MOZ_NO_REMOTE': '1', 05:09:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:04 INFO - 'NO_EM_RESTART': '1', 05:09:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:09:04 INFO - 'PWD': '/builds/slave/test-pgo', 05:09:04 INFO - 'SHELL': '/bin/bash', 05:09:04 INFO - 'SHLVL': '1', 05:09:04 INFO - 'TERM': 'linux', 05:09:04 INFO - 'TMOUT': '86400', 05:09:04 INFO - 'USER': 'cltbld', 05:09:04 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450703322.589020-883333102', 05:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:04 INFO - '_': '/tools/buildbot/bin/python'} 05:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:05 INFO - Downloading/unpacking psutil>=0.7.1 05:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:06 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:09:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:09:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:09:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:06 INFO - Installing collected packages: psutil 05:09:06 INFO - Running setup.py install for psutil 05:09:07 INFO - building 'psutil._psutil_linux' extension 05:09:07 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 05:09:07 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 05:09:07 INFO - building 'psutil._psutil_posix' extension 05:09:07 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 05:09:07 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 05:09:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:07 INFO - Successfully installed psutil 05:09:07 INFO - Cleaning up... 05:09:07 INFO - Return code: 0 05:09:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd9b6fcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2148350>, '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 0x2149250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21496e0>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450703322.589020-883333102', '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 05:09:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:09:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:09:07 INFO - Using env: {'DISPLAY': ':0', 05:09:07 INFO - 'HOME': '/home/cltbld', 05:09:07 INFO - 'LANG': 'en_US.UTF-8', 05:09:07 INFO - 'LANGUAGE': 'en_US:en', 05:09:07 INFO - 'LOGNAME': 'cltbld', 05:09:07 INFO - 'MAIL': '/var/mail/cltbld', 05:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:07 INFO - 'MOZ_NO_REMOTE': '1', 05:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:07 INFO - 'NO_EM_RESTART': '1', 05:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:09:07 INFO - 'PWD': '/builds/slave/test-pgo', 05:09:07 INFO - 'SHELL': '/bin/bash', 05:09:07 INFO - 'SHLVL': '1', 05:09:07 INFO - 'TERM': 'linux', 05:09:07 INFO - 'TMOUT': '86400', 05:09:07 INFO - 'USER': 'cltbld', 05:09:07 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450703322.589020-883333102', 05:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:07 INFO - '_': '/tools/buildbot/bin/python'} 05:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:09:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:09:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:09:09 INFO - Installing collected packages: mozsystemmonitor 05:09:09 INFO - Running setup.py install for mozsystemmonitor 05:09:09 INFO - Successfully installed mozsystemmonitor 05:09:09 INFO - Cleaning up... 05:09:09 INFO - Return code: 0 05:09:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:09:09 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')]} 05:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:09 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')]} 05:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:09 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 0x7fd9b6fcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2148350>, '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 0x2149250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21496e0>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450703322.589020-883333102', '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 05:09:09 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 05:09:09 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 05:09:09 INFO - Using env: {'DISPLAY': ':0', 05:09:09 INFO - 'HOME': '/home/cltbld', 05:09:09 INFO - 'LANG': 'en_US.UTF-8', 05:09:09 INFO - 'LANGUAGE': 'en_US:en', 05:09:09 INFO - 'LOGNAME': 'cltbld', 05:09:09 INFO - 'MAIL': '/var/mail/cltbld', 05:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:09 INFO - 'MOZ_NO_REMOTE': '1', 05:09:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:09 INFO - 'NO_EM_RESTART': '1', 05:09:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:09:09 INFO - 'PWD': '/builds/slave/test-pgo', 05:09:09 INFO - 'SHELL': '/bin/bash', 05:09:09 INFO - 'SHLVL': '1', 05:09:09 INFO - 'TERM': 'linux', 05:09:09 INFO - 'TMOUT': '86400', 05:09:09 INFO - 'USER': 'cltbld', 05:09:09 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450703322.589020-883333102', 05:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:09 INFO - '_': '/tools/buildbot/bin/python'} 05:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:09 INFO - Downloading/unpacking blobuploader==1.2.4 05:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:11 INFO - Downloading blobuploader-1.2.4.tar.gz 05:09:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:09:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:09:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:09:11 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 05:09:11 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 05:09:11 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 05:09:11 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 05:09:11 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 05:09:11 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 05:09:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:09:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:09:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:09:11 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 05:09:11 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 05:09:11 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 05:09:11 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 05:09:11 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 05:09:11 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 05:09:12 INFO - Downloading docopt-0.6.1.tar.gz 05:09:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:09:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:09:12 INFO - Installing collected packages: blobuploader, requests, docopt 05:09:12 INFO - Running setup.py install for blobuploader 05:09:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:09:12 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:09:12 INFO - Running setup.py install for requests 05:09:12 INFO - Running setup.py install for docopt 05:09:12 INFO - Successfully installed blobuploader requests docopt 05:09:12 INFO - Cleaning up... 05:09:12 INFO - Return code: 0 05:09:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:12 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 0x7fd9b6fcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2148350>, '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 0x2149250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21496e0>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450703322.589020-883333102', '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 05:09:12 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 05:09:12 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 05:09:12 INFO - Using env: {'DISPLAY': ':0', 05:09:12 INFO - 'HOME': '/home/cltbld', 05:09:12 INFO - 'LANG': 'en_US.UTF-8', 05:09:12 INFO - 'LANGUAGE': 'en_US:en', 05:09:12 INFO - 'LOGNAME': 'cltbld', 05:09:12 INFO - 'MAIL': '/var/mail/cltbld', 05:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:12 INFO - 'MOZ_NO_REMOTE': '1', 05:09:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:12 INFO - 'NO_EM_RESTART': '1', 05:09:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:09:12 INFO - 'PWD': '/builds/slave/test-pgo', 05:09:12 INFO - 'SHELL': '/bin/bash', 05:09:12 INFO - 'SHLVL': '1', 05:09:12 INFO - 'TERM': 'linux', 05:09:12 INFO - 'TMOUT': '86400', 05:09:12 INFO - 'USER': 'cltbld', 05:09:12 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450703322.589020-883333102', 05:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:12 INFO - '_': '/tools/buildbot/bin/python'} 05:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:09:13 INFO - Running setup.py (path:/tmp/pip-CSn07j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:09:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:09:13 INFO - Running setup.py (path:/tmp/pip-mA79oY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:09:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:09:13 INFO - Running setup.py (path:/tmp/pip-k0PCL6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:09:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:09:13 INFO - Running setup.py (path:/tmp/pip-KIrFDr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:09:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:09:13 INFO - Running setup.py (path:/tmp/pip-OkUr7Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:09:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:09:13 INFO - Running setup.py (path:/tmp/pip-vWproV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:09:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:09:13 INFO - Running setup.py (path:/tmp/pip-MVRnKO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:09:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:09:13 INFO - Running setup.py (path:/tmp/pip-XSZaZd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:09:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:09:13 INFO - Running setup.py (path:/tmp/pip-xMJFNT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:09:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:09:13 INFO - Running setup.py (path:/tmp/pip-AvQahf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:09:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:09:13 INFO - Running setup.py (path:/tmp/pip-woxCql-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:09:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:09:13 INFO - Running setup.py (path:/tmp/pip-JpyU3W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:09:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:09:13 INFO - Running setup.py (path:/tmp/pip-ThYJN2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:09:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:09:13 INFO - Running setup.py (path:/tmp/pip-XTLdWh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:09:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:09:14 INFO - Running setup.py (path:/tmp/pip-WtCtGq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:09:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:09:14 INFO - Running setup.py (path:/tmp/pip-1nPxG3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:09:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:09:14 INFO - Running setup.py (path:/tmp/pip-5dfZkc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:09:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:09:14 INFO - Running setup.py install for manifestparser 05:09:14 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:09:14 INFO - Running setup.py install for mozcrash 05:09:14 INFO - Running setup.py install for mozdebug 05:09:14 INFO - Running setup.py install for mozdevice 05:09:14 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:09:14 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:09:14 INFO - Running setup.py install for mozfile 05:09:14 INFO - Running setup.py install for mozhttpd 05:09:14 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:09:14 INFO - Running setup.py install for mozinfo 05:09:14 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:09:14 INFO - Running setup.py install for mozInstall 05:09:15 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:09:15 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:09:15 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:09:15 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:09:15 INFO - Running setup.py install for mozleak 05:09:15 INFO - Running setup.py install for mozlog 05:09:15 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:09:15 INFO - Running setup.py install for moznetwork 05:09:15 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:09:15 INFO - Running setup.py install for mozprocess 05:09:15 INFO - Running setup.py install for mozprofile 05:09:15 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:09:15 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:09:15 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:09:15 INFO - Running setup.py install for mozrunner 05:09:15 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:09:15 INFO - Running setup.py install for mozscreenshot 05:09:15 INFO - Running setup.py install for moztest 05:09:15 INFO - Running setup.py install for mozversion 05:09:15 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:09:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:09:15 INFO - Cleaning up... 05:09:16 INFO - Return code: 0 05:09:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:09:16 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')]} 05:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:16 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')]} 05:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:16 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 0x7fd9b6fcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2148350>, '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 0x2149250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21496e0>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450703322.589020-883333102', '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 05:09:16 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 05:09:16 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 05:09:16 INFO - Using env: {'DISPLAY': ':0', 05:09:16 INFO - 'HOME': '/home/cltbld', 05:09:16 INFO - 'LANG': 'en_US.UTF-8', 05:09:16 INFO - 'LANGUAGE': 'en_US:en', 05:09:16 INFO - 'LOGNAME': 'cltbld', 05:09:16 INFO - 'MAIL': '/var/mail/cltbld', 05:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:16 INFO - 'MOZ_NO_REMOTE': '1', 05:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:16 INFO - 'NO_EM_RESTART': '1', 05:09:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:09:16 INFO - 'PWD': '/builds/slave/test-pgo', 05:09:16 INFO - 'SHELL': '/bin/bash', 05:09:16 INFO - 'SHLVL': '1', 05:09:16 INFO - 'TERM': 'linux', 05:09:16 INFO - 'TMOUT': '86400', 05:09:16 INFO - 'USER': 'cltbld', 05:09:16 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450703322.589020-883333102', 05:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:16 INFO - '_': '/tools/buildbot/bin/python'} 05:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:09:16 INFO - Running setup.py (path:/tmp/pip-ylQUmo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:09:16 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)) 05:09:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:09:16 INFO - Running setup.py (path:/tmp/pip-9nTdj1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:09:16 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)) 05:09:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:09:16 INFO - Running setup.py (path:/tmp/pip-QDqeNx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:09:16 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)) 05:09:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:09:16 INFO - Running setup.py (path:/tmp/pip-ENtKvO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:09:16 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)) 05:09:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:09:16 INFO - Running setup.py (path:/tmp/pip-TriA1T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:09:16 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)) 05:09:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:09:16 INFO - Running setup.py (path:/tmp/pip-JMjgg3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:09:16 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)) 05:09:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:09:16 INFO - Running setup.py (path:/tmp/pip-aTVGjl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:09:16 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)) 05:09:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:09:16 INFO - Running setup.py (path:/tmp/pip-LvD79h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:09:16 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)) 05:09:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:09:16 INFO - Running setup.py (path:/tmp/pip-BJrqOv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:09:16 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)) 05:09:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:09:16 INFO - Running setup.py (path:/tmp/pip-75TRe7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:09:16 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)) 05:09:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:09:16 INFO - Running setup.py (path:/tmp/pip-niRfqE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:09:17 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)) 05:09:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:09:17 INFO - Running setup.py (path:/tmp/pip-EzYP_X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:09:17 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)) 05:09:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:09:17 INFO - Running setup.py (path:/tmp/pip-E7RZZD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:09:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 05:09:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:09:17 INFO - Running setup.py (path:/tmp/pip-7cD7jQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:09:17 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)) 05:09:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:09:17 INFO - Running setup.py (path:/tmp/pip-9spRkf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:09:17 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)) 05:09:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:09:17 INFO - Running setup.py (path:/tmp/pip-Wqvj9S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:09:17 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)) 05:09:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:09:17 INFO - Running setup.py (path:/tmp/pip-feEI9I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:09:17 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)) 05:09:17 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)) 05:09:17 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)) 05:09:17 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)) 05:09:17 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)) 05:09:17 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)) 05:09:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:19 INFO - Downloading blessings-1.5.1.tar.gz 05:09:19 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 05:09:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:09:19 INFO - Installing collected packages: blessings 05:09:19 INFO - Running setup.py install for blessings 05:09:19 INFO - Successfully installed blessings 05:09:19 INFO - Cleaning up... 05:09:19 INFO - Return code: 0 05:09:19 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:09:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:09:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:09:19 INFO - Reading from file tmpfile_stdout 05:09:19 INFO - Current package versions: 05:09:19 INFO - argparse == 1.2.1 05:09:19 INFO - blessings == 1.5.1 05:09:19 INFO - blobuploader == 1.2.4 05:09:19 INFO - docopt == 0.6.1 05:09:19 INFO - manifestparser == 1.1 05:09:19 INFO - mozInstall == 1.12 05:09:19 INFO - mozcrash == 0.16 05:09:19 INFO - mozdebug == 0.1 05:09:19 INFO - mozdevice == 0.47 05:09:19 INFO - mozfile == 1.2 05:09:19 INFO - mozhttpd == 0.7 05:09:19 INFO - mozinfo == 0.9 05:09:19 INFO - mozleak == 0.1 05:09:19 INFO - mozlog == 3.1 05:09:19 INFO - moznetwork == 0.27 05:09:19 INFO - mozprocess == 0.22 05:09:19 INFO - mozprofile == 0.27 05:09:19 INFO - mozrunner == 6.11 05:09:19 INFO - mozscreenshot == 0.1 05:09:19 INFO - mozsystemmonitor == 0.0 05:09:19 INFO - moztest == 0.7 05:09:19 INFO - mozversion == 1.4 05:09:19 INFO - psutil == 3.1.1 05:09:19 INFO - requests == 1.2.3 05:09:19 INFO - wsgiref == 0.1.2 05:09:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:09:19 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')]} 05:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:19 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')]} 05:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:19 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 0x7fd9b6fcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2148350>, '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 0x2149250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21496e0>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450703322.589020-883333102', '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 05:09:19 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 05:09:19 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 05:09:19 INFO - Using env: {'DISPLAY': ':0', 05:09:19 INFO - 'HOME': '/home/cltbld', 05:09:19 INFO - 'LANG': 'en_US.UTF-8', 05:09:19 INFO - 'LANGUAGE': 'en_US:en', 05:09:19 INFO - 'LOGNAME': 'cltbld', 05:09:19 INFO - 'MAIL': '/var/mail/cltbld', 05:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:19 INFO - 'MOZ_NO_REMOTE': '1', 05:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:19 INFO - 'NO_EM_RESTART': '1', 05:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:09:19 INFO - 'PWD': '/builds/slave/test-pgo', 05:09:19 INFO - 'SHELL': '/bin/bash', 05:09:19 INFO - 'SHLVL': '1', 05:09:19 INFO - 'TERM': 'linux', 05:09:19 INFO - 'TMOUT': '86400', 05:09:19 INFO - 'USER': 'cltbld', 05:09:19 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450703322.589020-883333102', 05:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:19 INFO - '_': '/tools/buildbot/bin/python'} 05:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:19 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 1)) 05:09:19 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 2)) 05:09:19 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 3)) 05:09:19 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 4)) 05:09:19 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 5)) 05:09:19 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 6)) 05:09:19 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 7)) 05:09:19 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 8)) 05:09:19 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:09:19 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 3)) 05:09:19 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:09:19 INFO - Cleaning up... 05:09:19 INFO - Return code: 0 05:09:19 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:09:19 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')]} 05:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:19 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')]} 05:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:19 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 0x7fd9b6fcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2148350>, '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 0x2149250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21496e0>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450703322.589020-883333102', '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 05:09:19 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 05:09:19 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 05:09:19 INFO - Using env: {'DISPLAY': ':0', 05:09:19 INFO - 'HOME': '/home/cltbld', 05:09:19 INFO - 'LANG': 'en_US.UTF-8', 05:09:19 INFO - 'LANGUAGE': 'en_US:en', 05:09:19 INFO - 'LOGNAME': 'cltbld', 05:09:19 INFO - 'MAIL': '/var/mail/cltbld', 05:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:19 INFO - 'MOZ_NO_REMOTE': '1', 05:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:19 INFO - 'NO_EM_RESTART': '1', 05:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:09:19 INFO - 'PWD': '/builds/slave/test-pgo', 05:09:19 INFO - 'SHELL': '/bin/bash', 05:09:19 INFO - 'SHLVL': '1', 05:09:19 INFO - 'TERM': 'linux', 05:09:19 INFO - 'TMOUT': '86400', 05:09:19 INFO - 'USER': 'cltbld', 05:09:19 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450703322.589020-883333102', 05:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:19 INFO - '_': '/tools/buildbot/bin/python'} 05:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:20 INFO - Downloading/unpacking jsonschema 05:09:20 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 05:09:20 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 05:09:20 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 05:09:20 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 05:09:20 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 05:09:20 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 05:09:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:09:21 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 05:09:21 INFO - Downloading/unpacking functools32 (from jsonschema) 05:09:21 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 05:09:21 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 05:09:21 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 05:09:21 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 05:09:21 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 05:09:21 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 05:09:21 INFO - Downloading functools32-3.2.3-2.tar.gz 05:09:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:09:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:09:22 INFO - warning: no files found matching '*.txt' 05:09:22 INFO - no previously-included directories found matching 'build' 05:09:22 INFO - no previously-included directories found matching 'dist' 05:09:22 INFO - no previously-included directories found matching '.git*' 05:09:22 INFO - Installing collected packages: jsonschema, functools32 05:09:22 INFO - Running setup.py install for functools32 05:09:22 INFO - warning: no files found matching '*.txt' 05:09:22 INFO - no previously-included directories found matching 'build' 05:09:22 INFO - no previously-included directories found matching 'dist' 05:09:22 INFO - no previously-included directories found matching '.git*' 05:09:22 INFO - Successfully installed jsonschema functools32 05:09:22 INFO - Cleaning up... 05:09:22 INFO - Return code: 0 05:09:22 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:09:22 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')]} 05:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:22 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')]} 05:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:22 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 0x7fd9b6fcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2148350>, '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 0x2149250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21496e0>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1450703322.589020-883333102', '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 05:09:22 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 05:09:22 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 05:09:22 INFO - Using env: {'DISPLAY': ':0', 05:09:22 INFO - 'HOME': '/home/cltbld', 05:09:22 INFO - 'LANG': 'en_US.UTF-8', 05:09:22 INFO - 'LANGUAGE': 'en_US:en', 05:09:22 INFO - 'LOGNAME': 'cltbld', 05:09:22 INFO - 'MAIL': '/var/mail/cltbld', 05:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:22 INFO - 'MOZ_NO_REMOTE': '1', 05:09:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:22 INFO - 'NO_EM_RESTART': '1', 05:09:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:09:22 INFO - 'PWD': '/builds/slave/test-pgo', 05:09:22 INFO - 'SHELL': '/bin/bash', 05:09:22 INFO - 'SHLVL': '1', 05:09:22 INFO - 'TERM': 'linux', 05:09:22 INFO - 'TMOUT': '86400', 05:09:22 INFO - 'USER': 'cltbld', 05:09:22 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450703322.589020-883333102', 05:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:22 INFO - '_': '/tools/buildbot/bin/python'} 05:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:22 INFO - Downloading/unpacking flake8 05:09:22 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 05:09:22 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 05:09:22 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 05:09:22 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 05:09:22 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 05:09:22 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 05:09:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:09:24 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 05:09:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:09:24 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 05:09:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:24 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 05:09:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:09:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:09:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:09:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:09:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:09:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:09:24 INFO - no previously-included directories found matching 'docs/_build' 05:09:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:09:24 INFO - Running setup.py install for pep8 05:09:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:09:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:09:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:09:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:09:24 INFO - no previously-included directories found matching 'docs/_build' 05:09:24 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:09:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:09:24 INFO - Cleaning up... 05:09:24 INFO - Return code: 0 05:09:24 INFO - Running post-action listener: _resource_record_post_action 05:09:24 INFO - Running post-action listener: _start_resource_monitoring 05:09:24 INFO - Starting resource monitoring. 05:09:24 INFO - ##### 05:09:24 INFO - ##### Running install step. 05:09:24 INFO - ##### 05:09:24 INFO - Running pre-action listener: _resource_record_pre_action 05:09:24 INFO - Running main action method: install 05:09:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:09:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:09:25 INFO - Reading from file tmpfile_stdout 05:09:25 INFO - Detecting whether we're running mozinstall >=1.0... 05:09:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:09:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:09:25 INFO - Reading from file tmpfile_stdout 05:09:25 INFO - Output received: 05:09:25 INFO - Usage: mozinstall [options] installer 05:09:25 INFO - Options: 05:09:25 INFO - -h, --help show this help message and exit 05:09:25 INFO - -d DEST, --destination=DEST 05:09:25 INFO - Directory to install application into. [default: 05:09:25 INFO - "/builds/slave/test-pgo"] 05:09:25 INFO - --app=APP Application being installed. [default: firefox] 05:09:25 INFO - mkdir: /builds/slave/test-pgo/build/application 05:09:25 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'] 05:09:25 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 05:09:41 INFO - Reading from file tmpfile_stdout 05:09:41 INFO - Output received: 05:09:41 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:09:41 INFO - Running post-action listener: _resource_record_post_action 05:09:41 INFO - ##### 05:09:41 INFO - ##### Running run-tests step. 05:09:41 INFO - ##### 05:09:41 INFO - Running pre-action listener: _resource_record_pre_action 05:09:41 INFO - Running main action method: run_tests 05:09:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:09:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:09:41 INFO - Python 2.7.3 05:09:41 INFO - Return code: 0 05:09:41 INFO - grabbing minidump binary from tooltool 05:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:41 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 0x2148350>, '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 0x2149250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21496e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:09:41 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 05:09:41 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 05:09:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:09:41 INFO - Return code: 0 05:09:41 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:09:41 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:09:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:09:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:09:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:09:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:09:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:09:42 INFO - Return code: 0 05:09:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XSDTTqG9TySmHlfwaasy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:09:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XSDTTqG9TySmHlfwaasy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost 05:09:42 INFO - Using env: {'DISPLAY': ':0', 05:09:42 INFO - 'HOME': '/home/cltbld', 05:09:42 INFO - 'LANG': 'en_US.UTF-8', 05:09:42 INFO - 'LANGUAGE': 'en_US:en', 05:09:42 INFO - 'LOGNAME': 'cltbld', 05:09:42 INFO - 'MAIL': '/var/mail/cltbld', 05:09:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:09:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:42 INFO - 'MOZ_NO_REMOTE': '1', 05:09:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:42 INFO - 'NO_EM_RESTART': '1', 05:09:42 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:09:42 INFO - 'PWD': '/builds/slave/test-pgo', 05:09:42 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:09:42 INFO - 'SHELL': '/bin/bash', 05:09:42 INFO - 'SHLVL': '1', 05:09:42 INFO - 'TERM': 'linux', 05:09:42 INFO - 'TMOUT': '86400', 05:09:42 INFO - 'USER': 'cltbld', 05:09:42 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1450703322.589020-883333102', 05:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:42 INFO - '_': '/tools/buildbot/bin/python'} 05:09:42 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XSDTTqG9TySmHlfwaasy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] with output_timeout 3600 05:09:42 INFO - mozversion INFO | application_buildid: 20151221023004 05:09:42 INFO - mozversion INFO | application_changeset: b76ea647debcadd234066150c78b3bba77a50c74 05:09:42 INFO - mozversion INFO | application_display_name: Nightly 05:09:42 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:09:42 INFO - mozversion INFO | application_name: Firefox 05:09:42 INFO - mozversion INFO | application_remotingname: firefox 05:09:42 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 05:09:42 INFO - mozversion INFO | application_vendor: Mozilla 05:09:42 INFO - mozversion INFO | application_version: 46.0a1 05:09:42 INFO - mozversion INFO | platform_buildid: 20151221023004 05:09:42 INFO - mozversion INFO | platform_changeset: b76ea647debcadd234066150c78b3bba77a50c74 05:09:42 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 05:09:42 INFO - mozversion INFO | platform_version: 46.0a1 05:09:42 INFO - 2015-12-21 05:09:42,231 DEBUG : using testdate: 1450703382 05:09:42 INFO - 2015-12-21 05:09:42,231 DEBUG : actual date: 1450703382 05:09:42 INFO - 2015-12-21 05:09:42,279 INFO : starting webserver on 'localhost:39988' 05:09:42 INFO - 2015-12-21 05:09:42,280 INFO : Starting test suite talos-linux64-ix-022 05:09:42 INFO - 2015-12-21 05:09:42,280 INFO : Starting test dromaeo_css 05:09:42 INFO - 2015-12-21 05:09:42,280 DEBUG : operating with platform_type : linux_ 05:09:42 INFO - 2015-12-21 05:09:42,281 INFO : Initialising browser for dromaeo_css test... 05:09:42 INFO - 2015-12-21 05:09:42,293 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfRdqTm/profile http://localhost:39988/getInfo.html 05:09:46 INFO - 2015-12-21 05:09:46,720 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 05:09:47 INFO - 2015-12-21 05:09:47,024 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:09:47 INFO - 2015-12-21 05:09:47,024 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:09:47 INFO - 2015-12-21 05:09:47,024 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:09:47 INFO - 2015-12-21 05:09:47,024 DEBUG : BROWSER_OUTPUT: __metrics 05:09:47 INFO - 2015-12-21 05:09:47,146 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:09:47 INFO - 2015-12-21 05:09:47,210 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:09:47 ERROR - 2015-12-21 05:09:47,225 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 05:09:48 INFO - 2015-12-21 05:09:48,064 INFO : Browser initialized. 05:09:48 INFO - 2015-12-21 05:09:48,064 INFO : Running cycle 1/1 for dromaeo_css test... 05:09:48 INFO - 2015-12-21 05:09:48,065 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfRdqTm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:09:59 INFO - 2015-12-21 05:09:59,865 DEBUG : BROWSER_OUTPUT: RSS: Main: 149889024 05:09:59 INFO - 2015-12-21 05:09:59,865 DEBUG : BROWSER_OUTPUT: 05:10:51 INFO - 2015-12-21 05:10:51,348 DEBUG : BROWSER_OUTPUT: 1450703451347 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] 05:13:00 INFO - 2015-12-21 05:13:00,005 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39988/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39988/tests/dromaeo/cssquery-ext.html) 05:13:01 INFO - 2015-12-21 05:13:01,169 DEBUG : BROWSER_OUTPUT: RSS: Main: 274075648 05:13:01 INFO - 2015-12-21 05:13:01,169 DEBUG : BROWSER_OUTPUT: 05:16:03 INFO - 2015-12-21 05:16:03,724 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39988/tests/dromaeo/cssquery-ext.html (next: http://localhost:39988/tests/dromaeo/cssquery-jquery.html) 05:16:04 INFO - 2015-12-21 05:16:04,291 DEBUG : BROWSER_OUTPUT: RSS: Main: 233807872 05:16:04 INFO - 2015-12-21 05:16:04,291 DEBUG : BROWSER_OUTPUT: 05:19:06 INFO - 2015-12-21 05:19:06,180 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39988/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39988/tests/dromaeo/cssquery-mootools.html) 05:19:06 INFO - 2015-12-21 05:19:06,762 DEBUG : BROWSER_OUTPUT: RSS: Main: 222969856 05:19:06 INFO - 2015-12-21 05:19:06,762 DEBUG : BROWSER_OUTPUT: 05:22:08 INFO - 2015-12-21 05:22:08,622 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39988/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39988/tests/dromaeo/cssquery-prototype.html) 05:22:09 INFO - 2015-12-21 05:22:09,188 DEBUG : BROWSER_OUTPUT: RSS: Main: 210841600 05:22:09 INFO - 2015-12-21 05:22:09,188 DEBUG : BROWSER_OUTPUT: 05:25:11 INFO - 2015-12-21 05:25:11,709 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39988/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39988/tests/dromaeo/cssquery-yui.html) 05:25:12 INFO - 2015-12-21 05:25:12,296 DEBUG : BROWSER_OUTPUT: RSS: Main: 215080960 05:25:12 INFO - 2015-12-21 05:25:12,296 DEBUG : BROWSER_OUTPUT: 05:28:14 INFO - 2015-12-21 05:28:14,957 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39988/tests/dromaeo/cssquery-yui.html (next: http://localhost:39988/tests/dromaeo/cssquery-dojo.html) 05:28:15 INFO - 2015-12-21 05:28:15,208 DEBUG : BROWSER_OUTPUT: RSS: Main: 264290304 05:28:15 INFO - 2015-12-21 05:28:15,208 DEBUG : BROWSER_OUTPUT: 05:28:15 INFO - 2015-12-21 05:28:15,209 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:28:15 INFO - 2015-12-21 05:28:15,209 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:28:15 INFO - 2015-12-21 05:28:15,209 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:28:15 INFO - 2015-12-21 05:28:15,209 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:28:15 INFO - 2015-12-21 05:28:15,209 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3110.953335699965;3156.447621666208;3194.3132226571283;3205.3108581654956;3226.2740883301253;5017.749112544368;5143.125668636331;5181.145111056671;5228.797376603384;5289.233061206128;5091.9236211456855;5180.8704782380455;5208.166693329068;5274.129768588188;5283.8150664726745;4766.880827979311;4768.713877167373;4792.448868380128;4808.663393562435;4855.126077306083;4866.31871537985;4896.045271172123;4901.558859702626;4902.264660300948;4976.129177393942;4654.185517534418;4685.765711714418;4721.905561888777;4780.139574876521;4796.712197268175;4837.540433658832;4862.367892173995;4868.391451068616;4870.245112007645;4877.365942427497;4834.129856625806;4834.516548345173;4840.298156767284;4851.175300198975;4857.247126695368;4937.901241975176;4977.352944117278;5062.924056139161;5141.562967147797;5147.48525147486;5657.830265092054;5658.575606829463;5659.377468478464;5666.716664166816;5670.432956704338;5432.91850622241;5691.4024027476935;5695.088785794253;5697.515711164556;5713.14302854571;5173.249878767558;5210.218467229908;5266.578673706094;5340.652857564323;5366.570674346043;5823.097419899922;5826.621269617462;5840.386759390288;5849.5027922626205;5850.268716410449;5346.812861549827;5630.915536266959;5652;5652.802151924745;5657.094864821609;5536.390996990328;5584.301962254718;5596.58025648078;5599.888002239933;5642.351129620064;5591.440855914458;5625.240592520039;5645.5483561314995;5646.85882852932;5660.2075709400715;5433.103537916279;5596.384397716248;5597.524210442158;5604.8038318658655;5618.6628802272;4359.106383191438;4366.978165109154;4383.539728328544;4466.419365482467;4481.663875209372;3895.2988462076532;3908.687305015592;3910.081130934228;3916.6279203475624;3935.311320518955;5336.546393556591;5339.86650333737;5346.5455436287575;5351.09031464652;5351.732413379315;5435.483629055233;5564;5566.276384070045;5623.8594035149445;5706.400827913009;5279.762410691528;5280.234366016906;5286.207068939613;5287.048331300326;5291.629585929025;4856.077345304381;4875.756212189376;4879.170541008037;4882.170031094723;4929.704217746947;5548.944510554843;5621.971890140605;5642.915356269659;5699.344575373802;5831.125331200354;5603.32760068778;5668.064769313017;5669.801556945487;5670.744816483186;5687.090065589486;5713.685747283939;5772.134179873053;5774.364819869895;5778.451047150514;5780.21967034445;5372.677639341652;5477.45225477465;5479.863003424946;5546.168074788814;5661.207430959586;5642.71786410686;5691.117876729114;5705.315362156568;5716.456936591017;5746.367899531132;5570.832875013756;5572.080606699849;5581.804636837691;5583.916241256303;5584.190292407497;5276;5360.222767698584;5375.139977603565;5486.149646804752;5592.049351610155;5464.071107911744;5466.180072989084;5467.72661366938;5470.480304371078;5488.121900495901;5542.251796007648;5563.248961390161;5580.135079062752;5581.051221292471;5637.633553818989;5339.279197308314;5341.946580534301;5387.730613469233;5434.510894019557;5444.754986025559 05:28:15 INFO - 2015-12-21 05:28:15,211 DEBUG : BROWSER_OUTPUT: |1;ext.html;560.9747561359738;565.183310116881;567.0586825869058;589.4047012517357;592.8636413624863;29482;37597;38165.42751858725;38188.99999999996;38203.42694859579;41511.58488415123;41898.16203675925;41933.58066419335;41968;41993.7900310498;7498.175200727916;7648.349890259306;8746.344024198195;8930.821383572356;8937.865932011026;7707.229277072304;9987.950060249688;10208.285420020564;10262.948685256562;10280.588776448933;10101.54543045561;10183.643572474964;10189.388636681786;10189.745256368577;10191.388516688985;7731.536107833548;7985.281324680748;10078.395296282246;10163.898361016369;10183.796324073477;7668.118166410878;10413.166946644325;10625.5218515167;10666.573337066508;10680.893191068146;38799.80600096982;39093.41359879604;39093.60906390928;39171.804140979395;39222;3133.780635355526;3162.557241986101;3185.824779637119;3240.8865689700747;3372.274960883422;29815.70184298151;30003.549946750816;30162.84918575415;30231;30985.690143098505;3822.808859557011;3904.8438062477467;3928.9607103929166;3976.602339766029;4116.403121547389;261667;265316;265513;265834.67082664656;266215;53584.732076339365;54244.18633720497;58145.41854581485;64478;65684;58148;58661.70669146627;58751.11873321904;58797.118043229384;58977.70511147503;13983;14070.718585628434;14147.43410263578;14169.149851008973;14179.716405671828;10391;10413;10420.947895260475;10477.790444191074;10480.895191048145;19447.902760486108;19932;20054.799452005584;20137;20154.093065812074;7730.806729831799;7868.84262314762;7976.122626511079;7990.320822730133;7998.48009879356;862.6376921692904;939.9295052871062;954.289054654287;1004.9346792458467;1053.5891002509027;31900.521492177635;33826.32347353089;33932.49101263483;34017;34315.313693726486;998.001998001998;1012.5038731021893;1041.2294901772784;1052.9262951593469;1129.983015286249;15113.47102851395;15163.924180379028;15174.696506069817;15270.31283592241;15348.693026139415;379353;383866;385413;385759;386605;53796.193057104174;54172;54184.45815541873;54285.72857135689;54292.72853635706;1238.1642391385778;1306.1183701001976;1313.9540116096082;1353.086666500128;1354.5800801751489;26367;28493.430131397672;28988.27529311784;29454.263643409085;30936.071917842502;47683.76158119187;48643;48846.26730599115;48915.266271005254;49012;288660;290636;290788;291769;292602;27519.44961100727;27566.310842229104;27726.168214953585;32223;32611.836940816094;37891.62108378991;37895;37909.81045094757;44494.332585010605;44950.77524612356;28601.42797144087;30224.539567739856;31965.520517191795;32454.188645284055;33920.321593568486;34346.14134646654;34364.48453273153;40485;41516.79241603773;41628.37557436701;36545.634543654225;36653.63346366502;36853.44719829151;37699;38626.42060369041;31264.531032034993;33004;33070.33859322752;33641.3271734559;33764.3247135051;25203.495930081663;25317.987280508572;25376.238712838644;25527.234182974542;25685.229443116736 05:28:15 INFO - 2015-12-21 05:28:15,212 DEBUG : BROWSER_OUTPUT: |2;jquery.html;353.71702637889683;353.77712041413923;359.6978538028056;362.84216365880843;363.84536571956926;13986.300684965761;14071;16931.830681693194;17416.303347866087;18116.728249076274;14774.556763297118;14824.407023719064;17173.82826171738;17471.563210919703;17536.736948945745;5281.471852814717;5367.731613419333;5384.40771515133;5386.730663466811;5387.272718183054;4025.81883815229;4124.31948728461;4815.277708343741;5895.646261224319;5935.198748169007;4103.692223083266;5727.3699893011735;5922.111683247525;5929.169916211734;5932.644041357511;5729.971350143264;5841.299044114691;5841.88316233673;5847.093700476433;5877.970610146965;5192.3769147702515;5192.662476938987;5195.038917800219;5196.220566914955;5199.376074871002;20543.28098516545;20873.68689469644;21177.364679059654;21444.892775536024;21464.35606931779;2109.4093653776968;2209.5912256232486;2240.574290884743;2265.8980345884474;2311.3643747969277;12848.329717136807;13171.802422963663;13190.34048297591;13362.465501380031;13573.321333933363;1724.7499112628725;1735.8264173582668;1790.588164722108;1826.2786199451143;1882.190658017052;58810.11784823231;59949;60840.39159608436;61162.38837611611;63317.68341158311;9987.151092157103;10268.948655256676;10274.691759247235;10318.845217321747;10319.48402579868;13368.064235503422;13391.933040334736;13483.31458567679;13568.457261709422;13573.457061717618;6986.406155476841;6994.720211191496;7000.229974702778;7043.718251269995;7073.257307982691;6554.4756419487285;6576.934230657632;6585.637789921505;6636.601803891782;6648.867022659617;4369.453818272716;4409.49290831552;4433.512313645497;4457.866264012085;4482.820687172477;1685.536477468706;1750.0812073661175;1782.9019403932907;1785.7410525579694;1820.8998505082347;873.5370253765515;898.645035211101;900.504722402676;940.9153176214037;980.9950950245203;16415.507534773977;17325.56686082858;17499.38752143669;17735.37926172578;17816.91091544534;867.6789587852535;897.4435849773182;912.0833562269876;941.110650435332;976.3995142987012;9831.705048848404;10331.845022324671;10337.9483102584;10462.372257664565;10635.627753028606;525108;533488.9953301407;534098;550722;552648;81640.59179704063;83322;84060.57969710235;84550.57724711337;84681;1145.0782120392996;1161.0769438296575;1166.5158959031908;1169.6607983684637;1172.0330727150135;15884.920575397511;15895.364185432452;15960.441384551485;16069.91965040214;16337.101459419371;35001.124971875906;35843.28313433769;36537.63462365342;37370;37443.81278093592;40805.59194408018;42277.57722422737;42959.14081718286;43351;43540.78229608832;9536.380135291462;9714.659986900424;9721.416714997124;9796.21630269591;9820.4107753535;16898.577535561708;16979.405720799714;17972.19125139346;18471;18567.25730970746;11339.886601134212;11560.364179969845;11748.58879939198;13831.100978436369;14368.209748463516;13365.933170334087;14004.649883752987;14173.858261417667;14396.640083997983;14397.280135992949;14860.331285091981;15036.699266014837;15450.9227453862;15779.526614201592;15788;9716.174125199437;9837.360571562825;9872;10060.496975151067;10063.798724025624;10087.949560252151;10187.745306367104;10269.664943557289;15121.395144194548;15330 05:28:15 INFO - 2015-12-21 05:28:15,216 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1316.5457917018637;1611.790467239259;1662.3184494357315;1673.0380031481898;1707.8292170782922;5998.640081595102;6588.209414870216;6742.52802303839;6800.421964133042;6802.319768023195;6788.490863185269;6917.654117294128;6934.410575101122;6937.271586483423;6942.583444993291;1839.2918726290407;1875.165551329659;2063.865848719836;2091.8012788785118;2099.88450635215;2137.6152292587326;2143.132031527226;2143.4212762554102;2146.0450099705636;2146.7101941237966;2072.554400803827;2107.683847422891;2124.0654112190664;2124.5644642848256;2127.1597718901025;2114.2283066680707;2116.947076323089;2124.3414541492034;2136.1241890824845;2138.8395870309787;2080.916763329465;2084.5622419291967;2099.8950052497466;2110.9366718998454;2111.6938043983537;6846.178458584952;6941.965290173567;6952.339527744856;6958.65206739661;6960.895586566155;4130.091379896448;4230.090530535918;4231.851885184004;4240.915181696349;4244.3209086546;2714.484247992875;2752.967637136074;2769.404578015716;2790.9581356279673;2804.032608749978;918.0360621347559;933.5938866593053;935.2144198872979;937.3532262738688;941.5010044676333;9375.390599611004;9377.202937750299;9396.953015234949;9399;9410.388324758937;3802.049487628093;3814.2752876953846;3853.3641949078087;3884.6503814656817;3887.6501114899793;8093.392995525359;8125.024997000398;8131.79670508242;8142.185781421929;8146.022477302761;4299.634531064832;4299.78501074945;4302.763348015889;4315.741055536678;4326.870193894189;3932.174243408859;3953.7825419601622;3964.8810535683974;3965.306071437487;3966.0679740261016;3039.8480075996113;3095.613048368954;3163.3040731039596;3217.2117831131523;3274.3287626036604;1026.3226270661328;1040.6773900090996;1043.1654676258963;1048.6015314180563;1052.952617132231;1017.2523195451338;1023.0690072034413;1025.5385076715509;1151.1366475143643;1301.7526669932683;6635.104260924713;6660.83347916306;6698.263191048981;6703.195616526048;6705.430038446787;1097.0729733375285;1153.3425947210178;1163.813789793629;1168.67861338131;1187.7825229140028;5330.92003619946;5332.6000549958135;5354.143337066129;5371.3822910365025;5379.1393377059485;7976.601169941479;8228.958855205685;8293.419460637697;8397.538135402612;8417.284530814826;8220.753377398687;8289.58552072394;8293.875591866126;8329.08380078191;8335.416520843482;6479.254885688206;6550.868982620321;6601.70292336846;6653;6666.533342666064;6454.064160696579;6454.322296158835;6455.4512866406885;6461.967690161519;6462.159919210472;7230.783076507713;7362.889556656762;7383.2985866342615;7391.186969433251;7482.139553951148;7427.665755041145;7576.356009739234;7714.807129821575;7739.613019349123;7742.070951485633;6160.229971253593;6177.62934223948;6215.689215539114;6220.409061139185;6221.3156552778255;6010.128531363015;6116.052011938156;6514.9348506514325;6659.367360100783;6908.965455172692;6270.592411493239;6332.620042797447;6465.2564955030775;6533.216014078341;6555.80332590023;6271.090691849748;6364.204474440695;6369.522285828489;6460.257070436772;6466.0947467355545;6261.24865016201;6267.310595834363;6271.4669253114;6302.180716506825;6467.450266727381;5946.524278057832;5972.34304226526;5992.400759923973;6007.158997740233;6012.6392416455155;5829.15477255804;6088.665123418255;6103.389661033861;6113.388661133851;6120.785772497941 05:28:15 INFO - 2015-12-21 05:28:15,217 DEBUG : BROWSER_OUTPUT: |4;prototype.html;328.29744347097215;336.94271973764455;352.0951155530288;352.65792181583885;355.69232613789046;5909.763609455622;5919.37846526115;5949.851253718659;5979.342272350038;5997.220361353029;5877.67672777997;5886.440788125121;5888;5898.88202235955;5906.202662640542;4644.140833945714;4645.187092258858;4650.046740418223;4650.348951146825;4655.7439340836245;4404.427424434835;4551.5676010778925;4570.154521413532;4573.977130114361;4574.931376029363;4550.271956486963;4554.567316104964;4563.726176429408;4565.201089809287;4568.086382723452;4350.347447882811;4392.143532011259;4427.026054268056;4556.157110934471;4567.862964111066;3962.4254483100076;3984.063745019918;3985.5416627087966;3992.900177495557;4000.4799376081214;5579.7489112990015;5586.497215250606;5607.607467477278;5618.381977982419;5637.915431268534;5051.873703157414;5145.6398052136365;5164.147915593922;5292.68243905363;5293.550048245904;6228.096925945758;6271.466925311354;6287.434130928193;6292.937070629281;6310.2427708674795;4387.561243875587;4454.554544545552;4455.643548516111;4458.3535387368975;4459.219636563588;6380.872382552323;6478.578892371981;6536.738530458776;6548.738050477975;6560.671966401661;4511.390962220124;4541.500434952152;4544.431946006749;4546.568076032771;4548.11311794197;4604.493505714368;4604.746738929391;4605.792739326738;4607.792649330788;4608.861734147914;5300.257963885059;5307.681539107666;5313.468653134656;5314.7608357624;5316.840494785162;6188.1027251048345;6341.239051313872;6344.777932772331;6348.555601107971;6390.712417941204;1598.8081430228447;1624.301550333368;1627.593101724569;1628.3161072349642;1633.2976819967528;1053.947302634865;1055.5302890213782;1066.4827558634056;1081.2215205052507;1115.0132133062298;6071.392860713893;6073.5748497604745;6076.088586712029;6079.209702738615;6083.7870674526175;6526.706298216592;6527.902081468782;6528.183977002875;6531.118299029666;6536.379043990813;5964.950473495115;6057.878842423215;6070.2108725865355;6077.3314935357075;6078.088286757022;3436.3127374525193;3520.2959408118477;3539.4513850352723;3544.2734239480847;3547.7161827053774;6626.304238055031;6627.86744265112;6631.635260060646;6638.5684930479365;6646.767363142363;6467.385598368148;6662;6702.128723265944;6709.765158219537;6712.899306510406;6125.4487096160665;6548.9017664735065;6605.900911486331;6697.296783837822;6727.461803055841;6630;6630.602163870183;6637.734490620321;6639.336066393322;6641.634710090992;6541.542092053701;6546.214454265519;6551.770688025897;6557.180352455943;6557.442617377576;6593.340665933369;6704.564203326768;6712.127423434922;6715.832104197434;6722.529422940347;4491.528389519053;4492.2587773018395;4494;4494.820207191807;4495.640348772025;6611.07444957716;6614.801555953329;6619.635920024252;6625.768098116543;6629.867402652017;6279.937200627935;6455.3221911700475;6458.644774537445;6461.996780997905;6464.676766161767;6369.617822930639;6419.550631455753;6430.1319321892815;6437.485001199986;6446.323136070832;6306.211723534559;6315.494760419064;6316.494680425647;6320.652364120017;6329.588576742497;6269.592476489013;6449.484041276781;6480.384363485461;6483.319251478527;6498.740050397932;6327.810165695037;6330.683465826598;6332.873342533216;6335.1130841683125;6341 05:28:15 INFO - 2015-12-21 05:28:15,219 DEBUG : BROWSER_OUTPUT: |5;yui.html;735.8896165575163;744.2260049548466;763.6792547130208;767.4052609227848;830.3066939105846;13379.331033448325;13805.861941380583;13820.378082986264;13822.723545529096;13823.308834558282;11328.546858125665;11404.258723182988;11417.200795944287;11434.54261829528;11445.02717269031;662.241733215468;667.9532432729711;765.402985671176;788.8304014636852;799.220759759233;808.8018435483315;810.307187354812;815.7348861619968;816.7876352148454;817.464560712734;841.5581819544757;849.1762989899787;850.7022542110243;851.0680804519042;851.1573542193215;688.8518968421788;693.8612277544511;826.1655727715021;840.5671079394117;844.5270648436895;622.8691974685322;624.1012941364421;624.6096189881324;625.6590158363703;626.1640709652619;12977.091603587753;13101.737965240736;13130.671733206651;13164.6708832279;13213.405396757073;11660.883391166064;12216.816747748702;12242.143049986504;12304.07719421038;12370.381480925918;10217;10270.435126068063;10308.948455257676;10352.741181470448;10558.726418596798;3608.566971963381;3610.963890361089;3713.5543734752005;3715.5912849586525;3717.6839968602703;44613.77693111546;44743.105137897386;44812.3278150828;44818.77590612059;44885.10229795386;9854.655087071918;10060.144887684628;10217.18262538995;10312.793744125076;10488.423136727553;17445;17487.38794142199;17532.29870805179;17544.56138596545;17605.911970440065;7502.099748030271;7560.773176804704;7611.961940190264;7779.961100194463;7819.609019549;3997.2205419942834;4129.463169787969;4180.602842729936;4202.348635961431;4308.332208507686;2923.9707602924123;2956.334824664433;2965.332800119999;2966.3770608172094;2976.1071678496364;507.7664274433728;527.736131934033;530.6471196654181;536.4769349883832;540.3299908113911;545.9945400546023;590.630855715178;602.2020822410236;641.1344684675651;647.9967600162063;8657.567121643893;8700.564971751388;8895.955520222358;8907.495258528446;9132.81734365309;542.3275138827825;609.5276160975279;624.2353117431202;628.7265039707742;629.8929182039064;4058.9797051014557;4217.304144816132;4258.552851950562;4354.53215646864;4376.978115109404;51741;52924.735376322875;52981.47018529842;53337.1999420009;54666.72666636641;51060.744696276284;51190.74404627953;51566;51612.74193629008;51959.74020129875;45312.546874531494;45353.77323113364;45565.54434455613;45830;45974;7584.1788118683;7604.5437273763755;7801.882971755314;7938.6030698466;8003.279704826594;33631.831840841616;34371.656283436845;34900.127496812784;35027.299454010266;35332.82333588316;43170.352444713986;44346.556534435535;44407.111857762015;44790.3281450785;45117.774411127735;9658.275629327689;9760.316777825768;9882.4564648945;10139.188864890939;10188.694339169837;10610.310329828537;10832.67501974942;10869.836952445878;11102.389368584805;11449.370284634426;10291.258283401368;10399.740006499898;10660.84008739885;10922.235443518877;10936.617218397318;10686.57253709843;10714.946425267824;10801.135909127408;11048.613298534834;11172.888271117185;9729.416235025921;9839.557219925264;9858.704238872846;10150.086492215736;10165.644202452879;8920.509371984344;8925.285977121684;9142.314326425678;9266.629334826532;9353.896877731067;8559.979791275606;8827.69103081389;9236.399634023766;9268.675596354095;9333.906660933304 05:28:15 INFO - 2015-12-21 05:28:15,219 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:28:15 INFO - 2015-12-21 05:28:15,219 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:28:15 INFO - 2015-12-21 05:28:15,219 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,961 05:28:15 INFO - 2015-12-21 05:28:15,219 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:28:15 INFO - 2015-12-21 05:28:15,219 DEBUG : BROWSER_OUTPUT: __startTimestamp1450704495208__endTimestamp 05:28:15 INFO - 2015-12-21 05:28:15,219 DEBUG : BROWSER_OUTPUT: 05:28:15 INFO - 2015-12-21 05:28:15,220 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:28:15 INFO - 2015-12-21 05:28:15,220 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:28:15 INFO - 2015-12-21 05:28:15,220 DEBUG : BROWSER_OUTPUT: 05:28:15 INFO - 2015-12-21 05:28:15,220 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5233.70 Median:5387.73 stddev:564.07 (10.5%) stddev-sans-first:540.66 05:28:15 INFO - 2015-12-21 05:28:15,221 DEBUG : BROWSER_OUTPUT: Values: 3111.0 3156.4 3194.3 3205.3 3226.3 5017.7 5143.1 5181.1 5228.8 5289.2 5091.9 5180.9 5208.2 5274.1 5283.8 4766.9 4768.7 4792.4 4808.7 4855.1 4866.3 4896.0 4901.6 4902.3 4976.1 4654.2 4685.8 4721.9 4780.1 4796.7 4837.5 4862.4 4868.4 4870.2 4877.4 4834.1 4834.5 4840.3 4851.2 4857.2 4937.9 4977.4 5062.9 5141.6 5147.5 5657.8 5658.6 5659.4 5666.7 5670.4 5432.9 5691.4 5695.1 5697.5 5713.1 5173.2 5210.2 5266.6 5340.7 5366.6 5823.1 5826.6 5840.4 5849.5 5850.3 5346.8 5630.9 5652.0 5652.8 5657.1 5536.4 5584.3 5596.6 5599.9 5642.4 5591.4 5625.2 5645.5 5646.9 5660.2 5433.1 5596.4 5597.5 5604.8 5618.7 4359.1 4367.0 4383.5 4466.4 4481.7 3895.3 3908.7 3910.1 3916.6 3935.3 5336.5 5339.9 5346.5 5351.1 5351.7 5435.5 5564.0 5566.3 5623.9 5706.4 5279.8 5280.2 5286.2 5287.0 5291.6 4856.1 4875.8 4879.2 4882.2 4929.7 5548.9 5622.0 5642.9 5699.3 5831.1 5603.3 5668.1 5669.8 5670.7 5687.1 5713.7 5772.1 5774.4 5778.5 5780.2 5372.7 5477.5 5479.9 5546.2 5661.2 5642.7 5691.1 5705.3 5716.5 5746.4 5570.8 5572.1 5581.8 5583.9 5584.2 5276.0 5360.2 5375.1 5486.1 5592.0 5464.1 5466.2 5467.7 5470.5 5488.1 5542.3 5563.2 5580.1 5581.1 5637.6 5339.3 5341.9 5387.7 5434.5 5444.8 05:28:15 INFO - 2015-12-21 05:28:15,221 DEBUG : BROWSER_OUTPUT: 05:28:15 INFO - 2015-12-21 05:28:15,221 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48123.74 Median:18568.30 stddev:83303.73 (448.6%) stddev-sans-first:83460.87 05:28:15 INFO - 2015-12-21 05:28:15,221 DEBUG : BROWSER_OUTPUT: Values: 561.0 565.2 567.1 589.4 592.9 29482.0 37597.0 38165.4 38189.0 38203.4 41511.6 41898.2 41933.6 41968.0 41993.8 7498.2 7648.3 8746.3 8930.8 8937.9 7707.2 9988.0 10208.3 10262.9 10280.6 10101.5 10183.6 10189.4 10189.7 10191.4 7731.5 7985.3 10078.4 10163.9 10183.8 7668.1 10413.2 10625.5 10666.6 10680.9 38799.8 39093.4 39093.6 39171.8 39222.0 3133.8 3162.6 3185.8 3240.9 3372.3 29815.7 30003.5 30162.8 30231.0 30985.7 3822.8 3904.8 3929.0 3976.6 4116.4 261667.0 265316.0 265513.0 265834.7 266215.0 53584.7 54244.2 58145.4 64478.0 65684.0 58148.0 58661.7 58751.1 58797.1 58977.7 13983.0 14070.7 14147.4 14169.1 14179.7 10391.0 10413.0 10420.9 10477.8 10480.9 19447.9 19932.0 20054.8 20137.0 20154.1 7730.8 7868.8 7976.1 7990.3 7998.5 862.6 939.9 954.3 1004.9 1053.6 31900.5 33826.3 33932.5 34017.0 34315.3 998.0 1012.5 1041.2 1052.9 1130.0 15113.5 15163.9 15174.7 15270.3 15348.7 379353.0 383866.0 385413.0 385759.0 386605.0 53796.2 54172.0 54184.5 54285.7 54292.7 1238.2 1306.1 1314.0 1353.1 1354.6 26367.0 28493.4 28988.3 29454.3 30936.1 47683.8 48643.0 48846.3 48915.3 49012.0 288660.0 290636.0 290788.0 291769.0 292602.0 27519.4 27566.3 27726.2 32223.0 32611.8 37891.6 37895.0 37909.8 44494.3 44950.8 28601.4 30224.5 31965.5 32454.2 33920.3 34346.1 34364.5 40485.0 41516.8 41628.4 36545.6 36653.6 36853.4 37699.0 38626.4 31264.5 33004.0 33070.3 33641.3 33764.3 25203.5 25318.0 25376.2 25527.2 25685.2 05:28:15 INFO - 2015-12-21 05:28:15,222 DEBUG : BROWSER_OUTPUT: 05:28:15 INFO - 2015-12-21 05:28:15,222 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28961.16 Median:17677.42 stddev:88144.70 (498.6%) stddev-sans-first:88365.80 05:28:15 INFO - 2015-12-21 05:28:15,222 DEBUG : BROWSER_OUTPUT: Values: 353.7 353.8 359.7 362.8 363.8 13986.3 14071.0 16931.8 17416.3 18116.7 14774.6 14824.4 17173.8 17471.6 17536.7 5281.5 5367.7 5384.4 5386.7 5387.3 4025.8 4124.3 4815.3 5895.6 5935.2 4103.7 5727.4 5922.1 5929.2 5932.6 5730.0 5841.3 5841.9 5847.1 5878.0 5192.4 5192.7 5195.0 5196.2 5199.4 20543.3 20873.7 21177.4 21444.9 21464.4 2109.4 2209.6 2240.6 2265.9 2311.4 12848.3 13171.8 13190.3 13362.5 13573.3 1724.7 1735.8 1790.6 1826.3 1882.2 58810.1 59949.0 60840.4 61162.4 63317.7 9987.2 10268.9 10274.7 10318.8 10319.5 13368.1 13391.9 13483.3 13568.5 13573.5 6986.4 6994.7 7000.2 7043.7 7073.3 6554.5 6576.9 6585.6 6636.6 6648.9 4369.5 4409.5 4433.5 4457.9 4482.8 1685.5 1750.1 1782.9 1785.7 1820.9 873.5 898.6 900.5 940.9 981.0 16415.5 17325.6 17499.4 17735.4 17816.9 867.7 897.4 912.1 941.1 976.4 9831.7 10331.8 10337.9 10462.4 10635.6 525108.0 533489.0 534098.0 550722.0 552648.0 81640.6 83322.0 84060.6 84550.6 84681.0 1145.1 1161.1 1166.5 1169.7 1172.0 15884.9 15895.4 15960.4 16069.9 16337.1 35001.1 35843.3 36537.6 37370.0 37443.8 40805.6 42277.6 42959.1 43351.0 43540.8 9536.4 9714.7 9721.4 9796.2 9820.4 16898.6 16979.4 17972.2 18471.0 18567.3 11339.9 11560.4 11748.6 13831.1 14368.2 13365.9 14004.6 14173.9 14396.6 14397.3 14860.3 15036.7 15450.9 15779.5 15788.0 9716.2 9837.4 9872.0 10060.5 10063.8 10087.9 10187.7 10269.7 15121.4 15330.0 05:28:15 INFO - 2015-12-21 05:28:15,222 DEBUG : BROWSER_OUTPUT: 05:28:15 INFO - 2015-12-21 05:28:15,222 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4915.40 Median:6114.72 stddev:2478.47 (40.5%) stddev-sans-first:2470.65 05:28:15 INFO - 2015-12-21 05:28:15,223 DEBUG : BROWSER_OUTPUT: Values: 1316.5 1611.8 1662.3 1673.0 1707.8 5998.6 6588.2 6742.5 6800.4 6802.3 6788.5 6917.7 6934.4 6937.3 6942.6 1839.3 1875.2 2063.9 2091.8 2099.9 2137.6 2143.1 2143.4 2146.0 2146.7 2072.6 2107.7 2124.1 2124.6 2127.2 2114.2 2116.9 2124.3 2136.1 2138.8 2080.9 2084.6 2099.9 2110.9 2111.7 6846.2 6942.0 6952.3 6958.7 6960.9 4130.1 4230.1 4231.9 4240.9 4244.3 2714.5 2753.0 2769.4 2791.0 2804.0 918.0 933.6 935.2 937.4 941.5 9375.4 9377.2 9397.0 9399.0 9410.4 3802.0 3814.3 3853.4 3884.7 3887.7 8093.4 8125.0 8131.8 8142.2 8146.0 4299.6 4299.8 4302.8 4315.7 4326.9 3932.2 3953.8 3964.9 3965.3 3966.1 3039.8 3095.6 3163.3 3217.2 3274.3 1026.3 1040.7 1043.2 1048.6 1053.0 1017.3 1023.1 1025.5 1151.1 1301.8 6635.1 6660.8 6698.3 6703.2 6705.4 1097.1 1153.3 1163.8 1168.7 1187.8 5330.9 5332.6 5354.1 5371.4 5379.1 7976.6 8229.0 8293.4 8397.5 8417.3 8220.8 8289.6 8293.9 8329.1 8335.4 6479.3 6550.9 6601.7 6653.0 6666.5 6454.1 6454.3 6455.5 6462.0 6462.2 7230.8 7362.9 7383.3 7391.2 7482.1 7427.7 7576.4 7714.8 7739.6 7742.1 6160.2 6177.6 6215.7 6220.4 6221.3 6010.1 6116.1 6514.9 6659.4 6909.0 6270.6 6332.6 6465.3 6533.2 6555.8 6271.1 6364.2 6369.5 6460.3 6466.1 6261.2 6267.3 6271.5 6302.2 6467.5 5946.5 5972.3 5992.4 6007.2 6012.6 5829.2 6088.7 6103.4 6113.4 6120.8 05:28:15 INFO - 2015-12-21 05:28:15,224 DEBUG : BROWSER_OUTPUT: 05:28:15 INFO - 2015-12-21 05:28:15,224 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5299.76 Median:6027.55 stddev:1592.07 (26.4%) stddev-sans-first:1552.19 05:28:15 INFO - 2015-12-21 05:28:15,224 DEBUG : BROWSER_OUTPUT: Values: 328.3 336.9 352.1 352.7 355.7 5909.8 5919.4 5949.9 5979.3 5997.2 5877.7 5886.4 5888.0 5898.9 5906.2 4644.1 4645.2 4650.0 4650.3 4655.7 4404.4 4551.6 4570.2 4574.0 4574.9 4550.3 4554.6 4563.7 4565.2 4568.1 4350.3 4392.1 4427.0 4556.2 4567.9 3962.4 3984.1 3985.5 3992.9 4000.5 5579.7 5586.5 5607.6 5618.4 5637.9 5051.9 5145.6 5164.1 5292.7 5293.6 6228.1 6271.5 6287.4 6292.9 6310.2 4387.6 4454.6 4455.6 4458.4 4459.2 6380.9 6478.6 6536.7 6548.7 6560.7 4511.4 4541.5 4544.4 4546.6 4548.1 4604.5 4604.7 4605.8 4607.8 4608.9 5300.3 5307.7 5313.5 5314.8 5316.8 6188.1 6341.2 6344.8 6348.6 6390.7 1598.8 1624.3 1627.6 1628.3 1633.3 1053.9 1055.5 1066.5 1081.2 1115.0 6071.4 6073.6 6076.1 6079.2 6083.8 6526.7 6527.9 6528.2 6531.1 6536.4 5965.0 6057.9 6070.2 6077.3 6078.1 3436.3 3520.3 3539.5 3544.3 3547.7 6626.3 6627.9 6631.6 6638.6 6646.8 6467.4 6662.0 6702.1 6709.8 6712.9 6125.4 6548.9 6605.9 6697.3 6727.5 6630.0 6630.6 6637.7 6639.3 6641.6 6541.5 6546.2 6551.8 6557.2 6557.4 6593.3 6704.6 6712.1 6715.8 6722.5 4491.5 4492.3 4494.0 4494.8 4495.6 6611.1 6614.8 6619.6 6625.8 6629.9 6279.9 6455.3 6458.6 6462.0 6464.7 6369.6 6419.6 6430.1 6437.5 6446.3 6306.2 6315.5 6316.5 6320.7 6329.6 6269.6 6449.5 6480.4 6483.3 6498.7 6327.8 6330.7 6332.9 6335.1 6341.0 05:28:15 INFO - 2015-12-21 05:28:15,224 DEBUG : BROWSER_OUTPUT: 05:28:15 INFO - 2015-12-21 05:28:15,224 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13296.52 Median:45697.77 stddev:15404.64 (33.7%) stddev-sans-first:15418.97 05:28:15 INFO - 2015-12-21 05:28:15,225 DEBUG : BROWSER_OUTPUT: Values: 735.9 744.2 763.7 767.4 830.3 13379.3 13805.9 13820.4 13822.7 13823.3 11328.5 11404.3 11417.2 11434.5 11445.0 662.2 668.0 765.4 788.8 799.2 808.8 810.3 815.7 816.8 817.5 841.6 849.2 850.7 851.1 851.2 688.9 693.9 826.2 840.6 844.5 622.9 624.1 624.6 625.7 626.2 12977.1 13101.7 13130.7 13164.7 13213.4 11660.9 12216.8 12242.1 12304.1 12370.4 10217.0 10270.4 10308.9 10352.7 10558.7 3608.6 3611.0 3713.6 3715.6 3717.7 44613.8 44743.1 44812.3 44818.8 44885.1 9854.7 10060.1 10217.2 10312.8 10488.4 17445.0 17487.4 17532.3 17544.6 17605.9 7502.1 7560.8 7612.0 7780.0 7819.6 3997.2 4129.5 4180.6 4202.3 4308.3 2924.0 2956.3 2965.3 2966.4 2976.1 507.8 527.7 530.6 536.5 540.3 546.0 590.6 602.2 641.1 648.0 8657.6 8700.6 8896.0 8907.5 9132.8 542.3 609.5 624.2 628.7 629.9 4059.0 4217.3 4258.6 4354.5 4377.0 51741.0 52924.7 52981.5 53337.2 54666.7 51060.7 51190.7 51566.0 51612.7 51959.7 45312.5 45353.8 45565.5 45830.0 45974.0 7584.2 7604.5 7801.9 7938.6 8003.3 33631.8 34371.7 34900.1 35027.3 35332.8 43170.4 44346.6 44407.1 44790.3 45117.8 9658.3 9760.3 9882.5 10139.2 10188.7 10610.3 10832.7 10869.8 11102.4 11449.4 10291.3 10399.7 10660.8 10922.2 10936.6 10686.6 10714.9 10801.1 11048.6 11172.9 9729.4 9839.6 9858.7 10150.1 10165.6 8920.5 8925.3 9142.3 9266.6 9353.9 8560.0 8827.7 9236.4 9268.7 9333.9 05:28:15 INFO - 2015-12-21 05:28:15,225 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:28:15 INFO - 2015-12-21 05:28:15,225 DEBUG : BROWSER_OUTPUT: 05:28:15 INFO - 2015-12-21 05:28:15,967 INFO : Browser exited with error code: 0 05:28:15 INFO - 2015-12-21 05:28:15,983 INFO : Completed test dromaeo_css (00:18:33) 05:28:15 INFO - 2015-12-21 05:28:15,983 INFO : Starting test kraken 05:28:15 INFO - 2015-12-21 05:28:15,983 DEBUG : operating with platform_type : linux_ 05:28:15 INFO - 2015-12-21 05:28:15,983 INFO : Initialising browser for kraken test... 05:28:15 INFO - 2015-12-21 05:28:15,990 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpI857DT/profile http://localhost:39988/getInfo.html 05:28:20 INFO - 2015-12-21 05:28:20,192 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 05:28:20 INFO - 2015-12-21 05:28:20,200 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:28:20 INFO - 2015-12-21 05:28:20,200 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:28:20 INFO - 2015-12-21 05:28:20,200 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:28:20 INFO - 2015-12-21 05:28:20,200 DEBUG : BROWSER_OUTPUT: __metrics 05:28:20 INFO - 2015-12-21 05:28:20,301 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:28:20 INFO - 2015-12-21 05:28:20,357 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:28:21 INFO - 2015-12-21 05:28:21,559 INFO : Browser initialized. 05:28:21 INFO - 2015-12-21 05:28:21,560 INFO : Running cycle 1/1 for kraken test... 05:28:21 INFO - 2015-12-21 05:28:21,560 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpI857DT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:28:33 INFO - 2015-12-21 05:28:33,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 150896640 05:28:33 INFO - 2015-12-21 05:28:33,325 DEBUG : BROWSER_OUTPUT: 05:28:35 INFO - 2015-12-21 05:28:35,792 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39988/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39988/tests/kraken/driver.html?testName=audio-beat-detection) 05:28:36 INFO - 2015-12-21 05:28:36,385 DEBUG : BROWSER_OUTPUT: RSS: Main: 186998784 05:28:36 INFO - 2015-12-21 05:28:36,385 DEBUG : BROWSER_OUTPUT: 05:28:38 INFO - 2015-12-21 05:28:38,954 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39988/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39988/tests/kraken/driver.html?testName=audio-dft) 05:28:39 INFO - 2015-12-21 05:28:39,528 DEBUG : BROWSER_OUTPUT: RSS: Main: 176488448 05:28:39 INFO - 2015-12-21 05:28:39,528 DEBUG : BROWSER_OUTPUT: 05:28:42 INFO - 2015-12-21 05:28:42,371 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39988/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39988/tests/kraken/driver.html?testName=audio-fft) 05:28:42 INFO - 2015-12-21 05:28:42,937 DEBUG : BROWSER_OUTPUT: RSS: Main: 159277056 05:28:42 INFO - 2015-12-21 05:28:42,937 DEBUG : BROWSER_OUTPUT: 05:28:44 INFO - 2015-12-21 05:28:44,917 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39988/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39988/tests/kraken/driver.html?testName=audio-oscillator) 05:28:45 INFO - 2015-12-21 05:28:45,483 DEBUG : BROWSER_OUTPUT: RSS: Main: 163516416 05:28:45 INFO - 2015-12-21 05:28:45,483 DEBUG : BROWSER_OUTPUT: 05:28:47 INFO - 2015-12-21 05:28:47,682 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39988/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39988/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:28:48 INFO - 2015-12-21 05:28:48,243 DEBUG : BROWSER_OUTPUT: RSS: Main: 165527552 05:28:48 INFO - 2015-12-21 05:28:48,243 DEBUG : BROWSER_OUTPUT: 05:28:51 INFO - 2015-12-21 05:28:51,134 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39988/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39988/tests/kraken/driver.html?testName=imaging-darkroom) 05:28:51 INFO - 2015-12-21 05:28:51,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 164478976 05:28:51 INFO - 2015-12-21 05:28:51,701 DEBUG : BROWSER_OUTPUT: 05:28:55 INFO - 2015-12-21 05:28:55,028 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39988/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39988/tests/kraken/driver.html?testName=imaging-desaturate) 05:28:55 INFO - 2015-12-21 05:28:55,601 DEBUG : BROWSER_OUTPUT: RSS: Main: 165191680 05:28:55 INFO - 2015-12-21 05:28:55,601 DEBUG : BROWSER_OUTPUT: 05:28:58 INFO - 2015-12-21 05:28:58,312 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39988/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39988/tests/kraken/driver.html?testName=json-parse-financial) 05:28:58 INFO - 2015-12-21 05:28:58,885 DEBUG : BROWSER_OUTPUT: RSS: Main: 165490688 05:28:58 INFO - 2015-12-21 05:28:58,885 DEBUG : BROWSER_OUTPUT: 05:29:00 INFO - 2015-12-21 05:29:00,494 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39988/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39988/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:29:01 INFO - 2015-12-21 05:29:01,048 DEBUG : BROWSER_OUTPUT: RSS: Main: 179417088 05:29:01 INFO - 2015-12-21 05:29:01,048 DEBUG : BROWSER_OUTPUT: 05:29:02 INFO - 2015-12-21 05:29:02,850 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39988/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39988/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:29:03 INFO - 2015-12-21 05:29:03,452 DEBUG : BROWSER_OUTPUT: RSS: Main: 172740608 05:29:03 INFO - 2015-12-21 05:29:03,452 DEBUG : BROWSER_OUTPUT: 05:29:05 INFO - 2015-12-21 05:29:05,484 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39988/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39988/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:29:06 INFO - 2015-12-21 05:29:06,057 DEBUG : BROWSER_OUTPUT: RSS: Main: 182902784 05:29:06 INFO - 2015-12-21 05:29:06,058 DEBUG : BROWSER_OUTPUT: 05:29:08 INFO - 2015-12-21 05:29:08,460 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39988/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39988/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:29:09 INFO - 2015-12-21 05:29:09,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 190255104 05:29:09 INFO - 2015-12-21 05:29:09,041 DEBUG : BROWSER_OUTPUT: 05:29:11 INFO - 2015-12-21 05:29:11,617 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39988/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39988/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:29:12 INFO - 2015-12-21 05:29:12,184 DEBUG : BROWSER_OUTPUT: RSS: Main: 187498496 05:29:12 INFO - 2015-12-21 05:29:12,184 DEBUG : BROWSER_OUTPUT: 05:29:13 INFO - 2015-12-21 05:29:13,893 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39988/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39988/tests/kraken/driver.html?testName=ai-astar) 05:29:14 INFO - 2015-12-21 05:29:14,143 DEBUG : BROWSER_OUTPUT: RSS: Main: 245850112 05:29:14 INFO - 2015-12-21 05:29:14,143 DEBUG : BROWSER_OUTPUT: 05:29:14 INFO - 2015-12-21 05:29:14,143 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:29:14 INFO - 2015-12-21 05:29:14,144 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:29:14 INFO - 2015-12-21 05:29:14,144 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:29:14 INFO - 2015-12-21 05:29:14,144 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:29:14 INFO - 2015-12-21 05:29:14,144 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;112;104;111;111;113;100;111;111;116 05:29:14 INFO - 2015-12-21 05:29:14,144 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;124;149;171;129;147;146;123;158;123 05:29:14 INFO - 2015-12-21 05:29:14,144 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;160;160;162;159;160;161;160;160;161 05:29:14 INFO - 2015-12-21 05:29:14,144 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;84;92;71;71;72;90;94;71 05:29:14 INFO - 2015-12-21 05:29:14,144 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;94;139;92;93;93;138;93;92;139 05:29:14 INFO - 2015-12-21 05:29:14,145 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;110;109;109;109;109;109;110 05:29:14 INFO - 2015-12-21 05:29:14,145 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;144;144;145;144;145;144;144 05:29:14 INFO - 2015-12-21 05:29:14,145 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;96;96;95;96;95;95 05:29:14 INFO - 2015-12-21 05:29:14,145 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;60;61;61;61;62;61;72;59;59 05:29:14 INFO - 2015-12-21 05:29:14,145 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;67;67;67;66;67;67;66;70;66 05:29:14 INFO - 2015-12-21 05:29:14,145 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;85;82;84;84;83;82;84;85 05:29:14 INFO - 2015-12-21 05:29:14,145 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;131;123;122;122;113;116;122;117;122 05:29:14 INFO - 2015-12-21 05:29:14,146 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;143;151;156;152;142;151;153;146;143 05:29:14 INFO - 2015-12-21 05:29:14,146 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;68;68;67;67;67;68;68;67;66 05:29:14 INFO - 2015-12-21 05:29:14,146 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:29:14 INFO - 2015-12-21 05:29:14,146 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:29:14 INFO - 2015-12-21 05:29:14,146 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,905 05:29:14 INFO - 2015-12-21 05:29:14,146 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:29:14 INFO - 2015-12-21 05:29:14,146 DEBUG : BROWSER_OUTPUT: __startTimestamp1450704554141__endTimestamp 05:29:14 INFO - 2015-12-21 05:29:14,147 DEBUG : BROWSER_OUTPUT: 05:29:14 INFO - 2015-12-21 05:29:14,150 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:29:14 INFO - 2015-12-21 05:29:14,150 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:29:14 INFO - 2015-12-21 05:29:14,150 DEBUG : BROWSER_OUTPUT: 05:29:14 INFO - 2015-12-21 05:29:14,150 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:4.59 (4.1%) stddev-sans-first:4.86 05:29:14 INFO - 2015-12-21 05:29:14,151 DEBUG : BROWSER_OUTPUT: Values: 111.0 112.0 104.0 111.0 111.0 113.0 100.0 111.0 111.0 116.0 05:29:14 INFO - 2015-12-21 05:29:14,151 DEBUG : BROWSER_OUTPUT: 05:29:14 INFO - 2015-12-21 05:29:14,151 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.80 Median:147.50 stddev:16.46 (11.2%) stddev-sans-first:17.30 05:29:14 INFO - 2015-12-21 05:29:14,151 DEBUG : BROWSER_OUTPUT: Values: 148.0 124.0 149.0 171.0 129.0 147.0 146.0 123.0 158.0 123.0 05:29:14 INFO - 2015-12-21 05:29:14,151 DEBUG : BROWSER_OUTPUT: 05:29:14 INFO - 2015-12-21 05:29:14,151 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.70 Median:160.50 stddev:1.42 (0.9%) stddev-sans-first:0.87 05:29:14 INFO - 2015-12-21 05:29:14,151 DEBUG : BROWSER_OUTPUT: Values: 164.0 160.0 160.0 162.0 159.0 160.0 161.0 160.0 160.0 161.0 05:29:14 INFO - 2015-12-21 05:29:14,151 DEBUG : BROWSER_OUTPUT: 05:29:14 INFO - 2015-12-21 05:29:14,151 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.70 Median:78.00 stddev:10.04 (12.9%) stddev-sans-first:10.26 05:29:14 INFO - 2015-12-21 05:29:14,151 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 84.0 92.0 71.0 71.0 72.0 90.0 94.0 71.0 05:29:14 INFO - 2015-12-21 05:29:14,151 DEBUG : BROWSER_OUTPUT: 05:29:14 INFO - 2015-12-21 05:29:14,151 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.60 Median:93.00 stddev:22.14 (23.8%) stddev-sans-first:22.93 05:29:14 INFO - 2015-12-21 05:29:14,151 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 139.0 92.0 93.0 93.0 138.0 93.0 92.0 139.0 05:29:14 INFO - 2015-12-21 05:29:14,151 DEBUG : BROWSER_OUTPUT: 05:29:14 INFO - 2015-12-21 05:29:14,151 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 05:29:14 INFO - 2015-12-21 05:29:14,152 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 110.0 109.0 109.0 109.0 109.0 109.0 110.0 05:29:14 INFO - 2015-12-21 05:29:14,152 DEBUG : BROWSER_OUTPUT: 05:29:14 INFO - 2015-12-21 05:29:14,152 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:144.50 Median:145.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 05:29:14 INFO - 2015-12-21 05:29:14,152 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 144.0 144.0 145.0 144.0 145.0 144.0 144.0 05:29:14 INFO - 2015-12-21 05:29:14,152 DEBUG : BROWSER_OUTPUT: 05:29:14 INFO - 2015-12-21 05:29:14,152 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:29:14 INFO - 2015-12-21 05:29:14,152 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 05:29:14 INFO - 2015-12-21 05:29:14,152 DEBUG : BROWSER_OUTPUT: 05:29:14 INFO - 2015-12-21 05:29:14,152 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.70 Median:61.00 stddev:3.74 (6.1%) stddev-sans-first:3.96 05:29:14 INFO - 2015-12-21 05:29:14,152 DEBUG : BROWSER_OUTPUT: Values: 61.0 60.0 61.0 61.0 61.0 62.0 61.0 72.0 59.0 59.0 05:29:14 INFO - 2015-12-21 05:29:14,152 DEBUG : BROWSER_OUTPUT: 05:29:14 INFO - 2015-12-21 05:29:14,152 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:1.20 (1.8%) stddev-sans-first:1.22 05:29:14 INFO - 2015-12-21 05:29:14,152 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 67.0 67.0 66.0 67.0 67.0 66.0 70.0 66.0 05:29:14 INFO - 2015-12-21 05:29:14,152 DEBUG : BROWSER_OUTPUT: 05:29:14 INFO - 2015-12-21 05:29:14,152 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:1.14 (1.4%) stddev-sans-first:1.20 05:29:14 INFO - 2015-12-21 05:29:14,152 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 85.0 82.0 84.0 84.0 83.0 82.0 84.0 85.0 05:29:14 INFO - 2015-12-21 05:29:14,153 DEBUG : BROWSER_OUTPUT: 05:29:14 INFO - 2015-12-21 05:29:14,153 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.50 Median:122.00 stddev:5.02 (4.1%) stddev-sans-first:5.16 05:29:14 INFO - 2015-12-21 05:29:14,153 DEBUG : BROWSER_OUTPUT: Values: 117.0 131.0 123.0 122.0 122.0 113.0 116.0 122.0 117.0 122.0 05:29:14 INFO - 2015-12-21 05:29:14,153 DEBUG : BROWSER_OUTPUT: 05:29:14 INFO - 2015-12-21 05:29:14,153 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:151.00 stddev:5.26 (3.5%) stddev-sans-first:5.13 05:29:14 INFO - 2015-12-21 05:29:14,153 DEBUG : BROWSER_OUTPUT: Values: 142.0 143.0 151.0 156.0 152.0 142.0 151.0 153.0 146.0 143.0 05:29:14 INFO - 2015-12-21 05:29:14,153 DEBUG : BROWSER_OUTPUT: 05:29:14 INFO - 2015-12-21 05:29:14,153 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 05:29:14 INFO - 2015-12-21 05:29:14,153 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 67.0 67.0 67.0 68.0 68.0 67.0 66.0 05:29:14 INFO - 2015-12-21 05:29:14,153 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:29:14 INFO - 2015-12-21 05:29:14,153 DEBUG : BROWSER_OUTPUT: 05:29:14 INFO - 2015-12-21 05:29:14,967 INFO : Browser exited with error code: 0 05:29:15 INFO - 2015-12-21 05:29:15,169 INFO : Completed test kraken (00:00:59) 05:29:15 INFO - 2015-12-21 05:29:15,169 INFO : Starting test v8_7 05:29:15 INFO - 2015-12-21 05:29:15,169 DEBUG : operating with platform_type : linux_ 05:29:15 INFO - 2015-12-21 05:29:15,169 INFO : Initialising browser for v8_7 test... 05:29:15 INFO - 2015-12-21 05:29:15,175 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsr53o6/profile http://localhost:39988/getInfo.html 05:29:19 INFO - 2015-12-21 05:29:19,345 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 05:29:19 INFO - 2015-12-21 05:29:19,361 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:29:19 INFO - 2015-12-21 05:29:19,361 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:29:19 INFO - 2015-12-21 05:29:19,361 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:29:19 INFO - 2015-12-21 05:29:19,361 DEBUG : BROWSER_OUTPUT: __metrics 05:29:19 INFO - 2015-12-21 05:29:19,478 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:29:19 INFO - 2015-12-21 05:29:19,519 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:29:20 INFO - 2015-12-21 05:29:20,745 INFO : Browser initialized. 05:29:20 INFO - 2015-12-21 05:29:20,746 INFO : Running cycle 1/1 for v8_7 test... 05:29:20 INFO - 2015-12-21 05:29:20,746 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsr53o6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:29:32 INFO - 2015-12-21 05:29:32,499 DEBUG : BROWSER_OUTPUT: RSS: Main: 150044672 05:29:32 INFO - 2015-12-21 05:29:32,499 DEBUG : BROWSER_OUTPUT: 05:29:53 INFO - 2015-12-21 05:29:53,922 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39988/tests/v8_7/run.html (next: http://localhost:39988/tests/v8_7/run.html) 05:29:54 INFO - 2015-12-21 05:29:54,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 595197952 05:29:54 INFO - 2015-12-21 05:29:54,167 DEBUG : BROWSER_OUTPUT: 05:29:54 INFO - 2015-12-21 05:29:54,169 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:29:54 INFO - 2015-12-21 05:29:54,169 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:29:54 INFO - 2015-12-21 05:29:54,169 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:29:54 INFO - 2015-12-21 05:29:54,169 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:29:54 INFO - 2015-12-21 05:29:54,169 DEBUG : BROWSER_OUTPUT: |0;Richards;165.56291390728478 05:29:54 INFO - 2015-12-21 05:29:54,169 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;189.000189000189 05:29:54 INFO - 2015-12-21 05:29:54,170 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.3296089385475 05:29:54 INFO - 2015-12-21 05:29:54,170 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 05:29:54 INFO - 2015-12-21 05:29:54,170 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1102.5358324145534 05:29:54 INFO - 2015-12-21 05:29:54,170 DEBUG : BROWSER_OUTPUT: |5;Earley;780.2026500389711 05:29:54 INFO - 2015-12-21 05:29:54,170 DEBUG : BROWSER_OUTPUT: |6;Boyer;12444.444444444445 05:29:54 INFO - 2015-12-21 05:29:54,170 DEBUG : BROWSER_OUTPUT: |7;RegExp;26000 05:29:54 INFO - 2015-12-21 05:29:54,170 DEBUG : BROWSER_OUTPUT: |8;Splay;679.8096532970768 05:29:54 INFO - 2015-12-21 05:29:54,171 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 05:29:54 INFO - 2015-12-21 05:29:54,171 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:29:54 INFO - 2015-12-21 05:29:54,171 DEBUG : BROWSER_OUTPUT: __startTimestamp1450704594168__endTimestamp 05:29:54 INFO - 2015-12-21 05:29:54,171 DEBUG : BROWSER_OUTPUT: 05:29:54 INFO - 2015-12-21 05:29:54,171 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:29:54 INFO - 2015-12-21 05:29:54,171 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:29:54 INFO - 2015-12-21 05:29:54,171 DEBUG : BROWSER_OUTPUT: 05:29:54 INFO - 2015-12-21 05:29:54,171 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.56 Median:165.56 stddev:0.00 (0.0%) 05:29:54 INFO - 2015-12-21 05:29:54,171 DEBUG : BROWSER_OUTPUT: Values: 165.6 05:29:54 INFO - 2015-12-21 05:29:54,171 DEBUG : BROWSER_OUTPUT: 05:29:54 INFO - 2015-12-21 05:29:54,172 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:189.00 Median:189.00 stddev:0.00 (0.0%) 05:29:54 INFO - 2015-12-21 05:29:54,173 DEBUG : BROWSER_OUTPUT: Values: 189.0 05:29:54 INFO - 2015-12-21 05:29:54,173 DEBUG : BROWSER_OUTPUT: 05:29:54 INFO - 2015-12-21 05:29:54,173 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.33 Median:279.33 stddev:0.00 (0.0%) 05:29:54 INFO - 2015-12-21 05:29:54,173 DEBUG : BROWSER_OUTPUT: Values: 279.3 05:29:54 INFO - 2015-12-21 05:29:54,173 DEBUG : BROWSER_OUTPUT: 05:29:54 INFO - 2015-12-21 05:29:54,173 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 05:29:54 INFO - 2015-12-21 05:29:54,173 DEBUG : BROWSER_OUTPUT: Values: 5186.5 05:29:54 INFO - 2015-12-21 05:29:54,173 DEBUG : BROWSER_OUTPUT: 05:29:54 INFO - 2015-12-21 05:29:54,173 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1102.54 Median:1102.54 stddev:0.00 (0.0%) 05:29:54 INFO - 2015-12-21 05:29:54,173 DEBUG : BROWSER_OUTPUT: Values: 1102.5 05:29:54 INFO - 2015-12-21 05:29:54,173 DEBUG : BROWSER_OUTPUT: 05:29:54 INFO - 2015-12-21 05:29:54,173 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:780.20 Median:780.20 stddev:0.00 (0.0%) 05:29:54 INFO - 2015-12-21 05:29:54,173 DEBUG : BROWSER_OUTPUT: Values: 780.2 05:29:54 INFO - 2015-12-21 05:29:54,173 DEBUG : BROWSER_OUTPUT: 05:29:54 INFO - 2015-12-21 05:29:54,173 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12444.44 Median:12444.44 stddev:0.00 (0.0%) 05:29:54 INFO - 2015-12-21 05:29:54,174 DEBUG : BROWSER_OUTPUT: Values: 12444.4 05:29:54 INFO - 2015-12-21 05:29:54,174 DEBUG : BROWSER_OUTPUT: 05:29:54 INFO - 2015-12-21 05:29:54,174 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26000.00 Median:26000.00 stddev:0.00 (0.0%) 05:29:54 INFO - 2015-12-21 05:29:54,174 DEBUG : BROWSER_OUTPUT: Values: 26000.0 05:29:54 INFO - 2015-12-21 05:29:54,174 DEBUG : BROWSER_OUTPUT: 05:29:54 INFO - 2015-12-21 05:29:54,174 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:679.81 Median:679.81 stddev:0.00 (0.0%) 05:29:54 INFO - 2015-12-21 05:29:54,174 DEBUG : BROWSER_OUTPUT: Values: 679.8 05:29:54 INFO - 2015-12-21 05:29:54,174 DEBUG : BROWSER_OUTPUT: 05:29:54 INFO - 2015-12-21 05:29:54,174 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 05:29:54 INFO - 2015-12-21 05:29:54,175 DEBUG : BROWSER_OUTPUT: Values: 4835.7 05:29:54 INFO - 2015-12-21 05:29:54,175 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:29:54 INFO - 2015-12-21 05:29:54,175 DEBUG : BROWSER_OUTPUT: 05:29:54 INFO - 2015-12-21 05:29:54,979 INFO : Browser exited with error code: 0 05:29:54 INFO - 2015-12-21 05:29:54,991 INFO : Completed test v8_7 (00:00:39) 05:29:55 INFO - 2015-12-21 05:29:55,158 INFO : Completed test suite (00:20:12) 05:29:55 INFO - 2015-12-21 05:29:55,158 DEBUG : Working with test: dromaeo_css 05:29:55 INFO - 2015-12-21 05:29:55,159 DEBUG : Generating results file: dromaeo_css 05:29:55 INFO - 2015-12-21 05:29:55,160 DEBUG : Working with test: kraken 05:29:55 INFO - 2015-12-21 05:29:55,160 DEBUG : Generating results file: kraken 05:29:55 INFO - 2015-12-21 05:29:55,160 INFO : javascript benchmark 05:29:55 INFO - 2015-12-21 05:29:55,160 DEBUG : Working with test: v8_7 05:29:55 INFO - 2015-12-21 05:29:55,160 DEBUG : Generating results file: v8_7 05:29:55 INFO - 2015-12-21 05:29:55,161 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:29:55 INFO - 2015-12-21 05:29:55,220 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 05:29:55 INFO - 2015-12-21 05:29:55,220 DEBUG : process_Request line: dromaeo_css 6842.23 graph.html#tests=[[72,64,35]] 05:29:55 INFO - 2015-12-21 05:29:55,220 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:29:55 INFO - 2015-12-21 05:29:55,248 DEBUG : process_Request line: kraken 1495.10 graph.html#tests=[[232,64,35]] 05:29:55 INFO - 2015-12-21 05:29:55,248 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:29:55 INFO - 2015-12-21 05:29:55,287 DEBUG : process_Request line: v8_7 20783.47 graph.html#tests=[[230,64,35]] 05:29:55 INFO - 2015-12-21 05:29:55,289 INFO : javascript benchmark 05:29:55 INFO - 2015-12-21 05:29:55,292 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3110.953335699965, 3156.447621666208, 3194.3132226571283, 3205.3108581654956, 3226.2740883301253, 5017.749112544368, 5143.125668636331, 5181.145111056671, 5228.797376603384, 5289.233061206128, 5091.9236211456855, 5180.8704782380455, 5208.166693329068, 5274.129768588188, 5283.8150664726745, 4766.880827979311, 4768.713877167373, 4792.448868380128, 4808.663393562435, 4855.126077306083, 4866.31871537985, 4896.045271172123, 4901.558859702626, 4902.264660300948, 4976.129177393942, 4654.185517534418, 4685.765711714418, 4721.905561888777, 4780.139574876521, 4796.712197268175, 4837.540433658832, 4862.367892173995, 4868.391451068616, 4870.245112007645, 4877.365942427497, 4834.129856625806, 4834.516548345173, 4840.298156767284, 4851.175300198975, 4857.247126695368, 4937.901241975176, 4977.352944117278, 5062.924056139161, 5141.562967147797, 5147.48525147486, 5657.830265092054, 5658.575606829463, 5659.377468478464, 5666.716664166816, 5670.432956704338, 5432.91850622241, 5691.4024027476935, 5695.088785794253, 5697.515711164556, 5713.14302854571, 5173.249878767558, 5210.218467229908, 5266.578673706094, 5340.652857564323, 5366.570674346043, 5823.097419899922, 5826.621269617462, 5840.386759390288, 5849.5027922626205, 5850.268716410449, 5346.812861549827, 5630.915536266959, 5652.0, 5652.802151924745, 5657.094864821609, 5536.390996990328, 5584.301962254718, 5596.58025648078, 5599.888002239933, 5642.351129620064, 5591.440855914458, 5625.240592520039, 5645.5483561314995, 5646.85882852932, 5660.2075709400715, 5433.103537916279, 5596.384397716248, 5597.524210442158, 5604.8038318658655, 5618.6628802272, 4359.106383191438, 4366.978165109154, 4383.539728328544, 4466.419365482467, 4481.663875209372, 3895.2988462076532, 3908.687305015592, 3910.081130934228, 3916.6279203475624, 3935.311320518955, 5336.546393556591, 5339.86650333737, 5346.5455436287575, 5351.09031464652, 5351.732413379315, 5435.483629055233, 5564.0, 5566.276384070045, 5623.8594035149445, 5706.400827913009, 5279.762410691528, 5280.234366016906, 5286.207068939613, 5287.048331300326, 5291.629585929025, 4856.077345304381, 4875.756212189376, 4879.170541008037, 4882.170031094723, 4929.704217746947, 5548.944510554843, 5621.971890140605, 5642.915356269659, 5699.344575373802, 5831.125331200354, 5603.32760068778, 5668.064769313017, 5669.801556945487, 5670.744816483186, 5687.090065589486, 5713.685747283939, 5772.134179873053, 5774.364819869895, 5778.451047150514, 5780.21967034445, 5372.677639341652, 5477.45225477465, 5479.863003424946, 5546.168074788814, 5661.207430959586, 5642.71786410686, 5691.117876729114, 5705.315362156568, 5716.456936591017, 5746.367899531132, 5570.832875013756, 5572.080606699849, 5581.804636837691, 5583.916241256303, 5584.190292407497, 5276.0, 5360.222767698584, 5375.139977603565, 5486.149646804752, 5592.049351610155, 5464.071107911744, 5466.180072989084, 5467.72661366938, 5470.480304371078, 5488.121900495901, 5542.251796007648, 5563.248961390161, 5580.135079062752, 5581.051221292471, 5637.633553818989, 5339.279197308314, 5341.946580534301, 5387.730613469233, 5434.510894019557, 5444.754986025559], "unit": "score", "name": "dojo.html", "value": 5198.312696603526}, {"lowerIsBetter": false, "replicates": [560.9747561359738, 565.183310116881, 567.0586825869058, 589.4047012517357, 592.8636413624863, 29482.0, 37597.0, 38165.42751858725, 38188.99999999996, 38203.42694859579, 41511.58488415123, 41898.16203675925, 41933.58066419335, 41968.0, 41993.7900310498, 7498.175200727916, 7648.349890259306, 8746.344024198195, 8930.821383572356, 8937.865932011026, 7707.229277072304, 9987.950060249688, 10208.285420020564, 10262.948685256562, 10280.588776448933, 10101.54543045561, 10183.643572474964, 10189.388636681786, 10189.745256368577, 10191.388516688985, 7731.536107833548, 7985.281324680748, 10078.395296282246, 10163.898361016369, 10183.796324073477, 7668.118166410878, 10413.166946644325, 10625.5218515167, 10666.573337066508, 10680.893191068146, 38799.80600096982, 39093.41359879604, 39093.60906390928, 39171.804140979395, 39222.0, 3133.780635355526, 3162.557241986101, 3185.824779637119, 3240.8865689700747, 3372.274960883422, 29815.70184298151, 30003.549946750816, 30162.84918575415, 30231.0, 30985.690143098505, 3822.808859557011, 3904.8438062477467, 3928.9607103929166, 3976.602339766029, 4116.403121547389, 261667.0, 265316.0, 265513.0, 265834.67082664656, 266215.0, 53584.732076339365, 54244.18633720497, 58145.41854581485, 64478.0, 65684.0, 58148.0, 58661.70669146627, 58751.11873321904, 58797.118043229384, 58977.70511147503, 13983.0, 14070.718585628434, 14147.43410263578, 14169.149851008973, 14179.716405671828, 10391.0, 10413.0, 10420.947895260475, 10477.790444191074, 10480.895191048145, 19447.902760486108, 19932.0, 20054.799452005584, 20137.0, 20154.093065812074, 7730.806729831799, 7868.84262314762, 7976.122626511079, 7990.320822730133, 7998.48009879356, 862.6376921692904, 939.9295052871062, 954.289054654287, 1004.9346792458467, 1053.5891002509027, 31900.521492177635, 33826.32347353089, 33932.49101263483, 34017.0, 34315.313693726486, 998.001998001998, 1012.5038731021893, 1041.2294901772784, 1052.9262951593469, 1129.983015286249, 15113.47102851395, 15163.924180379028, 15174.696506069817, 15270.31283592241, 15348.693026139415, 379353.0, 383866.0, 385413.0, 385759.0, 386605.0, 53796.193057104174, 54172.0, 54184.45815541873, 54285.72857135689, 54292.72853635706, 1238.1642391385778, 1306.1183701001976, 1313.9540116096082, 1353.086666500128, 1354.5800801751489, 26367.0, 28493.430131397672, 28988.27529311784, 29454.263643409085, 30936.071917842502, 47683.76158119187, 48643.0, 48846.26730599115, 48915.266271005254, 49012.0, 288660.0, 290636.0, 290788.0, 291769.0, 292602.0, 27519.44961100727, 27566.310842229104, 27726.168214953585, 32223.0, 32611.836940816094, 37891.62108378991, 37895.0, 37909.81045094757, 44494.332585010605, 44950.77524612356, 28601.42797144087, 30224.539567739856, 31965.520517191795, 32454.188645284055, 33920.321593568486, 34346.14134646654, 34364.48453273153, 40485.0, 41516.79241603773, 41628.37557436701, 36545.634543654225, 36653.63346366502, 36853.44719829151, 37699.0, 38626.42060369041, 31264.531032034993, 33004.0, 33070.33859322752, 33641.3271734559, 33764.3247135051, 25203.495930081663, 25317.987280508572, 25376.238712838644, 25527.234182974542, 25685.229443116736], "unit": "score", "name": "ext.html", "value": 18653.321204400378}, {"lowerIsBetter": false, "replicates": [353.71702637889683, 353.77712041413923, 359.6978538028056, 362.84216365880843, 363.84536571956926, 13986.300684965761, 14071.0, 16931.830681693194, 17416.303347866087, 18116.728249076274, 14774.556763297118, 14824.407023719064, 17173.82826171738, 17471.563210919703, 17536.736948945745, 5281.471852814717, 5367.731613419333, 5384.40771515133, 5386.730663466811, 5387.272718183054, 4025.81883815229, 4124.31948728461, 4815.277708343741, 5895.646261224319, 5935.198748169007, 4103.692223083266, 5727.3699893011735, 5922.111683247525, 5929.169916211734, 5932.644041357511, 5729.971350143264, 5841.299044114691, 5841.88316233673, 5847.093700476433, 5877.970610146965, 5192.3769147702515, 5192.662476938987, 5195.038917800219, 5196.220566914955, 5199.376074871002, 20543.28098516545, 20873.68689469644, 21177.364679059654, 21444.892775536024, 21464.35606931779, 2109.4093653776968, 2209.5912256232486, 2240.574290884743, 2265.8980345884474, 2311.3643747969277, 12848.329717136807, 13171.802422963663, 13190.34048297591, 13362.465501380031, 13573.321333933363, 1724.7499112628725, 1735.8264173582668, 1790.588164722108, 1826.2786199451143, 1882.190658017052, 58810.11784823231, 59949.0, 60840.39159608436, 61162.38837611611, 63317.68341158311, 9987.151092157103, 10268.948655256676, 10274.691759247235, 10318.845217321747, 10319.48402579868, 13368.064235503422, 13391.933040334736, 13483.31458567679, 13568.457261709422, 13573.457061717618, 6986.406155476841, 6994.720211191496, 7000.229974702778, 7043.718251269995, 7073.257307982691, 6554.4756419487285, 6576.934230657632, 6585.637789921505, 6636.601803891782, 6648.867022659617, 4369.453818272716, 4409.49290831552, 4433.512313645497, 4457.866264012085, 4482.820687172477, 1685.536477468706, 1750.0812073661175, 1782.9019403932907, 1785.7410525579694, 1820.8998505082347, 873.5370253765515, 898.645035211101, 900.504722402676, 940.9153176214037, 980.9950950245203, 16415.507534773977, 17325.56686082858, 17499.38752143669, 17735.37926172578, 17816.91091544534, 867.6789587852535, 897.4435849773182, 912.0833562269876, 941.110650435332, 976.3995142987012, 9831.705048848404, 10331.845022324671, 10337.9483102584, 10462.372257664565, 10635.627753028606, 525108.0, 533488.9953301407, 534098.0, 550722.0, 552648.0, 81640.59179704063, 83322.0, 84060.57969710235, 84550.57724711337, 84681.0, 1145.0782120392996, 1161.0769438296575, 1166.5158959031908, 1169.6607983684637, 1172.0330727150135, 15884.920575397511, 15895.364185432452, 15960.441384551485, 16069.91965040214, 16337.101459419371, 35001.124971875906, 35843.28313433769, 36537.63462365342, 37370.0, 37443.81278093592, 40805.59194408018, 42277.57722422737, 42959.14081718286, 43351.0, 43540.78229608832, 9536.380135291462, 9714.659986900424, 9721.416714997124, 9796.21630269591, 9820.4107753535, 16898.577535561708, 16979.405720799714, 17972.19125139346, 18471.0, 18567.25730970746, 11339.886601134212, 11560.364179969845, 11748.58879939198, 13831.100978436369, 14368.209748463516, 13365.933170334087, 14004.649883752987, 14173.858261417667, 14396.640083997983, 14397.280135992949, 14860.331285091981, 15036.699266014837, 15450.9227453862, 15779.526614201592, 15788.0, 9716.174125199437, 9837.360571562825, 9872.0, 10060.496975151067, 10063.798724025624, 10087.949560252151, 10187.745306367104, 10269.664943557289, 15121.395144194548, 15330.0], "unit": "score", "name": "jquery.html", "value": 8915.64078826983}, {"lowerIsBetter": false, "replicates": [1316.5457917018637, 1611.790467239259, 1662.3184494357315, 1673.0380031481898, 1707.8292170782922, 5998.640081595102, 6588.209414870216, 6742.52802303839, 6800.421964133042, 6802.319768023195, 6788.490863185269, 6917.654117294128, 6934.410575101122, 6937.271586483423, 6942.583444993291, 1839.2918726290407, 1875.165551329659, 2063.865848719836, 2091.8012788785118, 2099.88450635215, 2137.6152292587326, 2143.132031527226, 2143.4212762554102, 2146.0450099705636, 2146.7101941237966, 2072.554400803827, 2107.683847422891, 2124.0654112190664, 2124.5644642848256, 2127.1597718901025, 2114.2283066680707, 2116.947076323089, 2124.3414541492034, 2136.1241890824845, 2138.8395870309787, 2080.916763329465, 2084.5622419291967, 2099.8950052497466, 2110.9366718998454, 2111.6938043983537, 6846.178458584952, 6941.965290173567, 6952.339527744856, 6958.65206739661, 6960.895586566155, 4130.091379896448, 4230.090530535918, 4231.851885184004, 4240.915181696349, 4244.3209086546, 2714.484247992875, 2752.967637136074, 2769.404578015716, 2790.9581356279673, 2804.032608749978, 918.0360621347559, 933.5938866593053, 935.2144198872979, 937.3532262738688, 941.5010044676333, 9375.390599611004, 9377.202937750299, 9396.953015234949, 9399.0, 9410.388324758937, 3802.049487628093, 3814.2752876953846, 3853.3641949078087, 3884.6503814656817, 3887.6501114899793, 8093.392995525359, 8125.024997000398, 8131.79670508242, 8142.185781421929, 8146.022477302761, 4299.634531064832, 4299.78501074945, 4302.763348015889, 4315.741055536678, 4326.870193894189, 3932.174243408859, 3953.7825419601622, 3964.8810535683974, 3965.306071437487, 3966.0679740261016, 3039.8480075996113, 3095.613048368954, 3163.3040731039596, 3217.2117831131523, 3274.3287626036604, 1026.3226270661328, 1040.6773900090996, 1043.1654676258963, 1048.6015314180563, 1052.952617132231, 1017.2523195451338, 1023.0690072034413, 1025.5385076715509, 1151.1366475143643, 1301.7526669932683, 6635.104260924713, 6660.83347916306, 6698.263191048981, 6703.195616526048, 6705.430038446787, 1097.0729733375285, 1153.3425947210178, 1163.813789793629, 1168.67861338131, 1187.7825229140028, 5330.92003619946, 5332.6000549958135, 5354.143337066129, 5371.3822910365025, 5379.1393377059485, 7976.601169941479, 8228.958855205685, 8293.419460637697, 8397.538135402612, 8417.284530814826, 8220.753377398687, 8289.58552072394, 8293.875591866126, 8329.08380078191, 8335.416520843482, 6479.254885688206, 6550.868982620321, 6601.70292336846, 6653.0, 6666.533342666064, 6454.064160696579, 6454.322296158835, 6455.4512866406885, 6461.967690161519, 6462.159919210472, 7230.783076507713, 7362.889556656762, 7383.2985866342615, 7391.186969433251, 7482.139553951148, 7427.665755041145, 7576.356009739234, 7714.807129821575, 7739.613019349123, 7742.070951485633, 6160.229971253593, 6177.62934223948, 6215.689215539114, 6220.409061139185, 6221.3156552778255, 6010.128531363015, 6116.052011938156, 6514.9348506514325, 6659.367360100783, 6908.965455172692, 6270.592411493239, 6332.620042797447, 6465.2564955030775, 6533.216014078341, 6555.80332590023, 6271.090691849748, 6364.204474440695, 6369.522285828489, 6460.257070436772, 6466.0947467355545, 6261.24865016201, 6267.310595834363, 6271.4669253114, 6302.180716506825, 6467.450266727381, 5946.524278057832, 5972.34304226526, 5992.400759923973, 6007.158997740233, 6012.6392416455155, 5829.15477255804, 6088.665123418255, 6103.389661033861, 6113.388661133851, 6120.785772497941], "unit": "score", "name": "mootools.html", "value": 4086.5843571275227}, {"lowerIsBetter": false, "replicates": [328.29744347097215, 336.94271973764455, 352.0951155530288, 352.65792181583885, 355.69232613789046, 5909.763609455622, 5919.37846526115, 5949.851253718659, 5979.342272350038, 5997.220361353029, 5877.67672777997, 5886.440788125121, 5888.0, 5898.88202235955, 5906.202662640542, 4644.140833945714, 4645.187092258858, 4650.046740418223, 4650.348951146825, 4655.7439340836245, 4404.427424434835, 4551.5676010778925, 4570.154521413532, 4573.977130114361, 4574.931376029363, 4550.271956486963, 4554.567316104964, 4563.726176429408, 4565.201089809287, 4568.086382723452, 4350.347447882811, 4392.143532011259, 4427.026054268056, 4556.157110934471, 4567.862964111066, 3962.4254483100076, 3984.063745019918, 3985.5416627087966, 3992.900177495557, 4000.4799376081214, 5579.7489112990015, 5586.497215250606, 5607.607467477278, 5618.381977982419, 5637.915431268534, 5051.873703157414, 5145.6398052136365, 5164.147915593922, 5292.68243905363, 5293.550048245904, 6228.096925945758, 6271.466925311354, 6287.434130928193, 6292.937070629281, 6310.2427708674795, 4387.561243875587, 4454.554544545552, 4455.643548516111, 4458.3535387368975, 4459.219636563588, 6380.872382552323, 6478.578892371981, 6536.738530458776, 6548.738050477975, 6560.671966401661, 4511.390962220124, 4541.500434952152, 4544.431946006749, 4546.568076032771, 4548.11311794197, 4604.493505714368, 4604.746738929391, 4605.792739326738, 4607.792649330788, 4608.861734147914, 5300.257963885059, 5307.681539107666, 5313.468653134656, 5314.7608357624, 5316.840494785162, 6188.1027251048345, 6341.239051313872, 6344.777932772331, 6348.555601107971, 6390.712417941204, 1598.8081430228447, 1624.301550333368, 1627.593101724569, 1628.3161072349642, 1633.2976819967528, 1053.947302634865, 1055.5302890213782, 1066.4827558634056, 1081.2215205052507, 1115.0132133062298, 6071.392860713893, 6073.5748497604745, 6076.088586712029, 6079.209702738615, 6083.7870674526175, 6526.706298216592, 6527.902081468782, 6528.183977002875, 6531.118299029666, 6536.379043990813, 5964.950473495115, 6057.878842423215, 6070.2108725865355, 6077.3314935357075, 6078.088286757022, 3436.3127374525193, 3520.2959408118477, 3539.4513850352723, 3544.2734239480847, 3547.7161827053774, 6626.304238055031, 6627.86744265112, 6631.635260060646, 6638.5684930479365, 6646.767363142363, 6467.385598368148, 6662.0, 6702.128723265944, 6709.765158219537, 6712.899306510406, 6125.4487096160665, 6548.9017664735065, 6605.900911486331, 6697.296783837822, 6727.461803055841, 6630.0, 6630.602163870183, 6637.734490620321, 6639.336066393322, 6641.634710090992, 6541.542092053701, 6546.214454265519, 6551.770688025897, 6557.180352455943, 6557.442617377576, 6593.340665933369, 6704.564203326768, 6712.127423434922, 6715.832104197434, 6722.529422940347, 4491.528389519053, 4492.2587773018395, 4494.0, 4494.820207191807, 4495.640348772025, 6611.07444957716, 6614.801555953329, 6619.635920024252, 6625.768098116543, 6629.867402652017, 6279.937200627935, 6455.3221911700475, 6458.644774537445, 6461.996780997905, 6464.676766161767, 6369.617822930639, 6419.550631455753, 6430.1319321892815, 6437.485001199986, 6446.323136070832, 6306.211723534559, 6315.494760419064, 6316.494680425647, 6320.652364120017, 6329.588576742497, 6269.592476489013, 6449.484041276781, 6480.384363485461, 6483.319251478527, 6498.740050397932, 6327.810165695037, 6330.683465826598, 6332.873342533216, 6335.1130841683125, 6341.0], "unit": "score", "name": "prototype.html", "value": 4785.319627987252}, {"lowerIsBetter": false, "replicates": [735.8896165575163, 744.2260049548466, 763.6792547130208, 767.4052609227848, 830.3066939105846, 13379.331033448325, 13805.861941380583, 13820.378082986264, 13822.723545529096, 13823.308834558282, 11328.546858125665, 11404.258723182988, 11417.200795944287, 11434.54261829528, 11445.02717269031, 662.241733215468, 667.9532432729711, 765.402985671176, 788.8304014636852, 799.220759759233, 808.8018435483315, 810.307187354812, 815.7348861619968, 816.7876352148454, 817.464560712734, 841.5581819544757, 849.1762989899787, 850.7022542110243, 851.0680804519042, 851.1573542193215, 688.8518968421788, 693.8612277544511, 826.1655727715021, 840.5671079394117, 844.5270648436895, 622.8691974685322, 624.1012941364421, 624.6096189881324, 625.6590158363703, 626.1640709652619, 12977.091603587753, 13101.737965240736, 13130.671733206651, 13164.6708832279, 13213.405396757073, 11660.883391166064, 12216.816747748702, 12242.143049986504, 12304.07719421038, 12370.381480925918, 10217.0, 10270.435126068063, 10308.948455257676, 10352.741181470448, 10558.726418596798, 3608.566971963381, 3610.963890361089, 3713.5543734752005, 3715.5912849586525, 3717.6839968602703, 44613.77693111546, 44743.105137897386, 44812.3278150828, 44818.77590612059, 44885.10229795386, 9854.655087071918, 10060.144887684628, 10217.18262538995, 10312.793744125076, 10488.423136727553, 17445.0, 17487.38794142199, 17532.29870805179, 17544.56138596545, 17605.911970440065, 7502.099748030271, 7560.773176804704, 7611.961940190264, 7779.961100194463, 7819.609019549, 3997.2205419942834, 4129.463169787969, 4180.602842729936, 4202.348635961431, 4308.332208507686, 2923.9707602924123, 2956.334824664433, 2965.332800119999, 2966.3770608172094, 2976.1071678496364, 507.7664274433728, 527.736131934033, 530.6471196654181, 536.4769349883832, 540.3299908113911, 545.9945400546023, 590.630855715178, 602.2020822410236, 641.1344684675651, 647.9967600162063, 8657.567121643893, 8700.564971751388, 8895.955520222358, 8907.495258528446, 9132.81734365309, 542.3275138827825, 609.5276160975279, 624.2353117431202, 628.7265039707742, 629.8929182039064, 4058.9797051014557, 4217.304144816132, 4258.552851950562, 4354.53215646864, 4376.978115109404, 51741.0, 52924.735376322875, 52981.47018529842, 53337.1999420009, 54666.72666636641, 51060.744696276284, 51190.74404627953, 51566.0, 51612.74193629008, 51959.74020129875, 45312.546874531494, 45353.77323113364, 45565.54434455613, 45830.0, 45974.0, 7584.1788118683, 7604.5437273763755, 7801.882971755314, 7938.6030698466, 8003.279704826594, 33631.831840841616, 34371.656283436845, 34900.127496812784, 35027.299454010266, 35332.82333588316, 43170.352444713986, 44346.556534435535, 44407.111857762015, 44790.3281450785, 45117.774411127735, 9658.275629327689, 9760.316777825768, 9882.4564648945, 10139.188864890939, 10188.694339169837, 10610.310329828537, 10832.67501974942, 10869.836952445878, 11102.389368584805, 11449.370284634426, 10291.258283401368, 10399.740006499898, 10660.84008739885, 10922.235443518877, 10936.617218397318, 10686.57253709843, 10714.946425267824, 10801.135909127408, 11048.613298534834, 11172.888271117185, 9729.416235025921, 9839.557219925264, 9858.704238872846, 10150.086492215736, 10165.644202452879, 8920.509371984344, 8925.285977121684, 9142.314326425678, 9266.629334826532, 9353.896877731067, 8559.979791275606, 8827.69103081389, 9236.399634023766, 9268.675596354095, 9333.906660933304], "unit": "score", "name": "yui.html", "value": 6068.795396945875}], "name": "dromaeo_css", "value": 6842.236082132736}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 104.0, 111.0, 111.0, 113.0, 100.0, 111.0, 111.0, 116.0], "unit": "score", "name": "ai-astar", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 124.0, 149.0, 171.0, 129.0, 147.0, 146.0, 123.0, 158.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 141.8}, {"lowerIsBetter": true, "replicates": [164.0, 160.0, 160.0, 162.0, 159.0, 160.0, 161.0, 160.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 84.0, 92.0, 71.0, 71.0, 72.0, 90.0, 94.0, 71.0], "unit": "score", "name": "audio-fft", "value": 78.7}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 139.0, 92.0, 93.0, 93.0, 138.0, 93.0, 92.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 106.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 144.0, 144.0, 145.0, 144.0, 145.0, 144.0, 144.0], "unit": "score", "name": "imaging-darkroom", "value": 144.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [61.0, 60.0, 61.0, 61.0, 61.0, 62.0, 61.0, 72.0, 59.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 61.7}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 67.0, 66.0, 67.0, 67.0, 66.0, 70.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.9}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 85.0, 82.0, 84.0, 84.0, 83.0, 82.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [117.0, 131.0, 123.0, 122.0, 122.0, 113.0, 116.0, 122.0, 117.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.5}, {"lowerIsBetter": true, "replicates": [142.0, 143.0, 151.0, 156.0, 152.0, 142.0, 151.0, 153.0, 146.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 67.0, 67.0, 67.0, 68.0, 68.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1495.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.56291390728478], "unit": "score", "name": "Richards", "value": 213.2240799999999}, {"lowerIsBetter": false, "replicates": [189.000189000189], "unit": "score", "name": "DeltaBlue", "value": 349.8303379999999}, {"lowerIsBetter": false, "replicates": [279.3296089385475], "unit": "score", "name": "Encrypt", "value": 952.9279799999998}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1102.5358324145534], "unit": "score", "name": "RayTrace", "value": 671.170023}, {"lowerIsBetter": false, "replicates": [780.2026500389711], "unit": "score", "name": "Earley", "value": 854.2178111888112}, {"lowerIsBetter": false, "replicates": [12444.444444444445], "unit": "score", "name": "Boyer", "value": 53.555062500000005}, {"lowerIsBetter": false, "replicates": [26000.0], "unit": "score", "name": "RegExp", "value": 35.037884615384634}, {"lowerIsBetter": false, "replicates": [679.8096532970768], "unit": "score", "name": "Splay", "value": 119.87326099999996}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20783.46528527257}]} 05:29:55 INFO - RETURN: dromaeo_css: 6842.23 05:29:55 INFO - RETURN: kraken: 1495.10 05:29:55 INFO - RETURN: v8_7: 20783.47 05:29:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20783.47"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1495.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6842.23"}}} 05:29:55 INFO - Return code: 0 05:29:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:29:55 ERROR - # TBPL SUCCESS # 05:29:55 INFO - Running post-action listener: _resource_record_post_action 05:29:55 INFO - Running post-run listener: _resource_record_post_run 05:29:56 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 28672; Write bytes: 556552192; Read time: 164; Write time: 539072 05:29:56 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234475520; Read time: 0; Write time: 346520 05:29:56 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 28672; Write bytes: 322076672; Read time: 164; Write time: 192552 05:29:56 INFO - Running post-run listener: _upload_blobber_files 05:29:56 INFO - Blob upload gear active. 05:29:56 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:29:56 INFO - Copying logs to upload dir... 05:29:56 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1272.259397 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-21 05:29:56.150561) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-21 05:29:56.153746) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450703322.589020-883333102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/XSDTTqG9TySmHlfwaasy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009791 build_url: 'https://queue.taskcluster.net/v1/task/XSDTTqG9TySmHlfwaasy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-21 05:29:56.207403) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:29:56.207745) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1450703322.589020-883333102 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:29:56.258870) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 05:29:56.259619) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 05:29:56.260425) ========= ========= Total master_lag: 0.21 =========