builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-023 starttime: 1453683492.53 results: success (0) buildid: 20160124143004 builduid: 8f23f1b0f399422c8c88cf43d821c993 revision: c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:12.526023) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:12.526534) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:12.526865) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006467 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:12.566386) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:12.566693) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:12.629696) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:12.629996) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004624 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:12.685102) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:12.685462) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:12.685939) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:12.686271) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-24 16:58:13-- 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% 215M=0s 2016-01-24 16:58:14 (215 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.460328 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:13.161118) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:13.161531) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018535 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:13.211706) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-24 16:58:13.212167) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7 --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 c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7 --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=6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-24 16:58:14,126 truncating revision to first 12 chars 2016-01-24 16:58:14,126 Setting DEBUG logging. 2016-01-24 16:58:14,126 attempt 1/10 2016-01-24 16:58:14,126 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c2256ee8ae9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-24 16:58:15,367 unpacking tar archive at: fx-team-c2256ee8ae9a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.525121 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-24 16:58:14.752439) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:14.752907) ========= echo c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7'] 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=6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7 program finished with exit code 0 elapsedTime=0.004519 script_repo_revision: 'c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:14.804133) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:14.804493) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-24 16:58:14.814777) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-24 16:58:14.815168) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:58:15 INFO - MultiFileLogger online at 20160124 16:58:15 in /builds/slave/test-pgo 16:58:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:58:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:58:15 INFO - {'append_to_log': False, 16:58:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:58:15 INFO - 'blob_upload_branch': 'Fx-Team', 16:58:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:58:15 INFO - 'branch': 'Fx-Team', 16:58:15 INFO - 'buildbot_json_path': 'buildprops.json', 16:58:15 INFO - 'config_files': ('talos/linux_config.py',), 16:58:15 INFO - 'default_actions': ('clobber', 16:58:15 INFO - 'read-buildbot-config', 16:58:15 INFO - 'download-and-extract', 16:58:15 INFO - 'populate-webroot', 16:58:15 INFO - 'create-virtualenv', 16:58:15 INFO - 'install', 16:58:15 INFO - 'run-tests'), 16:58:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:58:15 INFO - 'download_minidump_stackwalk': True, 16:58:15 INFO - 'download_symbols': 'ondemand', 16:58:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:58:15 INFO - 'tooltool.py': '/tools/tooltool.py', 16:58:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:58:15 INFO - '/tools/misc-python/virtualenv.py')}, 16:58:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:58:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:58:15 INFO - 'installer_path': 'installer.exe', 16:58:15 INFO - 'log_level': 'info', 16:58:15 INFO - 'log_name': 'talos', 16:58:15 INFO - 'log_to_console': True, 16:58:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:58:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:58:15 INFO - 'opt_config_files': (), 16:58:15 INFO - 'pip_index': False, 16:58:15 INFO - 'sps_profile': False, 16:58:15 INFO - 'sps_profile_interval': 0, 16:58:15 INFO - 'suite': 'dromaeojs-e10s', 16:58:15 INFO - 'system_bits': '32', 16:58:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:58:15 INFO - 'title': 'talos-linux64-ix-023', 16:58:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:58:15 INFO - 'use_talos_json': True, 16:58:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:58:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:58:15 INFO - 'work_dir': 'build'} 16:58:15 INFO - ##### 16:58:15 INFO - ##### Running clobber step. 16:58:15 INFO - ##### 16:58:15 INFO - Running pre-action listener: _resource_record_pre_action 16:58:15 INFO - Running main action method: clobber 16:58:15 INFO - rmtree: /builds/slave/test-pgo/build 16:58:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:58:16 INFO - Running post-action listener: _resource_record_post_action 16:58:16 INFO - ##### 16:58:16 INFO - ##### Running read-buildbot-config step. 16:58:16 INFO - ##### 16:58:16 INFO - Running pre-action listener: _resource_record_pre_action 16:58:16 INFO - Running main action method: read_buildbot_config 16:58:16 INFO - Using buildbot properties: 16:58:16 INFO - { 16:58:16 INFO - "project": "", 16:58:16 INFO - "product": "firefox", 16:58:16 INFO - "script_repo_revision": "production", 16:58:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:58:16 INFO - "repository": "", 16:58:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 16:58:16 INFO - "buildid": "20160124143004", 16:58:16 INFO - "pgo_build": "True", 16:58:16 INFO - "basedir": "/builds/slave/test-pgo", 16:58:16 INFO - "buildnumber": 242, 16:58:16 INFO - "slavename": "talos-linux64-ix-023", 16:58:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:58:16 INFO - "platform": "ubuntu64_hw", 16:58:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:58:16 INFO - "branch": "fx-team", 16:58:16 INFO - "repo_path": "integration/fx-team", 16:58:16 INFO - "revision": "c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7", 16:58:16 INFO - "stage_platform": "linux64-pgo", 16:58:16 INFO - "builduid": "8f23f1b0f399422c8c88cf43d821c993", 16:58:16 INFO - "slavebuilddir": "test" 16:58:16 INFO - } 16:58:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:58:16 INFO - Running post-action listener: _resource_record_post_action 16:58:16 INFO - ##### 16:58:16 INFO - ##### Running download-and-extract step. 16:58:16 INFO - ##### 16:58:16 INFO - Running pre-action listener: _resource_record_pre_action 16:58:16 INFO - Running main action method: download_and_extract 16:58:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:16 INFO - https://queue.taskcluster.net/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:58:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/test_packages.json 16:58:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/test_packages.json 16:58:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:58:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:58:20 INFO - Downloaded 1448 bytes. 16:58:20 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:58:20 INFO - Using the following test package requirements: 16:58:20 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:58:20 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:58:20 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:58:20 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:20 INFO - u'jsshell-linux-x86_64.zip'], 16:58:20 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:58:20 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:58:20 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:58:20 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:58:20 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:58:20 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:58:20 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:58:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:58:20 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:58: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')]} 16:58:20 INFO - https://queue.taskcluster.net/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:58:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:58:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:58:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/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 16:58:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/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 16:58:22 INFO - Downloaded 22491968 bytes. 16:58:22 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'] 16:58:22 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 16:58:23 INFO - Return code: 0 16:58:23 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 16:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:23 INFO - https://queue.taskcluster.net/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:58:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:58:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:58:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/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 16:58:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/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 16:58:27 INFO - Downloaded 22491968 bytes. 16:58:27 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'] 16:58:27 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 16:58:29 INFO - Return code: 0 16:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:29 INFO - https://queue.taskcluster.net/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:58:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:58:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:58:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/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 16:58:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/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 16:58:30 INFO - Downloaded 10706572 bytes. 16:58:30 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'] 16:58:30 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 16:58:30 INFO - Return code: 0 16:58: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')]} 16:58:30 INFO - https://queue.taskcluster.net/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:58:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:58:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:58:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/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 16:58:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZuqQquBhRbGvIftu27RAhg/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 16:58:32 INFO - Downloaded 55977776 bytes. 16:58:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:58:32 INFO - mkdir: /builds/slave/test-pgo/properties 16:58:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:58:32 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:58:32 INFO - Contents: 16:58:32 INFO - build_url:https://queue.taskcluster.net/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:58:32 INFO - Running post-action listener: _resource_record_post_action 16:58:32 INFO - Running post-action listener: set_extra_try_arguments 16:58:32 INFO - ##### 16:58:32 INFO - ##### Running populate-webroot step. 16:58:32 INFO - ##### 16:58:32 INFO - Running pre-action listener: _resource_record_pre_action 16:58:32 INFO - Running main action method: populate_webroot 16:58:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:58:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:58:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:58:32 INFO - '--tppagecycles', 16:58:32 INFO - '7'], 16:58:32 INFO - 'tests': ['tsvgm']}}, 16:58:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:58:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:58:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:58:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:58:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:58:32 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:58:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:58:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:32 INFO - 'talos_options': ['--e10s'], 16:58:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:58:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:32 INFO - 'tests': ['damp', 'tps']}, 16:58:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:32 INFO - 'talos_options': ['--e10s'], 16:58:32 INFO - 'tests': ['damp', 'tps']}, 16:58:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:58:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:58:32 INFO - 'other': {'tests': ['a11yr', 16:58:32 INFO - 'ts_paint', 16:58:32 INFO - 'tpaint', 16:58:32 INFO - 'sessionrestore', 16:58:32 INFO - 'sessionrestore_no_auto_restore']}, 16:58:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:58:32 INFO - 'tests': ['a11yr', 16:58:32 INFO - 'ts_paint', 16:58:32 INFO - 'tpaint', 16:58:32 INFO - 'sessionrestore', 16:58:32 INFO - 'sessionrestore_no_auto_restore']}, 16:58:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:58:32 INFO - 'tests': ['a11yr', 16:58:32 INFO - 'ts_paint', 16:58:32 INFO - 'tpaint', 16:58:32 INFO - 'sessionrestore', 16:58:32 INFO - 'sessionrestore_no_auto_restore']}, 16:58:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:58:32 INFO - 'tests': ['a11yr', 16:58:32 INFO - 'ts_paint', 16:58:32 INFO - 'tpaint', 16:58:32 INFO - 'sessionrestore', 16:58:32 INFO - 'sessionrestore_no_auto_restore']}, 16:58:32 INFO - 'other_l64': {'tests': ['a11yr', 16:58:32 INFO - 'ts_paint', 16:58:32 INFO - 'tpaint', 16:58:32 INFO - 'sessionrestore', 16:58:32 INFO - 'sessionrestore_no_auto_restore']}, 16:58:32 INFO - 'other_nol64': {'tests': ['a11yr', 16:58:32 INFO - 'ts_paint', 16:58:32 INFO - 'tpaint', 16:58:32 INFO - 'sessionrestore', 16:58:32 INFO - 'sessionrestore_no_auto_restore']}, 16:58:32 INFO - 'svgr': {'tests': ['tsvgx', 16:58:32 INFO - 'tsvgr_opacity', 16:58:32 INFO - 'tart', 16:58:32 INFO - 'tscrollx', 16:58:32 INFO - 'cart']}, 16:58:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:58:32 INFO - 'tests': ['tsvgx', 16:58:32 INFO - 'tsvgr_opacity', 16:58:32 INFO - 'tart', 16:58:32 INFO - 'tscrollx', 16:58:32 INFO - 'cart']}, 16:58:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:32 INFO - 'tests': ['tp5o']}, 16:58:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:32 INFO - 'talos_options': ['--e10s'], 16:58:32 INFO - 'tests': ['tp5o']}, 16:58:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:32 INFO - 'talos_options': ['--xperf_path', 16:58:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:58:32 INFO - 'tests': ['tp5n']}, 16:58:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:32 INFO - 'talos_options': ['--e10s', 16:58:32 INFO - '--xperf_path', 16:58:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:58:32 INFO - 'tests': ['tp5n']}}, 16:58:32 INFO - 'talos.zip': {'path': '', 16:58:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:58:32 INFO - Running post-action listener: _resource_record_post_action 16:58:32 INFO - ##### 16:58:32 INFO - ##### Running create-virtualenv step. 16:58:32 INFO - ##### 16:58:32 INFO - Running pre-action listener: _resource_record_pre_action 16:58:32 INFO - Running main action method: create_virtualenv 16:58:32 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:58:32 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 16:58:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:58:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:58:32 INFO - Using real prefix '/usr' 16:58:32 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:58:33 INFO - Installing distribute.............................................................................................................................................................................................done. 16:58:35 INFO - Installing pip.................done. 16:58:35 INFO - Return code: 0 16:58:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:58:35 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')]} 16:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:35 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')]} 16:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:35 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 0x7fe2d6194f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1209480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298660>, '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 0x1299560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1299a10>, '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': '6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277', '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 16:58:35 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 16:58:35 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 16:58:35 INFO - Using env: {'DISPLAY': ':0', 16:58:35 INFO - 'HOME': '/home/cltbld', 16:58:35 INFO - 'LANG': 'en_US.UTF-8', 16:58:35 INFO - 'LANGUAGE': 'en_US:en', 16:58:35 INFO - 'LOGNAME': 'cltbld', 16:58:35 INFO - 'MAIL': '/var/mail/cltbld', 16:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:35 INFO - 'MOZ_NO_REMOTE': '1', 16:58:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:35 INFO - 'NO_EM_RESTART': '1', 16:58:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:35 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:35 INFO - 'SHELL': '/bin/bash', 16:58:35 INFO - 'SHLVL': '1', 16:58:35 INFO - 'TERM': 'linux', 16:58:35 INFO - 'TMOUT': '86400', 16:58:35 INFO - 'USER': 'cltbld', 16:58:35 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277', 16:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:35 INFO - '_': '/tools/buildbot/bin/python'} 16:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:35 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 16:58:35 INFO - Cleaning up... 16:58:35 INFO - Return code: 0 16:58:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:58:35 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')]} 16:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:35 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')]} 16:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:35 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 0x7fe2d6194f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1209480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298660>, '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 0x1299560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1299a10>, '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': '6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277', '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 16:58:35 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 16:58:35 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 16:58:35 INFO - Using env: {'DISPLAY': ':0', 16:58:35 INFO - 'HOME': '/home/cltbld', 16:58:35 INFO - 'LANG': 'en_US.UTF-8', 16:58:35 INFO - 'LANGUAGE': 'en_US:en', 16:58:35 INFO - 'LOGNAME': 'cltbld', 16:58:35 INFO - 'MAIL': '/var/mail/cltbld', 16:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:35 INFO - 'MOZ_NO_REMOTE': '1', 16:58:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:35 INFO - 'NO_EM_RESTART': '1', 16:58:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:35 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:35 INFO - 'SHELL': '/bin/bash', 16:58:35 INFO - 'SHLVL': '1', 16:58:35 INFO - 'TERM': 'linux', 16:58:35 INFO - 'TMOUT': '86400', 16:58:35 INFO - 'USER': 'cltbld', 16:58:35 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277', 16:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:35 INFO - '_': '/tools/buildbot/bin/python'} 16:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:35 INFO - Downloading/unpacking psutil>=0.7.1 16:58:35 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 16:58:35 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 16:58:35 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 16:58:35 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 16:58:35 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 16:58:35 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 16:58:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:58:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:58:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:58:37 INFO - Installing collected packages: psutil 16:58:37 INFO - Running setup.py install for psutil 16:58:37 INFO - building 'psutil._psutil_linux' extension 16:58:37 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 16:58:37 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 16:58:37 INFO - building 'psutil._psutil_posix' extension 16:58:37 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 16:58:37 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 16:58:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:58:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:58:38 INFO - Successfully installed psutil 16:58:38 INFO - Cleaning up... 16:58:38 INFO - Return code: 0 16:58:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:38 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 0x7fe2d6194f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1209480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298660>, '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 0x1299560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1299a10>, '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': '6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277', '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 16:58:38 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 16:58:38 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 16:58:38 INFO - Using env: {'DISPLAY': ':0', 16:58:38 INFO - 'HOME': '/home/cltbld', 16:58:38 INFO - 'LANG': 'en_US.UTF-8', 16:58:38 INFO - 'LANGUAGE': 'en_US:en', 16:58:38 INFO - 'LOGNAME': 'cltbld', 16:58:38 INFO - 'MAIL': '/var/mail/cltbld', 16:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:38 INFO - 'MOZ_NO_REMOTE': '1', 16:58:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:38 INFO - 'NO_EM_RESTART': '1', 16:58:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:38 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:38 INFO - 'SHELL': '/bin/bash', 16:58:38 INFO - 'SHLVL': '1', 16:58:38 INFO - 'TERM': 'linux', 16:58:38 INFO - 'TMOUT': '86400', 16:58:38 INFO - 'USER': 'cltbld', 16:58:38 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277', 16:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:38 INFO - '_': '/tools/buildbot/bin/python'} 16:58:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:58:38 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 16:58:38 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 16:58:38 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 16:58:38 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 16:58:38 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 16:58:38 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 16:58:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:58:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:58:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:58:40 INFO - Installing collected packages: mozsystemmonitor 16:58:40 INFO - Running setup.py install for mozsystemmonitor 16:58:40 INFO - Successfully installed mozsystemmonitor 16:58:40 INFO - Cleaning up... 16:58:40 INFO - Return code: 0 16:58:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:40 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 0x7fe2d6194f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1209480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298660>, '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 0x1299560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1299a10>, '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': '6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277', '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 16:58:40 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 16:58:40 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 16:58:40 INFO - Using env: {'DISPLAY': ':0', 16:58:40 INFO - 'HOME': '/home/cltbld', 16:58:40 INFO - 'LANG': 'en_US.UTF-8', 16:58:40 INFO - 'LANGUAGE': 'en_US:en', 16:58:40 INFO - 'LOGNAME': 'cltbld', 16:58:40 INFO - 'MAIL': '/var/mail/cltbld', 16:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:40 INFO - 'MOZ_NO_REMOTE': '1', 16:58:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:40 INFO - 'NO_EM_RESTART': '1', 16:58:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:40 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:40 INFO - 'SHELL': '/bin/bash', 16:58:40 INFO - 'SHLVL': '1', 16:58:40 INFO - 'TERM': 'linux', 16:58:40 INFO - 'TMOUT': '86400', 16:58:40 INFO - 'USER': 'cltbld', 16:58:40 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277', 16:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:40 INFO - '_': '/tools/buildbot/bin/python'} 16:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:40 INFO - Downloading/unpacking blobuploader==1.2.4 16:58:40 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 16:58:40 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 16:58:40 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 16:58:40 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 16:58:40 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 16:58:40 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 16:58:42 INFO - Downloading blobuploader-1.2.4.tar.gz 16:58:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:58:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:58:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:42 INFO - Downloading docopt-0.6.1.tar.gz 16:58:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:58:42 INFO - Installing collected packages: blobuploader, requests, docopt 16:58:42 INFO - Running setup.py install for blobuploader 16:58:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:58:43 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:58:43 INFO - Running setup.py install for requests 16:58:43 INFO - Running setup.py install for docopt 16:58:43 INFO - Successfully installed blobuploader requests docopt 16:58:43 INFO - Cleaning up... 16:58:43 INFO - Return code: 0 16:58:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:58:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:43 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 0x7fe2d6194f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1209480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298660>, '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 0x1299560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1299a10>, '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': '6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277', '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 16:58:43 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 16:58:43 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 16:58:43 INFO - Using env: {'DISPLAY': ':0', 16:58:43 INFO - 'HOME': '/home/cltbld', 16:58:43 INFO - 'LANG': 'en_US.UTF-8', 16:58:43 INFO - 'LANGUAGE': 'en_US:en', 16:58:43 INFO - 'LOGNAME': 'cltbld', 16:58:43 INFO - 'MAIL': '/var/mail/cltbld', 16:58:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:43 INFO - 'MOZ_NO_REMOTE': '1', 16:58:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:43 INFO - 'NO_EM_RESTART': '1', 16:58:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:43 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:43 INFO - 'SHELL': '/bin/bash', 16:58:43 INFO - 'SHLVL': '1', 16:58:43 INFO - 'TERM': 'linux', 16:58:43 INFO - 'TMOUT': '86400', 16:58:43 INFO - 'USER': 'cltbld', 16:58:43 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277', 16:58:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:43 INFO - '_': '/tools/buildbot/bin/python'} 16:58:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:58:43 INFO - Running setup.py (path:/tmp/pip-1n1qXY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:58:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:58:43 INFO - Running setup.py (path:/tmp/pip-9e25sE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:58:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:58:43 INFO - Running setup.py (path:/tmp/pip-ih_dCW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:58:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:58:43 INFO - Running setup.py (path:/tmp/pip-EhX9HA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:58:44 INFO - Running setup.py (path:/tmp/pip-T2tful-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:58:44 INFO - Running setup.py (path:/tmp/pip-6tVHtA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:58:44 INFO - Running setup.py (path:/tmp/pip-7Cc2r0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:58:44 INFO - Running setup.py (path:/tmp/pip-4VZ78a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:58:44 INFO - Running setup.py (path:/tmp/pip-l3JeG7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:58:44 INFO - Running setup.py (path:/tmp/pip-obCxVb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:58:44 INFO - Running setup.py (path:/tmp/pip-__Le_X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:58:44 INFO - Running setup.py (path:/tmp/pip-u6QOvP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:58:44 INFO - Running setup.py (path:/tmp/pip-iyK6HE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:58:44 INFO - Running setup.py (path:/tmp/pip-2zlqAa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:58:44 INFO - Running setup.py (path:/tmp/pip-vy8IS0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:58:44 INFO - Running setup.py (path:/tmp/pip-bA8NLO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:58:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:58:44 INFO - Running setup.py (path:/tmp/pip-XaZlQA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:58:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:58:44 INFO - Running setup.py install for manifestparser 16:58:45 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:58:45 INFO - Running setup.py install for mozcrash 16:58:45 INFO - Running setup.py install for mozdebug 16:58:45 INFO - Running setup.py install for mozdevice 16:58:45 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:58:45 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:58:45 INFO - Running setup.py install for mozfile 16:58:45 INFO - Running setup.py install for mozhttpd 16:58:45 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:58:45 INFO - Running setup.py install for mozinfo 16:58:45 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:58:45 INFO - Running setup.py install for mozInstall 16:58:45 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:58:45 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:58:45 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:58:45 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:58:45 INFO - Running setup.py install for mozleak 16:58:45 INFO - Running setup.py install for mozlog 16:58:45 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:58:46 INFO - Running setup.py install for moznetwork 16:58:46 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:58:46 INFO - Running setup.py install for mozprocess 16:58:46 INFO - Running setup.py install for mozprofile 16:58:46 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:58:46 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:58:46 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:58:46 INFO - Running setup.py install for mozrunner 16:58:46 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:58:46 INFO - Running setup.py install for mozscreenshot 16:58:46 INFO - Running setup.py install for moztest 16:58:46 INFO - Running setup.py install for mozversion 16:58:46 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:58:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:58:46 INFO - Cleaning up... 16:58:46 INFO - Return code: 0 16:58:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:46 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 0x7fe2d6194f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1209480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298660>, '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 0x1299560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1299a10>, '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': '6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277', '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 16:58:46 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 16:58:46 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 16:58:46 INFO - Using env: {'DISPLAY': ':0', 16:58:46 INFO - 'HOME': '/home/cltbld', 16:58:46 INFO - 'LANG': 'en_US.UTF-8', 16:58:46 INFO - 'LANGUAGE': 'en_US:en', 16:58:46 INFO - 'LOGNAME': 'cltbld', 16:58:46 INFO - 'MAIL': '/var/mail/cltbld', 16:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:46 INFO - 'MOZ_NO_REMOTE': '1', 16:58:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:46 INFO - 'NO_EM_RESTART': '1', 16:58:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:46 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:46 INFO - 'SHELL': '/bin/bash', 16:58:46 INFO - 'SHLVL': '1', 16:58:46 INFO - 'TERM': 'linux', 16:58:46 INFO - 'TMOUT': '86400', 16:58:46 INFO - 'USER': 'cltbld', 16:58:46 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277', 16:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:46 INFO - '_': '/tools/buildbot/bin/python'} 16:58:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:58:46 INFO - Running setup.py (path:/tmp/pip-FFHhmD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:58:47 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)) 16:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:58:47 INFO - Running setup.py (path:/tmp/pip-JDLNzn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:58:47 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)) 16:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:58:47 INFO - Running setup.py (path:/tmp/pip-C1xUEB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:58:47 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)) 16:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:58:47 INFO - Running setup.py (path:/tmp/pip-DdtyyM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:58:47 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)) 16:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:58:47 INFO - Running setup.py (path:/tmp/pip-BG7OAi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:58:47 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)) 16:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:58:47 INFO - Running setup.py (path:/tmp/pip-_JmBkz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:58:47 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)) 16:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:58:47 INFO - Running setup.py (path:/tmp/pip-FP0B8S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:58:47 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)) 16:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:58:47 INFO - Running setup.py (path:/tmp/pip-2NS5I8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:58:47 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)) 16:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:58:47 INFO - Running setup.py (path:/tmp/pip-ssGzpE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:58:47 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)) 16:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:58:47 INFO - Running setup.py (path:/tmp/pip-kfdZ9p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:58:47 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)) 16:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:58:47 INFO - Running setup.py (path:/tmp/pip-B8mYUJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:58:47 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)) 16:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:58:47 INFO - Running setup.py (path:/tmp/pip-lor8zX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:58:47 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)) 16:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:58:47 INFO - Running setup.py (path:/tmp/pip-1Q5J6S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:58:47 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)) 16:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:58:47 INFO - Running setup.py (path:/tmp/pip-qrq_bw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:58:47 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)) 16:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:58:47 INFO - Running setup.py (path:/tmp/pip-Sd7BJN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:58:48 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)) 16:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:58:48 INFO - Running setup.py (path:/tmp/pip-z_ct2b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:58:48 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)) 16:58:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:58:48 INFO - Running setup.py (path:/tmp/pip-AlyKaH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:58:48 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)) 16:58:48 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)) 16:58:48 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)) 16:58:48 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)) 16:58:48 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)) 16:58:48 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)) 16:58:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:58:48 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 16:58:48 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 16:58:48 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 16:58:48 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 16:58:48 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 16:58:48 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 16:58:49 INFO - Downloading blessings-1.6.tar.gz 16:58:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:58:50 INFO - Installing collected packages: blessings 16:58:50 INFO - Running setup.py install for blessings 16:58:50 INFO - Successfully installed blessings 16:58:50 INFO - Cleaning up... 16:58:50 INFO - Return code: 0 16:58:50 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:58:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:58:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:58:50 INFO - Reading from file tmpfile_stdout 16:58:50 INFO - Current package versions: 16:58:50 INFO - argparse == 1.2.1 16:58:50 INFO - blessings == 1.6 16:58:50 INFO - blobuploader == 1.2.4 16:58:50 INFO - docopt == 0.6.1 16:58:50 INFO - manifestparser == 1.1 16:58:50 INFO - mozInstall == 1.12 16:58:50 INFO - mozcrash == 0.16 16:58:50 INFO - mozdebug == 0.1 16:58:50 INFO - mozdevice == 0.48 16:58:50 INFO - mozfile == 1.2 16:58:50 INFO - mozhttpd == 0.7 16:58:50 INFO - mozinfo == 0.9 16:58:50 INFO - mozleak == 0.1 16:58:50 INFO - mozlog == 3.1 16:58:50 INFO - moznetwork == 0.27 16:58:50 INFO - mozprocess == 0.22 16:58:50 INFO - mozprofile == 0.28 16:58:50 INFO - mozrunner == 6.11 16:58:50 INFO - mozscreenshot == 0.1 16:58:50 INFO - mozsystemmonitor == 0.0 16:58:50 INFO - moztest == 0.7 16:58:50 INFO - mozversion == 1.4 16:58:50 INFO - psutil == 3.1.1 16:58:50 INFO - requests == 1.2.3 16:58:50 INFO - wsgiref == 0.1.2 16:58:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:50 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 0x7fe2d6194f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1209480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298660>, '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 0x1299560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1299a10>, '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': '6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277', '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 16:58:50 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 16:58:50 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 16:58:50 INFO - Using env: {'DISPLAY': ':0', 16:58:50 INFO - 'HOME': '/home/cltbld', 16:58:50 INFO - 'LANG': 'en_US.UTF-8', 16:58:50 INFO - 'LANGUAGE': 'en_US:en', 16:58:50 INFO - 'LOGNAME': 'cltbld', 16:58:50 INFO - 'MAIL': '/var/mail/cltbld', 16:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:50 INFO - 'MOZ_NO_REMOTE': '1', 16:58:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:50 INFO - 'NO_EM_RESTART': '1', 16:58:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:50 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:50 INFO - 'SHELL': '/bin/bash', 16:58:50 INFO - 'SHLVL': '1', 16:58:50 INFO - 'TERM': 'linux', 16:58:50 INFO - 'TMOUT': '86400', 16:58:50 INFO - 'USER': 'cltbld', 16:58:50 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277', 16:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:50 INFO - '_': '/tools/buildbot/bin/python'} 16:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:50 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)) 16:58:50 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)) 16:58:50 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)) 16:58:50 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)) 16:58:50 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)) 16:58:50 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)) 16:58:50 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)) 16:58:50 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)) 16:58:50 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)) 16:58:50 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)) 16:58:50 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)) 16:58:50 INFO - Cleaning up... 16:58:50 INFO - Return code: 0 16:58:50 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:50 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 0x7fe2d6194f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1209480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298660>, '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 0x1299560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1299a10>, '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': '6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277', '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 16:58:50 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 16:58:50 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 16:58:50 INFO - Using env: {'DISPLAY': ':0', 16:58:50 INFO - 'HOME': '/home/cltbld', 16:58:50 INFO - 'LANG': 'en_US.UTF-8', 16:58:50 INFO - 'LANGUAGE': 'en_US:en', 16:58:50 INFO - 'LOGNAME': 'cltbld', 16:58:50 INFO - 'MAIL': '/var/mail/cltbld', 16:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:50 INFO - 'MOZ_NO_REMOTE': '1', 16:58:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:50 INFO - 'NO_EM_RESTART': '1', 16:58:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:50 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:50 INFO - 'SHELL': '/bin/bash', 16:58:50 INFO - 'SHLVL': '1', 16:58:50 INFO - 'TERM': 'linux', 16:58:50 INFO - 'TMOUT': '86400', 16:58:50 INFO - 'USER': 'cltbld', 16:58:50 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277', 16:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:50 INFO - '_': '/tools/buildbot/bin/python'} 16:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:50 INFO - Downloading/unpacking jsonschema 16:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:58:52 INFO - Downloading/unpacking functools32 (from jsonschema) 16:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:52 INFO - Downloading functools32-3.2.3-2.tar.gz 16:58:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:58:52 INFO - warning: no files found matching '*.txt' 16:58:52 INFO - no previously-included directories found matching 'build' 16:58:52 INFO - no previously-included directories found matching 'dist' 16:58:52 INFO - no previously-included directories found matching '.git*' 16:58:52 INFO - Installing collected packages: jsonschema, functools32 16:58:53 INFO - Running setup.py install for functools32 16:58:53 INFO - warning: no files found matching '*.txt' 16:58:53 INFO - no previously-included directories found matching 'build' 16:58:53 INFO - no previously-included directories found matching 'dist' 16:58:53 INFO - no previously-included directories found matching '.git*' 16:58:53 INFO - Successfully installed jsonschema functools32 16:58:53 INFO - Cleaning up... 16:58:53 INFO - Return code: 0 16:58:53 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:58:53 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')]} 16:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:53 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')]} 16:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:53 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 0x7fe2d6194f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1209480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298660>, '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 0x1299560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1299a10>, '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': '6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277', '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 16:58:53 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 16:58:53 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 16:58:53 INFO - Using env: {'DISPLAY': ':0', 16:58:53 INFO - 'HOME': '/home/cltbld', 16:58:53 INFO - 'LANG': 'en_US.UTF-8', 16:58:53 INFO - 'LANGUAGE': 'en_US:en', 16:58:53 INFO - 'LOGNAME': 'cltbld', 16:58:53 INFO - 'MAIL': '/var/mail/cltbld', 16:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:53 INFO - 'MOZ_NO_REMOTE': '1', 16:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:53 INFO - 'NO_EM_RESTART': '1', 16:58:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:58:53 INFO - 'PWD': '/builds/slave/test-pgo', 16:58:53 INFO - 'SHELL': '/bin/bash', 16:58:53 INFO - 'SHLVL': '1', 16:58:53 INFO - 'TERM': 'linux', 16:58:53 INFO - 'TMOUT': '86400', 16:58:53 INFO - 'USER': 'cltbld', 16:58:53 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277', 16:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:53 INFO - '_': '/tools/buildbot/bin/python'} 16:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:53 INFO - Downloading/unpacking flake8 16:58:53 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 16:58:53 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 16:58:53 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 16:58:53 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 16:58:53 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 16:58:53 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 16:58:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:58:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:58:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:58:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:58:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:58:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:58:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:58:55 INFO - no previously-included directories found matching 'docs/_build' 16:58:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:58:55 INFO - Running setup.py install for pep8 16:58:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:58:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:58:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:58:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:58:55 INFO - no previously-included directories found matching 'docs/_build' 16:58:55 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:58:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:58:55 INFO - Cleaning up... 16:58:56 INFO - Return code: 0 16:58:56 INFO - Running post-action listener: _resource_record_post_action 16:58:56 INFO - Running post-action listener: _start_resource_monitoring 16:58:56 INFO - Starting resource monitoring. 16:58:56 INFO - ##### 16:58:56 INFO - ##### Running install step. 16:58:56 INFO - ##### 16:58:56 INFO - Running pre-action listener: _resource_record_pre_action 16:58:56 INFO - Running main action method: install 16:58:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:58:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:58:56 INFO - Reading from file tmpfile_stdout 16:58:56 INFO - Detecting whether we're running mozinstall >=1.0... 16:58:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:58:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:58:56 INFO - Reading from file tmpfile_stdout 16:58:56 INFO - Output received: 16:58:56 INFO - Usage: mozinstall [options] installer 16:58:56 INFO - Options: 16:58:56 INFO - -h, --help show this help message and exit 16:58:56 INFO - -d DEST, --destination=DEST 16:58:56 INFO - Directory to install application into. [default: 16:58:56 INFO - "/builds/slave/test-pgo"] 16:58:56 INFO - --app=APP Application being installed. [default: firefox] 16:58:56 INFO - mkdir: /builds/slave/test-pgo/build/application 16:58:56 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'] 16:58:56 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 16:59:12 INFO - Reading from file tmpfile_stdout 16:59:12 INFO - Output received: 16:59:12 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:59:12 INFO - Running post-action listener: _resource_record_post_action 16:59:12 INFO - ##### 16:59:12 INFO - ##### Running run-tests step. 16:59:12 INFO - ##### 16:59:12 INFO - Running pre-action listener: _resource_record_pre_action 16:59:12 INFO - Running main action method: run_tests 16:59:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:59:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:59:12 INFO - Python 2.7.3 16:59:12 INFO - Return code: 0 16:59:12 INFO - grabbing minidump binary from tooltool 16:59: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')]} 16:59:12 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 0x1298660>, '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 0x1299560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1299a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:59:12 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 16:59:12 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 16:59:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:59:12 INFO - Return code: 0 16:59:12 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:59:12 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:59:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:59:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:59:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:59:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:59:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:59:13 INFO - Return code: 0 16:59:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 16:59:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:59:13 INFO - Using env: {'DISPLAY': ':0', 16:59:13 INFO - 'HOME': '/home/cltbld', 16:59:13 INFO - 'LANG': 'en_US.UTF-8', 16:59:13 INFO - 'LANGUAGE': 'en_US:en', 16:59:13 INFO - 'LOGNAME': 'cltbld', 16:59:13 INFO - 'MAIL': '/var/mail/cltbld', 16:59:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:59:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:13 INFO - 'MOZ_NO_REMOTE': '1', 16:59:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:59:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:13 INFO - 'NO_EM_RESTART': '1', 16:59:13 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:59:13 INFO - 'PWD': '/builds/slave/test-pgo', 16:59:13 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:59:13 INFO - 'SHELL': '/bin/bash', 16:59:13 INFO - 'SHLVL': '1', 16:59:13 INFO - 'TERM': 'linux', 16:59:13 INFO - 'TMOUT': '86400', 16:59:13 INFO - 'USER': 'cltbld', 16:59:13 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277', 16:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:13 INFO - '_': '/tools/buildbot/bin/python'} 16:59:13 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:59:13 INFO - mozversion application_buildid: 20160124143004 16:59:13 INFO - mozversion application_changeset: c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7 16:59:13 INFO - mozversion application_display_name: Nightly 16:59:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:59:13 INFO - mozversion application_name: Firefox 16:59:13 INFO - mozversion application_remotingname: firefox 16:59:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:59:13 INFO - mozversion application_vendor: Mozilla 16:59:13 INFO - mozversion application_version: 46.0a1 16:59:13 INFO - mozversion platform_buildid: 20160124143004 16:59:13 INFO - mozversion platform_changeset: c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7 16:59:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:59:13 INFO - mozversion platform_version: 46.0a1 16:59:13 INFO - using testdate: 1453683553 16:59:13 INFO - actual date: 1453683553 16:59:13 INFO - starting webserver on 'localhost:55013' 16:59:13 INFO - SUITE-START | Running 3 tests 16:59:13 INFO - TEST-START | dromaeo_css 16:59:13 INFO - operating with platform_type : linux_ 16:59:13 INFO - Initialising browser for dromaeo_css test... 16:59:13 INFO - TEST-INFO | started process 1297 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7Th04y/profile http://localhost:55013/getInfo.html) 16:59:17 INFO - PROCESS | 1297 | 16:59:17 INFO - PROCESS | 1297 | (process:1378): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:59:18 INFO - PROCESS | 1297 | __metrics Screen width/height:1600/1200 16:59:18 INFO - PROCESS | 1297 | colorDepth:24 16:59:18 INFO - PROCESS | 1297 | Browser inner width/height: 1024/697 16:59:18 INFO - PROCESS | 1297 | __metrics 16:59:18 INFO - PROCESS | 1297 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:59:19 INFO - TEST-INFO | 1297: exit 0 16:59:19 INFO - Browser initialized. 16:59:19 INFO - Running cycle 1/1 for dromaeo_css test... 16:59:19 INFO - TEST-INFO | started process 1428 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7Th04y/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:59:20 INFO - PROCESS | 1428 | 16:59:20 INFO - PROCESS | 1428 | (process:1486): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:59:30 INFO - PROCESS | 1428 | RSS: Main: 151584768 16:59:30 INFO - PROCESS | 1428 | 17:00:20 INFO - PROCESS | 1428 | 1453683620546 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:02:28 INFO - PROCESS | 1428 | Cycle 1(1): loaded http://localhost:55013/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55013/tests/dromaeo/cssquery-ext.html) 17:02:30 INFO - PROCESS | 1428 | RSS: Main: 162074624 17:02:30 INFO - PROCESS | 1428 | 17:05:32 INFO - PROCESS | 1428 | Cycle 1(1): loaded http://localhost:55013/tests/dromaeo/cssquery-ext.html (next: http://localhost:55013/tests/dromaeo/cssquery-jquery.html) 17:05:32 INFO - PROCESS | 1428 | RSS: Main: 157454336 17:05:32 INFO - PROCESS | 1428 | 17:08:34 INFO - PROCESS | 1428 | Cycle 1(1): loaded http://localhost:55013/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55013/tests/dromaeo/cssquery-mootools.html) 17:08:35 INFO - PROCESS | 1428 | RSS: Main: 156401664 17:08:35 INFO - PROCESS | 1428 | 17:11:36 INFO - PROCESS | 1428 | Cycle 1(1): loaded http://localhost:55013/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55013/tests/dromaeo/cssquery-prototype.html) 17:11:37 INFO - PROCESS | 1428 | RSS: Main: 155430912 17:11:37 INFO - PROCESS | 1428 | 17:14:39 INFO - PROCESS | 1428 | Cycle 1(1): loaded http://localhost:55013/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55013/tests/dromaeo/cssquery-yui.html) 17:14:40 INFO - PROCESS | 1428 | RSS: Main: 154501120 17:14:40 INFO - PROCESS | 1428 | 17:17:42 INFO - PROCESS | 1428 | Cycle 1(1): loaded http://localhost:55013/tests/dromaeo/cssquery-yui.html (next: http://localhost:55013/tests/dromaeo/cssquery-dojo.html) 17:17:43 INFO - PROCESS | 1428 | RSS: Main: 158285824 17:17:43 INFO - PROCESS | 1428 | 17:17:43 INFO - PROCESS | 1428 | __start_tp_report 17:17:43 INFO - PROCESS | 1428 | _x_x_mozilla_page_load 17:17:43 INFO - PROCESS | 1428 | _x_x_mozilla_page_load_details 17:17:43 INFO - PROCESS | 1428 | |i|pagename|runs| 17:17:43 INFO - PROCESS | 1428 | |0;dojo.html;3142.8585713642888;3175.3331800321916;3182.2203560127773;3192.55304257404;3219.0021093461028;5147.279380886679;5194.948050519493;5225.947740522598;5227.503387178222;5247.055530004598;5186.507281808223;5189.584833213344;5232.032074066291;5233.476652334764;5333.466653334664;4748.477667456577;4763.404574428197;4815.205491093965;4850.345203397549;4888.926666100011;528.2245348470512;4547.204239258133;4715.811367545294;4796.3045358423005;4811.879703007417;4772.522747725235;4802.759862006903;4816.903661926777;4822.252550854623;4856.830010949618;4823.397075365579;4835.081334546425;4842.903141937177;4856.417229932431;4871.4397844248015;4712.222483290253;4734.289856521515;4789.377380940456;4825.034993001414;4859.5383438573635;4982;5034.4713805050305;5058.772355244023;5065.974670126662;5112.539871411591;5542.168674698787;5550.139728342114;5552.500274975231;5561.082421400464;5583.944160558383;5588.888222235573;5653.406392328829;5659.6321239119325;5666.490015898547;5729.942700572982;5338.199270109476;5346.4118946915805;5347.2781174541715;5360.2227676987;5367.43641917597;5798.420157984167;5834.649921004753;5838.095095260242;5846.912296315559;5871.236739223874;5396.3524377075;5404.216388623628;5424.077906755861;5454.318210223722;5574.1917421973585;5669.2346533218315;5678.290213723285;5689.800856969986;5702.31572211329;5712.485876271156;5634.464725851038;5635.492805647511;5648.604597678123;5651.350094739076;5660.518855897212;5477.068898287301;5477.75350109246;5485.725713714299;5616.522595579339;5623.409541998113;4386.210482113251;4400.515943246241;4403.603675669206;4423.07115505741;4449.510553839075;3860.0542866997766;3902.6097390260747;3935.1539419024475;3941.625545573166;3958.8218530166214;5225.320708307896;5240.895182096413;5314.1497360422145;5316.229146773696;5318;5556.16657501378;5576.776928922797;5589.580781441408;5592.86017849557;5603.859903502445;5239.633225674166;5248.212768084818;5254.894902101936;5268.947310526923;5299.31108955841;4686.062787442525;4790.592799612072;4812.735299558488;4855.417349918032;4857.587105096036;5695.572832037614;5733.483986441241;5750.396208398058;5750.7987220447085;5762.942370576325;5525.972370138124;5532.847873965696;5588.720563971704;5601.327840659147;5607.607467477319;5708.257926469532;5806.796762113306;5845.269341332333;5931.733072011683;5959.76160953557;5514.393416724238;5531.197976293334;5532.391436941853;5538.889222215614;5561.721913904208;5615.326160860723;5629.155626656035;5636.85907852307;5641.802536911188;5643.830685079454;5416.783328666809;5442.292501974876;5488.91766623493;5491.093969494988;5491.75287112073;5495.890082198253;5551.861203469945;5580.972095139498;5631.436856314336;5676.120201368794;5369.48989845964;5376.327959005124;5381.381141168816;5387.353517577916;5392.595555333287;5518.44815518461;5527;5534.529564987021;5542.972285138549;5550.333959924835;5347.037533243898;5368.677879327252;5417.51242388187;5427.1045277528765;5476.205950137128 17:17:43 INFO - PROCESS | 1428 | |1;ext.html;530.2073400266602;560.5627610463839;564.7373971103436;570.9229254050703;587.0460501684762;35675.82162089189;36180.276394472094;36256.81871590645;36351.4547281791;36482.270354592925;39468;39691.801540992325;39899.800500997524;39936;40115.39826902599;8347.91652083479;8562.272206862424;8583.227509524142;8584.74245772628;8634.697785577506;8321.958390208041;8420.747377578682;8470.957645211765;8719.564021798884;8739.868901966476;8704.347173961947;8731.607077681489;8754.6935857245;8774.912250877505;8779.561021948908;8643.2653224476;8652.956735216316;8751.60617772205;8768.210861022539;8770.868436973451;8541.231289183941;8644.351673624504;8666.696665616737;8675.56622168889;8694.304455643596;38412.23175536474;38481.80759096215;38685.61314386848;38712.225755485015;38977.61022389768;3123.484625036866;3291.210109573709;3297.6207736110414;3378.189234583707;3680.5031320771623;29174.124776256747;29194.562081568794;29242.268943276376;29326.70673293261;29620.851895740383;3969.861054863095;4030.6573941215033;4067.959320406788;4124.979375103136;4133.46264985553;258677;260697.9999999981;260699;261554;263036;48304.27543586849;49535.25697114546;54491.18263226055;54509.72745136249;54751.178732319044;59587.404125958186;60482;60936.69531652313;61195.694021529605;61530.69234653798;13670.384832682554;13757.862421375658;14149;14163.150210987375;14249.073810202304;10798.73003174927;10836.970487803646;10847.403392813314;10911.618093366695;10921.617743378943;18127.18427670758;18272.177752000927;18399.448016559523;18814;19058.714119288223;7346.96326518364;7533.773986780406;7583.848323033509;7665.61671916402;7729.227077292226;982;993.4734590666958;1023.744063984004;1034.332855308322;1044.2272718188638;25777;26642.333941651614;27542.724572754018;28775.424491510053;31176.22059448532;1031.7781676939344;1051.4322265976286;1054.7626783973699;1073.5222825842425;1074.9032587067202;13315.66710832237;13547.390367433489;13614.659633509242;13645.11306765057;13738.381772820247;319470;320830;321924;322546;322725;48612.5138748608;48772.75613621909;48930;48987.26519102216;49136.75431622891;1365.9521916732867;1375.3879523611897;1376.7027968016744;1376.827896512936;1387.9861201387857;25233.243002709947;25971.22086337413;26461.867690661424;26469.33826654349;26629.334266643487;41680.3747943775;41778.37332439955;42054.36918446287;42210.15579688328;42283;292737;294362;297460;297980;298401;27729;28035.299117522227;29365.26586835346;30665.386692266475;31140.688593114686;36489.270214596094;36930.44604330883;37145.25709485849;37584.812075939444;37736.245275094894;31098.378032439676;31165.844170779;31517;31935;32229.35541289208;31293;31478.52782208223;31520.52719209168;31526.211844704067;31790.682093179697;34984.650153499155;35288.29423411466;35493.645063550066;35645.287094258485;35923;28251.293717657223;29162.562561561168;31405.214869628442;31776.470471522807;32196.83901580477;24767.876160619082;24835.25494235176;24981.75018249867;25315.367115822253;25400.872995635644 17:17:43 INFO - PROCESS | 1428 | |2;jquery.html;358.14760869131464;359.7086360048361;363.1629094936172;365.9249853779975;370.71084554047854;15640.84359156408;16263.918680406596;16608.25262863171;16835.83164168358;17359.566010849736;15502.767458488132;15731.213439328016;15994.440194593191;16460.259288332025;16484.67030659389;4986.650934434591;5165.302684137631;5165.354330708661;5183.870403239912;5198.064348417283;5038.294638750578;5053.242013697938;5136.43499215086;5512.834614961557;5557.527610153142;5490.478404551562;5513.173024046405;5528.253685752432;5708.885822283572;5726.083826587746;5464.180372944071;5586.692731899744;5644.6613203207735;6062.242219722535;6084.5436592255755;5404.486573775485;5413.64811287269;5416.647917885364;5423.755930983115;5432.837014889559;16986.235619397157;19020.334288299844;19656.41030769065;19669.606607867907;19826.900865495725;2149.9892500537553;2176.1404245323165;2210.303754317385;2249.4039079643744;2302.1712183613886;12641.304728239944;12649;12774.552890648876;12858.678533036655;13126.409311580906;1761.2778760708047;1811.6376724655122;1835.6695794756938;1857.7399164117035;1861.7300491428803;51464;52099.73950130263;54103.45896541024;54520.45479545194;55273.9999999996;9694.272929530314;9778.804423911482;10097.44464054484;10124.797504050026;10128.44293563861;13113.541026064042;13189;13214.405351759195;13215.801762973562;13236.669083272802;6868.244493105754;6961.37347638715;7130.964345178241;7240.565566066053;7262.491625586158;6793.252742198354;6846.938724497711;6863.2793556676825;6868.587884726832;6930.5148639594745;4330.913381732347;4365.410669559569;4387.188370151533;4393.84621538251;4398.846040388571;1776.840084392411;1812.7643406357354;1847.8059803720416;1887.7829049659465;1897.7532920720494;897.8383890899701;980.8970058143935;1015.4618052432223;1048.8059708953867;1089.8147314956477;15731.528054158394;15779.132147731985;16203.756943645854;16306.918465407834;16437.753433698505;894.2398960883197;951.833429149896;989.9208063354914;1003.6286573967678;1005.627917670452;9440.48077355752;9460.621575136918;9510.33427660071;9514.187168090979;9536.2371010319;461577;474589;491596;498468;505631;40725;46016.53983460189;57981.55046123797;67006;67146.328536714;1069.3690722473623;1079.9794194486135;1082.1505118481955;1098.8406681031365;1114.403793970222;13808.447662093404;14324.355404006636;15224.771628425804;15301.464448744686;15522.146281954601;31910.84044579762;31941.20146996344;32997.67002329946;33137.337253254314;33751.83124084364;37483.250334992605;38517.2296554073;38858.6114138855;39251.80374098226;40474.39288410735;7107.253738357605;7114.14630244374;7158.141023077264;7256.637168141678;7489.925100748923;7298.868950081956;9814.214862810815;10119.949400252952;10379.688609341732;10455.529501172314;6845.623490708059;7064.929350706633;7160.785176444715;7391.334779869838;7582.279683430065;7026.402755765817;7523.473356864967;7558.622068896423;7664.578448185181;7796.84406311882;7305.305995930378;7338.192798792022;7474.92525074764;7499.100107987077;7543.3965282778345;9966.103050725469;10176.542055607368;10241.07830295277;10322;10391.324563903323;9471.384360016576;9587.376820506644;9601.951990240004;9685.70942871715;9688.612455501701 17:17:43 INFO - PROCESS | 1428 | |3;mootools.html;1468.8017117689112;1490.8360080391155;1633.5671047172493;1724.887882287652;1756.7013607686692;7644.885326720104;7710.460267781257;7790.610469476518;7866.449348545597;7922.366210703144;7859.096203936549;7891.684332626688;7945.523268603888;8007.799805004878;8048.798780030487;2286.6912966749483;2298.092253559843;2303.2284184798027;2307.7692230776956;2309.168699268262;2309;2319.721633403994;2347.190219374313;2347.80043696286;2357.045396614374;2240.0143936667896;2263.6265016272378;2290.9770902291016;2300.7124109486313;2303.9078436862505;2230.4200907764016;2249.2352600115873;2253.549290141978;2267.3764714703425;2268.5122698619875;2260.2541161416693;2309.572729045132;2317.9420514487106;2321.976780232193;2329.5457385809773;7343.742968996113;7371.410287177013;7380.630968451556;7403.703851845919;7413.481056326059;4594.9310760338285;4739.857804265843;4740.620750339999;4777.59390451812;4815.036992601459;3048.3903219356216;3089.845507724605;3155.921101972446;3182.204448887778;3184.1561986073707;1038.6260946059413;1051.3218973761957;1051.5898799468214;1070.7002039428971;1091.5197313182175;10570.577176912915;10772.515236814363;10800.86590907959;10804.837927431096;10833.566657333697;4303.698741088094;4343.522212556616;4432.423784907941;4439.755813430228;4445.310976798602;9430.056994300652;9446.622135114656;9447.622095116256;9469.810603787886;9478.241740660731;4655.883602909955;4699.694519856198;4708.199606066977;4723.622110231173;4740.691855029412;4215.747055176699;4225.556316586775;4229.534751177368;4230.49234091911;4247.745135291892;3660.432632941898;3733.9439908401396;3735.738498305147;3739.719521035933;3759.3045286622064;1161.9360935148648;1171.2738102376582;1197.4731118307916;1197.736497970445;1207.879212078785;948.7106432538142;998.6904059741504;1102.9613963511238;1177.1642134084725;1303.6024012676226;7155.570665760071;7231.132264128233;7255.020572222682;7265.927340726631;7280.199178090405;602.0908428273251;623.7660877171061;623.9188905442263;627.6234259444296;756.9583672898043;5582.190582365534;5601.467860553241;5710.7430165642645;5717.113847353667;5723.8569035774435;9110.180083792358;9381.249500039981;9455.621775128919;9772.706818795448;9772.951135244279;9271.536423178948;9287.72136835896;9341.252699784001;9444.291678124167;9520.047995200563;7413;7523.962380188064;7527.736529221451;7528.698852045966;7593.506422082436;6966.825829354307;7224.241454647186;7232.602206878672;7233.095863017123;7249.8400255958795;8403.621837017226;8498.787530311545;8585.785355365915;8635.95682021611;8688.087750786077;8586.22723954847;8752.037275899518;8765.34259930495;8779.648814047621;8827.293816494794;6915.03189553473;6982.7206911725;7069;7080.398166155728;7097.361237488651;7444;7453.180150183367;7515.586642734702;7517.060367454068;7548.282913123245;7018.859622807618;7083.858322833411;7176.138863336433;7265.418766498773;7271.454640901848;6227.221597300338;6792.864142717217;6874.6562671867205;6992.0910281663055;7187.065681461377;6797.490188236001;6889.242183359726;6914.654267286716;6930.341617546325;6962.3733863950465;6463.127477790438;6473.287938326686;6494.902576461452;6509.902351464826;6515.869682606416;6286.339934307015;6388.840278993062;6429.935700643121;6522.804315870531;6533.379328963741 17:17:43 INFO - PROCESS | 1428 | |4;prototype.html;338.8136524911298;340.3108704872633;350.9789412635241;351.77310634640673;353.008047386843;6162.630242185472;6294.527910406715;6304.180456540649;6310.684465776716;6328.968355158224;6045.758169673208;6147.846303842406;6176.011838105904;6199.969000155004;6220.533459990496;4765.857024289259;4790.161721698706;4807.567318941295;4812.759362031902;4814.1334559779225;4789.712617242959;4794.42466903972;4806.927896081562;4813.037392521493;4823.975880120594;4686.765661716918;4752.952470475286;4767.833125840596;4770.165221086313;4777.80888764449;4763.69036012658;4776.546228108324;4776.976115119437;4791.664583479158;4794.9520504794855;4201.2017716633745;4203.864956461769;4207.863876753259;4215.861717336333;4228.9154216915485;5920.319163296233;5952.3154837193415;5953.732082056318;5968.552358573081;5978.730957106941;5388.568914486832;5499.065158922953;5529.972350138264;5537.418571050022;5566.2207290979295;6550.984597387413;6580.605163690194;6589.505787065989;6593.472522198213;6595.8021259362295;4612.538746125394;4616.192166370905;4618.769061546943;4635.11932732783;4650.604698600623;6618.635975021371;6847.527781526946;6869.862602747967;6895.172579290517;6913.619750913697;4733.881652958704;4747.098051370229;4762.3808904842845;4762.9523704763205;4768.7615619218905;4812.398450193726;4818.156822556109;4818.542238487338;4823;4833.661643684908;5514.172874068841;5524.364698059694;5537.889242215133;5542.140968149944;5554.944450555524;6501.284858665543;6592.17597800275;6637.601743895381;6643.2360278568585;6649.667516624149;1625.9024458532526;1666.1835700506665;1666.7916510436196;1666.9499915002568;1675.3968571314317;1096.0792933935531;1107.9944600277108;1108.0415440643947;1114.2701530497536;1117.3351855645878;6196.628202307876;6200.596961197508;6247.312795592481;6252.3122456529745;6275.152854364603;6675.232348279913;6683.832904177434;6706.530542861953;6717.899231511531;6723.663816809238;6069.666168360783;6190.133381326618;6190.721417536221;6212.192414986113;6212.689365531705;3634.109643137448;3646.8176591170336;3667.889963301052;3675.4854320395166;3693.5013773140818;7006.824829379204;7020.7542736004;7027;7040.436765058783;7048.118985126859;6877.65611719412;6907.7236910524025;6916.412104971033;6929.237783843773;6957.756478523227;7142.857142857114;7156.499045066899;7188.820279493055;7210.459215558854;7247.2390399009455;6841.794746157623;6867.313268673092;6868.793936181923;6880.552764070319;6936.826579335557;6717.764878229434;6868.0769384572395;6868.553544019623;6872.553284036521;6876.346747059021;7152.356287934111;7214;7219.8556028880175;7223.386012188813;7249.927500724925;4693.389859318267;4710.105080034782;4716.3868697069165;4729.385179926588;4732.526747325378;6752.122224111031;6917.204521480095;6943.513954023372;6962.7911162665205;6968.6864091115;6649.900251496329;6697.497687673346;6727;6765.661716914233;6769.898451523132;6755.831104222434;6759.662016899234;6759.898601520883;6761.188657361148;6767.898481522682;6441.3880681335195;6567.605943643397;6571.080048793268;6592.077109204619;6612.23959244693;6722.563033402813;6748.527603067738;6765.86468270622;6784.118064651564;6792.490563207681;6534.215894092739;6579.342065793382;6601.735930562916;6605.207375115017;6607.7356905725155 17:17:43 INFO - PROCESS | 1428 | |5;yui.html;773.2151865856156;831.8752187171928;853.9103394143615;860.393422637041;866.0516734176078;13042.608721738352;13123.671908202276;13188.472461101544;13230.536931207409;13264.867351326484;11737.178397512178;11865.169438139334;12582.559610413637;12584.622461326175;12668.936655316711;794.5749024272016;809.4172196018857;809.4495742894829;811.7402431222012;818.9877151842697;799.9080105787822;803.4014659078995;807.1283014344494;808.9191080891893;810.6635746165334;849.7195925344653;851.5188918261193;852.1904191018526;855.3969451536683;859.2696208223023;844.5819319436856;848.367965865428;850.587465079436;855.5123579559654;857.5540718826238;628.6542401679104;630.2027934662656;631.4790298004165;631.9778807741753;633.1294470103608;12010.759784804342;12042.157049006573;12084.456199471046;12142.392880356036;12192.57325993586;10505.684829455053;10783.245172837904;10890.67327980154;10991.395473248967;11177.49701263445;9532.475713835736;9626.326157169002;9710.854337184948;9712.22302215821;9856.90143098567;3427.4344733119005;3458.9654103458893;3496.318217947501;3598.964010359889;3603.94594081089;45253.77373113146;45844.541554584364;45958.310625340644;46061.53938460606;46212.5378746215;9593.664221752206;9819.852702209473;10033.654300244058;10151.64469243573;10152.23858210637;17035.659286814196;17084.231209595597;17102;17106.743398849027;17151.313947442213;7451.2921272479025;7505.474616776883;7538.208488108669;7671.3862890968585;7806.0632724073475;4256.446661933929;4259.893502662396;4288.442502474721;4328.242557552416;4340.348947657813;2994.895178668736;2995.026616349695;2998.14552852436;2999.895003674861;3020.5167173252175;552.8175702018324;566.2723400430509;575.786958825229;577.177522031104;581.8021872563348;541.0019952550654;583.7956715149663;620.2990620598695;689.5862482510454;691.9100516932766;8165.63254653542;8706.1729135732;8732.65069397217;8906.332025098143;8935.553222338856;562.8508445262008;568.7724910036019;588.7233000489763;644.9774257900951;659.0772917914861;3997.8200980955926;4085.4076158956786;4089.26393249218;4100.6924480664065;4201.369794530845;54918.72540637351;55042.449575504535;55083.44916550863;55399.44600554024;59420.70289648524;47070.29394559016;47230.527694722616;47547.76226118847;47692;48234.758826205645;42641.147177056286;42758;43846.561534384884;44846.77576612096;47037.05925881463;8850.159234872677;8861.33539984491;9225.538723063954;9312.813743724952;9471.715848524555;33715.494267586495;34073.48889766606;34093.14767130841;34214.48678269778;34741.47887781635;40777.18445631011;42045;42682;43034.35448468338;43249;11274.943625281821;11340.149488788209;11342.886571134513;11403.942980285046;11499.94250028778;11882.16824822254;11979.820302695642;12194.207376520499;12280.385980701109;12378.319192444502;11421.714457138638;11611.419429028347;11731.824022639497;11976.341301228516;12179;10882.455877206266;11104.500297486471;11971.341576213392;12029.278243305429;12441.377931103227;11423.657290281304;11565.942170289094;11601.245919015237;11965.880341196476;12042.63872083839;9464.432134071978;9760.56077476501;9894.505274736379;9907;10205.897941020792;9275.814483710423;9344.34589578723;9476.668316608886;9580.233581313618;10195.541200645841 17:17:43 INFO - PROCESS | 1428 | __end_tp_report 17:17:43 INFO - PROCESS | 1428 | __start_cc_report 17:17:43 INFO - PROCESS | 1428 | _x_x_mozilla_cycle_collect,309 17:17:43 INFO - PROCESS | 1428 | __end_cc_report 17:17:43 INFO - PROCESS | 1428 | __startTimestamp1453684663003__endTimestamp 17:17:43 INFO - PROCESS | 1428 | 17:17:43 INFO - PROCESS | 1428 | ------- Summary: start ------- 17:17:43 INFO - PROCESS | 1428 | Number of tests: 6 17:17:43 INFO - PROCESS | 1428 | 17:17:43 INFO - PROCESS | 1428 | [#0] dojo.html Cycles:165 Average:5197.35 Median:5396.35 stddev:672.26 (12.5%) stddev-sans-first:654.72 17:17:43 INFO - PROCESS | 1428 | Values: 3142.9 3175.3 3182.2 3192.6 3219.0 5147.3 5194.9 5225.9 5227.5 5247.1 5186.5 5189.6 5232.0 5233.5 5333.5 4748.5 4763.4 4815.2 4850.3 4888.9 528.2 4547.2 4715.8 4796.3 4811.9 4772.5 4802.8 4816.9 4822.3 4856.8 4823.4 4835.1 4842.9 4856.4 4871.4 4712.2 4734.3 4789.4 4825.0 4859.5 4982.0 5034.5 5058.8 5066.0 5112.5 5542.2 5550.1 5552.5 5561.1 5583.9 5588.9 5653.4 5659.6 5666.5 5729.9 5338.2 5346.4 5347.3 5360.2 5367.4 5798.4 5834.6 5838.1 5846.9 5871.2 5396.4 5404.2 5424.1 5454.3 5574.2 5669.2 5678.3 5689.8 5702.3 5712.5 5634.5 5635.5 5648.6 5651.4 5660.5 5477.1 5477.8 5485.7 5616.5 5623.4 4386.2 4400.5 4403.6 4423.1 4449.5 3860.1 3902.6 3935.2 3941.6 3958.8 5225.3 5240.9 5314.1 5316.2 5318.0 5556.2 5576.8 5589.6 5592.9 5603.9 5239.6 5248.2 5254.9 5268.9 5299.3 4686.1 4790.6 4812.7 4855.4 4857.6 5695.6 5733.5 5750.4 5750.8 5762.9 5526.0 5532.8 5588.7 5601.3 5607.6 5708.3 5806.8 5845.3 5931.7 5959.8 5514.4 5531.2 5532.4 5538.9 5561.7 5615.3 5629.2 5636.9 5641.8 5643.8 5416.8 5442.3 5488.9 5491.1 5491.8 5495.9 5551.9 5581.0 5631.4 5676.1 5369.5 5376.3 5381.4 5387.4 5392.6 5518.4 5527.0 5534.5 5543.0 5550.3 5347.0 5368.7 5417.5 5427.1 5476.2 17:17:43 INFO - PROCESS | 1428 | 17:17:43 INFO - PROCESS | 1428 | [#1] ext.html Cycles:180 Average:45016.86 Median:3337.91 stddev:76935.86 (2304.9%) stddev-sans-first:77079.18 17:17:43 INFO - PROCESS | 1428 | Values: 530.2 560.6 564.7 570.9 587.0 35675.8 36180.3 36256.8 36351.5 36482.3 39468.0 39691.8 39899.8 39936.0 40115.4 8347.9 8562.3 8583.2 8584.7 8634.7 8322.0 8420.7 8471.0 8719.6 8739.9 8704.3 8731.6 8754.7 8774.9 8779.6 8643.3 8653.0 8751.6 8768.2 8770.9 8541.2 8644.4 8666.7 8675.6 8694.3 38412.2 38481.8 38685.6 38712.2 38977.6 3123.5 3291.2 3297.6 3378.2 3680.5 29174.1 29194.6 29242.3 29326.7 29620.9 3969.9 4030.7 4068.0 4125.0 4133.5 258677.0 260698.0 260699.0 261554.0 263036.0 48304.3 49535.3 54491.2 54509.7 54751.2 59587.4 60482.0 60936.7 61195.7 61530.7 13670.4 13757.9 14149.0 14163.2 14249.1 10798.7 10837.0 10847.4 10911.6 10921.6 18127.2 18272.2 18399.4 18814.0 19058.7 7347.0 7533.8 7583.8 7665.6 7729.2 982.0 993.5 1023.7 1034.3 1044.2 25777.0 26642.3 27542.7 28775.4 31176.2 1031.8 1051.4 1054.8 1073.5 1074.9 13315.7 13547.4 13614.7 13645.1 13738.4 319470.0 320830.0 321924.0 322546.0 322725.0 48612.5 48772.8 48930.0 48987.3 49136.8 1366.0 1375.4 1376.7 1376.8 1388.0 25233.2 25971.2 26461.9 26469.3 26629.3 41680.4 41778.4 42054.4 42210.2 42283.0 292737.0 294362.0 297460.0 297980.0 298401.0 27729.0 28035.3 29365.3 30665.4 31140.7 36489.3 36930.4 37145.3 37584.8 37736.2 31098.4 31165.8 31517.0 31935.0 32229.4 31293.0 31478.5 31520.5 31526.2 31790.7 34984.7 35288.3 35493.6 35645.3 35923.0 28251.3 29162.6 31405.2 31776.5 32196.8 24767.9 24835.3 24981.8 25315.4 25400.9 17:17:43 INFO - PROCESS | 1428 | 17:17:43 INFO - PROCESS | 1428 | [#2] jquery.html Cycles:180 Average:25248.51 Median:25207.69 stddev:79318.90 (314.7%) stddev-sans-first:79519.39 17:17:43 INFO - PROCESS | 1428 | Values: 358.1 359.7 363.2 365.9 370.7 15640.8 16263.9 16608.3 16835.8 17359.6 15502.8 15731.2 15994.4 16460.3 16484.7 4986.7 5165.3 5165.4 5183.9 5198.1 5038.3 5053.2 5136.4 5512.8 5557.5 5490.5 5513.2 5528.3 5708.9 5726.1 5464.2 5586.7 5644.7 6062.2 6084.5 5404.5 5413.6 5416.6 5423.8 5432.8 16986.2 19020.3 19656.4 19669.6 19826.9 2150.0 2176.1 2210.3 2249.4 2302.2 12641.3 12649.0 12774.6 12858.7 13126.4 1761.3 1811.6 1835.7 1857.7 1861.7 51464.0 52099.7 54103.5 54520.5 55274.0 9694.3 9778.8 10097.4 10124.8 10128.4 13113.5 13189.0 13214.4 13215.8 13236.7 6868.2 6961.4 7131.0 7240.6 7262.5 6793.3 6846.9 6863.3 6868.6 6930.5 4330.9 4365.4 4387.2 4393.8 4398.8 1776.8 1812.8 1847.8 1887.8 1897.8 897.8 980.9 1015.5 1048.8 1089.8 15731.5 15779.1 16203.8 16306.9 16437.8 894.2 951.8 989.9 1003.6 1005.6 9440.5 9460.6 9510.3 9514.2 9536.2 461577.0 474589.0 491596.0 498468.0 505631.0 40725.0 46016.5 57981.6 67006.0 67146.3 1069.4 1080.0 1082.2 1098.8 1114.4 13808.4 14324.4 15224.8 15301.5 15522.1 31910.8 31941.2 32997.7 33137.3 33751.8 37483.3 38517.2 38858.6 39251.8 40474.4 7107.3 7114.1 7158.1 7256.6 7489.9 7298.9 9814.2 10119.9 10379.7 10455.5 6845.6 7064.9 7160.8 7391.3 7582.3 7026.4 7523.5 7558.6 7664.6 7796.8 7305.3 7338.2 7474.9 7499.1 7543.4 9966.1 10176.5 10241.1 10322.0 10391.3 9471.4 9587.4 9602.0 9685.7 9688.6 17:17:43 INFO - PROCESS | 1428 | 17:17:43 INFO - PROCESS | 1428 | [#3] mootools.html Cycles:180 Average:5484.72 Median:6446.53 stddev:2866.74 (44.5%) stddev-sans-first:2858.89 17:17:43 INFO - PROCESS | 1428 | Values: 1468.8 1490.8 1633.6 1724.9 1756.7 7644.9 7710.5 7790.6 7866.4 7922.4 7859.1 7891.7 7945.5 8007.8 8048.8 2286.7 2298.1 2303.2 2307.8 2309.2 2309.0 2319.7 2347.2 2347.8 2357.0 2240.0 2263.6 2291.0 2300.7 2303.9 2230.4 2249.2 2253.5 2267.4 2268.5 2260.3 2309.6 2317.9 2322.0 2329.5 7343.7 7371.4 7380.6 7403.7 7413.5 4594.9 4739.9 4740.6 4777.6 4815.0 3048.4 3089.8 3155.9 3182.2 3184.2 1038.6 1051.3 1051.6 1070.7 1091.5 10570.6 10772.5 10800.9 10804.8 10833.6 4303.7 4343.5 4432.4 4439.8 4445.3 9430.1 9446.6 9447.6 9469.8 9478.2 4655.9 4699.7 4708.2 4723.6 4740.7 4215.7 4225.6 4229.5 4230.5 4247.7 3660.4 3733.9 3735.7 3739.7 3759.3 1161.9 1171.3 1197.5 1197.7 1207.9 948.7 998.7 1103.0 1177.2 1303.6 7155.6 7231.1 7255.0 7265.9 7280.2 602.1 623.8 623.9 627.6 757.0 5582.2 5601.5 5710.7 5717.1 5723.9 9110.2 9381.2 9455.6 9772.7 9773.0 9271.5 9287.7 9341.3 9444.3 9520.0 7413.0 7524.0 7527.7 7528.7 7593.5 6966.8 7224.2 7232.6 7233.1 7249.8 8403.6 8498.8 8585.8 8636.0 8688.1 8586.2 8752.0 8765.3 8779.6 8827.3 6915.0 6982.7 7069.0 7080.4 7097.4 7444.0 7453.2 7515.6 7517.1 7548.3 7018.9 7083.9 7176.1 7265.4 7271.5 6227.2 6792.9 6874.7 6992.1 7187.1 6797.5 6889.2 6914.7 6930.3 6962.4 6463.1 6473.3 6494.9 6509.9 6515.9 6286.3 6388.8 6429.9 6522.8 6533.4 17:17:43 INFO - PROCESS | 1428 | 17:17:43 INFO - PROCESS | 1428 | [#4] prototype.html Cycles:180 Average:5554.68 Median:6212.44 stddev:1676.66 (27.0%) stddev-sans-first:1635.02 17:17:43 INFO - PROCESS | 1428 | Values: 338.8 340.3 351.0 351.8 353.0 6162.6 6294.5 6304.2 6310.7 6329.0 6045.8 6147.8 6176.0 6200.0 6220.5 4765.9 4790.2 4807.6 4812.8 4814.1 4789.7 4794.4 4806.9 4813.0 4824.0 4686.8 4753.0 4767.8 4770.2 4777.8 4763.7 4776.5 4777.0 4791.7 4795.0 4201.2 4203.9 4207.9 4215.9 4228.9 5920.3 5952.3 5953.7 5968.6 5978.7 5388.6 5499.1 5530.0 5537.4 5566.2 6551.0 6580.6 6589.5 6593.5 6595.8 4612.5 4616.2 4618.8 4635.1 4650.6 6618.6 6847.5 6869.9 6895.2 6913.6 4733.9 4747.1 4762.4 4763.0 4768.8 4812.4 4818.2 4818.5 4823.0 4833.7 5514.2 5524.4 5537.9 5542.1 5554.9 6501.3 6592.2 6637.6 6643.2 6649.7 1625.9 1666.2 1666.8 1666.9 1675.4 1096.1 1108.0 1108.0 1114.3 1117.3 6196.6 6200.6 6247.3 6252.3 6275.2 6675.2 6683.8 6706.5 6717.9 6723.7 6069.7 6190.1 6190.7 6212.2 6212.7 3634.1 3646.8 3667.9 3675.5 3693.5 7006.8 7020.8 7027.0 7040.4 7048.1 6877.7 6907.7 6916.4 6929.2 6957.8 7142.9 7156.5 7188.8 7210.5 7247.2 6841.8 6867.3 6868.8 6880.6 6936.8 6717.8 6868.1 6868.6 6872.6 6876.3 7152.4 7214.0 7219.9 7223.4 7249.9 4693.4 4710.1 4716.4 4729.4 4732.5 6752.1 6917.2 6943.5 6962.8 6968.7 6649.9 6697.5 6727.0 6765.7 6769.9 6755.8 6759.7 6759.9 6761.2 6767.9 6441.4 6567.6 6571.1 6592.1 6612.2 6722.6 6748.5 6765.9 6784.1 6792.5 6534.2 6579.3 6601.7 6605.2 6607.7 17:17:43 INFO - PROCESS | 1428 | 17:17:43 INFO - PROCESS | 1428 | [#5] yui.html Cycles:180 Average:13343.13 Median:45901.43 stddev:15175.61 (33.1%) stddev-sans-first:15188.82 17:17:43 INFO - PROCESS | 1428 | Values: 773.2 831.9 853.9 860.4 866.1 13042.6 13123.7 13188.5 13230.5 13264.9 11737.2 11865.2 12582.6 12584.6 12668.9 794.6 809.4 809.4 811.7 819.0 799.9 803.4 807.1 808.9 810.7 849.7 851.5 852.2 855.4 859.3 844.6 848.4 850.6 855.5 857.6 628.7 630.2 631.5 632.0 633.1 12010.8 12042.2 12084.5 12142.4 12192.6 10505.7 10783.2 10890.7 10991.4 11177.5 9532.5 9626.3 9710.9 9712.2 9856.9 3427.4 3459.0 3496.3 3599.0 3603.9 45253.8 45844.5 45958.3 46061.5 46212.5 9593.7 9819.9 10033.7 10151.6 10152.2 17035.7 17084.2 17102.0 17106.7 17151.3 7451.3 7505.5 7538.2 7671.4 7806.1 4256.4 4259.9 4288.4 4328.2 4340.3 2994.9 2995.0 2998.1 2999.9 3020.5 552.8 566.3 575.8 577.2 581.8 541.0 583.8 620.3 689.6 691.9 8165.6 8706.2 8732.7 8906.3 8935.6 562.9 568.8 588.7 645.0 659.1 3997.8 4085.4 4089.3 4100.7 4201.4 54918.7 55042.4 55083.4 55399.4 59420.7 47070.3 47230.5 47547.8 47692.0 48234.8 42641.1 42758.0 43846.6 44846.8 47037.1 8850.2 8861.3 9225.5 9312.8 9471.7 33715.5 34073.5 34093.1 34214.5 34741.5 40777.2 42045.0 42682.0 43034.4 43249.0 11274.9 11340.1 11342.9 11403.9 11499.9 11882.2 11979.8 12194.2 12280.4 12378.3 11421.7 11611.4 11731.8 11976.3 12179.0 10882.5 11104.5 11971.3 12029.3 12441.4 11423.7 11565.9 11601.2 11965.9 12042.6 9464.4 9760.6 9894.5 9907.0 10205.9 9275.8 9344.3 9476.7 9580.2 10195.5 17:17:43 INFO - PROCESS | 1428 | -------- Summary: end -------- 17:17:43 INFO - PROCESS | 1428 | 17:17:43 INFO - TEST-INFO | 1428: exit 0 17:17:43 INFO - TEST-OK | dromaeo_css | took 1109927ms 17:17:43 INFO - TEST-START | kraken 17:17:43 INFO - operating with platform_type : linux_ 17:17:43 INFO - Initialising browser for kraken test... 17:17:43 INFO - TEST-INFO | started process 1671 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMS5fPY/profile http://localhost:55013/getInfo.html) 17:17:47 INFO - PROCESS | 1671 | 17:17:47 INFO - PROCESS | 1671 | (process:1742): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:17:48 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 17:17:48 INFO - PROCESS | 1671 | colorDepth:24 17:17:48 INFO - PROCESS | 1671 | Browser inner width/height: 1024/697 17:17:48 INFO - PROCESS | 1671 | __metrics 17:17:48 INFO - PROCESS | 1671 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:17:48 INFO - TEST-INFO | 1671: exit 0 17:17:48 INFO - Browser initialized. 17:17:48 INFO - Running cycle 1/1 for kraken test... 17:17:48 INFO - TEST-INFO | started process 1791 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMS5fPY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:17:50 INFO - PROCESS | 1791 | 17:17:50 INFO - PROCESS | 1791 | (process:1849): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:18:00 INFO - PROCESS | 1791 | RSS: Main: 151588864 17:18:00 INFO - PROCESS | 1791 | 17:18:03 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55013/tests/kraken/driver.html?testName=audio-beat-detection) 17:18:03 INFO - PROCESS | 1791 | RSS: Main: 154972160 17:18:03 INFO - PROCESS | 1791 | 17:18:06 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55013/tests/kraken/driver.html?testName=audio-dft) 17:18:07 INFO - PROCESS | 1791 | RSS: Main: 158597120 17:18:07 INFO - PROCESS | 1791 | 17:18:10 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55013/tests/kraken/driver.html?testName=audio-fft) 17:18:10 INFO - PROCESS | 1791 | RSS: Main: 149938176 17:18:10 INFO - PROCESS | 1791 | 17:18:12 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55013/tests/kraken/driver.html?testName=audio-oscillator) 17:18:13 INFO - PROCESS | 1791 | RSS: Main: 150163456 17:18:13 INFO - PROCESS | 1791 | 17:18:15 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55013/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:18:16 INFO - PROCESS | 1791 | RSS: Main: 151990272 17:18:16 INFO - PROCESS | 1791 | 17:18:19 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55013/tests/kraken/driver.html?testName=imaging-darkroom) 17:18:19 INFO - PROCESS | 1791 | RSS: Main: 151838720 17:18:19 INFO - PROCESS | 1791 | 17:18:23 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55013/tests/kraken/driver.html?testName=imaging-desaturate) 17:18:23 INFO - PROCESS | 1791 | RSS: Main: 152698880 17:18:23 INFO - PROCESS | 1791 | 17:18:26 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55013/tests/kraken/driver.html?testName=json-parse-financial) 17:18:27 INFO - PROCESS | 1791 | RSS: Main: 154914816 17:18:27 INFO - PROCESS | 1791 | 17:18:28 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55013/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:18:29 INFO - PROCESS | 1791 | RSS: Main: 155131904 17:18:29 INFO - PROCESS | 1791 | 17:18:31 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55013/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:18:31 INFO - PROCESS | 1791 | RSS: Main: 155414528 17:18:31 INFO - PROCESS | 1791 | 17:18:33 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55013/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:18:34 INFO - PROCESS | 1791 | RSS: Main: 154652672 17:18:34 INFO - PROCESS | 1791 | 17:18:36 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55013/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:18:37 INFO - PROCESS | 1791 | RSS: Main: 155189248 17:18:37 INFO - PROCESS | 1791 | 17:18:40 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55013/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:18:40 INFO - PROCESS | 1791 | RSS: Main: 155705344 17:18:40 INFO - PROCESS | 1791 | 17:18:42 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:55013/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55013/tests/kraken/driver.html?testName=ai-astar) 17:18:42 INFO - PROCESS | 1791 | RSS: Main: 155734016 17:18:42 INFO - PROCESS | 1791 | 17:18:42 INFO - PROCESS | 1791 | __start_tp_report 17:18:42 INFO - PROCESS | 1791 | _x_x_mozilla_page_load 17:18:42 INFO - PROCESS | 1791 | _x_x_mozilla_page_load_details 17:18:42 INFO - PROCESS | 1791 | |i|pagename|runs| 17:18:42 INFO - PROCESS | 1791 | |0;ai-astar;115;105;115;110;111;124;111;111;111;110 17:18:42 INFO - PROCESS | 1791 | |1;audio-beat-detection;156;128;156;185;127;157;159;135;178;130 17:18:42 INFO - PROCESS | 1791 | |2;audio-dft;163;162;161;163;161;163;166;164;165;163 17:18:42 INFO - PROCESS | 1791 | |3;audio-fft;73;77;75;73;74;73;142;73;76;73 17:18:42 INFO - PROCESS | 1791 | |4;audio-oscillator;97;97;137;97;97;96;141;96;97;136 17:18:42 INFO - PROCESS | 1791 | |5;imaging-gaussian-blur;109;110;110;110;111;110;109;110;110;109 17:18:42 INFO - PROCESS | 1791 | |6;imaging-darkroom;146;147;145;148;146;148;146;147;146;148 17:18:42 INFO - PROCESS | 1791 | |7;imaging-desaturate;97;96;97;98;96;96;97;96;96;96 17:18:42 INFO - PROCESS | 1791 | |8;json-parse-financial;59;62;58;60;59;61;59;58;73;57 17:18:42 INFO - PROCESS | 1791 | |9;json-stringify-tinderbox;68;70;69;67;72;68;67;68;68;68 17:18:42 INFO - PROCESS | 1791 | |10;stanford-crypto-aes;84;80;82;85;83;83;84;82;87;83 17:18:42 INFO - PROCESS | 1791 | |11;stanford-crypto-ccm;128;114;113;121;123;115;120;122;119;120 17:18:42 INFO - PROCESS | 1791 | |12;stanford-crypto-pbkdf2;135;140;143;140;140;129;141;143;139;138 17:18:42 INFO - PROCESS | 1791 | |13;stanford-crypto-sha256-iterative;68;65;67;68;68;66;68;67;66;65 17:18:42 INFO - PROCESS | 1791 | __end_tp_report 17:18:42 INFO - PROCESS | 1791 | __start_cc_report 17:18:42 INFO - PROCESS | 1791 | _x_x_mozilla_cycle_collect,734 17:18:42 INFO - PROCESS | 1791 | __end_cc_report 17:18:42 INFO - PROCESS | 1791 | __startTimestamp1453684722557__endTimestamp 17:18:42 INFO - PROCESS | 1791 | 17:18:42 INFO - PROCESS | 1791 | ------- Summary: start ------- 17:18:42 INFO - PROCESS | 1791 | Number of tests: 14 17:18:42 INFO - PROCESS | 1791 | 17:18:42 INFO - PROCESS | 1791 | [#0] ai-astar Cycles:10 Average:112.30 Median:111.00 stddev:4.97 (4.5%) stddev-sans-first:5.17 17:18:42 INFO - PROCESS | 1791 | Values: 115.0 105.0 115.0 110.0 111.0 124.0 111.0 111.0 111.0 110.0 17:18:42 INFO - PROCESS | 1791 | 17:18:42 INFO - PROCESS | 1791 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:156.50 stddev:20.65 (13.2%) stddev-sans-first:21.82 17:18:42 INFO - PROCESS | 1791 | Values: 156.0 128.0 156.0 185.0 127.0 157.0 159.0 135.0 178.0 130.0 17:18:42 INFO - PROCESS | 1791 | 17:18:42 INFO - PROCESS | 1791 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:1.60 (1.0%) stddev-sans-first:1.69 17:18:42 INFO - PROCESS | 1791 | Values: 163.0 162.0 161.0 163.0 161.0 163.0 166.0 164.0 165.0 163.0 17:18:42 INFO - PROCESS | 1791 | 17:18:42 INFO - PROCESS | 1791 | [#3] audio-fft Cycles:10 Average:80.90 Median:73.50 stddev:21.52 (29.3%) stddev-sans-first:22.63 17:18:42 INFO - PROCESS | 1791 | Values: 73.0 77.0 75.0 73.0 74.0 73.0 142.0 73.0 76.0 73.0 17:18:42 INFO - PROCESS | 1791 | 17:18:42 INFO - PROCESS | 1791 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:97.00 stddev:19.99 (20.6%) stddev-sans-first:20.71 17:18:42 INFO - PROCESS | 1791 | Values: 97.0 97.0 137.0 97.0 97.0 96.0 141.0 96.0 97.0 136.0 17:18:42 INFO - PROCESS | 1791 | 17:18:42 INFO - PROCESS | 1791 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 17:18:42 INFO - PROCESS | 1791 | Values: 109.0 110.0 110.0 110.0 111.0 110.0 109.0 110.0 110.0 109.0 17:18:42 INFO - PROCESS | 1791 | 17:18:42 INFO - PROCESS | 1791 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:1.06 (0.7%) stddev-sans-first:1.09 17:18:42 INFO - PROCESS | 1791 | Values: 146.0 147.0 145.0 148.0 146.0 148.0 146.0 147.0 146.0 148.0 17:18:42 INFO - PROCESS | 1791 | 17:18:42 INFO - PROCESS | 1791 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 17:18:42 INFO - PROCESS | 1791 | Values: 97.0 96.0 97.0 98.0 96.0 96.0 97.0 96.0 96.0 96.0 17:18:42 INFO - PROCESS | 1791 | 17:18:42 INFO - PROCESS | 1791 | [#8] json-parse-financial Cycles:10 Average:60.60 Median:59.50 stddev:4.60 (7.7%) stddev-sans-first:4.84 17:18:42 INFO - PROCESS | 1791 | Values: 59.0 62.0 58.0 60.0 59.0 61.0 59.0 58.0 73.0 57.0 17:18:42 INFO - PROCESS | 1791 | 17:18:42 INFO - PROCESS | 1791 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.00 stddev:1.51 (2.2%) stddev-sans-first:1.59 17:18:42 INFO - PROCESS | 1791 | Values: 68.0 70.0 69.0 67.0 72.0 68.0 67.0 68.0 68.0 68.0 17:18:42 INFO - PROCESS | 1791 | 17:18:42 INFO - PROCESS | 1791 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.50 stddev:1.89 (2.3%) stddev-sans-first:1.99 17:18:42 INFO - PROCESS | 1791 | Values: 84.0 80.0 82.0 85.0 83.0 83.0 84.0 82.0 87.0 83.0 17:18:42 INFO - PROCESS | 1791 | 17:18:42 INFO - PROCESS | 1791 | [#11] stanford-crypto-ccm Cycles:10 Average:119.50 Median:120.50 stddev:4.55 (3.8%) stddev-sans-first:3.64 17:18:42 INFO - PROCESS | 1791 | Values: 128.0 114.0 113.0 121.0 123.0 115.0 120.0 122.0 119.0 120.0 17:18:42 INFO - PROCESS | 1791 | 17:18:42 INFO - PROCESS | 1791 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.80 Median:140.00 stddev:4.16 (3.0%) stddev-sans-first:4.18 17:18:42 INFO - PROCESS | 1791 | Values: 135.0 140.0 143.0 140.0 140.0 129.0 141.0 143.0 139.0 138.0 17:18:42 INFO - PROCESS | 1791 | 17:18:42 INFO - PROCESS | 1791 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.50 stddev:1.23 (1.8%) stddev-sans-first:1.22 17:18:42 INFO - PROCESS | 1791 | Values: 68.0 65.0 67.0 68.0 68.0 66.0 68.0 67.0 66.0 65.0 17:18:42 INFO - PROCESS | 1791 | -------- Summary: end -------- 17:18:42 INFO - PROCESS | 1791 | 17:18:43 INFO - TEST-INFO | 1791: exit 0 17:18:43 INFO - TEST-OK | kraken | took 60020ms 17:18:43 INFO - TEST-START | v8_7 17:18:43 INFO - operating with platform_type : linux_ 17:18:43 INFO - Initialising browser for v8_7 test... 17:18:43 INFO - TEST-INFO | started process 2077 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpp08DQo/profile http://localhost:55013/getInfo.html) 17:18:47 INFO - PROCESS | 2077 | 17:18:47 INFO - PROCESS | 2077 | (process:2148): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:18:47 INFO - PROCESS | 2077 | __metrics Screen width/height:1600/1200 17:18:47 INFO - PROCESS | 2077 | colorDepth:24 17:18:47 INFO - PROCESS | 2077 | Browser inner width/height: 1024/697 17:18:47 INFO - PROCESS | 2077 | __metrics 17:18:48 INFO - PROCESS | 2077 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:18:48 INFO - TEST-INFO | 2077: exit 0 17:18:48 INFO - Browser initialized. 17:18:48 INFO - Running cycle 1/1 for v8_7 test... 17:18:48 INFO - TEST-INFO | started process 2197 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpp08DQo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:18:50 INFO - PROCESS | 2197 | 17:18:50 INFO - PROCESS | 2197 | (process:2254): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:19:00 INFO - PROCESS | 2197 | RSS: Main: 151760896 17:19:00 INFO - PROCESS | 2197 | 17:19:23 INFO - PROCESS | 2197 | Cycle 1(1): loaded http://localhost:55013/tests/v8_7/run.html (next: http://localhost:55013/tests/v8_7/run.html) 17:19:23 INFO - PROCESS | 2197 | RSS: Main: 151867392 17:19:23 INFO - PROCESS | 2197 | 17:19:23 INFO - PROCESS | 2197 | __start_tp_report 17:19:23 INFO - PROCESS | 2197 | _x_x_mozilla_page_load 17:19:23 INFO - PROCESS | 2197 | _x_x_mozilla_page_load_details 17:19:23 INFO - PROCESS | 2197 | |i|pagename|runs| 17:19:23 INFO - PROCESS | 2197 | |0;Richards;166.5278934221482 17:19:23 INFO - PROCESS | 2197 | |1;DeltaBlue;188.7504718761797 17:19:23 INFO - PROCESS | 2197 | |2;Encrypt;279.56388034665923 17:19:23 INFO - PROCESS | 2197 | |3;Decrypt;5256.544502617801 17:19:23 INFO - PROCESS | 2197 | |4;RayTrace;1053.740779768177 17:19:23 INFO - PROCESS | 2197 | |5;Earley;714.2857142857143 17:19:23 INFO - PROCESS | 2197 | |6;Boyer;12587.5 17:19:23 INFO - PROCESS | 2197 | |7;RegExp;41428.57142857143 17:19:23 INFO - PROCESS | 2197 | |8;Splay;634.8101265822785 17:19:23 INFO - PROCESS | 2197 | |9;NavierStokes;4835.748792270531 17:19:23 INFO - PROCESS | 2197 | __end_tp_report 17:19:23 INFO - PROCESS | 2197 | __startTimestamp1453684763464__endTimestamp 17:19:23 INFO - PROCESS | 2197 | 17:19:23 INFO - PROCESS | 2197 | ------- Summary: start ------- 17:19:23 INFO - PROCESS | 2197 | Number of tests: 10 17:19:23 INFO - PROCESS | 2197 | 17:19:23 INFO - PROCESS | 2197 | [#0] Richards Cycles:1 Average:166.53 Median:166.53 stddev:0.00 (0.0%) 17:19:23 INFO - PROCESS | 2197 | Values: 166.5 17:19:23 INFO - PROCESS | 2197 | 17:19:23 INFO - PROCESS | 2197 | [#1] DeltaBlue Cycles:1 Average:188.75 Median:188.75 stddev:0.00 (0.0%) 17:19:23 INFO - PROCESS | 2197 | Values: 188.8 17:19:23 INFO - PROCESS | 2197 | 17:19:23 INFO - PROCESS | 2197 | [#2] Encrypt Cycles:1 Average:279.56 Median:279.56 stddev:0.00 (0.0%) 17:19:23 INFO - PROCESS | 2197 | Values: 279.6 17:19:23 INFO - PROCESS | 2197 | 17:19:23 INFO - PROCESS | 2197 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 17:19:23 INFO - PROCESS | 2197 | Values: 5256.5 17:19:23 INFO - PROCESS | 2197 | 17:19:23 INFO - PROCESS | 2197 | [#4] RayTrace Cycles:1 Average:1053.74 Median:1053.74 stddev:0.00 (0.0%) 17:19:23 INFO - PROCESS | 2197 | Values: 1053.7 17:19:23 INFO - PROCESS | 2197 | 17:19:23 INFO - PROCESS | 2197 | [#5] Earley Cycles:1 Average:714.29 Median:714.29 stddev:0.00 (0.0%) 17:19:23 INFO - PROCESS | 2197 | Values: 714.3 17:19:23 INFO - PROCESS | 2197 | 17:19:23 INFO - PROCESS | 2197 | [#6] Boyer Cycles:1 Average:12587.50 Median:12587.50 stddev:0.00 (0.0%) 17:19:23 INFO - PROCESS | 2197 | Values: 12587.5 17:19:23 INFO - PROCESS | 2197 | 17:19:23 INFO - PROCESS | 2197 | [#7] RegExp Cycles:1 Average:41428.57 Median:41428.57 stddev:0.00 (0.0%) 17:19:23 INFO - PROCESS | 2197 | Values: 41428.6 17:19:23 INFO - PROCESS | 2197 | 17:19:23 INFO - PROCESS | 2197 | [#8] Splay Cycles:1 Average:634.81 Median:634.81 stddev:0.00 (0.0%) 17:19:23 INFO - PROCESS | 2197 | Values: 634.8 17:19:23 INFO - PROCESS | 2197 | 17:19:23 INFO - PROCESS | 2197 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 17:19:23 INFO - PROCESS | 2197 | Values: 4835.7 17:19:23 INFO - PROCESS | 2197 | -------- Summary: end -------- 17:19:23 INFO - PROCESS | 2197 | 17:19:24 INFO - TEST-INFO | 2197: exit 0 17:19:24 INFO - TEST-OK | v8_7 | took 40623ms 17:19:24 INFO - SUITE-END | took 1210s 17:19:24 INFO - Completed test suite (00:20:10) 17:19:24 INFO - Working with test: dromaeo_css 17:19:24 INFO - Generating results file: dromaeo_css 17:19:24 INFO - Working with test: kraken 17:19:24 INFO - Generating results file: kraken 17:19:24 INFO - javascript benchmark 17:19:24 INFO - Working with test: v8_7 17:19:24 INFO - Generating results file: v8_7 17:19:24 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:19:24 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 17:19:24 INFO - process_Request line: dromaeo_css 6823.44 graph.html#tests=[[72,64,43]] 17:19:24 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:19:24 INFO - process_Request line: kraken 1507.00 graph.html#tests=[[232,64,43]] 17:19:24 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:19:24 INFO - process_Request line: v8_7 20211.09 graph.html#tests=[[230,64,43]] 17:19:24 INFO - RETURN: dromaeo_css: 6823.44 17:19:24 INFO - RETURN: kraken: 1507.00 17:19:24 INFO - RETURN: v8_7: 20211.09 17:19:24 INFO - javascript benchmark 17:19:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3142.8585713642888, 3175.3331800321916, 3182.2203560127773, 3192.55304257404, 3219.0021093461028, 5147.279380886679, 5194.948050519493, 5225.947740522598, 5227.503387178222, 5247.055530004598, 5186.507281808223, 5189.584833213344, 5232.032074066291, 5233.476652334764, 5333.466653334664, 4748.477667456577, 4763.404574428197, 4815.205491093965, 4850.345203397549, 4888.926666100011, 528.2245348470512, 4547.204239258133, 4715.811367545294, 4796.3045358423005, 4811.879703007417, 4772.522747725235, 4802.759862006903, 4816.903661926777, 4822.252550854623, 4856.830010949618, 4823.397075365579, 4835.081334546425, 4842.903141937177, 4856.417229932431, 4871.4397844248015, 4712.222483290253, 4734.289856521515, 4789.377380940456, 4825.034993001414, 4859.5383438573635, 4982.0, 5034.4713805050305, 5058.772355244023, 5065.974670126662, 5112.539871411591, 5542.168674698787, 5550.139728342114, 5552.500274975231, 5561.082421400464, 5583.944160558383, 5588.888222235573, 5653.406392328829, 5659.6321239119325, 5666.490015898547, 5729.942700572982, 5338.199270109476, 5346.4118946915805, 5347.2781174541715, 5360.2227676987, 5367.43641917597, 5798.420157984167, 5834.649921004753, 5838.095095260242, 5846.912296315559, 5871.236739223874, 5396.3524377075, 5404.216388623628, 5424.077906755861, 5454.318210223722, 5574.1917421973585, 5669.2346533218315, 5678.290213723285, 5689.800856969986, 5702.31572211329, 5712.485876271156, 5634.464725851038, 5635.492805647511, 5648.604597678123, 5651.350094739076, 5660.518855897212, 5477.068898287301, 5477.75350109246, 5485.725713714299, 5616.522595579339, 5623.409541998113, 4386.210482113251, 4400.515943246241, 4403.603675669206, 4423.07115505741, 4449.510553839075, 3860.0542866997766, 3902.6097390260747, 3935.1539419024475, 3941.625545573166, 3958.8218530166214, 5225.320708307896, 5240.895182096413, 5314.1497360422145, 5316.229146773696, 5318.0, 5556.16657501378, 5576.776928922797, 5589.580781441408, 5592.86017849557, 5603.859903502445, 5239.633225674166, 5248.212768084818, 5254.894902101936, 5268.947310526923, 5299.31108955841, 4686.062787442525, 4790.592799612072, 4812.735299558488, 4855.417349918032, 4857.587105096036, 5695.572832037614, 5733.483986441241, 5750.396208398058, 5750.7987220447085, 5762.942370576325, 5525.972370138124, 5532.847873965696, 5588.720563971704, 5601.327840659147, 5607.607467477319, 5708.257926469532, 5806.796762113306, 5845.269341332333, 5931.733072011683, 5959.76160953557, 5514.393416724238, 5531.197976293334, 5532.391436941853, 5538.889222215614, 5561.721913904208, 5615.326160860723, 5629.155626656035, 5636.85907852307, 5641.802536911188, 5643.830685079454, 5416.783328666809, 5442.292501974876, 5488.91766623493, 5491.093969494988, 5491.75287112073, 5495.890082198253, 5551.861203469945, 5580.972095139498, 5631.436856314336, 5676.120201368794, 5369.48989845964, 5376.327959005124, 5381.381141168816, 5387.353517577916, 5392.595555333287, 5518.44815518461, 5527.0, 5534.529564987021, 5542.972285138549, 5550.333959924835, 5347.037533243898, 5368.677879327252, 5417.51242388187, 5427.1045277528765, 5476.205950137128], "unit": "score", "name": "dojo.html", "value": 5156.488498187244}, {"lowerIsBetter": false, "replicates": [530.2073400266602, 560.5627610463839, 564.7373971103436, 570.9229254050703, 587.0460501684762, 35675.82162089189, 36180.276394472094, 36256.81871590645, 36351.4547281791, 36482.270354592925, 39468.0, 39691.801540992325, 39899.800500997524, 39936.0, 40115.39826902599, 8347.91652083479, 8562.272206862424, 8583.227509524142, 8584.74245772628, 8634.697785577506, 8321.958390208041, 8420.747377578682, 8470.957645211765, 8719.564021798884, 8739.868901966476, 8704.347173961947, 8731.607077681489, 8754.6935857245, 8774.912250877505, 8779.561021948908, 8643.2653224476, 8652.956735216316, 8751.60617772205, 8768.210861022539, 8770.868436973451, 8541.231289183941, 8644.351673624504, 8666.696665616737, 8675.56622168889, 8694.304455643596, 38412.23175536474, 38481.80759096215, 38685.61314386848, 38712.225755485015, 38977.61022389768, 3123.484625036866, 3291.210109573709, 3297.6207736110414, 3378.189234583707, 3680.5031320771623, 29174.124776256747, 29194.562081568794, 29242.268943276376, 29326.70673293261, 29620.851895740383, 3969.861054863095, 4030.6573941215033, 4067.959320406788, 4124.979375103136, 4133.46264985553, 258677.0, 260697.9999999981, 260699.0, 261554.0, 263036.0, 48304.27543586849, 49535.25697114546, 54491.18263226055, 54509.72745136249, 54751.178732319044, 59587.404125958186, 60482.0, 60936.69531652313, 61195.694021529605, 61530.69234653798, 13670.384832682554, 13757.862421375658, 14149.0, 14163.150210987375, 14249.073810202304, 10798.73003174927, 10836.970487803646, 10847.403392813314, 10911.618093366695, 10921.617743378943, 18127.18427670758, 18272.177752000927, 18399.448016559523, 18814.0, 19058.714119288223, 7346.96326518364, 7533.773986780406, 7583.848323033509, 7665.61671916402, 7729.227077292226, 982.0, 993.4734590666958, 1023.744063984004, 1034.332855308322, 1044.2272718188638, 25777.0, 26642.333941651614, 27542.724572754018, 28775.424491510053, 31176.22059448532, 1031.7781676939344, 1051.4322265976286, 1054.7626783973699, 1073.5222825842425, 1074.9032587067202, 13315.66710832237, 13547.390367433489, 13614.659633509242, 13645.11306765057, 13738.381772820247, 319470.0, 320830.0, 321924.0, 322546.0, 322725.0, 48612.5138748608, 48772.75613621909, 48930.0, 48987.26519102216, 49136.75431622891, 1365.9521916732867, 1375.3879523611897, 1376.7027968016744, 1376.827896512936, 1387.9861201387857, 25233.243002709947, 25971.22086337413, 26461.867690661424, 26469.33826654349, 26629.334266643487, 41680.3747943775, 41778.37332439955, 42054.36918446287, 42210.15579688328, 42283.0, 292737.0, 294362.0, 297460.0, 297980.0, 298401.0, 27729.0, 28035.299117522227, 29365.26586835346, 30665.386692266475, 31140.688593114686, 36489.270214596094, 36930.44604330883, 37145.25709485849, 37584.812075939444, 37736.245275094894, 31098.378032439676, 31165.844170779, 31517.0, 31935.0, 32229.35541289208, 31293.0, 31478.52782208223, 31520.52719209168, 31526.211844704067, 31790.682093179697, 34984.650153499155, 35288.29423411466, 35493.645063550066, 35645.287094258485, 35923.0, 28251.293717657223, 29162.562561561168, 31405.214869628442, 31776.470471522807, 32196.83901580477, 24767.876160619082, 24835.25494235176, 24981.75018249867, 25315.367115822253, 25400.872995635644], "unit": "score", "name": "ext.html", "value": 17735.186963547338}, {"lowerIsBetter": false, "replicates": [358.14760869131464, 359.7086360048361, 363.1629094936172, 365.9249853779975, 370.71084554047854, 15640.84359156408, 16263.918680406596, 16608.25262863171, 16835.83164168358, 17359.566010849736, 15502.767458488132, 15731.213439328016, 15994.440194593191, 16460.259288332025, 16484.67030659389, 4986.650934434591, 5165.302684137631, 5165.354330708661, 5183.870403239912, 5198.064348417283, 5038.294638750578, 5053.242013697938, 5136.43499215086, 5512.834614961557, 5557.527610153142, 5490.478404551562, 5513.173024046405, 5528.253685752432, 5708.885822283572, 5726.083826587746, 5464.180372944071, 5586.692731899744, 5644.6613203207735, 6062.242219722535, 6084.5436592255755, 5404.486573775485, 5413.64811287269, 5416.647917885364, 5423.755930983115, 5432.837014889559, 16986.235619397157, 19020.334288299844, 19656.41030769065, 19669.606607867907, 19826.900865495725, 2149.9892500537553, 2176.1404245323165, 2210.303754317385, 2249.4039079643744, 2302.1712183613886, 12641.304728239944, 12649.0, 12774.552890648876, 12858.678533036655, 13126.409311580906, 1761.2778760708047, 1811.6376724655122, 1835.6695794756938, 1857.7399164117035, 1861.7300491428803, 51464.0, 52099.73950130263, 54103.45896541024, 54520.45479545194, 55273.9999999996, 9694.272929530314, 9778.804423911482, 10097.44464054484, 10124.797504050026, 10128.44293563861, 13113.541026064042, 13189.0, 13214.405351759195, 13215.801762973562, 13236.669083272802, 6868.244493105754, 6961.37347638715, 7130.964345178241, 7240.565566066053, 7262.491625586158, 6793.252742198354, 6846.938724497711, 6863.2793556676825, 6868.587884726832, 6930.5148639594745, 4330.913381732347, 4365.410669559569, 4387.188370151533, 4393.84621538251, 4398.846040388571, 1776.840084392411, 1812.7643406357354, 1847.8059803720416, 1887.7829049659465, 1897.7532920720494, 897.8383890899701, 980.8970058143935, 1015.4618052432223, 1048.8059708953867, 1089.8147314956477, 15731.528054158394, 15779.132147731985, 16203.756943645854, 16306.918465407834, 16437.753433698505, 894.2398960883197, 951.833429149896, 989.9208063354914, 1003.6286573967678, 1005.627917670452, 9440.48077355752, 9460.621575136918, 9510.33427660071, 9514.187168090979, 9536.2371010319, 461577.0, 474589.0, 491596.0, 498468.0, 505631.0, 40725.0, 46016.53983460189, 57981.55046123797, 67006.0, 67146.328536714, 1069.3690722473623, 1079.9794194486135, 1082.1505118481955, 1098.8406681031365, 1114.403793970222, 13808.447662093404, 14324.355404006636, 15224.771628425804, 15301.464448744686, 15522.146281954601, 31910.84044579762, 31941.20146996344, 32997.67002329946, 33137.337253254314, 33751.83124084364, 37483.250334992605, 38517.2296554073, 38858.6114138855, 39251.80374098226, 40474.39288410735, 7107.253738357605, 7114.14630244374, 7158.141023077264, 7256.637168141678, 7489.925100748923, 7298.868950081956, 9814.214862810815, 10119.949400252952, 10379.688609341732, 10455.529501172314, 6845.623490708059, 7064.929350706633, 7160.785176444715, 7391.334779869838, 7582.279683430065, 7026.402755765817, 7523.473356864967, 7558.622068896423, 7664.578448185181, 7796.84406311882, 7305.305995930378, 7338.192798792022, 7474.92525074764, 7499.100107987077, 7543.3965282778345, 9966.103050725469, 10176.542055607368, 10241.07830295277, 10322.0, 10391.324563903323, 9471.384360016576, 9587.376820506644, 9601.951990240004, 9685.70942871715, 9688.612455501701], "unit": "score", "name": "jquery.html", "value": 7971.557952218024}, {"lowerIsBetter": false, "replicates": [1468.8017117689112, 1490.8360080391155, 1633.5671047172493, 1724.887882287652, 1756.7013607686692, 7644.885326720104, 7710.460267781257, 7790.610469476518, 7866.449348545597, 7922.366210703144, 7859.096203936549, 7891.684332626688, 7945.523268603888, 8007.799805004878, 8048.798780030487, 2286.6912966749483, 2298.092253559843, 2303.2284184798027, 2307.7692230776956, 2309.168699268262, 2309.0, 2319.721633403994, 2347.190219374313, 2347.80043696286, 2357.045396614374, 2240.0143936667896, 2263.6265016272378, 2290.9770902291016, 2300.7124109486313, 2303.9078436862505, 2230.4200907764016, 2249.2352600115873, 2253.549290141978, 2267.3764714703425, 2268.5122698619875, 2260.2541161416693, 2309.572729045132, 2317.9420514487106, 2321.976780232193, 2329.5457385809773, 7343.742968996113, 7371.410287177013, 7380.630968451556, 7403.703851845919, 7413.481056326059, 4594.9310760338285, 4739.857804265843, 4740.620750339999, 4777.59390451812, 4815.036992601459, 3048.3903219356216, 3089.845507724605, 3155.921101972446, 3182.204448887778, 3184.1561986073707, 1038.6260946059413, 1051.3218973761957, 1051.5898799468214, 1070.7002039428971, 1091.5197313182175, 10570.577176912915, 10772.515236814363, 10800.86590907959, 10804.837927431096, 10833.566657333697, 4303.698741088094, 4343.522212556616, 4432.423784907941, 4439.755813430228, 4445.310976798602, 9430.056994300652, 9446.622135114656, 9447.622095116256, 9469.810603787886, 9478.241740660731, 4655.883602909955, 4699.694519856198, 4708.199606066977, 4723.622110231173, 4740.691855029412, 4215.747055176699, 4225.556316586775, 4229.534751177368, 4230.49234091911, 4247.745135291892, 3660.432632941898, 3733.9439908401396, 3735.738498305147, 3739.719521035933, 3759.3045286622064, 1161.9360935148648, 1171.2738102376582, 1197.4731118307916, 1197.736497970445, 1207.879212078785, 948.7106432538142, 998.6904059741504, 1102.9613963511238, 1177.1642134084725, 1303.6024012676226, 7155.570665760071, 7231.132264128233, 7255.020572222682, 7265.927340726631, 7280.199178090405, 602.0908428273251, 623.7660877171061, 623.9188905442263, 627.6234259444296, 756.9583672898043, 5582.190582365534, 5601.467860553241, 5710.7430165642645, 5717.113847353667, 5723.8569035774435, 9110.180083792358, 9381.249500039981, 9455.621775128919, 9772.706818795448, 9772.951135244279, 9271.536423178948, 9287.72136835896, 9341.252699784001, 9444.291678124167, 9520.047995200563, 7413.0, 7523.962380188064, 7527.736529221451, 7528.698852045966, 7593.506422082436, 6966.825829354307, 7224.241454647186, 7232.602206878672, 7233.095863017123, 7249.8400255958795, 8403.621837017226, 8498.787530311545, 8585.785355365915, 8635.95682021611, 8688.087750786077, 8586.22723954847, 8752.037275899518, 8765.34259930495, 8779.648814047621, 8827.293816494794, 6915.03189553473, 6982.7206911725, 7069.0, 7080.398166155728, 7097.361237488651, 7444.0, 7453.180150183367, 7515.586642734702, 7517.060367454068, 7548.282913123245, 7018.859622807618, 7083.858322833411, 7176.138863336433, 7265.418766498773, 7271.454640901848, 6227.221597300338, 6792.864142717217, 6874.6562671867205, 6992.0910281663055, 7187.065681461377, 6797.490188236001, 6889.242183359726, 6914.654267286716, 6930.341617546325, 6962.3733863950465, 6463.127477790438, 6473.287938326686, 6494.902576461452, 6509.902351464826, 6515.869682606416, 6286.339934307015, 6388.840278993062, 6429.935700643121, 6522.804315870531, 6533.379328963741], "unit": "score", "name": "mootools.html", "value": 4455.048640025322}, {"lowerIsBetter": false, "replicates": [338.8136524911298, 340.3108704872633, 350.9789412635241, 351.77310634640673, 353.008047386843, 6162.630242185472, 6294.527910406715, 6304.180456540649, 6310.684465776716, 6328.968355158224, 6045.758169673208, 6147.846303842406, 6176.011838105904, 6199.969000155004, 6220.533459990496, 4765.857024289259, 4790.161721698706, 4807.567318941295, 4812.759362031902, 4814.1334559779225, 4789.712617242959, 4794.42466903972, 4806.927896081562, 4813.037392521493, 4823.975880120594, 4686.765661716918, 4752.952470475286, 4767.833125840596, 4770.165221086313, 4777.80888764449, 4763.69036012658, 4776.546228108324, 4776.976115119437, 4791.664583479158, 4794.9520504794855, 4201.2017716633745, 4203.864956461769, 4207.863876753259, 4215.861717336333, 4228.9154216915485, 5920.319163296233, 5952.3154837193415, 5953.732082056318, 5968.552358573081, 5978.730957106941, 5388.568914486832, 5499.065158922953, 5529.972350138264, 5537.418571050022, 5566.2207290979295, 6550.984597387413, 6580.605163690194, 6589.505787065989, 6593.472522198213, 6595.8021259362295, 4612.538746125394, 4616.192166370905, 4618.769061546943, 4635.11932732783, 4650.604698600623, 6618.635975021371, 6847.527781526946, 6869.862602747967, 6895.172579290517, 6913.619750913697, 4733.881652958704, 4747.098051370229, 4762.3808904842845, 4762.9523704763205, 4768.7615619218905, 4812.398450193726, 4818.156822556109, 4818.542238487338, 4823.0, 4833.661643684908, 5514.172874068841, 5524.364698059694, 5537.889242215133, 5542.140968149944, 5554.944450555524, 6501.284858665543, 6592.17597800275, 6637.601743895381, 6643.2360278568585, 6649.667516624149, 1625.9024458532526, 1666.1835700506665, 1666.7916510436196, 1666.9499915002568, 1675.3968571314317, 1096.0792933935531, 1107.9944600277108, 1108.0415440643947, 1114.2701530497536, 1117.3351855645878, 6196.628202307876, 6200.596961197508, 6247.312795592481, 6252.3122456529745, 6275.152854364603, 6675.232348279913, 6683.832904177434, 6706.530542861953, 6717.899231511531, 6723.663816809238, 6069.666168360783, 6190.133381326618, 6190.721417536221, 6212.192414986113, 6212.689365531705, 3634.109643137448, 3646.8176591170336, 3667.889963301052, 3675.4854320395166, 3693.5013773140818, 7006.824829379204, 7020.7542736004, 7027.0, 7040.436765058783, 7048.118985126859, 6877.65611719412, 6907.7236910524025, 6916.412104971033, 6929.237783843773, 6957.756478523227, 7142.857142857114, 7156.499045066899, 7188.820279493055, 7210.459215558854, 7247.2390399009455, 6841.794746157623, 6867.313268673092, 6868.793936181923, 6880.552764070319, 6936.826579335557, 6717.764878229434, 6868.0769384572395, 6868.553544019623, 6872.553284036521, 6876.346747059021, 7152.356287934111, 7214.0, 7219.8556028880175, 7223.386012188813, 7249.927500724925, 4693.389859318267, 4710.105080034782, 4716.3868697069165, 4729.385179926588, 4732.526747325378, 6752.122224111031, 6917.204521480095, 6943.513954023372, 6962.7911162665205, 6968.6864091115, 6649.900251496329, 6697.497687673346, 6727.0, 6765.661716914233, 6769.898451523132, 6755.831104222434, 6759.662016899234, 6759.898601520883, 6761.188657361148, 6767.898481522682, 6441.3880681335195, 6567.605943643397, 6571.080048793268, 6592.077109204619, 6612.23959244693, 6722.563033402813, 6748.527603067738, 6765.86468270622, 6784.118064651564, 6792.490563207681, 6534.215894092739, 6579.342065793382, 6601.735930562916, 6605.207375115017, 6607.7356905725155], "unit": "score", "name": "prototype.html", "value": 5005.453616621776}, {"lowerIsBetter": false, "replicates": [773.2151865856156, 831.8752187171928, 853.9103394143615, 860.393422637041, 866.0516734176078, 13042.608721738352, 13123.671908202276, 13188.472461101544, 13230.536931207409, 13264.867351326484, 11737.178397512178, 11865.169438139334, 12582.559610413637, 12584.622461326175, 12668.936655316711, 794.5749024272016, 809.4172196018857, 809.4495742894829, 811.7402431222012, 818.9877151842697, 799.9080105787822, 803.4014659078995, 807.1283014344494, 808.9191080891893, 810.6635746165334, 849.7195925344653, 851.5188918261193, 852.1904191018526, 855.3969451536683, 859.2696208223023, 844.5819319436856, 848.367965865428, 850.587465079436, 855.5123579559654, 857.5540718826238, 628.6542401679104, 630.2027934662656, 631.4790298004165, 631.9778807741753, 633.1294470103608, 12010.759784804342, 12042.157049006573, 12084.456199471046, 12142.392880356036, 12192.57325993586, 10505.684829455053, 10783.245172837904, 10890.67327980154, 10991.395473248967, 11177.49701263445, 9532.475713835736, 9626.326157169002, 9710.854337184948, 9712.22302215821, 9856.90143098567, 3427.4344733119005, 3458.9654103458893, 3496.318217947501, 3598.964010359889, 3603.94594081089, 45253.77373113146, 45844.541554584364, 45958.310625340644, 46061.53938460606, 46212.5378746215, 9593.664221752206, 9819.852702209473, 10033.654300244058, 10151.64469243573, 10152.23858210637, 17035.659286814196, 17084.231209595597, 17102.0, 17106.743398849027, 17151.313947442213, 7451.2921272479025, 7505.474616776883, 7538.208488108669, 7671.3862890968585, 7806.0632724073475, 4256.446661933929, 4259.893502662396, 4288.442502474721, 4328.242557552416, 4340.348947657813, 2994.895178668736, 2995.026616349695, 2998.14552852436, 2999.895003674861, 3020.5167173252175, 552.8175702018324, 566.2723400430509, 575.786958825229, 577.177522031104, 581.8021872563348, 541.0019952550654, 583.7956715149663, 620.2990620598695, 689.5862482510454, 691.9100516932766, 8165.63254653542, 8706.1729135732, 8732.65069397217, 8906.332025098143, 8935.553222338856, 562.8508445262008, 568.7724910036019, 588.7233000489763, 644.9774257900951, 659.0772917914861, 3997.8200980955926, 4085.4076158956786, 4089.26393249218, 4100.6924480664065, 4201.369794530845, 54918.72540637351, 55042.449575504535, 55083.44916550863, 55399.44600554024, 59420.70289648524, 47070.29394559016, 47230.527694722616, 47547.76226118847, 47692.0, 48234.758826205645, 42641.147177056286, 42758.0, 43846.561534384884, 44846.77576612096, 47037.05925881463, 8850.159234872677, 8861.33539984491, 9225.538723063954, 9312.813743724952, 9471.715848524555, 33715.494267586495, 34073.48889766606, 34093.14767130841, 34214.48678269778, 34741.47887781635, 40777.18445631011, 42045.0, 42682.0, 43034.35448468338, 43249.0, 11274.943625281821, 11340.149488788209, 11342.886571134513, 11403.942980285046, 11499.94250028778, 11882.16824822254, 11979.820302695642, 12194.207376520499, 12280.385980701109, 12378.319192444502, 11421.714457138638, 11611.419429028347, 11731.824022639497, 11976.341301228516, 12179.0, 10882.455877206266, 11104.500297486471, 11971.341576213392, 12029.278243305429, 12441.377931103227, 11423.657290281304, 11565.942170289094, 11601.245919015237, 11965.880341196476, 12042.63872083839, 9464.432134071978, 9760.56077476501, 9894.505274736379, 9907.0, 10205.897941020792, 9275.814483710423, 9344.34589578723, 9476.668316608886, 9580.233581313618, 10195.541200645841], "unit": "score", "name": "yui.html", "value": 6208.029581455184}], "name": "dromaeo_css", "value": 6823.434606728569}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 105.0, 115.0, 110.0, 111.0, 124.0, 111.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [156.0, 128.0, 156.0, 185.0, 127.0, 157.0, 159.0, 135.0, 178.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 151.1}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 161.0, 163.0, 161.0, 163.0, 166.0, 164.0, 165.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.1}, {"lowerIsBetter": true, "replicates": [73.0, 77.0, 75.0, 73.0, 74.0, 73.0, 142.0, 73.0, 76.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 137.0, 97.0, 97.0, 96.0, 141.0, 96.0, 97.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 111.0, 110.0, 109.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 145.0, 148.0, 146.0, 148.0, 146.0, 147.0, 146.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 98.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [59.0, 62.0, 58.0, 60.0, 59.0, 61.0, 59.0, 58.0, 73.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 60.6}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 69.0, 67.0, 72.0, 68.0, 67.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [84.0, 80.0, 82.0, 85.0, 83.0, 83.0, 84.0, 82.0, 87.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [128.0, 114.0, 113.0, 121.0, 123.0, 115.0, 120.0, 122.0, 119.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.5}, {"lowerIsBetter": true, "replicates": [135.0, 140.0, 143.0, 140.0, 140.0, 129.0, 141.0, 143.0, 139.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.8}, {"lowerIsBetter": true, "replicates": [68.0, 65.0, 67.0, 68.0, 68.0, 66.0, 68.0, 67.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1506.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.5278934221482], "unit": "score", "name": "Richards", "value": 211.98851000000005}, {"lowerIsBetter": false, "replicates": [188.7504718761797], "unit": "score", "name": "DeltaBlue", "value": 350.2931640000001}, {"lowerIsBetter": false, "replicates": [279.56388034665923], "unit": "score", "name": "Encrypt", "value": 952.1294369999999}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1053.740779768177], "unit": "score", "name": "RayTrace", "value": 702.2495610000001}, {"lowerIsBetter": false, "replicates": [714.2857142857143], "unit": "score", "name": "Earley", "value": 933.0482000000002}, {"lowerIsBetter": false, "replicates": [12587.5], "unit": "score", "name": "Boyer", "value": 52.946415094339656}, {"lowerIsBetter": false, "replicates": [41428.57142857143], "unit": "score", "name": "RegExp", "value": 21.989293103448276}, {"lowerIsBetter": false, "replicates": [634.8101265822785], "unit": "score", "name": "Splay", "value": 128.37066799601197}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20211.09404594156}]} 17:19:24 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20211.09"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1507.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6823.44"}}} 17:19:24 INFO - Return code: 0 17:19:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:19:24 INFO - # TBPL SUCCESS # 17:19:24 INFO - Running post-action listener: _resource_record_post_action 17:19:24 INFO - Running post-run listener: _resource_record_post_run 17:19:25 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 258048; Write bytes: 550215680; Read time: 16; Write time: 481256 17:19:25 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236228608; Read time: 0; Write time: 238168 17:19:25 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 258048; Write bytes: 313987072; Read time: 16; Write time: 243088 17:19:25 INFO - Running post-run listener: _upload_blobber_files 17:19:25 INFO - Blob upload gear active. 17:19:25 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:19:25 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:19:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:19:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:19:26 INFO - (blobuploader) - INFO - Open directory for files ... 17:19:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:19:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:19:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:19:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:19:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:19:27 INFO - (blobuploader) - INFO - Done attempting. 17:19:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:19:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:19:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:19:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:19:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:19:27 INFO - (blobuploader) - INFO - Done attempting. 17:19:27 INFO - (blobuploader) - INFO - Iteration through files over. 17:19:27 INFO - Return code: 0 17:19:27 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:19:27 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:19:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f1deccecce5be9ebc2ff761dc08140b142527d157f7ab87ee0b63e4c6b3de6920443143fda858134539702da1725f42c5e05f102ffd38012d1433b2fd850519", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d736ce793e0d52587f148e81bb7a4b170d2fcf3436a15b8040436fb6dfae518b0be52f5351c7addc8f2b5005d03d443ff234d3430e700550ec7c708b2e4e3736"} 17:19:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:19:27 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:19:27 INFO - Contents: 17:19:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f1deccecce5be9ebc2ff761dc08140b142527d157f7ab87ee0b63e4c6b3de6920443143fda858134539702da1725f42c5e05f102ffd38012d1433b2fd850519", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d736ce793e0d52587f148e81bb7a4b170d2fcf3436a15b8040436fb6dfae518b0be52f5351c7addc8f2b5005d03d443ff234d3430e700550ec7c708b2e4e3736"} 17:19:27 INFO - Running post-run listener: copy_logs_to_upload_dir 17:19:27 INFO - Copying logs to upload dir... 17:19:27 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:19:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.237840 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-24 17:19:27.063491) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-24 17:19:27.066695) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f1deccecce5be9ebc2ff761dc08140b142527d157f7ab87ee0b63e4c6b3de6920443143fda858134539702da1725f42c5e05f102ffd38012d1433b2fd850519", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d736ce793e0d52587f148e81bb7a4b170d2fcf3436a15b8040436fb6dfae518b0be52f5351c7addc8f2b5005d03d443ff234d3430e700550ec7c708b2e4e3736"} build_url:https://queue.taskcluster.net/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011341 build_url: 'https://queue.taskcluster.net/v1/task/ZuqQquBhRbGvIftu27RAhg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f1deccecce5be9ebc2ff761dc08140b142527d157f7ab87ee0b63e4c6b3de6920443143fda858134539702da1725f42c5e05f102ffd38012d1433b2fd850519", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d736ce793e0d52587f148e81bb7a4b170d2fcf3436a15b8040436fb6dfae518b0be52f5351c7addc8f2b5005d03d443ff234d3430e700550ec7c708b2e4e3736"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-24 17:19:27.091881) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 17:19:27.092240) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453682924.158914-1837939277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 17:19:27.174273) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-24 17:19:27.174622) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-24 17:19:27.174962) ========= ========= Total master_lag: 0.29 =========