builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-015 starttime: 1456795451.81 results: success (0) buildid: 20160229143016 builduid: 304208db15cd4d9599394a7b2e8a31d6 revision: 446932a345fe1631718eb0b6bcb3e098c2958265 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 17:24:11.814079) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 17:24:11.814542) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 17:24:11.814835) ========= 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=20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004390 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 17:24:11.832236) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 17:24:11.832506) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 17:24:11.860725) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:24:11.861013) ========= 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=20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.036829 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:24:11.907529) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 17:24:11.907812) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 17:24:11.908183) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:24:11.908455) ========= 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=20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-29 17:24:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 59.8M=0s 2016-02-29 17:24:12 (59.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103413 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:24:12.025085) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:24:12.025431) ========= 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=20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.145621 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:24:12.182875) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:24:12.183286) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 446932a345fe1631718eb0b6bcb3e098c2958265 --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 446932a345fe1631718eb0b6bcb3e098c2958265 --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=20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-29 17:24:12,238 truncating revision to first 12 chars 2016-02-29 17:24:12,238 Setting DEBUG logging. 2016-02-29 17:24:12,239 attempt 1/10 2016-02-29 17:24:12,239 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/446932a345fe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-29 17:24:12,591 unpacking tar archive at: fx-team-446932a345fe/testing/mozharness/ program finished with exit code 0 elapsedTime=0.699327 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:24:12.895737) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 17:24:12.896118) ========= echo 446932a345fe1631718eb0b6bcb3e098c2958265 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'446932a345fe1631718eb0b6bcb3e098c2958265'] 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=20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 446932a345fe1631718eb0b6bcb3e098c2958265 program finished with exit code 0 elapsedTime=0.003738 script_repo_revision: '446932a345fe1631718eb0b6bcb3e098c2958265' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 17:24:12.944808) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 17:24:12.945296) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 17:24:12.956166) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-02-29 17:24:12.956609) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:24:13 INFO - MultiFileLogger online at 20160229 17:24:13 in /builds/slave/test-pgo 17:24:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:24:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:24:13 INFO - {'append_to_log': False, 17:24:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:24:13 INFO - 'blob_upload_branch': 'Fx-Team', 17:24:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:24:13 INFO - 'branch': 'Fx-Team', 17:24:13 INFO - 'buildbot_json_path': 'buildprops.json', 17:24:13 INFO - 'config_files': ('talos/linux_config.py',), 17:24:13 INFO - 'default_actions': ('clobber', 17:24:13 INFO - 'read-buildbot-config', 17:24:13 INFO - 'download-and-extract', 17:24:13 INFO - 'populate-webroot', 17:24:13 INFO - 'create-virtualenv', 17:24:13 INFO - 'install', 17:24:13 INFO - 'run-tests'), 17:24:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:24:13 INFO - 'download_minidump_stackwalk': True, 17:24:13 INFO - 'download_symbols': 'ondemand', 17:24:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:24:13 INFO - 'tooltool.py': '/tools/tooltool.py', 17:24:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:24:13 INFO - '/tools/misc-python/virtualenv.py')}, 17:24:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:24:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:24:13 INFO - 'installer_path': 'installer.exe', 17:24:13 INFO - 'log_level': 'info', 17:24:13 INFO - 'log_name': 'talos', 17:24:13 INFO - 'log_to_console': True, 17:24:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:24:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:24:13 INFO - 'opt_config_files': (), 17:24:13 INFO - 'pip_index': False, 17:24:13 INFO - 'sps_profile': False, 17:24:13 INFO - 'sps_profile_interval': 0, 17:24:13 INFO - 'suite': 'dromaeojs-e10s', 17:24:13 INFO - 'system_bits': '32', 17:24:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:24:13 INFO - 'title': 'talos-linux64-ix-015', 17:24:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:24:13 INFO - 'use_talos_json': True, 17:24:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:24:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:24:13 INFO - 'work_dir': 'build'} 17:24:13 INFO - ##### 17:24:13 INFO - ##### Running clobber step. 17:24:13 INFO - ##### 17:24:13 INFO - Running pre-action listener: _resource_record_pre_action 17:24:13 INFO - Running main action method: clobber 17:24:13 INFO - rmtree: /builds/slave/test-pgo/build 17:24:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:24:17 INFO - Running post-action listener: _resource_record_post_action 17:24:17 INFO - ##### 17:24:17 INFO - ##### Running read-buildbot-config step. 17:24:17 INFO - ##### 17:24:17 INFO - Running pre-action listener: _resource_record_pre_action 17:24:17 INFO - Running main action method: read_buildbot_config 17:24:17 INFO - Using buildbot properties: 17:24:17 INFO - { 17:24:17 INFO - "project": "", 17:24:17 INFO - "product": "firefox", 17:24:17 INFO - "script_repo_revision": "production", 17:24:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:24:17 INFO - "repository": "", 17:24:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:24:17 INFO - "buildid": "20160229143016", 17:24:17 INFO - "pgo_build": "True", 17:24:17 INFO - "basedir": "/builds/slave/test-pgo", 17:24:17 INFO - "buildnumber": 306, 17:24:17 INFO - "slavename": "talos-linux64-ix-015", 17:24:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:24:17 INFO - "platform": "ubuntu64_hw", 17:24:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:24:17 INFO - "branch": "fx-team", 17:24:17 INFO - "repo_path": "integration/fx-team", 17:24:17 INFO - "revision": "446932a345fe1631718eb0b6bcb3e098c2958265", 17:24:17 INFO - "stage_platform": "linux64-pgo", 17:24:17 INFO - "builduid": "304208db15cd4d9599394a7b2e8a31d6", 17:24:17 INFO - "slavebuilddir": "test" 17:24:17 INFO - } 17:24:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 17:24:17 INFO - Running post-action listener: _resource_record_post_action 17:24:17 INFO - ##### 17:24:17 INFO - ##### Running download-and-extract step. 17:24:17 INFO - ##### 17:24:17 INFO - Running pre-action listener: _resource_record_pre_action 17:24:17 INFO - Running main action method: download_and_extract 17:24:17 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:24: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')]} 17:24:17 INFO - https://queue.taskcluster.net/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:24:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/test_packages.json 17:24:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/test_packages.json 17:24:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 17:24:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 17:24:18 INFO - Downloaded 1448 bytes. 17:24:18 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 17:24:18 INFO - Using the following test package requirements: 17:24:18 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:24:18 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:18 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:24:18 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:18 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:24:18 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:18 INFO - u'jsshell-linux-x86_64.zip'], 17:24:18 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:18 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:24:18 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:24:18 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:18 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:24:18 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:18 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:24:18 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:18 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:24:18 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:24:18 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:18 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:24:18 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:24:18 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')]} 17:24:18 INFO - https://queue.taskcluster.net/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:24:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:24:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:24:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/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 17:24:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/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 17:24:19 INFO - Downloaded 23372555 bytes. 17:24:19 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'] 17:24:19 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 17:24:20 INFO - Return code: 0 17:24:20 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 17:24:20 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')]} 17:24:20 INFO - https://queue.taskcluster.net/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:24:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:24:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:24:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/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 17:24:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/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 17:24:22 INFO - Downloaded 23372555 bytes. 17:24:22 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'] 17:24:22 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 17:24:23 INFO - Return code: 0 17:24:23 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')]} 17:24:23 INFO - https://queue.taskcluster.net/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:24:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:24:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:24:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/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 17:24:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/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 17:24:24 INFO - Downloaded 10713410 bytes. 17:24:24 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'] 17:24:24 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 17:24:24 INFO - Return code: 0 17:24:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:24 INFO - https://queue.taskcluster.net/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:24:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:24:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:24:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/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 17:24:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/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 17:24:26 INFO - Downloaded 56618535 bytes. 17:24:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:24:26 INFO - mkdir: /builds/slave/test-pgo/properties 17:24:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:24:26 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:24:26 INFO - Contents: 17:24:26 INFO - build_url:https://queue.taskcluster.net/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:24:26 INFO - Running post-action listener: _resource_record_post_action 17:24:26 INFO - Running post-action listener: set_extra_try_arguments 17:24:26 INFO - ##### 17:24:26 INFO - ##### Running populate-webroot step. 17:24:26 INFO - ##### 17:24:26 INFO - Running pre-action listener: _resource_record_pre_action 17:24:26 INFO - Running main action method: populate_webroot 17:24:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:24:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:24:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:24:26 INFO - '--tppagecycles', 17:24:26 INFO - '7'], 17:24:26 INFO - 'tests': ['tsvgm']}}, 17:24:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:24:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:24:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:24:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:24:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:24:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:24:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:24:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:26 INFO - 'talos_options': ['--e10s'], 17:24:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:24:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:26 INFO - 'tests': ['damp', 'tps']}, 17:24:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:26 INFO - 'talos_options': ['--e10s'], 17:24:26 INFO - 'tests': ['damp', 'tps']}, 17:24:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:24:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:24:26 INFO - 'other': {'tests': ['a11yr', 17:24:26 INFO - 'ts_paint', 17:24:26 INFO - 'tpaint', 17:24:26 INFO - 'sessionrestore', 17:24:26 INFO - 'sessionrestore_no_auto_restore']}, 17:24:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:24:26 INFO - 'tests': ['a11yr', 17:24:26 INFO - 'ts_paint', 17:24:26 INFO - 'tpaint', 17:24:26 INFO - 'sessionrestore', 17:24:26 INFO - 'sessionrestore_no_auto_restore']}, 17:24:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:24:26 INFO - 'tests': ['a11yr', 17:24:26 INFO - 'ts_paint', 17:24:26 INFO - 'tpaint', 17:24:26 INFO - 'sessionrestore', 17:24:26 INFO - 'sessionrestore_no_auto_restore']}, 17:24:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:24:26 INFO - 'tests': ['a11yr', 17:24:26 INFO - 'ts_paint', 17:24:26 INFO - 'tpaint', 17:24:26 INFO - 'sessionrestore', 17:24:26 INFO - 'sessionrestore_no_auto_restore']}, 17:24:26 INFO - 'other_l64': {'tests': ['a11yr', 17:24:26 INFO - 'ts_paint', 17:24:26 INFO - 'tpaint', 17:24:26 INFO - 'sessionrestore', 17:24:26 INFO - 'sessionrestore_no_auto_restore']}, 17:24:26 INFO - 'other_nol64': {'tests': ['a11yr', 17:24:26 INFO - 'ts_paint', 17:24:26 INFO - 'tpaint', 17:24:26 INFO - 'sessionrestore', 17:24:26 INFO - 'sessionrestore_no_auto_restore']}, 17:24:26 INFO - 'svgr': {'tests': ['tsvgx', 17:24:26 INFO - 'tsvgr_opacity', 17:24:26 INFO - 'tart', 17:24:26 INFO - 'tscrollx', 17:24:26 INFO - 'cart']}, 17:24:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:24:26 INFO - 'tests': ['tsvgx', 17:24:26 INFO - 'tsvgr_opacity', 17:24:26 INFO - 'tart', 17:24:26 INFO - 'tscrollx', 17:24:26 INFO - 'cart']}, 17:24:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:26 INFO - 'tests': ['tp5o']}, 17:24:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:26 INFO - 'talos_options': ['--e10s'], 17:24:26 INFO - 'tests': ['tp5o']}, 17:24:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:26 INFO - 'talos_options': ['--xperf_path', 17:24:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:24:26 INFO - 'tests': ['tp5n']}, 17:24:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:26 INFO - 'talos_options': ['--e10s', 17:24:26 INFO - '--xperf_path', 17:24:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:24:26 INFO - 'tests': ['tp5n']}}, 17:24:26 INFO - 'talos.zip': {'path': '', 17:24:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:24:26 INFO - Running post-action listener: _resource_record_post_action 17:24:26 INFO - ##### 17:24:26 INFO - ##### Running create-virtualenv step. 17:24:26 INFO - ##### 17:24:26 INFO - Running pre-action listener: _resource_record_pre_action 17:24:26 INFO - Running main action method: create_virtualenv 17:24:26 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:24:26 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 17:24:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:24:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:24:26 INFO - Using real prefix '/usr' 17:24:26 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:24:27 INFO - Installing distribute.............................................................................................................................................................................................done. 17:24:29 INFO - Installing pip.................done. 17:24:29 INFO - Return code: 0 17:24:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:24:29 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')]} 17:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:29 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')]} 17:24:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:29 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 0x7fdc1d388f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef8670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf878c0>, '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 0xf887c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf88c50>, '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': '20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253', '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 17:24:29 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 17:24:29 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 17:24:29 INFO - Using env: {'DISPLAY': ':0', 17:24:29 INFO - 'HOME': '/home/cltbld', 17:24:29 INFO - 'LANG': 'en_US.UTF-8', 17:24:29 INFO - 'LANGUAGE': 'en_US:en', 17:24:29 INFO - 'LOGNAME': 'cltbld', 17:24:29 INFO - 'MAIL': '/var/mail/cltbld', 17:24:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:29 INFO - 'MOZ_NO_REMOTE': '1', 17:24:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:29 INFO - 'NO_EM_RESTART': '1', 17:24:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:24:29 INFO - 'PWD': '/builds/slave/test-pgo', 17:24:29 INFO - 'SHELL': '/bin/bash', 17:24:29 INFO - 'SHLVL': '1', 17:24:29 INFO - 'TERM': 'linux', 17:24:29 INFO - 'TMOUT': '86400', 17:24:29 INFO - 'USER': 'cltbld', 17:24:29 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253', 17:24:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:29 INFO - '_': '/tools/buildbot/bin/python'} 17:24:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:29 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 17:24:29 INFO - Cleaning up... 17:24:29 INFO - Return code: 0 17:24:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:24:29 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')]} 17:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:29 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')]} 17:24:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:29 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 0x7fdc1d388f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef8670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf878c0>, '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 0xf887c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf88c50>, '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': '20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253', '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 17:24:29 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 17:24:29 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 17:24:29 INFO - Using env: {'DISPLAY': ':0', 17:24:29 INFO - 'HOME': '/home/cltbld', 17:24:29 INFO - 'LANG': 'en_US.UTF-8', 17:24:29 INFO - 'LANGUAGE': 'en_US:en', 17:24:29 INFO - 'LOGNAME': 'cltbld', 17:24:29 INFO - 'MAIL': '/var/mail/cltbld', 17:24:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:29 INFO - 'MOZ_NO_REMOTE': '1', 17:24:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:29 INFO - 'NO_EM_RESTART': '1', 17:24:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:24:29 INFO - 'PWD': '/builds/slave/test-pgo', 17:24:29 INFO - 'SHELL': '/bin/bash', 17:24:29 INFO - 'SHLVL': '1', 17:24:29 INFO - 'TERM': 'linux', 17:24:29 INFO - 'TMOUT': '86400', 17:24:29 INFO - 'USER': 'cltbld', 17:24:29 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253', 17:24:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:29 INFO - '_': '/tools/buildbot/bin/python'} 17:24:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:29 INFO - Downloading/unpacking psutil>=0.7.1 17:24:29 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 17:24:29 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 17:24:29 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 17:24:29 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 17:24:29 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 17:24:29 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 17:24:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:24:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:24:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:24:31 INFO - Installing collected packages: psutil 17:24:31 INFO - Running setup.py install for psutil 17:24:31 INFO - building 'psutil._psutil_linux' extension 17:24:31 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 17:24:31 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 17:24:31 INFO - building 'psutil._psutil_posix' extension 17:24:31 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 17:24:32 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 17:24:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:24:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:24:32 INFO - Successfully installed psutil 17:24:32 INFO - Cleaning up... 17:24:32 INFO - Return code: 0 17:24:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:24: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')]} 17:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24: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')]} 17:24:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:32 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 0x7fdc1d388f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef8670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf878c0>, '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 0xf887c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf88c50>, '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': '20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253', '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 17:24:32 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 17:24:32 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 17:24:32 INFO - Using env: {'DISPLAY': ':0', 17:24:32 INFO - 'HOME': '/home/cltbld', 17:24:32 INFO - 'LANG': 'en_US.UTF-8', 17:24:32 INFO - 'LANGUAGE': 'en_US:en', 17:24:32 INFO - 'LOGNAME': 'cltbld', 17:24:32 INFO - 'MAIL': '/var/mail/cltbld', 17:24:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:32 INFO - 'MOZ_NO_REMOTE': '1', 17:24:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:32 INFO - 'NO_EM_RESTART': '1', 17:24:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:24:32 INFO - 'PWD': '/builds/slave/test-pgo', 17:24:32 INFO - 'SHELL': '/bin/bash', 17:24:32 INFO - 'SHLVL': '1', 17:24:32 INFO - 'TERM': 'linux', 17:24:32 INFO - 'TMOUT': '86400', 17:24:32 INFO - 'USER': 'cltbld', 17:24:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253', 17:24:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:32 INFO - '_': '/tools/buildbot/bin/python'} 17:24:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:24:32 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 17:24:32 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 17:24:32 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 17:24:32 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 17:24:32 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 17:24:32 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 17:24:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:24:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:24:34 INFO - Installing collected packages: mozsystemmonitor 17:24:34 INFO - Running setup.py install for mozsystemmonitor 17:24:34 INFO - Successfully installed mozsystemmonitor 17:24:34 INFO - Cleaning up... 17:24:34 INFO - Return code: 0 17:24:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:24:34 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')]} 17:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:34 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')]} 17:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:34 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 0x7fdc1d388f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef8670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf878c0>, '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 0xf887c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf88c50>, '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': '20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253', '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 17:24:34 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 17:24:34 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 17:24:34 INFO - Using env: {'DISPLAY': ':0', 17:24:34 INFO - 'HOME': '/home/cltbld', 17:24:34 INFO - 'LANG': 'en_US.UTF-8', 17:24:34 INFO - 'LANGUAGE': 'en_US:en', 17:24:34 INFO - 'LOGNAME': 'cltbld', 17:24:34 INFO - 'MAIL': '/var/mail/cltbld', 17:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:34 INFO - 'MOZ_NO_REMOTE': '1', 17:24:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:34 INFO - 'NO_EM_RESTART': '1', 17:24:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:24:34 INFO - 'PWD': '/builds/slave/test-pgo', 17:24:34 INFO - 'SHELL': '/bin/bash', 17:24:34 INFO - 'SHLVL': '1', 17:24:34 INFO - 'TERM': 'linux', 17:24:34 INFO - 'TMOUT': '86400', 17:24:34 INFO - 'USER': 'cltbld', 17:24:34 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253', 17:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:34 INFO - '_': '/tools/buildbot/bin/python'} 17:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:34 INFO - Downloading/unpacking blobuploader==1.2.4 17:24:34 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 17:24:34 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 17:24:34 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 17:24:34 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 17:24:34 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 17:24:34 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 17:24:36 INFO - Downloading blobuploader-1.2.4.tar.gz 17:24:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:24:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:24:36 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 17:24:36 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 17:24:36 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 17:24:36 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 17:24:36 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 17:24:36 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 17:24:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:24:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:24:36 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 17:24:36 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 17:24:36 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 17:24:36 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 17:24:36 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 17:24:36 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 17:24:37 INFO - Downloading docopt-0.6.1.tar.gz 17:24:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:24:37 INFO - Installing collected packages: blobuploader, requests, docopt 17:24:37 INFO - Running setup.py install for blobuploader 17:24:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:24:37 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:24:37 INFO - Running setup.py install for requests 17:24:37 INFO - Running setup.py install for docopt 17:24:37 INFO - Successfully installed blobuploader requests docopt 17:24:37 INFO - Cleaning up... 17:24:37 INFO - Return code: 0 17:24:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:24:37 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')]} 17:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:37 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')]} 17:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:37 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 0x7fdc1d388f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef8670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf878c0>, '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 0xf887c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf88c50>, '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': '20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253', '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 17:24:37 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 17:24:37 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 17:24:37 INFO - Using env: {'DISPLAY': ':0', 17:24:37 INFO - 'HOME': '/home/cltbld', 17:24:37 INFO - 'LANG': 'en_US.UTF-8', 17:24:37 INFO - 'LANGUAGE': 'en_US:en', 17:24:37 INFO - 'LOGNAME': 'cltbld', 17:24:37 INFO - 'MAIL': '/var/mail/cltbld', 17:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:37 INFO - 'MOZ_NO_REMOTE': '1', 17:24:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:37 INFO - 'NO_EM_RESTART': '1', 17:24:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:24:37 INFO - 'PWD': '/builds/slave/test-pgo', 17:24:37 INFO - 'SHELL': '/bin/bash', 17:24:37 INFO - 'SHLVL': '1', 17:24:37 INFO - 'TERM': 'linux', 17:24:37 INFO - 'TMOUT': '86400', 17:24:37 INFO - 'USER': 'cltbld', 17:24:37 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253', 17:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:37 INFO - '_': '/tools/buildbot/bin/python'} 17:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:24:38 INFO - Running setup.py (path:/tmp/pip-rPy8zh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:24:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:24:38 INFO - Running setup.py (path:/tmp/pip-RBWG3F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:24:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:24:38 INFO - Running setup.py (path:/tmp/pip-IjycBA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:24:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:24:38 INFO - Running setup.py (path:/tmp/pip-iL96XZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:24:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:24:38 INFO - Running setup.py (path:/tmp/pip-tx4gY1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:24:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:24:38 INFO - Running setup.py (path:/tmp/pip-dggu4f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:24:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:24:38 INFO - Running setup.py (path:/tmp/pip-yNoUYb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:24:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:24:38 INFO - Running setup.py (path:/tmp/pip-FfqDLp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:24:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:24:38 INFO - Running setup.py (path:/tmp/pip-xi1TGS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:24:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:24:38 INFO - Running setup.py (path:/tmp/pip-bqbi9z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:24:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:24:38 INFO - Running setup.py (path:/tmp/pip-6OvFY0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:24:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:24:38 INFO - Running setup.py (path:/tmp/pip-7SMnvF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:24:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:24:38 INFO - Running setup.py (path:/tmp/pip-dHvCEt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:24:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:24:39 INFO - Running setup.py (path:/tmp/pip-iGJqhn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:24:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:24:39 INFO - Running setup.py (path:/tmp/pip-VWJYvm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:24:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:24:39 INFO - Running setup.py (path:/tmp/pip-LP4xj4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:24:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:24:39 INFO - Running setup.py (path:/tmp/pip-Z8WEve-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:24:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:24:39 INFO - Running setup.py install for manifestparser 17:24:39 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:24:39 INFO - Running setup.py install for mozcrash 17:24:39 INFO - Running setup.py install for mozdebug 17:24:39 INFO - Running setup.py install for mozdevice 17:24:39 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:24:39 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:24:39 INFO - Running setup.py install for mozfile 17:24:39 INFO - Running setup.py install for mozhttpd 17:24:39 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:24:39 INFO - Running setup.py install for mozinfo 17:24:40 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:24:40 INFO - Running setup.py install for mozInstall 17:24:40 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:24:40 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:24:40 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:24:40 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:24:40 INFO - Running setup.py install for mozleak 17:24:40 INFO - Running setup.py install for mozlog 17:24:40 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:24:40 INFO - Running setup.py install for moznetwork 17:24:40 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:24:40 INFO - Running setup.py install for mozprocess 17:24:40 INFO - Running setup.py install for mozprofile 17:24:40 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:24:40 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:24:40 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:24:40 INFO - Running setup.py install for mozrunner 17:24:40 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:24:40 INFO - Running setup.py install for mozscreenshot 17:24:40 INFO - Running setup.py install for moztest 17:24:40 INFO - Running setup.py install for mozversion 17:24:41 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:24:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:24:41 INFO - Cleaning up... 17:24:41 INFO - Return code: 0 17:24:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:41 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 0x7fdc1d388f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef8670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf878c0>, '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 0xf887c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf88c50>, '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': '20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253', '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 17:24:41 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 17:24:41 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 17:24:41 INFO - Using env: {'DISPLAY': ':0', 17:24:41 INFO - 'HOME': '/home/cltbld', 17:24:41 INFO - 'LANG': 'en_US.UTF-8', 17:24:41 INFO - 'LANGUAGE': 'en_US:en', 17:24:41 INFO - 'LOGNAME': 'cltbld', 17:24:41 INFO - 'MAIL': '/var/mail/cltbld', 17:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:41 INFO - 'MOZ_NO_REMOTE': '1', 17:24:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:41 INFO - 'NO_EM_RESTART': '1', 17:24:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:24:41 INFO - 'PWD': '/builds/slave/test-pgo', 17:24:41 INFO - 'SHELL': '/bin/bash', 17:24:41 INFO - 'SHLVL': '1', 17:24:41 INFO - 'TERM': 'linux', 17:24:41 INFO - 'TMOUT': '86400', 17:24:41 INFO - 'USER': 'cltbld', 17:24:41 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253', 17:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:41 INFO - '_': '/tools/buildbot/bin/python'} 17:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:24:41 INFO - Running setup.py (path:/tmp/pip-nfzzsi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:24:41 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)) 17:24:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:24:41 INFO - Running setup.py (path:/tmp/pip-P2Vkvw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:24:41 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)) 17:24:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:24:41 INFO - Running setup.py (path:/tmp/pip-DoY3WX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:24:41 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)) 17:24:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:24:41 INFO - Running setup.py (path:/tmp/pip-d_e04i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:24:41 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)) 17:24:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:24:41 INFO - Running setup.py (path:/tmp/pip-7Vx_ze-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:24:41 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)) 17:24:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:24:41 INFO - Running setup.py (path:/tmp/pip-7hSAjN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:24:41 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)) 17:24:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:24:41 INFO - Running setup.py (path:/tmp/pip-DfO4ix-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:24:41 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)) 17:24:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:24:41 INFO - Running setup.py (path:/tmp/pip-r02i96-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:24:41 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)) 17:24:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:24:41 INFO - Running setup.py (path:/tmp/pip-RddRRH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:24:41 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)) 17:24:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:24:41 INFO - Running setup.py (path:/tmp/pip-xczUHW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:24:42 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)) 17:24:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:24:42 INFO - Running setup.py (path:/tmp/pip-Tpt61X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:24:42 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)) 17:24:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:24:42 INFO - Running setup.py (path:/tmp/pip-1gOkTU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:24:42 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)) 17:24:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:24:42 INFO - Running setup.py (path:/tmp/pip-qf5Bcz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:24:42 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)) 17:24:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:24:42 INFO - Running setup.py (path:/tmp/pip-JRMihN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:24:42 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)) 17:24:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:24:42 INFO - Running setup.py (path:/tmp/pip-393q7L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:24:42 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)) 17:24:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:24:42 INFO - Running setup.py (path:/tmp/pip-h3GwCv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:24:42 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)) 17:24:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:24:42 INFO - Running setup.py (path:/tmp/pip-Zz0AfN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:24:42 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)) 17:24:42 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)) 17:24:42 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)) 17:24:42 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)) 17:24:42 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)) 17:24:42 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)) 17:24:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:24: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 17:24: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 17:24: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 17:24: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 17:24: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 17:24: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 17:24:44 INFO - Downloading blessings-1.6.tar.gz 17:24:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:24:44 INFO - Installing collected packages: blessings 17:24:44 INFO - Running setup.py install for blessings 17:24:44 INFO - Successfully installed blessings 17:24:44 INFO - Cleaning up... 17:24:44 INFO - Return code: 0 17:24:44 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:24:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:24:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:24:44 INFO - Reading from file tmpfile_stdout 17:24:44 INFO - Current package versions: 17:24:44 INFO - argparse == 1.2.1 17:24:44 INFO - blessings == 1.6 17:24:44 INFO - blobuploader == 1.2.4 17:24:44 INFO - docopt == 0.6.1 17:24:44 INFO - manifestparser == 1.1 17:24:44 INFO - mozInstall == 1.12 17:24:44 INFO - mozcrash == 0.16 17:24:44 INFO - mozdebug == 0.1 17:24:44 INFO - mozdevice == 0.48 17:24:44 INFO - mozfile == 1.2 17:24:44 INFO - mozhttpd == 0.7 17:24:44 INFO - mozinfo == 0.9 17:24:44 INFO - mozleak == 0.1 17:24:44 INFO - mozlog == 3.1 17:24:44 INFO - moznetwork == 0.27 17:24:44 INFO - mozprocess == 0.22 17:24:44 INFO - mozprofile == 0.28 17:24:44 INFO - mozrunner == 6.11 17:24:44 INFO - mozscreenshot == 0.1 17:24:44 INFO - mozsystemmonitor == 0.0 17:24:44 INFO - moztest == 0.7 17:24:44 INFO - mozversion == 1.4 17:24:44 INFO - psutil == 3.1.1 17:24:44 INFO - requests == 1.2.3 17:24:44 INFO - wsgiref == 0.1.2 17:24:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:24: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')]} 17:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24: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')]} 17:24:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:44 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 0x7fdc1d388f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef8670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf878c0>, '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 0xf887c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf88c50>, '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': '20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253', '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 17:24:44 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 17:24:44 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 17:24:44 INFO - Using env: {'DISPLAY': ':0', 17:24:44 INFO - 'HOME': '/home/cltbld', 17:24:44 INFO - 'LANG': 'en_US.UTF-8', 17:24:44 INFO - 'LANGUAGE': 'en_US:en', 17:24:44 INFO - 'LOGNAME': 'cltbld', 17:24:44 INFO - 'MAIL': '/var/mail/cltbld', 17:24:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:44 INFO - 'MOZ_NO_REMOTE': '1', 17:24:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:44 INFO - 'NO_EM_RESTART': '1', 17:24:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:24:44 INFO - 'PWD': '/builds/slave/test-pgo', 17:24:44 INFO - 'SHELL': '/bin/bash', 17:24:44 INFO - 'SHLVL': '1', 17:24:44 INFO - 'TERM': 'linux', 17:24:44 INFO - 'TMOUT': '86400', 17:24:44 INFO - 'USER': 'cltbld', 17:24:44 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253', 17:24:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:44 INFO - '_': '/tools/buildbot/bin/python'} 17:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:45 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)) 17:24:45 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)) 17:24:45 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)) 17:24:45 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)) 17:24:45 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)) 17:24:45 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)) 17:24:45 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)) 17:24:45 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)) 17:24:45 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)) 17:24:45 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)) 17:24:45 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)) 17:24:45 INFO - Cleaning up... 17:24:45 INFO - Return code: 0 17:24:45 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:24:45 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')]} 17:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:45 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')]} 17:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:45 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 0x7fdc1d388f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef8670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf878c0>, '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 0xf887c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf88c50>, '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': '20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253', '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 17:24:45 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 17:24:45 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 17:24:45 INFO - Using env: {'DISPLAY': ':0', 17:24:45 INFO - 'HOME': '/home/cltbld', 17:24:45 INFO - 'LANG': 'en_US.UTF-8', 17:24:45 INFO - 'LANGUAGE': 'en_US:en', 17:24:45 INFO - 'LOGNAME': 'cltbld', 17:24:45 INFO - 'MAIL': '/var/mail/cltbld', 17:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:45 INFO - 'MOZ_NO_REMOTE': '1', 17:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:45 INFO - 'NO_EM_RESTART': '1', 17:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:24:45 INFO - 'PWD': '/builds/slave/test-pgo', 17:24:45 INFO - 'SHELL': '/bin/bash', 17:24:45 INFO - 'SHLVL': '1', 17:24:45 INFO - 'TERM': 'linux', 17:24:45 INFO - 'TMOUT': '86400', 17:24:45 INFO - 'USER': 'cltbld', 17:24:45 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253', 17:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:45 INFO - '_': '/tools/buildbot/bin/python'} 17:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:45 INFO - Downloading/unpacking jsonschema 17:24:45 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 17:24:45 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 17:24:45 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 17:24:45 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 17:24:45 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 17:24:45 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 17:24:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:24:47 INFO - Downloading/unpacking functools32 (from jsonschema) 17:24: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 17:24: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 17:24: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 17:24: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 17:24: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 17:24: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 17:24:47 INFO - Downloading functools32-3.2.3-2.tar.gz 17:24:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:24:47 INFO - warning: no files found matching '*.txt' 17:24:47 INFO - no previously-included directories found matching 'build' 17:24:47 INFO - no previously-included directories found matching 'dist' 17:24:47 INFO - no previously-included directories found matching '.git*' 17:24:47 INFO - Installing collected packages: jsonschema, functools32 17:24:47 INFO - Running setup.py install for functools32 17:24:47 INFO - warning: no files found matching '*.txt' 17:24:47 INFO - no previously-included directories found matching 'build' 17:24:47 INFO - no previously-included directories found matching 'dist' 17:24:47 INFO - no previously-included directories found matching '.git*' 17:24:47 INFO - Successfully installed jsonschema functools32 17:24:47 INFO - Cleaning up... 17:24:47 INFO - Return code: 0 17:24:47 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:24: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')]} 17:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24: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')]} 17:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:47 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 0x7fdc1d388f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef8670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf878c0>, '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 0xf887c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf88c50>, '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': '20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253', '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 17:24:47 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 17:24:47 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 17:24:47 INFO - Using env: {'DISPLAY': ':0', 17:24:47 INFO - 'HOME': '/home/cltbld', 17:24:47 INFO - 'LANG': 'en_US.UTF-8', 17:24:47 INFO - 'LANGUAGE': 'en_US:en', 17:24:47 INFO - 'LOGNAME': 'cltbld', 17:24:47 INFO - 'MAIL': '/var/mail/cltbld', 17:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:47 INFO - 'MOZ_NO_REMOTE': '1', 17:24:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:47 INFO - 'NO_EM_RESTART': '1', 17:24:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:24:47 INFO - 'PWD': '/builds/slave/test-pgo', 17:24:47 INFO - 'SHELL': '/bin/bash', 17:24:47 INFO - 'SHLVL': '1', 17:24:47 INFO - 'TERM': 'linux', 17:24:47 INFO - 'TMOUT': '86400', 17:24:47 INFO - 'USER': 'cltbld', 17:24:47 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253', 17:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:47 INFO - '_': '/tools/buildbot/bin/python'} 17:24:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:47 INFO - Downloading/unpacking flake8 17:24: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 17:24: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 17:24: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 17:24: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 17:24: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 17:24: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 17:24:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:24:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:24:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:24:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:24:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:24:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:24:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:24:50 INFO - no previously-included directories found matching 'docs/_build' 17:24:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:24:50 INFO - Running setup.py install for pep8 17:24:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:24:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:24:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:24:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:24:50 INFO - no previously-included directories found matching 'docs/_build' 17:24:50 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:24:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:24:50 INFO - Cleaning up... 17:24:50 INFO - Return code: 0 17:24:50 INFO - Running post-action listener: _resource_record_post_action 17:24:50 INFO - Running post-action listener: _start_resource_monitoring 17:24:50 INFO - Starting resource monitoring. 17:24:50 INFO - ##### 17:24:50 INFO - ##### Running install step. 17:24:50 INFO - ##### 17:24:50 INFO - Running pre-action listener: _resource_record_pre_action 17:24:50 INFO - Running main action method: install 17:24:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:24:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:24:50 INFO - Reading from file tmpfile_stdout 17:24:50 INFO - Detecting whether we're running mozinstall >=1.0... 17:24:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:24:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:24:51 INFO - Reading from file tmpfile_stdout 17:24:51 INFO - Output received: 17:24:51 INFO - Usage: mozinstall [options] installer 17:24:51 INFO - Options: 17:24:51 INFO - -h, --help show this help message and exit 17:24:51 INFO - -d DEST, --destination=DEST 17:24:51 INFO - Directory to install application into. [default: 17:24:51 INFO - "/builds/slave/test-pgo"] 17:24:51 INFO - --app=APP Application being installed. [default: firefox] 17:24:51 INFO - mkdir: /builds/slave/test-pgo/build/application 17:24:51 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'] 17:24:51 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 17:25:07 INFO - Reading from file tmpfile_stdout 17:25:07 INFO - Output received: 17:25:07 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:25:07 INFO - Running post-action listener: _resource_record_post_action 17:25:07 INFO - ##### 17:25:07 INFO - ##### Running run-tests step. 17:25:07 INFO - ##### 17:25:07 INFO - Running pre-action listener: _resource_record_pre_action 17:25:07 INFO - Running main action method: run_tests 17:25:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:25:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:25:07 INFO - Python 2.7.3 17:25:07 INFO - Return code: 0 17:25:07 INFO - grabbing minidump binary from tooltool 17:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:07 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 0xf878c0>, '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 0xf887c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf88c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:25:07 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 17:25:07 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 17:25:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:25:07 INFO - Return code: 0 17:25:07 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:25:07 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:25:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:25:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:25:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:25:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:25:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:25:08 INFO - Return code: 0 17:25:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 17:25:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:25:08 INFO - Using env: {'DISPLAY': ':0', 17:25:08 INFO - 'HOME': '/home/cltbld', 17:25:08 INFO - 'LANG': 'en_US.UTF-8', 17:25:08 INFO - 'LANGUAGE': 'en_US:en', 17:25:08 INFO - 'LOGNAME': 'cltbld', 17:25:08 INFO - 'MAIL': '/var/mail/cltbld', 17:25:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:25:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:08 INFO - 'MOZ_NO_REMOTE': '1', 17:25:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:25:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:08 INFO - 'NO_EM_RESTART': '1', 17:25:08 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:25:08 INFO - 'PWD': '/builds/slave/test-pgo', 17:25:08 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:25:08 INFO - 'SHELL': '/bin/bash', 17:25:08 INFO - 'SHLVL': '1', 17:25:08 INFO - 'TERM': 'linux', 17:25:08 INFO - 'TMOUT': '86400', 17:25:08 INFO - 'USER': 'cltbld', 17:25:08 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253', 17:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:08 INFO - '_': '/tools/buildbot/bin/python'} 17:25:08 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:25:08 INFO - mozversion application_buildid: 20160229143016 17:25:08 INFO - mozversion application_changeset: 446932a345fe1631718eb0b6bcb3e098c2958265 17:25:08 INFO - mozversion application_display_name: Nightly 17:25:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:25:08 INFO - mozversion application_name: Firefox 17:25:08 INFO - mozversion application_remotingname: firefox 17:25:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:25:08 INFO - mozversion application_vendor: Mozilla 17:25:08 INFO - mozversion application_version: 47.0a1 17:25:08 INFO - mozversion platform_buildid: 20160229143016 17:25:08 INFO - mozversion platform_changeset: 446932a345fe1631718eb0b6bcb3e098c2958265 17:25:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:25:08 INFO - mozversion platform_version: 47.0a1 17:25:08 INFO - using testdate: 1456795508 17:25:08 INFO - actual date: 1456795508 17:25:08 INFO - starting webserver on 'localhost:36894' 17:25:08 INFO - SUITE-START | Running 2 tests 17:25:08 INFO - TEST-START | dromaeo_css 17:25:08 INFO - operating with platform_type : linux_ 17:25:08 INFO - Initialising browser for dromaeo_css test... 17:25:08 INFO - TEST-INFO | started process 8403 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYXzsTU/profile http://localhost:36894/getInfo.html) 17:25:12 INFO - PROCESS | 8403 | 17:25:12 INFO - PROCESS | 8403 | (process:8485): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:25:13 INFO - PROCESS | 8403 | __metrics Screen width/height:1600/1200 17:25:13 INFO - PROCESS | 8403 | colorDepth:24 17:25:13 INFO - PROCESS | 8403 | Browser inner width/height: 1024/697 17:25:13 INFO - PROCESS | 8403 | __metrics 17:25:13 ERROR - PROCESS | 8403 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 17:25:13 INFO - PROCESS | 8403 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:25:13 INFO - PROCESS | 8403 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:25:13 INFO - PROCESS | 8403 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:25:13 INFO - PROCESS | 8403 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:25:13 INFO - PROCESS | 8403 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:25:13 INFO - PROCESS | 8403 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:25:13 INFO - PROCESS | 8403 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:25:13 INFO - PROCESS | 8403 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:25:13 INFO - PROCESS | 8403 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:25:14 INFO - TEST-INFO | 8403: exit 0 17:25:14 INFO - Browser initialized. 17:25:14 INFO - Running cycle 1/1 for dromaeo_css test... 17:25:14 INFO - TEST-INFO | started process 8536 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYXzsTU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:25:16 INFO - PROCESS | 8536 | 17:25:16 INFO - PROCESS | 8536 | (process:8596): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:25:26 INFO - PROCESS | 8536 | RSS: Main: 160870400 17:25:26 INFO - PROCESS | 8536 | 17:26:16 INFO - PROCESS | 8536 | 1456795576180 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] 17:28:24 INFO - PROCESS | 8536 | Cycle 1(1): loaded http://localhost:36894/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36894/tests/dromaeo/cssquery-ext.html) 17:28:25 INFO - PROCESS | 8536 | RSS: Main: 170483712 17:28:25 INFO - PROCESS | 8536 | 17:31:27 INFO - PROCESS | 8536 | Cycle 1(1): loaded http://localhost:36894/tests/dromaeo/cssquery-ext.html (next: http://localhost:36894/tests/dromaeo/cssquery-jquery.html) 17:31:27 INFO - PROCESS | 8536 | RSS: Main: 165040128 17:31:27 INFO - PROCESS | 8536 | 17:34:29 INFO - PROCESS | 8536 | Cycle 1(1): loaded http://localhost:36894/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36894/tests/dromaeo/cssquery-mootools.html) 17:34:30 INFO - PROCESS | 8536 | RSS: Main: 166510592 17:34:30 INFO - PROCESS | 8536 | 17:37:31 INFO - PROCESS | 8536 | Cycle 1(1): loaded http://localhost:36894/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36894/tests/dromaeo/cssquery-prototype.html) 17:37:32 INFO - PROCESS | 8536 | RSS: Main: 164454400 17:37:32 INFO - PROCESS | 8536 | 17:40:34 INFO - PROCESS | 8536 | Cycle 1(1): loaded http://localhost:36894/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36894/tests/dromaeo/cssquery-yui.html) 17:40:35 INFO - PROCESS | 8536 | RSS: Main: 165011456 17:40:35 INFO - PROCESS | 8536 | 17:43:37 INFO - PROCESS | 8536 | Cycle 1(1): loaded http://localhost:36894/tests/dromaeo/cssquery-yui.html (next: http://localhost:36894/tests/dromaeo/cssquery-dojo.html) 17:43:38 INFO - PROCESS | 8536 | RSS: Main: 168448000 17:43:38 INFO - PROCESS | 8536 | 17:43:38 INFO - PROCESS | 8536 | __start_tp_report 17:43:38 INFO - PROCESS | 8536 | _x_x_mozilla_page_load 17:43:38 INFO - PROCESS | 8536 | _x_x_mozilla_page_load_details 17:43:38 INFO - PROCESS | 8536 | |i|pagename|runs| 17:43:38 INFO - PROCESS | 8536 | |0;dojo.html;3138.152698771332;3143.1042152986397;3175.4284228838815;3187.681231876814;3188.473901806202;5075.9238611420815;5082.898342033157;5114.9744251278735;5165.715885626294;5183.870403239921;5072.568831649305;5082.822101226458;5089.847304580869;5092.414372347182;5128.000039992203;4702.435707715079;4755.738434386108;4757.595604373632;4772.141014617368;4778.044391121773;850.1653213791936;4751.596114330268;4808.663393562452;4824.710517368969;4843.564079232869;4760.11937791508;4783.067301876135;4798.568128868401;4799.688020278671;4833.299171620095;4773.880652983668;4776.0925424169645;4805.087033463631;4831.661783675144;4849.612031037544;4646.4191976003;4829.492903245144;4846.29728689338;4854.077725232195;4902.28916807061;4979.526944940225;4983.950160498385;4991.975040124812;4992.40091189056;5018.723970181639;5427.891442171174;5487.917681234785;5491.313585801775;5496.670199787985;5540.584456165804;5512.889742205173;5514.6139770216105;5520.420355862657;5529.778808847682;5593.105103183511;5126.384833819965;5136.409312928986;5141.871453213662;5143.459936706629;5179.378474583074;5555.2222688823595;5561.277033985556;5563.5271001964475;5565.1930470082425;5612.887742245132;5365.946340536622;5373.032854086224;5386.48828361305;5412.621116521806;5441;5525.557955363562;5546.55627549795;5551.944480555224;5567.777288908398;5569.66582005081;5471.097268950579;5523.7790488380815;5538.6122971391615;5543.639663421945;5549.056660367747;5319.2021196820015;5419.3225846769155;5444.5916556258435;5499.587530935196;5500.064988951808;4116.361963895601;4210.326347784401;4251.213525497793;4257.5529569395385;4293.69944103916;3831.310364134427;3839.2513459875613;3840.8655697051026;3850.4416859555768;3872.7869967151514;5235.188545775335;5250.684958902478;5326.733663316819;5332.493413125747;5388.46115388458;5462.235287059815;5473.425290344536;5491.2312276281355;5502.119660854244;5513.09034009384;5177.974110129425;5240.109181439165;5243.528082472596;5244.265802787537;5289.70906600133;4652.255639097796;4685;4704.153252414599;4719.339292499053;4719.646026547954;5854.765809367577;5861;5864.618799778001;5870;5886.793962211302;5544.362398324163;5596.468335508121;5600.131979543177;5600.691961942132;5610.354809196994;5702.37273899879;5736.569757268138;5761.567882408753;5781.248437703071;5814.651120932757;5402.378726446509;5405.8107966221;5412.621116521806;5414.620976531763;5424.403315635356;5436.809711660073;5495.477929596682;5497.560195184456;5508.3114610673665;5552.7223638818705;5385.596080293915;5391.514763671288;5411.783528658967;5432.755526001419;5481.561475082063;5331.067063263991;5388.218708287355;5416.51251387377;5426.620136590401;5437.157240627709;5202.843914682566;5297.5232229099565;5339;5351.919721204107;5360.0887849064975;5404.54061404785;5437.293151890229;5463.48096930791;5478.835634930959;5488.780448782004;5307.203919411964;5313.388960269618;5314.415414304501;5335.253064571041;5366.785328586969 17:43:38 INFO - PROCESS | 8536 | |1;ext.html;519.8310549071552;531.3862488825406;564.6301672404577;587.6914619824593;603.6770327874588;35662.82168589157;36160.276794464095;36271;36281.99999999996;36516.26967460649;37058;37524;37662.623373766255;37766.62233377666;37900.052498687546;8293.419460637759;8443.83112337753;8489.44818586793;8505.277051450634;8518.318534517224;8305.294050005727;8417.158284171564;8451.366147538929;8608.741737747878;8616.526091064989;8526;8610.268127209163;8619.741407757778;8625.827483450326;8634.740957771277;8564.443311184754;8586.742397728078;8596.914030859736;8617.310615150804;8628.956855215747;8544.487330760174;8641.049484556694;8647.827043459158;8665.436746611513;8687.47875127488;34914.603415863334;35208.823955880056;35224.29551408957;35299.11752206215;35348.29303413918;2650.6024096385504;3052.2064263291704;3249.5938007749032;3343.164208947763;3733.775973441602;26743.598846017325;26751.331216719544;26961.595576066375;27000.729992700017;27280.181594552196;3292.407366673998;3308.8841890533718;3358.9160270993175;3407.4510528444557;3493.2489514754197;186610;186733;187553;187728;188019.99999999863;40432.39351409731;55086.86848486379;55279.44720552823;55299.72350138304;55411.44588554063;38988.80505597511;39213;39226.803865981055;39252.21495570073;39341.606583934365;14007.649808754863;14253.928730356281;14257.429702811978;14302.356393962296;14329.140251584939;11270.492827822603;11327.093832493381;11332.490037948312;11348.262362946381;11349.148813838996;14045.578632640832;14095.78856317156;14139.717205656036;14149.646258843612;14176.291185440892;5862.413758624189;5956.64260144384;6035.185249991283;6063.181470501514;6070.787522436782;915.697819719491;941.0379359036349;951.7573018880141;993.3543196921914;1064.9307794993301;30657.08028759141;31275.530867037014;31773.52339714906;32088.358232835213;32172.517412238834;972.4505654305295;1045.8849526552074;1078.719532921446;1103.9668809935715;1135.4833550734395;14266.714665706628;14476.34856431463;14487.275636218146;14697.338619762137;14711.632209194855;379379;386226;389290;390158;390266;52817.2077418839;53916.460835391146;53957.730211348695;54072.72963635156;54500.72749636226;1171.6075114836626;1179.6343133628432;1201.141184053406;1215.8601760797444;1437.9431118128168;28503.42993140167;29083.691233894104;29086.127416177547;29736.553951690308;29743.553846691884;45112.77443612761;45237.54762452334;45584.54415455936;45616;45755.77122114368;286071;287286;287663;288859;290037;31764.523532147497;31799.205019874687;32367;32825.67174328226;33078.338433231685;42486.82072218464;42525.78737106295;42973.140537189705;43081.138377232906;43201.3519797197;34835.65164348324;36492;36539.26921461609;36594.8170259147;37182.44226336661;36561.63438365582;36602.45096323611;37021;37415.81292093522;37542.624573753914;35125.29749404947;35444.82277588699;36043.459348109274;36266;36435.27129457343;27611.861940690167;29319.973800916865;29507;29599.704002960556;29752.55371169391;23274.65088023647;23509;23630.52738945177;24257.39356516101;24295.878520607283 17:43:38 INFO - PROCESS | 8536 | |2;jquery.html;329.17213208779907;330.6032760687176;336.998315008425;338.237274944999;338.36049865753716;16440.588985275375;16975.745363819537;17059.31762729491;18083.54791130219;18131.72802407965;9168.449893006424;9441.527923603826;9499;14795.26023698816;15022.173780442072;4587.931181032279;4707.364505791726;4764.452088009872;4767.76161191939;4783.210770222909;3676.2647470506004;4674.555917187861;5012.097822391968;5185.55922746567;5197.376314842205;5159.226116082599;5161.66449180802;5162.174052151657;5167.689938603677;5169.379674439054;5029.170186919172;5055.494450554952;5074.756684612294;5115.437301896788;5149.9485005149845;4908.779104940286;4909.754512274408;4930.33440485537;4932.358793356877;4947.653664243504;11416.059269924133;11681.649550513499;11821.586244481488;11834.822477662841;11865.88134118665;2006.7491563554556;2082.0526660369646;2143.389134096775;2149.140343862452;2198.670199470076;8449;8618.310535157236;8737.169968852948;8788;8809.251213646849;1816.6911625023777;1843.4101087651957;1856.4523465577688;1865.6175484025741;1866.188208129468;65279.34720652828;67490.66254668696;67689.32310676879;68325.31674683289;69096.65451672759;8917.063708310663;9115.453072815651;9146.771330716785;9825.901740982641;9870.851937220947;12659.303738294298;12734.490620375267;12761.042921780903;12769.489220431078;12772.361381930867;6645.933540664531;6736.157980252468;6827.2831352708245;6899.930510770839;6902.8619427612175;6698.83252918681;6798.558093723892;6823.658817059128;6967;6968.581885086911;4118.320477121241;4145.481814773153;4153.356229784388;4167.1040726244;4228.344606585984;1646.843549862785;1671.7492376143432;1699.4137022727139;1731.454591803603;1738.7049095194222;373.45475605616105;900.293269783217;928.9535523223811;944.9622015119318;1041.8853926068127;9495.857562136573;9671.419714817133;9724.27067969891;10275.588976440858;10313;400.49137595253865;402.47477042459286;409.35935261315944;413.9565345638725;424.7027081043282;5478.534324582375;5510.862228444321;5524.558035357162;5529.834104976857;5531;418941;422417;426972;451780;460556;75548;75559.24440755633;75933;78502;80458.19541804507;414.86724248240876;420.1743573877346;423.9025024244441;424.02474309088973;424.8194517330122;9254.35219534626;9299.349045566745;9434.811303774024;9461.38500997433;9555.331126821056;34040.14899627529;34622.480662789574;34639;34705.479417808245;34936.47595286022;46478;50274.74862625664;50504.49495504998;50670.493295066575;50784.49215507945;7477.663505142173;7490.475666703496;7556.055493063367;7634.503757255983;7641.083070031409;8779.20987111163;11161.162912781412;12248.510059597516;12612.36938153107;12970.35148242603;10026.849597256192;10380.169586433218;10398.68803935883;10531.78936421252;10766.138708903425;10837;10897.346159230472;10975.945120274348;11023.669289921316;11166.832497512381;10839;10846.67459976202;10956;10972.615958441416;11126.388048657078;7485.925140748523;7535.924640753522;7598.392128629807;7625.123110842324;7755.72854950074;7467.439942004263;9215.44707317563;10818.24272300963;10927.781444370909;11141.442927853737 17:43:38 INFO - PROCESS | 8536 | |3;mootools.html;1445.472402573061;1475.8450362711912;1617.7007253658073;1744.4504980931013;1760.234298080336;6552.541322107454;7076.964615176929;7378.815529611762;7534.472586918911;7616.08606967164;7010.964945175279;7017.052697885784;7072.434205263579;7099.929000709992;7128.572285662864;2205.9448513787165;2232.687423760675;2236.630955892276;2240.0591751464426;2242.7308722953267;2186.529896072344;2186.835987300951;2233.530958498717;2237.038073628339;2243.1363924888956;2199.296225207934;2199.3292045925987;2229.2977712020743;2244;2255.6842042114117;2174.3042226487532;2176.619091658961;2186.8031877131057;2190.211523851412;2199.49411635324;2185.355320180535;2188.518525924294;2189.2665956904457;2190.89045547722;2194.3526659635445;7252.347288743986;7283.526570772936;7299.89050164248;7322.560646361236;7332.816679582999;4273.658107351404;4385.144896745136;4402.713823601455;4408.096340250241;4411.029573493826;2834.7307005834414;2916.6500019997525;2989.1929179121735;2996.640403151614;3017.803842750236;933.2347475070445;956.2827879090682;977.1401166973089;982.0523195116747;988.2489308125804;9757;9792.853107203398;9794.608215671364;9810.656627018092;9825.3613515122;3777.0746167189213;3785.2240290740333;3812.2947254757405;3857.035741064734;3866.709996750255;8484.236418722345;8496.362772792065;8504.107068757816;8513.702020429379;8542.103079176597;4230.788460576959;4249.3625956106835;4252.425922500484;4254.404383386328;4283.186194623012;3587.3184095022384;3855.094052897567;3910.550286717007;3986.86045988389;4036.455078564415;3541.8760343387858;3551.786892786441;3597.8201089945396;3622.836972336251;3627.2564124354444;996.2428554298785;1020.6631811502186;1023.5240613114788;1028.3624153025173;1100.8018556659717;1306.4708792938875;1308.587794844621;1321.9933900330436;1323.4639970811836;1325.8011298305332;6839.418649414855;6841.897371539431;6936.79189624312;6949.722011119599;6950.339717726808;436.5874248834884;440.7774074092627;442.6834813108643;445.2608669608499;454.8385323210279;5279.340082489689;5347;5360.222767698662;5365.463453654604;5403.4326395727885;8383.664653413916;8578.914210857936;8723.60743766532;8805.811215485828;8870.512121833232;8552.444091134057;8613.310935125175;8700.12998700125;8705.563582009025;8751;6879.105716256955;6904.206016308089;6956.234814170437;6960.338767817049;7015.754448594173;6984.930150698428;7038.718451261892;7097.858042839218;7098.574085554883;7131.8573628528175;7566.583837888748;7905.920940790518;7923;7945.0863150738405;8108.878366824384;7683.692652293846;7853.293203611703;7909.9209007909185;7945.284924356835;7959.4030447715495;6661.666916654051;6804.897926531205;6829.112215411965;7100;7189.1013623297085;6771.052052712525;6847.554908930903;6863.07348507965;6897.48268879826;6918.238993710788;6371.13989611415;6434.938235191141;6512.869742605216;6518.57629254097;6533.640649764308;6291.559590828598;6364.904526432199;6453.225612926479;6575.112359831553;6591.274959754327;6578.539502234989;6603;6612;6734.629595372302;6776.119104516381;6009.429104235091;6155.538334624832;6160.507159427325;6270.372962703693;6296.181496405438;6314.4632706218645;6317.6209427434505;6335.461485773761;6353.96823015882;6366.649834258975 17:43:38 INFO - PROCESS | 8536 | |4;prototype.html;289.5049465414142;292.4574913535392;294.0912580127406;295.24859233251385;296.89311847734814;6171.876562468748;6211.627302361861;6237.563370564062;6329.7151628176725;6366.840828979278;6145.324014358417;6233.688315584225;6251.4998800096;6270.717817698203;6270.968645156768;4440.289553671413;4529.003619203786;4547.113312903985;4618.099470603233;4624.3294722265255;4587.036722288307;4593.563611456923;4598.448186217642;4602.240630295997;4607.216773148572;4507.414036175309;4515.029268707227;4519.0961807638605;4525.841595544157;4533.252013417782;4512.954870451286;4517.164324599943;4517.390152329443;4532.116237333721;4540.909181816345;3858.247641709868;3861.3049651062797;3873.32216862048;3874.7093967952515;3881.6700580450697;5852.912206316909;5879.118132280149;5904.911426328608;5908.940910590925;5925.34821169671;5116.641835071547;5251.789928402859;5266.7629956652045;5276.762545685453;5278.9208161877605;6503.707333169971;6517.446017088553;6526.836829079263;6536.477081833442;6554.115194448784;4252.319628859399;4264.360345948102;4264.552222016675;4267.679924005712;4276.166147601219;6801.829954251134;6947.3747362737595;6955.860882782366;6974.0236366908675;6979;4317.978410107929;4328;4334.414853994734;4337.132573485315;4337.980574564975;4212.557681443465;4323.416338794285;4389.758563279051;4395.747212044552;4409.536998615164;5152.072626927189;5153.330067091254;5174.09453345663;5185.844424667266;5201.245819356172;6613.669316534154;6614.239362473377;6619.470442364599;6627.933720662828;6629.071929929813;1513.3190064471032;1545.0266332210635;1547.1645311531872;1549.5971047527498;1552.2394026926725;974.751438383222;989.1740396768779;994.8855881573567;1002.0630710285906;1004.9799004019878;6341.397567231105;6355.142055822497;6364.459020983176;6367.968160159169;6375.553711240262;6773.051772751819;6782.491313151533;6799.898001529981;6800.591964482147;6812.386885180357;6122.632642041492;6234.127222188898;6329.272133704683;6331.841703957438;6332.4934005279465;3677.3196958562753;3693.0582701410967;3707.1844194277214;3709.8330575124182;3713.795741234258;7281.817954551073;7287;7304.780856574312;7314.08573928259;7315.707371705179;7019.666263409936;7027.472939529555;7032.578045317195;7037.894431583531;7043.471739619549;6919.619420931796;7064.92935070653;7099.07711997437;7131.322524360177;7269.345758881726;6843.657817109224;6847.144106986627;6857.074294970115;6862.519623626298;6869.450443964371;6769.1876974763345;6792.72829086831;6792.830179245559;6799.864002720017;6800.795976120724;7266.200717920919;7273.3817625502425;7277.345038946521;7280.381167600814;7312.634368281671;4275.273203555341;4369.71596846204;4375.343698445131;4380.518143004203;4386.692931494765;6792.388685018372;6870.862582748217;6881.174259088942;6881.346272104142;6884;6572.375624315682;6586.868262634816;6603.372679595431;6614.10709554204;6634.469242460688;6588.670566471753;6604.768833090819;6613.834654133685;6622.304658010839;6665.900011499734;6313.05304204373;6448.226212854487;6509.544331896722;6517.641529715911;6525.967370163309;6653.534252602465;6668.733250669919;6670.866582668416;6675.499337549606;6678.3989440950545;6450.451711604566;6480.870382592416;6498.090267362479;6500.089987401673;6505.739770409131 17:43:38 INFO - PROCESS | 8536 | |5;yui.html;677.4309579952842;698.7449580902966;706.5336877660743;743.9918909877116;792.1959211400429;13416.396262168202;13439.059265851394;13604.931975340109;13628.454861805529;13638.045336826426;12732.745345093115;12800.80798788019;12816.487340506392;13578.592642220725;13798.448062077505;670.0318040431579;796.7012370361115;797.8364435290752;813.9064007639138;815.514768712615;808.0989696488432;810.5420437452821;812.6668066092903;812.9471584347028;813.2883726739103;847.8643417053273;849.235687880906;849.4351256414477;851.8296340731847;853.4068822168596;833.6165363932598;844.4215712237137;844.9788755281106;846.8899043124385;852.0882655558555;624.7625902157197;627.645380360095;627.7991042866284;629.8992161254178;632.9208848893888;14163.79607733344;14213.360398782079;14300.427982880672;14302.427902883872;14360.138391696428;12267.141300108997;12286.324252166127;12568.560100396442;12653.620391388273;12727.427265773062;10473.581056757721;10482.528286227138;10559.630412935587;10631.627893023708;10692.732681682943;3527.7001454876367;3556.448750443685;3559.66183212597;3687.9858039039477;3703.4815125882396;50637.240441393405;50939.490605093844;51468.22797658038;51601.741991289804;51925.99999999962;9713.514324283757;10064.496775161213;10130.594776208869;10174.643887463903;10176.694699159038;17505.299788008593;17544.736828947574;17552.38566650161;17557.91221043912;17590.824091759176;7421.517601355895;7459.738909138154;7540.660670269851;7560.659770310349;7570.583617900958;4092.570280120604;4118.444010058603;4293.656507479394;4340.327249276367;4343.261645520269;3052.481078216664;3064.5096784514817;3077.07687693691;3082.9383412331626;3089.304906396088;544.6568661743156;544.964577302474;547.7261369315343;554.5757495515934;555.1173633922002;607.7116512992484;623.0778447897137;635.4535099814157;650.3561474140566;653.6502970910635;7554.8866766998535;7927.3658107351275;8023.9598802006785;8130.105688374274;8528.445651032664;540.4244479629261;562.4937556199371;567.3418834152446;573.3292048303495;578.5892016668129;3657.7073834093208;3777.622237776255;3882.165334453106;3945.2109578084496;3976.3240249157134;54151;54248.45751542434;54899.72550137224;55332.72333638306;56356;44296.77851610721;44397.33403998943;45020.77489612531;45310;45396;42513.57486425158;42796.35805462921;43115;43804;44137.779311103885;7896.565688887166;7985.680572777024;8081.434299598972;8178.713745018896;8435.409521333448;32370.35259294848;32800.50799238061;32976.835115824266;33212.1696957578;33666.49500257449;38893;38974;41942;42009.78995105005;42443.15113697771;10173.898261017592;10775.892241077489;10866.836997444887;10915.945420273165;11174.608888688857;12028.699282518008;12171.817422738843;12331.136820422484;12368.319742413894;12924.030697697899;10845;11322.207445479067;11389.772204556028;11946.76106477883;11952.34262115592;11111.222214444912;11283.605073822377;11319.377434241196;11688.532458701557;11812.232204906653;9785.755356116155;10523.526441310007;10531.210159237935;10602.840957385491;11272.83090753623;8588;8717.651293948426;8747.927443135068;8816.779580510538;9128.224100951493;8395.664173432995;8850.690225842065;9044.547772611475;9180.6786762463;9326.766830829283 17:43:38 INFO - PROCESS | 8536 | __end_tp_report 17:43:38 INFO - PROCESS | 8536 | __start_cc_report 17:43:38 INFO - PROCESS | 8536 | _x_x_mozilla_cycle_collect,309 17:43:38 INFO - PROCESS | 8536 | __end_cc_report 17:43:38 INFO - PROCESS | 8536 | __startTimestamp1456796618183__endTimestamp 17:43:38 INFO - PROCESS | 8536 | 17:43:38 INFO - PROCESS | 8536 | ------- Summary: start ------- 17:43:38 INFO - PROCESS | 8536 | Number of tests: 6 17:43:38 INFO - PROCESS | 8536 | 17:43:38 INFO - PROCESS | 8536 | [#0] dojo.html Cycles:165 Average:5122.96 Median:5351.92 stddev:644.68 (12.0%) stddev-sans-first:627.57 17:43:38 INFO - PROCESS | 8536 | Values: 3138.2 3143.1 3175.4 3187.7 3188.5 5075.9 5082.9 5115.0 5165.7 5183.9 5072.6 5082.8 5089.8 5092.4 5128.0 4702.4 4755.7 4757.6 4772.1 4778.0 850.2 4751.6 4808.7 4824.7 4843.6 4760.1 4783.1 4798.6 4799.7 4833.3 4773.9 4776.1 4805.1 4831.7 4849.6 4646.4 4829.5 4846.3 4854.1 4902.3 4979.5 4984.0 4992.0 4992.4 5018.7 5427.9 5487.9 5491.3 5496.7 5540.6 5512.9 5514.6 5520.4 5529.8 5593.1 5126.4 5136.4 5141.9 5143.5 5179.4 5555.2 5561.3 5563.5 5565.2 5612.9 5365.9 5373.0 5386.5 5412.6 5441.0 5525.6 5546.6 5551.9 5567.8 5569.7 5471.1 5523.8 5538.6 5543.6 5549.1 5319.2 5419.3 5444.6 5499.6 5500.1 4116.4 4210.3 4251.2 4257.6 4293.7 3831.3 3839.3 3840.9 3850.4 3872.8 5235.2 5250.7 5326.7 5332.5 5388.5 5462.2 5473.4 5491.2 5502.1 5513.1 5178.0 5240.1 5243.5 5244.3 5289.7 4652.3 4685.0 4704.2 4719.3 4719.6 5854.8 5861.0 5864.6 5870.0 5886.8 5544.4 5596.5 5600.1 5600.7 5610.4 5702.4 5736.6 5761.6 5781.2 5814.7 5402.4 5405.8 5412.6 5414.6 5424.4 5436.8 5495.5 5497.6 5508.3 5552.7 5385.6 5391.5 5411.8 5432.8 5481.6 5331.1 5388.2 5416.5 5426.6 5437.2 5202.8 5297.5 5339.0 5351.9 5360.1 5404.5 5437.3 5463.5 5478.8 5488.8 5307.2 5313.4 5314.4 5335.3 5366.8 17:43:38 INFO - PROCESS | 8536 | 17:43:38 INFO - PROCESS | 8536 | [#1] ext.html Cycles:180 Average:44464.28 Median:36268.50 stddev:78738.76 (217.1%) stddev-sans-first:78890.51 17:43:38 INFO - PROCESS | 8536 | Values: 519.8 531.4 564.6 587.7 603.7 35662.8 36160.3 36271.0 36282.0 36516.3 37058.0 37524.0 37662.6 37766.6 37900.1 8293.4 8443.8 8489.4 8505.3 8518.3 8305.3 8417.2 8451.4 8608.7 8616.5 8526.0 8610.3 8619.7 8625.8 8634.7 8564.4 8586.7 8596.9 8617.3 8629.0 8544.5 8641.0 8647.8 8665.4 8687.5 34914.6 35208.8 35224.3 35299.1 35348.3 2650.6 3052.2 3249.6 3343.2 3733.8 26743.6 26751.3 26961.6 27000.7 27280.2 3292.4 3308.9 3358.9 3407.5 3493.2 186610.0 186733.0 187553.0 187728.0 188020.0 40432.4 55086.9 55279.4 55299.7 55411.4 38988.8 39213.0 39226.8 39252.2 39341.6 14007.6 14253.9 14257.4 14302.4 14329.1 11270.5 11327.1 11332.5 11348.3 11349.1 14045.6 14095.8 14139.7 14149.6 14176.3 5862.4 5956.6 6035.2 6063.2 6070.8 915.7 941.0 951.8 993.4 1064.9 30657.1 31275.5 31773.5 32088.4 32172.5 972.5 1045.9 1078.7 1104.0 1135.5 14266.7 14476.3 14487.3 14697.3 14711.6 379379.0 386226.0 389290.0 390158.0 390266.0 52817.2 53916.5 53957.7 54072.7 54500.7 1171.6 1179.6 1201.1 1215.9 1437.9 28503.4 29083.7 29086.1 29736.6 29743.6 45112.8 45237.5 45584.5 45616.0 45755.8 286071.0 287286.0 287663.0 288859.0 290037.0 31764.5 31799.2 32367.0 32825.7 33078.3 42486.8 42525.8 42973.1 43081.1 43201.4 34835.7 36492.0 36539.3 36594.8 37182.4 36561.6 36602.5 37021.0 37415.8 37542.6 35125.3 35444.8 36043.5 36266.0 36435.3 27611.9 29320.0 29507.0 29599.7 29752.6 23274.7 23509.0 23630.5 24257.4 24295.9 17:43:38 INFO - PROCESS | 8536 | 17:43:38 INFO - PROCESS | 8536 | [#2] jquery.html Cycles:180 Average:24461.19 Median:25576.28 stddev:71929.91 (281.2%) stddev-sans-first:72108.87 17:43:38 INFO - PROCESS | 8536 | Values: 329.2 330.6 337.0 338.2 338.4 16440.6 16975.7 17059.3 18083.5 18131.7 9168.4 9441.5 9499.0 14795.3 15022.2 4587.9 4707.4 4764.5 4767.8 4783.2 3676.3 4674.6 5012.1 5185.6 5197.4 5159.2 5161.7 5162.2 5167.7 5169.4 5029.2 5055.5 5074.8 5115.4 5149.9 4908.8 4909.8 4930.3 4932.4 4947.7 11416.1 11681.6 11821.6 11834.8 11865.9 2006.7 2082.1 2143.4 2149.1 2198.7 8449.0 8618.3 8737.2 8788.0 8809.3 1816.7 1843.4 1856.5 1865.6 1866.2 65279.3 67490.7 67689.3 68325.3 69096.7 8917.1 9115.5 9146.8 9825.9 9870.9 12659.3 12734.5 12761.0 12769.5 12772.4 6645.9 6736.2 6827.3 6899.9 6902.9 6698.8 6798.6 6823.7 6967.0 6968.6 4118.3 4145.5 4153.4 4167.1 4228.3 1646.8 1671.7 1699.4 1731.5 1738.7 373.5 900.3 929.0 945.0 1041.9 9495.9 9671.4 9724.3 10275.6 10313.0 400.5 402.5 409.4 414.0 424.7 5478.5 5510.9 5524.6 5529.8 5531.0 418941.0 422417.0 426972.0 451780.0 460556.0 75548.0 75559.2 75933.0 78502.0 80458.2 414.9 420.2 423.9 424.0 424.8 9254.4 9299.3 9434.8 9461.4 9555.3 34040.1 34622.5 34639.0 34705.5 34936.5 46478.0 50274.7 50504.5 50670.5 50784.5 7477.7 7490.5 7556.1 7634.5 7641.1 8779.2 11161.2 12248.5 12612.4 12970.4 10026.8 10380.2 10398.7 10531.8 10766.1 10837.0 10897.3 10975.9 11023.7 11166.8 10839.0 10846.7 10956.0 10972.6 11126.4 7485.9 7535.9 7598.4 7625.1 7755.7 7467.4 9215.4 10818.2 10927.8 11141.4 17:43:38 INFO - PROCESS | 8536 | 17:43:38 INFO - PROCESS | 8536 | [#3] mootools.html Cycles:180 Average:5123.16 Median:6368.89 stddev:2636.60 (41.4%) stddev-sans-first:2629.51 17:43:38 INFO - PROCESS | 8536 | Values: 1445.5 1475.8 1617.7 1744.5 1760.2 6552.5 7077.0 7378.8 7534.5 7616.1 7011.0 7017.1 7072.4 7099.9 7128.6 2205.9 2232.7 2236.6 2240.1 2242.7 2186.5 2186.8 2233.5 2237.0 2243.1 2199.3 2199.3 2229.3 2244.0 2255.7 2174.3 2176.6 2186.8 2190.2 2199.5 2185.4 2188.5 2189.3 2190.9 2194.4 7252.3 7283.5 7299.9 7322.6 7332.8 4273.7 4385.1 4402.7 4408.1 4411.0 2834.7 2916.7 2989.2 2996.6 3017.8 933.2 956.3 977.1 982.1 988.2 9757.0 9792.9 9794.6 9810.7 9825.4 3777.1 3785.2 3812.3 3857.0 3866.7 8484.2 8496.4 8504.1 8513.7 8542.1 4230.8 4249.4 4252.4 4254.4 4283.2 3587.3 3855.1 3910.6 3986.9 4036.5 3541.9 3551.8 3597.8 3622.8 3627.3 996.2 1020.7 1023.5 1028.4 1100.8 1306.5 1308.6 1322.0 1323.5 1325.8 6839.4 6841.9 6936.8 6949.7 6950.3 436.6 440.8 442.7 445.3 454.8 5279.3 5347.0 5360.2 5365.5 5403.4 8383.7 8578.9 8723.6 8805.8 8870.5 8552.4 8613.3 8700.1 8705.6 8751.0 6879.1 6904.2 6956.2 6960.3 7015.8 6984.9 7038.7 7097.9 7098.6 7131.9 7566.6 7905.9 7923.0 7945.1 8108.9 7683.7 7853.3 7909.9 7945.3 7959.4 6661.7 6804.9 6829.1 7100.0 7189.1 6771.1 6847.6 6863.1 6897.5 6918.2 6371.1 6434.9 6512.9 6518.6 6533.6 6291.6 6364.9 6453.2 6575.1 6591.3 6578.5 6603.0 6612.0 6734.6 6776.1 6009.4 6155.5 6160.5 6270.4 6296.2 6314.5 6317.6 6335.5 6354.0 6366.6 17:43:38 INFO - PROCESS | 8536 | 17:43:38 INFO - PROCESS | 8536 | [#4] prototype.html Cycles:180 Average:5451.72 Median:6332.17 stddev:1747.69 (27.6%) stddev-sans-first:1709.11 17:43:38 INFO - PROCESS | 8536 | Values: 289.5 292.5 294.1 295.2 296.9 6171.9 6211.6 6237.6 6329.7 6366.8 6145.3 6233.7 6251.5 6270.7 6271.0 4440.3 4529.0 4547.1 4618.1 4624.3 4587.0 4593.6 4598.4 4602.2 4607.2 4507.4 4515.0 4519.1 4525.8 4533.3 4513.0 4517.2 4517.4 4532.1 4540.9 3858.2 3861.3 3873.3 3874.7 3881.7 5852.9 5879.1 5904.9 5908.9 5925.3 5116.6 5251.8 5266.8 5276.8 5278.9 6503.7 6517.4 6526.8 6536.5 6554.1 4252.3 4264.4 4264.6 4267.7 4276.2 6801.8 6947.4 6955.9 6974.0 6979.0 4318.0 4328.0 4334.4 4337.1 4338.0 4212.6 4323.4 4389.8 4395.7 4409.5 5152.1 5153.3 5174.1 5185.8 5201.2 6613.7 6614.2 6619.5 6627.9 6629.1 1513.3 1545.0 1547.2 1549.6 1552.2 974.8 989.2 994.9 1002.1 1005.0 6341.4 6355.1 6364.5 6368.0 6375.6 6773.1 6782.5 6799.9 6800.6 6812.4 6122.6 6234.1 6329.3 6331.8 6332.5 3677.3 3693.1 3707.2 3709.8 3713.8 7281.8 7287.0 7304.8 7314.1 7315.7 7019.7 7027.5 7032.6 7037.9 7043.5 6919.6 7064.9 7099.1 7131.3 7269.3 6843.7 6847.1 6857.1 6862.5 6869.5 6769.2 6792.7 6792.8 6799.9 6800.8 7266.2 7273.4 7277.3 7280.4 7312.6 4275.3 4369.7 4375.3 4380.5 4386.7 6792.4 6870.9 6881.2 6881.3 6884.0 6572.4 6586.9 6603.4 6614.1 6634.5 6588.7 6604.8 6613.8 6622.3 6665.9 6313.1 6448.2 6509.5 6517.6 6526.0 6653.5 6668.7 6670.9 6675.5 6678.4 6450.5 6480.9 6498.1 6500.1 6505.7 17:43:38 INFO - PROCESS | 8536 | 17:43:38 INFO - PROCESS | 8536 | [#5] yui.html Cycles:180 Average:13309.73 Median:24073.63 stddev:15149.06 (62.9%) stddev-sans-first:15161.85 17:43:38 INFO - PROCESS | 8536 | Values: 677.4 698.7 706.5 744.0 792.2 13416.4 13439.1 13604.9 13628.5 13638.0 12732.7 12800.8 12816.5 13578.6 13798.4 670.0 796.7 797.8 813.9 815.5 808.1 810.5 812.7 812.9 813.3 847.9 849.2 849.4 851.8 853.4 833.6 844.4 845.0 846.9 852.1 624.8 627.6 627.8 629.9 632.9 14163.8 14213.4 14300.4 14302.4 14360.1 12267.1 12286.3 12568.6 12653.6 12727.4 10473.6 10482.5 10559.6 10631.6 10692.7 3527.7 3556.4 3559.7 3688.0 3703.5 50637.2 50939.5 51468.2 51601.7 51926.0 9713.5 10064.5 10130.6 10174.6 10176.7 17505.3 17544.7 17552.4 17557.9 17590.8 7421.5 7459.7 7540.7 7560.7 7570.6 4092.6 4118.4 4293.7 4340.3 4343.3 3052.5 3064.5 3077.1 3082.9 3089.3 544.7 545.0 547.7 554.6 555.1 607.7 623.1 635.5 650.4 653.7 7554.9 7927.4 8024.0 8130.1 8528.4 540.4 562.5 567.3 573.3 578.6 3657.7 3777.6 3882.2 3945.2 3976.3 54151.0 54248.5 54899.7 55332.7 56356.0 44296.8 44397.3 45020.8 45310.0 45396.0 42513.6 42796.4 43115.0 43804.0 44137.8 7896.6 7985.7 8081.4 8178.7 8435.4 32370.4 32800.5 32976.8 33212.2 33666.5 38893.0 38974.0 41942.0 42009.8 42443.2 10173.9 10775.9 10866.8 10915.9 11174.6 12028.7 12171.8 12331.1 12368.3 12924.0 10845.0 11322.2 11389.8 11946.8 11952.3 11111.2 11283.6 11319.4 11688.5 11812.2 9785.8 10523.5 10531.2 10602.8 11272.8 8588.0 8717.7 8747.9 8816.8 9128.2 8395.7 8850.7 9044.5 9180.7 9326.8 17:43:38 INFO - PROCESS | 8536 | -------- Summary: end -------- 17:43:38 INFO - PROCESS | 8536 | 17:43:38 INFO - PROCESS | 8536 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:43:38 INFO - PROCESS | 8536 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:43:38 INFO - PROCESS | 8536 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:43:38 INFO - PROCESS | 8536 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:43:38 INFO - PROCESS | 8536 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:43:38 INFO - PROCESS | 8536 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:43:38 INFO - PROCESS | 8536 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:43:38 INFO - PROCESS | 8536 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:43:38 INFO - PROCESS | 8536 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:43:38 INFO - TEST-INFO | 8536: exit 0 17:43:38 INFO - TEST-OK | dromaeo_css | took 1110154ms 17:43:38 INFO - TEST-START | kraken 17:43:38 INFO - operating with platform_type : linux_ 17:43:38 INFO - Initialising browser for kraken test... 17:43:38 INFO - TEST-INFO | started process 8774 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp97jtLs/profile http://localhost:36894/getInfo.html) 17:43:42 INFO - PROCESS | 8774 | 17:43:42 INFO - PROCESS | 8774 | (process:8846): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:43:43 INFO - PROCESS | 8774 | __metrics Screen width/height:1600/1200 17:43:43 INFO - PROCESS | 8774 | colorDepth:24 17:43:43 INFO - PROCESS | 8774 | Browser inner width/height: 1024/697 17:43:43 INFO - PROCESS | 8774 | __metrics 17:43:43 ERROR - PROCESS | 8774 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 17:43:43 INFO - PROCESS | 8774 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:43:43 INFO - PROCESS | 8774 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:43:43 INFO - PROCESS | 8774 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:43:43 INFO - PROCESS | 8774 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:43:43 INFO - PROCESS | 8774 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:43:43 INFO - PROCESS | 8774 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:43:43 INFO - PROCESS | 8774 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:43:43 INFO - PROCESS | 8774 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:43:43 INFO - PROCESS | 8774 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:43:44 INFO - TEST-INFO | 8774: exit 0 17:43:44 INFO - Browser initialized. 17:43:44 INFO - Running cycle 1/1 for kraken test... 17:43:44 INFO - TEST-INFO | started process 8897 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp97jtLs/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:43:45 INFO - PROCESS | 8897 | 17:43:45 INFO - PROCESS | 8897 | (process:8957): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:43:56 INFO - PROCESS | 8897 | RSS: Main: 160911360 17:43:56 INFO - PROCESS | 8897 | 17:43:58 INFO - PROCESS | 8897 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36894/tests/kraken/driver.html?testName=audio-beat-detection) 17:43:59 INFO - PROCESS | 8897 | RSS: Main: 167690240 17:43:59 INFO - PROCESS | 8897 | 17:44:02 INFO - PROCESS | 8897 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36894/tests/kraken/driver.html?testName=audio-dft) 17:44:02 INFO - PROCESS | 8897 | RSS: Main: 169705472 17:44:02 INFO - PROCESS | 8897 | 17:44:05 INFO - PROCESS | 8897 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36894/tests/kraken/driver.html?testName=audio-fft) 17:44:06 INFO - PROCESS | 8897 | RSS: Main: 161906688 17:44:06 INFO - PROCESS | 8897 | 17:44:08 INFO - PROCESS | 8897 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36894/tests/kraken/driver.html?testName=audio-oscillator) 17:44:08 INFO - PROCESS | 8897 | RSS: Main: 162873344 17:44:08 INFO - PROCESS | 8897 | 17:44:10 INFO - PROCESS | 8897 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36894/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:44:11 INFO - PROCESS | 8897 | RSS: Main: 164585472 17:44:11 INFO - PROCESS | 8897 | 17:44:14 INFO - PROCESS | 8897 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36894/tests/kraken/driver.html?testName=imaging-darkroom) 17:44:15 INFO - PROCESS | 8897 | RSS: Main: 162951168 17:44:15 INFO - PROCESS | 8897 | 17:44:18 INFO - PROCESS | 8897 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36894/tests/kraken/driver.html?testName=imaging-desaturate) 17:44:19 INFO - PROCESS | 8897 | RSS: Main: 165097472 17:44:19 INFO - PROCESS | 8897 | 17:44:22 INFO - PROCESS | 8897 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36894/tests/kraken/driver.html?testName=json-parse-financial) 17:44:22 INFO - PROCESS | 8897 | RSS: Main: 165613568 17:44:22 INFO - PROCESS | 8897 | 17:44:24 INFO - PROCESS | 8897 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36894/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:44:24 INFO - PROCESS | 8897 | RSS: Main: 166899712 17:44:24 INFO - PROCESS | 8897 | 17:44:26 INFO - PROCESS | 8897 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36894/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:44:27 INFO - PROCESS | 8897 | RSS: Main: 165650432 17:44:27 INFO - PROCESS | 8897 | 17:44:29 INFO - PROCESS | 8897 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36894/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:44:29 INFO - PROCESS | 8897 | RSS: Main: 165900288 17:44:29 INFO - PROCESS | 8897 | 17:44:32 INFO - PROCESS | 8897 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36894/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:44:32 INFO - PROCESS | 8897 | RSS: Main: 165814272 17:44:32 INFO - PROCESS | 8897 | 17:44:35 INFO - PROCESS | 8897 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36894/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:44:36 INFO - PROCESS | 8897 | RSS: Main: 165859328 17:44:36 INFO - PROCESS | 8897 | 17:44:37 INFO - PROCESS | 8897 | Cycle 1(1): loaded http://localhost:36894/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36894/tests/kraken/driver.html?testName=ai-astar) 17:44:38 INFO - PROCESS | 8897 | RSS: Main: 167424000 17:44:38 INFO - PROCESS | 8897 | 17:44:38 INFO - PROCESS | 8897 | __start_tp_report 17:44:38 INFO - PROCESS | 8897 | _x_x_mozilla_page_load 17:44:38 INFO - PROCESS | 8897 | _x_x_mozilla_page_load_details 17:44:38 INFO - PROCESS | 8897 | |i|pagename|runs| 17:44:38 INFO - PROCESS | 8897 | |0;ai-astar;113;107;111;111;112;122;111;111;112;111 17:44:38 INFO - PROCESS | 8897 | |1;audio-beat-detection;157;126;151;186;133;155;154;129;172;129 17:44:38 INFO - PROCESS | 8897 | |2;audio-dft;162;165;161;161;161;160;160;169;169;161 17:44:38 INFO - PROCESS | 8897 | |3;audio-fft;73;73;73;74;74;164;73;72;74;74 17:44:38 INFO - PROCESS | 8897 | |4;audio-oscillator;96;97;147;96;96;95;151;94;96;143 17:44:38 INFO - PROCESS | 8897 | |5;imaging-gaussian-blur;120;117;117;115;116;115;115;114;116;115 17:44:38 INFO - PROCESS | 8897 | |6;imaging-darkroom;146;146;146;148;146;147;146;147;146;146 17:44:38 INFO - PROCESS | 8897 | |7;imaging-desaturate;97;98;97;97;99;96;96;98;96;97 17:44:38 INFO - PROCESS | 8897 | |8;json-parse-financial;57;57;57;60;56;57;56;63;56;55 17:44:38 INFO - PROCESS | 8897 | |9;json-stringify-tinderbox;68;68;69;69;69;69;68;69;68;69 17:44:38 INFO - PROCESS | 8897 | |10;stanford-crypto-aes;83;91;86;91;83;83;84;87;85;84 17:44:38 INFO - PROCESS | 8897 | |11;stanford-crypto-ccm;121;119;119;120;119;121;118;119;117;118 17:44:38 INFO - PROCESS | 8897 | |12;stanford-crypto-pbkdf2;147;154;155;154;157;147;158;152;144;143 17:44:38 INFO - PROCESS | 8897 | |13;stanford-crypto-sha256-iterative;71;71;70;70;70;67;70;71;71;70 17:44:38 INFO - PROCESS | 8897 | __end_tp_report 17:44:38 INFO - PROCESS | 8897 | __start_cc_report 17:44:38 INFO - PROCESS | 8897 | _x_x_mozilla_cycle_collect,821 17:44:38 INFO - PROCESS | 8897 | __end_cc_report 17:44:38 INFO - PROCESS | 8897 | __startTimestamp1456796678095__endTimestamp 17:44:38 INFO - PROCESS | 8897 | 17:44:38 INFO - PROCESS | 8897 | ------- Summary: start ------- 17:44:38 INFO - PROCESS | 8897 | Number of tests: 14 17:44:38 INFO - PROCESS | 8897 | 17:44:38 INFO - PROCESS | 8897 | [#0] ai-astar Cycles:10 Average:112.10 Median:111.50 stddev:3.81 (3.4%) stddev-sans-first:4.03 17:44:38 INFO - PROCESS | 8897 | Values: 113.0 107.0 111.0 111.0 112.0 122.0 111.0 111.0 112.0 111.0 17:44:38 INFO - PROCESS | 8897 | 17:44:38 INFO - PROCESS | 8897 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:154.50 stddev:20.03 (13.0%) stddev-sans-first:21.05 17:44:38 INFO - PROCESS | 8897 | Values: 157.0 126.0 151.0 186.0 133.0 155.0 154.0 129.0 172.0 129.0 17:44:38 INFO - PROCESS | 8897 | 17:44:38 INFO - PROCESS | 8897 | [#2] audio-dft Cycles:10 Average:162.90 Median:161.50 stddev:3.51 (2.2%) stddev-sans-first:3.71 17:44:38 INFO - PROCESS | 8897 | Values: 162.0 165.0 161.0 161.0 161.0 160.0 160.0 169.0 169.0 161.0 17:44:38 INFO - PROCESS | 8897 | 17:44:38 INFO - PROCESS | 8897 | [#3] audio-fft Cycles:10 Average:82.40 Median:73.50 stddev:28.68 (39.0%) stddev-sans-first:30.22 17:44:38 INFO - PROCESS | 8897 | Values: 73.0 73.0 73.0 74.0 74.0 164.0 73.0 72.0 74.0 74.0 17:44:38 INFO - PROCESS | 8897 | 17:44:38 INFO - PROCESS | 8897 | [#4] audio-oscillator Cycles:10 Average:111.10 Median:96.00 stddev:24.86 (25.9%) stddev-sans-first:25.76 17:44:38 INFO - PROCESS | 8897 | Values: 96.0 97.0 147.0 96.0 96.0 95.0 151.0 94.0 96.0 143.0 17:44:38 INFO - PROCESS | 8897 | 17:44:38 INFO - PROCESS | 8897 | [#5] imaging-gaussian-blur Cycles:10 Average:116.00 Median:116.00 stddev:1.70 (1.5%) stddev-sans-first:1.01 17:44:38 INFO - PROCESS | 8897 | Values: 120.0 117.0 117.0 115.0 116.0 115.0 115.0 114.0 116.0 115.0 17:44:38 INFO - PROCESS | 8897 | 17:44:38 INFO - PROCESS | 8897 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 17:44:38 INFO - PROCESS | 8897 | Values: 146.0 146.0 146.0 148.0 146.0 147.0 146.0 147.0 146.0 146.0 17:44:38 INFO - PROCESS | 8897 | 17:44:38 INFO - PROCESS | 8897 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:97.00 stddev:0.99 (1.0%) stddev-sans-first:1.05 17:44:38 INFO - PROCESS | 8897 | Values: 97.0 98.0 97.0 97.0 99.0 96.0 96.0 98.0 96.0 97.0 17:44:38 INFO - PROCESS | 8897 | 17:44:38 INFO - PROCESS | 8897 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.00 stddev:2.37 (4.2%) stddev-sans-first:2.51 17:44:38 INFO - PROCESS | 8897 | Values: 57.0 57.0 57.0 60.0 56.0 57.0 56.0 63.0 56.0 55.0 17:44:38 INFO - PROCESS | 8897 | 17:44:38 INFO - PROCESS | 8897 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.52 (0.7%) stddev-sans-first:0.50 17:44:38 INFO - PROCESS | 8897 | Values: 68.0 68.0 69.0 69.0 69.0 69.0 68.0 69.0 68.0 69.0 17:44:38 INFO - PROCESS | 8897 | 17:44:38 INFO - PROCESS | 8897 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.50 stddev:3.09 (3.6%) stddev-sans-first:3.12 17:44:38 INFO - PROCESS | 8897 | Values: 83.0 91.0 86.0 91.0 83.0 83.0 84.0 87.0 85.0 84.0 17:44:38 INFO - PROCESS | 8897 | 17:44:38 INFO - PROCESS | 8897 | [#11] stanford-crypto-ccm Cycles:10 Average:119.10 Median:119.00 stddev:1.29 (1.1%) stddev-sans-first:1.17 17:44:38 INFO - PROCESS | 8897 | Values: 121.0 119.0 119.0 120.0 119.0 121.0 118.0 119.0 117.0 118.0 17:44:38 INFO - PROCESS | 8897 | 17:44:38 INFO - PROCESS | 8897 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.10 Median:154.00 stddev:5.43 (3.5%) stddev-sans-first:5.55 17:44:38 INFO - PROCESS | 8897 | Values: 147.0 154.0 155.0 154.0 157.0 147.0 158.0 152.0 144.0 143.0 17:44:38 INFO - PROCESS | 8897 | 17:44:38 INFO - PROCESS | 8897 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.50 stddev:1.20 (1.7%) stddev-sans-first:1.22 17:44:38 INFO - PROCESS | 8897 | Values: 71.0 71.0 70.0 70.0 70.0 67.0 70.0 71.0 71.0 70.0 17:44:38 INFO - PROCESS | 8897 | -------- Summary: end -------- 17:44:38 INFO - PROCESS | 8897 | 17:44:38 INFO - PROCESS | 8897 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:44:38 INFO - PROCESS | 8897 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:44:38 INFO - PROCESS | 8897 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:44:38 INFO - PROCESS | 8897 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:44:38 INFO - PROCESS | 8897 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:44:38 INFO - PROCESS | 8897 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:44:38 INFO - PROCESS | 8897 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:44:39 INFO - TEST-INFO | 8897: exit 0 17:44:39 INFO - TEST-OK | kraken | took 60213ms 17:44:39 INFO - SUITE-END | took 1170s 17:44:39 INFO - Completed test suite (00:19:30) 17:44:39 INFO - Working with test: dromaeo_css 17:44:39 INFO - Generating results file: dromaeo_css 17:44:39 INFO - Working with test: kraken 17:44:39 INFO - Generating results file: kraken 17:44:39 INFO - javascript benchmark 17:44:39 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:44:39 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 17:44:39 INFO - process_Request line: dromaeo_css 6547.90 graph.html#tests=[[72,64,43]] 17:44:39 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:44:39 INFO - process_Request line: kraken 1529.20 graph.html#tests=[[232,64,43]] 17:44:39 INFO - RETURN: dromaeo_css: 6547.90 17:44:39 INFO - RETURN: kraken: 1529.20 17:44:39 INFO - javascript benchmark 17:44:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3138.152698771332, 3143.1042152986397, 3175.4284228838815, 3187.681231876814, 3188.473901806202, 5075.9238611420815, 5082.898342033157, 5114.9744251278735, 5165.715885626294, 5183.870403239921, 5072.568831649305, 5082.822101226458, 5089.847304580869, 5092.414372347182, 5128.000039992203, 4702.435707715079, 4755.738434386108, 4757.595604373632, 4772.141014617368, 4778.044391121773, 850.1653213791936, 4751.596114330268, 4808.663393562452, 4824.710517368969, 4843.564079232869, 4760.11937791508, 4783.067301876135, 4798.568128868401, 4799.688020278671, 4833.299171620095, 4773.880652983668, 4776.0925424169645, 4805.087033463631, 4831.661783675144, 4849.612031037544, 4646.4191976003, 4829.492903245144, 4846.29728689338, 4854.077725232195, 4902.28916807061, 4979.526944940225, 4983.950160498385, 4991.975040124812, 4992.40091189056, 5018.723970181639, 5427.891442171174, 5487.917681234785, 5491.313585801775, 5496.670199787985, 5540.584456165804, 5512.889742205173, 5514.6139770216105, 5520.420355862657, 5529.778808847682, 5593.105103183511, 5126.384833819965, 5136.409312928986, 5141.871453213662, 5143.459936706629, 5179.378474583074, 5555.2222688823595, 5561.277033985556, 5563.5271001964475, 5565.1930470082425, 5612.887742245132, 5365.946340536622, 5373.032854086224, 5386.48828361305, 5412.621116521806, 5441.0, 5525.557955363562, 5546.55627549795, 5551.944480555224, 5567.777288908398, 5569.66582005081, 5471.097268950579, 5523.7790488380815, 5538.6122971391615, 5543.639663421945, 5549.056660367747, 5319.2021196820015, 5419.3225846769155, 5444.5916556258435, 5499.587530935196, 5500.064988951808, 4116.361963895601, 4210.326347784401, 4251.213525497793, 4257.5529569395385, 4293.69944103916, 3831.310364134427, 3839.2513459875613, 3840.8655697051026, 3850.4416859555768, 3872.7869967151514, 5235.188545775335, 5250.684958902478, 5326.733663316819, 5332.493413125747, 5388.46115388458, 5462.235287059815, 5473.425290344536, 5491.2312276281355, 5502.119660854244, 5513.09034009384, 5177.974110129425, 5240.109181439165, 5243.528082472596, 5244.265802787537, 5289.70906600133, 4652.255639097796, 4685.0, 4704.153252414599, 4719.339292499053, 4719.646026547954, 5854.765809367577, 5861.0, 5864.618799778001, 5870.0, 5886.793962211302, 5544.362398324163, 5596.468335508121, 5600.131979543177, 5600.691961942132, 5610.354809196994, 5702.37273899879, 5736.569757268138, 5761.567882408753, 5781.248437703071, 5814.651120932757, 5402.378726446509, 5405.8107966221, 5412.621116521806, 5414.620976531763, 5424.403315635356, 5436.809711660073, 5495.477929596682, 5497.560195184456, 5508.3114610673665, 5552.7223638818705, 5385.596080293915, 5391.514763671288, 5411.783528658967, 5432.755526001419, 5481.561475082063, 5331.067063263991, 5388.218708287355, 5416.51251387377, 5426.620136590401, 5437.157240627709, 5202.843914682566, 5297.5232229099565, 5339.0, 5351.919721204107, 5360.0887849064975, 5404.54061404785, 5437.293151890229, 5463.48096930791, 5478.835634930959, 5488.780448782004, 5307.203919411964, 5313.388960269618, 5314.415414304501, 5335.253064571041, 5366.785328586969], "unit": "score", "name": "dojo.html", "value": 5084.735594303922}, {"lowerIsBetter": false, "replicates": [519.8310549071552, 531.3862488825406, 564.6301672404577, 587.6914619824593, 603.6770327874588, 35662.82168589157, 36160.276794464095, 36271.0, 36281.99999999996, 36516.26967460649, 37058.0, 37524.0, 37662.623373766255, 37766.62233377666, 37900.052498687546, 8293.419460637759, 8443.83112337753, 8489.44818586793, 8505.277051450634, 8518.318534517224, 8305.294050005727, 8417.158284171564, 8451.366147538929, 8608.741737747878, 8616.526091064989, 8526.0, 8610.268127209163, 8619.741407757778, 8625.827483450326, 8634.740957771277, 8564.443311184754, 8586.742397728078, 8596.914030859736, 8617.310615150804, 8628.956855215747, 8544.487330760174, 8641.049484556694, 8647.827043459158, 8665.436746611513, 8687.47875127488, 34914.603415863334, 35208.823955880056, 35224.29551408957, 35299.11752206215, 35348.29303413918, 2650.6024096385504, 3052.2064263291704, 3249.5938007749032, 3343.164208947763, 3733.775973441602, 26743.598846017325, 26751.331216719544, 26961.595576066375, 27000.729992700017, 27280.181594552196, 3292.407366673998, 3308.8841890533718, 3358.9160270993175, 3407.4510528444557, 3493.2489514754197, 186610.0, 186733.0, 187553.0, 187728.0, 188019.99999999863, 40432.39351409731, 55086.86848486379, 55279.44720552823, 55299.72350138304, 55411.44588554063, 38988.80505597511, 39213.0, 39226.803865981055, 39252.21495570073, 39341.606583934365, 14007.649808754863, 14253.928730356281, 14257.429702811978, 14302.356393962296, 14329.140251584939, 11270.492827822603, 11327.093832493381, 11332.490037948312, 11348.262362946381, 11349.148813838996, 14045.578632640832, 14095.78856317156, 14139.717205656036, 14149.646258843612, 14176.291185440892, 5862.413758624189, 5956.64260144384, 6035.185249991283, 6063.181470501514, 6070.787522436782, 915.697819719491, 941.0379359036349, 951.7573018880141, 993.3543196921914, 1064.9307794993301, 30657.08028759141, 31275.530867037014, 31773.52339714906, 32088.358232835213, 32172.517412238834, 972.4505654305295, 1045.8849526552074, 1078.719532921446, 1103.9668809935715, 1135.4833550734395, 14266.714665706628, 14476.34856431463, 14487.275636218146, 14697.338619762137, 14711.632209194855, 379379.0, 386226.0, 389290.0, 390158.0, 390266.0, 52817.2077418839, 53916.460835391146, 53957.730211348695, 54072.72963635156, 54500.72749636226, 1171.6075114836626, 1179.6343133628432, 1201.141184053406, 1215.8601760797444, 1437.9431118128168, 28503.42993140167, 29083.691233894104, 29086.127416177547, 29736.553951690308, 29743.553846691884, 45112.77443612761, 45237.54762452334, 45584.54415455936, 45616.0, 45755.77122114368, 286071.0, 287286.0, 287663.0, 288859.0, 290037.0, 31764.523532147497, 31799.205019874687, 32367.0, 32825.67174328226, 33078.338433231685, 42486.82072218464, 42525.78737106295, 42973.140537189705, 43081.138377232906, 43201.3519797197, 34835.65164348324, 36492.0, 36539.26921461609, 36594.8170259147, 37182.44226336661, 36561.63438365582, 36602.45096323611, 37021.0, 37415.81292093522, 37542.624573753914, 35125.29749404947, 35444.82277588699, 36043.459348109274, 36266.0, 36435.27129457343, 27611.861940690167, 29319.973800916865, 29507.0, 29599.704002960556, 29752.55371169391, 23274.65088023647, 23509.0, 23630.52738945177, 24257.39356516101, 24295.878520607283], "unit": "score", "name": "ext.html", "value": 17352.198230911872}, {"lowerIsBetter": false, "replicates": [329.17213208779907, 330.6032760687176, 336.998315008425, 338.237274944999, 338.36049865753716, 16440.588985275375, 16975.745363819537, 17059.31762729491, 18083.54791130219, 18131.72802407965, 9168.449893006424, 9441.527923603826, 9499.0, 14795.26023698816, 15022.173780442072, 4587.931181032279, 4707.364505791726, 4764.452088009872, 4767.76161191939, 4783.210770222909, 3676.2647470506004, 4674.555917187861, 5012.097822391968, 5185.55922746567, 5197.376314842205, 5159.226116082599, 5161.66449180802, 5162.174052151657, 5167.689938603677, 5169.379674439054, 5029.170186919172, 5055.494450554952, 5074.756684612294, 5115.437301896788, 5149.9485005149845, 4908.779104940286, 4909.754512274408, 4930.33440485537, 4932.358793356877, 4947.653664243504, 11416.059269924133, 11681.649550513499, 11821.586244481488, 11834.822477662841, 11865.88134118665, 2006.7491563554556, 2082.0526660369646, 2143.389134096775, 2149.140343862452, 2198.670199470076, 8449.0, 8618.310535157236, 8737.169968852948, 8788.0, 8809.251213646849, 1816.6911625023777, 1843.4101087651957, 1856.4523465577688, 1865.6175484025741, 1866.188208129468, 65279.34720652828, 67490.66254668696, 67689.32310676879, 68325.31674683289, 69096.65451672759, 8917.063708310663, 9115.453072815651, 9146.771330716785, 9825.901740982641, 9870.851937220947, 12659.303738294298, 12734.490620375267, 12761.042921780903, 12769.489220431078, 12772.361381930867, 6645.933540664531, 6736.157980252468, 6827.2831352708245, 6899.930510770839, 6902.8619427612175, 6698.83252918681, 6798.558093723892, 6823.658817059128, 6967.0, 6968.581885086911, 4118.320477121241, 4145.481814773153, 4153.356229784388, 4167.1040726244, 4228.344606585984, 1646.843549862785, 1671.7492376143432, 1699.4137022727139, 1731.454591803603, 1738.7049095194222, 373.45475605616105, 900.293269783217, 928.9535523223811, 944.9622015119318, 1041.8853926068127, 9495.857562136573, 9671.419714817133, 9724.27067969891, 10275.588976440858, 10313.0, 400.49137595253865, 402.47477042459286, 409.35935261315944, 413.9565345638725, 424.7027081043282, 5478.534324582375, 5510.862228444321, 5524.558035357162, 5529.834104976857, 5531.0, 418941.0, 422417.0, 426972.0, 451780.0, 460556.0, 75548.0, 75559.24440755633, 75933.0, 78502.0, 80458.19541804507, 414.86724248240876, 420.1743573877346, 423.9025024244441, 424.02474309088973, 424.8194517330122, 9254.35219534626, 9299.349045566745, 9434.811303774024, 9461.38500997433, 9555.331126821056, 34040.14899627529, 34622.480662789574, 34639.0, 34705.479417808245, 34936.47595286022, 46478.0, 50274.74862625664, 50504.49495504998, 50670.493295066575, 50784.49215507945, 7477.663505142173, 7490.475666703496, 7556.055493063367, 7634.503757255983, 7641.083070031409, 8779.20987111163, 11161.162912781412, 12248.510059597516, 12612.36938153107, 12970.35148242603, 10026.849597256192, 10380.169586433218, 10398.68803935883, 10531.78936421252, 10766.138708903425, 10837.0, 10897.346159230472, 10975.945120274348, 11023.669289921316, 11166.832497512381, 10839.0, 10846.67459976202, 10956.0, 10972.615958441416, 11126.388048657078, 7485.925140748523, 7535.924640753522, 7598.392128629807, 7625.123110842324, 7755.72854950074, 7467.439942004263, 9215.44707317563, 10818.24272300963, 10927.781444370909, 11141.442927853737], "unit": "score", "name": "jquery.html", "value": 7202.310341867294}, {"lowerIsBetter": false, "replicates": [1445.472402573061, 1475.8450362711912, 1617.7007253658073, 1744.4504980931013, 1760.234298080336, 6552.541322107454, 7076.964615176929, 7378.815529611762, 7534.472586918911, 7616.08606967164, 7010.964945175279, 7017.052697885784, 7072.434205263579, 7099.929000709992, 7128.572285662864, 2205.9448513787165, 2232.687423760675, 2236.630955892276, 2240.0591751464426, 2242.7308722953267, 2186.529896072344, 2186.835987300951, 2233.530958498717, 2237.038073628339, 2243.1363924888956, 2199.296225207934, 2199.3292045925987, 2229.2977712020743, 2244.0, 2255.6842042114117, 2174.3042226487532, 2176.619091658961, 2186.8031877131057, 2190.211523851412, 2199.49411635324, 2185.355320180535, 2188.518525924294, 2189.2665956904457, 2190.89045547722, 2194.3526659635445, 7252.347288743986, 7283.526570772936, 7299.89050164248, 7322.560646361236, 7332.816679582999, 4273.658107351404, 4385.144896745136, 4402.713823601455, 4408.096340250241, 4411.029573493826, 2834.7307005834414, 2916.6500019997525, 2989.1929179121735, 2996.640403151614, 3017.803842750236, 933.2347475070445, 956.2827879090682, 977.1401166973089, 982.0523195116747, 988.2489308125804, 9757.0, 9792.853107203398, 9794.608215671364, 9810.656627018092, 9825.3613515122, 3777.0746167189213, 3785.2240290740333, 3812.2947254757405, 3857.035741064734, 3866.709996750255, 8484.236418722345, 8496.362772792065, 8504.107068757816, 8513.702020429379, 8542.103079176597, 4230.788460576959, 4249.3625956106835, 4252.425922500484, 4254.404383386328, 4283.186194623012, 3587.3184095022384, 3855.094052897567, 3910.550286717007, 3986.86045988389, 4036.455078564415, 3541.8760343387858, 3551.786892786441, 3597.8201089945396, 3622.836972336251, 3627.2564124354444, 996.2428554298785, 1020.6631811502186, 1023.5240613114788, 1028.3624153025173, 1100.8018556659717, 1306.4708792938875, 1308.587794844621, 1321.9933900330436, 1323.4639970811836, 1325.8011298305332, 6839.418649414855, 6841.897371539431, 6936.79189624312, 6949.722011119599, 6950.339717726808, 436.5874248834884, 440.7774074092627, 442.6834813108643, 445.2608669608499, 454.8385323210279, 5279.340082489689, 5347.0, 5360.222767698662, 5365.463453654604, 5403.4326395727885, 8383.664653413916, 8578.914210857936, 8723.60743766532, 8805.811215485828, 8870.512121833232, 8552.444091134057, 8613.310935125175, 8700.12998700125, 8705.563582009025, 8751.0, 6879.105716256955, 6904.206016308089, 6956.234814170437, 6960.338767817049, 7015.754448594173, 6984.930150698428, 7038.718451261892, 7097.858042839218, 7098.574085554883, 7131.8573628528175, 7566.583837888748, 7905.920940790518, 7923.0, 7945.0863150738405, 8108.878366824384, 7683.692652293846, 7853.293203611703, 7909.9209007909185, 7945.284924356835, 7959.4030447715495, 6661.666916654051, 6804.897926531205, 6829.112215411965, 7100.0, 7189.1013623297085, 6771.052052712525, 6847.554908930903, 6863.07348507965, 6897.48268879826, 6918.238993710788, 6371.13989611415, 6434.938235191141, 6512.869742605216, 6518.57629254097, 6533.640649764308, 6291.559590828598, 6364.904526432199, 6453.225612926479, 6575.112359831553, 6591.274959754327, 6578.539502234989, 6603.0, 6612.0, 6734.629595372302, 6776.119104516381, 6009.429104235091, 6155.538334624832, 6160.507159427325, 6270.372962703693, 6296.181496405438, 6314.4632706218645, 6317.6209427434505, 6335.461485773761, 6353.96823015882, 6366.649834258975], "unit": "score", "name": "mootools.html", "value": 4162.237029878572}, {"lowerIsBetter": false, "replicates": [289.5049465414142, 292.4574913535392, 294.0912580127406, 295.24859233251385, 296.89311847734814, 6171.876562468748, 6211.627302361861, 6237.563370564062, 6329.7151628176725, 6366.840828979278, 6145.324014358417, 6233.688315584225, 6251.4998800096, 6270.717817698203, 6270.968645156768, 4440.289553671413, 4529.003619203786, 4547.113312903985, 4618.099470603233, 4624.3294722265255, 4587.036722288307, 4593.563611456923, 4598.448186217642, 4602.240630295997, 4607.216773148572, 4507.414036175309, 4515.029268707227, 4519.0961807638605, 4525.841595544157, 4533.252013417782, 4512.954870451286, 4517.164324599943, 4517.390152329443, 4532.116237333721, 4540.909181816345, 3858.247641709868, 3861.3049651062797, 3873.32216862048, 3874.7093967952515, 3881.6700580450697, 5852.912206316909, 5879.118132280149, 5904.911426328608, 5908.940910590925, 5925.34821169671, 5116.641835071547, 5251.789928402859, 5266.7629956652045, 5276.762545685453, 5278.9208161877605, 6503.707333169971, 6517.446017088553, 6526.836829079263, 6536.477081833442, 6554.115194448784, 4252.319628859399, 4264.360345948102, 4264.552222016675, 4267.679924005712, 4276.166147601219, 6801.829954251134, 6947.3747362737595, 6955.860882782366, 6974.0236366908675, 6979.0, 4317.978410107929, 4328.0, 4334.414853994734, 4337.132573485315, 4337.980574564975, 4212.557681443465, 4323.416338794285, 4389.758563279051, 4395.747212044552, 4409.536998615164, 5152.072626927189, 5153.330067091254, 5174.09453345663, 5185.844424667266, 5201.245819356172, 6613.669316534154, 6614.239362473377, 6619.470442364599, 6627.933720662828, 6629.071929929813, 1513.3190064471032, 1545.0266332210635, 1547.1645311531872, 1549.5971047527498, 1552.2394026926725, 974.751438383222, 989.1740396768779, 994.8855881573567, 1002.0630710285906, 1004.9799004019878, 6341.397567231105, 6355.142055822497, 6364.459020983176, 6367.968160159169, 6375.553711240262, 6773.051772751819, 6782.491313151533, 6799.898001529981, 6800.591964482147, 6812.386885180357, 6122.632642041492, 6234.127222188898, 6329.272133704683, 6331.841703957438, 6332.4934005279465, 3677.3196958562753, 3693.0582701410967, 3707.1844194277214, 3709.8330575124182, 3713.795741234258, 7281.817954551073, 7287.0, 7304.780856574312, 7314.08573928259, 7315.707371705179, 7019.666263409936, 7027.472939529555, 7032.578045317195, 7037.894431583531, 7043.471739619549, 6919.619420931796, 7064.92935070653, 7099.07711997437, 7131.322524360177, 7269.345758881726, 6843.657817109224, 6847.144106986627, 6857.074294970115, 6862.519623626298, 6869.450443964371, 6769.1876974763345, 6792.72829086831, 6792.830179245559, 6799.864002720017, 6800.795976120724, 7266.200717920919, 7273.3817625502425, 7277.345038946521, 7280.381167600814, 7312.634368281671, 4275.273203555341, 4369.71596846204, 4375.343698445131, 4380.518143004203, 4386.692931494765, 6792.388685018372, 6870.862582748217, 6881.174259088942, 6881.346272104142, 6884.0, 6572.375624315682, 6586.868262634816, 6603.372679595431, 6614.10709554204, 6634.469242460688, 6588.670566471753, 6604.768833090819, 6613.834654133685, 6622.304658010839, 6665.900011499734, 6313.05304204373, 6448.226212854487, 6509.544331896722, 6517.641529715911, 6525.967370163309, 6653.534252602465, 6668.733250669919, 6670.866582668416, 6675.499337549606, 6678.3989440950545, 6450.451711604566, 6480.870382592416, 6498.090267362479, 6500.089987401673, 6505.739770409131], "unit": "score", "name": "prototype.html", "value": 4855.733954916445}, {"lowerIsBetter": false, "replicates": [677.4309579952842, 698.7449580902966, 706.5336877660743, 743.9918909877116, 792.1959211400429, 13416.396262168202, 13439.059265851394, 13604.931975340109, 13628.454861805529, 13638.045336826426, 12732.745345093115, 12800.80798788019, 12816.487340506392, 13578.592642220725, 13798.448062077505, 670.0318040431579, 796.7012370361115, 797.8364435290752, 813.9064007639138, 815.514768712615, 808.0989696488432, 810.5420437452821, 812.6668066092903, 812.9471584347028, 813.2883726739103, 847.8643417053273, 849.235687880906, 849.4351256414477, 851.8296340731847, 853.4068822168596, 833.6165363932598, 844.4215712237137, 844.9788755281106, 846.8899043124385, 852.0882655558555, 624.7625902157197, 627.645380360095, 627.7991042866284, 629.8992161254178, 632.9208848893888, 14163.79607733344, 14213.360398782079, 14300.427982880672, 14302.427902883872, 14360.138391696428, 12267.141300108997, 12286.324252166127, 12568.560100396442, 12653.620391388273, 12727.427265773062, 10473.581056757721, 10482.528286227138, 10559.630412935587, 10631.627893023708, 10692.732681682943, 3527.7001454876367, 3556.448750443685, 3559.66183212597, 3687.9858039039477, 3703.4815125882396, 50637.240441393405, 50939.490605093844, 51468.22797658038, 51601.741991289804, 51925.99999999962, 9713.514324283757, 10064.496775161213, 10130.594776208869, 10174.643887463903, 10176.694699159038, 17505.299788008593, 17544.736828947574, 17552.38566650161, 17557.91221043912, 17590.824091759176, 7421.517601355895, 7459.738909138154, 7540.660670269851, 7560.659770310349, 7570.583617900958, 4092.570280120604, 4118.444010058603, 4293.656507479394, 4340.327249276367, 4343.261645520269, 3052.481078216664, 3064.5096784514817, 3077.07687693691, 3082.9383412331626, 3089.304906396088, 544.6568661743156, 544.964577302474, 547.7261369315343, 554.5757495515934, 555.1173633922002, 607.7116512992484, 623.0778447897137, 635.4535099814157, 650.3561474140566, 653.6502970910635, 7554.8866766998535, 7927.3658107351275, 8023.9598802006785, 8130.105688374274, 8528.445651032664, 540.4244479629261, 562.4937556199371, 567.3418834152446, 573.3292048303495, 578.5892016668129, 3657.7073834093208, 3777.622237776255, 3882.165334453106, 3945.2109578084496, 3976.3240249157134, 54151.0, 54248.45751542434, 54899.72550137224, 55332.72333638306, 56356.0, 44296.77851610721, 44397.33403998943, 45020.77489612531, 45310.0, 45396.0, 42513.57486425158, 42796.35805462921, 43115.0, 43804.0, 44137.779311103885, 7896.565688887166, 7985.680572777024, 8081.434299598972, 8178.713745018896, 8435.409521333448, 32370.35259294848, 32800.50799238061, 32976.835115824266, 33212.1696957578, 33666.49500257449, 38893.0, 38974.0, 41942.0, 42009.78995105005, 42443.15113697771, 10173.898261017592, 10775.892241077489, 10866.836997444887, 10915.945420273165, 11174.608888688857, 12028.699282518008, 12171.817422738843, 12331.136820422484, 12368.319742413894, 12924.030697697899, 10845.0, 11322.207445479067, 11389.772204556028, 11946.76106477883, 11952.34262115592, 11111.222214444912, 11283.605073822377, 11319.377434241196, 11688.532458701557, 11812.232204906653, 9785.755356116155, 10523.526441310007, 10531.210159237935, 10602.840957385491, 11272.83090753623, 8588.0, 8717.651293948426, 8747.927443135068, 8816.779580510538, 9128.224100951493, 8395.664173432995, 8850.690225842065, 9044.547772611475, 9180.6786762463, 9326.766830829283], "unit": "score", "name": "yui.html", "value": 6136.19497871778}], "name": "dromaeo_css", "value": 6547.901635701343}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 107.0, 111.0, 111.0, 112.0, 122.0, 111.0, 111.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.1}, {"lowerIsBetter": true, "replicates": [157.0, 126.0, 151.0, 186.0, 133.0, 155.0, 154.0, 129.0, 172.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 149.2}, {"lowerIsBetter": true, "replicates": [162.0, 165.0, 161.0, 161.0, 161.0, 160.0, 160.0, 169.0, 169.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.9}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 73.0, 74.0, 74.0, 164.0, 73.0, 72.0, 74.0, 74.0], "unit": "score", "name": "audio-fft", "value": 82.4}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 147.0, 96.0, 96.0, 95.0, 151.0, 94.0, 96.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 111.1}, {"lowerIsBetter": true, "replicates": [120.0, 117.0, 117.0, 115.0, 116.0, 115.0, 115.0, 114.0, 116.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.0}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 148.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 97.0, 97.0, 99.0, 96.0, 96.0, 98.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.1}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 57.0, 60.0, 56.0, 57.0, 56.0, 63.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 69.0, 69.0, 69.0, 68.0, 69.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [83.0, 91.0, 86.0, 91.0, 83.0, 83.0, 84.0, 87.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [121.0, 119.0, 119.0, 120.0, 119.0, 121.0, 118.0, 119.0, 117.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.1}, {"lowerIsBetter": true, "replicates": [147.0, 154.0, 155.0, 154.0, 157.0, 147.0, 158.0, 152.0, 144.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.1}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 70.0, 70.0, 70.0, 67.0, 70.0, 71.0, 71.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.1}], "name": "kraken", "value": 1529.1999999999996}]} 17:44:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1529.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6547.90"}}} 17:44:39 INFO - Return code: 0 17:44:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:44:39 ERROR - # TBPL SUCCESS # 17:44:39 INFO - Running post-action listener: _resource_record_post_action 17:44:39 INFO - Running post-run listener: _resource_record_post_run 17:44:40 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 528384; Write bytes: 298278912; Read time: 284; Write time: 182240 17:44:40 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1236992; Read time: 0; Write time: 48 17:44:40 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 528384; Write bytes: 297041920; Read time: 284; Write time: 182192 17:44:40 INFO - Running post-run listener: _upload_blobber_files 17:44:40 INFO - Blob upload gear active. 17:44:40 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:44:40 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 17:44:40 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'] 17:44:40 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 17:44:40 INFO - (blobuploader) - INFO - Open directory for files ... 17:44:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:44:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:44:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:44:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:44:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:44:41 INFO - (blobuploader) - INFO - Done attempting. 17:44:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:44:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:44:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:44:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:44:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:44:42 INFO - (blobuploader) - INFO - Done attempting. 17:44:42 INFO - (blobuploader) - INFO - Iteration through files over. 17:44:42 INFO - Return code: 0 17:44:42 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:44:42 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:44:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/afc468e70def6859b9b8874de9ed470ef85d5fe85b0a04af46ff96e3bfc2bfde2955f1caa4c4acc146bcc8411cdaf36074d411da7b86f440009542f10c3e9a38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c207080acac597084578f813aaf02725b3cb67fa5d701710aec9df76441f0247699727991e665af8311a18bf177563b05ff11cfa4ae28305084ee1f7a204ebec"} 17:44:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:44:42 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:44:42 INFO - Contents: 17:44:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/afc468e70def6859b9b8874de9ed470ef85d5fe85b0a04af46ff96e3bfc2bfde2955f1caa4c4acc146bcc8411cdaf36074d411da7b86f440009542f10c3e9a38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c207080acac597084578f813aaf02725b3cb67fa5d701710aec9df76441f0247699727991e665af8311a18bf177563b05ff11cfa4ae28305084ee1f7a204ebec"} 17:44:42 INFO - Running post-run listener: copy_logs_to_upload_dir 17:44:42 INFO - Copying logs to upload dir... 17:44:42 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:44:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.766381 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-02-29 17:44:42.744789) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 17:44:42.748343) ========= 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=20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/afc468e70def6859b9b8874de9ed470ef85d5fe85b0a04af46ff96e3bfc2bfde2955f1caa4c4acc146bcc8411cdaf36074d411da7b86f440009542f10c3e9a38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c207080acac597084578f813aaf02725b3cb67fa5d701710aec9df76441f0247699727991e665af8311a18bf177563b05ff11cfa4ae28305084ee1f7a204ebec"} build_url:https://queue.taskcluster.net/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011421 build_url: 'https://queue.taskcluster.net/v1/task/NYoEPmmnT4SNRy8zWLo-Qw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/afc468e70def6859b9b8874de9ed470ef85d5fe85b0a04af46ff96e3bfc2bfde2955f1caa4c4acc146bcc8411cdaf36074d411da7b86f440009542f10c3e9a38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c207080acac597084578f813aaf02725b3cb67fa5d701710aec9df76441f0247699727991e665af8311a18bf177563b05ff11cfa4ae28305084ee1f7a204ebec"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 17:44:42.772431) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:44:42.772712) ========= 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=20e666a3d4cfbb71505a330e000001b4-1456795451.192591-705221253 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004594 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:44:42.858812) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 17:44:42.859132) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 17:44:42.859403) ========= ========= Total master_lag: 0.22 =========