builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1456512011.06 results: success (0) buildid: 20160226075927 builduid: 00e6cfadceb44ccc9e154f8feb96ef2e revision: 79d93a35ff024b5c85f3cd96954dd5b22ef8c257 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 10:40:11.062036) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 10:40:11.062486) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 10:40:11.062782) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005764 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 10:40:11.079232) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 10:40:11.079494) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 10:40:11.086979) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 10:40:11.087238) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003963 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 10:40:11.134380) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 10:40:11.134744) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 10:40:11.135085) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 10:40:11.135352) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-26 10:40:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.4M=0s 2016-02-26 10:40:12 (84.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113399 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 10:40:11.260905) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 10:40:11.261212) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019271 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 10:40:11.310575) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 10:40:11.310954) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 79d93a35ff024b5c85f3cd96954dd5b22ef8c257 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 79d93a35ff024b5c85f3cd96954dd5b22ef8c257 --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=e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-26 10:40:12,556 truncating revision to first 12 chars 2016-02-26 10:40:12,556 Setting DEBUG logging. 2016-02-26 10:40:12,556 attempt 1/10 2016-02-26 10:40:12,556 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/79d93a35ff02?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-26 10:40:12,823 unpacking tar archive at: mozilla-aurora-79d93a35ff02/testing/mozharness/ program finished with exit code 0 elapsedTime=0.534252 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 10:40:11.858081) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 10:40:11.858494) ========= echo 79d93a35ff024b5c85f3cd96954dd5b22ef8c257 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'79d93a35ff024b5c85f3cd96954dd5b22ef8c257'] 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=e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 79d93a35ff024b5c85f3cd96954dd5b22ef8c257 program finished with exit code 0 elapsedTime=0.003946 script_repo_revision: '79d93a35ff024b5c85f3cd96954dd5b22ef8c257' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 10:40:11.907409) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 10:40:11.907770) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 10:40:11.917437) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-02-26 10:40:11.917736) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:40:13 INFO - MultiFileLogger online at 20160226 10:40:13 in /builds/slave/test-pgo 10:40:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:40:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:40:13 INFO - {'append_to_log': False, 10:40:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:40:13 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:40:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:40:13 INFO - 'branch': 'Mozilla-Aurora', 10:40:13 INFO - 'buildbot_json_path': 'buildprops.json', 10:40:13 INFO - 'config_files': ('talos/linux_config.py',), 10:40:13 INFO - 'default_actions': ('clobber', 10:40:13 INFO - 'read-buildbot-config', 10:40:13 INFO - 'download-and-extract', 10:40:13 INFO - 'populate-webroot', 10:40:13 INFO - 'create-virtualenv', 10:40:13 INFO - 'install', 10:40:13 INFO - 'run-tests'), 10:40:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:40:13 INFO - 'download_minidump_stackwalk': True, 10:40:13 INFO - 'download_symbols': 'ondemand', 10:40:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:40:13 INFO - 'tooltool.py': '/tools/tooltool.py', 10:40:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:40:13 INFO - '/tools/misc-python/virtualenv.py')}, 10:40:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:40:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:40:13 INFO - 'installer_path': 'installer.exe', 10:40:13 INFO - 'log_level': 'info', 10:40:13 INFO - 'log_name': 'talos', 10:40:13 INFO - 'log_to_console': True, 10:40:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:40:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:40:13 INFO - 'opt_config_files': (), 10:40:13 INFO - 'pip_index': False, 10:40:13 INFO - 'sps_profile': False, 10:40:13 INFO - 'sps_profile_interval': 0, 10:40:13 INFO - 'suite': 'dromaeojs-e10s', 10:40:13 INFO - 'system_bits': '32', 10:40:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:40:13 INFO - 'title': 'talos-linux64-ix-067', 10:40:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:40:13 INFO - 'use_talos_json': True, 10:40:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:40:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:40:13 INFO - 'work_dir': 'build'} 10:40:13 INFO - ##### 10:40:13 INFO - ##### Running clobber step. 10:40:13 INFO - ##### 10:40:13 INFO - Running pre-action listener: _resource_record_pre_action 10:40:13 INFO - Running main action method: clobber 10:40:13 INFO - rmtree: /builds/slave/test-pgo/build 10:40:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:40:14 INFO - Running post-action listener: _resource_record_post_action 10:40:14 INFO - ##### 10:40:14 INFO - ##### Running read-buildbot-config step. 10:40:14 INFO - ##### 10:40:14 INFO - Running pre-action listener: _resource_record_pre_action 10:40:14 INFO - Running main action method: read_buildbot_config 10:40:14 INFO - Using buildbot properties: 10:40:14 INFO - { 10:40:14 INFO - "project": "", 10:40:14 INFO - "product": "firefox", 10:40:14 INFO - "script_repo_revision": "production", 10:40:14 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 10:40:14 INFO - "repository": "", 10:40:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 10:40:14 INFO - "buildid": "20160226075927", 10:40:14 INFO - "pgo_build": "True", 10:40:14 INFO - "basedir": "/builds/slave/test-pgo", 10:40:14 INFO - "buildnumber": 169, 10:40:14 INFO - "slavename": "talos-linux64-ix-067", 10:40:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:40:14 INFO - "platform": "ubuntu64_hw", 10:40:14 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:40:14 INFO - "branch": "mozilla-aurora", 10:40:14 INFO - "repo_path": "releases/mozilla-aurora", 10:40:14 INFO - "revision": "79d93a35ff024b5c85f3cd96954dd5b22ef8c257", 10:40:14 INFO - "stage_platform": "linux64-pgo", 10:40:14 INFO - "builduid": "00e6cfadceb44ccc9e154f8feb96ef2e", 10:40:14 INFO - "slavebuilddir": "test" 10:40:14 INFO - } 10:40:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 10:40:14 INFO - Running post-action listener: _resource_record_post_action 10:40:14 INFO - ##### 10:40:14 INFO - ##### Running download-and-extract step. 10:40:14 INFO - ##### 10:40:14 INFO - Running pre-action listener: _resource_record_pre_action 10:40:14 INFO - Running main action method: download_and_extract 10:40:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:40:14 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')]} 10:40:14 INFO - https://queue.taskcluster.net/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:40:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/test_packages.json 10:40:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/test_packages.json 10:40:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:40:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:40:15 INFO - Downloaded 1448 bytes. 10:40:15 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:40:15 INFO - Using the following test package requirements: 10:40:15 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 10:40:15 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:40:15 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:40:15 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:40:15 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:40:15 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:40:15 INFO - u'jsshell-linux-x86_64.zip'], 10:40:15 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:40:15 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:40:15 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 10:40:15 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:40:15 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:40:15 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:40:15 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:40:15 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:40:15 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:40:15 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 10:40:15 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:40:15 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:40:15 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:15 INFO - https://queue.taskcluster.net/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:40:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 10:40:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 10:40:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 10:40:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:40:17 INFO - Downloaded 23082916 bytes. 10:40:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:40:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 10:40:18 INFO - Return code: 0 10:40:18 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:40:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:18 INFO - https://queue.taskcluster.net/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:40:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 10:40:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 10:40:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 10:40:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:40:19 INFO - Downloaded 23082916 bytes. 10:40:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:40:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 10:40:20 INFO - Return code: 0 10:40: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')]} 10:40:20 INFO - https://queue.taskcluster.net/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:40:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 10:40:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 10:40:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 10:40:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:40:21 INFO - Downloaded 10706649 bytes. 10:40:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:40:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 10:40:22 INFO - Return code: 0 10:40:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:22 INFO - https://queue.taskcluster.net/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:40:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 10:40:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 10:40:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 10:40:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:40:23 INFO - Downloaded 59966614 bytes. 10:40:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 10:40:23 INFO - mkdir: /builds/slave/test-pgo/properties 10:40:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:40:23 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:40:23 INFO - Contents: 10:40:23 INFO - build_url:https://queue.taskcluster.net/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 10:40:24 INFO - Running post-action listener: _resource_record_post_action 10:40:24 INFO - Running post-action listener: set_extra_try_arguments 10:40:24 INFO - ##### 10:40:24 INFO - ##### Running populate-webroot step. 10:40:24 INFO - ##### 10:40:24 INFO - Running pre-action listener: _resource_record_pre_action 10:40:24 INFO - Running main action method: populate_webroot 10:40:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:40:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:40:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:40:24 INFO - '--tppagecycles', 10:40:24 INFO - '7'], 10:40:24 INFO - 'tests': ['tsvgm']}}, 10:40:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:40:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:40:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:40:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:40:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:40:24 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:40:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:40:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:24 INFO - 'talos_options': ['--e10s'], 10:40:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:40:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:24 INFO - 'tests': ['damp', 'tps']}, 10:40:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:24 INFO - 'talos_options': ['--e10s'], 10:40:24 INFO - 'tests': ['damp', 'tps']}, 10:40:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:40:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:40:24 INFO - 'other': {'tests': ['a11yr', 10:40:24 INFO - 'ts_paint', 10:40:24 INFO - 'tpaint', 10:40:24 INFO - 'sessionrestore', 10:40:24 INFO - 'sessionrestore_no_auto_restore']}, 10:40:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:40:24 INFO - 'tests': ['a11yr', 10:40:24 INFO - 'ts_paint', 10:40:24 INFO - 'tpaint', 10:40:24 INFO - 'sessionrestore', 10:40:24 INFO - 'sessionrestore_no_auto_restore']}, 10:40:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:40:24 INFO - 'tests': ['a11yr', 10:40:24 INFO - 'ts_paint', 10:40:24 INFO - 'tpaint', 10:40:24 INFO - 'sessionrestore', 10:40:24 INFO - 'sessionrestore_no_auto_restore']}, 10:40:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:40:24 INFO - 'tests': ['a11yr', 10:40:24 INFO - 'ts_paint', 10:40:24 INFO - 'tpaint', 10:40:24 INFO - 'sessionrestore', 10:40:24 INFO - 'sessionrestore_no_auto_restore']}, 10:40:24 INFO - 'other_l64': {'tests': ['a11yr', 10:40:24 INFO - 'ts_paint', 10:40:24 INFO - 'tpaint', 10:40:24 INFO - 'sessionrestore', 10:40:24 INFO - 'sessionrestore_no_auto_restore']}, 10:40:24 INFO - 'other_nol64': {'tests': ['a11yr', 10:40:24 INFO - 'ts_paint', 10:40:24 INFO - 'tpaint', 10:40:24 INFO - 'sessionrestore', 10:40:24 INFO - 'sessionrestore_no_auto_restore']}, 10:40:24 INFO - 'svgr': {'tests': ['tsvgx', 10:40:24 INFO - 'tsvgr_opacity', 10:40:24 INFO - 'tart', 10:40:24 INFO - 'tscrollx', 10:40:24 INFO - 'cart']}, 10:40:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:40:24 INFO - 'tests': ['tsvgx', 10:40:24 INFO - 'tsvgr_opacity', 10:40:24 INFO - 'tart', 10:40:24 INFO - 'tscrollx', 10:40:24 INFO - 'cart']}, 10:40:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:24 INFO - 'tests': ['tp5o']}, 10:40:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:24 INFO - 'talos_options': ['--e10s'], 10:40:24 INFO - 'tests': ['tp5o']}, 10:40:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:24 INFO - 'talos_options': ['--xperf_path', 10:40:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:40:24 INFO - 'tests': ['tp5n']}, 10:40:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:40:24 INFO - 'talos_options': ['--e10s', 10:40:24 INFO - '--xperf_path', 10:40:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:40:24 INFO - 'tests': ['tp5n']}}, 10:40:24 INFO - 'talos.zip': {'path': '', 10:40:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:40:24 INFO - Running post-action listener: _resource_record_post_action 10:40:24 INFO - ##### 10:40:24 INFO - ##### Running create-virtualenv step. 10:40:24 INFO - ##### 10:40:24 INFO - Running pre-action listener: _resource_record_pre_action 10:40:24 INFO - Running main action method: create_virtualenv 10:40:24 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:40:24 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 10:40:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:40:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:40:24 INFO - Using real prefix '/usr' 10:40:24 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:40:25 INFO - Installing distribute.............................................................................................................................................................................................done. 10:40:26 INFO - Installing pip.................done. 10:40:26 INFO - Return code: 0 10:40:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:40:26 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')]} 10:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:26 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')]} 10:40:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:26 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 0x7f553d807f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b597f0>, '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 0x2ac52d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac5760>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180', '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 10:40:26 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 10:40:26 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 10:40:26 INFO - Using env: {'DISPLAY': ':0', 10:40:26 INFO - 'HOME': '/home/cltbld', 10:40:26 INFO - 'LANG': 'en_US.UTF-8', 10:40:26 INFO - 'LANGUAGE': 'en_US:en', 10:40:26 INFO - 'LOGNAME': 'cltbld', 10:40:26 INFO - 'MAIL': '/var/mail/cltbld', 10:40:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:26 INFO - 'MOZ_NO_REMOTE': '1', 10:40:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:26 INFO - 'NO_EM_RESTART': '1', 10:40:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:40:26 INFO - 'PWD': '/builds/slave/test-pgo', 10:40:26 INFO - 'SHELL': '/bin/bash', 10:40:26 INFO - 'SHLVL': '1', 10:40:26 INFO - 'TERM': 'linux', 10:40:26 INFO - 'TMOUT': '86400', 10:40:26 INFO - 'USER': 'cltbld', 10:40:26 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180', 10:40:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:26 INFO - '_': '/tools/buildbot/bin/python'} 10:40:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:27 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 10:40:27 INFO - Cleaning up... 10:40:27 INFO - Return code: 0 10:40:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:27 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 0x7f553d807f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b597f0>, '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 0x2ac52d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac5760>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180', '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 10:40:27 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 10:40:27 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 10:40:27 INFO - Using env: {'DISPLAY': ':0', 10:40:27 INFO - 'HOME': '/home/cltbld', 10:40:27 INFO - 'LANG': 'en_US.UTF-8', 10:40:27 INFO - 'LANGUAGE': 'en_US:en', 10:40:27 INFO - 'LOGNAME': 'cltbld', 10:40:27 INFO - 'MAIL': '/var/mail/cltbld', 10:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:27 INFO - 'MOZ_NO_REMOTE': '1', 10:40:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:27 INFO - 'NO_EM_RESTART': '1', 10:40:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:40:27 INFO - 'PWD': '/builds/slave/test-pgo', 10:40:27 INFO - 'SHELL': '/bin/bash', 10:40:27 INFO - 'SHLVL': '1', 10:40:27 INFO - 'TERM': 'linux', 10:40:27 INFO - 'TMOUT': '86400', 10:40:27 INFO - 'USER': 'cltbld', 10:40:27 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180', 10:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:27 INFO - '_': '/tools/buildbot/bin/python'} 10:40:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:27 INFO - Downloading/unpacking psutil>=0.7.1 10:40:27 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 10:40:27 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 10:40:27 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 10:40:27 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 10:40:27 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 10:40:27 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 10:40:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:40:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:40:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:40:29 INFO - Installing collected packages: psutil 10:40:29 INFO - Running setup.py install for psutil 10:40:29 INFO - building 'psutil._psutil_linux' extension 10:40:29 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 10:40:29 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 10:40:29 INFO - building 'psutil._psutil_posix' extension 10:40:29 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 10:40:29 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 10:40:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:40:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:40:29 INFO - Successfully installed psutil 10:40:29 INFO - Cleaning up... 10:40:29 INFO - Return code: 0 10:40:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:40: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')]} 10:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40: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')]} 10:40:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f553d807f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b597f0>, '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 0x2ac52d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac5760>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180', '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 10:40:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:40:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:40:29 INFO - Using env: {'DISPLAY': ':0', 10:40:29 INFO - 'HOME': '/home/cltbld', 10:40:29 INFO - 'LANG': 'en_US.UTF-8', 10:40:29 INFO - 'LANGUAGE': 'en_US:en', 10:40:29 INFO - 'LOGNAME': 'cltbld', 10:40:29 INFO - 'MAIL': '/var/mail/cltbld', 10:40:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:29 INFO - 'MOZ_NO_REMOTE': '1', 10:40:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:29 INFO - 'NO_EM_RESTART': '1', 10:40:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:40:29 INFO - 'PWD': '/builds/slave/test-pgo', 10:40:29 INFO - 'SHELL': '/bin/bash', 10:40:29 INFO - 'SHLVL': '1', 10:40:29 INFO - 'TERM': 'linux', 10:40:29 INFO - 'TMOUT': '86400', 10:40:29 INFO - 'USER': 'cltbld', 10:40:29 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180', 10:40:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:29 INFO - '_': '/tools/buildbot/bin/python'} 10:40:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:40:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:40:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:40:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:40:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:40:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:40:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:40:31 INFO - Installing collected packages: mozsystemmonitor 10:40:31 INFO - Running setup.py install for mozsystemmonitor 10:40:32 INFO - Successfully installed mozsystemmonitor 10:40:32 INFO - Cleaning up... 10:40:32 INFO - Return code: 0 10:40:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:40:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:32 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f553d807f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b597f0>, '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 0x2ac52d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac5760>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180', '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 10:40:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 10:40:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:40:32 INFO - Using env: {'DISPLAY': ':0', 10:40:32 INFO - 'HOME': '/home/cltbld', 10:40:32 INFO - 'LANG': 'en_US.UTF-8', 10:40:32 INFO - 'LANGUAGE': 'en_US:en', 10:40:32 INFO - 'LOGNAME': 'cltbld', 10:40:32 INFO - 'MAIL': '/var/mail/cltbld', 10:40:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:32 INFO - 'MOZ_NO_REMOTE': '1', 10:40:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:32 INFO - 'NO_EM_RESTART': '1', 10:40:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:40:32 INFO - 'PWD': '/builds/slave/test-pgo', 10:40:32 INFO - 'SHELL': '/bin/bash', 10:40:32 INFO - 'SHLVL': '1', 10:40:32 INFO - 'TERM': 'linux', 10:40:32 INFO - 'TMOUT': '86400', 10:40:32 INFO - 'USER': 'cltbld', 10:40:32 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180', 10:40:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:32 INFO - '_': '/tools/buildbot/bin/python'} 10:40:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:32 INFO - Downloading/unpacking blobuploader==1.2.4 10:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:40:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:40:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:40:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:40:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:40:35 INFO - Downloading blobuploader-1.2.4.tar.gz 10:40:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:40:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:40: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 10:40: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 10:40: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 10:40: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 10:40: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 10:40: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 10:40:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:40:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:40: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 10:40: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 10:40: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 10:40: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 10:40: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 10:40: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 10:40:35 INFO - Downloading docopt-0.6.1.tar.gz 10:40:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:40:35 INFO - Installing collected packages: blobuploader, requests, docopt 10:40:35 INFO - Running setup.py install for blobuploader 10:40:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:40:35 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:40:35 INFO - Running setup.py install for requests 10:40:36 INFO - Running setup.py install for docopt 10:40:36 INFO - Successfully installed blobuploader requests docopt 10:40:36 INFO - Cleaning up... 10:40:36 INFO - Return code: 0 10:40:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:40:36 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')]} 10:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:36 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')]} 10:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:36 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 0x7f553d807f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b597f0>, '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 0x2ac52d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac5760>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180', '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 10:40:36 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 10:40:36 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 10:40:36 INFO - Using env: {'DISPLAY': ':0', 10:40:36 INFO - 'HOME': '/home/cltbld', 10:40:36 INFO - 'LANG': 'en_US.UTF-8', 10:40:36 INFO - 'LANGUAGE': 'en_US:en', 10:40:36 INFO - 'LOGNAME': 'cltbld', 10:40:36 INFO - 'MAIL': '/var/mail/cltbld', 10:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:36 INFO - 'MOZ_NO_REMOTE': '1', 10:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:36 INFO - 'NO_EM_RESTART': '1', 10:40:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:40:36 INFO - 'PWD': '/builds/slave/test-pgo', 10:40:36 INFO - 'SHELL': '/bin/bash', 10:40:36 INFO - 'SHLVL': '1', 10:40:36 INFO - 'TERM': 'linux', 10:40:36 INFO - 'TMOUT': '86400', 10:40:36 INFO - 'USER': 'cltbld', 10:40:36 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180', 10:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:36 INFO - '_': '/tools/buildbot/bin/python'} 10:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:40:36 INFO - Running setup.py (path:/tmp/pip-0rPi8C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:40:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:40:36 INFO - Running setup.py (path:/tmp/pip-ecRIp1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:40:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:40:36 INFO - Running setup.py (path:/tmp/pip-0sIa0s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:40:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:40:36 INFO - Running setup.py (path:/tmp/pip-F3SA6e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:40:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:40:36 INFO - Running setup.py (path:/tmp/pip-v_3FJ8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:40:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:40:37 INFO - Running setup.py (path:/tmp/pip-2kFVfx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:40:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:40:37 INFO - Running setup.py (path:/tmp/pip-zKP10M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:40:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:40:37 INFO - Running setup.py (path:/tmp/pip-e9UmSn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:40:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:40:37 INFO - Running setup.py (path:/tmp/pip-W8AVjN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:40:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:40:37 INFO - Running setup.py (path:/tmp/pip-nYiHwg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:40:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:40:37 INFO - Running setup.py (path:/tmp/pip-o3CVuD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:40:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:40:37 INFO - Running setup.py (path:/tmp/pip-6NycYa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:40:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:40:37 INFO - Running setup.py (path:/tmp/pip-0E0Fwp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:40:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:40:37 INFO - Running setup.py (path:/tmp/pip-qGyjvb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:40:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:40:37 INFO - Running setup.py (path:/tmp/pip-4xni6v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:40:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:40:37 INFO - Running setup.py (path:/tmp/pip-RrUZUZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:40:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:40:37 INFO - Running setup.py (path:/tmp/pip-nWh4vb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:40:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:40:37 INFO - Running setup.py install for manifestparser 10:40:38 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:40:38 INFO - Running setup.py install for mozcrash 10:40:38 INFO - Running setup.py install for mozdebug 10:40:38 INFO - Running setup.py install for mozdevice 10:40:38 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:40:38 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:40:38 INFO - Running setup.py install for mozfile 10:40:38 INFO - Running setup.py install for mozhttpd 10:40:38 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:40:38 INFO - Running setup.py install for mozinfo 10:40:38 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:40:38 INFO - Running setup.py install for mozInstall 10:40:38 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:40:38 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:40:38 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:40:38 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:40:38 INFO - Running setup.py install for mozleak 10:40:38 INFO - Running setup.py install for mozlog 10:40:38 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:40:38 INFO - Running setup.py install for moznetwork 10:40:39 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:40:39 INFO - Running setup.py install for mozprocess 10:40:39 INFO - Running setup.py install for mozprofile 10:40:39 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:40:39 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:40:39 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:40:39 INFO - Running setup.py install for mozrunner 10:40:39 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:40:39 INFO - Running setup.py install for mozscreenshot 10:40:39 INFO - Running setup.py install for moztest 10:40:39 INFO - Running setup.py install for mozversion 10:40:39 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:40:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:40:39 INFO - Cleaning up... 10:40:39 INFO - Return code: 0 10:40:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:40:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:40:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:39 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 0x7f553d807f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b597f0>, '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 0x2ac52d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac5760>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180', '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 10:40:39 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 10:40:39 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 10:40:39 INFO - Using env: {'DISPLAY': ':0', 10:40:39 INFO - 'HOME': '/home/cltbld', 10:40:39 INFO - 'LANG': 'en_US.UTF-8', 10:40:39 INFO - 'LANGUAGE': 'en_US:en', 10:40:39 INFO - 'LOGNAME': 'cltbld', 10:40:39 INFO - 'MAIL': '/var/mail/cltbld', 10:40:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:39 INFO - 'MOZ_NO_REMOTE': '1', 10:40:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:39 INFO - 'NO_EM_RESTART': '1', 10:40:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:40:39 INFO - 'PWD': '/builds/slave/test-pgo', 10:40:39 INFO - 'SHELL': '/bin/bash', 10:40:39 INFO - 'SHLVL': '1', 10:40:39 INFO - 'TERM': 'linux', 10:40:39 INFO - 'TMOUT': '86400', 10:40:39 INFO - 'USER': 'cltbld', 10:40:39 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180', 10:40:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:39 INFO - '_': '/tools/buildbot/bin/python'} 10:40:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:40:39 INFO - Running setup.py (path:/tmp/pip-8wKUJL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:40:39 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)) 10:40:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:40:39 INFO - Running setup.py (path:/tmp/pip-gActi0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:40:40 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)) 10:40:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:40:40 INFO - Running setup.py (path:/tmp/pip-dydEjE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:40:40 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)) 10:40:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:40:40 INFO - Running setup.py (path:/tmp/pip-cQ4Zex-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:40:40 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)) 10:40:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:40:40 INFO - Running setup.py (path:/tmp/pip-hxf9iv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:40:40 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)) 10:40:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:40:40 INFO - Running setup.py (path:/tmp/pip-BiY571-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:40:40 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)) 10:40:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:40:40 INFO - Running setup.py (path:/tmp/pip-NmV6go-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:40:40 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)) 10:40:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:40:40 INFO - Running setup.py (path:/tmp/pip-UwRBkI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:40:40 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)) 10:40:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:40:40 INFO - Running setup.py (path:/tmp/pip-edRdvN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:40:40 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)) 10:40:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:40:40 INFO - Running setup.py (path:/tmp/pip-pDyAKI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:40:40 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)) 10:40:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:40:40 INFO - Running setup.py (path:/tmp/pip-9Ruggj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:40:40 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)) 10:40:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:40:40 INFO - Running setup.py (path:/tmp/pip-xHCwg9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:40:40 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)) 10:40:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:40:40 INFO - Running setup.py (path:/tmp/pip-fu4vjW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:40:40 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)) 10:40:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:40:40 INFO - Running setup.py (path:/tmp/pip-ji914L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:40:40 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)) 10:40:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:40:40 INFO - Running setup.py (path:/tmp/pip-3a0YaC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:40:41 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)) 10:40:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:40:41 INFO - Running setup.py (path:/tmp/pip-QMBxIk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:40:41 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)) 10:40:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:40:41 INFO - Running setup.py (path:/tmp/pip-cbezTE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:40:41 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)) 10:40:41 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)) 10:40:41 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)) 10:40:41 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)) 10:40:41 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)) 10:40:41 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)) 10:40:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:40:41 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 10:40:41 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 10:40:41 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 10:40:41 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 10:40:41 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 10:40:41 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 10:40:42 INFO - Downloading blessings-1.6.tar.gz 10:40:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:40:43 INFO - Installing collected packages: blessings 10:40:43 INFO - Running setup.py install for blessings 10:40:43 INFO - Successfully installed blessings 10:40:43 INFO - Cleaning up... 10:40:43 INFO - Return code: 0 10:40:43 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:40:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:40:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:40:43 INFO - Reading from file tmpfile_stdout 10:40:43 INFO - Current package versions: 10:40:43 INFO - argparse == 1.2.1 10:40:43 INFO - blessings == 1.6 10:40:43 INFO - blobuploader == 1.2.4 10:40:43 INFO - docopt == 0.6.1 10:40:43 INFO - manifestparser == 1.1 10:40:43 INFO - mozInstall == 1.12 10:40:43 INFO - mozcrash == 0.16 10:40:43 INFO - mozdebug == 0.1 10:40:43 INFO - mozdevice == 0.48 10:40:43 INFO - mozfile == 1.2 10:40:43 INFO - mozhttpd == 0.7 10:40:43 INFO - mozinfo == 0.9 10:40:43 INFO - mozleak == 0.1 10:40:43 INFO - mozlog == 3.1 10:40:43 INFO - moznetwork == 0.27 10:40:43 INFO - mozprocess == 0.22 10:40:43 INFO - mozprofile == 0.28 10:40:43 INFO - mozrunner == 6.11 10:40:43 INFO - mozscreenshot == 0.1 10:40:43 INFO - mozsystemmonitor == 0.0 10:40:43 INFO - moztest == 0.7 10:40:43 INFO - mozversion == 1.4 10:40:43 INFO - psutil == 3.1.1 10:40:43 INFO - requests == 1.2.3 10:40:43 INFO - wsgiref == 0.1.2 10:40:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:40: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')]} 10:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40: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')]} 10:40:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:43 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 0x7f553d807f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b597f0>, '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 0x2ac52d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac5760>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180', '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 10:40:43 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 10:40:43 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 10:40:43 INFO - Using env: {'DISPLAY': ':0', 10:40:43 INFO - 'HOME': '/home/cltbld', 10:40:43 INFO - 'LANG': 'en_US.UTF-8', 10:40:43 INFO - 'LANGUAGE': 'en_US:en', 10:40:43 INFO - 'LOGNAME': 'cltbld', 10:40:43 INFO - 'MAIL': '/var/mail/cltbld', 10:40:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:43 INFO - 'MOZ_NO_REMOTE': '1', 10:40:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:43 INFO - 'NO_EM_RESTART': '1', 10:40:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:40:43 INFO - 'PWD': '/builds/slave/test-pgo', 10:40:43 INFO - 'SHELL': '/bin/bash', 10:40:43 INFO - 'SHLVL': '1', 10:40:43 INFO - 'TERM': 'linux', 10:40:43 INFO - 'TMOUT': '86400', 10:40:43 INFO - 'USER': 'cltbld', 10:40:43 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180', 10:40:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:43 INFO - '_': '/tools/buildbot/bin/python'} 10:40:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:43 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)) 10:40:43 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)) 10:40:43 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)) 10:40:43 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)) 10:40:43 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)) 10:40:43 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)) 10:40:43 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)) 10:40:43 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)) 10:40:43 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)) 10:40:43 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)) 10:40:43 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)) 10:40:43 INFO - Cleaning up... 10:40:43 INFO - Return code: 0 10:40:43 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:40: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')]} 10:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40: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')]} 10:40:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:43 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 0x7f553d807f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b597f0>, '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 0x2ac52d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac5760>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180', '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 10:40:43 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 10:40:43 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 10:40:43 INFO - Using env: {'DISPLAY': ':0', 10:40:43 INFO - 'HOME': '/home/cltbld', 10:40:43 INFO - 'LANG': 'en_US.UTF-8', 10:40:43 INFO - 'LANGUAGE': 'en_US:en', 10:40:43 INFO - 'LOGNAME': 'cltbld', 10:40:43 INFO - 'MAIL': '/var/mail/cltbld', 10:40:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:43 INFO - 'MOZ_NO_REMOTE': '1', 10:40:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:43 INFO - 'NO_EM_RESTART': '1', 10:40:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:40:43 INFO - 'PWD': '/builds/slave/test-pgo', 10:40:43 INFO - 'SHELL': '/bin/bash', 10:40:43 INFO - 'SHLVL': '1', 10:40:43 INFO - 'TERM': 'linux', 10:40:43 INFO - 'TMOUT': '86400', 10:40:43 INFO - 'USER': 'cltbld', 10:40:43 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180', 10:40:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:43 INFO - '_': '/tools/buildbot/bin/python'} 10:40:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:43 INFO - Downloading/unpacking jsonschema 10:40:43 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 10:40:43 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 10:40:43 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 10:40:43 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 10:40:43 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 10:40:43 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 10:40:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:40:45 INFO - Downloading/unpacking functools32 (from jsonschema) 10:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:40:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:40:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:40:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:40:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:40:45 INFO - Downloading functools32-3.2.3-2.tar.gz 10:40:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:40:45 INFO - warning: no files found matching '*.txt' 10:40:45 INFO - no previously-included directories found matching 'build' 10:40:45 INFO - no previously-included directories found matching 'dist' 10:40:45 INFO - no previously-included directories found matching '.git*' 10:40:45 INFO - Installing collected packages: jsonschema, functools32 10:40:46 INFO - Running setup.py install for functools32 10:40:46 INFO - warning: no files found matching '*.txt' 10:40:46 INFO - no previously-included directories found matching 'build' 10:40:46 INFO - no previously-included directories found matching 'dist' 10:40:46 INFO - no previously-included directories found matching '.git*' 10:40:46 INFO - Successfully installed jsonschema functools32 10:40:46 INFO - Cleaning up... 10:40:46 INFO - Return code: 0 10:40:46 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:40: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')]} 10:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:40:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40: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')]} 10:40:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:40:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:40:46 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 0x7f553d807f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b597f0>, '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 0x2ac52d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac5760>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180', '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 10:40:46 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 10:40:46 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 10:40:46 INFO - Using env: {'DISPLAY': ':0', 10:40:46 INFO - 'HOME': '/home/cltbld', 10:40:46 INFO - 'LANG': 'en_US.UTF-8', 10:40:46 INFO - 'LANGUAGE': 'en_US:en', 10:40:46 INFO - 'LOGNAME': 'cltbld', 10:40:46 INFO - 'MAIL': '/var/mail/cltbld', 10:40:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:40:46 INFO - 'MOZ_NO_REMOTE': '1', 10:40:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:40:46 INFO - 'NO_EM_RESTART': '1', 10:40:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:40:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:40:46 INFO - 'PWD': '/builds/slave/test-pgo', 10:40:46 INFO - 'SHELL': '/bin/bash', 10:40:46 INFO - 'SHLVL': '1', 10:40:46 INFO - 'TERM': 'linux', 10:40:46 INFO - 'TMOUT': '86400', 10:40:46 INFO - 'USER': 'cltbld', 10:40:46 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180', 10:40:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:40:46 INFO - '_': '/tools/buildbot/bin/python'} 10:40:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:40:46 INFO - Downloading/unpacking flake8 10:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:40:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:40:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:40:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:40:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:40:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:40:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:40: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 10:40: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 10:40: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 10:40: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 10:40: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 10:40: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 10:40:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:40:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:40: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 10:40: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 10:40: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 10:40: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 10:40: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 10:40: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 10:40:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:40: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 10:40: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 10:40: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 10:40: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 10:40: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 10:40: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 10:40:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:40:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:40:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:40:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:40:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:40:48 INFO - no previously-included directories found matching 'docs/_build' 10:40:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:40:48 INFO - Running setup.py install for pep8 10:40:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:40:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:40:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:40:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:40:49 INFO - no previously-included directories found matching 'docs/_build' 10:40:49 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:40:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:40:49 INFO - Cleaning up... 10:40:49 INFO - Return code: 0 10:40:49 INFO - Running post-action listener: _resource_record_post_action 10:40:49 INFO - Running post-action listener: _start_resource_monitoring 10:40:49 INFO - Starting resource monitoring. 10:40:49 INFO - ##### 10:40:49 INFO - ##### Running install step. 10:40:49 INFO - ##### 10:40:49 INFO - Running pre-action listener: _resource_record_pre_action 10:40:49 INFO - Running main action method: install 10:40:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:40:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:40:49 INFO - Reading from file tmpfile_stdout 10:40:49 INFO - Detecting whether we're running mozinstall >=1.0... 10:40:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:40:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:40:49 INFO - Reading from file tmpfile_stdout 10:40:49 INFO - Output received: 10:40:49 INFO - Usage: mozinstall [options] installer 10:40:49 INFO - Options: 10:40:49 INFO - -h, --help show this help message and exit 10:40:49 INFO - -d DEST, --destination=DEST 10:40:49 INFO - Directory to install application into. [default: 10:40:49 INFO - "/builds/slave/test-pgo"] 10:40:49 INFO - --app=APP Application being installed. [default: firefox] 10:40:49 INFO - mkdir: /builds/slave/test-pgo/build/application 10:40:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 10:40:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 10:41:04 INFO - Reading from file tmpfile_stdout 10:41:04 INFO - Output received: 10:41:04 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:41:04 INFO - Running post-action listener: _resource_record_post_action 10:41:04 INFO - ##### 10:41:04 INFO - ##### Running run-tests step. 10:41:04 INFO - ##### 10:41:04 INFO - Running pre-action listener: _resource_record_pre_action 10:41:04 INFO - Running main action method: run_tests 10:41:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:41:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:41:04 INFO - Python 2.7.3 10:41:04 INFO - Return code: 0 10:41:04 INFO - grabbing minidump binary from tooltool 10:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:41:04 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 0x2b597f0>, '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 0x2ac52d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac5760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:41:04 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 10:41:04 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 10:41:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:41:04 INFO - Return code: 0 10:41:04 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:41:04 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:41:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:41:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:41:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:41:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:41:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:41:05 INFO - Return code: 0 10:41:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 10:41:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 10:41:05 INFO - Using env: {'DISPLAY': ':0', 10:41:05 INFO - 'HOME': '/home/cltbld', 10:41:05 INFO - 'LANG': 'en_US.UTF-8', 10:41:05 INFO - 'LANGUAGE': 'en_US:en', 10:41:05 INFO - 'LOGNAME': 'cltbld', 10:41:05 INFO - 'MAIL': '/var/mail/cltbld', 10:41:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:41:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:05 INFO - 'MOZ_NO_REMOTE': '1', 10:41:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:41:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:05 INFO - 'NO_EM_RESTART': '1', 10:41:05 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:41:05 INFO - 'PWD': '/builds/slave/test-pgo', 10:41:05 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:41:05 INFO - 'SHELL': '/bin/bash', 10:41:05 INFO - 'SHLVL': '1', 10:41:05 INFO - 'TERM': 'linux', 10:41:05 INFO - 'TMOUT': '86400', 10:41:05 INFO - 'USER': 'cltbld', 10:41:05 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180', 10:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:05 INFO - '_': '/tools/buildbot/bin/python'} 10:41:05 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 10:41:05 INFO - mozversion application_buildid: 20160226075927 10:41:05 INFO - mozversion application_changeset: 79d93a35ff024b5c85f3cd96954dd5b22ef8c257 10:41:05 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:41:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:41:05 INFO - mozversion application_name: Firefox 10:41:05 INFO - mozversion application_remotingname: firefox-dev 10:41:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:41:05 INFO - mozversion application_vendor: Mozilla 10:41:05 INFO - mozversion application_version: 46.0a2 10:41:05 INFO - mozversion platform_buildid: 20160226075927 10:41:05 INFO - mozversion platform_changeset: 79d93a35ff024b5c85f3cd96954dd5b22ef8c257 10:41:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:41:05 INFO - mozversion platform_version: 46.0a2 10:41:05 INFO - using testdate: 1456512065 10:41:05 INFO - actual date: 1456512065 10:41:05 INFO - starting webserver on 'localhost:34884' 10:41:05 INFO - SUITE-START | Running 3 tests 10:41:05 INFO - TEST-START | dromaeo_css 10:41:05 INFO - operating with platform_type : linux_ 10:41:05 INFO - Initialising browser for dromaeo_css test... 10:41:05 INFO - TEST-INFO | started process 8706 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCUh7j1/profile http://localhost:34884/getInfo.html) 10:41:09 INFO - PROCESS | 8706 | 10:41:09 INFO - PROCESS | 8706 | (process:8788): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:41:10 INFO - PROCESS | 8706 | __metrics Screen width/height:1600/1200 10:41:10 INFO - PROCESS | 8706 | colorDepth:24 10:41:10 INFO - PROCESS | 8706 | Browser inner width/height: 1024/697 10:41:10 INFO - PROCESS | 8706 | __metrics 10:41:11 INFO - TEST-INFO | 8706: exit 0 10:41:11 INFO - Browser initialized. 10:41:11 INFO - Running cycle 1/1 for dromaeo_css test... 10:41:11 INFO - TEST-INFO | started process 8837 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCUh7j1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:41:12 INFO - PROCESS | 8837 | 10:41:12 INFO - PROCESS | 8837 | (process:8902): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:41:23 INFO - PROCESS | 8837 | RSS: Main: 140611584 10:41:23 INFO - PROCESS | 8837 | 10:42:12 INFO - PROCESS | 8837 | 1456512132751 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] 10:44:20 INFO - PROCESS | 8837 | Cycle 1(1): loaded http://localhost:34884/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34884/tests/dromaeo/cssquery-ext.html) 10:44:21 INFO - PROCESS | 8837 | RSS: Main: 145874944 10:44:21 INFO - PROCESS | 8837 | 10:47:23 INFO - PROCESS | 8837 | Cycle 1(1): loaded http://localhost:34884/tests/dromaeo/cssquery-ext.html (next: http://localhost:34884/tests/dromaeo/cssquery-jquery.html) 10:47:24 INFO - PROCESS | 8837 | RSS: Main: 145272832 10:47:24 INFO - PROCESS | 8837 | 10:50:25 INFO - PROCESS | 8837 | Cycle 1(1): loaded http://localhost:34884/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34884/tests/dromaeo/cssquery-mootools.html) 10:50:26 INFO - PROCESS | 8837 | RSS: Main: 143364096 10:50:26 INFO - PROCESS | 8837 | 10:53:28 INFO - PROCESS | 8837 | Cycle 1(1): loaded http://localhost:34884/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34884/tests/dromaeo/cssquery-prototype.html) 10:53:28 INFO - PROCESS | 8837 | RSS: Main: 143810560 10:53:28 INFO - PROCESS | 8837 | 10:56:30 INFO - PROCESS | 8837 | Cycle 1(1): loaded http://localhost:34884/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34884/tests/dromaeo/cssquery-yui.html) 10:56:31 INFO - PROCESS | 8837 | RSS: Main: 145301504 10:56:31 INFO - PROCESS | 8837 | 10:59:33 INFO - PROCESS | 8837 | Cycle 1(1): loaded http://localhost:34884/tests/dromaeo/cssquery-yui.html (next: http://localhost:34884/tests/dromaeo/cssquery-dojo.html) 10:59:34 INFO - PROCESS | 8837 | RSS: Main: 145354752 10:59:34 INFO - PROCESS | 8837 | 10:59:34 INFO - PROCESS | 8837 | __start_tp_report 10:59:34 INFO - PROCESS | 8837 | _x_x_mozilla_page_load 10:59:34 INFO - PROCESS | 8837 | _x_x_mozilla_page_load_details 10:59:34 INFO - PROCESS | 8837 | |i|pagename|runs| 10:59:34 INFO - PROCESS | 8837 | |0;dojo.html;3309.0900002499316;3357;3369.0903456066876;3377.3076519313536;3398.558187435633;5558.777648894044;5577.44225577442;5581.7209139542965;5596.2165296858375;5613.83158505245;5565.443455654433;5584.553235741141;5598.076317407633;5617.21359009739;5655.802046928358;5051.419086805018;5080.542751152396;5096.057229412552;5154.149565321717;5212.973935130319;4873.853784386456;4988.700677959316;4991.900161996758;5018;5135.255387968742;5031.069252188357;5060.671056381323;5063.620228482879;5082.3138876251605;5100.591952643798;5006.724630145341;5027.723475208862;5039.924401133986;5069.340985671857;5074.746262686851;4889.997550502138;4925.950740492621;4973.254011898208;4988.8503344899345;5059.747012649353;5345.465453454663;5351.812686555952;5382.4886635769535;5391.892162156774;5419.512243898068;5946.137810017523;5976.252968378953;5988.520918326523;6003.129546215818;6011.398860113954;5718.656880587178;5866.266716660418;5982.923073846706;6056.909146362808;6068.696565171768;5634.6337488063145;5653.123765816305;5657.8019769307875;5659.094544872801;5676.602637815355;5928.140419639129;6133.969330153321;6134.570580059442;6142.877142457215;6146.6004709693725;5658.405867383865;5926.644401335933;5977.581569290195;5983.581149319593;6029.728662210211;5901.439363260483;5905.911411328833;5918.171455996164;5938.732757025944;5950.821475355746;5772.509336706343;5866.853328666817;5879.617824841372;5892.852678682982;5939.465448109604;5976.073708575091;6004.789832355847;6011.759529618854;6048.334683184846;6052.425019623129;4479.081788233404;4487.573680500347;4493.191225579361;4519.5480451954545;4523.570260825217;3980.024893900955;4026.053877338823;4057.7159598827798;4061.3501839706096;4067.7559346438716;5605.971970140124;5618.129189975561;5635.802746903839;5644.209810626516;5683.488486036276;5992.64044157352;6006.039033754579;6014.36849130835;6022.066579680157;6029.969850150721;5406;5492.038893193675;5586.385497595261;5655.519280861173;5657;5013.623978201649;5075.923861142086;5083.110455670243;5087.364079490064;5090.490950904954;6126.846828829226;6128.693565321716;6158.445739883432;6160.229971253593;6179.81460556184;5810.564207684441;5853.64878107315;6032.065029920369;6121.693915304128;6129.601575897553;6138.176170136532;6153.169322141453;6166.136740856374;6187.597806142767;6194.349593292639;5683.943160568507;5961.374055724086;5964.284285885721;5992.101184822312;5995.550333724901;5845.561582881386;5964.493018093337;6031.819045428644;6035.456808887221;6069.150318955261;5776.711164441677;5802.1586869902785;5806.535477161732;5807.82576522705;5832.562557808096;5715.228444159985;5789.478946894799;5793.362730099601;5799.884002319845;5825.3883342248455;5787;5864.882702345843;5865.4134586541;5876.206712093984;5886.293644762656;5860.648361098348;5919.141724449844;5924.377940316204;5932.7033648318275;5936.317323507852;5627.549796016391;5628.859278517906;5653.943460565341;5780.132980053026;5788.652680839163 10:59:34 INFO - PROCESS | 8837 | |1;ext.html;540.954018908393;553.869840587462;574.2792795042227;577.7919948818426;603.0471854469938;36960;37654.43518347227;37682.623173768254;38126;38242;41154;41512.169756604926;41535.58464415355;41698.37452438216;41706.37440438388;8749.912500875005;8850.203481686647;8909;8920.598573064195;8920.910790892072;8629.180227878342;8816.030236673992;8830.955845220766;8990.415622984518;9042.140996605312;8993.910060899405;9053.818923621524;9117.133872282122;9127.634894604207;9173.174414302712;8838.86741698875;8918.777030574223;8924.598393072327;9024.368294219406;9056.683016094405;8885.955570222108;8893.955530222307;8989.505577193251;9027.187553120186;9043.502607356593;42016.369754453706;42368.57631423677;42508;42614.786926065484;42825.57174428278;3103.5189545620465;3515.3145136698354;3581.3553560359123;4076.7961601919787;4242.481193710974;30040.399192016037;30193.557403396084;30289.848550757324;30545.847270763505;30964.535531967038;3924.1759230561615;4036.732064655623;4143.70994030418;4157.48031496063;4198.349255865346;226976;229878;229925;230600;231028.84485577632;44672.3299150513;45697.54302457;45890.393836215575;57036.144457833165;57384.13923791146;42363.57636423596;42568.78715606464;42910;42939.78530107392;43148.78425607852;15599.688006239812;15634.296456659478;15646.2176891155;15691.607709807346;15734.527964161094;11486.827697584544;11491.138164637685;11548.884511154782;11556;11609.535618575163;14910.776338354717;15041.924790375979;15107.4712385066;15116.622084447978;15313.46402875894;5930;6056.426018941932;6114.2357205349335;6140.539459540552;6180.783672571529;1023.948802559869;1115.1469126118525;1142.1890457774907;1217.72601164739;1231.199720181889;30601.08196754101;30841.8457907709;30908.53637195444;34178.14554636154;35065.474017889755;1135.982960255597;1149.6033868315417;1164.2374244869625;1178.6699724077273;1318.7824009038593;14339.283035848166;14543.984346923275;14693.55919322422;15017.924910375597;15120.773188402183;501048;523607;523781;523926;527164;52565.47434525606;52683.73658131685;52847.47152528426;52870.735646321526;52921.735391323564;1468.6768910839812;1472.2197235465221;1481.1705444950862;1488.977665335021;1586.0008194837178;28991.710082898902;29504.262393439476;29714.55428168536;30151;31926.36147276995;46965.295520566535;46987.29519057149;47271.52728472809;47463.762681186374;47507.76246118747;324329;325076;325978;326745;327025.5541056052;33537.329253414304;33858.49212261769;33916;34286.14284642804;34658.30683386369;42615.360769589104;42688.78655606826;42737;42756.78621606872;43749.34375984426;38005.42991855069;38051.61948380481;38550.2289954205;38897.222055559294;39260.41109383304;38236.235275294894;38692;39110.6088939107;39226;39359.2128157441;35670.28659426745;36505.63494365022;39315.21369572535;39341.40987885241;39536.60463395444;32622.673773261962;33324.66675333313;33340.499892501146;33733.49399758956;34048;26664.20007399781;26713;26903;27041.459170816866;27147.321316966445 10:59:34 INFO - PROCESS | 8837 | |2;jquery.html;399.8020979615091;400.7134898547538;402.6336034208867;402.63762613647725;407.23643169058016;14729.48446804362;15391.153486558234;17005.65988680227;17621.7356739649;17674;11342.319460832356;11658.183927125105;15372.923135384335;16810.747838782427;16877.156142192904;5035.546800787937;5270.657407268534;5571.025070612626;5590.468905453975;5600.831975040755;5268.130758424874;5458.344998600173;5473.808416705416;5483.150111732688;5499.917501237484;5454.91817622736;5464.781408743645;5606.523445507137;5819.418058194189;5853.151293062503;5960.195373624592;6035.6076855004285;6079.604825686339;6085.421884920926;6319.4312511873695;5593.776248950037;5610.523105536035;5620.353659329188;5632.5212356949705;5652.0391533439415;16898.40855570049;20957.47606309839;21475.785242147536;21661.891690541448;21782.128714851544;2245.41619179013;2345.6129738593113;2350.17743789674;2356.929292121222;2435.7442468540726;9570.712878613653;9636.518174091267;9979.950100249525;10218.233632477593;10484.79030419395;1807.9096045197687;1926.2198809482181;1927.3254360973547;1931.758530183727;1963.6465436221474;52623.73688131535;53139.468605313836;56949.71525142348;60727;61534.38465615376;11107.333559986426;11108.111351092055;11122.44387780624;11139.16456265767;11139.331640101458;14557.490487832874;14584.781228281585;14619.634509137144;14638.487652932095;14699.26503674812;8270.627821748036;8299.460535065202;8321;8328.417010809186;8374.078851326349;7783.221677832172;7880.763577092696;7921.801954951057;7925.128235894047;7928;4461.910761784746;4591.931121033121;4631.444226692818;4810.687305325143;4920.5571498565305;1995.2418081129078;2031.1672214392029;2033.2172113736317;2039.4799326172028;2067.576146889884;1018.7453136715822;1019.9133073688671;1023.6417253961203;1099.6591056772265;1158.1082566423806;15536.689266214613;16911.830881691272;16931.661366772594;17585.472435826945;17645.647087058187;1037.8443233515034;1064.6167379743285;1078.1374900079904;1082.0748260237542;1090.9727256818644;9924.950375248078;10130.442825644514;10148.746281342877;10165.13596344319;10187.592496300213;398114;400394;400442;545476;549010;77988.05029874298;79736;79967;81165.59417202877;81370.77943830847;1185.5139392849062;1195.4142470189718;1196.4316949449117;1218.421249906305;1222.9816552751715;15754.606134846263;15832.525024249291;15968.28142733603;16034.35862565531;16129.354825806837;32158.678413216505;34316.48525272073;34467.655323446445;34610.82694586511;37401;41458.79270603628;41678;42114.57885421229;43307.13385732331;45190.548094518635;7653.540787552764;7747.612619369122;7797.337226335825;7819.100803407681;7930.841383172189;11568.537258509901;11642.301461912313;11814.291142531476;11843.940780296389;12259.38703064861;10031.799364012824;10295.845562316721;10453.529591168568;10664.842080028619;10806.189535785004;10743.570257189625;11111.499982500645;11132.944335278271;11312.264702794291;11360.602378916697;10800.891991080303;11056;11061.723456913642;11167.832482512606;11269.323840569265;7737.342325902361;7910.5649189295145;7915.802104947423;7949.165337639464;8007.15924827908;10685.946570267099;10978.505967231653;11066.944665276944;11160.330380177214;11258.887411125785 10:59:34 INFO - PROCESS | 8837 | |3;mootools.html;1525.687234117006;1547.14133655821;1796.811334809845;1881.2851116575716;1910.560571068654;7916.445848790587;7931.6034198290145;8089.271965523117;8122.431429799916;8126.024877014759;8230.547319897403;8283.08886022537;8331.541765202926;8398.034226064005;8400.53797041164;2447.5104979004227;2455.2756936703627;2458.43456005118;2475.8638274894874;2476.368526025861;2450.2894160693377;2497.3382053755768;2498.113169824713;2499.1377974598736;2502.2868482482495;2243.5849367866917;2303.7235531736133;2323.488832456865;2404.0744313439277;2423.9151629692965;2432.74456182101;2442.560339138954;2447.9755202447927;2459.7786199242155;2467.679201703767;2468.062136388179;2468.7654672806234;2495.1641200197955;2495.2763698527406;2499.687539057618;8263.421560490768;8284.585770711501;8358.414910956235;8384.119667434954;8400.41197116202;4954.504549545053;5120.871978200575;5125.384953805567;5132.358455193101;5158.484151584849;3115.610548681415;3171.57183780189;3204.439223135965;3213.0521496158453;3226.4998925166637;1014.5028935821394;1014.5028935821468;1023.8413045977885;1062.8193207154802;1074.049466222391;11572.76854462906;11609.07127429812;11623.186376953616;11635.825462618152;11656.067514598812;4453.599176074169;4511.796969136397;4546.795394207269;4565.657575681771;4567.840125595588;9395.389299695498;9430.481323527134;9457.810843783085;9459.574319155654;9489.288303377274;5165.483451654804;5189.351331083614;5196.142636464941;5201.063808514428;5206.505381988705;4654.4414670239785;4675.859724208279;4737.549932756383;4738.668293219511;4759.333693282943;3715.405535114369;3734.477173195755;3745.7377983541437;3749.643783840531;3760.2667479841716;1104.6520346090956;1110.2783190925963;1115.3308015190821;1122;1128.1087940526893;1411.8094057302133;1433.677422579932;1434.2971943747489;1437.985620143806;1473.4106357457104;7613.5431874087735;7634.427417943676;7664.271894170045;7735.033120859893;7759.107702614158;1211.3700875544666;1217.5190799634095;1229.6003798765437;1236.1470585296297;1242.310517662706;5924.644521328734;6037.305709843425;6049.939500605025;6099.115628233882;6144.78493252734;9818.754531136636;10116.140128089195;10123.898761012442;10177.134943529734;10269.537870795832;9798.069183427562;9937.205023598095;10029.04724051214;10067.748306292402;10075.496225188857;7710.76627739559;7820.374370050382;7837.1770964047955;7857.4499785014505;7868.173841746763;7428.777136685908;7472.327490525661;7507.62461876893;7525.322720954921;7526.962365188139;8806.735797926072;8853.867191991996;8924.152205540464;8980.955095224483;9075.2286055686;8730.083341249077;9002.279817614444;9229.307801914749;9279.304052195977;9410.576524056298;7721.961390193013;7868.370530357443;7878.881816772868;7882.605869706377;7897.091834439113;7678.425922685724;7794.025746781653;7867.606619669108;7882.408819338687;7885.053793544811;7398.815029624087;7401.59291238987;7425.405967522694;7433.516821406592;7464.290892365217;7320.341169294789;7401.259874012771;7431.962840185981;7478.214787447239;7508.549487030796;7114.537555058904;7202.71189152428;7252.673629686571;7301.963490182515;7306.378957788647;6785.355391237825;6812.420944219797;6826.214985276558;6845;6850.246472887879;6648.9002664961035;6778.2205046420295;6840.3501667341525;6852.6231057292325;6871.690773915286 10:59:34 INFO - PROCESS | 8837 | |4;prototype.html;363.7072156913687;365.3916229477919;365.9762115462495;369.2448941913786;370.5553335996803;6264.715733274679;6311.873762524752;6334.271558770743;6417.422431981121;6554.6067235965875;6316.368363163681;6335.398137176972;6344.619322840633;6351;6384.425401713845;4805.495422980589;4818.951810481903;4876.4148302203785;4884.145274576953;4898.779554920019;4860.270959356089;4901.583365413944;4918.483559226283;4919.704817710949;4926.211806111023;4704.670673052888;4723.07899959508;4786.401699787527;4809.158397280462;4883.072216278913;4814.325994360793;4815.518448155191;4842.733649649268;4842.927356089662;4843.443004054544;4209.284421648327;4224.66202703783;4227.217964676544;4230.51349094855;4242.957570424318;5913.940860591425;5924.2298501195;5925.970370148165;5934.258217722785;5946.137810017566;5485.890282194334;5614.466625670555;5678.630888992202;5679.971600141973;5690.857728556819;6736.494762892754;6752.155980502437;6779.796606101825;6786.219584747768;6786.524943253974;4729.243321068647;4738.976305118486;4741.8103275868925;4744.928826067612;4747.477777444478;6911.723531058751;6984.965075174642;7058.400035996895;7071.964640176818;7078.398336141434;4779.928301075487;4790.5448982346625;4816.446108697474;4827.879303017453;4834.927476087862;4867;4867.975660121677;4893.535114164149;4896.779644915988;4904.60763138948;5627.606067575312;5664.405237450009;5669.773209071674;5669.886602268014;5689.146628005832;6647.169103862017;6753.561018533779;6754.358335958076;6777.661116944133;6778.356056174655;1701.4810482802864;1733;1735.5747841778593;1736.7047601907707;1739.6955532781712;1149.080735411684;1154.3766366162347;1157.0280963990288;1163.1567113842395;1181.5864447443325;6442.903356449657;6484.416402523795;6527.988161834924;6530.216374035146;6555;6964.4080253179045;7026.402755765817;7030.050943122716;7032.964835175791;7035.753748618774;6382.776602818879;6521.706523206467;6522.608643481311;6571.80284591463;6576.80269591913;3769.1142581493327;3819.560750513671;3820.331441997695;3823.6941044716914;3827.234553089393;7188;7255.45584081196;7255.854882902312;7258.419326453871;7277.126744790659;7101.857962840714;7204.9279507204255;7245.384142347854;7249.673764680602;7262.20115787263;7193.856122877618;7242.13094428672;7258.818529536698;7284.781456556312;7288.052553168054;6957.026016357613;7062.788116356517;7063.293670632896;7067.858642827217;7069.82325441868;6813.727450901908;6917;6958.269381715049;6960.512764106464;6964.860702786017;7256.455765817479;7275.672594733144;7280.089988751406;7281.526700764433;7289.8177545559665;4854.053459575349;4854.466008739107;4875.68308059975;4893.461719210813;4897.41231052276;6915.101036865175;7074.04500392461;7079.68141433647;7082.362587367162;7114.324139206767;6840.897386539106;6853.657317134023;6890.896636550356;6897.206821215424;6910.7581234658555;6738.191417029988;6795.72817087311;6803;6859.794206173823;6867.07294515234;6726.8654626908165;6756.087928129639;6763.458923286224;6826.624535650587;6828.453723701992;6867.141607299088;6934.375906168469;6936.514443988873;6940.813643702218;6940.895886561605;6613.074169616354;6739.932600674127;6754.3921047106;6758.797236082925;6773.085633439423 10:59:34 INFO - PROCESS | 8837 | |5;yui.html;798.3652995868284;808.6361137488132;853.3855623950753;891.4933761942318;914.693577651487;14595.708085838276;14831.55505334839;14838.85161148391;14843.109413435188;14859.331330090145;13560.796588051187;13636.181829090237;13677;13720.58838234852;13721.93139034306;879.1120967822513;880.5201165364875;882.1575395497284;888.6845169964666;893.2273583350387;901.711452335253;913.9177474027337;915.7573243090586;918.481058202117;919.5907821019615;849.7748096754365;850.7575341027808;850.9234168924795;855.4610595324967;858.9785255368603;838.8448137094626;849.3290300662469;849.4181485682296;849.5964416901984;850.6980022092192;624.8594066335083;626.7524327890503;627.5795217204438;628.7045088808253;629.7134803664321;14968;14980.475683351031;15008.174550399724;15009.549713508612;15043.548693539102;13191.802122968164;13247.801282980763;13281.468741250339;13329.266890321029;13364.532241371506;11290.266132701348;11460.255083419552;11525.48135333912;11529.711757206052;11759.412029398582;3921.509811273591;3950.1902110067367;3981.402789581557;3994.560598334181;4041;51231;52271.73864130693;52330.476695232945;53486.46513534854;53586.46413535854;10983.505742241618;10999.560017599206;11019.393933333744;11065.612703555336;11210.66368008961;18735.531611709815;18805.62388752217;18856.52858678544;18917.62164756697;18959.810401895804;7664.386849052063;7880;7896.763097107096;8042.115367309591;8105.6757729691335;4376.715513491613;4535.024969631545;4551.385562949025;4599.05719327537;4655.790489427984;3007.263220510945;3035.4991426414394;3037.665856755755;3040.4831178699674;3056.312329725794;580.494969376645;582.1820342418908;584.6316820403118;588.4644973074481;590.4243362721398;649.4122818848855;665.6339013542629;668.5320275806955;702.9350533941083;758.7989182866545;9717.222622190207;9846.95076524627;10075.647352342632;10223.335483193718;10587.311824731369;615.5414216408805;704.968276427562;729.9306466168366;771.5794891783992;780.4770803561628;4426.734395936254;4430.490493593278;4433.091216300651;4441.977790111029;4499.775011249424;55919.440805591425;56191.71904140535;56651.43348566462;57016.71491642515;62658.68670656617;51740.74129629328;51751.22373164406;52404.73797630987;52978.470215298126;53442.73278633659;46369;46373.07253854904;46872.5312746875;48718.26922596164;49620;8891.866622000805;9234.815303694022;9333.953330233306;9687;9721.270904682036;34844.477332839524;35407.468887966184;36042;37616.81191594025;37623.623763762014;47496.287555687384;47560.286595701786;47631.52368476409;47906.76046619745;47995;11766.823497647714;11958;12032.75934481323;12144;12159.513619455123;13505.32473376347;13696.383662735001;13977.161370317814;14147.717045658823;14295.785563216352;12467.563635272722;12993.415296311878;13012.154209976321;13098.083134180515;13182.143160694524;11867;11980.760384792082;12634.2419454833;12796;13154.934225329194;11920.642380728592;12337.50649973991;12502.374881255719;12594.748105038032;12701.42843572023;10471;10595.576176953144;10703;10992.340459572451;11475.368854713071;10514.737131571772;11063.502142403771;11188.608398706006;11356.432178391213;11444.828327574927 10:59:34 INFO - PROCESS | 8837 | __end_tp_report 10:59:34 INFO - PROCESS | 8837 | __start_cc_report 10:59:34 INFO - PROCESS | 8837 | _x_x_mozilla_cycle_collect,283 10:59:34 INFO - PROCESS | 8837 | __end_cc_report 10:59:34 INFO - PROCESS | 8837 | __startTimestamp1456513174099__endTimestamp 10:59:34 INFO - PROCESS | 8837 | 10:59:34 INFO - PROCESS | 8837 | ------- Summary: start ------- 10:59:34 INFO - PROCESS | 8837 | Number of tests: 6 10:59:34 INFO - PROCESS | 8837 | 10:59:34 INFO - PROCESS | 8837 | [#0] dojo.html Cycles:165 Average:5534.14 Median:5772.51 stddev:628.81 (10.9%) stddev-sans-first:606.03 10:59:34 INFO - PROCESS | 8837 | Values: 3309.1 3357.0 3369.1 3377.3 3398.6 5558.8 5577.4 5581.7 5596.2 5613.8 5565.4 5584.6 5598.1 5617.2 5655.8 5051.4 5080.5 5096.1 5154.1 5213.0 4873.9 4988.7 4991.9 5018.0 5135.3 5031.1 5060.7 5063.6 5082.3 5100.6 5006.7 5027.7 5039.9 5069.3 5074.7 4890.0 4926.0 4973.3 4988.9 5059.7 5345.5 5351.8 5382.5 5391.9 5419.5 5946.1 5976.3 5988.5 6003.1 6011.4 5718.7 5866.3 5982.9 6056.9 6068.7 5634.6 5653.1 5657.8 5659.1 5676.6 5928.1 6134.0 6134.6 6142.9 6146.6 5658.4 5926.6 5977.6 5983.6 6029.7 5901.4 5905.9 5918.2 5938.7 5950.8 5772.5 5866.9 5879.6 5892.9 5939.5 5976.1 6004.8 6011.8 6048.3 6052.4 4479.1 4487.6 4493.2 4519.5 4523.6 3980.0 4026.1 4057.7 4061.4 4067.8 5606.0 5618.1 5635.8 5644.2 5683.5 5992.6 6006.0 6014.4 6022.1 6030.0 5406.0 5492.0 5586.4 5655.5 5657.0 5013.6 5075.9 5083.1 5087.4 5090.5 6126.8 6128.7 6158.4 6160.2 6179.8 5810.6 5853.6 6032.1 6121.7 6129.6 6138.2 6153.2 6166.1 6187.6 6194.3 5683.9 5961.4 5964.3 5992.1 5995.6 5845.6 5964.5 6031.8 6035.5 6069.2 5776.7 5802.2 5806.5 5807.8 5832.6 5715.2 5789.5 5793.4 5799.9 5825.4 5787.0 5864.9 5865.4 5876.2 5886.3 5860.6 5919.1 5924.4 5932.7 5936.3 5627.5 5628.9 5653.9 5780.1 5788.7 10:59:34 INFO - PROCESS | 8837 | 10:59:34 INFO - PROCESS | 8837 | [#1] ext.html Cycles:180 Average:51548.69 Median:39003.92 stddev:100483.35 (257.6%) stddev-sans-first:100692.25 10:59:34 INFO - PROCESS | 8837 | Values: 541.0 553.9 574.3 577.8 603.0 36960.0 37654.4 37682.6 38126.0 38242.0 41154.0 41512.2 41535.6 41698.4 41706.4 8749.9 8850.2 8909.0 8920.6 8920.9 8629.2 8816.0 8831.0 8990.4 9042.1 8993.9 9053.8 9117.1 9127.6 9173.2 8838.9 8918.8 8924.6 9024.4 9056.7 8886.0 8894.0 8989.5 9027.2 9043.5 42016.4 42368.6 42508.0 42614.8 42825.6 3103.5 3515.3 3581.4 4076.8 4242.5 30040.4 30193.6 30289.8 30545.8 30964.5 3924.2 4036.7 4143.7 4157.5 4198.3 226976.0 229878.0 229925.0 230600.0 231028.8 44672.3 45697.5 45890.4 57036.1 57384.1 42363.6 42568.8 42910.0 42939.8 43148.8 15599.7 15634.3 15646.2 15691.6 15734.5 11486.8 11491.1 11548.9 11556.0 11609.5 14910.8 15041.9 15107.5 15116.6 15313.5 5930.0 6056.4 6114.2 6140.5 6180.8 1023.9 1115.1 1142.2 1217.7 1231.2 30601.1 30841.8 30908.5 34178.1 35065.5 1136.0 1149.6 1164.2 1178.7 1318.8 14339.3 14544.0 14693.6 15017.9 15120.8 501048.0 523607.0 523781.0 523926.0 527164.0 52565.5 52683.7 52847.5 52870.7 52921.7 1468.7 1472.2 1481.2 1489.0 1586.0 28991.7 29504.3 29714.6 30151.0 31926.4 46965.3 46987.3 47271.5 47463.8 47507.8 324329.0 325076.0 325978.0 326745.0 327025.6 33537.3 33858.5 33916.0 34286.1 34658.3 42615.4 42688.8 42737.0 42756.8 43749.3 38005.4 38051.6 38550.2 38897.2 39260.4 38236.2 38692.0 39110.6 39226.0 39359.2 35670.3 36505.6 39315.2 39341.4 39536.6 32622.7 33324.7 33340.5 33733.5 34048.0 26664.2 26713.0 26903.0 27041.5 27147.3 10:59:34 INFO - PROCESS | 8837 | 10:59:34 INFO - PROCESS | 8837 | [#2] jquery.html Cycles:180 Average:25932.01 Median:12013.77 stddev:76073.11 (633.2%) stddev-sans-first:76262.36 10:59:34 INFO - PROCESS | 8837 | Values: 399.8 400.7 402.6 402.6 407.2 14729.5 15391.2 17005.7 17621.7 17674.0 11342.3 11658.2 15372.9 16810.7 16877.2 5035.5 5270.7 5571.0 5590.5 5600.8 5268.1 5458.3 5473.8 5483.2 5499.9 5454.9 5464.8 5606.5 5819.4 5853.2 5960.2 6035.6 6079.6 6085.4 6319.4 5593.8 5610.5 5620.4 5632.5 5652.0 16898.4 20957.5 21475.8 21661.9 21782.1 2245.4 2345.6 2350.2 2356.9 2435.7 9570.7 9636.5 9980.0 10218.2 10484.8 1807.9 1926.2 1927.3 1931.8 1963.6 52623.7 53139.5 56949.7 60727.0 61534.4 11107.3 11108.1 11122.4 11139.2 11139.3 14557.5 14584.8 14619.6 14638.5 14699.3 8270.6 8299.5 8321.0 8328.4 8374.1 7783.2 7880.8 7921.8 7925.1 7928.0 4461.9 4591.9 4631.4 4810.7 4920.6 1995.2 2031.2 2033.2 2039.5 2067.6 1018.7 1019.9 1023.6 1099.7 1158.1 15536.7 16911.8 16931.7 17585.5 17645.6 1037.8 1064.6 1078.1 1082.1 1091.0 9925.0 10130.4 10148.7 10165.1 10187.6 398114.0 400394.0 400442.0 545476.0 549010.0 77988.1 79736.0 79967.0 81165.6 81370.8 1185.5 1195.4 1196.4 1218.4 1223.0 15754.6 15832.5 15968.3 16034.4 16129.4 32158.7 34316.5 34467.7 34610.8 37401.0 41458.8 41678.0 42114.6 43307.1 45190.5 7653.5 7747.6 7797.3 7819.1 7930.8 11568.5 11642.3 11814.3 11843.9 12259.4 10031.8 10295.8 10453.5 10664.8 10806.2 10743.6 11111.5 11132.9 11312.3 11360.6 10800.9 11056.0 11061.7 11167.8 11269.3 7737.3 7910.6 7915.8 7949.2 8007.2 10685.9 10978.5 11066.9 11160.3 11258.9 10:59:34 INFO - PROCESS | 8837 | 10:59:34 INFO - PROCESS | 8837 | [#3] mootools.html Cycles:180 Average:5821.54 Median:5203.78 stddev:3000.85 (57.7%) stddev-sans-first:2991.89 10:59:34 INFO - PROCESS | 8837 | Values: 1525.7 1547.1 1796.8 1881.3 1910.6 7916.4 7931.6 8089.3 8122.4 8126.0 8230.5 8283.1 8331.5 8398.0 8400.5 2447.5 2455.3 2458.4 2475.9 2476.4 2450.3 2497.3 2498.1 2499.1 2502.3 2243.6 2303.7 2323.5 2404.1 2423.9 2432.7 2442.6 2448.0 2459.8 2467.7 2468.1 2468.8 2495.2 2495.3 2499.7 8263.4 8284.6 8358.4 8384.1 8400.4 4954.5 5120.9 5125.4 5132.4 5158.5 3115.6 3171.6 3204.4 3213.1 3226.5 1014.5 1014.5 1023.8 1062.8 1074.0 11572.8 11609.1 11623.2 11635.8 11656.1 4453.6 4511.8 4546.8 4565.7 4567.8 9395.4 9430.5 9457.8 9459.6 9489.3 5165.5 5189.4 5196.1 5201.1 5206.5 4654.4 4675.9 4737.5 4738.7 4759.3 3715.4 3734.5 3745.7 3749.6 3760.3 1104.7 1110.3 1115.3 1122.0 1128.1 1411.8 1433.7 1434.3 1438.0 1473.4 7613.5 7634.4 7664.3 7735.0 7759.1 1211.4 1217.5 1229.6 1236.1 1242.3 5924.6 6037.3 6049.9 6099.1 6144.8 9818.8 10116.1 10123.9 10177.1 10269.5 9798.1 9937.2 10029.0 10067.7 10075.5 7710.8 7820.4 7837.2 7857.4 7868.2 7428.8 7472.3 7507.6 7525.3 7527.0 8806.7 8853.9 8924.2 8981.0 9075.2 8730.1 9002.3 9229.3 9279.3 9410.6 7722.0 7868.4 7878.9 7882.6 7897.1 7678.4 7794.0 7867.6 7882.4 7885.1 7398.8 7401.6 7425.4 7433.5 7464.3 7320.3 7401.3 7432.0 7478.2 7508.5 7114.5 7202.7 7252.7 7302.0 7306.4 6785.4 6812.4 6826.2 6845.0 6850.2 6648.9 6778.2 6840.4 6852.6 6871.7 10:59:34 INFO - PROCESS | 8837 | 10:59:34 INFO - PROCESS | 8837 | [#4] prototype.html Cycles:180 Average:5684.31 Median:6463.66 stddev:1717.64 (26.6%) stddev-sans-first:1675.40 10:59:34 INFO - PROCESS | 8837 | Values: 363.7 365.4 366.0 369.2 370.6 6264.7 6311.9 6334.3 6417.4 6554.6 6316.4 6335.4 6344.6 6351.0 6384.4 4805.5 4819.0 4876.4 4884.1 4898.8 4860.3 4901.6 4918.5 4919.7 4926.2 4704.7 4723.1 4786.4 4809.2 4883.1 4814.3 4815.5 4842.7 4842.9 4843.4 4209.3 4224.7 4227.2 4230.5 4243.0 5913.9 5924.2 5926.0 5934.3 5946.1 5485.9 5614.5 5678.6 5680.0 5690.9 6736.5 6752.2 6779.8 6786.2 6786.5 4729.2 4739.0 4741.8 4744.9 4747.5 6911.7 6985.0 7058.4 7072.0 7078.4 4779.9 4790.5 4816.4 4827.9 4834.9 4867.0 4868.0 4893.5 4896.8 4904.6 5627.6 5664.4 5669.8 5669.9 5689.1 6647.2 6753.6 6754.4 6777.7 6778.4 1701.5 1733.0 1735.6 1736.7 1739.7 1149.1 1154.4 1157.0 1163.2 1181.6 6442.9 6484.4 6528.0 6530.2 6555.0 6964.4 7026.4 7030.1 7033.0 7035.8 6382.8 6521.7 6522.6 6571.8 6576.8 3769.1 3819.6 3820.3 3823.7 3827.2 7188.0 7255.5 7255.9 7258.4 7277.1 7101.9 7204.9 7245.4 7249.7 7262.2 7193.9 7242.1 7258.8 7284.8 7288.1 6957.0 7062.8 7063.3 7067.9 7069.8 6813.7 6917.0 6958.3 6960.5 6964.9 7256.5 7275.7 7280.1 7281.5 7289.8 4854.1 4854.5 4875.7 4893.5 4897.4 6915.1 7074.0 7079.7 7082.4 7114.3 6840.9 6853.7 6890.9 6897.2 6910.8 6738.2 6795.7 6803.0 6859.8 6867.1 6726.9 6756.1 6763.5 6826.6 6828.5 6867.1 6934.4 6936.5 6940.8 6940.9 6613.1 6739.9 6754.4 6758.8 6773.1 10:59:34 INFO - PROCESS | 8837 | 10:59:34 INFO - PROCESS | 8837 | [#5] yui.html Cycles:180 Average:14683.88 Median:4431.79 stddev:16504.86 (372.4%) stddev-sans-first:16518.22 10:59:34 INFO - PROCESS | 8837 | Values: 798.4 808.6 853.4 891.5 914.7 14595.7 14831.6 14838.9 14843.1 14859.3 13560.8 13636.2 13677.0 13720.6 13721.9 879.1 880.5 882.2 888.7 893.2 901.7 913.9 915.8 918.5 919.6 849.8 850.8 850.9 855.5 859.0 838.8 849.3 849.4 849.6 850.7 624.9 626.8 627.6 628.7 629.7 14968.0 14980.5 15008.2 15009.5 15043.5 13191.8 13247.8 13281.5 13329.3 13364.5 11290.3 11460.3 11525.5 11529.7 11759.4 3921.5 3950.2 3981.4 3994.6 4041.0 51231.0 52271.7 52330.5 53486.5 53586.5 10983.5 10999.6 11019.4 11065.6 11210.7 18735.5 18805.6 18856.5 18917.6 18959.8 7664.4 7880.0 7896.8 8042.1 8105.7 4376.7 4535.0 4551.4 4599.1 4655.8 3007.3 3035.5 3037.7 3040.5 3056.3 580.5 582.2 584.6 588.5 590.4 649.4 665.6 668.5 702.9 758.8 9717.2 9847.0 10075.6 10223.3 10587.3 615.5 705.0 729.9 771.6 780.5 4426.7 4430.5 4433.1 4442.0 4499.8 55919.4 56191.7 56651.4 57016.7 62658.7 51740.7 51751.2 52404.7 52978.5 53442.7 46369.0 46373.1 46872.5 48718.3 49620.0 8891.9 9234.8 9334.0 9687.0 9721.3 34844.5 35407.5 36042.0 37616.8 37623.6 47496.3 47560.3 47631.5 47906.8 47995.0 11766.8 11958.0 12032.8 12144.0 12159.5 13505.3 13696.4 13977.2 14147.7 14295.8 12467.6 12993.4 13012.2 13098.1 13182.1 11867.0 11980.8 12634.2 12796.0 13154.9 11920.6 12337.5 12502.4 12594.7 12701.4 10471.0 10595.6 10703.0 10992.3 11475.4 10514.7 11063.5 11188.6 11356.4 11444.8 10:59:34 INFO - PROCESS | 8837 | -------- Summary: end -------- 10:59:34 INFO - PROCESS | 8837 | 10:59:34 INFO - TEST-INFO | 8837: exit 0 10:59:34 INFO - TEST-OK | dromaeo_css | took 1108864ms 10:59:34 INFO - TEST-START | kraken 10:59:34 INFO - operating with platform_type : linux_ 10:59:34 INFO - Initialising browser for kraken test... 10:59:34 INFO - TEST-INFO | started process 9081 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsUXoLS/profile http://localhost:34884/getInfo.html) 10:59:38 INFO - PROCESS | 9081 | 10:59:38 INFO - PROCESS | 9081 | (process:9163): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:59:38 INFO - PROCESS | 9081 | __metrics Screen width/height:1600/1200 10:59:38 INFO - PROCESS | 9081 | colorDepth:24 10:59:38 INFO - PROCESS | 9081 | Browser inner width/height: 1024/697 10:59:38 INFO - PROCESS | 9081 | __metrics 10:59:39 INFO - TEST-INFO | 9081: exit 0 10:59:39 INFO - Browser initialized. 10:59:39 INFO - Running cycle 1/1 for kraken test... 10:59:39 INFO - TEST-INFO | started process 9212 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsUXoLS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:59:41 INFO - PROCESS | 9212 | 10:59:41 INFO - PROCESS | 9212 | (process:9275): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:59:51 INFO - PROCESS | 9212 | RSS: Main: 140996608 10:59:51 INFO - PROCESS | 9212 | 10:59:54 INFO - PROCESS | 9212 | Cycle 1(1): loaded http://localhost:34884/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34884/tests/kraken/driver.html?testName=audio-beat-detection) 10:59:54 INFO - PROCESS | 9212 | RSS: Main: 146448384 10:59:54 INFO - PROCESS | 9212 | 10:59:57 INFO - PROCESS | 9212 | Cycle 1(1): loaded http://localhost:34884/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34884/tests/kraken/driver.html?testName=audio-dft) 10:59:57 INFO - PROCESS | 9212 | RSS: Main: 145432576 10:59:57 INFO - PROCESS | 9212 | 11:00:00 INFO - PROCESS | 9212 | Cycle 1(1): loaded http://localhost:34884/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34884/tests/kraken/driver.html?testName=audio-fft) 11:00:01 INFO - PROCESS | 9212 | RSS: Main: 145498112 11:00:01 INFO - PROCESS | 9212 | 11:00:03 INFO - PROCESS | 9212 | Cycle 1(1): loaded http://localhost:34884/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34884/tests/kraken/driver.html?testName=audio-oscillator) 11:00:03 INFO - PROCESS | 9212 | RSS: Main: 144781312 11:00:03 INFO - PROCESS | 9212 | 11:00:06 INFO - PROCESS | 9212 | Cycle 1(1): loaded http://localhost:34884/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34884/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:00:06 INFO - PROCESS | 9212 | RSS: Main: 146132992 11:00:06 INFO - PROCESS | 9212 | 11:00:09 INFO - PROCESS | 9212 | Cycle 1(1): loaded http://localhost:34884/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34884/tests/kraken/driver.html?testName=imaging-darkroom) 11:00:10 INFO - PROCESS | 9212 | RSS: Main: 146194432 11:00:10 INFO - PROCESS | 9212 | 11:00:13 INFO - PROCESS | 9212 | Cycle 1(1): loaded http://localhost:34884/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34884/tests/kraken/driver.html?testName=imaging-desaturate) 11:00:14 INFO - PROCESS | 9212 | RSS: Main: 145563648 11:00:14 INFO - PROCESS | 9212 | 11:00:17 INFO - PROCESS | 9212 | Cycle 1(1): loaded http://localhost:34884/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34884/tests/kraken/driver.html?testName=json-parse-financial) 11:00:17 INFO - PROCESS | 9212 | RSS: Main: 145260544 11:00:17 INFO - PROCESS | 9212 | 11:00:19 INFO - PROCESS | 9212 | Cycle 1(1): loaded http://localhost:34884/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34884/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:00:19 INFO - PROCESS | 9212 | RSS: Main: 146096128 11:00:19 INFO - PROCESS | 9212 | 11:00:21 INFO - PROCESS | 9212 | Cycle 1(1): loaded http://localhost:34884/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34884/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:00:22 INFO - PROCESS | 9212 | RSS: Main: 145162240 11:00:22 INFO - PROCESS | 9212 | 11:00:24 INFO - PROCESS | 9212 | Cycle 1(1): loaded http://localhost:34884/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34884/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:00:24 INFO - PROCESS | 9212 | RSS: Main: 146489344 11:00:24 INFO - PROCESS | 9212 | 11:00:27 INFO - PROCESS | 9212 | Cycle 1(1): loaded http://localhost:34884/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34884/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:00:27 INFO - PROCESS | 9212 | RSS: Main: 147648512 11:00:27 INFO - PROCESS | 9212 | 11:00:30 INFO - PROCESS | 9212 | Cycle 1(1): loaded http://localhost:34884/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34884/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:00:30 INFO - PROCESS | 9212 | RSS: Main: 147066880 11:00:30 INFO - PROCESS | 9212 | 11:00:32 INFO - PROCESS | 9212 | Cycle 1(1): loaded http://localhost:34884/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34884/tests/kraken/driver.html?testName=ai-astar) 11:00:32 INFO - PROCESS | 9212 | RSS: Main: 148606976 11:00:32 INFO - PROCESS | 9212 | 11:00:32 INFO - PROCESS | 9212 | __start_tp_report 11:00:32 INFO - PROCESS | 9212 | _x_x_mozilla_page_load 11:00:32 INFO - PROCESS | 9212 | _x_x_mozilla_page_load_details 11:00:32 INFO - PROCESS | 9212 | |i|pagename|runs| 11:00:32 INFO - PROCESS | 9212 | |0;ai-astar;113;107;110;112;113;123;111;112;113;110 11:00:32 INFO - PROCESS | 9212 | |1;audio-beat-detection;154;125;148;172;128;146;153;128;165;125 11:00:32 INFO - PROCESS | 9212 | |2;audio-dft;162;162;161;165;162;162;161;164;163;161 11:00:32 INFO - PROCESS | 9212 | |3;audio-fft;73;72;73;150;76;76;75;77;161;74 11:00:32 INFO - PROCESS | 9212 | |4;audio-oscillator;96;96;139;95;96;95;140;95;95;145 11:00:32 INFO - PROCESS | 9212 | |5;imaging-gaussian-blur;110;109;109;110;109;110;109;109;110;110 11:00:32 INFO - PROCESS | 9212 | |6;imaging-darkroom;147;147;146;147;149;147;146;146;148;146 11:00:32 INFO - PROCESS | 9212 | |7;imaging-desaturate;99;96;96;101;96;98;97;97;96;96 11:00:32 INFO - PROCESS | 9212 | |8;json-parse-financial;56;55;59;55;58;55;58;56;53;55 11:00:32 INFO - PROCESS | 9212 | |9;json-stringify-tinderbox;64;66;64;64;65;69;64;64;65;67 11:00:32 INFO - PROCESS | 9212 | |10;stanford-crypto-aes;79;80;79;80;80;79;82;81;80;79 11:00:32 INFO - PROCESS | 9212 | |11;stanford-crypto-ccm;118;113;113;114;113;111;119;112;115;114 11:00:32 INFO - PROCESS | 9212 | |12;stanford-crypto-pbkdf2;139;142;139;137;144;139;137;138;141;127 11:00:32 INFO - PROCESS | 9212 | |13;stanford-crypto-sha256-iterative;63;65;64;67;65;71;63;67;67;64 11:00:32 INFO - PROCESS | 9212 | __end_tp_report 11:00:32 INFO - PROCESS | 9212 | __start_cc_report 11:00:32 INFO - PROCESS | 9212 | _x_x_mozilla_cycle_collect,740 11:00:32 INFO - PROCESS | 9212 | __end_cc_report 11:00:32 INFO - PROCESS | 9212 | __startTimestamp1456513232635__endTimestamp 11:00:32 INFO - PROCESS | 9212 | 11:00:32 INFO - PROCESS | 9212 | ------- Summary: start ------- 11:00:32 INFO - PROCESS | 9212 | Number of tests: 14 11:00:32 INFO - PROCESS | 9212 | 11:00:32 INFO - PROCESS | 9212 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.50 stddev:4.17 (3.7%) stddev-sans-first:4.42 11:00:32 INFO - PROCESS | 9212 | Values: 113.0 107.0 110.0 112.0 113.0 123.0 111.0 112.0 113.0 110.0 11:00:32 INFO - PROCESS | 9212 | 11:00:32 INFO - PROCESS | 9212 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:150.50 stddev:17.19 (11.4%) stddev-sans-first:17.87 11:00:32 INFO - PROCESS | 9212 | Values: 154.0 125.0 148.0 172.0 128.0 146.0 153.0 128.0 165.0 125.0 11:00:32 INFO - PROCESS | 9212 | 11:00:32 INFO - PROCESS | 9212 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:1.34 (0.8%) stddev-sans-first:1.41 11:00:32 INFO - PROCESS | 9212 | Values: 162.0 162.0 161.0 165.0 162.0 162.0 161.0 164.0 163.0 161.0 11:00:32 INFO - PROCESS | 9212 | 11:00:32 INFO - PROCESS | 9212 | [#3] audio-fft Cycles:10 Average:90.70 Median:74.50 stddev:34.29 (46.0%) stddev-sans-first:35.76 11:00:32 INFO - PROCESS | 9212 | Values: 73.0 72.0 73.0 150.0 76.0 76.0 75.0 77.0 161.0 74.0 11:00:32 INFO - PROCESS | 9212 | 11:00:32 INFO - PROCESS | 9212 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:95.00 stddev:22.23 (23.4%) stddev-sans-first:23.06 11:00:32 INFO - PROCESS | 9212 | Values: 96.0 96.0 139.0 95.0 96.0 95.0 140.0 95.0 95.0 145.0 11:00:32 INFO - PROCESS | 9212 | 11:00:32 INFO - PROCESS | 9212 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 11:00:32 INFO - PROCESS | 9212 | Values: 110.0 109.0 109.0 110.0 109.0 110.0 109.0 109.0 110.0 110.0 11:00:32 INFO - PROCESS | 9212 | 11:00:32 INFO - PROCESS | 9212 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 11:00:32 INFO - PROCESS | 9212 | Values: 147.0 147.0 146.0 147.0 149.0 147.0 146.0 146.0 148.0 146.0 11:00:32 INFO - PROCESS | 9212 | 11:00:32 INFO - PROCESS | 9212 | [#7] imaging-desaturate Cycles:10 Average:97.20 Median:96.50 stddev:1.69 (1.7%) stddev-sans-first:1.66 11:00:32 INFO - PROCESS | 9212 | Values: 99.0 96.0 96.0 101.0 96.0 98.0 97.0 97.0 96.0 96.0 11:00:32 INFO - PROCESS | 9212 | 11:00:32 INFO - PROCESS | 9212 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:1.83 (3.3%) stddev-sans-first:1.94 11:00:32 INFO - PROCESS | 9212 | Values: 56.0 55.0 59.0 55.0 58.0 55.0 58.0 56.0 53.0 55.0 11:00:32 INFO - PROCESS | 9212 | 11:00:32 INFO - PROCESS | 9212 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:1.69 (2.6%) stddev-sans-first:1.73 11:00:32 INFO - PROCESS | 9212 | Values: 64.0 66.0 64.0 64.0 65.0 69.0 64.0 64.0 65.0 67.0 11:00:32 INFO - PROCESS | 9212 | 11:00:32 INFO - PROCESS | 9212 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:80.00 stddev:0.99 (1.2%) stddev-sans-first:1.00 11:00:32 INFO - PROCESS | 9212 | Values: 79.0 80.0 79.0 80.0 80.0 79.0 82.0 81.0 80.0 79.0 11:00:32 INFO - PROCESS | 9212 | 11:00:32 INFO - PROCESS | 9212 | [#11] stanford-crypto-ccm Cycles:10 Average:114.20 Median:114.00 stddev:2.53 (2.2%) stddev-sans-first:2.28 11:00:32 INFO - PROCESS | 9212 | Values: 118.0 113.0 113.0 114.0 113.0 111.0 119.0 112.0 115.0 114.0 11:00:32 INFO - PROCESS | 9212 | 11:00:32 INFO - PROCESS | 9212 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.30 Median:139.00 stddev:4.55 (3.3%) stddev-sans-first:4.82 11:00:32 INFO - PROCESS | 9212 | Values: 139.0 142.0 139.0 137.0 144.0 139.0 137.0 138.0 141.0 127.0 11:00:32 INFO - PROCESS | 9212 | 11:00:32 INFO - PROCESS | 9212 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:2.46 (3.7%) stddev-sans-first:2.42 11:00:32 INFO - PROCESS | 9212 | Values: 63.0 65.0 64.0 67.0 65.0 71.0 63.0 67.0 67.0 64.0 11:00:32 INFO - PROCESS | 9212 | -------- Summary: end -------- 11:00:32 INFO - PROCESS | 9212 | 11:00:33 INFO - TEST-INFO | 9212: exit 0 11:00:33 INFO - TEST-OK | kraken | took 58834ms 11:00:33 INFO - TEST-START | v8_7 11:00:33 INFO - operating with platform_type : linux_ 11:00:33 INFO - Initialising browser for v8_7 test... 11:00:33 INFO - TEST-INFO | started process 9504 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZHoMrB/profile http://localhost:34884/getInfo.html) 11:00:36 INFO - PROCESS | 9504 | 11:00:36 INFO - PROCESS | 9504 | (process:9581): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:00:37 INFO - PROCESS | 9504 | __metrics Screen width/height:1600/1200 11:00:37 INFO - PROCESS | 9504 | colorDepth:24 11:00:37 INFO - PROCESS | 9504 | Browser inner width/height: 1024/697 11:00:37 INFO - PROCESS | 9504 | __metrics 11:00:38 INFO - TEST-INFO | 9504: exit 0 11:00:38 INFO - Browser initialized. 11:00:38 INFO - Running cycle 1/1 for v8_7 test... 11:00:38 INFO - TEST-INFO | started process 9630 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZHoMrB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:00:39 INFO - PROCESS | 9630 | 11:00:39 INFO - PROCESS | 9630 | (process:9693): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:00:50 INFO - PROCESS | 9630 | RSS: Main: 141672448 11:00:50 INFO - PROCESS | 9630 | 11:01:12 INFO - PROCESS | 9630 | Cycle 1(1): loaded http://localhost:34884/tests/v8_7/run.html (next: http://localhost:34884/tests/v8_7/run.html) 11:01:13 INFO - PROCESS | 9630 | RSS: Main: 145678336 11:01:13 INFO - PROCESS | 9630 | 11:01:13 INFO - PROCESS | 9630 | __start_tp_report 11:01:13 INFO - PROCESS | 9630 | _x_x_mozilla_page_load 11:01:13 INFO - PROCESS | 9630 | _x_x_mozilla_page_load_details 11:01:13 INFO - PROCESS | 9630 | |i|pagename|runs| 11:01:13 INFO - PROCESS | 9630 | |0;Richards;166.55562958027983 11:01:13 INFO - PROCESS | 9630 | |1;DeltaBlue;170.41581458759373 11:01:13 INFO - PROCESS | 9630 | |2;Encrypt;278.9400278940028 11:01:13 INFO - PROCESS | 9630 | |3;Decrypt;5213.541666666667 11:01:13 INFO - PROCESS | 9630 | |4;RayTrace;912.4087591240876 11:01:13 INFO - PROCESS | 9630 | |5;Earley;599.880023995201 11:01:13 INFO - PROCESS | 9630 | |6;Boyer;11188.888888888889 11:01:13 INFO - PROCESS | 9630 | |7;RegExp;38923.07692307692 11:01:13 INFO - PROCESS | 9630 | |8;Splay;528.2620179609086 11:01:13 INFO - PROCESS | 9630 | |9;NavierStokes;4830.917874396136 11:01:13 INFO - PROCESS | 9630 | __end_tp_report 11:01:13 INFO - PROCESS | 9630 | __startTimestamp1456513273073__endTimestamp 11:01:13 INFO - PROCESS | 9630 | 11:01:13 INFO - PROCESS | 9630 | ------- Summary: start ------- 11:01:13 INFO - PROCESS | 9630 | Number of tests: 10 11:01:13 INFO - PROCESS | 9630 | 11:01:13 INFO - PROCESS | 9630 | [#0] Richards Cycles:1 Average:166.56 Median:166.56 stddev:0.00 (0.0%) 11:01:13 INFO - PROCESS | 9630 | Values: 166.6 11:01:13 INFO - PROCESS | 9630 | 11:01:13 INFO - PROCESS | 9630 | [#1] DeltaBlue Cycles:1 Average:170.42 Median:170.42 stddev:0.00 (0.0%) 11:01:13 INFO - PROCESS | 9630 | Values: 170.4 11:01:13 INFO - PROCESS | 9630 | 11:01:13 INFO - PROCESS | 9630 | [#2] Encrypt Cycles:1 Average:278.94 Median:278.94 stddev:0.00 (0.0%) 11:01:13 INFO - PROCESS | 9630 | Values: 278.9 11:01:13 INFO - PROCESS | 9630 | 11:01:13 INFO - PROCESS | 9630 | [#3] Decrypt Cycles:1 Average:5213.54 Median:5213.54 stddev:0.00 (0.0%) 11:01:13 INFO - PROCESS | 9630 | Values: 5213.5 11:01:13 INFO - PROCESS | 9630 | 11:01:13 INFO - PROCESS | 9630 | [#4] RayTrace Cycles:1 Average:912.41 Median:912.41 stddev:0.00 (0.0%) 11:01:13 INFO - PROCESS | 9630 | Values: 912.4 11:01:13 INFO - PROCESS | 9630 | 11:01:13 INFO - PROCESS | 9630 | [#5] Earley Cycles:1 Average:599.88 Median:599.88 stddev:0.00 (0.0%) 11:01:13 INFO - PROCESS | 9630 | Values: 599.9 11:01:13 INFO - PROCESS | 9630 | 11:01:13 INFO - PROCESS | 9630 | [#6] Boyer Cycles:1 Average:11188.89 Median:11188.89 stddev:0.00 (0.0%) 11:01:13 INFO - PROCESS | 9630 | Values: 11188.9 11:01:13 INFO - PROCESS | 9630 | 11:01:13 INFO - PROCESS | 9630 | [#7] RegExp Cycles:1 Average:38923.08 Median:38923.08 stddev:0.00 (0.0%) 11:01:13 INFO - PROCESS | 9630 | Values: 38923.1 11:01:13 INFO - PROCESS | 9630 | 11:01:13 INFO - PROCESS | 9630 | [#8] Splay Cycles:1 Average:528.26 Median:528.26 stddev:0.00 (0.0%) 11:01:13 INFO - PROCESS | 9630 | Values: 528.3 11:01:13 INFO - PROCESS | 9630 | 11:01:13 INFO - PROCESS | 9630 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 11:01:13 INFO - PROCESS | 9630 | Values: 4830.9 11:01:13 INFO - PROCESS | 9630 | -------- Summary: end -------- 11:01:13 INFO - PROCESS | 9630 | 11:01:13 INFO - TEST-INFO | 9630: exit 0 11:01:13 INFO - TEST-OK | v8_7 | took 40388ms 11:01:13 INFO - SUITE-END | took 1208s 11:01:14 INFO - Completed test suite (00:20:08) 11:01:14 INFO - Working with test: dromaeo_css 11:01:14 INFO - Generating results file: dromaeo_css 11:01:14 INFO - Working with test: kraken 11:01:14 INFO - Generating results file: kraken 11:01:14 INFO - javascript benchmark 11:01:14 INFO - Working with test: v8_7 11:01:14 INFO - Generating results file: v8_7 11:01:14 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:01:14 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 11:01:14 INFO - process_Request line: dromaeo_css 7287.19 graph.html#tests=[[72,52,43]] 11:01:14 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:01:14 INFO - process_Request line: kraken 1491.80 graph.html#tests=[[232,52,43]] 11:01:14 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:01:14 INFO - process_Request line: v8_7 21878.86 graph.html#tests=[[230,52,43]] 11:01:14 INFO - RETURN: dromaeo_css: 7287.19 11:01:14 INFO - RETURN: kraken: 1491.80 11:01:14 INFO - RETURN: v8_7: 21878.86 11:01:14 INFO - javascript benchmark 11:01:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3309.0900002499316, 3357.0, 3369.0903456066876, 3377.3076519313536, 3398.558187435633, 5558.777648894044, 5577.44225577442, 5581.7209139542965, 5596.2165296858375, 5613.83158505245, 5565.443455654433, 5584.553235741141, 5598.076317407633, 5617.21359009739, 5655.802046928358, 5051.419086805018, 5080.542751152396, 5096.057229412552, 5154.149565321717, 5212.973935130319, 4873.853784386456, 4988.700677959316, 4991.900161996758, 5018.0, 5135.255387968742, 5031.069252188357, 5060.671056381323, 5063.620228482879, 5082.3138876251605, 5100.591952643798, 5006.724630145341, 5027.723475208862, 5039.924401133986, 5069.340985671857, 5074.746262686851, 4889.997550502138, 4925.950740492621, 4973.254011898208, 4988.8503344899345, 5059.747012649353, 5345.465453454663, 5351.812686555952, 5382.4886635769535, 5391.892162156774, 5419.512243898068, 5946.137810017523, 5976.252968378953, 5988.520918326523, 6003.129546215818, 6011.398860113954, 5718.656880587178, 5866.266716660418, 5982.923073846706, 6056.909146362808, 6068.696565171768, 5634.6337488063145, 5653.123765816305, 5657.8019769307875, 5659.094544872801, 5676.602637815355, 5928.140419639129, 6133.969330153321, 6134.570580059442, 6142.877142457215, 6146.6004709693725, 5658.405867383865, 5926.644401335933, 5977.581569290195, 5983.581149319593, 6029.728662210211, 5901.439363260483, 5905.911411328833, 5918.171455996164, 5938.732757025944, 5950.821475355746, 5772.509336706343, 5866.853328666817, 5879.617824841372, 5892.852678682982, 5939.465448109604, 5976.073708575091, 6004.789832355847, 6011.759529618854, 6048.334683184846, 6052.425019623129, 4479.081788233404, 4487.573680500347, 4493.191225579361, 4519.5480451954545, 4523.570260825217, 3980.024893900955, 4026.053877338823, 4057.7159598827798, 4061.3501839706096, 4067.7559346438716, 5605.971970140124, 5618.129189975561, 5635.802746903839, 5644.209810626516, 5683.488486036276, 5992.64044157352, 6006.039033754579, 6014.36849130835, 6022.066579680157, 6029.969850150721, 5406.0, 5492.038893193675, 5586.385497595261, 5655.519280861173, 5657.0, 5013.623978201649, 5075.923861142086, 5083.110455670243, 5087.364079490064, 5090.490950904954, 6126.846828829226, 6128.693565321716, 6158.445739883432, 6160.229971253593, 6179.81460556184, 5810.564207684441, 5853.64878107315, 6032.065029920369, 6121.693915304128, 6129.601575897553, 6138.176170136532, 6153.169322141453, 6166.136740856374, 6187.597806142767, 6194.349593292639, 5683.943160568507, 5961.374055724086, 5964.284285885721, 5992.101184822312, 5995.550333724901, 5845.561582881386, 5964.493018093337, 6031.819045428644, 6035.456808887221, 6069.150318955261, 5776.711164441677, 5802.1586869902785, 5806.535477161732, 5807.82576522705, 5832.562557808096, 5715.228444159985, 5789.478946894799, 5793.362730099601, 5799.884002319845, 5825.3883342248455, 5787.0, 5864.882702345843, 5865.4134586541, 5876.206712093984, 5886.293644762656, 5860.648361098348, 5919.141724449844, 5924.377940316204, 5932.7033648318275, 5936.317323507852, 5627.549796016391, 5628.859278517906, 5653.943460565341, 5780.132980053026, 5788.652680839163], "unit": "score", "name": "dojo.html", "value": 5492.714077669796}, {"lowerIsBetter": false, "replicates": [540.954018908393, 553.869840587462, 574.2792795042227, 577.7919948818426, 603.0471854469938, 36960.0, 37654.43518347227, 37682.623173768254, 38126.0, 38242.0, 41154.0, 41512.169756604926, 41535.58464415355, 41698.37452438216, 41706.37440438388, 8749.912500875005, 8850.203481686647, 8909.0, 8920.598573064195, 8920.910790892072, 8629.180227878342, 8816.030236673992, 8830.955845220766, 8990.415622984518, 9042.140996605312, 8993.910060899405, 9053.818923621524, 9117.133872282122, 9127.634894604207, 9173.174414302712, 8838.86741698875, 8918.777030574223, 8924.598393072327, 9024.368294219406, 9056.683016094405, 8885.955570222108, 8893.955530222307, 8989.505577193251, 9027.187553120186, 9043.502607356593, 42016.369754453706, 42368.57631423677, 42508.0, 42614.786926065484, 42825.57174428278, 3103.5189545620465, 3515.3145136698354, 3581.3553560359123, 4076.7961601919787, 4242.481193710974, 30040.399192016037, 30193.557403396084, 30289.848550757324, 30545.847270763505, 30964.535531967038, 3924.1759230561615, 4036.732064655623, 4143.70994030418, 4157.48031496063, 4198.349255865346, 226976.0, 229878.0, 229925.0, 230600.0, 231028.84485577632, 44672.3299150513, 45697.54302457, 45890.393836215575, 57036.144457833165, 57384.13923791146, 42363.57636423596, 42568.78715606464, 42910.0, 42939.78530107392, 43148.78425607852, 15599.688006239812, 15634.296456659478, 15646.2176891155, 15691.607709807346, 15734.527964161094, 11486.827697584544, 11491.138164637685, 11548.884511154782, 11556.0, 11609.535618575163, 14910.776338354717, 15041.924790375979, 15107.4712385066, 15116.622084447978, 15313.46402875894, 5930.0, 6056.426018941932, 6114.2357205349335, 6140.539459540552, 6180.783672571529, 1023.948802559869, 1115.1469126118525, 1142.1890457774907, 1217.72601164739, 1231.199720181889, 30601.08196754101, 30841.8457907709, 30908.53637195444, 34178.14554636154, 35065.474017889755, 1135.982960255597, 1149.6033868315417, 1164.2374244869625, 1178.6699724077273, 1318.7824009038593, 14339.283035848166, 14543.984346923275, 14693.55919322422, 15017.924910375597, 15120.773188402183, 501048.0, 523607.0, 523781.0, 523926.0, 527164.0, 52565.47434525606, 52683.73658131685, 52847.47152528426, 52870.735646321526, 52921.735391323564, 1468.6768910839812, 1472.2197235465221, 1481.1705444950862, 1488.977665335021, 1586.0008194837178, 28991.710082898902, 29504.262393439476, 29714.55428168536, 30151.0, 31926.36147276995, 46965.295520566535, 46987.29519057149, 47271.52728472809, 47463.762681186374, 47507.76246118747, 324329.0, 325076.0, 325978.0, 326745.0, 327025.5541056052, 33537.329253414304, 33858.49212261769, 33916.0, 34286.14284642804, 34658.30683386369, 42615.360769589104, 42688.78655606826, 42737.0, 42756.78621606872, 43749.34375984426, 38005.42991855069, 38051.61948380481, 38550.2289954205, 38897.222055559294, 39260.41109383304, 38236.235275294894, 38692.0, 39110.6088939107, 39226.0, 39359.2128157441, 35670.28659426745, 36505.63494365022, 39315.21369572535, 39341.40987885241, 39536.60463395444, 32622.673773261962, 33324.66675333313, 33340.499892501146, 33733.49399758956, 34048.0, 26664.20007399781, 26713.0, 26903.0, 27041.459170816866, 27147.321316966445], "unit": "score", "name": "ext.html", "value": 18816.174040903323}, {"lowerIsBetter": false, "replicates": [399.8020979615091, 400.7134898547538, 402.6336034208867, 402.63762613647725, 407.23643169058016, 14729.48446804362, 15391.153486558234, 17005.65988680227, 17621.7356739649, 17674.0, 11342.319460832356, 11658.183927125105, 15372.923135384335, 16810.747838782427, 16877.156142192904, 5035.546800787937, 5270.657407268534, 5571.025070612626, 5590.468905453975, 5600.831975040755, 5268.130758424874, 5458.344998600173, 5473.808416705416, 5483.150111732688, 5499.917501237484, 5454.91817622736, 5464.781408743645, 5606.523445507137, 5819.418058194189, 5853.151293062503, 5960.195373624592, 6035.6076855004285, 6079.604825686339, 6085.421884920926, 6319.4312511873695, 5593.776248950037, 5610.523105536035, 5620.353659329188, 5632.5212356949705, 5652.0391533439415, 16898.40855570049, 20957.47606309839, 21475.785242147536, 21661.891690541448, 21782.128714851544, 2245.41619179013, 2345.6129738593113, 2350.17743789674, 2356.929292121222, 2435.7442468540726, 9570.712878613653, 9636.518174091267, 9979.950100249525, 10218.233632477593, 10484.79030419395, 1807.9096045197687, 1926.2198809482181, 1927.3254360973547, 1931.758530183727, 1963.6465436221474, 52623.73688131535, 53139.468605313836, 56949.71525142348, 60727.0, 61534.38465615376, 11107.333559986426, 11108.111351092055, 11122.44387780624, 11139.16456265767, 11139.331640101458, 14557.490487832874, 14584.781228281585, 14619.634509137144, 14638.487652932095, 14699.26503674812, 8270.627821748036, 8299.460535065202, 8321.0, 8328.417010809186, 8374.078851326349, 7783.221677832172, 7880.763577092696, 7921.801954951057, 7925.128235894047, 7928.0, 4461.910761784746, 4591.931121033121, 4631.444226692818, 4810.687305325143, 4920.5571498565305, 1995.2418081129078, 2031.1672214392029, 2033.2172113736317, 2039.4799326172028, 2067.576146889884, 1018.7453136715822, 1019.9133073688671, 1023.6417253961203, 1099.6591056772265, 1158.1082566423806, 15536.689266214613, 16911.830881691272, 16931.661366772594, 17585.472435826945, 17645.647087058187, 1037.8443233515034, 1064.6167379743285, 1078.1374900079904, 1082.0748260237542, 1090.9727256818644, 9924.950375248078, 10130.442825644514, 10148.746281342877, 10165.13596344319, 10187.592496300213, 398114.0, 400394.0, 400442.0, 545476.0, 549010.0, 77988.05029874298, 79736.0, 79967.0, 81165.59417202877, 81370.77943830847, 1185.5139392849062, 1195.4142470189718, 1196.4316949449117, 1218.421249906305, 1222.9816552751715, 15754.606134846263, 15832.525024249291, 15968.28142733603, 16034.35862565531, 16129.354825806837, 32158.678413216505, 34316.48525272073, 34467.655323446445, 34610.82694586511, 37401.0, 41458.79270603628, 41678.0, 42114.57885421229, 43307.13385732331, 45190.548094518635, 7653.540787552764, 7747.612619369122, 7797.337226335825, 7819.100803407681, 7930.841383172189, 11568.537258509901, 11642.301461912313, 11814.291142531476, 11843.940780296389, 12259.38703064861, 10031.799364012824, 10295.845562316721, 10453.529591168568, 10664.842080028619, 10806.189535785004, 10743.570257189625, 11111.499982500645, 11132.944335278271, 11312.264702794291, 11360.602378916697, 10800.891991080303, 11056.0, 11061.723456913642, 11167.832482512606, 11269.323840569265, 7737.342325902361, 7910.5649189295145, 7915.802104947423, 7949.165337639464, 8007.15924827908, 10685.946570267099, 10978.505967231653, 11066.944665276944, 11160.330380177214, 11258.887411125785], "unit": "score", "name": "jquery.html", "value": 8680.17022571319}, {"lowerIsBetter": false, "replicates": [1525.687234117006, 1547.14133655821, 1796.811334809845, 1881.2851116575716, 1910.560571068654, 7916.445848790587, 7931.6034198290145, 8089.271965523117, 8122.431429799916, 8126.024877014759, 8230.547319897403, 8283.08886022537, 8331.541765202926, 8398.034226064005, 8400.53797041164, 2447.5104979004227, 2455.2756936703627, 2458.43456005118, 2475.8638274894874, 2476.368526025861, 2450.2894160693377, 2497.3382053755768, 2498.113169824713, 2499.1377974598736, 2502.2868482482495, 2243.5849367866917, 2303.7235531736133, 2323.488832456865, 2404.0744313439277, 2423.9151629692965, 2432.74456182101, 2442.560339138954, 2447.9755202447927, 2459.7786199242155, 2467.679201703767, 2468.062136388179, 2468.7654672806234, 2495.1641200197955, 2495.2763698527406, 2499.687539057618, 8263.421560490768, 8284.585770711501, 8358.414910956235, 8384.119667434954, 8400.41197116202, 4954.504549545053, 5120.871978200575, 5125.384953805567, 5132.358455193101, 5158.484151584849, 3115.610548681415, 3171.57183780189, 3204.439223135965, 3213.0521496158453, 3226.4998925166637, 1014.5028935821394, 1014.5028935821468, 1023.8413045977885, 1062.8193207154802, 1074.049466222391, 11572.76854462906, 11609.07127429812, 11623.186376953616, 11635.825462618152, 11656.067514598812, 4453.599176074169, 4511.796969136397, 4546.795394207269, 4565.657575681771, 4567.840125595588, 9395.389299695498, 9430.481323527134, 9457.810843783085, 9459.574319155654, 9489.288303377274, 5165.483451654804, 5189.351331083614, 5196.142636464941, 5201.063808514428, 5206.505381988705, 4654.4414670239785, 4675.859724208279, 4737.549932756383, 4738.668293219511, 4759.333693282943, 3715.405535114369, 3734.477173195755, 3745.7377983541437, 3749.643783840531, 3760.2667479841716, 1104.6520346090956, 1110.2783190925963, 1115.3308015190821, 1122.0, 1128.1087940526893, 1411.8094057302133, 1433.677422579932, 1434.2971943747489, 1437.985620143806, 1473.4106357457104, 7613.5431874087735, 7634.427417943676, 7664.271894170045, 7735.033120859893, 7759.107702614158, 1211.3700875544666, 1217.5190799634095, 1229.6003798765437, 1236.1470585296297, 1242.310517662706, 5924.644521328734, 6037.305709843425, 6049.939500605025, 6099.115628233882, 6144.78493252734, 9818.754531136636, 10116.140128089195, 10123.898761012442, 10177.134943529734, 10269.537870795832, 9798.069183427562, 9937.205023598095, 10029.04724051214, 10067.748306292402, 10075.496225188857, 7710.76627739559, 7820.374370050382, 7837.1770964047955, 7857.4499785014505, 7868.173841746763, 7428.777136685908, 7472.327490525661, 7507.62461876893, 7525.322720954921, 7526.962365188139, 8806.735797926072, 8853.867191991996, 8924.152205540464, 8980.955095224483, 9075.2286055686, 8730.083341249077, 9002.279817614444, 9229.307801914749, 9279.304052195977, 9410.576524056298, 7721.961390193013, 7868.370530357443, 7878.881816772868, 7882.605869706377, 7897.091834439113, 7678.425922685724, 7794.025746781653, 7867.606619669108, 7882.408819338687, 7885.053793544811, 7398.815029624087, 7401.59291238987, 7425.405967522694, 7433.516821406592, 7464.290892365217, 7320.341169294789, 7401.259874012771, 7431.962840185981, 7478.214787447239, 7508.549487030796, 7114.537555058904, 7202.71189152428, 7252.673629686571, 7301.963490182515, 7306.378957788647, 6785.355391237825, 6812.420944219797, 6826.214985276558, 6845.0, 6850.246472887879, 6648.9002664961035, 6778.2205046420295, 6840.3501667341525, 6852.6231057292325, 6871.690773915286], "unit": "score", "name": "mootools.html", "value": 4796.292702235859}, {"lowerIsBetter": false, "replicates": [363.7072156913687, 365.3916229477919, 365.9762115462495, 369.2448941913786, 370.5553335996803, 6264.715733274679, 6311.873762524752, 6334.271558770743, 6417.422431981121, 6554.6067235965875, 6316.368363163681, 6335.398137176972, 6344.619322840633, 6351.0, 6384.425401713845, 4805.495422980589, 4818.951810481903, 4876.4148302203785, 4884.145274576953, 4898.779554920019, 4860.270959356089, 4901.583365413944, 4918.483559226283, 4919.704817710949, 4926.211806111023, 4704.670673052888, 4723.07899959508, 4786.401699787527, 4809.158397280462, 4883.072216278913, 4814.325994360793, 4815.518448155191, 4842.733649649268, 4842.927356089662, 4843.443004054544, 4209.284421648327, 4224.66202703783, 4227.217964676544, 4230.51349094855, 4242.957570424318, 5913.940860591425, 5924.2298501195, 5925.970370148165, 5934.258217722785, 5946.137810017566, 5485.890282194334, 5614.466625670555, 5678.630888992202, 5679.971600141973, 5690.857728556819, 6736.494762892754, 6752.155980502437, 6779.796606101825, 6786.219584747768, 6786.524943253974, 4729.243321068647, 4738.976305118486, 4741.8103275868925, 4744.928826067612, 4747.477777444478, 6911.723531058751, 6984.965075174642, 7058.400035996895, 7071.964640176818, 7078.398336141434, 4779.928301075487, 4790.5448982346625, 4816.446108697474, 4827.879303017453, 4834.927476087862, 4867.0, 4867.975660121677, 4893.535114164149, 4896.779644915988, 4904.60763138948, 5627.606067575312, 5664.405237450009, 5669.773209071674, 5669.886602268014, 5689.146628005832, 6647.169103862017, 6753.561018533779, 6754.358335958076, 6777.661116944133, 6778.356056174655, 1701.4810482802864, 1733.0, 1735.5747841778593, 1736.7047601907707, 1739.6955532781712, 1149.080735411684, 1154.3766366162347, 1157.0280963990288, 1163.1567113842395, 1181.5864447443325, 6442.903356449657, 6484.416402523795, 6527.988161834924, 6530.216374035146, 6555.0, 6964.4080253179045, 7026.402755765817, 7030.050943122716, 7032.964835175791, 7035.753748618774, 6382.776602818879, 6521.706523206467, 6522.608643481311, 6571.80284591463, 6576.80269591913, 3769.1142581493327, 3819.560750513671, 3820.331441997695, 3823.6941044716914, 3827.234553089393, 7188.0, 7255.45584081196, 7255.854882902312, 7258.419326453871, 7277.126744790659, 7101.857962840714, 7204.9279507204255, 7245.384142347854, 7249.673764680602, 7262.20115787263, 7193.856122877618, 7242.13094428672, 7258.818529536698, 7284.781456556312, 7288.052553168054, 6957.026016357613, 7062.788116356517, 7063.293670632896, 7067.858642827217, 7069.82325441868, 6813.727450901908, 6917.0, 6958.269381715049, 6960.512764106464, 6964.860702786017, 7256.455765817479, 7275.672594733144, 7280.089988751406, 7281.526700764433, 7289.8177545559665, 4854.053459575349, 4854.466008739107, 4875.68308059975, 4893.461719210813, 4897.41231052276, 6915.101036865175, 7074.04500392461, 7079.68141433647, 7082.362587367162, 7114.324139206767, 6840.897386539106, 6853.657317134023, 6890.896636550356, 6897.206821215424, 6910.7581234658555, 6738.191417029988, 6795.72817087311, 6803.0, 6859.794206173823, 6867.07294515234, 6726.8654626908165, 6756.087928129639, 6763.458923286224, 6826.624535650587, 6828.453723701992, 6867.141607299088, 6934.375906168469, 6936.514443988873, 6940.813643702218, 6940.895886561605, 6613.074169616354, 6739.932600674127, 6754.3921047106, 6758.797236082925, 6773.085633439423], "unit": "score", "name": "prototype.html", "value": 5129.209093378241}, {"lowerIsBetter": false, "replicates": [798.3652995868284, 808.6361137488132, 853.3855623950753, 891.4933761942318, 914.693577651487, 14595.708085838276, 14831.55505334839, 14838.85161148391, 14843.109413435188, 14859.331330090145, 13560.796588051187, 13636.181829090237, 13677.0, 13720.58838234852, 13721.93139034306, 879.1120967822513, 880.5201165364875, 882.1575395497284, 888.6845169964666, 893.2273583350387, 901.711452335253, 913.9177474027337, 915.7573243090586, 918.481058202117, 919.5907821019615, 849.7748096754365, 850.7575341027808, 850.9234168924795, 855.4610595324967, 858.9785255368603, 838.8448137094626, 849.3290300662469, 849.4181485682296, 849.5964416901984, 850.6980022092192, 624.8594066335083, 626.7524327890503, 627.5795217204438, 628.7045088808253, 629.7134803664321, 14968.0, 14980.475683351031, 15008.174550399724, 15009.549713508612, 15043.548693539102, 13191.802122968164, 13247.801282980763, 13281.468741250339, 13329.266890321029, 13364.532241371506, 11290.266132701348, 11460.255083419552, 11525.48135333912, 11529.711757206052, 11759.412029398582, 3921.509811273591, 3950.1902110067367, 3981.402789581557, 3994.560598334181, 4041.0, 51231.0, 52271.73864130693, 52330.476695232945, 53486.46513534854, 53586.46413535854, 10983.505742241618, 10999.560017599206, 11019.393933333744, 11065.612703555336, 11210.66368008961, 18735.531611709815, 18805.62388752217, 18856.52858678544, 18917.62164756697, 18959.810401895804, 7664.386849052063, 7880.0, 7896.763097107096, 8042.115367309591, 8105.6757729691335, 4376.715513491613, 4535.024969631545, 4551.385562949025, 4599.05719327537, 4655.790489427984, 3007.263220510945, 3035.4991426414394, 3037.665856755755, 3040.4831178699674, 3056.312329725794, 580.494969376645, 582.1820342418908, 584.6316820403118, 588.4644973074481, 590.4243362721398, 649.4122818848855, 665.6339013542629, 668.5320275806955, 702.9350533941083, 758.7989182866545, 9717.222622190207, 9846.95076524627, 10075.647352342632, 10223.335483193718, 10587.311824731369, 615.5414216408805, 704.968276427562, 729.9306466168366, 771.5794891783992, 780.4770803561628, 4426.734395936254, 4430.490493593278, 4433.091216300651, 4441.977790111029, 4499.775011249424, 55919.440805591425, 56191.71904140535, 56651.43348566462, 57016.71491642515, 62658.68670656617, 51740.74129629328, 51751.22373164406, 52404.73797630987, 52978.470215298126, 53442.73278633659, 46369.0, 46373.07253854904, 46872.5312746875, 48718.26922596164, 49620.0, 8891.866622000805, 9234.815303694022, 9333.953330233306, 9687.0, 9721.270904682036, 34844.477332839524, 35407.468887966184, 36042.0, 37616.81191594025, 37623.623763762014, 47496.287555687384, 47560.286595701786, 47631.52368476409, 47906.76046619745, 47995.0, 11766.823497647714, 11958.0, 12032.75934481323, 12144.0, 12159.513619455123, 13505.32473376347, 13696.383662735001, 13977.161370317814, 14147.717045658823, 14295.785563216352, 12467.563635272722, 12993.415296311878, 13012.154209976321, 13098.083134180515, 13182.143160694524, 11867.0, 11980.760384792082, 12634.2419454833, 12796.0, 13154.934225329194, 11920.642380728592, 12337.50649973991, 12502.374881255719, 12594.748105038032, 12701.42843572023, 10471.0, 10595.576176953144, 10703.0, 10992.340459572451, 11475.368854713071, 10514.737131571772, 11063.502142403771, 11188.608398706006, 11356.432178391213, 11444.828327574927], "unit": "score", "name": "yui.html", "value": 6784.6253614062925}], "name": "dromaeo_css", "value": 7287.19495754795}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 107.0, 110.0, 112.0, 113.0, 123.0, 111.0, 112.0, 113.0, 110.0], "unit": "score", "name": "ai-astar", "value": 112.4}, {"lowerIsBetter": true, "replicates": [154.0, 125.0, 148.0, 172.0, 128.0, 146.0, 153.0, 128.0, 165.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 144.4}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 165.0, 162.0, 162.0, 161.0, 164.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.3}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 150.0, 76.0, 76.0, 75.0, 77.0, 161.0, 74.0], "unit": "score", "name": "audio-fft", "value": 90.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 139.0, 95.0, 96.0, 95.0, 140.0, 95.0, 95.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 147.0, 149.0, 147.0, 146.0, 146.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [99.0, 96.0, 96.0, 101.0, 96.0, 98.0, 97.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 97.2}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 59.0, 55.0, 58.0, 55.0, 58.0, 56.0, 53.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 64.0, 64.0, 65.0, 69.0, 64.0, 64.0, 65.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.2}, {"lowerIsBetter": true, "replicates": [79.0, 80.0, 79.0, 80.0, 80.0, 79.0, 82.0, 81.0, 80.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.9}, {"lowerIsBetter": true, "replicates": [118.0, 113.0, 113.0, 114.0, 113.0, 111.0, 119.0, 112.0, 115.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.2}, {"lowerIsBetter": true, "replicates": [139.0, 142.0, 139.0, 137.0, 144.0, 139.0, 137.0, 138.0, 141.0, 127.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.3}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 64.0, 67.0, 65.0, 71.0, 63.0, 67.0, 67.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.6}], "name": "kraken", "value": 1491.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.55562958027983], "unit": "score", "name": "Richards", "value": 211.95320800000005}, {"lowerIsBetter": false, "replicates": [170.41581458759373], "unit": "score", "name": "DeltaBlue", "value": 387.9804240000001}, {"lowerIsBetter": false, "replicates": [278.9400278940028], "unit": "score", "name": "Encrypt", "value": 954.2588850000001}, {"lowerIsBetter": false, "replicates": [5213.541666666667], "unit": "score", "name": "Decrypt", "value": 51.05569630369634}, {"lowerIsBetter": false, "replicates": [912.4087591240876], "unit": "score", "name": "RayTrace", "value": 811.0279440000002}, {"lowerIsBetter": false, "replicates": [599.880023995201], "unit": "score", "name": "Earley", "value": 1110.9938210000003}, {"lowerIsBetter": false, "replicates": [11188.888888888889], "unit": "score", "name": "Boyer", "value": 59.56471698113206}, {"lowerIsBetter": false, "replicates": [38923.07692307692], "unit": "score", "name": "RegExp", "value": 23.404752964426894}, {"lowerIsBetter": false, "replicates": [528.2620179609086], "unit": "score", "name": "Splay", "value": 154.26246300000008}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21878.856476521058}]} 11:01:14 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "21878.86"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1491.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7287.19"}}} 11:01:14 INFO - Return code: 0 11:01:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:01:14 INFO - # TBPL SUCCESS # 11:01:14 INFO - Running post-action listener: _resource_record_post_action 11:01:14 INFO - Running post-run listener: _resource_record_post_run 11:01:15 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 502059008; Read time: 12; Write time: 364548 11:01:15 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 208760832; Read time: 0; Write time: 204388 11:01:15 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 4096; Write bytes: 259747840; Read time: 12; Write time: 149256 11:01:15 INFO - Running post-run listener: _upload_blobber_files 11:01:15 INFO - Blob upload gear active. 11:01:15 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:01:15 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:01:15 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', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 11:01:15 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 Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 11:01:16 INFO - (blobuploader) - INFO - Open directory for files ... 11:01:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:01:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:01:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:01:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:01:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:01:16 INFO - (blobuploader) - INFO - Done attempting. 11:01:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:01:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:01:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:01:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:01:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:01:18 INFO - (blobuploader) - INFO - Done attempting. 11:01:18 INFO - (blobuploader) - INFO - Iteration through files over. 11:01:18 INFO - Return code: 0 11:01:18 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:01:18 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:01:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ccf70377d4148eb1ae5b740fa9263cc57546c745da564a34bfdf634798e28d0f5310fcf26f715dda3c4ac2eb4afbc4164a94c9913bc06c218ae11f4397e77d29", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d47a2d26af2a7761c5ddba67bff3c9f34a30fadf2e62381f15027fe88a9c00adc66f7a2c3892c76243fe36d61f2839051cc82775877b19bafcca78b68a57db9d"} 11:01:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:01:18 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:01:18 INFO - Contents: 11:01:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ccf70377d4148eb1ae5b740fa9263cc57546c745da564a34bfdf634798e28d0f5310fcf26f715dda3c4ac2eb4afbc4164a94c9913bc06c218ae11f4397e77d29", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d47a2d26af2a7761c5ddba67bff3c9f34a30fadf2e62381f15027fe88a9c00adc66f7a2c3892c76243fe36d61f2839051cc82775877b19bafcca78b68a57db9d"} 11:01:18 INFO - Running post-run listener: copy_logs_to_upload_dir 11:01:18 INFO - Copying logs to upload dir... 11:01:18 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 11:01:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.026448 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-02-26 11:01:16.945366) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 11:01:16.949104) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180 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/Mozilla-Aurora/sha512/ccf70377d4148eb1ae5b740fa9263cc57546c745da564a34bfdf634798e28d0f5310fcf26f715dda3c4ac2eb4afbc4164a94c9913bc06c218ae11f4397e77d29", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d47a2d26af2a7761c5ddba67bff3c9f34a30fadf2e62381f15027fe88a9c00adc66f7a2c3892c76243fe36d61f2839051cc82775877b19bafcca78b68a57db9d"} build_url:https://queue.taskcluster.net/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011397 build_url: 'https://queue.taskcluster.net/v1/task/SQiiOzquSEGsXEEOayp6ug/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ccf70377d4148eb1ae5b740fa9263cc57546c745da564a34bfdf634798e28d0f5310fcf26f715dda3c4ac2eb4afbc4164a94c9913bc06c218ae11f4397e77d29", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d47a2d26af2a7761c5ddba67bff3c9f34a30fadf2e62381f15027fe88a9c00adc66f7a2c3892c76243fe36d61f2839051cc82775877b19bafcca78b68a57db9d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 11:01:16.977980) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 11:01:16.978768) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1456512011.538231-1712395180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 11:01:17.059905) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 11:01:17.060618) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 11:01:17.061286) ========= ========= Total master_lag: 0.25 =========