builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1456199777.89 results: success (0) buildid: 20160222173020 builduid: 4aff06f3c57741efa11e52540d2bb636 revision: 56ed0ec901c08f0368a2d8c751795c14aa6a5a41 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 19:56:17.892109) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 19:56:17.893906) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 19:56:17.894421) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006684 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.71 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 19:56:18.613197) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 19:56:18.613529) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 19:56:18.947476) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 19:56:18.947760) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004613 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 19:56:19.002473) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 19:56:19.002767) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 19:56:19.003146) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 19:56:19.003474) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-22 19:56:19-- 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% 15.7M=0.001s 2016-02-22 19:56:19 (15.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157681 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 19:56:19.175882) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 19:56:19.176195) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019968 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 19:56:19.227007) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 19:56:19.227408) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 56ed0ec901c08f0368a2d8c751795c14aa6a5a41 --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 56ed0ec901c08f0368a2d8c751795c14aa6a5a41 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-22 19:56:19,525 truncating revision to first 12 chars 2016-02-22 19:56:19,525 Setting DEBUG logging. 2016-02-22 19:56:19,526 attempt 1/10 2016-02-22 19:56:19,526 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/56ed0ec901c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-22 19:56:19,797 unpacking tar archive at: fx-team-56ed0ec901c0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.565704 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 19:56:19.811216) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 19:56:19.811565) ========= echo 56ed0ec901c08f0368a2d8c751795c14aa6a5a41 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'56ed0ec901c08f0368a2d8c751795c14aa6a5a41'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 56ed0ec901c08f0368a2d8c751795c14aa6a5a41 program finished with exit code 0 elapsedTime=0.004388 script_repo_revision: '56ed0ec901c08f0368a2d8c751795c14aa6a5a41' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 19:56:19.862373) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 19:56:19.862688) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 19:56:19.872384) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-02-22 19:56:19.872715) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:56:20 INFO - MultiFileLogger online at 20160222 19:56:20 in /builds/slave/test-pgo 19:56:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:56:20 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:56:20 INFO - {'append_to_log': False, 19:56:20 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:56:20 INFO - 'blob_upload_branch': 'Fx-Team', 19:56:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:56:20 INFO - 'branch': 'Fx-Team', 19:56:20 INFO - 'buildbot_json_path': 'buildprops.json', 19:56:20 INFO - 'config_files': ('talos/linux_config.py',), 19:56:20 INFO - 'default_actions': ('clobber', 19:56:20 INFO - 'read-buildbot-config', 19:56:20 INFO - 'download-and-extract', 19:56:20 INFO - 'populate-webroot', 19:56:20 INFO - 'create-virtualenv', 19:56:20 INFO - 'install', 19:56:20 INFO - 'run-tests'), 19:56:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:56:20 INFO - 'download_minidump_stackwalk': True, 19:56:20 INFO - 'download_symbols': 'ondemand', 19:56:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:56:20 INFO - 'tooltool.py': '/tools/tooltool.py', 19:56:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:56:20 INFO - '/tools/misc-python/virtualenv.py')}, 19:56:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:56:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:56:20 INFO - 'installer_path': 'installer.exe', 19:56:20 INFO - 'log_level': 'info', 19:56:20 INFO - 'log_name': 'talos', 19:56:20 INFO - 'log_to_console': True, 19:56:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:56:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:56:20 INFO - 'opt_config_files': (), 19:56:20 INFO - 'pip_index': False, 19:56:20 INFO - 'sps_profile': False, 19:56:20 INFO - 'sps_profile_interval': 0, 19:56:20 INFO - 'suite': 'dromaeojs', 19:56:20 INFO - 'system_bits': '32', 19:56:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:56:20 INFO - 'title': 'talos-linux64-ix-041', 19:56:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:56:20 INFO - 'use_talos_json': True, 19:56:20 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:56:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:56:20 INFO - 'work_dir': 'build'} 19:56:20 INFO - ##### 19:56:20 INFO - ##### Running clobber step. 19:56:20 INFO - ##### 19:56:20 INFO - Running pre-action listener: _resource_record_pre_action 19:56:20 INFO - Running main action method: clobber 19:56:20 INFO - rmtree: /builds/slave/test-pgo/build 19:56:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:56:21 INFO - Running post-action listener: _resource_record_post_action 19:56:21 INFO - ##### 19:56:21 INFO - ##### Running read-buildbot-config step. 19:56:21 INFO - ##### 19:56:21 INFO - Running pre-action listener: _resource_record_pre_action 19:56:21 INFO - Running main action method: read_buildbot_config 19:56:21 INFO - Using buildbot properties: 19:56:21 INFO - { 19:56:21 INFO - "project": "", 19:56:21 INFO - "product": "firefox", 19:56:21 INFO - "script_repo_revision": "production", 19:56:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:56:21 INFO - "repository": "", 19:56:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:56:21 INFO - "buildid": "20160222173020", 19:56:21 INFO - "pgo_build": "True", 19:56:21 INFO - "basedir": "/builds/slave/test-pgo", 19:56:21 INFO - "buildnumber": 660, 19:56:21 INFO - "slavename": "talos-linux64-ix-041", 19:56:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:56:21 INFO - "platform": "ubuntu64_hw", 19:56:21 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:56:21 INFO - "branch": "fx-team", 19:56:21 INFO - "repo_path": "integration/fx-team", 19:56:21 INFO - "revision": "56ed0ec901c08f0368a2d8c751795c14aa6a5a41", 19:56:21 INFO - "stage_platform": "linux64-pgo", 19:56:21 INFO - "builduid": "4aff06f3c57741efa11e52540d2bb636", 19:56:21 INFO - "slavebuilddir": "test" 19:56:21 INFO - } 19:56:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 19:56:21 INFO - Running post-action listener: _resource_record_post_action 19:56:21 INFO - ##### 19:56:21 INFO - ##### Running download-and-extract step. 19:56:21 INFO - ##### 19:56:21 INFO - Running pre-action listener: _resource_record_pre_action 19:56:21 INFO - Running main action method: download_and_extract 19:56:21 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:21 INFO - https://queue.taskcluster.net/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:56:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/test_packages.json 19:56:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/test_packages.json 19:56:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:56:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:56:22 INFO - Downloaded 1448 bytes. 19:56:22 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:56:22 INFO - Using the following test package requirements: 19:56:22 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 19:56:22 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:56:22 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:56:22 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:22 INFO - u'jsshell-linux-x86_64.zip'], 19:56:22 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:56:22 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 19:56:22 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:56:22 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:56:22 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:56:22 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 19:56:22 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:56:22 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:56: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')]} 19:56:22 INFO - https://queue.taskcluster.net/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:56:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:56:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:56:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:56:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:56:24 INFO - Downloaded 23366284 bytes. 19:56:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:56:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:56:25 INFO - Return code: 0 19:56:25 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:56:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:25 INFO - https://queue.taskcluster.net/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:56:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:56:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:56:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:56:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:56:31 INFO - Downloaded 23366284 bytes. 19:56:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:56:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:56:32 INFO - Return code: 0 19:56:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:32 INFO - https://queue.taskcluster.net/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:56:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 19:56:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 19:56:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 19:56:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:56:33 INFO - Downloaded 10707015 bytes. 19:56:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:56:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 19:56:33 INFO - Return code: 0 19:56:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:33 INFO - https://queue.taskcluster.net/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:56:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:56:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:56:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:56:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:56:36 INFO - Downloaded 56615891 bytes. 19:56:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:56:36 INFO - mkdir: /builds/slave/test-pgo/properties 19:56:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:56:36 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:56:36 INFO - Contents: 19:56:36 INFO - build_url:https://queue.taskcluster.net/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:56:36 INFO - Running post-action listener: _resource_record_post_action 19:56:36 INFO - Running post-action listener: set_extra_try_arguments 19:56:36 INFO - ##### 19:56:36 INFO - ##### Running populate-webroot step. 19:56:36 INFO - ##### 19:56:36 INFO - Running pre-action listener: _resource_record_pre_action 19:56:36 INFO - Running main action method: populate_webroot 19:56:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:56:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:56:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:56:36 INFO - '--tppagecycles', 19:56:36 INFO - '7'], 19:56:36 INFO - 'tests': ['tsvgm']}}, 19:56:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:56:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:56:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:56:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:56:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:56:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:56:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:56:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:36 INFO - 'talos_options': ['--e10s'], 19:56:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:56:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:36 INFO - 'tests': ['damp', 'tps']}, 19:56:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:36 INFO - 'talos_options': ['--e10s'], 19:56:36 INFO - 'tests': ['damp', 'tps']}, 19:56:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:56:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:56:36 INFO - 'other': {'tests': ['a11yr', 19:56:36 INFO - 'ts_paint', 19:56:36 INFO - 'tpaint', 19:56:36 INFO - 'sessionrestore', 19:56:36 INFO - 'sessionrestore_no_auto_restore']}, 19:56:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:56:36 INFO - 'tests': ['a11yr', 19:56:36 INFO - 'ts_paint', 19:56:36 INFO - 'tpaint', 19:56:36 INFO - 'sessionrestore', 19:56:36 INFO - 'sessionrestore_no_auto_restore']}, 19:56:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:56:36 INFO - 'tests': ['a11yr', 19:56:36 INFO - 'ts_paint', 19:56:36 INFO - 'tpaint', 19:56:36 INFO - 'sessionrestore', 19:56:36 INFO - 'sessionrestore_no_auto_restore']}, 19:56:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:56:36 INFO - 'tests': ['a11yr', 19:56:36 INFO - 'ts_paint', 19:56:36 INFO - 'tpaint', 19:56:36 INFO - 'sessionrestore', 19:56:36 INFO - 'sessionrestore_no_auto_restore']}, 19:56:36 INFO - 'other_l64': {'tests': ['a11yr', 19:56:36 INFO - 'ts_paint', 19:56:36 INFO - 'tpaint', 19:56:36 INFO - 'sessionrestore', 19:56:36 INFO - 'sessionrestore_no_auto_restore']}, 19:56:36 INFO - 'other_nol64': {'tests': ['a11yr', 19:56:36 INFO - 'ts_paint', 19:56:36 INFO - 'tpaint', 19:56:36 INFO - 'sessionrestore', 19:56:36 INFO - 'sessionrestore_no_auto_restore']}, 19:56:36 INFO - 'svgr': {'tests': ['tsvgx', 19:56:36 INFO - 'tsvgr_opacity', 19:56:36 INFO - 'tart', 19:56:36 INFO - 'tscrollx', 19:56:36 INFO - 'cart']}, 19:56:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:56:36 INFO - 'tests': ['tsvgx', 19:56:36 INFO - 'tsvgr_opacity', 19:56:36 INFO - 'tart', 19:56:36 INFO - 'tscrollx', 19:56:36 INFO - 'cart']}, 19:56:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:36 INFO - 'tests': ['tp5o']}, 19:56:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:36 INFO - 'talos_options': ['--e10s'], 19:56:36 INFO - 'tests': ['tp5o']}, 19:56:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:36 INFO - 'talos_options': ['--xperf_path', 19:56:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:56:36 INFO - 'tests': ['tp5n']}, 19:56:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:36 INFO - 'talos_options': ['--e10s', 19:56:36 INFO - '--xperf_path', 19:56:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:56:36 INFO - 'tests': ['tp5n']}}, 19:56:36 INFO - 'talos.zip': {'path': '', 19:56:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:56:36 INFO - Running post-action listener: _resource_record_post_action 19:56:36 INFO - ##### 19:56:36 INFO - ##### Running create-virtualenv step. 19:56:36 INFO - ##### 19:56:36 INFO - Running pre-action listener: _resource_record_pre_action 19:56:36 INFO - Running main action method: create_virtualenv 19:56:36 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:56:36 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 19:56:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:56:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:56:37 INFO - Using real prefix '/usr' 19:56:37 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:56:37 INFO - Installing distribute.............................................................................................................................................................................................done. 19:56:39 INFO - Installing pip.................done. 19:56:39 INFO - Return code: 0 19:56:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f9ca4f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe1670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708c0>, '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 0x10717c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071c50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288', '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 19:56:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:56:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:56:39 INFO - Using env: {'DISPLAY': ':0', 19:56:39 INFO - 'HOME': '/home/cltbld', 19:56:39 INFO - 'LANG': 'en_US.UTF-8', 19:56:39 INFO - 'LANGUAGE': 'en_US:en', 19:56:39 INFO - 'LOGNAME': 'cltbld', 19:56:39 INFO - 'MAIL': '/var/mail/cltbld', 19:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:39 INFO - 'MOZ_NO_REMOTE': '1', 19:56:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:39 INFO - 'NO_EM_RESTART': '1', 19:56:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:39 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:39 INFO - 'SHELL': '/bin/bash', 19:56:39 INFO - 'SHLVL': '1', 19:56:39 INFO - 'TERM': 'linux', 19:56:39 INFO - 'TMOUT': '86400', 19:56:39 INFO - 'USER': 'cltbld', 19:56:39 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288', 19:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:39 INFO - '_': '/tools/buildbot/bin/python'} 19:56:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:39 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 19:56:39 INFO - Cleaning up... 19:56:39 INFO - Return code: 0 19:56:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f9ca4f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe1670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708c0>, '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 0x10717c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071c50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288', '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 19:56:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:56:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:56:39 INFO - Using env: {'DISPLAY': ':0', 19:56:39 INFO - 'HOME': '/home/cltbld', 19:56:39 INFO - 'LANG': 'en_US.UTF-8', 19:56:39 INFO - 'LANGUAGE': 'en_US:en', 19:56:39 INFO - 'LOGNAME': 'cltbld', 19:56:39 INFO - 'MAIL': '/var/mail/cltbld', 19:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:39 INFO - 'MOZ_NO_REMOTE': '1', 19:56:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:39 INFO - 'NO_EM_RESTART': '1', 19:56:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:39 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:39 INFO - 'SHELL': '/bin/bash', 19:56:39 INFO - 'SHLVL': '1', 19:56:39 INFO - 'TERM': 'linux', 19:56:39 INFO - 'TMOUT': '86400', 19:56:39 INFO - 'USER': 'cltbld', 19:56:39 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288', 19:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:39 INFO - '_': '/tools/buildbot/bin/python'} 19:56:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:39 INFO - Downloading/unpacking psutil>=0.7.1 19:56:39 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 19:56:39 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 19:56:39 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 19:56:39 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 19:56:39 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 19:56:39 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 19:56:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:56:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:56:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:56:41 INFO - Installing collected packages: psutil 19:56:41 INFO - Running setup.py install for psutil 19:56:41 INFO - building 'psutil._psutil_linux' extension 19:56:41 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 19:56:42 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 19:56:42 INFO - building 'psutil._psutil_posix' extension 19:56:42 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 19:56:42 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 19:56:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:56:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:56:42 INFO - Successfully installed psutil 19:56:42 INFO - Cleaning up... 19:56:42 INFO - Return code: 0 19:56:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f9ca4f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe1670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708c0>, '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 0x10717c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071c50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288', '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 19:56:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:56:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:56:42 INFO - Using env: {'DISPLAY': ':0', 19:56:42 INFO - 'HOME': '/home/cltbld', 19:56:42 INFO - 'LANG': 'en_US.UTF-8', 19:56:42 INFO - 'LANGUAGE': 'en_US:en', 19:56:42 INFO - 'LOGNAME': 'cltbld', 19:56:42 INFO - 'MAIL': '/var/mail/cltbld', 19:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:42 INFO - 'MOZ_NO_REMOTE': '1', 19:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:42 INFO - 'NO_EM_RESTART': '1', 19:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:42 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:42 INFO - 'SHELL': '/bin/bash', 19:56:42 INFO - 'SHLVL': '1', 19:56:42 INFO - 'TERM': 'linux', 19:56:42 INFO - 'TMOUT': '86400', 19:56:42 INFO - 'USER': 'cltbld', 19:56:42 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288', 19:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:42 INFO - '_': '/tools/buildbot/bin/python'} 19:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:56:42 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 19:56:42 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 19:56:42 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 19:56:42 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 19:56:42 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 19:56:42 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 19:56:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:56:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:56:44 INFO - Installing collected packages: mozsystemmonitor 19:56:44 INFO - Running setup.py install for mozsystemmonitor 19:56:44 INFO - Successfully installed mozsystemmonitor 19:56:44 INFO - Cleaning up... 19:56:44 INFO - Return code: 0 19:56:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f9ca4f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe1670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708c0>, '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 0x10717c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071c50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288', '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 19:56:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:56:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:56:44 INFO - Using env: {'DISPLAY': ':0', 19:56:44 INFO - 'HOME': '/home/cltbld', 19:56:44 INFO - 'LANG': 'en_US.UTF-8', 19:56:44 INFO - 'LANGUAGE': 'en_US:en', 19:56:44 INFO - 'LOGNAME': 'cltbld', 19:56:44 INFO - 'MAIL': '/var/mail/cltbld', 19:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:44 INFO - 'MOZ_NO_REMOTE': '1', 19:56:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:44 INFO - 'NO_EM_RESTART': '1', 19:56:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:44 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:44 INFO - 'SHELL': '/bin/bash', 19:56:44 INFO - 'SHLVL': '1', 19:56:44 INFO - 'TERM': 'linux', 19:56:44 INFO - 'TMOUT': '86400', 19:56:44 INFO - 'USER': 'cltbld', 19:56:44 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288', 19:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:44 INFO - '_': '/tools/buildbot/bin/python'} 19:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:44 INFO - Downloading/unpacking blobuploader==1.2.4 19:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:46 INFO - Downloading blobuploader-1.2.4.tar.gz 19:56:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:56:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:56:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:47 INFO - Downloading docopt-0.6.1.tar.gz 19:56:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:56:47 INFO - Installing collected packages: blobuploader, requests, docopt 19:56:47 INFO - Running setup.py install for blobuploader 19:56:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:56:47 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:56:47 INFO - Running setup.py install for requests 19:56:47 INFO - Running setup.py install for docopt 19:56:47 INFO - Successfully installed blobuploader requests docopt 19:56:47 INFO - Cleaning up... 19:56:47 INFO - Return code: 0 19:56:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f9ca4f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe1670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708c0>, '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 0x10717c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071c50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288', '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 19:56:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 19:56:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 19:56:47 INFO - Using env: {'DISPLAY': ':0', 19:56:47 INFO - 'HOME': '/home/cltbld', 19:56:47 INFO - 'LANG': 'en_US.UTF-8', 19:56:47 INFO - 'LANGUAGE': 'en_US:en', 19:56:47 INFO - 'LOGNAME': 'cltbld', 19:56:47 INFO - 'MAIL': '/var/mail/cltbld', 19:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:47 INFO - 'MOZ_NO_REMOTE': '1', 19:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:47 INFO - 'NO_EM_RESTART': '1', 19:56:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:47 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:47 INFO - 'SHELL': '/bin/bash', 19:56:47 INFO - 'SHLVL': '1', 19:56:47 INFO - 'TERM': 'linux', 19:56:47 INFO - 'TMOUT': '86400', 19:56:47 INFO - 'USER': 'cltbld', 19:56:47 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288', 19:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:47 INFO - '_': '/tools/buildbot/bin/python'} 19:56:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:56:48 INFO - Running setup.py (path:/tmp/pip-FORG_4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:56:48 INFO - Running setup.py (path:/tmp/pip-qzw5Zd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:56:48 INFO - Running setup.py (path:/tmp/pip-0v0RVQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:56:48 INFO - Running setup.py (path:/tmp/pip-4OcbBn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:56:48 INFO - Running setup.py (path:/tmp/pip-u02V3O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:56:48 INFO - Running setup.py (path:/tmp/pip-ghoFWE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:56:48 INFO - Running setup.py (path:/tmp/pip-7ATBGl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:56:48 INFO - Running setup.py (path:/tmp/pip-g1JeoQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:56:48 INFO - Running setup.py (path:/tmp/pip-m7OXpI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:56:48 INFO - Running setup.py (path:/tmp/pip-n_NKUB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:56:48 INFO - Running setup.py (path:/tmp/pip-n81SNi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:56:48 INFO - Running setup.py (path:/tmp/pip-0iwexl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:56:49 INFO - Running setup.py (path:/tmp/pip-IsdidR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:56:49 INFO - Running setup.py (path:/tmp/pip-1Qre5H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:56:49 INFO - Running setup.py (path:/tmp/pip-r9bkNi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:56:49 INFO - Running setup.py (path:/tmp/pip-5qb2mN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:56:49 INFO - Running setup.py (path:/tmp/pip-5NKOiO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:56:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:56:49 INFO - Running setup.py install for manifestparser 19:56:49 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:56:49 INFO - Running setup.py install for mozcrash 19:56:49 INFO - Running setup.py install for mozdebug 19:56:49 INFO - Running setup.py install for mozdevice 19:56:49 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:56:49 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:56:49 INFO - Running setup.py install for mozfile 19:56:49 INFO - Running setup.py install for mozhttpd 19:56:49 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:56:50 INFO - Running setup.py install for mozinfo 19:56:50 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:56:50 INFO - Running setup.py install for mozInstall 19:56:50 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:56:50 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:56:50 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:56:50 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:56:50 INFO - Running setup.py install for mozleak 19:56:50 INFO - Running setup.py install for mozlog 19:56:50 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:56:50 INFO - Running setup.py install for moznetwork 19:56:50 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:56:50 INFO - Running setup.py install for mozprocess 19:56:50 INFO - Running setup.py install for mozprofile 19:56:50 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:56:50 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:56:50 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:56:50 INFO - Running setup.py install for mozrunner 19:56:50 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:56:50 INFO - Running setup.py install for mozscreenshot 19:56:50 INFO - Running setup.py install for moztest 19:56:51 INFO - Running setup.py install for mozversion 19:56:51 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:56:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:56:51 INFO - Cleaning up... 19:56:51 INFO - Return code: 0 19:56:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:56:51 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')]} 19:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:51 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')]} 19:56:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f9ca4f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe1670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708c0>, '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 0x10717c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071c50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288', '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 19:56:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:56:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:56:51 INFO - Using env: {'DISPLAY': ':0', 19:56:51 INFO - 'HOME': '/home/cltbld', 19:56:51 INFO - 'LANG': 'en_US.UTF-8', 19:56:51 INFO - 'LANGUAGE': 'en_US:en', 19:56:51 INFO - 'LOGNAME': 'cltbld', 19:56:51 INFO - 'MAIL': '/var/mail/cltbld', 19:56:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:51 INFO - 'MOZ_NO_REMOTE': '1', 19:56:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:51 INFO - 'NO_EM_RESTART': '1', 19:56:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:51 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:51 INFO - 'SHELL': '/bin/bash', 19:56:51 INFO - 'SHLVL': '1', 19:56:51 INFO - 'TERM': 'linux', 19:56:51 INFO - 'TMOUT': '86400', 19:56:51 INFO - 'USER': 'cltbld', 19:56:51 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288', 19:56:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:51 INFO - '_': '/tools/buildbot/bin/python'} 19:56:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:56:51 INFO - Running setup.py (path:/tmp/pip-S6ICkB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:56:51 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)) 19:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:56:51 INFO - Running setup.py (path:/tmp/pip-YKJh8h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:56:51 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)) 19:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:56:51 INFO - Running setup.py (path:/tmp/pip-KjyhmA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:56:51 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)) 19:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:56:51 INFO - Running setup.py (path:/tmp/pip-GT4JAU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:56:51 INFO - Running setup.py (path:/tmp/pip-lnQryJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:56:51 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)) 19:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:56:51 INFO - Running setup.py (path:/tmp/pip-IRJCyg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:56:51 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)) 19:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:56:51 INFO - Running setup.py (path:/tmp/pip-khJ2YE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:56:51 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)) 19:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:56:51 INFO - Running setup.py (path:/tmp/pip-xwNEhc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:56:51 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)) 19:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:56:51 INFO - Running setup.py (path:/tmp/pip-HQ4DOi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:56:52 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)) 19:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:56:52 INFO - Running setup.py (path:/tmp/pip-3XbmzU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:56:52 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)) 19:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:56:52 INFO - Running setup.py (path:/tmp/pip-pddG1e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:56:52 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)) 19:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:56:52 INFO - Running setup.py (path:/tmp/pip-7W8pdn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:56:52 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)) 19:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:56:52 INFO - Running setup.py (path:/tmp/pip-kEDNHi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 19:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:56:52 INFO - Running setup.py (path:/tmp/pip-Ro60Lw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:56:52 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)) 19:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:56:52 INFO - Running setup.py (path:/tmp/pip-H6bzJW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:56:52 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)) 19:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:56:52 INFO - Running setup.py (path:/tmp/pip-SRQIKa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:56:52 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)) 19:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:56:52 INFO - Running setup.py (path:/tmp/pip-m3c6aQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:56:52 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)) 19:56:52 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)) 19:56:52 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)) 19:56:52 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)) 19:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:56:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:54 INFO - Downloading blessings-1.6.tar.gz 19:56:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:56:54 INFO - Installing collected packages: blessings 19:56:54 INFO - Running setup.py install for blessings 19:56:54 INFO - Successfully installed blessings 19:56:54 INFO - Cleaning up... 19:56:54 INFO - Return code: 0 19:56:54 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:56:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:56:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:56:54 INFO - Reading from file tmpfile_stdout 19:56:54 INFO - Current package versions: 19:56:54 INFO - argparse == 1.2.1 19:56:54 INFO - blessings == 1.6 19:56:54 INFO - blobuploader == 1.2.4 19:56:54 INFO - docopt == 0.6.1 19:56:54 INFO - manifestparser == 1.1 19:56:54 INFO - mozInstall == 1.12 19:56:54 INFO - mozcrash == 0.16 19:56:54 INFO - mozdebug == 0.1 19:56:54 INFO - mozdevice == 0.48 19:56:54 INFO - mozfile == 1.2 19:56:54 INFO - mozhttpd == 0.7 19:56:54 INFO - mozinfo == 0.9 19:56:54 INFO - mozleak == 0.1 19:56:54 INFO - mozlog == 3.1 19:56:54 INFO - moznetwork == 0.27 19:56:54 INFO - mozprocess == 0.22 19:56:54 INFO - mozprofile == 0.28 19:56:54 INFO - mozrunner == 6.11 19:56:54 INFO - mozscreenshot == 0.1 19:56:54 INFO - mozsystemmonitor == 0.0 19:56:54 INFO - moztest == 0.7 19:56:54 INFO - mozversion == 1.4 19:56:54 INFO - psutil == 3.1.1 19:56:54 INFO - requests == 1.2.3 19:56:54 INFO - wsgiref == 0.1.2 19:56:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f9ca4f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe1670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708c0>, '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 0x10717c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071c50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288', '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 19:56:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:56:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:56:54 INFO - Using env: {'DISPLAY': ':0', 19:56:54 INFO - 'HOME': '/home/cltbld', 19:56:54 INFO - 'LANG': 'en_US.UTF-8', 19:56:54 INFO - 'LANGUAGE': 'en_US:en', 19:56:54 INFO - 'LOGNAME': 'cltbld', 19:56:54 INFO - 'MAIL': '/var/mail/cltbld', 19:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:54 INFO - 'MOZ_NO_REMOTE': '1', 19:56:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:54 INFO - 'NO_EM_RESTART': '1', 19:56:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:54 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:54 INFO - 'SHELL': '/bin/bash', 19:56:54 INFO - 'SHLVL': '1', 19:56:54 INFO - 'TERM': 'linux', 19:56:54 INFO - 'TMOUT': '86400', 19:56:54 INFO - 'USER': 'cltbld', 19:56:54 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288', 19:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:54 INFO - '_': '/tools/buildbot/bin/python'} 19:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 19:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 19:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 19:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 19:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 19:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 19:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 19:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 19:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 19:56:55 INFO - Cleaning up... 19:56:55 INFO - Return code: 0 19:56:55 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:56: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')]} 19:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56: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')]} 19:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f9ca4f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe1670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708c0>, '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 0x10717c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071c50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288', '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 19:56:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:56:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:56:55 INFO - Using env: {'DISPLAY': ':0', 19:56:55 INFO - 'HOME': '/home/cltbld', 19:56:55 INFO - 'LANG': 'en_US.UTF-8', 19:56:55 INFO - 'LANGUAGE': 'en_US:en', 19:56:55 INFO - 'LOGNAME': 'cltbld', 19:56:55 INFO - 'MAIL': '/var/mail/cltbld', 19:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:55 INFO - 'MOZ_NO_REMOTE': '1', 19:56:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:55 INFO - 'NO_EM_RESTART': '1', 19:56:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:55 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:55 INFO - 'SHELL': '/bin/bash', 19:56:55 INFO - 'SHLVL': '1', 19:56:55 INFO - 'TERM': 'linux', 19:56:55 INFO - 'TMOUT': '86400', 19:56:55 INFO - 'USER': 'cltbld', 19:56:55 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288', 19:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:55 INFO - '_': '/tools/buildbot/bin/python'} 19:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:55 INFO - Downloading/unpacking jsonschema 19:56:55 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 19:56:55 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 19:56:55 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 19:56:55 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 19:56:55 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 19:56:55 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 19:56:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:56:57 INFO - Downloading/unpacking functools32 (from jsonschema) 19:56:57 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 19:56:57 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 19:56:57 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 19:56:57 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 19:56:57 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 19:56:57 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 19:56:57 INFO - Downloading functools32-3.2.3-2.tar.gz 19:56:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:56:57 INFO - warning: no files found matching '*.txt' 19:56:57 INFO - no previously-included directories found matching 'build' 19:56:57 INFO - no previously-included directories found matching 'dist' 19:56:57 INFO - no previously-included directories found matching '.git*' 19:56:57 INFO - Installing collected packages: jsonschema, functools32 19:56:57 INFO - Running setup.py install for functools32 19:56:57 INFO - warning: no files found matching '*.txt' 19:56:57 INFO - no previously-included directories found matching 'build' 19:56:57 INFO - no previously-included directories found matching 'dist' 19:56:57 INFO - no previously-included directories found matching '.git*' 19:56:57 INFO - Successfully installed jsonschema functools32 19:56:57 INFO - Cleaning up... 19:56:57 INFO - Return code: 0 19:56:57 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f9ca4f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe1670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708c0>, '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 0x10717c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071c50>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288', '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 19:56:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:56:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:56:57 INFO - Using env: {'DISPLAY': ':0', 19:56:57 INFO - 'HOME': '/home/cltbld', 19:56:57 INFO - 'LANG': 'en_US.UTF-8', 19:56:57 INFO - 'LANGUAGE': 'en_US:en', 19:56:57 INFO - 'LOGNAME': 'cltbld', 19:56:57 INFO - 'MAIL': '/var/mail/cltbld', 19:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:57 INFO - 'MOZ_NO_REMOTE': '1', 19:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:57 INFO - 'NO_EM_RESTART': '1', 19:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:56:57 INFO - 'PWD': '/builds/slave/test-pgo', 19:56:57 INFO - 'SHELL': '/bin/bash', 19:56:57 INFO - 'SHLVL': '1', 19:56:57 INFO - 'TERM': 'linux', 19:56:57 INFO - 'TMOUT': '86400', 19:56:57 INFO - 'USER': 'cltbld', 19:56:57 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288', 19:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:57 INFO - '_': '/tools/buildbot/bin/python'} 19:56:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:57 INFO - Downloading/unpacking flake8 19:56:57 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 19:56:57 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 19:56:57 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 19:56:57 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 19:56:57 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 19:56:57 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 19:56:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:56:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:56:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:57:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:57:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:57:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:57:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:57:00 INFO - no previously-included directories found matching 'docs/_build' 19:57:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:57:00 INFO - Running setup.py install for pep8 19:57:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:57:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:57:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:57:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:57:00 INFO - no previously-included directories found matching 'docs/_build' 19:57:00 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:57:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:57:00 INFO - Cleaning up... 19:57:00 INFO - Return code: 0 19:57:00 INFO - Running post-action listener: _resource_record_post_action 19:57:00 INFO - Running post-action listener: _start_resource_monitoring 19:57:00 INFO - Starting resource monitoring. 19:57:00 INFO - ##### 19:57:00 INFO - ##### Running install step. 19:57:00 INFO - ##### 19:57:00 INFO - Running pre-action listener: _resource_record_pre_action 19:57:00 INFO - Running main action method: install 19:57:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:57:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:57:00 INFO - Reading from file tmpfile_stdout 19:57:00 INFO - Detecting whether we're running mozinstall >=1.0... 19:57:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:57:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:57:00 INFO - Reading from file tmpfile_stdout 19:57:00 INFO - Output received: 19:57:00 INFO - Usage: mozinstall [options] installer 19:57:00 INFO - Options: 19:57:00 INFO - -h, --help show this help message and exit 19:57:00 INFO - -d DEST, --destination=DEST 19:57:00 INFO - Directory to install application into. [default: 19:57:00 INFO - "/builds/slave/test-pgo"] 19:57:00 INFO - --app=APP Application being installed. [default: firefox] 19:57:00 INFO - mkdir: /builds/slave/test-pgo/build/application 19:57:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 19:57:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 19:57:17 INFO - Reading from file tmpfile_stdout 19:57:17 INFO - Output received: 19:57:17 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:57:17 INFO - Running post-action listener: _resource_record_post_action 19:57:17 INFO - ##### 19:57:17 INFO - ##### Running run-tests step. 19:57:17 INFO - ##### 19:57:17 INFO - Running pre-action listener: _resource_record_pre_action 19:57:17 INFO - Running main action method: run_tests 19:57:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:57:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:57:17 INFO - Python 2.7.3 19:57:17 INFO - Return code: 0 19:57:17 INFO - grabbing minidump binary from tooltool 19:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:17 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 0x10708c0>, '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 0x10717c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:57:17 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 19:57:17 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 19:57:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:57:17 INFO - Return code: 0 19:57:17 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:57:17 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:57:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:57:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:57:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:57:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:57:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:57:18 INFO - Return code: 0 19:57:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 19:57:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 19:57:18 INFO - Using env: {'DISPLAY': ':0', 19:57:18 INFO - 'HOME': '/home/cltbld', 19:57:18 INFO - 'LANG': 'en_US.UTF-8', 19:57:18 INFO - 'LANGUAGE': 'en_US:en', 19:57:18 INFO - 'LOGNAME': 'cltbld', 19:57:18 INFO - 'MAIL': '/var/mail/cltbld', 19:57:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:57:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:57:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:18 INFO - 'MOZ_NO_REMOTE': '1', 19:57:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:57:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:18 INFO - 'NO_EM_RESTART': '1', 19:57:18 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:57:18 INFO - 'PWD': '/builds/slave/test-pgo', 19:57:18 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:57:18 INFO - 'SHELL': '/bin/bash', 19:57:18 INFO - 'SHLVL': '1', 19:57:18 INFO - 'TERM': 'linux', 19:57:18 INFO - 'TMOUT': '86400', 19:57:18 INFO - 'USER': 'cltbld', 19:57:18 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288', 19:57:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:18 INFO - '_': '/tools/buildbot/bin/python'} 19:57:18 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:57:18 INFO - mozversion application_buildid: 20160222173020 19:57:18 INFO - mozversion application_changeset: 56ed0ec901c08f0368a2d8c751795c14aa6a5a41 19:57:18 INFO - mozversion application_display_name: Nightly 19:57:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:57:18 INFO - mozversion application_name: Firefox 19:57:18 INFO - mozversion application_remotingname: firefox 19:57:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:57:18 INFO - mozversion application_vendor: Mozilla 19:57:18 INFO - mozversion application_version: 47.0a1 19:57:18 INFO - mozversion platform_buildid: 20160222173020 19:57:18 INFO - mozversion platform_changeset: 56ed0ec901c08f0368a2d8c751795c14aa6a5a41 19:57:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:57:18 INFO - mozversion platform_version: 47.0a1 19:57:18 INFO - using testdate: 1456199838 19:57:18 INFO - actual date: 1456199838 19:57:18 INFO - starting webserver on 'localhost:51773' 19:57:18 INFO - SUITE-START | Running 2 tests 19:57:18 INFO - TEST-START | dromaeo_css 19:57:18 INFO - operating with platform_type : linux_ 19:57:18 INFO - Initialising browser for dromaeo_css test... 19:57:18 INFO - TEST-INFO | started process 28761 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGo_6ya/profile http://localhost:51773/getInfo.html) 19:57:22 INFO - PROCESS | 28761 | __metrics Screen width/height:1600/1200 19:57:22 INFO - PROCESS | 28761 | colorDepth:24 19:57:22 INFO - PROCESS | 28761 | Browser inner width/height: 1024/697 19:57:22 INFO - PROCESS | 28761 | __metrics 19:57:23 INFO - PROCESS | 28761 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:57:24 INFO - TEST-INFO | 28761: exit 0 19:57:24 INFO - Browser initialized. 19:57:24 INFO - Running cycle 1/1 for dromaeo_css test... 19:57:24 INFO - TEST-INFO | started process 28854 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGo_6ya/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:57:36 INFO - PROCESS | 28854 | RSS: Main: 147415040 19:57:36 INFO - PROCESS | 28854 | 19:58:27 INFO - PROCESS | 28854 | 1456199907990 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] 20:00:35 INFO - PROCESS | 28854 | Cycle 1(1): loaded http://localhost:51773/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51773/tests/dromaeo/cssquery-ext.html) 20:00:36 INFO - PROCESS | 28854 | RSS: Main: 267145216 20:00:36 INFO - PROCESS | 28854 | 20:03:39 INFO - PROCESS | 28854 | Cycle 1(1): loaded http://localhost:51773/tests/dromaeo/cssquery-ext.html (next: http://localhost:51773/tests/dromaeo/cssquery-jquery.html) 20:03:39 INFO - PROCESS | 28854 | RSS: Main: 224292864 20:03:39 INFO - PROCESS | 28854 | 20:06:41 INFO - PROCESS | 28854 | Cycle 1(1): loaded http://localhost:51773/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51773/tests/dromaeo/cssquery-mootools.html) 20:06:42 INFO - PROCESS | 28854 | RSS: Main: 231321600 20:06:42 INFO - PROCESS | 28854 | 20:09:44 INFO - PROCESS | 28854 | Cycle 1(1): loaded http://localhost:51773/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51773/tests/dromaeo/cssquery-prototype.html) 20:09:44 INFO - PROCESS | 28854 | RSS: Main: 214585344 20:09:44 INFO - PROCESS | 28854 | 20:12:47 INFO - PROCESS | 28854 | Cycle 1(1): loaded http://localhost:51773/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51773/tests/dromaeo/cssquery-yui.html) 20:12:48 INFO - PROCESS | 28854 | RSS: Main: 187596800 20:12:48 INFO - PROCESS | 28854 | 20:15:50 INFO - PROCESS | 28854 | Cycle 1(1): loaded http://localhost:51773/tests/dromaeo/cssquery-yui.html (next: http://localhost:51773/tests/dromaeo/cssquery-dojo.html) 20:15:51 INFO - PROCESS | 28854 | RSS: Main: 250490880 20:15:51 INFO - PROCESS | 28854 | 20:15:51 INFO - PROCESS | 28854 | __start_tp_report 20:15:51 INFO - PROCESS | 28854 | _x_x_mozilla_page_load 20:15:51 INFO - PROCESS | 28854 | _x_x_mozilla_page_load_details 20:15:51 INFO - PROCESS | 28854 | |i|pagename|runs| 20:15:51 INFO - PROCESS | 28854 | |0;dojo.html;3113.6886311368858;3116.4546204414223;3148.9685103148963;3155.7633177511693;3183.681631836816;5033.7483125843655;5084.949150508493;5097.923531147036;5142.074426603214;5145.639805213632;5109.4379618241965;5117.462666420028;5119.718415487147;5135.948640513594;5156.561692256153;4661.30080487927;4684.695494792828;4729.408823897013;4774.9761251193695;4879;4816.951830481703;4824.614030877539;4856.1016212000895;4882.07240624282;4905.362302900618;4645.535446455361;4679.859604211879;4723.055388922195;4728.858134255978;4759.785809638574;4731.929021064687;4740.905181896343;4742.146413645542;4744.193487107165;4780.306855505932;4585.793639286207;4653.325267836145;4698.7650617469335;4719.244920812654;4742.739149346785;4950.232713929347;4963.1562634351885;4968.801247950078;4970.2793095001025;5010.5240002199735;5447.319085114361;5448.482394172547;5450.182472629098;5466.972665136688;5506.614536982413;5488.1493368527945;5494;5542.5565954723925;5582.8325150245155;5603.579731520153;5221.6083793715625;5241.397239317527;5241.68549887008;5244.370675518962;5249;5554.72226388679;5700.885982280414;5702.45826646468;5703.315602127771;5703.372629010805;5397.973010134924;5419.3225846769155;5442.2380866678695;5445.210444485528;5496.1755736639825;5539.2522009529;5577.05190117681;5577.135543990688;5577.386487486373;5581.720913954286;5423.18652202165;5496.697681627469;5522.364928033247;5545.251391062155;5565.721713914288;5495.093309603951;5527.668339899538;5527.695976721319;5527.972360138254;5533.087040638249;4303.311470164821;4312.288472402081;4312.396264522969;4341.956580434218;4357.934630980538;3803.8858834235016;3844.115853353744;3856.4986551748093;3891.124496988155;3898.181381909774;5172.301739265226;5175.560077393464;5183.870403239949;5190.948090519047;5234.188700751313;5533.667979921218;5534.778608855681;5554.638948468337;5554.833354999276;5555.72221388937;5111.897762044739;5128.79484820603;5135.743212839343;5168.121419358718;5201.141811601119;4743.644226683013;4763.54746299101;4766.547178018082;4766.809327626856;4820.373351464357;5608.775648974077;5733.913991290217;5761.452661997104;5775.306963164363;5792.594518383757;5574.219609254626;5576.972115139399;5602.1036634138345;5604.187392828098;5631.042722737063;5789.681567513827;5807.680577568105;5809.82570522885;5815.069588865761;5833.387494313036;5384.246205531151;5454.154606036071;5481.753321100639;5518.951399234133;5533.114701647717;5492.395836458067;5501.9174712380145;5516.393196748274;5541.916871246854;5542.584306177134;5262.86842828917;5370.436104209002;5371.435999220025;5398.838034858961;5430.375506816767;5402.783888644567;5431.158170483582;5444.863878403072;5450.400455949763;5493.560515158698;5328.09422398201;5337.172738225581;5344.625876188629;5348.1442969124755;5406.945930540802;5361.463853614608;5381.246625472515;5413.648112872651;5426.593005524523;5456.781728730806;5235.528802407802;5238.764255608583;5248.527632513092;5262.342207224097;5303.893922121613 20:15:51 INFO - PROCESS | 28854 | |1;ext.html;524.6301357542931;557.8298618921233;565.9671100242058;582.8571999860033;586.4633860018083;28826.279343016435;36321;36997.81501092491;37079.07302317443;37119.62880371199;39643.40534891979;40050.19899602006;40159;40267.39598906019;40310;8366.121557236478;8549;8559.358048146383;8563.571821408936;8566.571671416405;8489.872651910226;8610.52642104684;8629.137086291383;8635.179657932485;8847.115288471134;8820;8868.37921345506;8887.777805554848;8908.777280567972;8937.374383793138;8783.253423459013;8805.691800786974;8830.55847207637;8877.822443551126;8879.422837515542;8604.913950860473;8746.256568191711;8753.3872628916;8804;8806.251468625174;39377.80311098455;39400.408993865116;39948.40077398841;39955;40028.19943601112;3393.5418718473184;3472.3576138414473;3833;3975.7216994810374;4115.9588404115875;29700.851495742598;30275;30529.69470305313;30567.235819104477;30768.8461557693;3841.9423708644395;3909.7263191576603;3941.6649584785328;3979.6418322350837;4111.527174374955;258217.7089114561;258891;259324;260819;261356;51664.22503662448;57167.42832571621;57470.42529574734;57516.42483575195;59852.10221846676;53689.731551341996;53705.462945370826;53841.73079134658;53853.73073134688;53868.461315387125;16022.919885400499;16264.268107935171;16297.614702750161;16330.75503867443;16340;11267;12338.81491777624;12381.814272785916;12538;12797.872021279669;18833.34083307105;18881.433556993314;19095.331663391993;19105.802832674144;19136.138873750715;7143.321384468467;7348.926510734931;7396.630168491554;7414.147373052168;7485.588292643957;899.5052721003422;998.3410948773919;1024.4365598920565;1037.3931250218707;1039.5633833789827;26581.601275980876;27405.725942740715;27583;27738.167854964384;27842.443151136864;1009.2632378363835;1011.231464087299;1023.8054769593754;1104.8784633690289;1130.5364800431948;14103.153810771386;14442.350094245785;14614.634634134232;15594.454194103379;15788.684226315409;246076;246266;247254;248531;249529;47797.52202478;48129;48178.75910620424;48208.758956205;48214.75892620515;1362.2167253829089;1368.3568722700513;1397.189630014589;1398.825146856643;1401.4884567133126;26240.4751904957;29263;29542.409151816413;29701.702982970757;29923.251918702208;45769;46537.301940471596;46583;46638;46657.53342466532;279893;285466;297108;305254;305619;27409.862950685118;28010.859945700955;31900.5214921781;33601.495977560844;33926.32147357088;40864.79567602143;41165;41488.79255603703;42351.57648423476;42461.363079553215;33934.490982635776;34086.48870266898;34309.828450858586;34399.14002149966;34612;34568;34568;34981.8250908754;35444.46833297451;35489.645103549665;31004.689953101082;31731.841340793148;35262.47106293356;35792.46311305281;35815.82092089523;27941.580876286465;31757.36485270328;31834.52248216325;33792.49311260284;34046.319073617895;23623.527529449657;23645;23970;24010.15964441236;24692.876535617208 20:15:51 INFO - PROCESS | 28854 | |2;jquery.html;352.2128043822057;352.2989251389735;353.7011225514441;354.18183994971616;356.157687070079;14004.369803358848;16388.34446622135;16995.66008679827;17369.392071277507;17494.21276042578;11109.388983605899;11432.199746017783;11504.42477876105;11730.882691173085;16284.10437425941;4688;4837.371141751567;4868.610511159099;4871.756412179395;4890.290907818364;3693.815309234541;5151.6908985460805;5276.683398996072;5292.550133238679;5298.09932311508;5262.81580144695;5267.604929630274;5276.525112739852;5280.313559237313;5283.682979021271;5130.179171332587;5198.2982297389935;5250.107481728096;5252.6323157379;5262.02652509287;4992.600591952635;4996.4254110777365;4997.225430058346;4999.9500004999845;5051.823186188502;12183.451744671422;19257;19490.80509194904;19743.80256197434;19921.50196245091;2122.2466024561368;2123.7239158909397;2205.106931692667;2405.1581946318647;2538.263903467992;9038;9143.862842057375;9227.815443691088;9480.762980925463;9710.514474276328;1741.9086808578;1833.8441232495254;1834.5872178759805;1860.9348672796386;1880.2666959885655;57836.71081644565;59847.70076149635;61517.692411538104;61904.69047654778;63162.68418657923;10050.547725352377;10245.231607629457;10316.793664126675;10358.792824143475;10418.895811041944;12461.563845265373;13390.866091338961;13613.387397567134;13622.250776207205;13627.863721362659;7511.211322811136;7774;7804.2585954334245;7917.604119793988;7941;7781.221877812173;7802.570858602831;7835.490693105044;7896.368290536743;7897.842043159219;4608.5161058088415;4680.53194680536;4688;4718.339432479455;4720.079584481062;1825.1148193126323;1842.1157844234574;1863.3757691173337;1881.6330815490849;1922.3464022232229;918.5958178401482;950.4012472142506;964.1852634523816;978.1734434402919;1048.4967215736337;16179.43371981975;16578.917105414635;16681.24934377956;16702.66594668124;17458.56353591145;920.2132176988579;979.1921664626711;1004.7086344960026;1011.4133802394593;1048.7797562511957;8077.515349078956;9221.631134754669;9275.768105797275;9857.852132218022;10172.338797978107;398754;408896;410593;415237;425664;72711;72799;73333.26666733371;73588;74590.62704686442;964.0841200859212;1035.668586052456;1037.8598889150019;1063.1176123817213;1068.166829872685;14479.131252124485;14662.34019469105;14682.339294731977;14920.552383428081;15022.399104035716;30501.23746906345;31437.214069648442;31890.840545797124;32167.195820104684;33323;43464;43631.56368436275;44007.559924400346;44045.33931991087;44290.335644966;7712.035995500562;7890.5949424644305;7915.129335773176;7939.444238903221;8038.83922321562;12383.071269654632;12829.550965716155;13029.179622099946;13301.135426197266;13486.190828550318;10993.835092473459;11236.775264494501;11275.605353812578;11418.82871756941;11507;10990;11163.832542511705;11200.327980321206;11431.657050288504;11788.233764805604;11363.090952723927;11594.072474202212;11644.2431241969;11771.117166212398;11792.70518237051;7818.33544148731;7929.405294603043;8227.83544329122;8238.546879921661;8312.21034001769;9788.9021109788;10813.729656758644;10969.561217551527;11273.549058037916;11499.195056345976 20:15:51 INFO - PROCESS | 28854 | |3;mootools.html;1372.7460419822328;1471.8822494200465;1476.438953197785;1645.2349657409302;1810.6288210916755;7557.546547207165;7724.536527808328;7728.92271077289;7763.650635721392;7764.689412423503;7385.778426647209;7550.660220290087;7550.962245188766;7579.1662917079075;7622.047244094489;1925.9711104333446;2265.207177487874;2272.4432514034083;2298.287530865429;2320.825938054644;2284.6116160252795;2311.4799170186657;2325.4418939454495;2327.592671282527;2328.6274196128625;2305.4236440889777;2310.099061366069;2311.0640190722784;2311.826613004023;2313.410080429488;2181.6618424144285;2233.8324625652976;2236.2508559632543;2236.664500324948;2236.798688118069;2252.7859853313907;2264.105678257096;2269.205777977711;2309.110992267972;2310.2260742651233;7662.61686915652;7678.654460549289;7718.575478348688;7720.845583088363;7725.150233474314;4677.789499472532;4790.520947905216;4795.760211989422;4795.784189711471;4799.208130658437;3186.6176058873084;3234.207619133327;3250.6099268087746;3265.053134590966;3308.073739352985;1058.3491152940962;1065.046783129095;1085.1535802074395;1091.4433638844246;1092.9016388525072;11087.50106245229;11196.888031119666;11198;11202.943985280102;11209.607663731731;4292.785360731951;4321.956780432219;4335;4373.190959672471;4373.2128216921255;9470.14768670823;9470.337076404723;9470.52647367629;9474;9476.905230947741;4104.199681062164;4567.588916997486;4823.252395878644;4858.271259311132;4860.975695121501;4205.9789701051295;4247.5752424757275;4250.936235956463;4261.87214383569;4264.317709166518;3632.909177270589;3633.0735662406446;3640.0535860675886;3678.1907980244305;3691.8154092295276;1134.6312448454285;1136.6817291158488;1140.2873204247346;1149.0233301693493;1149.0807354116673;1315.6316231455207;1321.7686904791815;1341.4567100324384;1371.636516323175;1390.3465371275483;7411.295926886937;7486.5508069516;7525.360344370681;7527.962360188273;7529.962350188214;494.69081823860085;509.3022559093991;509.4803300633333;509.78588992623185;514.2004183494627;5526.143447765603;5586.301712285965;5597.63615365;5639.041362968305;5656.236408084938;9055.922553512333;9305.395149315409;9391.671291504765;9394.295427842939;9517.714468565953;9332.626694932262;9335.439873607469;9345.205657519187;9370.437773733598;9408.811823763486;7138.821529461701;7329.230430804795;7401.888971665429;7402.518836275625;7405.851882962203;7267.709291628275;7386.852262954818;7391.113066432063;7401.7039318428815;7402.814929626802;8015.158408367038;8052.718154864786;8198.1391953844;8322.16778322163;8324.833503329779;8247.257746802576;8311.625976830936;8378.622961966605;8379.95810020946;8400.705975290835;5995.820125396245;6216.937830621817;6544.803655890331;6555.737770489127;6675.965225390072;7388.815279618053;7417.666205020679;7454.217307182667;7455.105387353552;7457.7389791357045;6665.433438157617;6794.694238759366;6834.248232694499;6900.068490753684;6944.618046007316;6833.180018397626;6856.177258728984;6907.102076730194;6958.3041695832035;7012.123484564429;7048.541844780073;7135.357817796424;7135.892961605477;7167.426605871414;7177.641117944187;6457.547971642128;6488.935110648833;6541.149650545399;6581.848176569177;6587.077809106825;6432.421082102634;6473.643949582818;6477;6488.870222595616;6531.216254049545 20:15:51 INFO - PROCESS | 28854 | |4;prototype.html;323.63914235627266;325.19676399293746;327.8573820388131;332.41992722698893;334.4381439182173;5674.773009079642;5781.942180578193;5802.245708057952;5835.883282334351;5851.444112809287;5752.539796816244;5801.361850196475;5811.854703632412;5839.7664093436315;5852.941470585293;4553.134904368159;4554.521775213605;4564.885877853064;4565.726056436608;4566.611837993774;4321.6326612238;4421.336799480072;4490.708103973231;4515.909681806362;4558.361829343895;4445.333200019991;4451.287793952968;4455.643548516111;4462.754548499831;4470.173017991666;4463.977680111579;4465.218586747323;4466.977665111686;4472.44094488189;4476.574725401114;3943.9211215775813;3944.9013774655577;3945.6251656092627;3947.230290093433;3948.506436695413;5535.142052981794;5547.583931205176;5549.1676248562635;5552.167174923794;5573.108302671593;5207;5210.426853046162;5211.1922651989;5216.817411390621;5217.817376391846;5952.136940143699;6101.816945491642;6132.202813634243;6138.14066030756;6193.597416167935;4193.832246710128;4195.307774217251;4197.832086716528;4200.6219440250525;4205.390218418343;6221.906671399933;6348.206474190726;6387.105805187278;6447.54867159299;6449.516286278501;4261.893452663709;4278.871633850989;4279.9786001070415;4282.8715138545895;4284.014676624394;4329.761863097497;4330.740155590612;4332.523422423531;4336.2845130553105;4341.696081274344;5039.722815245197;5051.797928082909;5054.721990290495;5055.595552355802;5059.215821547666;5954.464098231093;6094.847628809315;6208.348123447064;6225.159603453476;6230.221222347207;1521.1405555860904;1540.691861627679;1546.7215901137904;1549.1402271739069;1553.4562902984092;991.9950400247952;1006.0693858181153;1009.0867764672983;1010.7422607235108;1028.218553899042;5881.470667639933;5888.705564721747;5893;5904.498117660047;5904.9704751475965;6361.61830290184;6367.586106903036;6426.582272152295;6452.516061295328;6459.321771213955;5882.117682347596;5884.764609415575;5887.2052272943465;5890.8821823563285;5905.763769449174;3411.0449074259245;3434.261633748706;3438.0373495421322;3438.6045604755273;3446.190145315849;6473.643949582724;6658.600483970978;6663.800085997428;6736.225334086643;6760.3239676032;6561.639109849004;6621.437177839841;6623.370779775913;6626.768063117768;6632.8673426531195;6751.392374686302;6754.155730533684;6754.797356079325;6762.72949082041;6764.864702706017;6453.870922581428;6456.418922297016;6467.191601049869;6467.288598254282;6468.644224567505;6216.44052035319;6402.711877965596;6405.871882562229;6409.519286053472;6425.22897252314;6696.464282857262;6729.259781424137;6730.394264516217;6745.662716864235;6762.966185169043;4321.78391080451;4338.327559228324;4349.847755328548;4350.303951367766;4358.4769827620885;6212.751489940532;6340.334264902119;6480.805575832733;6538.803835884931;6554.901676474761;6303.558750887394;6311.147995020797;6326.240851097898;6334.334894835976;6338.207724034496;6240.7503699851495;6255.968720156552;6257.68711564429;6259.092431597302;6264.530160238091;6156.07658851158;6160.476359509492;6166.537509686702;6167.074938759222;6191.1641928339095;6147.538934579835;6291.370862913672;6302.338254483397;6302.684865756602;6303.991361382157;6099.268087829489;6126.356732543019;6127.816165515042;6128.540359473147;6184.165137706352 20:15:51 INFO - PROCESS | 28854 | |5;yui.html;735.646889493043;748.9513181643193;761.2083433229438;762.1996903251585;771.517801374141;13522.661933451656;13910.652233694163;13921.23433211173;13936.6515837104;13943.163410195395;13104.08271421001;13166.605001849959;13201.537946171886;13209.471621135142;13224.140430871987;654.7839213059679;816.9387295952797;826.6982551368767;830.5349004557437;831.5468069901918;825.3026192867018;826.4173757500947;827.9089300177005;828.8300898315831;829.498153617062;698.5494356140287;833.7707130539089;876.662484943295;878.8198419324056;879.9208071273584;844.2865778417258;846.8941382327209;848.8132610825609;849.452103393314;849.6516428264382;634.6477704873839;635.726637545855;635.8473966248114;638.2659941067762;640.218932901859;13358.532451364254;13406.731865362639;13412.597622071353;13419.329033548283;13432.731345373135;12629.494820207181;12755.872441275655;12879;13389.86610133896;13507.446643636009;10652.467376631137;10669.519871605797;10704.19718521114;10715.249932504728;10720.249582529226;3595.874144404959;3663.3955397359405;3669.972407725841;3761.360568703327;3766.359718847775;47987.76006119982;48079;48207.517924821004;48238.51761482375;48239.75880120612;10015.198784097254;10345.793084138275;10391.37651740898;10434.478276086165;10443.164546836235;18953;19047.52381190481;19092.2363105477;19098.427047188605;19101.61796764057;7194.956731273936;7695.653695583712;7721.575313357707;7928.801779955432;7987.480813747088;4238.406623072772;4329.826806927687;4341.674374421931;4362.389265502832;4377.343398490252;2975.8065725727756;3168.651448340681;3180.157258326545;3186.330870517171;3193.1538142392283;599.9640021598718;631.950961404067;638.3456956619502;642.457123730447;654.1430725749188;658.3548122839644;682.7337338438014;698.5494356140363;703.3072423662688;704.1655638068904;8545.74362769118;9082.954585227031;9298.488583127857;9409.247260219166;9565.139137477661;604.7792555717219;609.1411110334407;619.5879739972958;621.4251817069284;638.6502792851524;4078.204750073707;4095.2219078375015;4288.335308027198;4408.493023302297;4435.379046933432;53768.462315377124;54427.45572544224;54528.45471545313;55253.723731381084;55417;48513;48630.270545941836;48870.51129488659;48960.26559601609;49462.75268623634;43886.12227755427;43900.341494877604;43966.340504891814;44412.55587444149;44701.55298447039;8292.917070829215;8718.91281087181;8811.691590794291;8958.462492250486;8970.86543701832;33163.17092072718;33399.33201335911;33888.49167262542;34175.658243417245;34369.62521499212;38493.42259866048;38596.42105368478;40727.38908916428;44472.55527444814;44686.3297050551;10777.353358798497;11299.983001529901;11364.602238921929;11865.28808271472;12336;12432.440540175532;12780.424880880197;12780.936095319465;12854.614361569167;13102;11280.210385272952;11605.825912611148;11880.34658093813;12187.110207773361;12314.384280786104;11758;12320.383980800745;12511.1867728601;12728.745425091261;12790.296533690364;11656.125790565911;11897.464614092214;12259.877401226231;12488.25070495773;12495.562655307021;9784.364016338915;9835.803283934425;9849.409035457895;10172.745681358025;10200.38797672142;9202.861957070516;9785.85321220168;9817.656382026595;9896.406215627085;10008.14930730867 20:15:51 INFO - PROCESS | 28854 | __end_tp_report 20:15:51 INFO - PROCESS | 28854 | __start_cc_report 20:15:51 INFO - PROCESS | 28854 | _x_x_mozilla_cycle_collect,946 20:15:51 INFO - PROCESS | 28854 | __end_cc_report 20:15:51 INFO - PROCESS | 28854 | __startTimestamp1456200951040__endTimestamp 20:15:51 INFO - PROCESS | 28854 | 20:15:51 INFO - PROCESS | 28854 | ------- Summary: start ------- 20:15:51 INFO - PROCESS | 28854 | Number of tests: 6 20:15:51 INFO - PROCESS | 28854 | 20:15:51 INFO - PROCESS | 28854 | [#0] dojo.html Cycles:165 Average:5147.16 Median:5337.17 stddev:555.38 (10.4%) stddev-sans-first:533.68 20:15:51 INFO - PROCESS | 28854 | Values: 3113.7 3116.5 3149.0 3155.8 3183.7 5033.7 5084.9 5097.9 5142.1 5145.6 5109.4 5117.5 5119.7 5135.9 5156.6 4661.3 4684.7 4729.4 4775.0 4879.0 4817.0 4824.6 4856.1 4882.1 4905.4 4645.5 4679.9 4723.1 4728.9 4759.8 4731.9 4740.9 4742.1 4744.2 4780.3 4585.8 4653.3 4698.8 4719.2 4742.7 4950.2 4963.2 4968.8 4970.3 5010.5 5447.3 5448.5 5450.2 5467.0 5506.6 5488.1 5494.0 5542.6 5582.8 5603.6 5221.6 5241.4 5241.7 5244.4 5249.0 5554.7 5700.9 5702.5 5703.3 5703.4 5398.0 5419.3 5442.2 5445.2 5496.2 5539.3 5577.1 5577.1 5577.4 5581.7 5423.2 5496.7 5522.4 5545.3 5565.7 5495.1 5527.7 5527.7 5528.0 5533.1 4303.3 4312.3 4312.4 4342.0 4357.9 3803.9 3844.1 3856.5 3891.1 3898.2 5172.3 5175.6 5183.9 5190.9 5234.2 5533.7 5534.8 5554.6 5554.8 5555.7 5111.9 5128.8 5135.7 5168.1 5201.1 4743.6 4763.5 4766.5 4766.8 4820.4 5608.8 5733.9 5761.5 5775.3 5792.6 5574.2 5577.0 5602.1 5604.2 5631.0 5789.7 5807.7 5809.8 5815.1 5833.4 5384.2 5454.2 5481.8 5519.0 5533.1 5492.4 5501.9 5516.4 5541.9 5542.6 5262.9 5370.4 5371.4 5398.8 5430.4 5402.8 5431.2 5444.9 5450.4 5493.6 5328.1 5337.2 5344.6 5348.1 5406.9 5361.5 5381.2 5413.6 5426.6 5456.8 5235.5 5238.8 5248.5 5262.3 5303.9 20:15:51 INFO - PROCESS | 28854 | 20:15:51 INFO - PROCESS | 28854 | [#1] ext.html Cycles:180 Average:43490.46 Median:35122.15 stddev:69805.12 (198.7%) stddev-sans-first:69926.39 20:15:51 INFO - PROCESS | 28854 | Values: 524.6 557.8 566.0 582.9 586.5 28826.3 36321.0 36997.8 37079.1 37119.6 39643.4 40050.2 40159.0 40267.4 40310.0 8366.1 8549.0 8559.4 8563.6 8566.6 8489.9 8610.5 8629.1 8635.2 8847.1 8820.0 8868.4 8887.8 8908.8 8937.4 8783.3 8805.7 8830.6 8877.8 8879.4 8604.9 8746.3 8753.4 8804.0 8806.3 39377.8 39400.4 39948.4 39955.0 40028.2 3393.5 3472.4 3833.0 3975.7 4116.0 29700.9 30275.0 30529.7 30567.2 30768.8 3841.9 3909.7 3941.7 3979.6 4111.5 258217.7 258891.0 259324.0 260819.0 261356.0 51664.2 57167.4 57470.4 57516.4 59852.1 53689.7 53705.5 53841.7 53853.7 53868.5 16022.9 16264.3 16297.6 16330.8 16340.0 11267.0 12338.8 12381.8 12538.0 12797.9 18833.3 18881.4 19095.3 19105.8 19136.1 7143.3 7348.9 7396.6 7414.1 7485.6 899.5 998.3 1024.4 1037.4 1039.6 26581.6 27405.7 27583.0 27738.2 27842.4 1009.3 1011.2 1023.8 1104.9 1130.5 14103.2 14442.4 14614.6 15594.5 15788.7 246076.0 246266.0 247254.0 248531.0 249529.0 47797.5 48129.0 48178.8 48208.8 48214.8 1362.2 1368.4 1397.2 1398.8 1401.5 26240.5 29263.0 29542.4 29701.7 29923.3 45769.0 46537.3 46583.0 46638.0 46657.5 279893.0 285466.0 297108.0 305254.0 305619.0 27409.9 28010.9 31900.5 33601.5 33926.3 40864.8 41165.0 41488.8 42351.6 42461.4 33934.5 34086.5 34309.8 34399.1 34612.0 34568.0 34568.0 34981.8 35444.5 35489.6 31004.7 31731.8 35262.5 35792.5 35815.8 27941.6 31757.4 31834.5 33792.5 34046.3 23623.5 23645.0 23970.0 24010.2 24692.9 20:15:51 INFO - PROCESS | 28854 | 20:15:51 INFO - PROCESS | 28854 | [#2] jquery.html Cycles:180 Average:24210.78 Median:353.94 stddev:67566.01 (19089.6%) stddev-sans-first:67731.80 20:15:51 INFO - PROCESS | 28854 | Values: 352.2 352.3 353.7 354.2 356.2 14004.4 16388.3 16995.7 17369.4 17494.2 11109.4 11432.2 11504.4 11730.9 16284.1 4688.0 4837.4 4868.6 4871.8 4890.3 3693.8 5151.7 5276.7 5292.6 5298.1 5262.8 5267.6 5276.5 5280.3 5283.7 5130.2 5198.3 5250.1 5252.6 5262.0 4992.6 4996.4 4997.2 5000.0 5051.8 12183.5 19257.0 19490.8 19743.8 19921.5 2122.2 2123.7 2205.1 2405.2 2538.3 9038.0 9143.9 9227.8 9480.8 9710.5 1741.9 1833.8 1834.6 1860.9 1880.3 57836.7 59847.7 61517.7 61904.7 63162.7 10050.5 10245.2 10316.8 10358.8 10418.9 12461.6 13390.9 13613.4 13622.3 13627.9 7511.2 7774.0 7804.3 7917.6 7941.0 7781.2 7802.6 7835.5 7896.4 7897.8 4608.5 4680.5 4688.0 4718.3 4720.1 1825.1 1842.1 1863.4 1881.6 1922.3 918.6 950.4 964.2 978.2 1048.5 16179.4 16578.9 16681.2 16702.7 17458.6 920.2 979.2 1004.7 1011.4 1048.8 8077.5 9221.6 9275.8 9857.9 10172.3 398754.0 408896.0 410593.0 415237.0 425664.0 72711.0 72799.0 73333.3 73588.0 74590.6 964.1 1035.7 1037.9 1063.1 1068.2 14479.1 14662.3 14682.3 14920.6 15022.4 30501.2 31437.2 31890.8 32167.2 33323.0 43464.0 43631.6 44007.6 44045.3 44290.3 7712.0 7890.6 7915.1 7939.4 8038.8 12383.1 12829.6 13029.2 13301.1 13486.2 10993.8 11236.8 11275.6 11418.8 11507.0 10990.0 11163.8 11200.3 11431.7 11788.2 11363.1 11594.1 11644.2 11771.1 11792.7 7818.3 7929.4 8227.8 8238.5 8312.2 9788.9 10813.7 10969.6 11273.5 11499.2 20:15:51 INFO - PROCESS | 28854 | 20:15:51 INFO - PROCESS | 28854 | [#3] mootools.html Cycles:180 Average:5450.61 Median:6106.38 stddev:2855.66 (46.8%) stddev-sans-first:2847.22 20:15:51 INFO - PROCESS | 28854 | Values: 1372.7 1471.9 1476.4 1645.2 1810.6 7557.5 7724.5 7728.9 7763.7 7764.7 7385.8 7550.7 7551.0 7579.2 7622.0 1926.0 2265.2 2272.4 2298.3 2320.8 2284.6 2311.5 2325.4 2327.6 2328.6 2305.4 2310.1 2311.1 2311.8 2313.4 2181.7 2233.8 2236.3 2236.7 2236.8 2252.8 2264.1 2269.2 2309.1 2310.2 7662.6 7678.7 7718.6 7720.8 7725.2 4677.8 4790.5 4795.8 4795.8 4799.2 3186.6 3234.2 3250.6 3265.1 3308.1 1058.3 1065.0 1085.2 1091.4 1092.9 11087.5 11196.9 11198.0 11202.9 11209.6 4292.8 4322.0 4335.0 4373.2 4373.2 9470.1 9470.3 9470.5 9474.0 9476.9 4104.2 4567.6 4823.3 4858.3 4861.0 4206.0 4247.6 4250.9 4261.9 4264.3 3632.9 3633.1 3640.1 3678.2 3691.8 1134.6 1136.7 1140.3 1149.0 1149.1 1315.6 1321.8 1341.5 1371.6 1390.3 7411.3 7486.6 7525.4 7528.0 7530.0 494.7 509.3 509.5 509.8 514.2 5526.1 5586.3 5597.6 5639.0 5656.2 9055.9 9305.4 9391.7 9394.3 9517.7 9332.6 9335.4 9345.2 9370.4 9408.8 7138.8 7329.2 7401.9 7402.5 7405.9 7267.7 7386.9 7391.1 7401.7 7402.8 8015.2 8052.7 8198.1 8322.2 8324.8 8247.3 8311.6 8378.6 8380.0 8400.7 5995.8 6216.9 6544.8 6555.7 6676.0 7388.8 7417.7 7454.2 7455.1 7457.7 6665.4 6794.7 6834.2 6900.1 6944.6 6833.2 6856.2 6907.1 6958.3 7012.1 7048.5 7135.4 7135.9 7167.4 7177.6 6457.5 6488.9 6541.1 6581.8 6587.1 6432.4 6473.6 6477.0 6488.9 6531.2 20:15:51 INFO - PROCESS | 28854 | 20:15:51 INFO - PROCESS | 28854 | [#4] prototype.html Cycles:180 Average:5187.97 Median:5883.44 stddev:1584.54 (26.9%) stddev-sans-first:1546.35 20:15:51 INFO - PROCESS | 28854 | Values: 323.6 325.2 327.9 332.4 334.4 5674.8 5781.9 5802.2 5835.9 5851.4 5752.5 5801.4 5811.9 5839.8 5852.9 4553.1 4554.5 4564.9 4565.7 4566.6 4321.6 4421.3 4490.7 4515.9 4558.4 4445.3 4451.3 4455.6 4462.8 4470.2 4464.0 4465.2 4467.0 4472.4 4476.6 3943.9 3944.9 3945.6 3947.2 3948.5 5535.1 5547.6 5549.2 5552.2 5573.1 5207.0 5210.4 5211.2 5216.8 5217.8 5952.1 6101.8 6132.2 6138.1 6193.6 4193.8 4195.3 4197.8 4200.6 4205.4 6221.9 6348.2 6387.1 6447.5 6449.5 4261.9 4278.9 4280.0 4282.9 4284.0 4329.8 4330.7 4332.5 4336.3 4341.7 5039.7 5051.8 5054.7 5055.6 5059.2 5954.5 6094.8 6208.3 6225.2 6230.2 1521.1 1540.7 1546.7 1549.1 1553.5 992.0 1006.1 1009.1 1010.7 1028.2 5881.5 5888.7 5893.0 5904.5 5905.0 6361.6 6367.6 6426.6 6452.5 6459.3 5882.1 5884.8 5887.2 5890.9 5905.8 3411.0 3434.3 3438.0 3438.6 3446.2 6473.6 6658.6 6663.8 6736.2 6760.3 6561.6 6621.4 6623.4 6626.8 6632.9 6751.4 6754.2 6754.8 6762.7 6764.9 6453.9 6456.4 6467.2 6467.3 6468.6 6216.4 6402.7 6405.9 6409.5 6425.2 6696.5 6729.3 6730.4 6745.7 6763.0 4321.8 4338.3 4349.8 4350.3 4358.5 6212.8 6340.3 6480.8 6538.8 6554.9 6303.6 6311.1 6326.2 6334.3 6338.2 6240.8 6256.0 6257.7 6259.1 6264.5 6156.1 6160.5 6166.5 6167.1 6191.2 6147.5 6291.4 6302.3 6302.7 6304.0 6099.3 6126.4 6127.8 6128.5 6184.2 20:15:51 INFO - PROCESS | 28854 | 20:15:51 INFO - PROCESS | 28854 | [#5] yui.html Cycles:180 Average:13688.54 Median:43933.34 stddev:15215.13 (34.6%) stddev-sans-first:15226.71 20:15:51 INFO - PROCESS | 28854 | Values: 735.6 749.0 761.2 762.2 771.5 13522.7 13910.7 13921.2 13936.7 13943.2 13104.1 13166.6 13201.5 13209.5 13224.1 654.8 816.9 826.7 830.5 831.5 825.3 826.4 827.9 828.8 829.5 698.5 833.8 876.7 878.8 879.9 844.3 846.9 848.8 849.5 849.7 634.6 635.7 635.8 638.3 640.2 13358.5 13406.7 13412.6 13419.3 13432.7 12629.5 12755.9 12879.0 13389.9 13507.4 10652.5 10669.5 10704.2 10715.2 10720.2 3595.9 3663.4 3670.0 3761.4 3766.4 47987.8 48079.0 48207.5 48238.5 48239.8 10015.2 10345.8 10391.4 10434.5 10443.2 18953.0 19047.5 19092.2 19098.4 19101.6 7195.0 7695.7 7721.6 7928.8 7987.5 4238.4 4329.8 4341.7 4362.4 4377.3 2975.8 3168.7 3180.2 3186.3 3193.2 600.0 632.0 638.3 642.5 654.1 658.4 682.7 698.5 703.3 704.2 8545.7 9083.0 9298.5 9409.2 9565.1 604.8 609.1 619.6 621.4 638.7 4078.2 4095.2 4288.3 4408.5 4435.4 53768.5 54427.5 54528.5 55253.7 55417.0 48513.0 48630.3 48870.5 48960.3 49462.8 43886.1 43900.3 43966.3 44412.6 44701.6 8292.9 8718.9 8811.7 8958.5 8970.9 33163.2 33399.3 33888.5 34175.7 34369.6 38493.4 38596.4 40727.4 44472.6 44686.3 10777.4 11300.0 11364.6 11865.3 12336.0 12432.4 12780.4 12780.9 12854.6 13102.0 11280.2 11605.8 11880.3 12187.1 12314.4 11758.0 12320.4 12511.2 12728.7 12790.3 11656.1 11897.5 12259.9 12488.3 12495.6 9784.4 9835.8 9849.4 10172.7 10200.4 9202.9 9785.9 9817.7 9896.4 10008.1 20:15:51 INFO - PROCESS | 28854 | -------- Summary: end -------- 20:15:51 INFO - PROCESS | 28854 | 20:15:51 INFO - TEST-INFO | 28854: exit 0 20:15:51 INFO - TEST-OK | dromaeo_css | took 1113283ms 20:15:51 INFO - TEST-START | kraken 20:15:51 INFO - operating with platform_type : linux_ 20:15:51 INFO - Initialising browser for kraken test... 20:15:51 INFO - TEST-INFO | started process 29034 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAnabUn/profile http://localhost:51773/getInfo.html) 20:15:55 INFO - PROCESS | 29034 | __metrics Screen width/height:1600/1200 20:15:55 INFO - PROCESS | 29034 | colorDepth:24 20:15:55 INFO - PROCESS | 29034 | Browser inner width/height: 1024/697 20:15:55 INFO - PROCESS | 29034 | __metrics 20:15:56 INFO - PROCESS | 29034 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:15:57 INFO - TEST-INFO | 29034: exit 0 20:15:57 INFO - Browser initialized. 20:15:57 INFO - Running cycle 1/1 for kraken test... 20:15:57 INFO - TEST-INFO | started process 29121 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAnabUn/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:16:09 INFO - PROCESS | 29121 | RSS: Main: 149254144 20:16:09 INFO - PROCESS | 29121 | 20:16:11 INFO - PROCESS | 29121 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51773/tests/kraken/driver.html?testName=audio-beat-detection) 20:16:12 INFO - PROCESS | 29121 | RSS: Main: 192098304 20:16:12 INFO - PROCESS | 29121 | 20:16:15 INFO - PROCESS | 29121 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51773/tests/kraken/driver.html?testName=audio-dft) 20:16:15 INFO - PROCESS | 29121 | RSS: Main: 181121024 20:16:15 INFO - PROCESS | 29121 | 20:16:18 INFO - PROCESS | 29121 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51773/tests/kraken/driver.html?testName=audio-fft) 20:16:19 INFO - PROCESS | 29121 | RSS: Main: 165965824 20:16:19 INFO - PROCESS | 29121 | 20:16:21 INFO - PROCESS | 29121 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51773/tests/kraken/driver.html?testName=audio-oscillator) 20:16:21 INFO - PROCESS | 29121 | RSS: Main: 167673856 20:16:21 INFO - PROCESS | 29121 | 20:16:23 INFO - PROCESS | 29121 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51773/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:16:24 INFO - PROCESS | 29121 | RSS: Main: 170688512 20:16:24 INFO - PROCESS | 29121 | 20:16:27 INFO - PROCESS | 29121 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51773/tests/kraken/driver.html?testName=imaging-darkroom) 20:16:28 INFO - PROCESS | 29121 | RSS: Main: 171347968 20:16:28 INFO - PROCESS | 29121 | 20:16:31 INFO - PROCESS | 29121 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51773/tests/kraken/driver.html?testName=imaging-desaturate) 20:16:32 INFO - PROCESS | 29121 | RSS: Main: 170053632 20:16:32 INFO - PROCESS | 29121 | 20:16:34 INFO - PROCESS | 29121 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51773/tests/kraken/driver.html?testName=json-parse-financial) 20:16:35 INFO - PROCESS | 29121 | RSS: Main: 171962368 20:16:35 INFO - PROCESS | 29121 | 20:16:37 INFO - PROCESS | 29121 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51773/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:16:37 INFO - PROCESS | 29121 | RSS: Main: 182145024 20:16:37 INFO - PROCESS | 29121 | 20:16:39 INFO - PROCESS | 29121 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51773/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:16:40 INFO - PROCESS | 29121 | RSS: Main: 180342784 20:16:40 INFO - PROCESS | 29121 | 20:16:42 INFO - PROCESS | 29121 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51773/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:16:42 INFO - PROCESS | 29121 | RSS: Main: 191971328 20:16:42 INFO - PROCESS | 29121 | 20:16:45 INFO - PROCESS | 29121 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51773/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:16:45 INFO - PROCESS | 29121 | RSS: Main: 198365184 20:16:45 INFO - PROCESS | 29121 | 20:16:48 INFO - PROCESS | 29121 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51773/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:16:48 INFO - PROCESS | 29121 | RSS: Main: 199176192 20:16:48 INFO - PROCESS | 29121 | 20:16:50 INFO - PROCESS | 29121 | Cycle 1(1): loaded http://localhost:51773/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51773/tests/kraken/driver.html?testName=ai-astar) 20:16:50 INFO - PROCESS | 29121 | RSS: Main: 258355200 20:16:50 INFO - PROCESS | 29121 | 20:16:50 INFO - PROCESS | 29121 | __start_tp_report 20:16:50 INFO - PROCESS | 29121 | _x_x_mozilla_page_load 20:16:50 INFO - PROCESS | 29121 | _x_x_mozilla_page_load_details 20:16:50 INFO - PROCESS | 29121 | |i|pagename|runs| 20:16:50 INFO - PROCESS | 29121 | |0;ai-astar;112;112;107;111;111;111;104;111;110;112 20:16:50 INFO - PROCESS | 29121 | |1;audio-beat-detection;151;130;152;171;128;158;147;136;165;129 20:16:50 INFO - PROCESS | 29121 | |2;audio-dft;163;162;161;160;160;160;161;162;162;162 20:16:50 INFO - PROCESS | 29121 | |3;audio-fft;73;72;96;99;73;73;74;108;94;73 20:16:50 INFO - PROCESS | 29121 | |4;audio-oscillator;95;96;143;96;98;96;139;95;97;141 20:16:50 INFO - PROCESS | 29121 | |5;imaging-gaussian-blur;119;115;115;117;115;115;116;115;116;115 20:16:50 INFO - PROCESS | 29121 | |6;imaging-darkroom;146;147;147;145;146;146;146;146;146;146 20:16:50 INFO - PROCESS | 29121 | |7;imaging-desaturate;97;97;96;95;95;95;96;96;96;96 20:16:50 INFO - PROCESS | 29121 | |8;json-parse-financial;57;56;56;55;55;56;57;64;53;53 20:16:50 INFO - PROCESS | 29121 | |9;json-stringify-tinderbox;68;68;68;67;69;69;68;69;68;69 20:16:50 INFO - PROCESS | 29121 | |10;stanford-crypto-aes;82;91;84;82;91;89;83;84;82;83 20:16:50 INFO - PROCESS | 29121 | |11;stanford-crypto-ccm;116;115;115;117;126;115;113;115;124;117 20:16:50 INFO - PROCESS | 29121 | |12;stanford-crypto-pbkdf2;154;141;150;146;149;140;161;149;147;161 20:16:50 INFO - PROCESS | 29121 | |13;stanford-crypto-sha256-iterative;70;68;68;67;67;68;69;67;67;67 20:16:50 INFO - PROCESS | 29121 | __end_tp_report 20:16:50 INFO - PROCESS | 29121 | __start_cc_report 20:16:50 INFO - PROCESS | 29121 | _x_x_mozilla_cycle_collect,951 20:16:50 INFO - PROCESS | 29121 | __end_cc_report 20:16:50 INFO - PROCESS | 29121 | __startTimestamp1456201010740__endTimestamp 20:16:50 INFO - PROCESS | 29121 | 20:16:50 INFO - PROCESS | 29121 | ------- Summary: start ------- 20:16:50 INFO - PROCESS | 29121 | Number of tests: 14 20:16:50 INFO - PROCESS | 29121 | 20:16:50 INFO - PROCESS | 29121 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.60 (2.3%) stddev-sans-first:2.67 20:16:50 INFO - PROCESS | 29121 | Values: 112.0 112.0 107.0 111.0 111.0 111.0 104.0 111.0 110.0 112.0 20:16:50 INFO - PROCESS | 29121 | 20:16:50 INFO - PROCESS | 29121 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:151.50 stddev:15.48 (10.2%) stddev-sans-first:16.34 20:16:50 INFO - PROCESS | 29121 | Values: 151.0 130.0 152.0 171.0 128.0 158.0 147.0 136.0 165.0 129.0 20:16:50 INFO - PROCESS | 29121 | 20:16:50 INFO - PROCESS | 29121 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:0.93 20:16:50 INFO - PROCESS | 29121 | Values: 163.0 162.0 161.0 160.0 160.0 160.0 161.0 162.0 162.0 162.0 20:16:50 INFO - PROCESS | 29121 | 20:16:50 INFO - PROCESS | 29121 | [#3] audio-fft Cycles:10 Average:83.50 Median:73.50 stddev:14.03 (19.1%) stddev-sans-first:14.35 20:16:50 INFO - PROCESS | 29121 | Values: 73.0 72.0 96.0 99.0 73.0 73.0 74.0 108.0 94.0 73.0 20:16:50 INFO - PROCESS | 29121 | 20:16:50 INFO - PROCESS | 29121 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:96.00 stddev:21.71 (22.6%) stddev-sans-first:22.37 20:16:50 INFO - PROCESS | 29121 | Values: 95.0 96.0 143.0 96.0 98.0 96.0 139.0 95.0 97.0 141.0 20:16:50 INFO - PROCESS | 29121 | 20:16:50 INFO - PROCESS | 29121 | [#5] imaging-gaussian-blur Cycles:10 Average:115.80 Median:115.50 stddev:1.32 (1.1%) stddev-sans-first:0.73 20:16:50 INFO - PROCESS | 29121 | Values: 119.0 115.0 115.0 117.0 115.0 115.0 116.0 115.0 116.0 115.0 20:16:50 INFO - PROCESS | 29121 | 20:16:50 INFO - PROCESS | 29121 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 20:16:50 INFO - PROCESS | 29121 | Values: 146.0 147.0 147.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 20:16:50 INFO - PROCESS | 29121 | 20:16:50 INFO - PROCESS | 29121 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 20:16:50 INFO - PROCESS | 29121 | Values: 97.0 97.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 20:16:50 INFO - PROCESS | 29121 | 20:16:50 INFO - PROCESS | 29121 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:3.08 (5.5%) stddev-sans-first:3.26 20:16:50 INFO - PROCESS | 29121 | Values: 57.0 56.0 56.0 55.0 55.0 56.0 57.0 64.0 53.0 53.0 20:16:50 INFO - PROCESS | 29121 | 20:16:50 INFO - PROCESS | 29121 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 20:16:50 INFO - PROCESS | 29121 | Values: 68.0 68.0 68.0 67.0 69.0 69.0 68.0 69.0 68.0 69.0 20:16:50 INFO - PROCESS | 29121 | 20:16:50 INFO - PROCESS | 29121 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:84.00 stddev:3.73 (4.4%) stddev-sans-first:3.78 20:16:50 INFO - PROCESS | 29121 | Values: 82.0 91.0 84.0 82.0 91.0 89.0 83.0 84.0 82.0 83.0 20:16:50 INFO - PROCESS | 29121 | 20:16:50 INFO - PROCESS | 29121 | [#11] stanford-crypto-ccm Cycles:10 Average:117.30 Median:116.50 stddev:4.24 (3.6%) stddev-sans-first:4.48 20:16:50 INFO - PROCESS | 29121 | Values: 116.0 115.0 115.0 117.0 126.0 115.0 113.0 115.0 124.0 117.0 20:16:50 INFO - PROCESS | 29121 | 20:16:50 INFO - PROCESS | 29121 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.80 Median:149.50 stddev:7.19 (4.8%) stddev-sans-first:7.47 20:16:50 INFO - PROCESS | 29121 | Values: 154.0 141.0 150.0 146.0 149.0 140.0 161.0 149.0 147.0 161.0 20:16:50 INFO - PROCESS | 29121 | 20:16:50 INFO - PROCESS | 29121 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.03 (1.5%) stddev-sans-first:0.73 20:16:50 INFO - PROCESS | 29121 | Values: 70.0 68.0 68.0 67.0 67.0 68.0 69.0 67.0 67.0 67.0 20:16:50 INFO - PROCESS | 29121 | -------- Summary: end -------- 20:16:50 INFO - PROCESS | 29121 | 20:16:51 INFO - TEST-INFO | 29121: exit 0 20:16:51 INFO - TEST-OK | kraken | took 59982ms 20:16:51 INFO - SUITE-END | took 1173s 20:16:51 INFO - Completed test suite (00:19:33) 20:16:51 INFO - Working with test: dromaeo_css 20:16:51 INFO - Generating results file: dromaeo_css 20:16:51 INFO - Working with test: kraken 20:16:51 INFO - Generating results file: kraken 20:16:51 INFO - javascript benchmark 20:16:51 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:16:51 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 20:16:51 INFO - process_Request line: dromaeo_css 6821.60 graph.html#tests=[[72,64,35]] 20:16:51 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:16:51 INFO - process_Request line: kraken 1513.50 graph.html#tests=[[232,64,35]] 20:16:51 INFO - RETURN: dromaeo_css: 6821.60 20:16:51 INFO - RETURN: kraken: 1513.50 20:16:51 INFO - javascript benchmark 20:16:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3113.6886311368858, 3116.4546204414223, 3148.9685103148963, 3155.7633177511693, 3183.681631836816, 5033.7483125843655, 5084.949150508493, 5097.923531147036, 5142.074426603214, 5145.639805213632, 5109.4379618241965, 5117.462666420028, 5119.718415487147, 5135.948640513594, 5156.561692256153, 4661.30080487927, 4684.695494792828, 4729.408823897013, 4774.9761251193695, 4879.0, 4816.951830481703, 4824.614030877539, 4856.1016212000895, 4882.07240624282, 4905.362302900618, 4645.535446455361, 4679.859604211879, 4723.055388922195, 4728.858134255978, 4759.785809638574, 4731.929021064687, 4740.905181896343, 4742.146413645542, 4744.193487107165, 4780.306855505932, 4585.793639286207, 4653.325267836145, 4698.7650617469335, 4719.244920812654, 4742.739149346785, 4950.232713929347, 4963.1562634351885, 4968.801247950078, 4970.2793095001025, 5010.5240002199735, 5447.319085114361, 5448.482394172547, 5450.182472629098, 5466.972665136688, 5506.614536982413, 5488.1493368527945, 5494.0, 5542.5565954723925, 5582.8325150245155, 5603.579731520153, 5221.6083793715625, 5241.397239317527, 5241.68549887008, 5244.370675518962, 5249.0, 5554.72226388679, 5700.885982280414, 5702.45826646468, 5703.315602127771, 5703.372629010805, 5397.973010134924, 5419.3225846769155, 5442.2380866678695, 5445.210444485528, 5496.1755736639825, 5539.2522009529, 5577.05190117681, 5577.135543990688, 5577.386487486373, 5581.720913954286, 5423.18652202165, 5496.697681627469, 5522.364928033247, 5545.251391062155, 5565.721713914288, 5495.093309603951, 5527.668339899538, 5527.695976721319, 5527.972360138254, 5533.087040638249, 4303.311470164821, 4312.288472402081, 4312.396264522969, 4341.956580434218, 4357.934630980538, 3803.8858834235016, 3844.115853353744, 3856.4986551748093, 3891.124496988155, 3898.181381909774, 5172.301739265226, 5175.560077393464, 5183.870403239949, 5190.948090519047, 5234.188700751313, 5533.667979921218, 5534.778608855681, 5554.638948468337, 5554.833354999276, 5555.72221388937, 5111.897762044739, 5128.79484820603, 5135.743212839343, 5168.121419358718, 5201.141811601119, 4743.644226683013, 4763.54746299101, 4766.547178018082, 4766.809327626856, 4820.373351464357, 5608.775648974077, 5733.913991290217, 5761.452661997104, 5775.306963164363, 5792.594518383757, 5574.219609254626, 5576.972115139399, 5602.1036634138345, 5604.187392828098, 5631.042722737063, 5789.681567513827, 5807.680577568105, 5809.82570522885, 5815.069588865761, 5833.387494313036, 5384.246205531151, 5454.154606036071, 5481.753321100639, 5518.951399234133, 5533.114701647717, 5492.395836458067, 5501.9174712380145, 5516.393196748274, 5541.916871246854, 5542.584306177134, 5262.86842828917, 5370.436104209002, 5371.435999220025, 5398.838034858961, 5430.375506816767, 5402.783888644567, 5431.158170483582, 5444.863878403072, 5450.400455949763, 5493.560515158698, 5328.09422398201, 5337.172738225581, 5344.625876188629, 5348.1442969124755, 5406.945930540802, 5361.463853614608, 5381.246625472515, 5413.648112872651, 5426.593005524523, 5456.781728730806, 5235.528802407802, 5238.764255608583, 5248.527632513092, 5262.342207224097, 5303.893922121613], "unit": "score", "name": "dojo.html", "value": 5112.28776105615}, {"lowerIsBetter": false, "replicates": [524.6301357542931, 557.8298618921233, 565.9671100242058, 582.8571999860033, 586.4633860018083, 28826.279343016435, 36321.0, 36997.81501092491, 37079.07302317443, 37119.62880371199, 39643.40534891979, 40050.19899602006, 40159.0, 40267.39598906019, 40310.0, 8366.121557236478, 8549.0, 8559.358048146383, 8563.571821408936, 8566.571671416405, 8489.872651910226, 8610.52642104684, 8629.137086291383, 8635.179657932485, 8847.115288471134, 8820.0, 8868.37921345506, 8887.777805554848, 8908.777280567972, 8937.374383793138, 8783.253423459013, 8805.691800786974, 8830.55847207637, 8877.822443551126, 8879.422837515542, 8604.913950860473, 8746.256568191711, 8753.3872628916, 8804.0, 8806.251468625174, 39377.80311098455, 39400.408993865116, 39948.40077398841, 39955.0, 40028.19943601112, 3393.5418718473184, 3472.3576138414473, 3833.0, 3975.7216994810374, 4115.9588404115875, 29700.851495742598, 30275.0, 30529.69470305313, 30567.235819104477, 30768.8461557693, 3841.9423708644395, 3909.7263191576603, 3941.6649584785328, 3979.6418322350837, 4111.527174374955, 258217.7089114561, 258891.0, 259324.0, 260819.0, 261356.0, 51664.22503662448, 57167.42832571621, 57470.42529574734, 57516.42483575195, 59852.10221846676, 53689.731551341996, 53705.462945370826, 53841.73079134658, 53853.73073134688, 53868.461315387125, 16022.919885400499, 16264.268107935171, 16297.614702750161, 16330.75503867443, 16340.0, 11267.0, 12338.81491777624, 12381.814272785916, 12538.0, 12797.872021279669, 18833.34083307105, 18881.433556993314, 19095.331663391993, 19105.802832674144, 19136.138873750715, 7143.321384468467, 7348.926510734931, 7396.630168491554, 7414.147373052168, 7485.588292643957, 899.5052721003422, 998.3410948773919, 1024.4365598920565, 1037.3931250218707, 1039.5633833789827, 26581.601275980876, 27405.725942740715, 27583.0, 27738.167854964384, 27842.443151136864, 1009.2632378363835, 1011.231464087299, 1023.8054769593754, 1104.8784633690289, 1130.5364800431948, 14103.153810771386, 14442.350094245785, 14614.634634134232, 15594.454194103379, 15788.684226315409, 246076.0, 246266.0, 247254.0, 248531.0, 249529.0, 47797.52202478, 48129.0, 48178.75910620424, 48208.758956205, 48214.75892620515, 1362.2167253829089, 1368.3568722700513, 1397.189630014589, 1398.825146856643, 1401.4884567133126, 26240.4751904957, 29263.0, 29542.409151816413, 29701.702982970757, 29923.251918702208, 45769.0, 46537.301940471596, 46583.0, 46638.0, 46657.53342466532, 279893.0, 285466.0, 297108.0, 305254.0, 305619.0, 27409.862950685118, 28010.859945700955, 31900.5214921781, 33601.495977560844, 33926.32147357088, 40864.79567602143, 41165.0, 41488.79255603703, 42351.57648423476, 42461.363079553215, 33934.490982635776, 34086.48870266898, 34309.828450858586, 34399.14002149966, 34612.0, 34568.0, 34568.0, 34981.8250908754, 35444.46833297451, 35489.645103549665, 31004.689953101082, 31731.841340793148, 35262.47106293356, 35792.46311305281, 35815.82092089523, 27941.580876286465, 31757.36485270328, 31834.52248216325, 33792.49311260284, 34046.319073617895, 23623.527529449657, 23645.0, 23970.0, 24010.15964441236, 24692.876535617208], "unit": "score", "name": "ext.html", "value": 18080.135574109376}, {"lowerIsBetter": false, "replicates": [352.2128043822057, 352.2989251389735, 353.7011225514441, 354.18183994971616, 356.157687070079, 14004.369803358848, 16388.34446622135, 16995.66008679827, 17369.392071277507, 17494.21276042578, 11109.388983605899, 11432.199746017783, 11504.42477876105, 11730.882691173085, 16284.10437425941, 4688.0, 4837.371141751567, 4868.610511159099, 4871.756412179395, 4890.290907818364, 3693.815309234541, 5151.6908985460805, 5276.683398996072, 5292.550133238679, 5298.09932311508, 5262.81580144695, 5267.604929630274, 5276.525112739852, 5280.313559237313, 5283.682979021271, 5130.179171332587, 5198.2982297389935, 5250.107481728096, 5252.6323157379, 5262.02652509287, 4992.600591952635, 4996.4254110777365, 4997.225430058346, 4999.9500004999845, 5051.823186188502, 12183.451744671422, 19257.0, 19490.80509194904, 19743.80256197434, 19921.50196245091, 2122.2466024561368, 2123.7239158909397, 2205.106931692667, 2405.1581946318647, 2538.263903467992, 9038.0, 9143.862842057375, 9227.815443691088, 9480.762980925463, 9710.514474276328, 1741.9086808578, 1833.8441232495254, 1834.5872178759805, 1860.9348672796386, 1880.2666959885655, 57836.71081644565, 59847.70076149635, 61517.692411538104, 61904.69047654778, 63162.68418657923, 10050.547725352377, 10245.231607629457, 10316.793664126675, 10358.792824143475, 10418.895811041944, 12461.563845265373, 13390.866091338961, 13613.387397567134, 13622.250776207205, 13627.863721362659, 7511.211322811136, 7774.0, 7804.2585954334245, 7917.604119793988, 7941.0, 7781.221877812173, 7802.570858602831, 7835.490693105044, 7896.368290536743, 7897.842043159219, 4608.5161058088415, 4680.53194680536, 4688.0, 4718.339432479455, 4720.079584481062, 1825.1148193126323, 1842.1157844234574, 1863.3757691173337, 1881.6330815490849, 1922.3464022232229, 918.5958178401482, 950.4012472142506, 964.1852634523816, 978.1734434402919, 1048.4967215736337, 16179.43371981975, 16578.917105414635, 16681.24934377956, 16702.66594668124, 17458.56353591145, 920.2132176988579, 979.1921664626711, 1004.7086344960026, 1011.4133802394593, 1048.7797562511957, 8077.515349078956, 9221.631134754669, 9275.768105797275, 9857.852132218022, 10172.338797978107, 398754.0, 408896.0, 410593.0, 415237.0, 425664.0, 72711.0, 72799.0, 73333.26666733371, 73588.0, 74590.62704686442, 964.0841200859212, 1035.668586052456, 1037.8598889150019, 1063.1176123817213, 1068.166829872685, 14479.131252124485, 14662.34019469105, 14682.339294731977, 14920.552383428081, 15022.399104035716, 30501.23746906345, 31437.214069648442, 31890.840545797124, 32167.195820104684, 33323.0, 43464.0, 43631.56368436275, 44007.559924400346, 44045.33931991087, 44290.335644966, 7712.035995500562, 7890.5949424644305, 7915.129335773176, 7939.444238903221, 8038.83922321562, 12383.071269654632, 12829.550965716155, 13029.179622099946, 13301.135426197266, 13486.190828550318, 10993.835092473459, 11236.775264494501, 11275.605353812578, 11418.82871756941, 11507.0, 10990.0, 11163.832542511705, 11200.327980321206, 11431.657050288504, 11788.233764805604, 11363.090952723927, 11594.072474202212, 11644.2431241969, 11771.117166212398, 11792.70518237051, 7818.33544148731, 7929.405294603043, 8227.83544329122, 8238.546879921661, 8312.21034001769, 9788.9021109788, 10813.729656758644, 10969.561217551527, 11273.549058037916, 11499.195056345976], "unit": "score", "name": "jquery.html", "value": 8249.14945529134}, {"lowerIsBetter": false, "replicates": [1372.7460419822328, 1471.8822494200465, 1476.438953197785, 1645.2349657409302, 1810.6288210916755, 7557.546547207165, 7724.536527808328, 7728.92271077289, 7763.650635721392, 7764.689412423503, 7385.778426647209, 7550.660220290087, 7550.962245188766, 7579.1662917079075, 7622.047244094489, 1925.9711104333446, 2265.207177487874, 2272.4432514034083, 2298.287530865429, 2320.825938054644, 2284.6116160252795, 2311.4799170186657, 2325.4418939454495, 2327.592671282527, 2328.6274196128625, 2305.4236440889777, 2310.099061366069, 2311.0640190722784, 2311.826613004023, 2313.410080429488, 2181.6618424144285, 2233.8324625652976, 2236.2508559632543, 2236.664500324948, 2236.798688118069, 2252.7859853313907, 2264.105678257096, 2269.205777977711, 2309.110992267972, 2310.2260742651233, 7662.61686915652, 7678.654460549289, 7718.575478348688, 7720.845583088363, 7725.150233474314, 4677.789499472532, 4790.520947905216, 4795.760211989422, 4795.784189711471, 4799.208130658437, 3186.6176058873084, 3234.207619133327, 3250.6099268087746, 3265.053134590966, 3308.073739352985, 1058.3491152940962, 1065.046783129095, 1085.1535802074395, 1091.4433638844246, 1092.9016388525072, 11087.50106245229, 11196.888031119666, 11198.0, 11202.943985280102, 11209.607663731731, 4292.785360731951, 4321.956780432219, 4335.0, 4373.190959672471, 4373.2128216921255, 9470.14768670823, 9470.337076404723, 9470.52647367629, 9474.0, 9476.905230947741, 4104.199681062164, 4567.588916997486, 4823.252395878644, 4858.271259311132, 4860.975695121501, 4205.9789701051295, 4247.5752424757275, 4250.936235956463, 4261.87214383569, 4264.317709166518, 3632.909177270589, 3633.0735662406446, 3640.0535860675886, 3678.1907980244305, 3691.8154092295276, 1134.6312448454285, 1136.6817291158488, 1140.2873204247346, 1149.0233301693493, 1149.0807354116673, 1315.6316231455207, 1321.7686904791815, 1341.4567100324384, 1371.636516323175, 1390.3465371275483, 7411.295926886937, 7486.5508069516, 7525.360344370681, 7527.962360188273, 7529.962350188214, 494.69081823860085, 509.3022559093991, 509.4803300633333, 509.78588992623185, 514.2004183494627, 5526.143447765603, 5586.301712285965, 5597.63615365, 5639.041362968305, 5656.236408084938, 9055.922553512333, 9305.395149315409, 9391.671291504765, 9394.295427842939, 9517.714468565953, 9332.626694932262, 9335.439873607469, 9345.205657519187, 9370.437773733598, 9408.811823763486, 7138.821529461701, 7329.230430804795, 7401.888971665429, 7402.518836275625, 7405.851882962203, 7267.709291628275, 7386.852262954818, 7391.113066432063, 7401.7039318428815, 7402.814929626802, 8015.158408367038, 8052.718154864786, 8198.1391953844, 8322.16778322163, 8324.833503329779, 8247.257746802576, 8311.625976830936, 8378.622961966605, 8379.95810020946, 8400.705975290835, 5995.820125396245, 6216.937830621817, 6544.803655890331, 6555.737770489127, 6675.965225390072, 7388.815279618053, 7417.666205020679, 7454.217307182667, 7455.105387353552, 7457.7389791357045, 6665.433438157617, 6794.694238759366, 6834.248232694499, 6900.068490753684, 6944.618046007316, 6833.180018397626, 6856.177258728984, 6907.102076730194, 6958.3041695832035, 7012.123484564429, 7048.541844780073, 7135.357817796424, 7135.892961605477, 7167.426605871414, 7177.641117944187, 6457.547971642128, 6488.935110648833, 6541.149650545399, 6581.848176569177, 6587.077809106825, 6432.421082102634, 6473.643949582818, 6477.0, 6488.870222595616, 6531.216254049545], "unit": "score", "name": "mootools.html", "value": 4416.331923820342}, {"lowerIsBetter": false, "replicates": [323.63914235627266, 325.19676399293746, 327.8573820388131, 332.41992722698893, 334.4381439182173, 5674.773009079642, 5781.942180578193, 5802.245708057952, 5835.883282334351, 5851.444112809287, 5752.539796816244, 5801.361850196475, 5811.854703632412, 5839.7664093436315, 5852.941470585293, 4553.134904368159, 4554.521775213605, 4564.885877853064, 4565.726056436608, 4566.611837993774, 4321.6326612238, 4421.336799480072, 4490.708103973231, 4515.909681806362, 4558.361829343895, 4445.333200019991, 4451.287793952968, 4455.643548516111, 4462.754548499831, 4470.173017991666, 4463.977680111579, 4465.218586747323, 4466.977665111686, 4472.44094488189, 4476.574725401114, 3943.9211215775813, 3944.9013774655577, 3945.6251656092627, 3947.230290093433, 3948.506436695413, 5535.142052981794, 5547.583931205176, 5549.1676248562635, 5552.167174923794, 5573.108302671593, 5207.0, 5210.426853046162, 5211.1922651989, 5216.817411390621, 5217.817376391846, 5952.136940143699, 6101.816945491642, 6132.202813634243, 6138.14066030756, 6193.597416167935, 4193.832246710128, 4195.307774217251, 4197.832086716528, 4200.6219440250525, 4205.390218418343, 6221.906671399933, 6348.206474190726, 6387.105805187278, 6447.54867159299, 6449.516286278501, 4261.893452663709, 4278.871633850989, 4279.9786001070415, 4282.8715138545895, 4284.014676624394, 4329.761863097497, 4330.740155590612, 4332.523422423531, 4336.2845130553105, 4341.696081274344, 5039.722815245197, 5051.797928082909, 5054.721990290495, 5055.595552355802, 5059.215821547666, 5954.464098231093, 6094.847628809315, 6208.348123447064, 6225.159603453476, 6230.221222347207, 1521.1405555860904, 1540.691861627679, 1546.7215901137904, 1549.1402271739069, 1553.4562902984092, 991.9950400247952, 1006.0693858181153, 1009.0867764672983, 1010.7422607235108, 1028.218553899042, 5881.470667639933, 5888.705564721747, 5893.0, 5904.498117660047, 5904.9704751475965, 6361.61830290184, 6367.586106903036, 6426.582272152295, 6452.516061295328, 6459.321771213955, 5882.117682347596, 5884.764609415575, 5887.2052272943465, 5890.8821823563285, 5905.763769449174, 3411.0449074259245, 3434.261633748706, 3438.0373495421322, 3438.6045604755273, 3446.190145315849, 6473.643949582724, 6658.600483970978, 6663.800085997428, 6736.225334086643, 6760.3239676032, 6561.639109849004, 6621.437177839841, 6623.370779775913, 6626.768063117768, 6632.8673426531195, 6751.392374686302, 6754.155730533684, 6754.797356079325, 6762.72949082041, 6764.864702706017, 6453.870922581428, 6456.418922297016, 6467.191601049869, 6467.288598254282, 6468.644224567505, 6216.44052035319, 6402.711877965596, 6405.871882562229, 6409.519286053472, 6425.22897252314, 6696.464282857262, 6729.259781424137, 6730.394264516217, 6745.662716864235, 6762.966185169043, 4321.78391080451, 4338.327559228324, 4349.847755328548, 4350.303951367766, 4358.4769827620885, 6212.751489940532, 6340.334264902119, 6480.805575832733, 6538.803835884931, 6554.901676474761, 6303.558750887394, 6311.147995020797, 6326.240851097898, 6334.334894835976, 6338.207724034496, 6240.7503699851495, 6255.968720156552, 6257.68711564429, 6259.092431597302, 6264.530160238091, 6156.07658851158, 6160.476359509492, 6166.537509686702, 6167.074938759222, 6191.1641928339095, 6147.538934579835, 6291.370862913672, 6302.338254483397, 6302.684865756602, 6303.991361382157, 6099.268087829489, 6126.356732543019, 6127.816165515042, 6128.540359473147, 6184.165137706352], "unit": "score", "name": "prototype.html", "value": 4669.4031057807215}, {"lowerIsBetter": false, "replicates": [735.646889493043, 748.9513181643193, 761.2083433229438, 762.1996903251585, 771.517801374141, 13522.661933451656, 13910.652233694163, 13921.23433211173, 13936.6515837104, 13943.163410195395, 13104.08271421001, 13166.605001849959, 13201.537946171886, 13209.471621135142, 13224.140430871987, 654.7839213059679, 816.9387295952797, 826.6982551368767, 830.5349004557437, 831.5468069901918, 825.3026192867018, 826.4173757500947, 827.9089300177005, 828.8300898315831, 829.498153617062, 698.5494356140287, 833.7707130539089, 876.662484943295, 878.8198419324056, 879.9208071273584, 844.2865778417258, 846.8941382327209, 848.8132610825609, 849.452103393314, 849.6516428264382, 634.6477704873839, 635.726637545855, 635.8473966248114, 638.2659941067762, 640.218932901859, 13358.532451364254, 13406.731865362639, 13412.597622071353, 13419.329033548283, 13432.731345373135, 12629.494820207181, 12755.872441275655, 12879.0, 13389.86610133896, 13507.446643636009, 10652.467376631137, 10669.519871605797, 10704.19718521114, 10715.249932504728, 10720.249582529226, 3595.874144404959, 3663.3955397359405, 3669.972407725841, 3761.360568703327, 3766.359718847775, 47987.76006119982, 48079.0, 48207.517924821004, 48238.51761482375, 48239.75880120612, 10015.198784097254, 10345.793084138275, 10391.37651740898, 10434.478276086165, 10443.164546836235, 18953.0, 19047.52381190481, 19092.2363105477, 19098.427047188605, 19101.61796764057, 7194.956731273936, 7695.653695583712, 7721.575313357707, 7928.801779955432, 7987.480813747088, 4238.406623072772, 4329.826806927687, 4341.674374421931, 4362.389265502832, 4377.343398490252, 2975.8065725727756, 3168.651448340681, 3180.157258326545, 3186.330870517171, 3193.1538142392283, 599.9640021598718, 631.950961404067, 638.3456956619502, 642.457123730447, 654.1430725749188, 658.3548122839644, 682.7337338438014, 698.5494356140363, 703.3072423662688, 704.1655638068904, 8545.74362769118, 9082.954585227031, 9298.488583127857, 9409.247260219166, 9565.139137477661, 604.7792555717219, 609.1411110334407, 619.5879739972958, 621.4251817069284, 638.6502792851524, 4078.204750073707, 4095.2219078375015, 4288.335308027198, 4408.493023302297, 4435.379046933432, 53768.462315377124, 54427.45572544224, 54528.45471545313, 55253.723731381084, 55417.0, 48513.0, 48630.270545941836, 48870.51129488659, 48960.26559601609, 49462.75268623634, 43886.12227755427, 43900.341494877604, 43966.340504891814, 44412.55587444149, 44701.55298447039, 8292.917070829215, 8718.91281087181, 8811.691590794291, 8958.462492250486, 8970.86543701832, 33163.17092072718, 33399.33201335911, 33888.49167262542, 34175.658243417245, 34369.62521499212, 38493.42259866048, 38596.42105368478, 40727.38908916428, 44472.55527444814, 44686.3297050551, 10777.353358798497, 11299.983001529901, 11364.602238921929, 11865.28808271472, 12336.0, 12432.440540175532, 12780.424880880197, 12780.936095319465, 12854.614361569167, 13102.0, 11280.210385272952, 11605.825912611148, 11880.34658093813, 12187.110207773361, 12314.384280786104, 11758.0, 12320.383980800745, 12511.1867728601, 12728.745425091261, 12790.296533690364, 11656.125790565911, 11897.464614092214, 12259.877401226231, 12488.25070495773, 12495.562655307021, 9784.364016338915, 9835.803283934425, 9849.409035457895, 10172.745681358025, 10200.38797672142, 9202.861957070516, 9785.85321220168, 9817.656382026595, 9896.406215627085, 10008.14930730867], "unit": "score", "name": "yui.html", "value": 6408.130245011934}], "name": "dromaeo_css", "value": 6821.604689532027}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 107.0, 111.0, 111.0, 111.0, 104.0, 111.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.1}, {"lowerIsBetter": true, "replicates": [151.0, 130.0, 152.0, 171.0, 128.0, 158.0, 147.0, 136.0, 165.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 146.7}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 161.0, 160.0, 160.0, 160.0, 161.0, 162.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 96.0, 99.0, 73.0, 73.0, 74.0, 108.0, 94.0, 73.0], "unit": "score", "name": "audio-fft", "value": 83.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 143.0, 96.0, 98.0, 96.0, 139.0, 95.0, 97.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 115.0, 117.0, 115.0, 115.0, 116.0, 115.0, 116.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.8}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 56.0, 55.0, 55.0, 56.0, 57.0, 64.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 67.0, 69.0, 69.0, 68.0, 69.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [82.0, 91.0, 84.0, 82.0, 91.0, 89.0, 83.0, 84.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [116.0, 115.0, 115.0, 117.0, 126.0, 115.0, 113.0, 115.0, 124.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.3}, {"lowerIsBetter": true, "replicates": [154.0, 141.0, 150.0, 146.0, 149.0, 140.0, 161.0, 149.0, 147.0, 161.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.8}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 68.0, 67.0, 67.0, 68.0, 69.0, 67.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1513.4999999999995}]} 20:16:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1513.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6821.60"}}} 20:16:52 INFO - Return code: 0 20:16:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:16:52 INFO - # TBPL SUCCESS # 20:16:52 INFO - Running post-action listener: _resource_record_post_action 20:16:52 INFO - Running post-run listener: _resource_record_post_run 20:16:53 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 12288; Write bytes: 539631616; Read time: 384; Write time: 523368 20:16:53 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 240693248; Read time: 144; Write time: 259056 20:16:53 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 298938368; Read time: 240; Write time: 264312 20:16:53 INFO - Running post-run listener: _upload_blobber_files 20:16:53 INFO - Blob upload gear active. 20:16:53 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:16:53 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:16:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 20:16:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 20:16:53 INFO - (blobuploader) - INFO - Open directory for files ... 20:16:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:16:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:16:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:16:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:16:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:16:54 INFO - (blobuploader) - INFO - Done attempting. 20:16:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:16:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:16:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:16:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:16:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:16:55 INFO - (blobuploader) - INFO - Done attempting. 20:16:55 INFO - (blobuploader) - INFO - Iteration through files over. 20:16:55 INFO - Return code: 0 20:16:55 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:16:55 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:16:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aca643d651e6ef00c4b1cd87f9f9ce4c3eebc9b44bf1340768a6078fea92fc7b852b88fcd14a1cf4dc88c4be5e7b8ef7a896d95ae4dbe141c9cea44ee5b83dd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20222d4a33efadebd2eefbe1b769e915c6c4ff31a3a6d1addf1a95ae3afe8eff2464a2d9788fe99c3e75e5116a415645a55b083eb58a7496a8535c2eb5261a0e"} 20:16:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:16:55 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:16:55 INFO - Contents: 20:16:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aca643d651e6ef00c4b1cd87f9f9ce4c3eebc9b44bf1340768a6078fea92fc7b852b88fcd14a1cf4dc88c4be5e7b8ef7a896d95ae4dbe141c9cea44ee5b83dd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20222d4a33efadebd2eefbe1b769e915c6c4ff31a3a6d1addf1a95ae3afe8eff2464a2d9788fe99c3e75e5116a415645a55b083eb58a7496a8535c2eb5261a0e"} 20:16:55 INFO - Running post-run listener: copy_logs_to_upload_dir 20:16:55 INFO - Copying logs to upload dir... 20:16:55 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 20:16:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.145919 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-02-22 20:16:55.066824) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 20:16:55.070175) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aca643d651e6ef00c4b1cd87f9f9ce4c3eebc9b44bf1340768a6078fea92fc7b852b88fcd14a1cf4dc88c4be5e7b8ef7a896d95ae4dbe141c9cea44ee5b83dd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20222d4a33efadebd2eefbe1b769e915c6c4ff31a3a6d1addf1a95ae3afe8eff2464a2d9788fe99c3e75e5116a415645a55b083eb58a7496a8535c2eb5261a0e"} build_url:https://queue.taskcluster.net/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011539 build_url: 'https://queue.taskcluster.net/v1/task/ZtZlvfJJT0SazEwy45UesQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aca643d651e6ef00c4b1cd87f9f9ce4c3eebc9b44bf1340768a6078fea92fc7b852b88fcd14a1cf4dc88c4be5e7b8ef7a896d95ae4dbe141c9cea44ee5b83dd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20222d4a33efadebd2eefbe1b769e915c6c4ff31a3a6d1addf1a95ae3afe8eff2464a2d9788fe99c3e75e5116a415645a55b083eb58a7496a8535c2eb5261a0e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 20:16:55.098475) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 20:16:55.098853) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1456199341.646868-1795434288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 20:16:55.182254) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 20:16:55.182714) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 20:16:55.183121) ========= ========= Total master_lag: 1.02 =========