builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-006 starttime: 1453749359.21 results: success (0) buildid: 20160125083105 builduid: 57094b2972ec4c06830921e9b0f90068 revision: 166f314b7d4dc21be028a8307d2e34887b9e95da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 11:15:59.210743) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 11:15:59.211210) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 11:15:59.211513) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004898 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 11:15:59.232678) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 11:15:59.232949) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 11:15:59.246148) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:15:59.246420) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:15:59.294759) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 11:15:59.295022) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 11:15:59.295382) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:15:59.295655) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 11:15:59-- 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% 34.3M=0s 2016-01-25 11:15:59 (34.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166285 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:15:59.474142) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:15:59.474548) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021325 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:15:59.524370) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:15:59.524717) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 166f314b7d4dc21be028a8307d2e34887b9e95da --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 166f314b7d4dc21be028a8307d2e34887b9e95da --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=e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 11:15:59,934 truncating revision to first 12 chars 2016-01-25 11:15:59,934 Setting DEBUG logging. 2016-01-25 11:15:59,934 attempt 1/10 2016-01-25 11:15:59,934 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/166f314b7d4d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 11:16:00,200 unpacking tar archive at: fx-team-166f314b7d4d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.554549 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:16:00.092327) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 11:16:00.092680) ========= echo 166f314b7d4dc21be028a8307d2e34887b9e95da in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'166f314b7d4dc21be028a8307d2e34887b9e95da'] 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=e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 166f314b7d4dc21be028a8307d2e34887b9e95da program finished with exit code 0 elapsedTime=0.004652 script_repo_revision: '166f314b7d4dc21be028a8307d2e34887b9e95da' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 11:16:00.141818) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 11:16:00.142107) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 11:16:00.152715) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-01-25 11:16:00.152995) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:16:00 INFO - MultiFileLogger online at 20160125 11:16:00 in /builds/slave/test-pgo 11:16:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:16:00 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:16:00 INFO - {'append_to_log': False, 11:16:00 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:16:00 INFO - 'blob_upload_branch': 'Fx-Team', 11:16:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:16:00 INFO - 'branch': 'Fx-Team', 11:16:00 INFO - 'buildbot_json_path': 'buildprops.json', 11:16:00 INFO - 'config_files': ('talos/linux_config.py',), 11:16:00 INFO - 'default_actions': ('clobber', 11:16:00 INFO - 'read-buildbot-config', 11:16:00 INFO - 'download-and-extract', 11:16:00 INFO - 'populate-webroot', 11:16:00 INFO - 'create-virtualenv', 11:16:00 INFO - 'install', 11:16:00 INFO - 'run-tests'), 11:16:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:16:00 INFO - 'download_minidump_stackwalk': True, 11:16:00 INFO - 'download_symbols': 'ondemand', 11:16:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:16:00 INFO - 'tooltool.py': '/tools/tooltool.py', 11:16:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:16:00 INFO - '/tools/misc-python/virtualenv.py')}, 11:16:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:16:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:16:00 INFO - 'installer_path': 'installer.exe', 11:16:00 INFO - 'log_level': 'info', 11:16:00 INFO - 'log_name': 'talos', 11:16:00 INFO - 'log_to_console': True, 11:16:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:16:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:16:00 INFO - 'opt_config_files': (), 11:16:00 INFO - 'pip_index': False, 11:16:00 INFO - 'sps_profile': False, 11:16:00 INFO - 'sps_profile_interval': 0, 11:16:00 INFO - 'suite': 'dromaeojs', 11:16:00 INFO - 'system_bits': '32', 11:16:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:16:00 INFO - 'title': 'talos-linux64-ix-006', 11:16:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:16:00 INFO - 'use_talos_json': True, 11:16:00 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:16:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:16:00 INFO - 'work_dir': 'build'} 11:16:00 INFO - ##### 11:16:00 INFO - ##### Running clobber step. 11:16:00 INFO - ##### 11:16:00 INFO - Running pre-action listener: _resource_record_pre_action 11:16:00 INFO - Running main action method: clobber 11:16:00 INFO - rmtree: /builds/slave/test-pgo/build 11:16:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:16:01 INFO - Running post-action listener: _resource_record_post_action 11:16:01 INFO - ##### 11:16:01 INFO - ##### Running read-buildbot-config step. 11:16:01 INFO - ##### 11:16:01 INFO - Running pre-action listener: _resource_record_pre_action 11:16:01 INFO - Running main action method: read_buildbot_config 11:16:01 INFO - Using buildbot properties: 11:16:01 INFO - { 11:16:01 INFO - "project": "", 11:16:01 INFO - "product": "firefox", 11:16:01 INFO - "script_repo_revision": "production", 11:16:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:16:01 INFO - "repository": "", 11:16:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:16:01 INFO - "buildid": "20160125083105", 11:16:01 INFO - "pgo_build": "True", 11:16:01 INFO - "basedir": "/builds/slave/test-pgo", 11:16:01 INFO - "buildnumber": 599, 11:16:01 INFO - "slavename": "talos-linux64-ix-006", 11:16:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:16:01 INFO - "platform": "ubuntu64_hw", 11:16:01 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:16:01 INFO - "branch": "fx-team", 11:16:01 INFO - "repo_path": "integration/fx-team", 11:16:01 INFO - "revision": "166f314b7d4dc21be028a8307d2e34887b9e95da", 11:16:01 INFO - "stage_platform": "linux64-pgo", 11:16:01 INFO - "builduid": "57094b2972ec4c06830921e9b0f90068", 11:16:01 INFO - "slavebuilddir": "test" 11:16:01 INFO - } 11:16:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 11:16:01 INFO - Running post-action listener: _resource_record_post_action 11:16:01 INFO - ##### 11:16:01 INFO - ##### Running download-and-extract step. 11:16:01 INFO - ##### 11:16:01 INFO - Running pre-action listener: _resource_record_pre_action 11:16:01 INFO - Running main action method: download_and_extract 11:16:01 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:01 INFO - https://queue.taskcluster.net/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:16:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/test_packages.json 11:16:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/test_packages.json 11:16:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:16:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:16:01 INFO - Downloaded 1448 bytes. 11:16:01 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:16:01 INFO - Using the following test package requirements: 11:16:01 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:16:01 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:01 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:16:01 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:01 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:16:01 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:01 INFO - u'jsshell-linux-x86_64.zip'], 11:16:01 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:01 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:16:01 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:16:01 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:01 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:16:01 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:01 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:16:01 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:01 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:16:01 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:16:01 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:01 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:16:01 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:01 INFO - https://queue.taskcluster.net/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:16:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:16:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:16:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:16:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:16:03 INFO - Downloaded 22494344 bytes. 11:16:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:16:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 11:16:04 INFO - Return code: 0 11:16:04 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:04 INFO - https://queue.taskcluster.net/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:16:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:16:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:16:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:16:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:16:06 INFO - Downloaded 22494344 bytes. 11:16:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:16:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 11:16:07 INFO - Return code: 0 11:16: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')]} 11:16:07 INFO - https://queue.taskcluster.net/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:16:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:16:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:16:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:16:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:16:08 INFO - Downloaded 10706572 bytes. 11:16:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:16:08 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 11:16:08 INFO - Return code: 0 11:16:08 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')]} 11:16:08 INFO - https://queue.taskcluster.net/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:16:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:16:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:16:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:16:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:16:09 INFO - Downloaded 55975185 bytes. 11:16:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:16:09 INFO - mkdir: /builds/slave/test-pgo/properties 11:16:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:16:09 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:16:09 INFO - Contents: 11:16:09 INFO - build_url:https://queue.taskcluster.net/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:16:09 INFO - Running post-action listener: _resource_record_post_action 11:16:09 INFO - Running post-action listener: set_extra_try_arguments 11:16:09 INFO - ##### 11:16:09 INFO - ##### Running populate-webroot step. 11:16:09 INFO - ##### 11:16:09 INFO - Running pre-action listener: _resource_record_pre_action 11:16:09 INFO - Running main action method: populate_webroot 11:16:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:16:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:16:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:16:09 INFO - '--tppagecycles', 11:16:09 INFO - '7'], 11:16:09 INFO - 'tests': ['tsvgm']}}, 11:16:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:16:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:16:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:16:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:16:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:16:09 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:16:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:16:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:09 INFO - 'talos_options': ['--e10s'], 11:16:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:16:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:09 INFO - 'tests': ['damp', 'tps']}, 11:16:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:09 INFO - 'talos_options': ['--e10s'], 11:16:09 INFO - 'tests': ['damp', 'tps']}, 11:16:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:16:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:16:09 INFO - 'other': {'tests': ['a11yr', 11:16:09 INFO - 'ts_paint', 11:16:09 INFO - 'tpaint', 11:16:09 INFO - 'sessionrestore', 11:16:09 INFO - 'sessionrestore_no_auto_restore']}, 11:16:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:16:09 INFO - 'tests': ['a11yr', 11:16:09 INFO - 'ts_paint', 11:16:09 INFO - 'tpaint', 11:16:09 INFO - 'sessionrestore', 11:16:09 INFO - 'sessionrestore_no_auto_restore']}, 11:16:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:16:09 INFO - 'tests': ['a11yr', 11:16:09 INFO - 'ts_paint', 11:16:09 INFO - 'tpaint', 11:16:09 INFO - 'sessionrestore', 11:16:09 INFO - 'sessionrestore_no_auto_restore']}, 11:16:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:16:09 INFO - 'tests': ['a11yr', 11:16:09 INFO - 'ts_paint', 11:16:09 INFO - 'tpaint', 11:16:09 INFO - 'sessionrestore', 11:16:09 INFO - 'sessionrestore_no_auto_restore']}, 11:16:09 INFO - 'other_l64': {'tests': ['a11yr', 11:16:09 INFO - 'ts_paint', 11:16:09 INFO - 'tpaint', 11:16:09 INFO - 'sessionrestore', 11:16:09 INFO - 'sessionrestore_no_auto_restore']}, 11:16:09 INFO - 'other_nol64': {'tests': ['a11yr', 11:16:09 INFO - 'ts_paint', 11:16:09 INFO - 'tpaint', 11:16:09 INFO - 'sessionrestore', 11:16:09 INFO - 'sessionrestore_no_auto_restore']}, 11:16:09 INFO - 'svgr': {'tests': ['tsvgx', 11:16:09 INFO - 'tsvgr_opacity', 11:16:09 INFO - 'tart', 11:16:09 INFO - 'tscrollx', 11:16:09 INFO - 'cart']}, 11:16:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:16:09 INFO - 'tests': ['tsvgx', 11:16:09 INFO - 'tsvgr_opacity', 11:16:09 INFO - 'tart', 11:16:09 INFO - 'tscrollx', 11:16:09 INFO - 'cart']}, 11:16:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:09 INFO - 'tests': ['tp5o']}, 11:16:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:09 INFO - 'talos_options': ['--e10s'], 11:16:09 INFO - 'tests': ['tp5o']}, 11:16:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:09 INFO - 'talos_options': ['--xperf_path', 11:16:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:16:09 INFO - 'tests': ['tp5n']}, 11:16:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:09 INFO - 'talos_options': ['--e10s', 11:16:09 INFO - '--xperf_path', 11:16:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:16:09 INFO - 'tests': ['tp5n']}}, 11:16:09 INFO - 'talos.zip': {'path': '', 11:16:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:16:09 INFO - Running post-action listener: _resource_record_post_action 11:16:09 INFO - ##### 11:16:09 INFO - ##### Running create-virtualenv step. 11:16:09 INFO - ##### 11:16:09 INFO - Running pre-action listener: _resource_record_pre_action 11:16:09 INFO - Running main action method: create_virtualenv 11:16:09 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:16:09 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 11:16:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:16:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:16:10 INFO - Using real prefix '/usr' 11:16:10 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:16:10 INFO - Installing distribute.............................................................................................................................................................................................done. 11:16:12 INFO - Installing pip.................done. 11:16:12 INFO - Return code: 0 11:16:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:12 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 0x7fdb61d8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb840>, '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 0x18586b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858b60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153', '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 11:16:12 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 11:16:12 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 11:16:12 INFO - Using env: {'DISPLAY': ':0', 11:16:12 INFO - 'HOME': '/home/cltbld', 11:16:12 INFO - 'LANG': 'en_US.UTF-8', 11:16:12 INFO - 'LANGUAGE': 'en_US:en', 11:16:12 INFO - 'LOGNAME': 'cltbld', 11:16:12 INFO - 'MAIL': '/var/mail/cltbld', 11:16:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:12 INFO - 'MOZ_NO_REMOTE': '1', 11:16:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:12 INFO - 'NO_EM_RESTART': '1', 11:16:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:16:12 INFO - 'PWD': '/builds/slave/test-pgo', 11:16:12 INFO - 'SHELL': '/bin/bash', 11:16:12 INFO - 'SHLVL': '1', 11:16:12 INFO - 'TERM': 'linux', 11:16:12 INFO - 'TMOUT': '86400', 11:16:12 INFO - 'USER': 'cltbld', 11:16:12 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153', 11:16:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:12 INFO - '_': '/tools/buildbot/bin/python'} 11:16:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:12 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 11:16:12 INFO - Cleaning up... 11:16:12 INFO - Return code: 0 11:16:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:12 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 0x7fdb61d8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb840>, '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 0x18586b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858b60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153', '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 11:16:12 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 11:16:12 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 11:16:12 INFO - Using env: {'DISPLAY': ':0', 11:16:12 INFO - 'HOME': '/home/cltbld', 11:16:12 INFO - 'LANG': 'en_US.UTF-8', 11:16:12 INFO - 'LANGUAGE': 'en_US:en', 11:16:12 INFO - 'LOGNAME': 'cltbld', 11:16:12 INFO - 'MAIL': '/var/mail/cltbld', 11:16:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:12 INFO - 'MOZ_NO_REMOTE': '1', 11:16:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:12 INFO - 'NO_EM_RESTART': '1', 11:16:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:16:12 INFO - 'PWD': '/builds/slave/test-pgo', 11:16:12 INFO - 'SHELL': '/bin/bash', 11:16:12 INFO - 'SHLVL': '1', 11:16:12 INFO - 'TERM': 'linux', 11:16:12 INFO - 'TMOUT': '86400', 11:16:12 INFO - 'USER': 'cltbld', 11:16:12 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153', 11:16:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:12 INFO - '_': '/tools/buildbot/bin/python'} 11:16:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:12 INFO - Downloading/unpacking psutil>=0.7.1 11:16:12 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 11:16:12 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 11:16:12 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 11:16:12 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 11:16:12 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 11:16:12 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 11:16:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:16:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:16:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:16:14 INFO - Installing collected packages: psutil 11:16:14 INFO - Running setup.py install for psutil 11:16:14 INFO - building 'psutil._psutil_linux' extension 11:16:14 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 11:16:15 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 11:16:15 INFO - building 'psutil._psutil_posix' extension 11:16:15 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 11:16:15 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 11:16:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:16:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:16:15 INFO - Successfully installed psutil 11:16:15 INFO - Cleaning up... 11:16:15 INFO - Return code: 0 11:16:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:16:15 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')]} 11:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:15 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')]} 11:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:15 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 0x7fdb61d8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb840>, '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 0x18586b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858b60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153', '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 11:16:15 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 11:16:15 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 11:16:15 INFO - Using env: {'DISPLAY': ':0', 11:16:15 INFO - 'HOME': '/home/cltbld', 11:16:15 INFO - 'LANG': 'en_US.UTF-8', 11:16:15 INFO - 'LANGUAGE': 'en_US:en', 11:16:15 INFO - 'LOGNAME': 'cltbld', 11:16:15 INFO - 'MAIL': '/var/mail/cltbld', 11:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:15 INFO - 'MOZ_NO_REMOTE': '1', 11:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:15 INFO - 'NO_EM_RESTART': '1', 11:16:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:16:15 INFO - 'PWD': '/builds/slave/test-pgo', 11:16:15 INFO - 'SHELL': '/bin/bash', 11:16:15 INFO - 'SHLVL': '1', 11:16:15 INFO - 'TERM': 'linux', 11:16:15 INFO - 'TMOUT': '86400', 11:16:15 INFO - 'USER': 'cltbld', 11:16:15 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153', 11:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:15 INFO - '_': '/tools/buildbot/bin/python'} 11:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:16:15 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 11:16:15 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 11:16:15 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 11:16:15 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 11:16:15 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 11:16:15 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 11:16:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:16:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:16:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:16:17 INFO - Installing collected packages: mozsystemmonitor 11:16:17 INFO - Running setup.py install for mozsystemmonitor 11:16:17 INFO - Successfully installed mozsystemmonitor 11:16:17 INFO - Cleaning up... 11:16:17 INFO - Return code: 0 11:16:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:16: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')]} 11:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16: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')]} 11:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:17 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 0x7fdb61d8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb840>, '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 0x18586b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858b60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153', '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 11:16:17 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 11:16:17 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 11:16:17 INFO - Using env: {'DISPLAY': ':0', 11:16:17 INFO - 'HOME': '/home/cltbld', 11:16:17 INFO - 'LANG': 'en_US.UTF-8', 11:16:17 INFO - 'LANGUAGE': 'en_US:en', 11:16:17 INFO - 'LOGNAME': 'cltbld', 11:16:17 INFO - 'MAIL': '/var/mail/cltbld', 11:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:17 INFO - 'MOZ_NO_REMOTE': '1', 11:16:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:17 INFO - 'NO_EM_RESTART': '1', 11:16:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:16:17 INFO - 'PWD': '/builds/slave/test-pgo', 11:16:17 INFO - 'SHELL': '/bin/bash', 11:16:17 INFO - 'SHLVL': '1', 11:16:17 INFO - 'TERM': 'linux', 11:16:17 INFO - 'TMOUT': '86400', 11:16:17 INFO - 'USER': 'cltbld', 11:16:17 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153', 11:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:17 INFO - '_': '/tools/buildbot/bin/python'} 11:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:17 INFO - Downloading/unpacking blobuploader==1.2.4 11:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:19 INFO - Downloading blobuploader-1.2.4.tar.gz 11:16:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:16:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:16:19 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 11:16:19 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 11:16:19 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 11:16:19 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 11:16:19 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 11:16:19 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 11:16:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:16:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:20 INFO - Downloading docopt-0.6.1.tar.gz 11:16:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:16:20 INFO - Installing collected packages: blobuploader, requests, docopt 11:16:20 INFO - Running setup.py install for blobuploader 11:16:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:16:20 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:16:20 INFO - Running setup.py install for requests 11:16:20 INFO - Running setup.py install for docopt 11:16:20 INFO - Successfully installed blobuploader requests docopt 11:16:20 INFO - Cleaning up... 11:16:20 INFO - Return code: 0 11:16:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:16: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')]} 11:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16: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')]} 11:16:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:20 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 0x7fdb61d8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb840>, '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 0x18586b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858b60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153', '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 11:16:20 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 11:16:20 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 11:16:20 INFO - Using env: {'DISPLAY': ':0', 11:16:20 INFO - 'HOME': '/home/cltbld', 11:16:20 INFO - 'LANG': 'en_US.UTF-8', 11:16:20 INFO - 'LANGUAGE': 'en_US:en', 11:16:20 INFO - 'LOGNAME': 'cltbld', 11:16:20 INFO - 'MAIL': '/var/mail/cltbld', 11:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:20 INFO - 'MOZ_NO_REMOTE': '1', 11:16:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:20 INFO - 'NO_EM_RESTART': '1', 11:16:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:16:20 INFO - 'PWD': '/builds/slave/test-pgo', 11:16:20 INFO - 'SHELL': '/bin/bash', 11:16:20 INFO - 'SHLVL': '1', 11:16:20 INFO - 'TERM': 'linux', 11:16:20 INFO - 'TMOUT': '86400', 11:16:20 INFO - 'USER': 'cltbld', 11:16:20 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153', 11:16:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:20 INFO - '_': '/tools/buildbot/bin/python'} 11:16:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:16:21 INFO - Running setup.py (path:/tmp/pip-3YsUc1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:16:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:16:21 INFO - Running setup.py (path:/tmp/pip-q5F60Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:16:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:16:21 INFO - Running setup.py (path:/tmp/pip-jAD5v3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:16:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:16:21 INFO - Running setup.py (path:/tmp/pip-ueWnYm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:16:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:16:21 INFO - Running setup.py (path:/tmp/pip-8ThdEZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:16:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:16:21 INFO - Running setup.py (path:/tmp/pip-DlBuzx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:16:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:16:21 INFO - Running setup.py (path:/tmp/pip-m6U1aD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:16:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:16:21 INFO - Running setup.py (path:/tmp/pip-rqajYO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:16:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:16:21 INFO - Running setup.py (path:/tmp/pip-rTcvVx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:16:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:16:21 INFO - Running setup.py (path:/tmp/pip-FWunGE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:16:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:16:21 INFO - Running setup.py (path:/tmp/pip-5QVasP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:16:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:16:21 INFO - Running setup.py (path:/tmp/pip-nMDJ1e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:16:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:16:22 INFO - Running setup.py (path:/tmp/pip-g3nBXf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:16:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:16:22 INFO - Running setup.py (path:/tmp/pip-waoH9C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:16:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:16:22 INFO - Running setup.py (path:/tmp/pip-8W1Qw9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:16:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:16:22 INFO - Running setup.py (path:/tmp/pip-cjPQrV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:16:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:16:22 INFO - Running setup.py (path:/tmp/pip-pCCx9M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:16:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:16:22 INFO - Running setup.py install for manifestparser 11:16:22 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:16:22 INFO - Running setup.py install for mozcrash 11:16:22 INFO - Running setup.py install for mozdebug 11:16:22 INFO - Running setup.py install for mozdevice 11:16:22 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:16:22 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:16:22 INFO - Running setup.py install for mozfile 11:16:22 INFO - Running setup.py install for mozhttpd 11:16:22 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:16:22 INFO - Running setup.py install for mozinfo 11:16:23 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:16:23 INFO - Running setup.py install for mozInstall 11:16:23 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:16:23 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:16:23 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:16:23 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:16:23 INFO - Running setup.py install for mozleak 11:16:23 INFO - Running setup.py install for mozlog 11:16:23 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:16:23 INFO - Running setup.py install for moznetwork 11:16:23 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:16:23 INFO - Running setup.py install for mozprocess 11:16:23 INFO - Running setup.py install for mozprofile 11:16:23 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:16:23 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:16:23 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:16:23 INFO - Running setup.py install for mozrunner 11:16:23 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:16:23 INFO - Running setup.py install for mozscreenshot 11:16:23 INFO - Running setup.py install for moztest 11:16:24 INFO - Running setup.py install for mozversion 11:16:24 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:16:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:16:24 INFO - Cleaning up... 11:16:24 INFO - Return code: 0 11:16:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:16: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')]} 11:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16: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')]} 11:16:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:24 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 0x7fdb61d8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb840>, '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 0x18586b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858b60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153', '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 11:16:24 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 11:16:24 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 11:16:24 INFO - Using env: {'DISPLAY': ':0', 11:16:24 INFO - 'HOME': '/home/cltbld', 11:16:24 INFO - 'LANG': 'en_US.UTF-8', 11:16:24 INFO - 'LANGUAGE': 'en_US:en', 11:16:24 INFO - 'LOGNAME': 'cltbld', 11:16:24 INFO - 'MAIL': '/var/mail/cltbld', 11:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:24 INFO - 'MOZ_NO_REMOTE': '1', 11:16:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:24 INFO - 'NO_EM_RESTART': '1', 11:16:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:16:24 INFO - 'PWD': '/builds/slave/test-pgo', 11:16:24 INFO - 'SHELL': '/bin/bash', 11:16:24 INFO - 'SHLVL': '1', 11:16:24 INFO - 'TERM': 'linux', 11:16:24 INFO - 'TMOUT': '86400', 11:16:24 INFO - 'USER': 'cltbld', 11:16:24 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153', 11:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:24 INFO - '_': '/tools/buildbot/bin/python'} 11:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:16:24 INFO - Running setup.py (path:/tmp/pip-D32qnD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:16:24 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)) 11:16:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:16:24 INFO - Running setup.py (path:/tmp/pip-Ap4kio-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:16:24 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)) 11:16:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:16:24 INFO - Running setup.py (path:/tmp/pip-BrlqMR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:16:24 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)) 11:16:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:16:24 INFO - Running setup.py (path:/tmp/pip-TlZdB8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:16:24 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)) 11:16:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:16:24 INFO - Running setup.py (path:/tmp/pip-OhjnWR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:16:24 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)) 11:16:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:16:24 INFO - Running setup.py (path:/tmp/pip-vBN2d9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:16:24 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)) 11:16:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:16:24 INFO - Running setup.py (path:/tmp/pip-WD7LZi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:16:24 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)) 11:16:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:16:24 INFO - Running setup.py (path:/tmp/pip-y2fVUF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:16:24 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)) 11:16:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:16:24 INFO - Running setup.py (path:/tmp/pip-X79dWY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:16:25 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)) 11:16:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:16:25 INFO - Running setup.py (path:/tmp/pip-W1AkmW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:16:25 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)) 11:16:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:16:25 INFO - Running setup.py (path:/tmp/pip-LJhuYw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:16:25 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)) 11:16:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:16:25 INFO - Running setup.py (path:/tmp/pip-qWDatO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:16:25 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)) 11:16:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:16:25 INFO - Running setup.py (path:/tmp/pip-eBnzQZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:16:25 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)) 11:16:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:16:25 INFO - Running setup.py (path:/tmp/pip-80jloc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:16:25 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)) 11:16:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:16:25 INFO - Running setup.py (path:/tmp/pip-UNwmWp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:16:25 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)) 11:16:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:16:25 INFO - Running setup.py (path:/tmp/pip-uLQlOI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:16:25 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)) 11:16:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:16:25 INFO - Running setup.py (path:/tmp/pip-8LAOlx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:16:25 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)) 11:16:25 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)) 11:16:25 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)) 11:16:25 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)) 11:16:25 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)) 11:16:25 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)) 11:16:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:16:25 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 11:16:25 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 11:16:25 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 11:16:25 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 11:16:25 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 11:16:25 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 11:16:27 INFO - Downloading blessings-1.6.tar.gz 11:16:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:16:27 INFO - Installing collected packages: blessings 11:16:27 INFO - Running setup.py install for blessings 11:16:27 INFO - Successfully installed blessings 11:16:27 INFO - Cleaning up... 11:16:27 INFO - Return code: 0 11:16:27 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:16:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:16:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:16:27 INFO - Reading from file tmpfile_stdout 11:16:27 INFO - Current package versions: 11:16:27 INFO - argparse == 1.2.1 11:16:27 INFO - blessings == 1.6 11:16:27 INFO - blobuploader == 1.2.4 11:16:27 INFO - docopt == 0.6.1 11:16:27 INFO - manifestparser == 1.1 11:16:27 INFO - mozInstall == 1.12 11:16:27 INFO - mozcrash == 0.16 11:16:27 INFO - mozdebug == 0.1 11:16:27 INFO - mozdevice == 0.48 11:16:27 INFO - mozfile == 1.2 11:16:27 INFO - mozhttpd == 0.7 11:16:27 INFO - mozinfo == 0.9 11:16:27 INFO - mozleak == 0.1 11:16:27 INFO - mozlog == 3.1 11:16:27 INFO - moznetwork == 0.27 11:16:27 INFO - mozprocess == 0.22 11:16:27 INFO - mozprofile == 0.28 11:16:27 INFO - mozrunner == 6.11 11:16:27 INFO - mozscreenshot == 0.1 11:16:27 INFO - mozsystemmonitor == 0.0 11:16:27 INFO - moztest == 0.7 11:16:27 INFO - mozversion == 1.4 11:16:27 INFO - psutil == 3.1.1 11:16:27 INFO - requests == 1.2.3 11:16:27 INFO - wsgiref == 0.1.2 11:16:27 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:16:27 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')]} 11:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:27 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')]} 11:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:27 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 0x7fdb61d8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb840>, '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 0x18586b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858b60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153', '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 11:16:27 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 11:16:27 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 11:16:27 INFO - Using env: {'DISPLAY': ':0', 11:16:27 INFO - 'HOME': '/home/cltbld', 11:16:27 INFO - 'LANG': 'en_US.UTF-8', 11:16:27 INFO - 'LANGUAGE': 'en_US:en', 11:16:27 INFO - 'LOGNAME': 'cltbld', 11:16:27 INFO - 'MAIL': '/var/mail/cltbld', 11:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:27 INFO - 'MOZ_NO_REMOTE': '1', 11:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:27 INFO - 'NO_EM_RESTART': '1', 11:16:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:16:27 INFO - 'PWD': '/builds/slave/test-pgo', 11:16:27 INFO - 'SHELL': '/bin/bash', 11:16:27 INFO - 'SHLVL': '1', 11:16:27 INFO - 'TERM': 'linux', 11:16:27 INFO - 'TMOUT': '86400', 11:16:27 INFO - 'USER': 'cltbld', 11:16:27 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153', 11:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:27 INFO - '_': '/tools/buildbot/bin/python'} 11:16:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:28 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)) 11:16:28 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)) 11:16:28 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)) 11:16:28 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)) 11:16:28 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)) 11:16:28 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)) 11:16:28 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)) 11:16:28 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)) 11:16:28 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)) 11:16:28 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)) 11:16:28 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)) 11:16:28 INFO - Cleaning up... 11:16:28 INFO - Return code: 0 11:16:28 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:16:28 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')]} 11:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:28 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')]} 11:16:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:28 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 0x7fdb61d8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb840>, '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 0x18586b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858b60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153', '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 11:16:28 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 11:16:28 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 11:16:28 INFO - Using env: {'DISPLAY': ':0', 11:16:28 INFO - 'HOME': '/home/cltbld', 11:16:28 INFO - 'LANG': 'en_US.UTF-8', 11:16:28 INFO - 'LANGUAGE': 'en_US:en', 11:16:28 INFO - 'LOGNAME': 'cltbld', 11:16:28 INFO - 'MAIL': '/var/mail/cltbld', 11:16:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:28 INFO - 'MOZ_NO_REMOTE': '1', 11:16:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:28 INFO - 'NO_EM_RESTART': '1', 11:16:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:16:28 INFO - 'PWD': '/builds/slave/test-pgo', 11:16:28 INFO - 'SHELL': '/bin/bash', 11:16:28 INFO - 'SHLVL': '1', 11:16:28 INFO - 'TERM': 'linux', 11:16:28 INFO - 'TMOUT': '86400', 11:16:28 INFO - 'USER': 'cltbld', 11:16:28 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153', 11:16:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:28 INFO - '_': '/tools/buildbot/bin/python'} 11:16:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:28 INFO - Downloading/unpacking jsonschema 11:16:28 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 11:16:28 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 11:16:28 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 11:16:28 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 11:16:28 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 11:16:28 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 11:16:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:16:30 INFO - Downloading/unpacking functools32 (from jsonschema) 11:16:30 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 11:16:30 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 11:16:30 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 11:16:30 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 11:16:30 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 11:16:30 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 11:16:30 INFO - Downloading functools32-3.2.3-2.tar.gz 11:16:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:16:30 INFO - warning: no files found matching '*.txt' 11:16:30 INFO - no previously-included directories found matching 'build' 11:16:30 INFO - no previously-included directories found matching 'dist' 11:16:30 INFO - no previously-included directories found matching '.git*' 11:16:30 INFO - Installing collected packages: jsonschema, functools32 11:16:30 INFO - Running setup.py install for functools32 11:16:30 INFO - warning: no files found matching '*.txt' 11:16:30 INFO - no previously-included directories found matching 'build' 11:16:30 INFO - no previously-included directories found matching 'dist' 11:16:30 INFO - no previously-included directories found matching '.git*' 11:16:30 INFO - Successfully installed jsonschema functools32 11:16:30 INFO - Cleaning up... 11:16:30 INFO - Return code: 0 11:16:30 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:16:30 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')]} 11:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:30 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')]} 11:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:30 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 0x7fdb61d8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb840>, '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 0x18586b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858b60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153', '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 11:16:30 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 11:16:30 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 11:16:30 INFO - Using env: {'DISPLAY': ':0', 11:16:30 INFO - 'HOME': '/home/cltbld', 11:16:30 INFO - 'LANG': 'en_US.UTF-8', 11:16:30 INFO - 'LANGUAGE': 'en_US:en', 11:16:30 INFO - 'LOGNAME': 'cltbld', 11:16:30 INFO - 'MAIL': '/var/mail/cltbld', 11:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:30 INFO - 'MOZ_NO_REMOTE': '1', 11:16:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:30 INFO - 'NO_EM_RESTART': '1', 11:16:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:16:30 INFO - 'PWD': '/builds/slave/test-pgo', 11:16:30 INFO - 'SHELL': '/bin/bash', 11:16:30 INFO - 'SHLVL': '1', 11:16:30 INFO - 'TERM': 'linux', 11:16:30 INFO - 'TMOUT': '86400', 11:16:30 INFO - 'USER': 'cltbld', 11:16:30 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153', 11:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:30 INFO - '_': '/tools/buildbot/bin/python'} 11:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:30 INFO - Downloading/unpacking flake8 11:16:30 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 11:16:30 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 11:16:30 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 11:16:30 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 11:16:30 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 11:16:30 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 11:16:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:16:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:16:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16: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 11:16:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:16:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:16:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:16:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:16:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:16:33 INFO - no previously-included directories found matching 'docs/_build' 11:16:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:16:33 INFO - Running setup.py install for pep8 11:16:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:16:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:16:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:16:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:16:33 INFO - no previously-included directories found matching 'docs/_build' 11:16:33 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:16:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:16:33 INFO - Cleaning up... 11:16:33 INFO - Return code: 0 11:16:33 INFO - Running post-action listener: _resource_record_post_action 11:16:33 INFO - Running post-action listener: _start_resource_monitoring 11:16:33 INFO - Starting resource monitoring. 11:16:33 INFO - ##### 11:16:33 INFO - ##### Running install step. 11:16:33 INFO - ##### 11:16:33 INFO - Running pre-action listener: _resource_record_pre_action 11:16:33 INFO - Running main action method: install 11:16:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:16:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:16:33 INFO - Reading from file tmpfile_stdout 11:16:33 INFO - Detecting whether we're running mozinstall >=1.0... 11:16:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:16:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:16:33 INFO - Reading from file tmpfile_stdout 11:16:33 INFO - Output received: 11:16:33 INFO - Usage: mozinstall [options] installer 11:16:33 INFO - Options: 11:16:33 INFO - -h, --help show this help message and exit 11:16:33 INFO - -d DEST, --destination=DEST 11:16:33 INFO - Directory to install application into. [default: 11:16:33 INFO - "/builds/slave/test-pgo"] 11:16:33 INFO - --app=APP Application being installed. [default: firefox] 11:16:33 INFO - mkdir: /builds/slave/test-pgo/build/application 11:16:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 11:16:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 11:16:49 INFO - Reading from file tmpfile_stdout 11:16:49 INFO - Output received: 11:16:49 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:16:49 INFO - Running post-action listener: _resource_record_post_action 11:16:49 INFO - ##### 11:16:49 INFO - ##### Running run-tests step. 11:16:49 INFO - ##### 11:16:49 INFO - Running pre-action listener: _resource_record_pre_action 11:16:49 INFO - Running main action method: run_tests 11:16:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:16:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:16:49 INFO - Python 2.7.3 11:16:49 INFO - Return code: 0 11:16:49 INFO - grabbing minidump binary from tooltool 11:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:49 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 0x18eb840>, '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 0x18586b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:16:49 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 11:16:49 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 11:16:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:16:49 INFO - Return code: 0 11:16:49 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:16:49 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:16:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:16:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:16:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:16:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:16:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:16:50 INFO - Return code: 0 11:16:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 11:16:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 11:16:50 INFO - Using env: {'DISPLAY': ':0', 11:16:50 INFO - 'HOME': '/home/cltbld', 11:16:50 INFO - 'LANG': 'en_US.UTF-8', 11:16:50 INFO - 'LANGUAGE': 'en_US:en', 11:16:50 INFO - 'LOGNAME': 'cltbld', 11:16:50 INFO - 'MAIL': '/var/mail/cltbld', 11:16:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:16:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:50 INFO - 'MOZ_NO_REMOTE': '1', 11:16:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:16:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:50 INFO - 'NO_EM_RESTART': '1', 11:16:50 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:16:50 INFO - 'PWD': '/builds/slave/test-pgo', 11:16:50 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:16:50 INFO - 'SHELL': '/bin/bash', 11:16:50 INFO - 'SHLVL': '1', 11:16:50 INFO - 'TERM': 'linux', 11:16:50 INFO - 'TMOUT': '86400', 11:16:50 INFO - 'USER': 'cltbld', 11:16:50 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153', 11:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:50 INFO - '_': '/tools/buildbot/bin/python'} 11:16:50 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:16:51 INFO - mozversion application_buildid: 20160125083105 11:16:51 INFO - mozversion application_changeset: 166f314b7d4dc21be028a8307d2e34887b9e95da 11:16:51 INFO - mozversion application_display_name: Nightly 11:16:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:16:51 INFO - mozversion application_name: Firefox 11:16:51 INFO - mozversion application_remotingname: firefox 11:16:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:16:51 INFO - mozversion application_vendor: Mozilla 11:16:51 INFO - mozversion application_version: 46.0a1 11:16:51 INFO - mozversion platform_buildid: 20160125083105 11:16:51 INFO - mozversion platform_changeset: 166f314b7d4dc21be028a8307d2e34887b9e95da 11:16:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:16:51 INFO - mozversion platform_version: 46.0a1 11:16:51 INFO - using testdate: 1453749411 11:16:51 INFO - actual date: 1453749411 11:16:51 INFO - starting webserver on 'localhost:50526' 11:16:51 INFO - SUITE-START | Running 3 tests 11:16:51 INFO - TEST-START | dromaeo_css 11:16:51 INFO - operating with platform_type : linux_ 11:16:51 INFO - Initialising browser for dromaeo_css test... 11:16:51 INFO - TEST-INFO | started process 16495 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0VHxv2/profile http://localhost:50526/getInfo.html) 11:16:54 INFO - PROCESS | 16495 | __metrics Screen width/height:1600/1200 11:16:54 INFO - PROCESS | 16495 | colorDepth:24 11:16:54 INFO - PROCESS | 16495 | Browser inner width/height: 1024/697 11:16:54 INFO - PROCESS | 16495 | __metrics 11:16:55 INFO - PROCESS | 16495 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:16:55 INFO - PROCESS | 16495 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:16:56 INFO - TEST-INFO | 16495: exit 0 11:16:56 INFO - Browser initialized. 11:16:56 INFO - Running cycle 1/1 for dromaeo_css test... 11:16:56 INFO - TEST-INFO | started process 16588 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0VHxv2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:17:07 INFO - PROCESS | 16588 | RSS: Main: 148533248 11:17:07 INFO - PROCESS | 16588 | 11:17:59 INFO - PROCESS | 16588 | 1453749479367 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] 11:20:07 INFO - PROCESS | 16588 | Cycle 1(1): loaded http://localhost:50526/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50526/tests/dromaeo/cssquery-ext.html) 11:20:08 INFO - PROCESS | 16588 | RSS: Main: 283848704 11:20:08 INFO - PROCESS | 16588 | 11:23:11 INFO - PROCESS | 16588 | Cycle 1(1): loaded http://localhost:50526/tests/dromaeo/cssquery-ext.html (next: http://localhost:50526/tests/dromaeo/cssquery-jquery.html) 11:23:11 INFO - PROCESS | 16588 | RSS: Main: 228331520 11:23:11 INFO - PROCESS | 16588 | 11:26:13 INFO - PROCESS | 16588 | Cycle 1(1): loaded http://localhost:50526/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50526/tests/dromaeo/cssquery-mootools.html) 11:26:14 INFO - PROCESS | 16588 | RSS: Main: 221151232 11:26:14 INFO - PROCESS | 16588 | 11:29:16 INFO - PROCESS | 16588 | Cycle 1(1): loaded http://localhost:50526/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50526/tests/dromaeo/cssquery-prototype.html) 11:29:17 INFO - PROCESS | 16588 | RSS: Main: 208351232 11:29:17 INFO - PROCESS | 16588 | 11:32:19 INFO - PROCESS | 16588 | Cycle 1(1): loaded http://localhost:50526/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50526/tests/dromaeo/cssquery-yui.html) 11:32:20 INFO - PROCESS | 16588 | RSS: Main: 213102592 11:32:20 INFO - PROCESS | 16588 | 11:35:22 INFO - PROCESS | 16588 | Cycle 1(1): loaded http://localhost:50526/tests/dromaeo/cssquery-yui.html (next: http://localhost:50526/tests/dromaeo/cssquery-dojo.html) 11:35:23 INFO - PROCESS | 16588 | RSS: Main: 298229760 11:35:23 INFO - PROCESS | 16588 | 11:35:23 INFO - PROCESS | 16588 | __start_tp_report 11:35:23 INFO - PROCESS | 16588 | _x_x_mozilla_page_load 11:35:23 INFO - PROCESS | 16588 | _x_x_mozilla_page_load_details 11:35:23 INFO - PROCESS | 16588 | |i|pagename|runs| 11:35:23 INFO - PROCESS | 16588 | |0;dojo.html;3144.2768163322435;3171.0803866878605;3219.4205043092247;3225.6935591118836;3244.3673483670677;4993.350864387625;5010;5181.740912954356;5190.1176799944005;5234.607404444668;5143.09995750744;5187.792488300463;5200.583953283738;5206.739663016843;5220.243064755608;4476.6418686505;4631.976840115794;4674.3923289972345;4722.409698787652;4740.691855029412;4543.613792827614;4609.792559334821;4691.554302341289;4693.460252071004;4809;4641.25739881619;4724.149653062447;4742.857714268577;4750.691205071659;4754.524547545235;4646.186917289495;4647.651426143053;4660.743659098748;4661.114388266218;4695.835645752416;4603.608693261077;4646.4191976003;4651.279051746985;4656.650751193674;4688;4946.060248552763;4946.159152944008;5010.949890501085;5030.496950304977;5053.065182941167;5512.641678290898;5534.059209934321;5537.141743029837;5537.695426751527;5539.584531160179;5420.13277875538;5515.338159420855;5543.279373681436;5549.889002219933;5594.188842617838;5064.215046667772;5224.425313215544;5259.552938000313;5264.394594621591;5279.287296215039;5632.3804381518;5675.687837168995;5682.948654498931;5683.0338842396895;5729.598928074995;5332.626716129911;5413.458654134633;5441.5102640762525;5483.040467918178;5486.341639003345;5388.595855310868;5391.056565101092;5408.972955135199;5441.700706461183;5458.6724796512335;5474.39781624021;5484.808031718871;5497.065498865202;5499.1476321170285;5501.394846566875;5211.687298762086;5271.1039123348355;5420.868552892825;5484.149956756709;5532.087205611109;4275.294576394922;4293.0769884474985;4301.354796780445;4323.373110898902;4331.696781225347;3837.1174629835295;3862.748921320105;3872.2120321905786;3897.337452633059;3907.433422153772;4964.205727083649;4993.725345105981;5121.743912804345;5124.205748109049;5168.53483186515;5515.979543784413;5592.328920529562;5608.327000759853;5623.8594035149445;5631.521320687705;5157.123289040872;5159.432462429129;5161.458046905096;5164.2770012198325;5201.661891977009;4695.413073365829;4738.407699037621;4751.026039661861;4762.904741905142;4775.2359622460235;5711.200431939532;5732.283464566929;5735.913961290584;5737.627054241544;5755.3381361144;5538.695371754592;5540.722963851872;5542.556595472433;5544.944550554443;5547.278853749148;5495.945040549704;5564.10974244119;5584.3857175711455;5623.437656234344;5724.685142317213;5476.589255805751;5479.890402192013;5490.6980116094;5491.752871120889;5519.448055194448;5501.229827824028;5544.223808666709;5549.972250138723;5553.0559804832465;5605.663660180402;5374.516293533445;5389.919151212814;5441.591880609049;5467.72661366938;5485.122380419114;5433.076377015837;5436.646617969819;5438.102713052302;5442.809501667581;5470.370907345547;5338.3593968724;5343.198520221842;5346.064438723286;5347.278117454094;5396.9190462142315;5240.082985477602;5284.550813180923;5325.9467405327005;5326.334208223972;5449.754761035842;5303.416624171416;5359.678419294854;5360.2227676987395;5363.758630861698;5385.703786291791 11:35:23 INFO - PROCESS | 16588 | |1;ext.html;524.3131497737961;555.339146415765;569.5671289819737;576.3832699012057;579.7130420441882;27976.440471190588;35526.82236588817;36046.09884752879;36114;36134.457983130276;38758;39384.80307598465;39405.8029709851;39458.408123878165;39510.20979580407;8393.664253429855;8559.957200214021;8591.26974207193;8614.913850861505;8626.3098952084;8182.877256841152;8327.916720832805;8333.041700204463;8336.124706905748;8339.708110216143;8581;8683;8697.695580654678;8702.912970870273;8707.434016788888;8472.491650500959;8600.182982616641;8609.139086091434;8614.05245423003;8628.870566941501;8481.957590212009;8638.956805215996;8640.827183456358;8648.524331161783;8649.524276164808;39897.60102398968;40363.596364036275;40464;40487.392689109685;40496.39255411171;3077.553754705555;3159.1154476746547;3169.3344397676515;3298.4392653249006;3528.9589571076594;29807.850960745276;29813.552796708067;30374;30529.847350763102;31797.84101079503;3855.9421608675893;3910.511186101737;3971.126352202511;4004.83980640774;4026.235015347104;268851;270905;270924;271034;271550.6422467895;40961;52336;53545.73227133839;58831.70584147052;59242.70378648165;39233.41149882754;39369.06309369097;39371.80314098469;39414.60585394167;39435.67618371483;12688.175268607696;12812.743745125046;12834.422450989729;12835.743285134246;12841.614751557468;9501.382410143457;9666.95166524163;10505.789884202273;10526.157907367393;10709.518071686793;13547.390367433489;13624.727505449835;13626.931865340808;13650.453981840814;13731.656708582166;5557.944420555824;5588.161775733673;5635.859103522363;5664.376918538957;5691.68695721731;860.8020155364301;899.8290324838259;905.090384163911;932.3566738950103;1014.0569270578286;26175;26946.865265673547;27360.58959115615;27560.10618884988;27965.16104516868;1010.5301035018751;1071.4053700196466;1071.796358691846;1076.0853274716428;1125.2685754259633;14379.209143496999;14465.49370772018;14501.071090519688;14644.315903671;14757.114573125433;329379;335129;337566;340437;341404;52022;52117;52611;52630;52692.473075269525;1145.9083273338113;1166.4401087478059;1172.4430895324654;1186.3890096600257;1336.6992426704107;24897.875510622333;26249.4750104993;26368.73631263663;26386.472270554867;26402.339941501617;39058.218835623695;39582.208355833296;39638.2072358557;43254.351184732885;43881;403157;410155;413516;414277;414540;32117.6788232124;32671.73282671714;32676.34647307088;32705.18237044093;32749.345013100083;42677.5732242686;43006;43509;43973.56026439695;44105;35081.64918350784;36849;37777.433338499395;37999.620003800715;38368.2326353477;37209.44185837269;38004.619953801215;38082.2383552333;38287.80856095702;38322.616773831905;35450;35937;36439;36694;36795.63204367922;31279.84360078185;33243.179738938205;33775.49336759902;34038.65961340355;34418.311633767684;21769.67345489787;21882;22103.668444973016;22113.668294975265;22187.334379968626 11:35:23 INFO - PROCESS | 16588 | |2;jquery.html;353.08198683423103;353.6410543298552;359.9244158726667;361.15850069338427;369.1712106321309;14091.577252682411;14227.21750303733;15474.226288685562;16442.42451514197;17869.55326116846;14541.854581454183;14565.198914059722;14634.634134146625;14646.487372941949;14776;5048.596112311006;5236.450172731866;5237.266782650441;5247.134222853225;5247.973760131194;3638.909027274326;3971.7616942983514;5147.510986456299;5204.115300398941;5420.403755586883;5370.248165256867;5382.596305277119;5400.513953744162;5415.83752487426;5420.105682562373;5196.68819870809;5379.704116273584;5388.110961691316;5409.350877894639;5426.348838139429;4827.372441582607;5033.874153146164;5178.689278643294;5179.067767801795;5180.818671346522;17973.37093201732;18383.172757225955;18564;18585.256589736393;18822.81177188238;1986.1757370691146;2001.2988959384552;2015.899205039757;2072.430081727522;2262.6266666000092;8718.738437846874;8723.956380218122;9422.717318480456;9427.670031548863;10209.795804083951;1705.6077102266547;1747.484492074841;1755.3154269834774;1801.7297405389165;1881.6895212289955;54720.17919731207;55041;55346.723266383815;56099.71950140264;56144.43855561474;9747.171490423252;9771.840737452283;9845.227858985309;9862.112409883144;9986.600535978625;12562;12618.864302212845;12715.364231788373;12758.553450629184;12771.489140434465;7130.073090498306;7211.89182162268;7239.348458638748;7240.52936559122;7291.562506249642;6879.965600171967;6888.448924086061;6906.8618627628175;6926.376626103674;6942.097527321416;4233.322668373107;4281.293586558183;4337.436133302651;4442.511323754385;4459.2865141577195;1649.690433393235;1738.2873022060894;1762.7091529897423;1774.3967051202653;1775.3076300242915;837.6146972392646;850.2900078434576;924.3529529329496;925.3846192282192;943.0428115462811;12737.108402411928;14188.929055354658;14635.634109147357;15392;15842.841571584137;869.2958703450225;918.8989211186764;938.7043081429327;940.9811803763887;984.8965858584888;8269.62786674601;8593.140685931357;8658.653653853902;8698.782530436789;8698.826023479494;146475;148422.25788870986;149674.25162874116;149862;150188;67159.32840671629;68133.3186668127;68372;69828.6508567464;71908.64045679843;1036.6060896859144;1051.0488008352454;1054.146141625286;1055.936643801359;1058.4125810175274;13668.93165534166;13762.793558096437;14056;14146.717065658835;14169.22069286158;26853.731462685122;33246.50130248097;33314.5002824953;33673.83163084169;35256;39521.60478395294;40717.1856562873;40781.796091020544;41084.79457602693;41328;6752.831179220559;6865.41643960269;6876.724931002904;7010.684519196547;7177.246389129066;9857.556409961713;10420.843687344848;10567;10655.13470523915;11325.716857078309;9593.28050396237;9640.75898102553;9768.511574421109;9802.166815820736;9950.10449059588;9738.81585193393;9790.657326993522;9984.650537231162;9985.550650220612;10171;6975.720971161097;9164.404313719588;9222.584983675617;9773.9022609773;9910.405375677483;6821.3519715626935;7017;7070.469714771516;7149.642517873982;7165.641717914188;8367.372447066373;8792.384533082623;9191.172794448265;9225.49259790718;9548.045195480674 11:35:23 INFO - PROCESS | 16588 | |3;mootools.html;1316.1839659411155;1473.388543754342;1479.7558402863524;1638.1890963972835;1802.387188355958;7164.713411463542;7756.069271687398;8000.119986801447;8013.398995075364;8019.278264956168;7885.960570197141;8042.195780421969;8058.959705201481;8065.516069035862;8071.91928080719;2012.929547465839;2066.2045112631595;2069.627467055929;2297.069686776858;2331.1258278145697;2058.361907808584;2295.494991101955;2340.6137987232173;2342.1451170322794;2342.2153578551206;2260.107257633234;2273.3975496493445;2284.006457191119;2285.5200407914276;2318.675385446039;2247.404437823978;2262.8868556572106;2272.409173614864;2277.8063864571614;2277.977220227793;2299.1952816514254;2309.9422514437106;2310.8844557772045;2312.583734927712;2324.023909957805;8097.838043239102;8142.552159631277;8148.674053037871;8157.143499932481;8160.5103693778565;4732.242841145435;4783.545563171528;4798.952010479886;4809.6392770542;4837.854864354075;3140.921476963071;3158.7630927680284;3254.869805207789;3262.771605987582;3263.804171749679;1075.8816530181673;1085.4898197847078;1090.6182836007413;1091.3397394576245;1109.1792073865363;11649.12631552637;11654.359010254517;11661.70845728855;11699.590514331958;11779.823302650382;4453.1316393303;4474.709143905636;4524.819007239739;4528.50186479487;4576.862694119115;9926.652567160114;9931.304808663468;9941.900580994097;9956.253281003954;9957.203423726085;4844.32179494871;4855.150348688965;4871.14754917888;4874.707517548958;4874.926876096791;4401.141777353385;4403.4495688039;4407.162639098561;4413.911721765547;4415.448068991376;3510.736694747904;3573.338932297533;3818.885433437001;3874.263889860974;3914.921701565953;1208.6796998795326;1209.6189700244395;1214.763121191377;1214.842070530843;1225.3199474291853;1272.7899896516972;1281.6859869331886;1294.1652634051172;1304.0675916719401;1330.9800352994712;7366.594837284001;7430.6284685765495;7449.068866391701;7452.739154129687;7456.850862982818;1071.6999240212754;1082.7888561730388;1084.1489430796787;1106.3140852671233;1116.7319843237565;5822.650640961556;5892.616979896378;5900.498457631149;5900.586958912835;5910.70446477683;9603.519824008772;9749.561269742879;9931;10041.447720375449;10066.14437772783;9797.06927841854;9922.751931201634;9941.751456213507;9962.352447090916;9964.153046991087;7450.292222238987;7644.082710074716;7699.11460182075;7699.307062364414;7708.807279817937;7510.624468776648;7601.543907365576;7691.30778229962;7698.615069246627;7708.653110610148;8692.391532592657;8773.605187766694;8860.29117670572;8930.687425940061;8958.462492250486;8733.388662793797;9062.22971047442;9199.218066464426;9202.355835091746;9210.447373157633;6924.549904256207;7070.858582828418;7071.186813516306;7082.327178917994;7082.752103676346;6802.489813263926;6854.280300568368;7605.733799316998;7706.730264440717;7760.068791745027;7074.469414793808;7153.570785752871;7198.604076775828;7271.163816160997;7371.299726525972;7168.89246661311;7247.202807691045;7313.016069653574;7358.816029599303;7450.515716478629;7144.964275178799;7334.009908662262;7410.740624078131;7437.442191835742;7440.3675687565;6791.2190098139345;6792.524523283323;6803.659817009228;6819.829504262433;6831.69257383409;6918.308169183041;6957.408620267334;6964.442844572523;6967.0246165535855;6972.755953541602 11:35:23 INFO - PROCESS | 16588 | |4;prototype.html;334.83593039410687;335.79180907837144;342.2641321159508;343.35449355212205;348.2512597914482;5797.101449275358;5930.347661757209;5952.58331916766;5964.045752679572;6014.458698717114;5713.114467257571;5814.854628634286;5834.066549352105;5877;5896.970515147418;4568.657350698702;4580.26715725484;4629.953700462986;4636.6058884994645;4637.04940487201;4371.409859668952;4464.241079016575;4494.842680506183;4583.724976501404;4609.3777340059;4549.61328287096;4573.153966516188;4581.79381927814;4581.908361832761;4599.356090147382;4581.748003859786;4584.747838868844;4586.266197408415;4596.35651008859;4602.930956035629;4067.5525692173837;4068.532118806316;4068.593140685937;4072.104137089865;4072.328065869128;5561.193626924073;5650.971745141289;5665.830025099212;5695.202671625976;5726.427357264281;5355.30381050461;5356.0894647909945;5357.276767636358;5360.035193665139;5367.577591938139;6019.247594050744;6341.746330146789;6345.111684364193;6355.046742988588;6355.936440635581;4382.496012958519;4386.495553011381;4475.955240447586;4511.887202819956;4516.932246016312;6478.74085036598;6537.803865884031;6562.770303039419;6582.210134783809;6590.604563726144;4608.262677971508;4612.654050946193;4617.353570500132;4617.746023968714;4618.376519169936;4504.81980720774;4638.304254361873;4661.137689527448;4667.673262871566;4673.60274376675;5342.358916929993;5342.893142137135;5357.866053348697;5361.839144825662;5368.3826359968325;6333.809985700436;6342.746290148435;6343.55595108338;6343.619382837044;6356.682165891687;1606.8714502839978;1661.1362091712242;1662.2187571841216;1662.4430815676883;1663.2931004323113;1091.47063674118;1123.8988491035682;1132.0547342968714;1132.224426268009;1149.8329195866202;5878.911816322759;5956.9575324318075;5962.4633782959745;5965.850853728692;5966.164736936832;6441.742330306829;6449.935500645028;6456.967715161394;6458.612483250926;6467.773627923;5743.684097374601;5764.654120752768;5804.2744656917885;5853.9170253503235;5880.735366908414;3403.931921361559;3481.112316359312;3483.00734290731;3485.7385696072897;3489.581250249986;6581.473482121419;6629.403353698191;6653.600783952978;6654.933450665529;6655.401013908771;6546.214454265519;6575.80272591823;6576.835579110465;6583.539152259392;6595.208574971034;6494.318096599884;6653.201615806038;6655.267920528835;6657.3342665733035;6661.9000714989315;6161.507079433545;6388.201474815648;6395.584287021329;6412.711427985845;6430.164078669743;6475.902861456988;6492.220933488012;6499.5775274607;6504.447121994494;6505.902411463927;6774.356436138559;6803.489738269551;6812.0122582226295;6815.659217039228;6818.386345228953;4646.834657764916;4681.742504162167;4720.622350211906;4724.291356296583;4733.5503127202865;6542.149520562297;6543.1821022372205;6543.476521878333;6546.574472659262;6563.0811686362995;6360.332165122781;6361.745530178741;6362.45919096882;6364.745410183726;6370.522210834113;6172.105044768573;6371.681415929278;6384.553081284451;6384.712687928962;6400.839979000562;6284.905726414199;6287.685615719287;6289.339619339903;6290.9056364155485;6293.716782744696;6423.197100362455;6491.156149700509;6493.285738568659;6498.577592456475;6503.967480162569;6117.776444711165;6259.593126446766;6272.655003974825;6275.403836635513;6292.559520833681 11:35:23 INFO - PROCESS | 16588 | |5;yui.html;699.063255237981;737.4763917618491;740.9296116868895;789.2580973884548;791.9743931608566;12891.484340626375;13027.804582931263;13057.869421305784;13062.934685326572;13093.214407135578;11296.943515282412;12873.935630321836;12967.221966682006;12979.351032448363;13004.804927926089;665.8335416145964;674.9392554670079;792.6393490961613;795.4789612803594;804.252045597594;785.4305628419407;790.6718711734624;791.3589992106412;794.4518282385136;794.9761507154766;846.7967687754956;848.6605357856876;849.7535714642746;850.2432834777022;850.9829803403928;689.9655017249142;695.5200911371163;835.6699103853974;851.7146755836802;855.114956020522;626.9780557680459;628.1425853709699;628.7045088808253;628.8679377330766;628.8930881750068;12866.549670761478;12887.484500620058;12954.481820727255;12960.48158073676;12963.805542916863;11987.520499180022;12180.695482612917;12222.694432639166;12312.50749970009;12424.192427492184;9848.310618256724;9869.506524673738;10005.949970250174;10325.070743633109;10450;3487.075924879909;3498.492718555821;3521.8767343142868;3543.0965103898343;3672.485851980725;48106.75946620315;48548.757256213845;48695.13048695138;48878;48912;9177.587008584629;9393.57728902201;9489.715308540755;9494.287928405398;9564.18704410119;18429.26282948667;18462.07689615514;18498.260069597334;18499.90750046241;18500.537486562673;6894.103766510321;6963.199232088375;7018.75434359795;7178.28217178278;7346.485745997836;4126.174765047002;4198.685098617616;4212.68404869636;4251.914961700749;4286.80709368073;3057.143999680093;3119.251379668863;3122.11019859339;3127.4526957782296;3127.5152351385573;560.087058095302;564.4355644355644;566.6854895533019;582.8105865593699;587.753143679647;526.9973650131801;582.8979928512493;599.901016332309;607.720448593643;629.4429429954523;8221.958890205511;8940;8950.23922966555;9021.729348119436;9342.205912497513;654.607235658601;660.5112216959416;669.1434963246954;672.0658284983876;673.8517526144241;3820.9426858597144;3857.4213867919475;3919.2440461661868;3994.820233089518;4011.2378648056774;59874.70062649746;60345.698271508365;60428.69785651044;60827.695861520406;61751.69124154351;49245;50073.49926500761;50163;50287.49712502901;50773;45535.772321138844;45978.31032534515;46456.3031554527;46954.76522617365;47270.29094563585;8238.423310368216;8320.791980200544;8443.746687599381;8509.404341696021;8524.104968978168;34169;34787.826060869535;34809.47785783266;34944.65055349414;35039.47440788441;41745;45261;45609;45716.77141614271;45720.31419528776;10895.673129806119;11038.613648522263;11046.889531104585;11047.668569942914;11056.778864422506;12023.579174728842;12076.456559455022;12159.81760273579;12626.55807046749;13085.607431777062;10719.303245289344;10905.890941090487;10909.39998300101;10987.230893837674;11007.229493935347;11534.942325288655;11599.710007249549;11654.650360489199;11966.880331196924;12115.273083615011;11077.889221108007;11208.607698730506;11217.102631789601;11229.21395502307;11585.147093996624;9056.592453339485;9117.270618350649;9465.148136667733;9566.473843938371;9577.425354478753;8853.513056781681;9185.357025008185;9232.815343693223;9303.488308143116;9325.440473571607 11:35:23 INFO - PROCESS | 16588 | __end_tp_report 11:35:23 INFO - PROCESS | 16588 | __start_cc_report 11:35:23 INFO - PROCESS | 16588 | _x_x_mozilla_cycle_collect,1092 11:35:23 INFO - PROCESS | 16588 | __end_cc_report 11:35:23 INFO - PROCESS | 16588 | __startTimestamp1453750523077__endTimestamp 11:35:23 INFO - PROCESS | 16588 | 11:35:23 INFO - PROCESS | 16588 | ------- Summary: start ------- 11:35:23 INFO - PROCESS | 16588 | Number of tests: 6 11:35:23 INFO - PROCESS | 16588 | 11:35:23 INFO - PROCESS | 16588 | [#0] dojo.html Cycles:165 Average:5125.35 Median:5332.63 stddev:549.47 (10.3%) stddev-sans-first:528.72 11:35:23 INFO - PROCESS | 16588 | Values: 3144.3 3171.1 3219.4 3225.7 3244.4 4993.4 5010.0 5181.7 5190.1 5234.6 5143.1 5187.8 5200.6 5206.7 5220.2 4476.6 4632.0 4674.4 4722.4 4740.7 4543.6 4609.8 4691.6 4693.5 4809.0 4641.3 4724.1 4742.9 4750.7 4754.5 4646.2 4647.7 4660.7 4661.1 4695.8 4603.6 4646.4 4651.3 4656.7 4688.0 4946.1 4946.2 5010.9 5030.5 5053.1 5512.6 5534.1 5537.1 5537.7 5539.6 5420.1 5515.3 5543.3 5549.9 5594.2 5064.2 5224.4 5259.6 5264.4 5279.3 5632.4 5675.7 5682.9 5683.0 5729.6 5332.6 5413.5 5441.5 5483.0 5486.3 5388.6 5391.1 5409.0 5441.7 5458.7 5474.4 5484.8 5497.1 5499.1 5501.4 5211.7 5271.1 5420.9 5484.1 5532.1 4275.3 4293.1 4301.4 4323.4 4331.7 3837.1 3862.7 3872.2 3897.3 3907.4 4964.2 4993.7 5121.7 5124.2 5168.5 5516.0 5592.3 5608.3 5623.9 5631.5 5157.1 5159.4 5161.5 5164.3 5201.7 4695.4 4738.4 4751.0 4762.9 4775.2 5711.2 5732.3 5735.9 5737.6 5755.3 5538.7 5540.7 5542.6 5544.9 5547.3 5495.9 5564.1 5584.4 5623.4 5724.7 5476.6 5479.9 5490.7 5491.8 5519.4 5501.2 5544.2 5550.0 5553.1 5605.7 5374.5 5389.9 5441.6 5467.7 5485.1 5433.1 5436.6 5438.1 5442.8 5470.4 5338.4 5343.2 5346.1 5347.3 5396.9 5240.1 5284.6 5325.9 5326.3 5449.8 5303.4 5359.7 5360.2 5363.8 5385.7 11:35:23 INFO - PROCESS | 16588 | 11:35:23 INFO - PROCESS | 16588 | [#1] ext.html Cycles:180 Average:48763.60 Median:38185.02 stddev:90848.48 (237.9%) stddev-sans-first:91031.13 11:35:23 INFO - PROCESS | 16588 | Values: 524.3 555.3 569.6 576.4 579.7 27976.4 35526.8 36046.1 36114.0 36134.5 38758.0 39384.8 39405.8 39458.4 39510.2 8393.7 8560.0 8591.3 8614.9 8626.3 8182.9 8327.9 8333.0 8336.1 8339.7 8581.0 8683.0 8697.7 8702.9 8707.4 8472.5 8600.2 8609.1 8614.1 8628.9 8482.0 8639.0 8640.8 8648.5 8649.5 39897.6 40363.6 40464.0 40487.4 40496.4 3077.6 3159.1 3169.3 3298.4 3529.0 29807.9 29813.6 30374.0 30529.8 31797.8 3855.9 3910.5 3971.1 4004.8 4026.2 268851.0 270905.0 270924.0 271034.0 271550.6 40961.0 52336.0 53545.7 58831.7 59242.7 39233.4 39369.1 39371.8 39414.6 39435.7 12688.2 12812.7 12834.4 12835.7 12841.6 9501.4 9667.0 10505.8 10526.2 10709.5 13547.4 13624.7 13626.9 13650.5 13731.7 5557.9 5588.2 5635.9 5664.4 5691.7 860.8 899.8 905.1 932.4 1014.1 26175.0 26946.9 27360.6 27560.1 27965.2 1010.5 1071.4 1071.8 1076.1 1125.3 14379.2 14465.5 14501.1 14644.3 14757.1 329379.0 335129.0 337566.0 340437.0 341404.0 52022.0 52117.0 52611.0 52630.0 52692.5 1145.9 1166.4 1172.4 1186.4 1336.7 24897.9 26249.5 26368.7 26386.5 26402.3 39058.2 39582.2 39638.2 43254.4 43881.0 403157.0 410155.0 413516.0 414277.0 414540.0 32117.7 32671.7 32676.3 32705.2 32749.3 42677.6 43006.0 43509.0 43973.6 44105.0 35081.6 36849.0 37777.4 37999.6 38368.2 37209.4 38004.6 38082.2 38287.8 38322.6 35450.0 35937.0 36439.0 36694.0 36795.6 31279.8 33243.2 33775.5 34038.7 34418.3 21769.7 21882.0 22103.7 22113.7 22187.3 11:35:23 INFO - PROCESS | 16588 | 11:35:23 INFO - PROCESS | 16588 | [#2] jquery.html Cycles:180 Average:16099.22 Median:5200.40 stddev:26887.18 (517.0%) stddev-sans-first:26936.61 11:35:23 INFO - PROCESS | 16588 | Values: 353.1 353.6 359.9 361.2 369.2 14091.6 14227.2 15474.2 16442.4 17869.6 14541.9 14565.2 14634.6 14646.5 14776.0 5048.6 5236.5 5237.3 5247.1 5248.0 3638.9 3971.8 5147.5 5204.1 5420.4 5370.2 5382.6 5400.5 5415.8 5420.1 5196.7 5379.7 5388.1 5409.4 5426.3 4827.4 5033.9 5178.7 5179.1 5180.8 17973.4 18383.2 18564.0 18585.3 18822.8 1986.2 2001.3 2015.9 2072.4 2262.6 8718.7 8724.0 9422.7 9427.7 10209.8 1705.6 1747.5 1755.3 1801.7 1881.7 54720.2 55041.0 55346.7 56099.7 56144.4 9747.2 9771.8 9845.2 9862.1 9986.6 12562.0 12618.9 12715.4 12758.6 12771.5 7130.1 7211.9 7239.3 7240.5 7291.6 6880.0 6888.4 6906.9 6926.4 6942.1 4233.3 4281.3 4337.4 4442.5 4459.3 1649.7 1738.3 1762.7 1774.4 1775.3 837.6 850.3 924.4 925.4 943.0 12737.1 14188.9 14635.6 15392.0 15842.8 869.3 918.9 938.7 941.0 984.9 8269.6 8593.1 8658.7 8698.8 8698.8 146475.0 148422.3 149674.3 149862.0 150188.0 67159.3 68133.3 68372.0 69828.7 71908.6 1036.6 1051.0 1054.1 1055.9 1058.4 13668.9 13762.8 14056.0 14146.7 14169.2 26853.7 33246.5 33314.5 33673.8 35256.0 39521.6 40717.2 40781.8 41084.8 41328.0 6752.8 6865.4 6876.7 7010.7 7177.2 9857.6 10420.8 10567.0 10655.1 11325.7 9593.3 9640.8 9768.5 9802.2 9950.1 9738.8 9790.7 9984.7 9985.6 10171.0 6975.7 9164.4 9222.6 9773.9 9910.4 6821.4 7017.0 7070.5 7149.6 7165.6 8367.4 8792.4 9191.2 9225.5 9548.0 11:35:23 INFO - PROCESS | 16588 | 11:35:23 INFO - PROCESS | 16588 | [#3] mootools.html Cycles:180 Average:5694.47 Median:5905.65 stddev:3014.41 (51.0%) stddev-sans-first:3004.90 11:35:23 INFO - PROCESS | 16588 | Values: 1316.2 1473.4 1479.8 1638.2 1802.4 7164.7 7756.1 8000.1 8013.4 8019.3 7886.0 8042.2 8059.0 8065.5 8071.9 2012.9 2066.2 2069.6 2297.1 2331.1 2058.4 2295.5 2340.6 2342.1 2342.2 2260.1 2273.4 2284.0 2285.5 2318.7 2247.4 2262.9 2272.4 2277.8 2278.0 2299.2 2309.9 2310.9 2312.6 2324.0 8097.8 8142.6 8148.7 8157.1 8160.5 4732.2 4783.5 4799.0 4809.6 4837.9 3140.9 3158.8 3254.9 3262.8 3263.8 1075.9 1085.5 1090.6 1091.3 1109.2 11649.1 11654.4 11661.7 11699.6 11779.8 4453.1 4474.7 4524.8 4528.5 4576.9 9926.7 9931.3 9941.9 9956.3 9957.2 4844.3 4855.2 4871.1 4874.7 4874.9 4401.1 4403.4 4407.2 4413.9 4415.4 3510.7 3573.3 3818.9 3874.3 3914.9 1208.7 1209.6 1214.8 1214.8 1225.3 1272.8 1281.7 1294.2 1304.1 1331.0 7366.6 7430.6 7449.1 7452.7 7456.9 1071.7 1082.8 1084.1 1106.3 1116.7 5822.7 5892.6 5900.5 5900.6 5910.7 9603.5 9749.6 9931.0 10041.4 10066.1 9797.1 9922.8 9941.8 9962.4 9964.2 7450.3 7644.1 7699.1 7699.3 7708.8 7510.6 7601.5 7691.3 7698.6 7708.7 8692.4 8773.6 8860.3 8930.7 8958.5 8733.4 9062.2 9199.2 9202.4 9210.4 6924.5 7070.9 7071.2 7082.3 7082.8 6802.5 6854.3 7605.7 7706.7 7760.1 7074.5 7153.6 7198.6 7271.2 7371.3 7168.9 7247.2 7313.0 7358.8 7450.5 7145.0 7334.0 7410.7 7437.4 7440.4 6791.2 6792.5 6803.7 6819.8 6831.7 6918.3 6957.4 6964.4 6967.0 6972.8 11:35:23 INFO - PROCESS | 16588 | 11:35:23 INFO - PROCESS | 16588 | [#4] prototype.html Cycles:180 Average:5295.08 Median:5888.85 stddev:1566.65 (26.6%) stddev-sans-first:1526.17 11:35:23 INFO - PROCESS | 16588 | Values: 334.8 335.8 342.3 343.4 348.3 5797.1 5930.3 5952.6 5964.0 6014.5 5713.1 5814.9 5834.1 5877.0 5897.0 4568.7 4580.3 4630.0 4636.6 4637.0 4371.4 4464.2 4494.8 4583.7 4609.4 4549.6 4573.2 4581.8 4581.9 4599.4 4581.7 4584.7 4586.3 4596.4 4602.9 4067.6 4068.5 4068.6 4072.1 4072.3 5561.2 5651.0 5665.8 5695.2 5726.4 5355.3 5356.1 5357.3 5360.0 5367.6 6019.2 6341.7 6345.1 6355.0 6355.9 4382.5 4386.5 4476.0 4511.9 4516.9 6478.7 6537.8 6562.8 6582.2 6590.6 4608.3 4612.7 4617.4 4617.7 4618.4 4504.8 4638.3 4661.1 4667.7 4673.6 5342.4 5342.9 5357.9 5361.8 5368.4 6333.8 6342.7 6343.6 6343.6 6356.7 1606.9 1661.1 1662.2 1662.4 1663.3 1091.5 1123.9 1132.1 1132.2 1149.8 5878.9 5957.0 5962.5 5965.9 5966.2 6441.7 6449.9 6457.0 6458.6 6467.8 5743.7 5764.7 5804.3 5853.9 5880.7 3403.9 3481.1 3483.0 3485.7 3489.6 6581.5 6629.4 6653.6 6654.9 6655.4 6546.2 6575.8 6576.8 6583.5 6595.2 6494.3 6653.2 6655.3 6657.3 6661.9 6161.5 6388.2 6395.6 6412.7 6430.2 6475.9 6492.2 6499.6 6504.4 6505.9 6774.4 6803.5 6812.0 6815.7 6818.4 4646.8 4681.7 4720.6 4724.3 4733.6 6542.1 6543.2 6543.5 6546.6 6563.1 6360.3 6361.7 6362.5 6364.7 6370.5 6172.1 6371.7 6384.6 6384.7 6400.8 6284.9 6287.7 6289.3 6290.9 6293.7 6423.2 6491.2 6493.3 6498.6 6504.0 6117.8 6259.6 6272.7 6275.4 6292.6 11:35:23 INFO - PROCESS | 16588 | 11:35:23 INFO - PROCESS | 16588 | [#5] yui.html Cycles:180 Average:13767.59 Median:48786.57 stddev:16183.00 (33.2%) stddev-sans-first:16198.64 11:35:23 INFO - PROCESS | 16588 | Values: 699.1 737.5 740.9 789.3 792.0 12891.5 13027.8 13057.9 13062.9 13093.2 11296.9 12873.9 12967.2 12979.4 13004.8 665.8 674.9 792.6 795.5 804.3 785.4 790.7 791.4 794.5 795.0 846.8 848.7 849.8 850.2 851.0 690.0 695.5 835.7 851.7 855.1 627.0 628.1 628.7 628.9 628.9 12866.5 12887.5 12954.5 12960.5 12963.8 11987.5 12180.7 12222.7 12312.5 12424.2 9848.3 9869.5 10005.9 10325.1 10450.0 3487.1 3498.5 3521.9 3543.1 3672.5 48106.8 48548.8 48695.1 48878.0 48912.0 9177.6 9393.6 9489.7 9494.3 9564.2 18429.3 18462.1 18498.3 18499.9 18500.5 6894.1 6963.2 7018.8 7178.3 7346.5 4126.2 4198.7 4212.7 4251.9 4286.8 3057.1 3119.3 3122.1 3127.5 3127.5 560.1 564.4 566.7 582.8 587.8 527.0 582.9 599.9 607.7 629.4 8222.0 8940.0 8950.2 9021.7 9342.2 654.6 660.5 669.1 672.1 673.9 3820.9 3857.4 3919.2 3994.8 4011.2 59874.7 60345.7 60428.7 60827.7 61751.7 49245.0 50073.5 50163.0 50287.5 50773.0 45535.8 45978.3 46456.3 46954.8 47270.3 8238.4 8320.8 8443.7 8509.4 8524.1 34169.0 34787.8 34809.5 34944.7 35039.5 41745.0 45261.0 45609.0 45716.8 45720.3 10895.7 11038.6 11046.9 11047.7 11056.8 12023.6 12076.5 12159.8 12626.6 13085.6 10719.3 10905.9 10909.4 10987.2 11007.2 11534.9 11599.7 11654.7 11966.9 12115.3 11077.9 11208.6 11217.1 11229.2 11585.1 9056.6 9117.3 9465.1 9566.5 9577.4 8853.5 9185.4 9232.8 9303.5 9325.4 11:35:23 INFO - PROCESS | 16588 | -------- Summary: end -------- 11:35:23 INFO - PROCESS | 16588 | 11:35:23 INFO - TEST-INFO | 16588: exit 0 11:35:23 INFO - TEST-OK | dromaeo_css | took 1112588ms 11:35:23 INFO - TEST-START | kraken 11:35:23 INFO - operating with platform_type : linux_ 11:35:23 INFO - Initialising browser for kraken test... 11:35:23 INFO - TEST-INFO | started process 16787 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsGBfL0/profile http://localhost:50526/getInfo.html) 11:35:27 INFO - PROCESS | 16787 | __metrics Screen width/height:1600/1200 11:35:27 INFO - PROCESS | 16787 | colorDepth:24 11:35:27 INFO - PROCESS | 16787 | Browser inner width/height: 1024/697 11:35:27 INFO - PROCESS | 16787 | __metrics 11:35:27 INFO - PROCESS | 16787 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:35:27 INFO - PROCESS | 16787 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:35:28 INFO - TEST-INFO | 16787: exit 0 11:35:28 INFO - Browser initialized. 11:35:28 INFO - Running cycle 1/1 for kraken test... 11:35:28 INFO - TEST-INFO | started process 16867 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsGBfL0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:35:40 INFO - PROCESS | 16867 | RSS: Main: 147648512 11:35:40 INFO - PROCESS | 16867 | 11:35:42 INFO - PROCESS | 16867 | Cycle 1(1): loaded http://localhost:50526/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50526/tests/kraken/driver.html?testName=audio-beat-detection) 11:35:43 INFO - PROCESS | 16867 | RSS: Main: 187924480 11:35:43 INFO - PROCESS | 16867 | 11:35:46 INFO - PROCESS | 16867 | Cycle 1(1): loaded http://localhost:50526/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50526/tests/kraken/driver.html?testName=audio-dft) 11:35:46 INFO - PROCESS | 16867 | RSS: Main: 177831936 11:35:46 INFO - PROCESS | 16867 | 11:35:49 INFO - PROCESS | 16867 | Cycle 1(1): loaded http://localhost:50526/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50526/tests/kraken/driver.html?testName=audio-fft) 11:35:50 INFO - PROCESS | 16867 | RSS: Main: 163594240 11:35:50 INFO - PROCESS | 16867 | 11:35:52 INFO - PROCESS | 16867 | Cycle 1(1): loaded http://localhost:50526/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50526/tests/kraken/driver.html?testName=audio-oscillator) 11:35:52 INFO - PROCESS | 16867 | RSS: Main: 166764544 11:35:52 INFO - PROCESS | 16867 | 11:35:54 INFO - PROCESS | 16867 | Cycle 1(1): loaded http://localhost:50526/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50526/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:35:55 INFO - PROCESS | 16867 | RSS: Main: 166617088 11:35:55 INFO - PROCESS | 16867 | 11:35:58 INFO - PROCESS | 16867 | Cycle 1(1): loaded http://localhost:50526/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50526/tests/kraken/driver.html?testName=imaging-darkroom) 11:35:59 INFO - PROCESS | 16867 | RSS: Main: 167030784 11:35:59 INFO - PROCESS | 16867 | 11:36:02 INFO - PROCESS | 16867 | Cycle 1(1): loaded http://localhost:50526/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50526/tests/kraken/driver.html?testName=imaging-desaturate) 11:36:03 INFO - PROCESS | 16867 | RSS: Main: 168644608 11:36:03 INFO - PROCESS | 16867 | 11:36:05 INFO - PROCESS | 16867 | Cycle 1(1): loaded http://localhost:50526/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50526/tests/kraken/driver.html?testName=json-parse-financial) 11:36:06 INFO - PROCESS | 16867 | RSS: Main: 167317504 11:36:06 INFO - PROCESS | 16867 | 11:36:07 INFO - PROCESS | 16867 | Cycle 1(1): loaded http://localhost:50526/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50526/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:36:08 INFO - PROCESS | 16867 | RSS: Main: 179826688 11:36:08 INFO - PROCESS | 16867 | 11:36:10 INFO - PROCESS | 16867 | Cycle 1(1): loaded http://localhost:50526/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50526/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:36:10 INFO - PROCESS | 16867 | RSS: Main: 177025024 11:36:10 INFO - PROCESS | 16867 | 11:36:12 INFO - PROCESS | 16867 | Cycle 1(1): loaded http://localhost:50526/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50526/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:36:13 INFO - PROCESS | 16867 | RSS: Main: 183738368 11:36:13 INFO - PROCESS | 16867 | 11:36:15 INFO - PROCESS | 16867 | Cycle 1(1): loaded http://localhost:50526/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50526/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:36:16 INFO - PROCESS | 16867 | RSS: Main: 189763584 11:36:16 INFO - PROCESS | 16867 | 11:36:19 INFO - PROCESS | 16867 | Cycle 1(1): loaded http://localhost:50526/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50526/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:36:19 INFO - PROCESS | 16867 | RSS: Main: 189698048 11:36:19 INFO - PROCESS | 16867 | 11:36:21 INFO - PROCESS | 16867 | Cycle 1(1): loaded http://localhost:50526/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50526/tests/kraken/driver.html?testName=ai-astar) 11:36:21 INFO - PROCESS | 16867 | RSS: Main: 250949632 11:36:21 INFO - PROCESS | 16867 | 11:36:21 INFO - PROCESS | 16867 | __start_tp_report 11:36:21 INFO - PROCESS | 16867 | _x_x_mozilla_page_load 11:36:21 INFO - PROCESS | 16867 | _x_x_mozilla_page_load_details 11:36:21 INFO - PROCESS | 16867 | |i|pagename|runs| 11:36:21 INFO - PROCESS | 16867 | |0;ai-astar;111;111;107;110;110;110;110;110;103;110 11:36:21 INFO - PROCESS | 16867 | |1;audio-beat-detection;153;128;153;171;127;159;150;132;170;126 11:36:21 INFO - PROCESS | 16867 | |2;audio-dft;161;161;162;162;163;161;161;160;161;162 11:36:21 INFO - PROCESS | 16867 | |3;audio-fft;73;74;97;98;80;73;73;123;96;73 11:36:21 INFO - PROCESS | 16867 | |4;audio-oscillator;96;102;143;94;95;95;153;95;94;140 11:36:21 INFO - PROCESS | 16867 | |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;109;109 11:36:21 INFO - PROCESS | 16867 | |6;imaging-darkroom;147;145;146;146;146;147;145;145;146;145 11:36:21 INFO - PROCESS | 16867 | |7;imaging-desaturate;96;96;95;96;96;95;103;95;96;96 11:36:21 INFO - PROCESS | 16867 | |8;json-parse-financial;57;58;56;56;55;56;56;55;58;53 11:36:21 INFO - PROCESS | 16867 | |9;json-stringify-tinderbox;66;68;68;66;68;69;67;67;67;67 11:36:21 INFO - PROCESS | 16867 | |10;stanford-crypto-aes;88;83;84;103;83;93;84;82;91;85 11:36:21 INFO - PROCESS | 16867 | |11;stanford-crypto-ccm;119;122;120;116;115;117;126;130;115;114 11:36:21 INFO - PROCESS | 16867 | |12;stanford-crypto-pbkdf2;144;135;156;135;145;131;146;148;134;144 11:36:21 INFO - PROCESS | 16867 | |13;stanford-crypto-sha256-iterative;67;66;69;68;67;67;69;68;67;68 11:36:21 INFO - PROCESS | 16867 | __end_tp_report 11:36:21 INFO - PROCESS | 16867 | __start_cc_report 11:36:21 INFO - PROCESS | 16867 | _x_x_mozilla_cycle_collect,936 11:36:21 INFO - PROCESS | 16867 | __end_cc_report 11:36:21 INFO - PROCESS | 16867 | __startTimestamp1453750581586__endTimestamp 11:36:21 INFO - PROCESS | 16867 | 11:36:21 INFO - PROCESS | 16867 | ------- Summary: start ------- 11:36:21 INFO - PROCESS | 16867 | Number of tests: 14 11:36:21 INFO - PROCESS | 16867 | 11:36:21 INFO - PROCESS | 16867 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:2.44 (2.2%) stddev-sans-first:2.50 11:36:21 INFO - PROCESS | 16867 | Values: 111.0 111.0 107.0 110.0 110.0 110.0 110.0 110.0 103.0 110.0 11:36:21 INFO - PROCESS | 16867 | 11:36:21 INFO - PROCESS | 16867 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:153.00 stddev:17.50 (11.4%) stddev-sans-first:18.42 11:36:21 INFO - PROCESS | 16867 | Values: 153.0 128.0 153.0 171.0 127.0 159.0 150.0 132.0 170.0 126.0 11:36:21 INFO - PROCESS | 16867 | 11:36:21 INFO - PROCESS | 16867 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.84 (0.5%) stddev-sans-first:0.88 11:36:21 INFO - PROCESS | 16867 | Values: 161.0 161.0 162.0 162.0 163.0 161.0 161.0 160.0 161.0 162.0 11:36:21 INFO - PROCESS | 16867 | 11:36:21 INFO - PROCESS | 16867 | [#3] audio-fft Cycles:10 Average:86.00 Median:77.00 stddev:16.96 (22.0%) stddev-sans-first:17.33 11:36:21 INFO - PROCESS | 16867 | Values: 73.0 74.0 97.0 98.0 80.0 73.0 73.0 123.0 96.0 73.0 11:36:21 INFO - PROCESS | 16867 | 11:36:21 INFO - PROCESS | 16867 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:94.50 stddev:24.22 (25.6%) stddev-sans-first:25.10 11:36:21 INFO - PROCESS | 16867 | Values: 96.0 102.0 143.0 94.0 95.0 95.0 153.0 95.0 94.0 140.0 11:36:21 INFO - PROCESS | 16867 | 11:36:21 INFO - PROCESS | 16867 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 11:36:21 INFO - PROCESS | 16867 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 11:36:21 INFO - PROCESS | 16867 | 11:36:21 INFO - PROCESS | 16867 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 11:36:21 INFO - PROCESS | 16867 | Values: 147.0 145.0 146.0 146.0 146.0 147.0 145.0 145.0 146.0 145.0 11:36:21 INFO - PROCESS | 16867 | 11:36:21 INFO - PROCESS | 16867 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:2.37 (2.5%) stddev-sans-first:2.51 11:36:21 INFO - PROCESS | 16867 | Values: 96.0 96.0 95.0 96.0 96.0 95.0 103.0 95.0 96.0 96.0 11:36:21 INFO - PROCESS | 16867 | 11:36:21 INFO - PROCESS | 16867 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:1.49 (2.7%) stddev-sans-first:1.54 11:36:21 INFO - PROCESS | 16867 | Values: 57.0 58.0 56.0 56.0 55.0 56.0 56.0 55.0 58.0 53.0 11:36:21 INFO - PROCESS | 16867 | 11:36:21 INFO - PROCESS | 16867 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.50 stddev:0.95 (1.4%) stddev-sans-first:0.88 11:36:21 INFO - PROCESS | 16867 | Values: 66.0 68.0 68.0 66.0 68.0 69.0 67.0 67.0 67.0 67.0 11:36:21 INFO - PROCESS | 16867 | 11:36:21 INFO - PROCESS | 16867 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:84.50 stddev:6.54 (7.7%) stddev-sans-first:6.93 11:36:21 INFO - PROCESS | 16867 | Values: 88.0 83.0 84.0 103.0 83.0 93.0 84.0 82.0 91.0 85.0 11:36:21 INFO - PROCESS | 16867 | 11:36:21 INFO - PROCESS | 16867 | [#11] stanford-crypto-ccm Cycles:10 Average:119.40 Median:119.50 stddev:5.25 (4.4%) stddev-sans-first:5.57 11:36:21 INFO - PROCESS | 16867 | Values: 119.0 122.0 120.0 116.0 115.0 117.0 126.0 130.0 115.0 114.0 11:36:21 INFO - PROCESS | 16867 | 11:36:21 INFO - PROCESS | 16867 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.80 Median:144.50 stddev:7.80 (5.4%) stddev-sans-first:8.23 11:36:21 INFO - PROCESS | 16867 | Values: 144.0 135.0 156.0 135.0 145.0 131.0 146.0 148.0 134.0 144.0 11:36:21 INFO - PROCESS | 16867 | 11:36:21 INFO - PROCESS | 16867 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:0.97 (1.4%) stddev-sans-first:1.00 11:36:21 INFO - PROCESS | 16867 | Values: 67.0 66.0 69.0 68.0 67.0 67.0 69.0 68.0 67.0 68.0 11:36:21 INFO - PROCESS | 16867 | -------- Summary: end -------- 11:36:21 INFO - PROCESS | 16867 | 11:36:22 INFO - TEST-INFO | 16867: exit 0 11:36:22 INFO - TEST-OK | kraken | took 58832ms 11:36:22 INFO - TEST-START | v8_7 11:36:22 INFO - operating with platform_type : linux_ 11:36:22 INFO - Initialising browser for v8_7 test... 11:36:22 INFO - TEST-INFO | started process 17114 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnQM0rk/profile http://localhost:50526/getInfo.html) 11:36:26 INFO - PROCESS | 17114 | __metrics Screen width/height:1600/1200 11:36:26 INFO - PROCESS | 17114 | colorDepth:24 11:36:26 INFO - PROCESS | 17114 | Browser inner width/height: 1024/697 11:36:26 INFO - PROCESS | 17114 | __metrics 11:36:26 INFO - PROCESS | 17114 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:36:26 INFO - PROCESS | 17114 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:36:27 INFO - TEST-INFO | 17114: exit 0 11:36:27 INFO - Browser initialized. 11:36:27 INFO - Running cycle 1/1 for v8_7 test... 11:36:27 INFO - TEST-INFO | started process 17200 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnQM0rk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:36:39 INFO - PROCESS | 17200 | RSS: Main: 148344832 11:36:39 INFO - PROCESS | 17200 | 11:37:01 INFO - PROCESS | 17200 | Cycle 1(1): loaded http://localhost:50526/tests/v8_7/run.html (next: http://localhost:50526/tests/v8_7/run.html) 11:37:01 INFO - PROCESS | 17200 | RSS: Main: 569204736 11:37:01 INFO - PROCESS | 17200 | 11:37:01 INFO - PROCESS | 17200 | __start_tp_report 11:37:01 INFO - PROCESS | 17200 | _x_x_mozilla_page_load 11:37:01 INFO - PROCESS | 17200 | _x_x_mozilla_page_load_details 11:37:01 INFO - PROCESS | 17200 | |i|pagename|runs| 11:37:01 INFO - PROCESS | 17200 | |0;Richards;167.58840288252054 11:37:01 INFO - PROCESS | 17200 | |1;DeltaBlue;191.27773527161438 11:37:01 INFO - PROCESS | 17200 | |2;Encrypt;281.214848143982 11:37:01 INFO - PROCESS | 17200 | |3;Decrypt;5251.308900523561 11:37:01 INFO - PROCESS | 17200 | |4;RayTrace;1113.5857461024498 11:37:01 INFO - PROCESS | 17200 | |5;Earley;794.2811755361398 11:37:01 INFO - PROCESS | 17200 | |6;Boyer;12268.292682926829 11:37:01 INFO - PROCESS | 17200 | |7;RegExp;43270.833333333336 11:37:01 INFO - PROCESS | 17200 | |8;Splay;619.9628022318661 11:37:01 INFO - PROCESS | 17200 | |9;NavierStokes;4850.241545893719 11:37:01 INFO - PROCESS | 17200 | __end_tp_report 11:37:01 INFO - PROCESS | 17200 | __startTimestamp1453750621908__endTimestamp 11:37:01 INFO - PROCESS | 17200 | 11:37:01 INFO - PROCESS | 17200 | ------- Summary: start ------- 11:37:01 INFO - PROCESS | 17200 | Number of tests: 10 11:37:01 INFO - PROCESS | 17200 | 11:37:01 INFO - PROCESS | 17200 | [#0] Richards Cycles:1 Average:167.59 Median:167.59 stddev:0.00 (0.0%) 11:37:01 INFO - PROCESS | 17200 | Values: 167.6 11:37:01 INFO - PROCESS | 17200 | 11:37:01 INFO - PROCESS | 17200 | [#1] DeltaBlue Cycles:1 Average:191.28 Median:191.28 stddev:0.00 (0.0%) 11:37:01 INFO - PROCESS | 17200 | Values: 191.3 11:37:01 INFO - PROCESS | 17200 | 11:37:01 INFO - PROCESS | 17200 | [#2] Encrypt Cycles:1 Average:281.21 Median:281.21 stddev:0.00 (0.0%) 11:37:01 INFO - PROCESS | 17200 | Values: 281.2 11:37:01 INFO - PROCESS | 17200 | 11:37:01 INFO - PROCESS | 17200 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 11:37:01 INFO - PROCESS | 17200 | Values: 5251.3 11:37:01 INFO - PROCESS | 17200 | 11:37:01 INFO - PROCESS | 17200 | [#4] RayTrace Cycles:1 Average:1113.59 Median:1113.59 stddev:0.00 (0.0%) 11:37:01 INFO - PROCESS | 17200 | Values: 1113.6 11:37:01 INFO - PROCESS | 17200 | 11:37:01 INFO - PROCESS | 17200 | [#5] Earley Cycles:1 Average:794.28 Median:794.28 stddev:0.00 (0.0%) 11:37:01 INFO - PROCESS | 17200 | Values: 794.3 11:37:01 INFO - PROCESS | 17200 | 11:37:01 INFO - PROCESS | 17200 | [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 11:37:01 INFO - PROCESS | 17200 | Values: 12268.3 11:37:01 INFO - PROCESS | 17200 | 11:37:01 INFO - PROCESS | 17200 | [#7] RegExp Cycles:1 Average:43270.83 Median:43270.83 stddev:0.00 (0.0%) 11:37:01 INFO - PROCESS | 17200 | Values: 43270.8 11:37:01 INFO - PROCESS | 17200 | 11:37:01 INFO - PROCESS | 17200 | [#8] Splay Cycles:1 Average:619.96 Median:619.96 stddev:0.00 (0.0%) 11:37:01 INFO - PROCESS | 17200 | Values: 620.0 11:37:01 INFO - PROCESS | 17200 | 11:37:01 INFO - PROCESS | 17200 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 11:37:01 INFO - PROCESS | 17200 | Values: 4850.2 11:37:01 INFO - PROCESS | 17200 | -------- Summary: end -------- 11:37:01 INFO - PROCESS | 17200 | 11:37:02 INFO - TEST-INFO | 17200: exit 0 11:37:02 INFO - TEST-OK | v8_7 | took 40261ms 11:37:02 INFO - SUITE-END | took 1211s 11:37:02 INFO - Completed test suite (00:20:11) 11:37:02 INFO - Working with test: dromaeo_css 11:37:02 INFO - Generating results file: dromaeo_css 11:37:02 INFO - Working with test: kraken 11:37:02 INFO - Generating results file: kraken 11:37:02 INFO - javascript benchmark 11:37:02 INFO - Working with test: v8_7 11:37:02 INFO - Generating results file: v8_7 11:37:02 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:37:02 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 11:37:02 INFO - process_Request line: dromaeo_css 6733.29 graph.html#tests=[[72,64,35]] 11:37:02 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:37:03 INFO - process_Request line: kraken 1505.10 graph.html#tests=[[232,64,35]] 11:37:03 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:37:03 INFO - process_Request line: v8_7 19845.70 graph.html#tests=[[230,64,35]] 11:37:03 INFO - RETURN: dromaeo_css: 6733.29 11:37:03 INFO - RETURN: kraken: 1505.10 11:37:03 INFO - RETURN: v8_7: 19845.70 11:37:03 INFO - javascript benchmark 11:37:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3144.2768163322435, 3171.0803866878605, 3219.4205043092247, 3225.6935591118836, 3244.3673483670677, 4993.350864387625, 5010.0, 5181.740912954356, 5190.1176799944005, 5234.607404444668, 5143.09995750744, 5187.792488300463, 5200.583953283738, 5206.739663016843, 5220.243064755608, 4476.6418686505, 4631.976840115794, 4674.3923289972345, 4722.409698787652, 4740.691855029412, 4543.613792827614, 4609.792559334821, 4691.554302341289, 4693.460252071004, 4809.0, 4641.25739881619, 4724.149653062447, 4742.857714268577, 4750.691205071659, 4754.524547545235, 4646.186917289495, 4647.651426143053, 4660.743659098748, 4661.114388266218, 4695.835645752416, 4603.608693261077, 4646.4191976003, 4651.279051746985, 4656.650751193674, 4688.0, 4946.060248552763, 4946.159152944008, 5010.949890501085, 5030.496950304977, 5053.065182941167, 5512.641678290898, 5534.059209934321, 5537.141743029837, 5537.695426751527, 5539.584531160179, 5420.13277875538, 5515.338159420855, 5543.279373681436, 5549.889002219933, 5594.188842617838, 5064.215046667772, 5224.425313215544, 5259.552938000313, 5264.394594621591, 5279.287296215039, 5632.3804381518, 5675.687837168995, 5682.948654498931, 5683.0338842396895, 5729.598928074995, 5332.626716129911, 5413.458654134633, 5441.5102640762525, 5483.040467918178, 5486.341639003345, 5388.595855310868, 5391.056565101092, 5408.972955135199, 5441.700706461183, 5458.6724796512335, 5474.39781624021, 5484.808031718871, 5497.065498865202, 5499.1476321170285, 5501.394846566875, 5211.687298762086, 5271.1039123348355, 5420.868552892825, 5484.149956756709, 5532.087205611109, 4275.294576394922, 4293.0769884474985, 4301.354796780445, 4323.373110898902, 4331.696781225347, 3837.1174629835295, 3862.748921320105, 3872.2120321905786, 3897.337452633059, 3907.433422153772, 4964.205727083649, 4993.725345105981, 5121.743912804345, 5124.205748109049, 5168.53483186515, 5515.979543784413, 5592.328920529562, 5608.327000759853, 5623.8594035149445, 5631.521320687705, 5157.123289040872, 5159.432462429129, 5161.458046905096, 5164.2770012198325, 5201.661891977009, 4695.413073365829, 4738.407699037621, 4751.026039661861, 4762.904741905142, 4775.2359622460235, 5711.200431939532, 5732.283464566929, 5735.913961290584, 5737.627054241544, 5755.3381361144, 5538.695371754592, 5540.722963851872, 5542.556595472433, 5544.944550554443, 5547.278853749148, 5495.945040549704, 5564.10974244119, 5584.3857175711455, 5623.437656234344, 5724.685142317213, 5476.589255805751, 5479.890402192013, 5490.6980116094, 5491.752871120889, 5519.448055194448, 5501.229827824028, 5544.223808666709, 5549.972250138723, 5553.0559804832465, 5605.663660180402, 5374.516293533445, 5389.919151212814, 5441.591880609049, 5467.72661366938, 5485.122380419114, 5433.076377015837, 5436.646617969819, 5438.102713052302, 5442.809501667581, 5470.370907345547, 5338.3593968724, 5343.198520221842, 5346.064438723286, 5347.278117454094, 5396.9190462142315, 5240.082985477602, 5284.550813180923, 5325.9467405327005, 5326.334208223972, 5449.754761035842, 5303.416624171416, 5359.678419294854, 5360.2227676987395, 5363.758630861698, 5385.703786291791], "unit": "score", "name": "dojo.html", "value": 5091.635957766189}, {"lowerIsBetter": false, "replicates": [524.3131497737961, 555.339146415765, 569.5671289819737, 576.3832699012057, 579.7130420441882, 27976.440471190588, 35526.82236588817, 36046.09884752879, 36114.0, 36134.457983130276, 38758.0, 39384.80307598465, 39405.8029709851, 39458.408123878165, 39510.20979580407, 8393.664253429855, 8559.957200214021, 8591.26974207193, 8614.913850861505, 8626.3098952084, 8182.877256841152, 8327.916720832805, 8333.041700204463, 8336.124706905748, 8339.708110216143, 8581.0, 8683.0, 8697.695580654678, 8702.912970870273, 8707.434016788888, 8472.491650500959, 8600.182982616641, 8609.139086091434, 8614.05245423003, 8628.870566941501, 8481.957590212009, 8638.956805215996, 8640.827183456358, 8648.524331161783, 8649.524276164808, 39897.60102398968, 40363.596364036275, 40464.0, 40487.392689109685, 40496.39255411171, 3077.553754705555, 3159.1154476746547, 3169.3344397676515, 3298.4392653249006, 3528.9589571076594, 29807.850960745276, 29813.552796708067, 30374.0, 30529.847350763102, 31797.84101079503, 3855.9421608675893, 3910.511186101737, 3971.126352202511, 4004.83980640774, 4026.235015347104, 268851.0, 270905.0, 270924.0, 271034.0, 271550.6422467895, 40961.0, 52336.0, 53545.73227133839, 58831.70584147052, 59242.70378648165, 39233.41149882754, 39369.06309369097, 39371.80314098469, 39414.60585394167, 39435.67618371483, 12688.175268607696, 12812.743745125046, 12834.422450989729, 12835.743285134246, 12841.614751557468, 9501.382410143457, 9666.95166524163, 10505.789884202273, 10526.157907367393, 10709.518071686793, 13547.390367433489, 13624.727505449835, 13626.931865340808, 13650.453981840814, 13731.656708582166, 5557.944420555824, 5588.161775733673, 5635.859103522363, 5664.376918538957, 5691.68695721731, 860.8020155364301, 899.8290324838259, 905.090384163911, 932.3566738950103, 1014.0569270578286, 26175.0, 26946.865265673547, 27360.58959115615, 27560.10618884988, 27965.16104516868, 1010.5301035018751, 1071.4053700196466, 1071.796358691846, 1076.0853274716428, 1125.2685754259633, 14379.209143496999, 14465.49370772018, 14501.071090519688, 14644.315903671, 14757.114573125433, 329379.0, 335129.0, 337566.0, 340437.0, 341404.0, 52022.0, 52117.0, 52611.0, 52630.0, 52692.473075269525, 1145.9083273338113, 1166.4401087478059, 1172.4430895324654, 1186.3890096600257, 1336.6992426704107, 24897.875510622333, 26249.4750104993, 26368.73631263663, 26386.472270554867, 26402.339941501617, 39058.218835623695, 39582.208355833296, 39638.2072358557, 43254.351184732885, 43881.0, 403157.0, 410155.0, 413516.0, 414277.0, 414540.0, 32117.6788232124, 32671.73282671714, 32676.34647307088, 32705.18237044093, 32749.345013100083, 42677.5732242686, 43006.0, 43509.0, 43973.56026439695, 44105.0, 35081.64918350784, 36849.0, 37777.433338499395, 37999.620003800715, 38368.2326353477, 37209.44185837269, 38004.619953801215, 38082.2383552333, 38287.80856095702, 38322.616773831905, 35450.0, 35937.0, 36439.0, 36694.0, 36795.63204367922, 31279.84360078185, 33243.179738938205, 33775.49336759902, 34038.65961340355, 34418.311633767684, 21769.67345489787, 21882.0, 22103.668444973016, 22113.668294975265, 22187.334379968626], "unit": "score", "name": "ext.html", "value": 17533.12521321543}, {"lowerIsBetter": false, "replicates": [353.08198683423103, 353.6410543298552, 359.9244158726667, 361.15850069338427, 369.1712106321309, 14091.577252682411, 14227.21750303733, 15474.226288685562, 16442.42451514197, 17869.55326116846, 14541.854581454183, 14565.198914059722, 14634.634134146625, 14646.487372941949, 14776.0, 5048.596112311006, 5236.450172731866, 5237.266782650441, 5247.134222853225, 5247.973760131194, 3638.909027274326, 3971.7616942983514, 5147.510986456299, 5204.115300398941, 5420.403755586883, 5370.248165256867, 5382.596305277119, 5400.513953744162, 5415.83752487426, 5420.105682562373, 5196.68819870809, 5379.704116273584, 5388.110961691316, 5409.350877894639, 5426.348838139429, 4827.372441582607, 5033.874153146164, 5178.689278643294, 5179.067767801795, 5180.818671346522, 17973.37093201732, 18383.172757225955, 18564.0, 18585.256589736393, 18822.81177188238, 1986.1757370691146, 2001.2988959384552, 2015.899205039757, 2072.430081727522, 2262.6266666000092, 8718.738437846874, 8723.956380218122, 9422.717318480456, 9427.670031548863, 10209.795804083951, 1705.6077102266547, 1747.484492074841, 1755.3154269834774, 1801.7297405389165, 1881.6895212289955, 54720.17919731207, 55041.0, 55346.723266383815, 56099.71950140264, 56144.43855561474, 9747.171490423252, 9771.840737452283, 9845.227858985309, 9862.112409883144, 9986.600535978625, 12562.0, 12618.864302212845, 12715.364231788373, 12758.553450629184, 12771.489140434465, 7130.073090498306, 7211.89182162268, 7239.348458638748, 7240.52936559122, 7291.562506249642, 6879.965600171967, 6888.448924086061, 6906.8618627628175, 6926.376626103674, 6942.097527321416, 4233.322668373107, 4281.293586558183, 4337.436133302651, 4442.511323754385, 4459.2865141577195, 1649.690433393235, 1738.2873022060894, 1762.7091529897423, 1774.3967051202653, 1775.3076300242915, 837.6146972392646, 850.2900078434576, 924.3529529329496, 925.3846192282192, 943.0428115462811, 12737.108402411928, 14188.929055354658, 14635.634109147357, 15392.0, 15842.841571584137, 869.2958703450225, 918.8989211186764, 938.7043081429327, 940.9811803763887, 984.8965858584888, 8269.62786674601, 8593.140685931357, 8658.653653853902, 8698.782530436789, 8698.826023479494, 146475.0, 148422.25788870986, 149674.25162874116, 149862.0, 150188.0, 67159.32840671629, 68133.3186668127, 68372.0, 69828.6508567464, 71908.64045679843, 1036.6060896859144, 1051.0488008352454, 1054.146141625286, 1055.936643801359, 1058.4125810175274, 13668.93165534166, 13762.793558096437, 14056.0, 14146.717065658835, 14169.22069286158, 26853.731462685122, 33246.50130248097, 33314.5002824953, 33673.83163084169, 35256.0, 39521.60478395294, 40717.1856562873, 40781.796091020544, 41084.79457602693, 41328.0, 6752.831179220559, 6865.41643960269, 6876.724931002904, 7010.684519196547, 7177.246389129066, 9857.556409961713, 10420.843687344848, 10567.0, 10655.13470523915, 11325.716857078309, 9593.28050396237, 9640.75898102553, 9768.511574421109, 9802.166815820736, 9950.10449059588, 9738.81585193393, 9790.657326993522, 9984.650537231162, 9985.550650220612, 10171.0, 6975.720971161097, 9164.404313719588, 9222.584983675617, 9773.9022609773, 9910.405375677483, 6821.3519715626935, 7017.0, 7070.469714771516, 7149.642517873982, 7165.641717914188, 8367.372447066373, 8792.384533082623, 9191.172794448265, 9225.49259790718, 9548.045195480674], "unit": "score", "name": "jquery.html", "value": 7554.6504170589005}, {"lowerIsBetter": false, "replicates": [1316.1839659411155, 1473.388543754342, 1479.7558402863524, 1638.1890963972835, 1802.387188355958, 7164.713411463542, 7756.069271687398, 8000.119986801447, 8013.398995075364, 8019.278264956168, 7885.960570197141, 8042.195780421969, 8058.959705201481, 8065.516069035862, 8071.91928080719, 2012.929547465839, 2066.2045112631595, 2069.627467055929, 2297.069686776858, 2331.1258278145697, 2058.361907808584, 2295.494991101955, 2340.6137987232173, 2342.1451170322794, 2342.2153578551206, 2260.107257633234, 2273.3975496493445, 2284.006457191119, 2285.5200407914276, 2318.675385446039, 2247.404437823978, 2262.8868556572106, 2272.409173614864, 2277.8063864571614, 2277.977220227793, 2299.1952816514254, 2309.9422514437106, 2310.8844557772045, 2312.583734927712, 2324.023909957805, 8097.838043239102, 8142.552159631277, 8148.674053037871, 8157.143499932481, 8160.5103693778565, 4732.242841145435, 4783.545563171528, 4798.952010479886, 4809.6392770542, 4837.854864354075, 3140.921476963071, 3158.7630927680284, 3254.869805207789, 3262.771605987582, 3263.804171749679, 1075.8816530181673, 1085.4898197847078, 1090.6182836007413, 1091.3397394576245, 1109.1792073865363, 11649.12631552637, 11654.359010254517, 11661.70845728855, 11699.590514331958, 11779.823302650382, 4453.1316393303, 4474.709143905636, 4524.819007239739, 4528.50186479487, 4576.862694119115, 9926.652567160114, 9931.304808663468, 9941.900580994097, 9956.253281003954, 9957.203423726085, 4844.32179494871, 4855.150348688965, 4871.14754917888, 4874.707517548958, 4874.926876096791, 4401.141777353385, 4403.4495688039, 4407.162639098561, 4413.911721765547, 4415.448068991376, 3510.736694747904, 3573.338932297533, 3818.885433437001, 3874.263889860974, 3914.921701565953, 1208.6796998795326, 1209.6189700244395, 1214.763121191377, 1214.842070530843, 1225.3199474291853, 1272.7899896516972, 1281.6859869331886, 1294.1652634051172, 1304.0675916719401, 1330.9800352994712, 7366.594837284001, 7430.6284685765495, 7449.068866391701, 7452.739154129687, 7456.850862982818, 1071.6999240212754, 1082.7888561730388, 1084.1489430796787, 1106.3140852671233, 1116.7319843237565, 5822.650640961556, 5892.616979896378, 5900.498457631149, 5900.586958912835, 5910.70446477683, 9603.519824008772, 9749.561269742879, 9931.0, 10041.447720375449, 10066.14437772783, 9797.06927841854, 9922.751931201634, 9941.751456213507, 9962.352447090916, 9964.153046991087, 7450.292222238987, 7644.082710074716, 7699.11460182075, 7699.307062364414, 7708.807279817937, 7510.624468776648, 7601.543907365576, 7691.30778229962, 7698.615069246627, 7708.653110610148, 8692.391532592657, 8773.605187766694, 8860.29117670572, 8930.687425940061, 8958.462492250486, 8733.388662793797, 9062.22971047442, 9199.218066464426, 9202.355835091746, 9210.447373157633, 6924.549904256207, 7070.858582828418, 7071.186813516306, 7082.327178917994, 7082.752103676346, 6802.489813263926, 6854.280300568368, 7605.733799316998, 7706.730264440717, 7760.068791745027, 7074.469414793808, 7153.570785752871, 7198.604076775828, 7271.163816160997, 7371.299726525972, 7168.89246661311, 7247.202807691045, 7313.016069653574, 7358.816029599303, 7450.515716478629, 7144.964275178799, 7334.009908662262, 7410.740624078131, 7437.442191835742, 7440.3675687565, 6791.2190098139345, 6792.524523283323, 6803.659817009228, 6819.829504262433, 6831.69257383409, 6918.308169183041, 6957.408620267334, 6964.442844572523, 6967.0246165535855, 6972.755953541602], "unit": "score", "name": "mootools.html", "value": 4650.599568878268}, {"lowerIsBetter": false, "replicates": [334.83593039410687, 335.79180907837144, 342.2641321159508, 343.35449355212205, 348.2512597914482, 5797.101449275358, 5930.347661757209, 5952.58331916766, 5964.045752679572, 6014.458698717114, 5713.114467257571, 5814.854628634286, 5834.066549352105, 5877.0, 5896.970515147418, 4568.657350698702, 4580.26715725484, 4629.953700462986, 4636.6058884994645, 4637.04940487201, 4371.409859668952, 4464.241079016575, 4494.842680506183, 4583.724976501404, 4609.3777340059, 4549.61328287096, 4573.153966516188, 4581.79381927814, 4581.908361832761, 4599.356090147382, 4581.748003859786, 4584.747838868844, 4586.266197408415, 4596.35651008859, 4602.930956035629, 4067.5525692173837, 4068.532118806316, 4068.593140685937, 4072.104137089865, 4072.328065869128, 5561.193626924073, 5650.971745141289, 5665.830025099212, 5695.202671625976, 5726.427357264281, 5355.30381050461, 5356.0894647909945, 5357.276767636358, 5360.035193665139, 5367.577591938139, 6019.247594050744, 6341.746330146789, 6345.111684364193, 6355.046742988588, 6355.936440635581, 4382.496012958519, 4386.495553011381, 4475.955240447586, 4511.887202819956, 4516.932246016312, 6478.74085036598, 6537.803865884031, 6562.770303039419, 6582.210134783809, 6590.604563726144, 4608.262677971508, 4612.654050946193, 4617.353570500132, 4617.746023968714, 4618.376519169936, 4504.81980720774, 4638.304254361873, 4661.137689527448, 4667.673262871566, 4673.60274376675, 5342.358916929993, 5342.893142137135, 5357.866053348697, 5361.839144825662, 5368.3826359968325, 6333.809985700436, 6342.746290148435, 6343.55595108338, 6343.619382837044, 6356.682165891687, 1606.8714502839978, 1661.1362091712242, 1662.2187571841216, 1662.4430815676883, 1663.2931004323113, 1091.47063674118, 1123.8988491035682, 1132.0547342968714, 1132.224426268009, 1149.8329195866202, 5878.911816322759, 5956.9575324318075, 5962.4633782959745, 5965.850853728692, 5966.164736936832, 6441.742330306829, 6449.935500645028, 6456.967715161394, 6458.612483250926, 6467.773627923, 5743.684097374601, 5764.654120752768, 5804.2744656917885, 5853.9170253503235, 5880.735366908414, 3403.931921361559, 3481.112316359312, 3483.00734290731, 3485.7385696072897, 3489.581250249986, 6581.473482121419, 6629.403353698191, 6653.600783952978, 6654.933450665529, 6655.401013908771, 6546.214454265519, 6575.80272591823, 6576.835579110465, 6583.539152259392, 6595.208574971034, 6494.318096599884, 6653.201615806038, 6655.267920528835, 6657.3342665733035, 6661.9000714989315, 6161.507079433545, 6388.201474815648, 6395.584287021329, 6412.711427985845, 6430.164078669743, 6475.902861456988, 6492.220933488012, 6499.5775274607, 6504.447121994494, 6505.902411463927, 6774.356436138559, 6803.489738269551, 6812.0122582226295, 6815.659217039228, 6818.386345228953, 4646.834657764916, 4681.742504162167, 4720.622350211906, 4724.291356296583, 4733.5503127202865, 6542.149520562297, 6543.1821022372205, 6543.476521878333, 6546.574472659262, 6563.0811686362995, 6360.332165122781, 6361.745530178741, 6362.45919096882, 6364.745410183726, 6370.522210834113, 6172.105044768573, 6371.681415929278, 6384.553081284451, 6384.712687928962, 6400.839979000562, 6284.905726414199, 6287.685615719287, 6289.339619339903, 6290.9056364155485, 6293.716782744696, 6423.197100362455, 6491.156149700509, 6493.285738568659, 6498.577592456475, 6503.967480162569, 6117.776444711165, 6259.593126446766, 6272.655003974825, 6275.403836635513, 6292.559520833681], "unit": "score", "name": "prototype.html", "value": 4791.007315383462}, {"lowerIsBetter": false, "replicates": [699.063255237981, 737.4763917618491, 740.9296116868895, 789.2580973884548, 791.9743931608566, 12891.484340626375, 13027.804582931263, 13057.869421305784, 13062.934685326572, 13093.214407135578, 11296.943515282412, 12873.935630321836, 12967.221966682006, 12979.351032448363, 13004.804927926089, 665.8335416145964, 674.9392554670079, 792.6393490961613, 795.4789612803594, 804.252045597594, 785.4305628419407, 790.6718711734624, 791.3589992106412, 794.4518282385136, 794.9761507154766, 846.7967687754956, 848.6605357856876, 849.7535714642746, 850.2432834777022, 850.9829803403928, 689.9655017249142, 695.5200911371163, 835.6699103853974, 851.7146755836802, 855.114956020522, 626.9780557680459, 628.1425853709699, 628.7045088808253, 628.8679377330766, 628.8930881750068, 12866.549670761478, 12887.484500620058, 12954.481820727255, 12960.48158073676, 12963.805542916863, 11987.520499180022, 12180.695482612917, 12222.694432639166, 12312.50749970009, 12424.192427492184, 9848.310618256724, 9869.506524673738, 10005.949970250174, 10325.070743633109, 10450.0, 3487.075924879909, 3498.492718555821, 3521.8767343142868, 3543.0965103898343, 3672.485851980725, 48106.75946620315, 48548.757256213845, 48695.13048695138, 48878.0, 48912.0, 9177.587008584629, 9393.57728902201, 9489.715308540755, 9494.287928405398, 9564.18704410119, 18429.26282948667, 18462.07689615514, 18498.260069597334, 18499.90750046241, 18500.537486562673, 6894.103766510321, 6963.199232088375, 7018.75434359795, 7178.28217178278, 7346.485745997836, 4126.174765047002, 4198.685098617616, 4212.68404869636, 4251.914961700749, 4286.80709368073, 3057.143999680093, 3119.251379668863, 3122.11019859339, 3127.4526957782296, 3127.5152351385573, 560.087058095302, 564.4355644355644, 566.6854895533019, 582.8105865593699, 587.753143679647, 526.9973650131801, 582.8979928512493, 599.901016332309, 607.720448593643, 629.4429429954523, 8221.958890205511, 8940.0, 8950.23922966555, 9021.729348119436, 9342.205912497513, 654.607235658601, 660.5112216959416, 669.1434963246954, 672.0658284983876, 673.8517526144241, 3820.9426858597144, 3857.4213867919475, 3919.2440461661868, 3994.820233089518, 4011.2378648056774, 59874.70062649746, 60345.698271508365, 60428.69785651044, 60827.695861520406, 61751.69124154351, 49245.0, 50073.49926500761, 50163.0, 50287.49712502901, 50773.0, 45535.772321138844, 45978.31032534515, 46456.3031554527, 46954.76522617365, 47270.29094563585, 8238.423310368216, 8320.791980200544, 8443.746687599381, 8509.404341696021, 8524.104968978168, 34169.0, 34787.826060869535, 34809.47785783266, 34944.65055349414, 35039.47440788441, 41745.0, 45261.0, 45609.0, 45716.77141614271, 45720.31419528776, 10895.673129806119, 11038.613648522263, 11046.889531104585, 11047.668569942914, 11056.778864422506, 12023.579174728842, 12076.456559455022, 12159.81760273579, 12626.55807046749, 13085.607431777062, 10719.303245289344, 10905.890941090487, 10909.39998300101, 10987.230893837674, 11007.229493935347, 11534.942325288655, 11599.710007249549, 11654.650360489199, 11966.880331196924, 12115.273083615011, 11077.889221108007, 11208.607698730506, 11217.102631789601, 11229.21395502307, 11585.147093996624, 9056.592453339485, 9117.270618350649, 9465.148136667733, 9566.473843938371, 9577.425354478753, 8853.513056781681, 9185.357025008185, 9232.815343693223, 9303.488308143116, 9325.440473571607], "unit": "score", "name": "yui.html", "value": 6201.023047290101}], "name": "dromaeo_css", "value": 6733.292258765396}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 107.0, 110.0, 110.0, 110.0, 110.0, 110.0, 103.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.2}, {"lowerIsBetter": true, "replicates": [153.0, 128.0, 153.0, 171.0, 127.0, 159.0, 150.0, 132.0, 170.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 146.9}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 162.0, 162.0, 163.0, 161.0, 161.0, 160.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 97.0, 98.0, 80.0, 73.0, 73.0, 123.0, 96.0, 73.0], "unit": "score", "name": "audio-fft", "value": 86.0}, {"lowerIsBetter": true, "replicates": [96.0, 102.0, 143.0, 94.0, 95.0, 95.0, 153.0, 95.0, 94.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 110.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 146.0, 146.0, 146.0, 147.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 103.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 56.0, 56.0, 55.0, 56.0, 56.0, 55.0, 58.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 68.0, 66.0, 68.0, 69.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [88.0, 83.0, 84.0, 103.0, 83.0, 93.0, 84.0, 82.0, 91.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.6}, {"lowerIsBetter": true, "replicates": [119.0, 122.0, 120.0, 116.0, 115.0, 117.0, 126.0, 130.0, 115.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.4}, {"lowerIsBetter": true, "replicates": [144.0, 135.0, 156.0, 135.0, 145.0, 131.0, 146.0, 148.0, 134.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.8}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 69.0, 68.0, 67.0, 67.0, 69.0, 68.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1505.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.58840288252054], "unit": "score", "name": "Richards", "value": 210.64703400000002}, {"lowerIsBetter": false, "replicates": [191.27773527161438], "unit": "score", "name": "DeltaBlue", "value": 345.66490400000004}, {"lowerIsBetter": false, "replicates": [281.214848143982], "unit": "score", "name": "Encrypt", "value": 946.5396360000002}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [1113.5857461024498], "unit": "score", "name": "RayTrace", "value": 664.510122}, {"lowerIsBetter": false, "replicates": [794.2811755361398], "unit": "score", "name": "Earley", "value": 839.0769169999999}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [43270.833333333336], "unit": "score", "name": "RegExp", "value": 21.05309581126625}, {"lowerIsBetter": false, "replicates": [619.9628022318661], "unit": "score", "name": "Splay", "value": 131.44498299999998}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 19845.70359956864}]} 11:37:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19845.70"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1505.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6733.29"}}} 11:37:03 INFO - Return code: 0 11:37:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:37:03 INFO - # TBPL SUCCESS # 11:37:03 INFO - Running post-action listener: _resource_record_post_action 11:37:03 INFO - Running post-run listener: _resource_record_post_run 11:37:04 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538730496; Read time: 12; Write time: 409908 11:37:04 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 236564480; Read time: 0; Write time: 206404 11:37:04 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 302166016; Read time: 12; Write time: 203504 11:37:04 INFO - Running post-run listener: _upload_blobber_files 11:37:04 INFO - Blob upload gear active. 11:37:04 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:37:04 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:37:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 11:37:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 11:37:04 INFO - (blobuploader) - INFO - Open directory for files ... 11:37:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:37:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:37:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:05 INFO - (blobuploader) - INFO - Done attempting. 11:37:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 11:37:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:37:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:06 INFO - (blobuploader) - INFO - Done attempting. 11:37:06 INFO - (blobuploader) - INFO - Iteration through files over. 11:37:06 INFO - Return code: 0 11:37:06 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:37:06 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:37:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb2a1fa6d1306d09f5806cefc81b51d13b610c7694ad060e3469af3dcd9b7d3c8fac38fc1f6b511ef19a3f43585eea140daa089564e41fa04454e2816ca63fe1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b19ff5a25373facc6ca0c8a72234eab0197804ff05fc381713221c8347a40000b108ca9dd3ee476d76fb0475336e508475cf8d26f6a125a31a5c07d1be740026"} 11:37:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:37:06 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:37:06 INFO - Contents: 11:37:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb2a1fa6d1306d09f5806cefc81b51d13b610c7694ad060e3469af3dcd9b7d3c8fac38fc1f6b511ef19a3f43585eea140daa089564e41fa04454e2816ca63fe1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b19ff5a25373facc6ca0c8a72234eab0197804ff05fc381713221c8347a40000b108ca9dd3ee476d76fb0475336e508475cf8d26f6a125a31a5c07d1be740026"} 11:37:06 INFO - Running post-run listener: copy_logs_to_upload_dir 11:37:06 INFO - Copying logs to upload dir... 11:37:06 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 11:37:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.482918 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-01-25 11:37:06.705116) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 11:37:06.708746) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb2a1fa6d1306d09f5806cefc81b51d13b610c7694ad060e3469af3dcd9b7d3c8fac38fc1f6b511ef19a3f43585eea140daa089564e41fa04454e2816ca63fe1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b19ff5a25373facc6ca0c8a72234eab0197804ff05fc381713221c8347a40000b108ca9dd3ee476d76fb0475336e508475cf8d26f6a125a31a5c07d1be740026"} build_url:https://queue.taskcluster.net/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011338 build_url: 'https://queue.taskcluster.net/v1/task/HFjTcYfiTbuBY_TmbzRPAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb2a1fa6d1306d09f5806cefc81b51d13b610c7694ad060e3469af3dcd9b7d3c8fac38fc1f6b511ef19a3f43585eea140daa089564e41fa04454e2816ca63fe1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b19ff5a25373facc6ca0c8a72234eab0197804ff05fc381713221c8347a40000b108ca9dd3ee476d76fb0475336e508475cf8d26f6a125a31a5c07d1be740026"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 11:37:06.734639) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:37:06.734970) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1453749358.913718-1787808153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004617 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:37:06.817446) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 11:37:06.817794) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 11:37:06.818152) ========= ========= Total master_lag: 0.32 =========