builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1454479640.35 results: success (0) buildid: 20160202192940 builduid: 8723079d68654dfea5b6915ba774e72d revision: 52d03258c7446174ae3f47d1ab9d687acdb4eee3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-02 22:07:20.345497) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-02 22:07:20.345978) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-02 22:07:20.346291) ========= 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=03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006451 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-02 22:07:20.397938) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-02 22:07:20.398334) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-02 22:07:20.421754) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 22:07:20.422054) ========= 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=03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004623 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 22:07:20.470764) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-02 22:07:20.471068) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-02 22:07:20.471439) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 22:07:20.471737) ========= 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=03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-02 22:07:20-- 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% 83.9M=0s 2016-02-02 22:07:20 (83.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171707 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 22:07:20.656277) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 22:07:20.656648) ========= 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=03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018107 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 22:07:20.706379) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 22:07:20.706728) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 52d03258c7446174ae3f47d1ab9d687acdb4eee3 --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 52d03258c7446174ae3f47d1ab9d687acdb4eee3 --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=03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-02 22:07:20,916 truncating revision to first 12 chars 2016-02-02 22:07:20,916 Setting DEBUG logging. 2016-02-02 22:07:20,916 attempt 1/10 2016-02-02 22:07:20,917 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/52d03258c744?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-02 22:07:21,167 unpacking tar archive at: mozilla-aurora-52d03258c744/testing/mozharness/ program finished with exit code 0 elapsedTime=0.524723 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 22:07:21.354427) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-02 22:07:21.354819) ========= echo 52d03258c7446174ae3f47d1ab9d687acdb4eee3 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'52d03258c7446174ae3f47d1ab9d687acdb4eee3'] 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=03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 52d03258c7446174ae3f47d1ab9d687acdb4eee3 program finished with exit code 0 elapsedTime=0.004704 script_repo_revision: '52d03258c7446174ae3f47d1ab9d687acdb4eee3' ========= master_lag: 0.02 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-02 22:07:21.376645) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-02 22:07:21.376987) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-02 22:07:21.445345) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-02-02 22:07:21.445636) ========= /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=03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:07:21 INFO - MultiFileLogger online at 20160202 22:07:21 in /builds/slave/test-pgo 22:07:21 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 22:07:21 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:07:21 INFO - {'append_to_log': False, 22:07:21 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:07:21 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 22:07:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:07:21 INFO - 'branch': 'Mozilla-Aurora', 22:07:21 INFO - 'buildbot_json_path': 'buildprops.json', 22:07:21 INFO - 'config_files': ('talos/linux_config.py',), 22:07:21 INFO - 'default_actions': ('clobber', 22:07:21 INFO - 'read-buildbot-config', 22:07:21 INFO - 'download-and-extract', 22:07:21 INFO - 'populate-webroot', 22:07:21 INFO - 'create-virtualenv', 22:07:21 INFO - 'install', 22:07:21 INFO - 'run-tests'), 22:07:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:07:21 INFO - 'download_minidump_stackwalk': True, 22:07:21 INFO - 'download_symbols': 'ondemand', 22:07:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:07:21 INFO - 'tooltool.py': '/tools/tooltool.py', 22:07:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:07:21 INFO - '/tools/misc-python/virtualenv.py')}, 22:07:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:07:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:07:21 INFO - 'installer_path': 'installer.exe', 22:07:21 INFO - 'log_level': 'info', 22:07:21 INFO - 'log_name': 'talos', 22:07:21 INFO - 'log_to_console': True, 22:07:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:07:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:07:21 INFO - 'opt_config_files': (), 22:07:21 INFO - 'pip_index': False, 22:07:21 INFO - 'sps_profile': False, 22:07:21 INFO - 'sps_profile_interval': 0, 22:07:21 INFO - 'suite': 'dromaeojs-e10s', 22:07:21 INFO - 'system_bits': '32', 22:07:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:07:21 INFO - 'title': 'talos-linux64-ix-047', 22:07:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:07:21 INFO - 'use_talos_json': True, 22:07:21 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:07:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:07:21 INFO - 'work_dir': 'build'} 22:07:21 INFO - ##### 22:07:21 INFO - ##### Running clobber step. 22:07:21 INFO - ##### 22:07:21 INFO - Running pre-action listener: _resource_record_pre_action 22:07:21 INFO - Running main action method: clobber 22:07:21 INFO - rmtree: /builds/slave/test-pgo/build 22:07:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:07:22 INFO - Running post-action listener: _resource_record_post_action 22:07:22 INFO - ##### 22:07:22 INFO - ##### Running read-buildbot-config step. 22:07:22 INFO - ##### 22:07:22 INFO - Running pre-action listener: _resource_record_pre_action 22:07:22 INFO - Running main action method: read_buildbot_config 22:07:22 INFO - Using buildbot properties: 22:07:22 INFO - { 22:07:22 INFO - "project": "", 22:07:22 INFO - "product": "firefox", 22:07:22 INFO - "script_repo_revision": "production", 22:07:22 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 22:07:22 INFO - "repository": "", 22:07:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 22:07:22 INFO - "buildid": "20160202192940", 22:07:22 INFO - "pgo_build": "True", 22:07:22 INFO - "basedir": "/builds/slave/test-pgo", 22:07:22 INFO - "buildnumber": 36, 22:07:22 INFO - "slavename": "talos-linux64-ix-047", 22:07:22 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:07:22 INFO - "platform": "ubuntu64_hw", 22:07:22 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 22:07:22 INFO - "branch": "mozilla-aurora", 22:07:22 INFO - "repo_path": "releases/mozilla-aurora", 22:07:22 INFO - "revision": "52d03258c7446174ae3f47d1ab9d687acdb4eee3", 22:07:22 INFO - "stage_platform": "linux64-pgo", 22:07:22 INFO - "builduid": "8723079d68654dfea5b6915ba774e72d", 22:07:22 INFO - "slavebuilddir": "test" 22:07:22 INFO - } 22:07:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/A9JWdZQ1SUGWD188G2NSIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 22:07:22 INFO - Running post-action listener: _resource_record_post_action 22:07:22 INFO - ##### 22:07:22 INFO - ##### Running download-and-extract step. 22:07:22 INFO - ##### 22:07:22 INFO - Running pre-action listener: _resource_record_pre_action 22:07:22 INFO - Running main action method: download_and_extract 22:07:22 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:07: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')]} 22:07:22 INFO - https://queue.taskcluster.net/v1/task/A9JWdZQ1SUGWD188G2NSIQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:07:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9JWdZQ1SUGWD188G2NSIQ/artifacts/public/build/test_packages.json 22:07:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9JWdZQ1SUGWD188G2NSIQ/artifacts/public/build/test_packages.json 22:07:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9JWdZQ1SUGWD188G2NSIQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:07:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9JWdZQ1SUGWD188G2NSIQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:07:31 INFO - Downloaded 1448 bytes. 22:07:31 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:07:31 INFO - Using the following test package requirements: 22:07:31 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 22:07:31 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 22:07:31 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 22:07:31 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 22:07:31 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 22:07:31 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 22:07:31 INFO - u'jsshell-linux-x86_64.zip'], 22:07:31 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 22:07:31 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 22:07:31 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 22:07:31 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 22:07:31 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 22:07:31 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 22:07:31 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 22:07:31 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 22:07:31 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 22:07:31 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 22:07:31 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 22:07:31 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 22:07:31 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:07:31 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')]} 22:07:31 INFO - https://queue.taskcluster.net/v1/task/A9JWdZQ1SUGWD188G2NSIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:07:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9JWdZQ1SUGWD188G2NSIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 22:07:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9JWdZQ1SUGWD188G2NSIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 22:07:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9JWdZQ1SUGWD188G2NSIQ/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 22:07:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9JWdZQ1SUGWD188G2NSIQ/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 22:07:33 INFO - Downloaded 22398916 bytes. 22:07:33 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'] 22:07:33 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 22:07:34 INFO - Return code: 0 22:07:34 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 22:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:34 INFO - https://queue.taskcluster.net/v1/task/A9JWdZQ1SUGWD188G2NSIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:07:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9JWdZQ1SUGWD188G2NSIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 22:07:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9JWdZQ1SUGWD188G2NSIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 22:07:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9JWdZQ1SUGWD188G2NSIQ/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 22:07:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9JWdZQ1SUGWD188G2NSIQ/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 22:07:44 INFO - Downloaded 22398916 bytes. 22:07:44 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'] 22:07:44 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 22:07:45 INFO - Return code: 0 22:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:45 INFO - https://queue.taskcluster.net/v1/task/A9JWdZQ1SUGWD188G2NSIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:07:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9JWdZQ1SUGWD188G2NSIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 22:07:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9JWdZQ1SUGWD188G2NSIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 22:07:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9JWdZQ1SUGWD188G2NSIQ/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 22:07:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9JWdZQ1SUGWD188G2NSIQ/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 22:07:47 INFO - Downloaded 10706572 bytes. 22:07:47 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'] 22:07:47 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 22:07:47 INFO - Return code: 0 22:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:47 INFO - https://queue.taskcluster.net/v1/task/A9JWdZQ1SUGWD188G2NSIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:07:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9JWdZQ1SUGWD188G2NSIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 22:07:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9JWdZQ1SUGWD188G2NSIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 22:07:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9JWdZQ1SUGWD188G2NSIQ/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 22:07:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9JWdZQ1SUGWD188G2NSIQ/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 22:07:49 INFO - Downloaded 59582930 bytes. 22:07:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A9JWdZQ1SUGWD188G2NSIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 22:07:49 INFO - mkdir: /builds/slave/test-pgo/properties 22:07:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:07:49 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:07:49 INFO - Contents: 22:07:49 INFO - build_url:https://queue.taskcluster.net/v1/task/A9JWdZQ1SUGWD188G2NSIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 22:07:49 INFO - Running post-action listener: _resource_record_post_action 22:07:49 INFO - Running post-action listener: set_extra_try_arguments 22:07:49 INFO - ##### 22:07:49 INFO - ##### Running populate-webroot step. 22:07:49 INFO - ##### 22:07:49 INFO - Running pre-action listener: _resource_record_pre_action 22:07:49 INFO - Running main action method: populate_webroot 22:07:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:07:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:07:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:07:49 INFO - '--tppagecycles', 22:07:49 INFO - '7'], 22:07:49 INFO - 'tests': ['tsvgm']}}, 22:07:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:07:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:07:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:07:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:07:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:07:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:07:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:07:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:49 INFO - 'talos_options': ['--e10s'], 22:07:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:07:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:49 INFO - 'tests': ['damp', 'tps']}, 22:07:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:49 INFO - 'talos_options': ['--e10s'], 22:07:49 INFO - 'tests': ['damp', 'tps']}, 22:07:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:07:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:07:49 INFO - 'other': {'tests': ['a11yr', 22:07:49 INFO - 'ts_paint', 22:07:49 INFO - 'tpaint', 22:07:49 INFO - 'sessionrestore', 22:07:49 INFO - 'sessionrestore_no_auto_restore']}, 22:07:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:07:49 INFO - 'tests': ['a11yr', 22:07:49 INFO - 'ts_paint', 22:07:49 INFO - 'tpaint', 22:07:49 INFO - 'sessionrestore', 22:07:49 INFO - 'sessionrestore_no_auto_restore']}, 22:07:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:07:49 INFO - 'tests': ['a11yr', 22:07:49 INFO - 'ts_paint', 22:07:49 INFO - 'tpaint', 22:07:49 INFO - 'sessionrestore', 22:07:49 INFO - 'sessionrestore_no_auto_restore']}, 22:07:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:07:49 INFO - 'tests': ['a11yr', 22:07:49 INFO - 'ts_paint', 22:07:49 INFO - 'tpaint', 22:07:49 INFO - 'sessionrestore', 22:07:49 INFO - 'sessionrestore_no_auto_restore']}, 22:07:49 INFO - 'other_l64': {'tests': ['a11yr', 22:07:49 INFO - 'ts_paint', 22:07:49 INFO - 'tpaint', 22:07:49 INFO - 'sessionrestore', 22:07:49 INFO - 'sessionrestore_no_auto_restore']}, 22:07:49 INFO - 'other_nol64': {'tests': ['a11yr', 22:07:49 INFO - 'ts_paint', 22:07:49 INFO - 'tpaint', 22:07:49 INFO - 'sessionrestore', 22:07:49 INFO - 'sessionrestore_no_auto_restore']}, 22:07:49 INFO - 'svgr': {'tests': ['tsvgx', 22:07:49 INFO - 'tsvgr_opacity', 22:07:49 INFO - 'tart', 22:07:49 INFO - 'tscrollx', 22:07:49 INFO - 'cart']}, 22:07:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:07:49 INFO - 'tests': ['tsvgx', 22:07:49 INFO - 'tsvgr_opacity', 22:07:49 INFO - 'tart', 22:07:49 INFO - 'tscrollx', 22:07:49 INFO - 'cart']}, 22:07:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:49 INFO - 'tests': ['tp5o']}, 22:07:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:49 INFO - 'talos_options': ['--e10s'], 22:07:49 INFO - 'tests': ['tp5o']}, 22:07:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:49 INFO - 'talos_options': ['--xperf_path', 22:07:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:07:49 INFO - 'tests': ['tp5n']}, 22:07:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:49 INFO - 'talos_options': ['--e10s', 22:07:49 INFO - '--xperf_path', 22:07:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:07:49 INFO - 'tests': ['tp5n']}}, 22:07:49 INFO - 'talos.zip': {'path': '', 22:07:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:07:49 INFO - Running post-action listener: _resource_record_post_action 22:07:49 INFO - ##### 22:07:49 INFO - ##### Running create-virtualenv step. 22:07:49 INFO - ##### 22:07:49 INFO - Running pre-action listener: _resource_record_pre_action 22:07:49 INFO - Running main action method: create_virtualenv 22:07:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:07:49 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 22:07:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:07:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:07:49 INFO - Using real prefix '/usr' 22:07:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:07:49 INFO - Installing distribute.............................................................................................................................................................................................done. 22:07:51 INFO - Installing pip.................done. 22:07:51 INFO - Return code: 0 22:07:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:51 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 0x7f02381e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1238660>, '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 0x1239560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1239a10>, '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': '03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896', '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 22:07:51 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 22:07:51 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 22:07:51 INFO - Using env: {'DISPLAY': ':0', 22:07:51 INFO - 'HOME': '/home/cltbld', 22:07:51 INFO - 'LANG': 'en_US.UTF-8', 22:07:51 INFO - 'LANGUAGE': 'en_US:en', 22:07:51 INFO - 'LOGNAME': 'cltbld', 22:07:51 INFO - 'MAIL': '/var/mail/cltbld', 22:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:51 INFO - 'MOZ_NO_REMOTE': '1', 22:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:51 INFO - 'NO_EM_RESTART': '1', 22:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:51 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:51 INFO - 'SHELL': '/bin/bash', 22:07:51 INFO - 'SHLVL': '1', 22:07:51 INFO - 'TERM': 'linux', 22:07:51 INFO - 'TMOUT': '86400', 22:07:51 INFO - 'USER': 'cltbld', 22:07:51 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896', 22:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:51 INFO - '_': '/tools/buildbot/bin/python'} 22:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:52 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 22:07:52 INFO - Cleaning up... 22:07:52 INFO - Return code: 0 22:07:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:07:52 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')]} 22:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:52 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')]} 22:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:52 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 0x7f02381e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1238660>, '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 0x1239560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1239a10>, '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': '03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896', '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 22:07:52 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 22:07:52 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 22:07:52 INFO - Using env: {'DISPLAY': ':0', 22:07:52 INFO - 'HOME': '/home/cltbld', 22:07:52 INFO - 'LANG': 'en_US.UTF-8', 22:07:52 INFO - 'LANGUAGE': 'en_US:en', 22:07:52 INFO - 'LOGNAME': 'cltbld', 22:07:52 INFO - 'MAIL': '/var/mail/cltbld', 22:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:52 INFO - 'MOZ_NO_REMOTE': '1', 22:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:52 INFO - 'NO_EM_RESTART': '1', 22:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:52 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:52 INFO - 'SHELL': '/bin/bash', 22:07:52 INFO - 'SHLVL': '1', 22:07:52 INFO - 'TERM': 'linux', 22:07:52 INFO - 'TMOUT': '86400', 22:07:52 INFO - 'USER': 'cltbld', 22:07:52 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896', 22:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:52 INFO - '_': '/tools/buildbot/bin/python'} 22:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:52 INFO - Downloading/unpacking psutil>=0.7.1 22:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:07:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:07:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:07:54 INFO - Installing collected packages: psutil 22:07:54 INFO - Running setup.py install for psutil 22:07:54 INFO - building 'psutil._psutil_linux' extension 22:07:54 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 22:07:54 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 22:07:54 INFO - building 'psutil._psutil_posix' extension 22:07:54 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 22:07:54 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 22:07:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:07:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:07:54 INFO - Successfully installed psutil 22:07:54 INFO - Cleaning up... 22:07:54 INFO - Return code: 0 22:07:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:54 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 0x7f02381e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1238660>, '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 0x1239560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1239a10>, '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': '03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896', '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 22:07:54 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 22:07:54 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 22:07:54 INFO - Using env: {'DISPLAY': ':0', 22:07:54 INFO - 'HOME': '/home/cltbld', 22:07:54 INFO - 'LANG': 'en_US.UTF-8', 22:07:54 INFO - 'LANGUAGE': 'en_US:en', 22:07:54 INFO - 'LOGNAME': 'cltbld', 22:07:54 INFO - 'MAIL': '/var/mail/cltbld', 22:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:54 INFO - 'MOZ_NO_REMOTE': '1', 22:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:54 INFO - 'NO_EM_RESTART': '1', 22:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:54 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:54 INFO - 'SHELL': '/bin/bash', 22:07:54 INFO - 'SHLVL': '1', 22:07:54 INFO - 'TERM': 'linux', 22:07:54 INFO - 'TMOUT': '86400', 22:07:54 INFO - 'USER': 'cltbld', 22:07:54 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896', 22:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:54 INFO - '_': '/tools/buildbot/bin/python'} 22:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:07:54 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 22:07:54 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 22:07:54 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 22:07:54 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 22:07:54 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 22:07:54 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 22:07:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:07:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:07:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:07:56 INFO - Installing collected packages: mozsystemmonitor 22:07:56 INFO - Running setup.py install for mozsystemmonitor 22:07:56 INFO - Successfully installed mozsystemmonitor 22:07:56 INFO - Cleaning up... 22:07:56 INFO - Return code: 0 22:07:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:07:56 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')]} 22:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:56 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')]} 22:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:56 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 0x7f02381e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1238660>, '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 0x1239560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1239a10>, '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': '03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896', '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 22:07:56 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 22:07:56 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 22:07:56 INFO - Using env: {'DISPLAY': ':0', 22:07:56 INFO - 'HOME': '/home/cltbld', 22:07:56 INFO - 'LANG': 'en_US.UTF-8', 22:07:56 INFO - 'LANGUAGE': 'en_US:en', 22:07:56 INFO - 'LOGNAME': 'cltbld', 22:07:56 INFO - 'MAIL': '/var/mail/cltbld', 22:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:56 INFO - 'MOZ_NO_REMOTE': '1', 22:07:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:56 INFO - 'NO_EM_RESTART': '1', 22:07:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:07:56 INFO - 'PWD': '/builds/slave/test-pgo', 22:07:56 INFO - 'SHELL': '/bin/bash', 22:07:56 INFO - 'SHLVL': '1', 22:07:56 INFO - 'TERM': 'linux', 22:07:56 INFO - 'TMOUT': '86400', 22:07:56 INFO - 'USER': 'cltbld', 22:07:56 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896', 22:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:56 INFO - '_': '/tools/buildbot/bin/python'} 22:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:57 INFO - Downloading/unpacking blobuploader==1.2.4 22:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:58 INFO - Downloading blobuploader-1.2.4.tar.gz 22:07:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:07:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:07:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:59 INFO - Downloading docopt-0.6.1.tar.gz 22:07:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:07:59 INFO - Installing collected packages: blobuploader, requests, docopt 22:07:59 INFO - Running setup.py install for blobuploader 22:07:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:07:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:07:59 INFO - Running setup.py install for requests 22:08:00 INFO - Running setup.py install for docopt 22:08:00 INFO - Successfully installed blobuploader requests docopt 22:08:00 INFO - Cleaning up... 22:08:00 INFO - Return code: 0 22:08:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:08:00 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')]} 22:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:00 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')]} 22:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:00 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 0x7f02381e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1238660>, '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 0x1239560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1239a10>, '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': '03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896', '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 22:08:00 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 22:08:00 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 22:08:00 INFO - Using env: {'DISPLAY': ':0', 22:08:00 INFO - 'HOME': '/home/cltbld', 22:08:00 INFO - 'LANG': 'en_US.UTF-8', 22:08:00 INFO - 'LANGUAGE': 'en_US:en', 22:08:00 INFO - 'LOGNAME': 'cltbld', 22:08:00 INFO - 'MAIL': '/var/mail/cltbld', 22:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:00 INFO - 'MOZ_NO_REMOTE': '1', 22:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:00 INFO - 'NO_EM_RESTART': '1', 22:08:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:08:00 INFO - 'PWD': '/builds/slave/test-pgo', 22:08:00 INFO - 'SHELL': '/bin/bash', 22:08:00 INFO - 'SHLVL': '1', 22:08:00 INFO - 'TERM': 'linux', 22:08:00 INFO - 'TMOUT': '86400', 22:08:00 INFO - 'USER': 'cltbld', 22:08:00 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896', 22:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:00 INFO - '_': '/tools/buildbot/bin/python'} 22:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:08:00 INFO - Running setup.py (path:/tmp/pip-lRg1y6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:08:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:08:00 INFO - Running setup.py (path:/tmp/pip-qqsZrD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:08:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:08:00 INFO - Running setup.py (path:/tmp/pip-5Sseyd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:08:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:08:00 INFO - Running setup.py (path:/tmp/pip-O5SeeD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:08:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:08:00 INFO - Running setup.py (path:/tmp/pip-rWb1w4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:08:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:08:00 INFO - Running setup.py (path:/tmp/pip-pn_4fA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:08:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:08:00 INFO - Running setup.py (path:/tmp/pip-_C22EC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:08:01 INFO - Running setup.py (path:/tmp/pip-RnbdCU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:08:01 INFO - Running setup.py (path:/tmp/pip-sww02O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:08:01 INFO - Running setup.py (path:/tmp/pip-GYXMWF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:08:01 INFO - Running setup.py (path:/tmp/pip-qdXEj9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:08:01 INFO - Running setup.py (path:/tmp/pip-BpovuW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:08:01 INFO - Running setup.py (path:/tmp/pip-jP0Od0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:08:01 INFO - Running setup.py (path:/tmp/pip-zBG9C3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:08:01 INFO - Running setup.py (path:/tmp/pip-peMwCY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:08:01 INFO - Running setup.py (path:/tmp/pip-5SVGgh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:08:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:08:01 INFO - Running setup.py (path:/tmp/pip-RPbH5H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:08:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:08:01 INFO - Running setup.py install for manifestparser 22:08:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:08:01 INFO - Running setup.py install for mozcrash 22:08:01 INFO - Running setup.py install for mozdebug 22:08:02 INFO - Running setup.py install for mozdevice 22:08:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:08:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:08:02 INFO - Running setup.py install for mozfile 22:08:02 INFO - Running setup.py install for mozhttpd 22:08:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:08:02 INFO - Running setup.py install for mozinfo 22:08:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:08:02 INFO - Running setup.py install for mozInstall 22:08:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:08:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:08:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:08:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:08:02 INFO - Running setup.py install for mozleak 22:08:02 INFO - Running setup.py install for mozlog 22:08:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:08:02 INFO - Running setup.py install for moznetwork 22:08:02 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:08:02 INFO - Running setup.py install for mozprocess 22:08:02 INFO - Running setup.py install for mozprofile 22:08:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:08:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:08:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:08:03 INFO - Running setup.py install for mozrunner 22:08:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:08:03 INFO - Running setup.py install for mozscreenshot 22:08:03 INFO - Running setup.py install for moztest 22:08:03 INFO - Running setup.py install for mozversion 22:08:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:08:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:08:03 INFO - Cleaning up... 22:08:03 INFO - Return code: 0 22:08:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:08:03 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')]} 22:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:03 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')]} 22:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:03 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 0x7f02381e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1238660>, '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 0x1239560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1239a10>, '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': '03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896', '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 22:08:03 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 22:08:03 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 22:08:03 INFO - Using env: {'DISPLAY': ':0', 22:08:03 INFO - 'HOME': '/home/cltbld', 22:08:03 INFO - 'LANG': 'en_US.UTF-8', 22:08:03 INFO - 'LANGUAGE': 'en_US:en', 22:08:03 INFO - 'LOGNAME': 'cltbld', 22:08:03 INFO - 'MAIL': '/var/mail/cltbld', 22:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:03 INFO - 'MOZ_NO_REMOTE': '1', 22:08:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:03 INFO - 'NO_EM_RESTART': '1', 22:08:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:08:03 INFO - 'PWD': '/builds/slave/test-pgo', 22:08:03 INFO - 'SHELL': '/bin/bash', 22:08:03 INFO - 'SHLVL': '1', 22:08:03 INFO - 'TERM': 'linux', 22:08:03 INFO - 'TMOUT': '86400', 22:08:03 INFO - 'USER': 'cltbld', 22:08:03 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896', 22:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:03 INFO - '_': '/tools/buildbot/bin/python'} 22:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:08:03 INFO - Running setup.py (path:/tmp/pip-hltG8V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:08:03 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)) 22:08:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:08:03 INFO - Running setup.py (path:/tmp/pip-qNCZry-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:08:03 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)) 22:08:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:08:03 INFO - Running setup.py (path:/tmp/pip-Er2b3g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:08:03 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)) 22:08:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:08:03 INFO - Running setup.py (path:/tmp/pip-Nxe4Tj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:08:04 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)) 22:08:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:08:04 INFO - Running setup.py (path:/tmp/pip-ljp6vL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:08:04 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)) 22:08:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:08:04 INFO - Running setup.py (path:/tmp/pip-n1QcqS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:08:04 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)) 22:08:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:08:04 INFO - Running setup.py (path:/tmp/pip-8I3Ali-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:08:04 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)) 22:08:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:08:04 INFO - Running setup.py (path:/tmp/pip-x4cQhm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:08:04 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)) 22:08:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:08:04 INFO - Running setup.py (path:/tmp/pip-wspa3w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:08:04 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)) 22:08:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:08:04 INFO - Running setup.py (path:/tmp/pip-6AxnUN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:08:04 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)) 22:08:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:08:04 INFO - Running setup.py (path:/tmp/pip-h0eM1r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:08:04 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)) 22:08:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:08:04 INFO - Running setup.py (path:/tmp/pip-ZstIDi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:08:04 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)) 22:08:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:08:04 INFO - Running setup.py (path:/tmp/pip-v5Q_Jx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:08:04 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)) 22:08:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:08:04 INFO - Running setup.py (path:/tmp/pip-TLpjLA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:08:04 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)) 22:08:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:08:04 INFO - Running setup.py (path:/tmp/pip-25Ol2M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:08:04 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)) 22:08:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:08:04 INFO - Running setup.py (path:/tmp/pip-hTN9AO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:08:04 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)) 22:08:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:08:04 INFO - Running setup.py (path:/tmp/pip-e4yFSj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:08:04 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)) 22:08:04 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)) 22:08:04 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)) 22:08:04 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)) 22:08:04 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)) 22:08:04 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)) 22:08:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:08:04 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 22:08:04 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 22:08:04 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 22:08:04 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 22:08:04 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 22:08:04 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 22:08:06 INFO - Downloading blessings-1.6.tar.gz 22:08:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:08:06 INFO - Installing collected packages: blessings 22:08:06 INFO - Running setup.py install for blessings 22:08:06 INFO - Successfully installed blessings 22:08:06 INFO - Cleaning up... 22:08:06 INFO - Return code: 0 22:08:06 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:08:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:08:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:08:07 INFO - Reading from file tmpfile_stdout 22:08:07 INFO - Current package versions: 22:08:07 INFO - argparse == 1.2.1 22:08:07 INFO - blessings == 1.6 22:08:07 INFO - blobuploader == 1.2.4 22:08:07 INFO - docopt == 0.6.1 22:08:07 INFO - manifestparser == 1.1 22:08:07 INFO - mozInstall == 1.12 22:08:07 INFO - mozcrash == 0.16 22:08:07 INFO - mozdebug == 0.1 22:08:07 INFO - mozdevice == 0.48 22:08:07 INFO - mozfile == 1.2 22:08:07 INFO - mozhttpd == 0.7 22:08:07 INFO - mozinfo == 0.9 22:08:07 INFO - mozleak == 0.1 22:08:07 INFO - mozlog == 3.1 22:08:07 INFO - moznetwork == 0.27 22:08:07 INFO - mozprocess == 0.22 22:08:07 INFO - mozprofile == 0.28 22:08:07 INFO - mozrunner == 6.11 22:08:07 INFO - mozscreenshot == 0.1 22:08:07 INFO - mozsystemmonitor == 0.0 22:08:07 INFO - moztest == 0.7 22:08:07 INFO - mozversion == 1.4 22:08:07 INFO - psutil == 3.1.1 22:08:07 INFO - requests == 1.2.3 22:08:07 INFO - wsgiref == 0.1.2 22:08:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:07 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 0x7f02381e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1238660>, '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 0x1239560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1239a10>, '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': '03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896', '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 22:08:07 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 22:08:07 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 22:08:07 INFO - Using env: {'DISPLAY': ':0', 22:08:07 INFO - 'HOME': '/home/cltbld', 22:08:07 INFO - 'LANG': 'en_US.UTF-8', 22:08:07 INFO - 'LANGUAGE': 'en_US:en', 22:08:07 INFO - 'LOGNAME': 'cltbld', 22:08:07 INFO - 'MAIL': '/var/mail/cltbld', 22:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:07 INFO - 'MOZ_NO_REMOTE': '1', 22:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:07 INFO - 'NO_EM_RESTART': '1', 22:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:08:07 INFO - 'PWD': '/builds/slave/test-pgo', 22:08:07 INFO - 'SHELL': '/bin/bash', 22:08:07 INFO - 'SHLVL': '1', 22:08:07 INFO - 'TERM': 'linux', 22:08:07 INFO - 'TMOUT': '86400', 22:08:07 INFO - 'USER': 'cltbld', 22:08:07 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896', 22:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:07 INFO - '_': '/tools/buildbot/bin/python'} 22:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:07 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)) 22:08:07 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)) 22:08:07 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)) 22:08:07 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)) 22:08:07 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)) 22:08:07 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)) 22:08:07 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)) 22:08:07 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)) 22:08:07 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)) 22:08:07 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)) 22:08:07 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)) 22:08:07 INFO - Cleaning up... 22:08:07 INFO - Return code: 0 22:08:07 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:07 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 0x7f02381e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1238660>, '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 0x1239560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1239a10>, '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': '03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896', '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 22:08:07 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 22:08:07 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 22:08:07 INFO - Using env: {'DISPLAY': ':0', 22:08:07 INFO - 'HOME': '/home/cltbld', 22:08:07 INFO - 'LANG': 'en_US.UTF-8', 22:08:07 INFO - 'LANGUAGE': 'en_US:en', 22:08:07 INFO - 'LOGNAME': 'cltbld', 22:08:07 INFO - 'MAIL': '/var/mail/cltbld', 22:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:07 INFO - 'MOZ_NO_REMOTE': '1', 22:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:07 INFO - 'NO_EM_RESTART': '1', 22:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:08:07 INFO - 'PWD': '/builds/slave/test-pgo', 22:08:07 INFO - 'SHELL': '/bin/bash', 22:08:07 INFO - 'SHLVL': '1', 22:08:07 INFO - 'TERM': 'linux', 22:08:07 INFO - 'TMOUT': '86400', 22:08:07 INFO - 'USER': 'cltbld', 22:08:07 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896', 22:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:07 INFO - '_': '/tools/buildbot/bin/python'} 22:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:07 INFO - Downloading/unpacking jsonschema 22:08:07 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 22:08:07 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 22:08:07 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 22:08:07 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 22:08:07 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 22:08:07 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 22:08:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:08:09 INFO - Downloading/unpacking functools32 (from jsonschema) 22:08:09 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 22:08:09 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 22:08:09 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 22:08:09 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 22:08:09 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 22:08:09 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 22:08:09 INFO - Downloading functools32-3.2.3-2.tar.gz 22:08:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:08:09 INFO - warning: no files found matching '*.txt' 22:08:09 INFO - no previously-included directories found matching 'build' 22:08:09 INFO - no previously-included directories found matching 'dist' 22:08:09 INFO - no previously-included directories found matching '.git*' 22:08:09 INFO - Installing collected packages: jsonschema, functools32 22:08:09 INFO - Running setup.py install for functools32 22:08:09 INFO - warning: no files found matching '*.txt' 22:08:09 INFO - no previously-included directories found matching 'build' 22:08:09 INFO - no previously-included directories found matching 'dist' 22:08:09 INFO - no previously-included directories found matching '.git*' 22:08:09 INFO - Successfully installed jsonschema functools32 22:08:09 INFO - Cleaning up... 22:08:09 INFO - Return code: 0 22:08:09 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:08:09 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')]} 22:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:09 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')]} 22:08:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:09 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 0x7f02381e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1238660>, '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 0x1239560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1239a10>, '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': '03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896', '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 22:08:09 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 22:08:09 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 22:08:09 INFO - Using env: {'DISPLAY': ':0', 22:08:09 INFO - 'HOME': '/home/cltbld', 22:08:09 INFO - 'LANG': 'en_US.UTF-8', 22:08:09 INFO - 'LANGUAGE': 'en_US:en', 22:08:09 INFO - 'LOGNAME': 'cltbld', 22:08:09 INFO - 'MAIL': '/var/mail/cltbld', 22:08:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:09 INFO - 'MOZ_NO_REMOTE': '1', 22:08:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:09 INFO - 'NO_EM_RESTART': '1', 22:08:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:08:09 INFO - 'PWD': '/builds/slave/test-pgo', 22:08:09 INFO - 'SHELL': '/bin/bash', 22:08:09 INFO - 'SHLVL': '1', 22:08:09 INFO - 'TERM': 'linux', 22:08:09 INFO - 'TMOUT': '86400', 22:08:09 INFO - 'USER': 'cltbld', 22:08:09 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896', 22:08:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:09 INFO - '_': '/tools/buildbot/bin/python'} 22:08:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:10 INFO - Downloading/unpacking flake8 22:08:10 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 22:08:10 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 22:08:10 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 22:08:10 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 22:08:10 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 22:08:10 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 22:08:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:08:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:08:11 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 22:08:11 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 22:08:11 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 22:08:11 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 22:08:11 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 22:08:11 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 22:08:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:08:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:08:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:08:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:08:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:08:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:08:12 INFO - no previously-included directories found matching 'docs/_build' 22:08:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:08:12 INFO - Running setup.py install for pep8 22:08:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:08:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:08:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:08:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:08:12 INFO - no previously-included directories found matching 'docs/_build' 22:08:12 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:08:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:08:12 INFO - Cleaning up... 22:08:12 INFO - Return code: 0 22:08:12 INFO - Running post-action listener: _resource_record_post_action 22:08:12 INFO - Running post-action listener: _start_resource_monitoring 22:08:12 INFO - Starting resource monitoring. 22:08:12 INFO - ##### 22:08:12 INFO - ##### Running install step. 22:08:12 INFO - ##### 22:08:12 INFO - Running pre-action listener: _resource_record_pre_action 22:08:12 INFO - Running main action method: install 22:08:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:08:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:08:13 INFO - Reading from file tmpfile_stdout 22:08:13 INFO - Detecting whether we're running mozinstall >=1.0... 22:08:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:08:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:08:13 INFO - Reading from file tmpfile_stdout 22:08:13 INFO - Output received: 22:08:13 INFO - Usage: mozinstall [options] installer 22:08:13 INFO - Options: 22:08:13 INFO - -h, --help show this help message and exit 22:08:13 INFO - -d DEST, --destination=DEST 22:08:13 INFO - Directory to install application into. [default: 22:08:13 INFO - "/builds/slave/test-pgo"] 22:08:13 INFO - --app=APP Application being installed. [default: firefox] 22:08:13 INFO - mkdir: /builds/slave/test-pgo/build/application 22:08:13 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'] 22:08:13 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 22:08:28 INFO - Reading from file tmpfile_stdout 22:08:28 INFO - Output received: 22:08:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:08:28 INFO - Running post-action listener: _resource_record_post_action 22:08:28 INFO - ##### 22:08:28 INFO - ##### Running run-tests step. 22:08:28 INFO - ##### 22:08:28 INFO - Running pre-action listener: _resource_record_pre_action 22:08:28 INFO - Running main action method: run_tests 22:08:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:08:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:08:28 INFO - Python 2.7.3 22:08:28 INFO - Return code: 0 22:08:28 INFO - grabbing minidump binary from tooltool 22:08:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:08:28 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 0x1238660>, '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 0x1239560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1239a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:08:28 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 22:08:28 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 22:08:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:08:28 INFO - Return code: 0 22:08:28 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:08:28 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:08:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:08:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:08:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:08:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:08:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:08:29 INFO - Return code: 0 22:08:29 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/A9JWdZQ1SUGWD188G2NSIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 22:08:29 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/A9JWdZQ1SUGWD188G2NSIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 22:08:29 INFO - Using env: {'DISPLAY': ':0', 22:08:29 INFO - 'HOME': '/home/cltbld', 22:08:29 INFO - 'LANG': 'en_US.UTF-8', 22:08:29 INFO - 'LANGUAGE': 'en_US:en', 22:08:29 INFO - 'LOGNAME': 'cltbld', 22:08:29 INFO - 'MAIL': '/var/mail/cltbld', 22:08:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:08:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:29 INFO - 'MOZ_NO_REMOTE': '1', 22:08:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:29 INFO - 'NO_EM_RESTART': '1', 22:08:29 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:08:29 INFO - 'PWD': '/builds/slave/test-pgo', 22:08:29 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:08:29 INFO - 'SHELL': '/bin/bash', 22:08:29 INFO - 'SHLVL': '1', 22:08:29 INFO - 'TERM': 'linux', 22:08:29 INFO - 'TMOUT': '86400', 22:08:29 INFO - 'USER': 'cltbld', 22:08:29 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896', 22:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:29 INFO - '_': '/tools/buildbot/bin/python'} 22:08:29 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/A9JWdZQ1SUGWD188G2NSIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 22:08:29 INFO - mozversion application_buildid: 20160202192940 22:08:29 INFO - mozversion application_changeset: 52d03258c7446174ae3f47d1ab9d687acdb4eee3 22:08:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 22:08:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:08:29 INFO - mozversion application_name: Firefox 22:08:29 INFO - mozversion application_remotingname: firefox-dev 22:08:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:08:29 INFO - mozversion application_vendor: Mozilla 22:08:29 INFO - mozversion application_version: 46.0a2 22:08:29 INFO - mozversion platform_buildid: 20160202192940 22:08:29 INFO - mozversion platform_changeset: 52d03258c7446174ae3f47d1ab9d687acdb4eee3 22:08:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:08:29 INFO - mozversion platform_version: 46.0a2 22:08:29 INFO - using testdate: 1454479709 22:08:29 INFO - actual date: 1454479709 22:08:29 INFO - starting webserver on 'localhost:47304' 22:08:29 INFO - SUITE-START | Running 3 tests 22:08:29 INFO - TEST-START | dromaeo_css 22:08:29 INFO - operating with platform_type : linux_ 22:08:29 INFO - Initialising browser for dromaeo_css test... 22:08:29 INFO - TEST-INFO | started process 13357 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgzmiDo/profile http://localhost:47304/getInfo.html) 22:08:33 INFO - PROCESS | 13357 | 22:08:33 INFO - PROCESS | 13357 | (process:13433): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:08:34 INFO - PROCESS | 13357 | __metrics Screen width/height:1600/1200 22:08:34 INFO - PROCESS | 13357 | colorDepth:24 22:08:34 INFO - PROCESS | 13357 | Browser inner width/height: 1024/697 22:08:34 INFO - PROCESS | 13357 | __metrics 22:08:35 INFO - TEST-INFO | 13357: exit 0 22:08:35 INFO - Browser initialized. 22:08:35 INFO - Running cycle 1/1 for dromaeo_css test... 22:08:35 INFO - TEST-INFO | started process 13482 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgzmiDo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:08:36 INFO - PROCESS | 13482 | 22:08:36 INFO - PROCESS | 13482 | (process:13544): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:08:47 INFO - PROCESS | 13482 | RSS: Main: 140623872 22:08:47 INFO - PROCESS | 13482 | 22:09:36 INFO - PROCESS | 13482 | 1454479776669 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] 22:11:44 INFO - PROCESS | 13482 | Cycle 1(1): loaded http://localhost:47304/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47304/tests/dromaeo/cssquery-ext.html) 22:11:45 INFO - PROCESS | 13482 | RSS: Main: 146202624 22:11:45 INFO - PROCESS | 13482 | 22:14:47 INFO - PROCESS | 13482 | Cycle 1(1): loaded http://localhost:47304/tests/dromaeo/cssquery-ext.html (next: http://localhost:47304/tests/dromaeo/cssquery-jquery.html) 22:14:48 INFO - PROCESS | 13482 | RSS: Main: 144019456 22:14:48 INFO - PROCESS | 13482 | 22:17:49 INFO - PROCESS | 13482 | Cycle 1(1): loaded http://localhost:47304/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47304/tests/dromaeo/cssquery-mootools.html) 22:17:50 INFO - PROCESS | 13482 | RSS: Main: 142643200 22:17:50 INFO - PROCESS | 13482 | 22:20:52 INFO - PROCESS | 13482 | Cycle 1(1): loaded http://localhost:47304/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47304/tests/dromaeo/cssquery-prototype.html) 22:20:52 INFO - PROCESS | 13482 | RSS: Main: 142237696 22:20:52 INFO - PROCESS | 13482 | 22:23:55 INFO - PROCESS | 13482 | Cycle 1(1): loaded http://localhost:47304/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47304/tests/dromaeo/cssquery-yui.html) 22:23:55 INFO - PROCESS | 13482 | RSS: Main: 142716928 22:23:55 INFO - PROCESS | 13482 | 22:26:57 INFO - PROCESS | 13482 | Cycle 1(1): loaded http://localhost:47304/tests/dromaeo/cssquery-yui.html (next: http://localhost:47304/tests/dromaeo/cssquery-dojo.html) 22:26:58 INFO - PROCESS | 13482 | RSS: Main: 145756160 22:26:58 INFO - PROCESS | 13482 | 22:26:58 INFO - PROCESS | 13482 | __start_tp_report 22:26:58 INFO - PROCESS | 13482 | _x_x_mozilla_page_load 22:26:58 INFO - PROCESS | 13482 | _x_x_mozilla_page_load_details 22:26:58 INFO - PROCESS | 13482 | |i|pagename|runs| 22:26:58 INFO - PROCESS | 13482 | |0;dojo.html;3381.2561236527968;3422.2299982503923;3424.7773894696857;3443.655634436556;3453.3093381323724;5541.861453463665;5560.916586251209;5562.721863906803;5571.582131340146;5580.386157522679;5523.309586301712;5551.861203469915;5577.163425486169;5581.939431508021;5587.608867379285;5042.369703787036;5077.365329333833;5089.185730283156;5115.155999260118;5203.710367438334;4984.875378115558;5127.282180494733;5136.306598609196;5143.074246635623;5173.224016397533;5097.388313402397;5201.843944681666;5204.843854684365;5222.373315202181;5227.18978558324;5144.536991670749;5155.613329000321;5157.123289040872;5176.430592634807;5185.274061631375;4968.801247950078;5042.344495215635;5054.696718196883;5060.1903695408555;5109.3613298337705;5361.356637203521;5369.5167434931045;5384.7846086156505;5394.568434525228;5398.217258497496;5944.910826337608;5954.821355359303;5969.194158788551;5998.97000514999;6002.8499287517725;5970.04479283317;6024.909626355608;6080.422359875804;6085.726142323606;6143.846403839895;5591.30108736408;5630.971845140748;5646.57650676201;5648.548116150698;5661.745221465044;6126.540509461719;6142.477889379364;6156.445919867234;6159.969200153971;6177.227846519185;5833.562482813806;5870.647761134345;5879.911801322984;5896.675682837399;5996.370381110008;6037.426444487766;6045.909311360333;6059.72731227087;6084.330723620398;6086.2958371656005;5956.16613674086;6016.819495415145;6024.969875150684;6025.096235564701;6036.064410016366;5789.507891829157;5906.675132867647;5952.4047595241;5973.731182096816;5979.730912108966;4601.470830854428;4606.516315786794;4624.306354046853;4643.3963584733765;4649.418822647169;4136.482939632546;4148.253314403436;4158.500979882433;4168.333066709312;4184.497860256789;5653.462921022497;5674.631148975386;5747.252857128547;5747.885042299131;5750.453706897838;6077.9392206078255;6078.0882867569335;6092.116643086728;6094.268687757498;6098.573099882966;5716.342620598602;5736.110902810071;5764.855878602984;5771.30744310677;5785.450382213683;5079.796808127633;5126.769295381717;5147.176451767699;5165.61257905651;5177.016366890279;6329.7468101275435;6339.873202536016;6366.427021568081;6388.648624325707;6389.648569328731;6071.9696401518595;6127.84680382994;6129.816105516842;6132.754689812357;6141.232345956755;6166.075088736726;6189.907151392643;6283.120363149254;6284.937150628435;6369.713362898773;5955.970220148872;5988.9551227098245;6009.338972712911;6010.978133717191;6054.969725151346;6056.424639659225;6095.664738439428;6104.572679912363;6107.144999699956;6112.113743507255;5808.361080281081;5870.647761134345;5890.970545147246;5912.793052243151;5975.611585246945;5913.852153696192;5918.674472904032;5941.287045554561;5946.762129514771;5975.641461512323;5693.5445164387575;5825.475707186373;5841.4450627190345;5847.38602446737;5850.0932355484965;5829.504492118048;5884.882302353843;5948.821535353946;5951.256092988377;5978.432048955517;5808.881248819959;5818.272715910512;5827.446392592697;5851.414858514115;5866.208061911758 22:26:58 INFO - PROCESS | 13482 | |1;ext.html;557.7545879812882;560.627182923356;576.7577617400689;578.1818726502;579.2527639345245;37188.44217336739;37509.812450937774;37985;38003.80998095013;38005.23989520208;38480.422793658116;39097.21805563894;39257.60742392575;39297.41053884194;39371.803140984324;8606.397552171366;8847.42491738035;8848.159424854628;8878.42290251135;8934.86597701035;8751.299896008335;8798.208161265486;8874.112588741138;8876.911230887674;8887.95556022219;8816.162464565856;8872.512011839346;8873.290136789074;8913.1978121969;8914.732558023237;8808.163224493695;8856.601452934634;8875.28997680184;8883.20051195389;8931.910680893174;8672.436291641023;8771.780705482413;8801.163889430494;8825.602847871862;8828.249598784047;39198;39736;39786.20427591432;39807.60192398097;40026.79986600048;3379.0876463355003;3527.9294414111832;4065.512138543364;4132.028973191298;4325.891852703676;32415.83792081048;32596;32653;32774.180645484055;33956.6604333956;4342.739435633841;4346.456692913386;4357.433533640638;4362.432883725127;4443.688941774077;291380;292184;292560;292640;292982;57882.131768023515;58946.70526647339;65357.673211633635;67515.3248467509;67606;60054.69972650109;60089.39910600925;60380.39619603835;60460.09309860355;60605;15785.68428631421;15796.36814527406;15928.442504512286;15942.521724348288;15995.200239987955;11243.100551955824;11263.718407039889;11364.465797117284;11600.129990250765;11626;21975.340739777832;22308.21921232749;22347.441313966956;22367.776322236896;22484;7947.648899687067;8039.919600803917;8042.356611471068;8072.394570407243;8078.151794061657;990.5537914644699;1017.1862509991977;1037.5672611887544;1078.358376765823;1107.6732363952653;31122.377552449278;31263.84368078145;31412;31934.680653193634;32086.19784505406;1076.7684947736118;1157.6064138193055;1163.0114402757758;1206.6862615719801;1250;16187.90351170667;16267.51197464078;16436.1781910904;16486.917565412095;16524.75212871808;526806;531377;532561;534690;537159;57308;57652.71173644105;57684.71157644185;57757.13364299539;57989.710051449474;1496.865282124614;1504.247876061969;1509.8565636264536;1512.19853477657;1517.6357674158123;30987.225319367197;31761.682383176798;33057.173570659965;34505.309893802485;35094.82452587721;51056.48943510517;51301.74349128231;51355.48644513507;51747.482525174266;51998.74000630124;329093;334653;337795;338050.2389952138;338255;46817.06365872732;47210.29184562166;47487.287690683974;48089;48474.75762621305;49751.75124124356;50145.24782128198;50701;51112;51153.74423127861;42307.7884610575;42890;43338.56661433345;43579;43911.78044109759;41844.37233441562;42276;42575.7871210642;42972;43551.346729798446;42950.78524607357;43010.13979720451;43238.135237295704;43306;43712;32354.83822580872;34327.82836085804;35069.123271918404;35095;35403.82298088493;27998.44003119967;28432.57351139693;28432.715672843005;28539.857300713364;28552 22:26:58 INFO - PROCESS | 13482 | |2;jquery.html;396.646984184076;396.72824115480887;397.3602499975041;397.5090762907809;400.7295075823818;14987;15192.544223673307;16937.830621693778;17304.22131004103;17419.73870391945;16086.517404477856;17566.560835979108;17604.38384656537;17913.28346866127;17963.91018044908;5046.848594542161;5210.635255532115;5213.556847667953;5228.346456692913;5257.553107985826;5060.165072762989;5264.341957255343;5408.296921400212;5471.042567550682;5472.452754724535;5389.703566303851;5418.729063546807;5561.360443548983;5814.796482123126;5821.56338274629;5882.647041177543;5999.340072592011;6041.24484439445;6046.244219472566;6174.135621013062;5500.669959802384;5501.064818980783;5509.338879334466;5526.613137080406;5548.112302031696;13924.094933829268;15922.681546369007;16073.517794466185;21145.259915903025;21267.36197914065;2139.3902737719677;2211.845170838042;2225.6995305633695;2257.808086312665;2350.2831636350907;9957.352772069793;10036.197104231644;10116.645917392929;10183.236257280734;10270.281080324381;1890.3100368365585;1933.4103098554936;1950.288144827142;1951.414575627306;1992.3524854422371;55553.72223138899;56433;61148.38851611471;63141.368586314005;63321.68339158321;10497.10774584169;10793.29843560166;10813.67558973232;10844.403557804239;11248.662540123645;14625.0493717908;14635.341409636592;14644;14701.485448009482;14719.705605887822;7472.887906681404;7488.625568721543;7541.944127822109;7546.471746977769;7555.471117021756;6976.7209311627985;7048.753293634698;7049.8237544060785;7059.329363710439;7101.467389945671;4673.7429441381055;4785.3300537924715;4845.5881250094135;4869.9269510957365;4908.509149085063;1902.9048547572565;1936.1964784614227;1951.9414417567211;1952.3947576251408;2000.1799262302677;509.34803451582036;514.4125050993508;984.0503913723292;987.4174237200086;1094.3379255550278;10917.56329746817;17021.48935531936;18705.625887482172;18712.90643546801;18952.52618684544;1043.634727845248;1052.1057101463848;1056.0759335581367;1071.4589132488043;1118.9440527973568;10316.123129534073;10594.099501542301;10636.255462117577;10639.840402393971;10645.627403041011;600629;610116;614286;624860;630343;78767.60616196998;79582;80231.59884200658;81070.18929810745;82001.76997345044;1199.094683513959;1222.834917286155;1224.797908345131;1226.1478272600634;1230.809224570175;15258.542243732705;16081.437149699705;16320.428784992468;16328.428505002743;16495.752563711314;32830.507542386404;33092.83453582717;33972;34174;38497.23005539818;45374.54625453703;46118.53881461143;46208.53791462177;47778.522214777404;49028.754856226915;7928.048634163937;8061.314788243065;8099.797505062184;8116.83766324682;8171.83656326882;11669.88330116722;11794.705132371759;12275;12291.446884890023;12341.75316493683;10823;10940.726481838017;11026.44867756593;11029;11178.832317515082;10801.24391292602;11056.170787190831;11065.225434219848;11079.113670906469;11213.383263920236;10284.228682848667;10467.319624224401;10997.252432171117;11062.944685276521;11198.608048718255;7611.238876112345;7635.198304178203;7995.920040799518;8034.55809930436;8124.959375203086;8621.69824056155;9935.701928942144;10352;10716.089132423831;10752.569897204337 22:26:58 INFO - PROCESS | 13482 | |3;mootools.html;1571.842815718428;1590.3320605345757;1828.7439758433823;1881.5202123458516;1938.7673479182492;8276.420650554455;8368.037675667292;8368.623411946463;8472.661093556258;8670.43642163259;8388.454750441217;8410.327173826094;8436;8440;8456.06983231844;2357.116081469449;2398.580248456522;2404.326788499214;2419.661247425362;2428.4171798768257;2394.0782798622567;2453.031052734169;2497.6628155198996;2499.1253061428447;2502.5745623244;2104.4002459299104;2149.0973791007737;2356.140008896749;2430.6718592989896;2449.4121410861444;2335.9182428615004;2346.6597343385197;2348.3189874936247;2354.5173239485866;2359.00921612923;2315.733690625566;2369.869657168855;2383.749706280833;2387.164492427654;2390.067873529325;8378.581070946428;8485;8488.363372747068;8538.316934645214;8544.316454683672;4978;5105.693658380509;5111.6677415968215;5127.7948882044675;5151.974240128776;3451.861925523001;3463.913402164966;3543.2204914918675;3565.6790888819874;3583.337082639694;1132.4733998690565;1138.4990604134236;1146.3752255021034;1169.8947094761427;1192.9105317101166;11677.474513646906;11788.587399440978;11815.172937894351;11823.34971576563;11865.703357416134;4531.8187272509385;4533.206688829442;4635.3278774578175;4653.278741795028;4673.859784206479;9553.856692149624;9565.139137477661;9590.520473976274;9607;9608.423494590346;5102.897942041139;5119.8720031998755;5167.069927413102;5181.35233095863;5195.350581177353;4659.464161621389;4668.206404911173;4697.365855609517;4734.810607575727;4735.83424580138;3785.0348161218712;3804.885853424402;3809.6761775249415;3823.0824602095295;3856.7878766668105;1155.9017483513828;1156.6414411532453;1158.368689064445;1163.9941800290944;1166.650004998497;1129.2716198052374;1148.2306854407566;1165.9242149260272;1173.4895320535595;1181.7459246262094;7904.446688731734;7913.169117242606;7942.960285198537;7963.562004089715;8038.437309388287;1138.231693606812;1174.4597485156924;1188.2692144331174;1201.5434135028809;1212.5452955141823;6140.907886381708;6166.136740856284;6193.163922870445;6213.347598502182;6222.315545290015;9835.3115281931;10057.849132263022;10066.345687530433;10096.14182794456;10177.796444071226;9910.504474776233;9988.650397236062;10021.79956400868;10030.799384012278;10056.29605927578;8091.190880911861;8105.148959359182;8119.066307374727;8147.103818579952;8191.79520511992;7821.92178078212;7855.921440785519;7879.448438609243;7942.483738556975;8075.676972921017;9152;9184.540772961458;9248.121428464285;9376.156145946898;9426.811463770824;9312.534373281444;9435.622575097193;9456.432614043179;9649.13157815772;9715.854262185932;7700.922990770021;7759.961200193963;7782.49413788102;7813;7829.373650108091;7745.419093567893;7950.7217247396065;7966.880496792669;7979.561124137996;7990.121086680577;7500.174980752004;7508.774736757906;7573.394128469819;7663.808404789702;7675.961620192087;7316.707331706672;7446.292602202782;7473.51422157558;7524.05949256343;7528.849423011399;7447.925520744723;7477.364424023801;7491.850162996819;7518.173000969779;7537.434692397982;6943.270956549692;6953.1656201254145;6977.965110174417;7016.22821489646;7019.052427922165;6788.490863185182;7077.079979602619;7131.286871313035;7138.321859423347;7165.856682866209 22:26:58 INFO - PROCESS | 13482 | |4;prototype.html;380.05935310107503;380.3097378258461;381.10630571310287;386.5110635046665;388.6909906624234;6265.749370025199;6283.246010478738;6285.748570057198;6379;6424.293327733945;6208.348123447041;6317.652529110897;6369.936300636992;6380.106785050085;6383.0744542041375;4864.586510146624;4897.8775530611665;4937.950620493803;4940.975295123538;4964.925526117111;4947.307376967227;4952.3561936948145;4954.628402869781;4961.677490963094;4963.776630051639;4690.616268200872;4823.541763532477;4832.420109586837;4840.394950631171;4870.439899411577;4781.593564547018;4801.61587073035;4835.274708793674;4838.177509823338;4839.7096174229655;4256.978715106436;4261.552536983603;4262.701610887239;4271.273883439822;4285.3786201000685;5876.676782776945;5958.880822383571;5973;5988;6013.188219590343;5663.377028526858;5686.3744988051285;5689.715514224314;5693.77224911003;5694.487496125369;6653.068570400148;6670.899936500957;6671.2995135510555;6677.699503522354;6703.826830304677;4736.455307639631;4737.407824021997;4738.241881298975;4746.074515469485;4747.52524747526;6928.376446119823;7021.82445438863;7089.929100708979;7102.005719199316;7104.6447677615915;4846.75766211688;4852.975735121372;4857.80568777252;4861.854144375674;4863.416390033219;4914.90170196594;4918.262260660929;4925.87685307863;4931.926021109686;4941.530554597308;5477.616566840283;5642.210090587321;5655.688937108499;5674.092145256739;5683.204351390808;6762.289959554274;6803.829904252433;6851.07510486088;6852.074969879102;6872.518923675295;1702.838230368113;1731.1430841733422;1738.721804511272;1740.8346207110305;1746.4847869878417;1167.737259116692;1181.2794195540714;1185.0874826383636;1201.3212534917743;1206.831043653889;6419.2296924369375;6446.645434501147;6450.129232553639;6460.741570337133;6465.15952926126;6855.691493882788;6867.690953907087;6870.862582748317;6898.586084834826;6910.7581234656545;6331.271903731038;6355.523335749745;6415;6440.452561532322;6442.871142577123;3719.237556300952;3726.06848287928;3748.775073495599;3751.5123034005405;3761.153740408441;7179.282071792779;7202.4238060954995;7214.639268036577;7226.241244669339;7246.166690830517;6949.339812717783;7025.297470252934;7027.5080744348425;7077.893831592531;7099.935009748579;7196.712131514785;7207.13514378278;7215.422766178693;7223.819404514824;7233.204347521663;6867.931320686729;6874.896876546756;6896.7586134485055;6900.068490753684;6907.102076729993;6639.933600664125;6767.932320676927;6776.6950487227205;6817.386435220854;6838.179418469816;7186;7209.0628218331285;7220.169680486812;7235.842265237537;7252.093488313961;4875.853724388274;4876.536729010738;4884.096442158212;4887.706737595756;4896.632752543503;6704.4301234395625;6879.105716256855;6889.517733758789;6896.206936202401;6990.23107458169;6790.185177778698;6804.4896632753735;6826;6853.93763966586;6862.828429289308;6779.864402712017;6809.489288303298;6836.316368363124;6842.7605033823575;6867.07294515254;6607.669616519251;6730.32696730323;6737.393634572912;6745.25802161752;6757.932420675927;6849.178098627997;6878.209005964378;6882.8967565485555;6883.862322753617;6890.035395044598;6677.165354330708;6680.83297917556;6705.765298214539;6712.295209002984;6714.160729908762 22:26:58 INFO - PROCESS | 13482 | |5;yui.html;900.3292547052445;911.4030310146857;912.9771755706106;916.9403988740736;932.1750251027838;14834.10995340279;15138.167400792952;15144.167070811101;16920;17043.57391065221;15157.393704251845;15263.847361526381;15344.923275383635;15392.153431561259;15522.767158492632;868.5049521772593;873.1399571422144;876.6493402638963;886.685226744506;892.1970226795871;885.026470882031;885.313881741649;887.7913690282811;892.7723430525207;893.8703887936246;925.1904583489446;927.7402327348319;927.9396839205464;929.4841363043508;929.8093890752414;918.2332752151962;920.4753290624346;922.0963455813273;925.3615005646117;929.2380248196414;684.7603338831419;684.7740245718901;687.7524091327168;689.0938415982966;690.858374033327;15022.699546009128;15060.171690557125;15062.096274223582;15079.849201507954;15083;13732.107413018222;13800.447982080705;13844.93077534616;13846.376913038837;13995.370208340548;10988.615398461096;11079.72300692489;11080.944595277053;11240.662780116609;11303.434828258554;3748.850045998157;3772.3021241070214;3791.563970143441;3830.195658911632;3838.098046958962;52895;53306.20040699393;53497.1975420369;53875.191872121555;53948;10731.678049658523;10803.83794243087;10877.292975956538;11256.380899050631;11492.425378731197;19097.331593394163;19102.808971910104;19269.61460770805;19283.807161928482;19321;7948.503213593761;8052.557109358924;8160.469569477965;8226.712065077812;8273.46222495548;4381.627561657231;4388.736675799462;4407.757573333497;4497.9325310120375;4647.512011238771;3401.3027329397414;3401.9659803402146;3416.8974930752115;3432.4508078707286;3446.5174875517446;618.6420806330062;620.7796232337546;625.337142628815;638.4636904999822;651.6285717141184;557.8075563930438;576.3803910795912;648.4602780954037;700.6811900585324;718.9496735228588;8130.878036829452;8506.040174881233;8518.574071296534;8520.488770673779;8724.43291186071;552.0235080747068;576.4034224577542;608.4128815692877;724.2974314914525;779.3570304498811;4374.868753937387;4510.8421205257655;4524.7511386873375;4630.58324750774;4636.436276468252;63384.04923926145;63729.36270637234;64174.35825641777;64192;64254.357456424834;55520;55661.721691391285;57173.42826571681;57495;57527.424725753044;49701.50298496969;50510;50591.747041264556;50850.237246441335;51223.48776512262;9131.543422828965;9292.814143717223;9363.892511873019;9373.625054997723;9403.623855045995;35616;35686.821565892;35830.64169358377;36366.63633363633;36389.81805090958;45118.548814511436;49205.26192107193;49477.75261123671;49854.750726247585;50124;11179;11419.885801142214;11454.828177577176;11556.47995840206;11643.243189192675;11505.597304094317;11624.07007439386;11640.650780476599;11795.882041179822;11879;11979.940100299791;12283.877161228631;12362.320072396105;12769.936150319189;14063.507777227747;12392.256464612152;12574.937125314314;12754.48982040745;12913.741725165632;13137.948964083042;12872.292023938773;13011.804822927854;13049.34753262314;13215.15947020271;13875.236861972688;9900.257480688833;9920.305578609428;9976.20190384753;10294.794104118026;10372.481375931324;10592.89407105919;11004.834927476255;11058;11193;11318.490667920129 22:26:58 INFO - PROCESS | 13482 | __end_tp_report 22:26:58 INFO - PROCESS | 13482 | __start_cc_report 22:26:58 INFO - PROCESS | 13482 | _x_x_mozilla_cycle_collect,296 22:26:58 INFO - PROCESS | 13482 | __end_cc_report 22:26:58 INFO - PROCESS | 13482 | __startTimestamp1454480818046__endTimestamp 22:26:58 INFO - PROCESS | 13482 | 22:26:58 INFO - PROCESS | 13482 | ------- Summary: start ------- 22:26:58 INFO - PROCESS | 13482 | Number of tests: 6 22:26:58 INFO - PROCESS | 13482 | 22:26:58 INFO - PROCESS | 13482 | [#0] dojo.html Cycles:165 Average:5605.67 Median:5829.50 stddev:625.15 (10.7%) stddev-sans-first:602.22 22:26:58 INFO - PROCESS | 13482 | Values: 3381.3 3422.2 3424.8 3443.7 3453.3 5541.9 5560.9 5562.7 5571.6 5580.4 5523.3 5551.9 5577.2 5581.9 5587.6 5042.4 5077.4 5089.2 5115.2 5203.7 4984.9 5127.3 5136.3 5143.1 5173.2 5097.4 5201.8 5204.8 5222.4 5227.2 5144.5 5155.6 5157.1 5176.4 5185.3 4968.8 5042.3 5054.7 5060.2 5109.4 5361.4 5369.5 5384.8 5394.6 5398.2 5944.9 5954.8 5969.2 5999.0 6002.8 5970.0 6024.9 6080.4 6085.7 6143.8 5591.3 5631.0 5646.6 5648.5 5661.7 6126.5 6142.5 6156.4 6160.0 6177.2 5833.6 5870.6 5879.9 5896.7 5996.4 6037.4 6045.9 6059.7 6084.3 6086.3 5956.2 6016.8 6025.0 6025.1 6036.1 5789.5 5906.7 5952.4 5973.7 5979.7 4601.5 4606.5 4624.3 4643.4 4649.4 4136.5 4148.3 4158.5 4168.3 4184.5 5653.5 5674.6 5747.3 5747.9 5750.5 6077.9 6078.1 6092.1 6094.3 6098.6 5716.3 5736.1 5764.9 5771.3 5785.5 5079.8 5126.8 5147.2 5165.6 5177.0 6329.7 6339.9 6366.4 6388.6 6389.6 6072.0 6127.8 6129.8 6132.8 6141.2 6166.1 6189.9 6283.1 6284.9 6369.7 5956.0 5989.0 6009.3 6011.0 6055.0 6056.4 6095.7 6104.6 6107.1 6112.1 5808.4 5870.6 5891.0 5912.8 5975.6 5913.9 5918.7 5941.3 5946.8 5975.6 5693.5 5825.5 5841.4 5847.4 5850.1 5829.5 5884.9 5948.8 5951.3 5978.4 5808.9 5818.3 5827.4 5851.4 5866.2 22:26:58 INFO - PROCESS | 13482 | 22:26:58 INFO - PROCESS | 13482 | [#1] ext.html Cycles:180 Average:56343.01 Median:42441.79 stddev:106069.63 (249.9%) stddev-sans-first:106284.48 22:26:58 INFO - PROCESS | 13482 | Values: 557.8 560.6 576.8 578.2 579.3 37188.4 37509.8 37985.0 38003.8 38005.2 38480.4 39097.2 39257.6 39297.4 39371.8 8606.4 8847.4 8848.2 8878.4 8934.9 8751.3 8798.2 8874.1 8876.9 8888.0 8816.2 8872.5 8873.3 8913.2 8914.7 8808.2 8856.6 8875.3 8883.2 8931.9 8672.4 8771.8 8801.2 8825.6 8828.2 39198.0 39736.0 39786.2 39807.6 40026.8 3379.1 3527.9 4065.5 4132.0 4325.9 32415.8 32596.0 32653.0 32774.2 33956.7 4342.7 4346.5 4357.4 4362.4 4443.7 291380.0 292184.0 292560.0 292640.0 292982.0 57882.1 58946.7 65357.7 67515.3 67606.0 60054.7 60089.4 60380.4 60460.1 60605.0 15785.7 15796.4 15928.4 15942.5 15995.2 11243.1 11263.7 11364.5 11600.1 11626.0 21975.3 22308.2 22347.4 22367.8 22484.0 7947.6 8039.9 8042.4 8072.4 8078.2 990.6 1017.2 1037.6 1078.4 1107.7 31122.4 31263.8 31412.0 31934.7 32086.2 1076.8 1157.6 1163.0 1206.7 1250.0 16187.9 16267.5 16436.2 16486.9 16524.8 526806.0 531377.0 532561.0 534690.0 537159.0 57308.0 57652.7 57684.7 57757.1 57989.7 1496.9 1504.2 1509.9 1512.2 1517.6 30987.2 31761.7 33057.2 34505.3 35094.8 51056.5 51301.7 51355.5 51747.5 51998.7 329093.0 334653.0 337795.0 338050.2 338255.0 46817.1 47210.3 47487.3 48089.0 48474.8 49751.8 50145.2 50701.0 51112.0 51153.7 42307.8 42890.0 43338.6 43579.0 43911.8 41844.4 42276.0 42575.8 42972.0 43551.3 42950.8 43010.1 43238.1 43306.0 43712.0 32354.8 34327.8 35069.1 35095.0 35403.8 27998.4 28432.6 28432.7 28539.9 28552.0 22:26:58 INFO - PROCESS | 13482 | 22:26:58 INFO - PROCESS | 13482 | [#2] jquery.html Cycles:180 Average:30443.34 Median:2241.75 stddev:100660.00 (4490.2%) stddev-sans-first:100917.09 22:26:58 INFO - PROCESS | 13482 | Values: 396.6 396.7 397.4 397.5 400.7 14987.0 15192.5 16937.8 17304.2 17419.7 16086.5 17566.6 17604.4 17913.3 17963.9 5046.8 5210.6 5213.6 5228.3 5257.6 5060.2 5264.3 5408.3 5471.0 5472.5 5389.7 5418.7 5561.4 5814.8 5821.6 5882.6 5999.3 6041.2 6046.2 6174.1 5500.7 5501.1 5509.3 5526.6 5548.1 13924.1 15922.7 16073.5 21145.3 21267.4 2139.4 2211.8 2225.7 2257.8 2350.3 9957.4 10036.2 10116.6 10183.2 10270.3 1890.3 1933.4 1950.3 1951.4 1992.4 55553.7 56433.0 61148.4 63141.4 63321.7 10497.1 10793.3 10813.7 10844.4 11248.7 14625.0 14635.3 14644.0 14701.5 14719.7 7472.9 7488.6 7541.9 7546.5 7555.5 6976.7 7048.8 7049.8 7059.3 7101.5 4673.7 4785.3 4845.6 4869.9 4908.5 1902.9 1936.2 1951.9 1952.4 2000.2 509.3 514.4 984.1 987.4 1094.3 10917.6 17021.5 18705.6 18712.9 18952.5 1043.6 1052.1 1056.1 1071.5 1118.9 10316.1 10594.1 10636.3 10639.8 10645.6 600629.0 610116.0 614286.0 624860.0 630343.0 78767.6 79582.0 80231.6 81070.2 82001.8 1199.1 1222.8 1224.8 1226.1 1230.8 15258.5 16081.4 16320.4 16328.4 16495.8 32830.5 33092.8 33972.0 34174.0 38497.2 45374.5 46118.5 46208.5 47778.5 49028.8 7928.0 8061.3 8099.8 8116.8 8171.8 11669.9 11794.7 12275.0 12291.4 12341.8 10823.0 10940.7 11026.4 11029.0 11178.8 10801.2 11056.2 11065.2 11079.1 11213.4 10284.2 10467.3 10997.3 11062.9 11198.6 7611.2 7635.2 7995.9 8034.6 8125.0 8621.7 9935.7 10352.0 10716.1 10752.6 22:26:58 INFO - PROCESS | 13482 | 22:26:58 INFO - PROCESS | 13482 | [#3] mootools.html Cycles:180 Average:5923.06 Median:5188.35 stddev:3086.01 (59.5%) stddev-sans-first:3077.34 22:26:58 INFO - PROCESS | 13482 | Values: 1571.8 1590.3 1828.7 1881.5 1938.8 8276.4 8368.0 8368.6 8472.7 8670.4 8388.5 8410.3 8436.0 8440.0 8456.1 2357.1 2398.6 2404.3 2419.7 2428.4 2394.1 2453.0 2497.7 2499.1 2502.6 2104.4 2149.1 2356.1 2430.7 2449.4 2335.9 2346.7 2348.3 2354.5 2359.0 2315.7 2369.9 2383.7 2387.2 2390.1 8378.6 8485.0 8488.4 8538.3 8544.3 4978.0 5105.7 5111.7 5127.8 5152.0 3451.9 3463.9 3543.2 3565.7 3583.3 1132.5 1138.5 1146.4 1169.9 1192.9 11677.5 11788.6 11815.2 11823.3 11865.7 4531.8 4533.2 4635.3 4653.3 4673.9 9553.9 9565.1 9590.5 9607.0 9608.4 5102.9 5119.9 5167.1 5181.4 5195.4 4659.5 4668.2 4697.4 4734.8 4735.8 3785.0 3804.9 3809.7 3823.1 3856.8 1155.9 1156.6 1158.4 1164.0 1166.7 1129.3 1148.2 1165.9 1173.5 1181.7 7904.4 7913.2 7943.0 7963.6 8038.4 1138.2 1174.5 1188.3 1201.5 1212.5 6140.9 6166.1 6193.2 6213.3 6222.3 9835.3 10057.8 10066.3 10096.1 10177.8 9910.5 9988.7 10021.8 10030.8 10056.3 8091.2 8105.1 8119.1 8147.1 8191.8 7821.9 7855.9 7879.4 7942.5 8075.7 9152.0 9184.5 9248.1 9376.2 9426.8 9312.5 9435.6 9456.4 9649.1 9715.9 7700.9 7760.0 7782.5 7813.0 7829.4 7745.4 7950.7 7966.9 7979.6 7990.1 7500.2 7508.8 7573.4 7663.8 7676.0 7316.7 7446.3 7473.5 7524.1 7528.8 7447.9 7477.4 7491.9 7518.2 7537.4 6943.3 6953.2 6978.0 7016.2 7019.1 6788.5 7077.1 7131.3 7138.3 7165.9 22:26:58 INFO - PROCESS | 13482 | 22:26:58 INFO - PROCESS | 13482 | [#4] prototype.html Cycles:180 Average:5655.61 Median:6399.04 stddev:1686.11 (26.3%) stddev-sans-first:1643.69 22:26:58 INFO - PROCESS | 13482 | Values: 380.1 380.3 381.1 386.5 388.7 6265.7 6283.2 6285.7 6379.0 6424.3 6208.3 6317.7 6369.9 6380.1 6383.1 4864.6 4897.9 4938.0 4941.0 4964.9 4947.3 4952.4 4954.6 4961.7 4963.8 4690.6 4823.5 4832.4 4840.4 4870.4 4781.6 4801.6 4835.3 4838.2 4839.7 4257.0 4261.6 4262.7 4271.3 4285.4 5876.7 5958.9 5973.0 5988.0 6013.2 5663.4 5686.4 5689.7 5693.8 5694.5 6653.1 6670.9 6671.3 6677.7 6703.8 4736.5 4737.4 4738.2 4746.1 4747.5 6928.4 7021.8 7089.9 7102.0 7104.6 4846.8 4853.0 4857.8 4861.9 4863.4 4914.9 4918.3 4925.9 4931.9 4941.5 5477.6 5642.2 5655.7 5674.1 5683.2 6762.3 6803.8 6851.1 6852.1 6872.5 1702.8 1731.1 1738.7 1740.8 1746.5 1167.7 1181.3 1185.1 1201.3 1206.8 6419.2 6446.6 6450.1 6460.7 6465.2 6855.7 6867.7 6870.9 6898.6 6910.8 6331.3 6355.5 6415.0 6440.5 6442.9 3719.2 3726.1 3748.8 3751.5 3761.2 7179.3 7202.4 7214.6 7226.2 7246.2 6949.3 7025.3 7027.5 7077.9 7099.9 7196.7 7207.1 7215.4 7223.8 7233.2 6867.9 6874.9 6896.8 6900.1 6907.1 6639.9 6767.9 6776.7 6817.4 6838.2 7186.0 7209.1 7220.2 7235.8 7252.1 4875.9 4876.5 4884.1 4887.7 4896.6 6704.4 6879.1 6889.5 6896.2 6990.2 6790.2 6804.5 6826.0 6853.9 6862.8 6779.9 6809.5 6836.3 6842.8 6867.1 6607.7 6730.3 6737.4 6745.3 6757.9 6849.2 6878.2 6882.9 6883.9 6890.0 6677.2 6680.8 6705.8 6712.3 6714.2 22:26:58 INFO - PROCESS | 13482 | 22:26:58 INFO - PROCESS | 13482 | [#5] yui.html Cycles:180 Average:15085.56 Median:4633.51 stddev:17539.41 (378.5%) stddev-sans-first:17556.26 22:26:58 INFO - PROCESS | 13482 | Values: 900.3 911.4 913.0 916.9 932.2 14834.1 15138.2 15144.2 16920.0 17043.6 15157.4 15263.8 15344.9 15392.2 15522.8 868.5 873.1 876.6 886.7 892.2 885.0 885.3 887.8 892.8 893.9 925.2 927.7 927.9 929.5 929.8 918.2 920.5 922.1 925.4 929.2 684.8 684.8 687.8 689.1 690.9 15022.7 15060.2 15062.1 15079.8 15083.0 13732.1 13800.4 13844.9 13846.4 13995.4 10988.6 11079.7 11080.9 11240.7 11303.4 3748.9 3772.3 3791.6 3830.2 3838.1 52895.0 53306.2 53497.2 53875.2 53948.0 10731.7 10803.8 10877.3 11256.4 11492.4 19097.3 19102.8 19269.6 19283.8 19321.0 7948.5 8052.6 8160.5 8226.7 8273.5 4381.6 4388.7 4407.8 4497.9 4647.5 3401.3 3402.0 3416.9 3432.5 3446.5 618.6 620.8 625.3 638.5 651.6 557.8 576.4 648.5 700.7 718.9 8130.9 8506.0 8518.6 8520.5 8724.4 552.0 576.4 608.4 724.3 779.4 4374.9 4510.8 4524.8 4630.6 4636.4 63384.0 63729.4 64174.4 64192.0 64254.4 55520.0 55661.7 57173.4 57495.0 57527.4 49701.5 50510.0 50591.7 50850.2 51223.5 9131.5 9292.8 9363.9 9373.6 9403.6 35616.0 35686.8 35830.6 36366.6 36389.8 45118.5 49205.3 49477.8 49854.8 50124.0 11179.0 11419.9 11454.8 11556.5 11643.2 11505.6 11624.1 11640.7 11795.9 11879.0 11979.9 12283.9 12362.3 12769.9 14063.5 12392.3 12574.9 12754.5 12913.7 13137.9 12872.3 13011.8 13049.3 13215.2 13875.2 9900.3 9920.3 9976.2 10294.8 10372.5 10592.9 11004.8 11058.0 11193.0 11318.5 22:26:58 INFO - PROCESS | 13482 | -------- Summary: end -------- 22:26:58 INFO - PROCESS | 13482 | 22:26:58 INFO - TEST-INFO | 13482: exit 0 22:26:58 INFO - TEST-OK | dromaeo_css | took 1109284ms 22:26:58 INFO - TEST-START | kraken 22:26:58 INFO - operating with platform_type : linux_ 22:26:58 INFO - Initialising browser for kraken test... 22:26:58 INFO - TEST-INFO | started process 13729 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbpZYw6/profile http://localhost:47304/getInfo.html) 22:27:02 INFO - PROCESS | 13729 | 22:27:02 INFO - PROCESS | 13729 | (process:13808): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:27:03 INFO - PROCESS | 13729 | __metrics Screen width/height:1600/1200 22:27:03 INFO - PROCESS | 13729 | colorDepth:24 22:27:03 INFO - PROCESS | 13729 | Browser inner width/height: 1024/697 22:27:03 INFO - PROCESS | 13729 | __metrics 22:27:04 INFO - TEST-INFO | 13729: exit 0 22:27:04 INFO - Browser initialized. 22:27:04 INFO - Running cycle 1/1 for kraken test... 22:27:04 INFO - TEST-INFO | started process 13857 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbpZYw6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:27:05 INFO - PROCESS | 13857 | 22:27:05 INFO - PROCESS | 13857 | (process:13921): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:27:16 INFO - PROCESS | 13857 | RSS: Main: 140570624 22:27:16 INFO - PROCESS | 13857 | 22:27:18 INFO - PROCESS | 13857 | Cycle 1(1): loaded http://localhost:47304/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47304/tests/kraken/driver.html?testName=audio-beat-detection) 22:27:19 INFO - PROCESS | 13857 | RSS: Main: 144297984 22:27:19 INFO - PROCESS | 13857 | 22:27:21 INFO - PROCESS | 13857 | Cycle 1(1): loaded http://localhost:47304/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47304/tests/kraken/driver.html?testName=audio-dft) 22:27:22 INFO - PROCESS | 13857 | RSS: Main: 144211968 22:27:22 INFO - PROCESS | 13857 | 22:27:25 INFO - PROCESS | 13857 | Cycle 1(1): loaded http://localhost:47304/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47304/tests/kraken/driver.html?testName=audio-fft) 22:27:25 INFO - PROCESS | 13857 | RSS: Main: 145539072 22:27:25 INFO - PROCESS | 13857 | 22:27:27 INFO - PROCESS | 13857 | Cycle 1(1): loaded http://localhost:47304/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47304/tests/kraken/driver.html?testName=audio-oscillator) 22:27:28 INFO - PROCESS | 13857 | RSS: Main: 145022976 22:27:28 INFO - PROCESS | 13857 | 22:27:30 INFO - PROCESS | 13857 | Cycle 1(1): loaded http://localhost:47304/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47304/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:27:31 INFO - PROCESS | 13857 | RSS: Main: 144793600 22:27:31 INFO - PROCESS | 13857 | 22:27:34 INFO - PROCESS | 13857 | Cycle 1(1): loaded http://localhost:47304/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47304/tests/kraken/driver.html?testName=imaging-darkroom) 22:27:34 INFO - PROCESS | 13857 | RSS: Main: 146587648 22:27:34 INFO - PROCESS | 13857 | 22:27:38 INFO - PROCESS | 13857 | Cycle 1(1): loaded http://localhost:47304/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47304/tests/kraken/driver.html?testName=imaging-desaturate) 22:27:38 INFO - PROCESS | 13857 | RSS: Main: 145887232 22:27:38 INFO - PROCESS | 13857 | 22:27:41 INFO - PROCESS | 13857 | Cycle 1(1): loaded http://localhost:47304/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47304/tests/kraken/driver.html?testName=json-parse-financial) 22:27:42 INFO - PROCESS | 13857 | RSS: Main: 145805312 22:27:42 INFO - PROCESS | 13857 | 22:27:43 INFO - PROCESS | 13857 | Cycle 1(1): loaded http://localhost:47304/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47304/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:27:44 INFO - PROCESS | 13857 | RSS: Main: 146534400 22:27:44 INFO - PROCESS | 13857 | 22:27:45 INFO - PROCESS | 13857 | Cycle 1(1): loaded http://localhost:47304/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47304/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:27:46 INFO - PROCESS | 13857 | RSS: Main: 146100224 22:27:46 INFO - PROCESS | 13857 | 22:27:48 INFO - PROCESS | 13857 | Cycle 1(1): loaded http://localhost:47304/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47304/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:27:49 INFO - PROCESS | 13857 | RSS: Main: 145887232 22:27:49 INFO - PROCESS | 13857 | 22:27:51 INFO - PROCESS | 13857 | Cycle 1(1): loaded http://localhost:47304/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47304/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:27:52 INFO - PROCESS | 13857 | RSS: Main: 145571840 22:27:52 INFO - PROCESS | 13857 | 22:27:54 INFO - PROCESS | 13857 | Cycle 1(1): loaded http://localhost:47304/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47304/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:27:55 INFO - PROCESS | 13857 | RSS: Main: 145162240 22:27:55 INFO - PROCESS | 13857 | 22:27:56 INFO - PROCESS | 13857 | Cycle 1(1): loaded http://localhost:47304/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47304/tests/kraken/driver.html?testName=ai-astar) 22:27:57 INFO - PROCESS | 13857 | RSS: Main: 147456000 22:27:57 INFO - PROCESS | 13857 | 22:27:57 INFO - PROCESS | 13857 | __start_tp_report 22:27:57 INFO - PROCESS | 13857 | _x_x_mozilla_page_load 22:27:57 INFO - PROCESS | 13857 | _x_x_mozilla_page_load_details 22:27:57 INFO - PROCESS | 13857 | |i|pagename|runs| 22:27:57 INFO - PROCESS | 13857 | |0;ai-astar;111;105;110;109;110;121;110;109;108;110 22:27:57 INFO - PROCESS | 13857 | |1;audio-beat-detection;153;124;147;167;128;163;155;124;162;127 22:27:57 INFO - PROCESS | 13857 | |2;audio-dft;162;163;162;161;163;161;161;163;165;164 22:27:57 INFO - PROCESS | 13857 | |3;audio-fft;74;76;77;154;72;73;72;76;159;75 22:27:57 INFO - PROCESS | 13857 | |4;audio-oscillator;101;96;143;94;95;96;141;94;95;135 22:27:57 INFO - PROCESS | 13857 | |5;imaging-gaussian-blur;110;110;110;110;110;109;110;110;110;110 22:27:57 INFO - PROCESS | 13857 | |6;imaging-darkroom;149;146;147;147;147;150;147;147;150;148 22:27:57 INFO - PROCESS | 13857 | |7;imaging-desaturate;96;98;97;97;96;96;96;96;96;97 22:27:57 INFO - PROCESS | 13857 | |8;json-parse-financial;54;57;57;57;57;57;60;62;56;53 22:27:57 INFO - PROCESS | 13857 | |9;json-stringify-tinderbox;65;65;65;65;65;67;65;65;65;66 22:27:57 INFO - PROCESS | 13857 | |10;stanford-crypto-aes;81;81;85;84;84;82;82;83;82;82 22:27:57 INFO - PROCESS | 13857 | |11;stanford-crypto-ccm;112;113;112;112;117;126;117;114;116;122 22:27:57 INFO - PROCESS | 13857 | |12;stanford-crypto-pbkdf2;140;129;135;140;126;137;138;138;139;139 22:27:57 INFO - PROCESS | 13857 | |13;stanford-crypto-sha256-iterative;66;66;65;64;67;65;67;65;66;70 22:27:57 INFO - PROCESS | 13857 | __end_tp_report 22:27:57 INFO - PROCESS | 13857 | __start_cc_report 22:27:57 INFO - PROCESS | 13857 | _x_x_mozilla_cycle_collect,721 22:27:57 INFO - PROCESS | 13857 | __end_cc_report 22:27:57 INFO - PROCESS | 13857 | __startTimestamp1454480877060__endTimestamp 22:27:57 INFO - PROCESS | 13857 | 22:27:57 INFO - PROCESS | 13857 | ------- Summary: start ------- 22:27:57 INFO - PROCESS | 13857 | Number of tests: 14 22:27:57 INFO - PROCESS | 13857 | 22:27:57 INFO - PROCESS | 13857 | [#0] ai-astar Cycles:10 Average:110.30 Median:110.00 stddev:4.11 (3.7%) stddev-sans-first:4.35 22:27:57 INFO - PROCESS | 13857 | Values: 111.0 105.0 110.0 109.0 110.0 121.0 110.0 109.0 108.0 110.0 22:27:57 INFO - PROCESS | 13857 | 22:27:57 INFO - PROCESS | 13857 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:154.00 stddev:17.51 (11.4%) stddev-sans-first:18.33 22:27:57 INFO - PROCESS | 13857 | Values: 153.0 124.0 147.0 167.0 128.0 163.0 155.0 124.0 162.0 127.0 22:27:57 INFO - PROCESS | 13857 | 22:27:57 INFO - PROCESS | 13857 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.35 (0.8%) stddev-sans-first:1.42 22:27:57 INFO - PROCESS | 13857 | Values: 162.0 163.0 162.0 161.0 163.0 161.0 161.0 163.0 165.0 164.0 22:27:57 INFO - PROCESS | 13857 | 22:27:57 INFO - PROCESS | 13857 | [#3] audio-fft Cycles:10 Average:90.80 Median:74.50 stddev:34.69 (46.6%) stddev-sans-first:36.26 22:27:57 INFO - PROCESS | 13857 | Values: 74.0 76.0 77.0 154.0 72.0 73.0 72.0 76.0 159.0 75.0 22:27:57 INFO - PROCESS | 13857 | 22:27:57 INFO - PROCESS | 13857 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:94.50 stddev:21.34 (22.6%) stddev-sans-first:22.44 22:27:57 INFO - PROCESS | 13857 | Values: 101.0 96.0 143.0 94.0 95.0 96.0 141.0 94.0 95.0 135.0 22:27:57 INFO - PROCESS | 13857 | 22:27:57 INFO - PROCESS | 13857 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 22:27:57 INFO - PROCESS | 13857 | Values: 110.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 110.0 110.0 22:27:57 INFO - PROCESS | 13857 | 22:27:57 INFO - PROCESS | 13857 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:147.50 stddev:1.40 (0.9%) stddev-sans-first:1.41 22:27:57 INFO - PROCESS | 13857 | Values: 149.0 146.0 147.0 147.0 147.0 150.0 147.0 147.0 150.0 148.0 22:27:57 INFO - PROCESS | 13857 | 22:27:57 INFO - PROCESS | 13857 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 22:27:57 INFO - PROCESS | 13857 | Values: 96.0 98.0 97.0 97.0 96.0 96.0 96.0 96.0 96.0 97.0 22:27:57 INFO - PROCESS | 13857 | 22:27:57 INFO - PROCESS | 13857 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.00 stddev:2.58 (4.5%) stddev-sans-first:2.50 22:27:57 INFO - PROCESS | 13857 | Values: 54.0 57.0 57.0 57.0 57.0 57.0 60.0 62.0 56.0 53.0 22:27:57 INFO - PROCESS | 13857 | 22:27:57 INFO - PROCESS | 13857 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 22:27:57 INFO - PROCESS | 13857 | Values: 65.0 65.0 65.0 65.0 65.0 67.0 65.0 65.0 65.0 66.0 22:27:57 INFO - PROCESS | 13857 | 22:27:57 INFO - PROCESS | 13857 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.50 stddev:1.35 (1.6%) stddev-sans-first:1.30 22:27:57 INFO - PROCESS | 13857 | Values: 81.0 81.0 85.0 84.0 84.0 82.0 82.0 83.0 82.0 82.0 22:27:57 INFO - PROCESS | 13857 | 22:27:57 INFO - PROCESS | 13857 | [#11] stanford-crypto-ccm Cycles:10 Average:116.10 Median:116.50 stddev:4.70 (4.0%) stddev-sans-first:4.75 22:27:57 INFO - PROCESS | 13857 | Values: 112.0 113.0 112.0 112.0 117.0 126.0 117.0 114.0 116.0 122.0 22:27:57 INFO - PROCESS | 13857 | 22:27:57 INFO - PROCESS | 13857 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.10 Median:138.50 stddev:4.82 (3.5%) stddev-sans-first:4.90 22:27:57 INFO - PROCESS | 13857 | Values: 140.0 129.0 135.0 140.0 126.0 137.0 138.0 138.0 139.0 139.0 22:27:57 INFO - PROCESS | 13857 | 22:27:57 INFO - PROCESS | 13857 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:1.66 (2.5%) stddev-sans-first:1.76 22:27:57 INFO - PROCESS | 13857 | Values: 66.0 66.0 65.0 64.0 67.0 65.0 67.0 65.0 66.0 70.0 22:27:57 INFO - PROCESS | 13857 | -------- Summary: end -------- 22:27:57 INFO - PROCESS | 13857 | 22:27:57 INFO - TEST-INFO | 13857: exit 0 22:27:57 INFO - TEST-OK | kraken | took 59291ms 22:27:57 INFO - TEST-START | v8_7 22:27:57 INFO - operating with platform_type : linux_ 22:27:57 INFO - Initialising browser for v8_7 test... 22:27:57 INFO - TEST-INFO | started process 14150 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYgx6Ml/profile http://localhost:47304/getInfo.html) 22:28:01 INFO - PROCESS | 14150 | 22:28:01 INFO - PROCESS | 14150 | (process:14232): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:28:02 INFO - PROCESS | 14150 | __metrics Screen width/height:1600/1200 22:28:02 INFO - PROCESS | 14150 | colorDepth:24 22:28:02 INFO - PROCESS | 14150 | Browser inner width/height: 1024/697 22:28:02 INFO - PROCESS | 14150 | __metrics 22:28:03 INFO - TEST-INFO | 14150: exit 0 22:28:03 INFO - Browser initialized. 22:28:03 INFO - Running cycle 1/1 for v8_7 test... 22:28:03 INFO - TEST-INFO | started process 14281 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYgx6Ml/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:28:04 INFO - PROCESS | 14281 | 22:28:04 INFO - PROCESS | 14281 | (process:14344): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:28:15 INFO - PROCESS | 14281 | RSS: Main: 140734464 22:28:15 INFO - PROCESS | 14281 | 22:28:37 INFO - PROCESS | 14281 | Cycle 1(1): loaded http://localhost:47304/tests/v8_7/run.html (next: http://localhost:47304/tests/v8_7/run.html) 22:28:37 INFO - PROCESS | 14281 | RSS: Main: 144285696 22:28:37 INFO - PROCESS | 14281 | 22:28:37 INFO - PROCESS | 14281 | __start_tp_report 22:28:37 INFO - PROCESS | 14281 | _x_x_mozilla_page_load 22:28:37 INFO - PROCESS | 14281 | _x_x_mozilla_page_load_details 22:28:37 INFO - PROCESS | 14281 | |i|pagename|runs| 22:28:37 INFO - PROCESS | 14281 | |0;Richards;166.80567139282735 22:28:37 INFO - PROCESS | 14281 | |1;DeltaBlue;170.64846416382252 22:28:37 INFO - PROCESS | 14281 | |2;Encrypt;278.55153203342616 22:28:37 INFO - PROCESS | 14281 | |3;Decrypt;5186.5284974093265 22:28:37 INFO - PROCESS | 14281 | |4;RayTrace;955.1098376313277 22:28:37 INFO - PROCESS | 14281 | |5;Earley;545.5537370430987 22:28:37 INFO - PROCESS | 14281 | |6;Boyer;11247.191011235955 22:28:37 INFO - PROCESS | 14281 | |7;RegExp;40180 22:28:37 INFO - PROCESS | 14281 | |8;Splay;504.2606516290727 22:28:37 INFO - PROCESS | 14281 | |9;NavierStokes;4822.115384615385 22:28:37 INFO - PROCESS | 14281 | __end_tp_report 22:28:37 INFO - PROCESS | 14281 | __startTimestamp1454480917821__endTimestamp 22:28:37 INFO - PROCESS | 14281 | 22:28:37 INFO - PROCESS | 14281 | ------- Summary: start ------- 22:28:37 INFO - PROCESS | 14281 | Number of tests: 10 22:28:37 INFO - PROCESS | 14281 | 22:28:37 INFO - PROCESS | 14281 | [#0] Richards Cycles:1 Average:166.81 Median:166.81 stddev:0.00 (0.0%) 22:28:37 INFO - PROCESS | 14281 | Values: 166.8 22:28:37 INFO - PROCESS | 14281 | 22:28:37 INFO - PROCESS | 14281 | [#1] DeltaBlue Cycles:1 Average:170.65 Median:170.65 stddev:0.00 (0.0%) 22:28:37 INFO - PROCESS | 14281 | Values: 170.6 22:28:37 INFO - PROCESS | 14281 | 22:28:37 INFO - PROCESS | 14281 | [#2] Encrypt Cycles:1 Average:278.55 Median:278.55 stddev:0.00 (0.0%) 22:28:37 INFO - PROCESS | 14281 | Values: 278.6 22:28:37 INFO - PROCESS | 14281 | 22:28:37 INFO - PROCESS | 14281 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 22:28:37 INFO - PROCESS | 14281 | Values: 5186.5 22:28:37 INFO - PROCESS | 14281 | 22:28:37 INFO - PROCESS | 14281 | [#4] RayTrace Cycles:1 Average:955.11 Median:955.11 stddev:0.00 (0.0%) 22:28:37 INFO - PROCESS | 14281 | Values: 955.1 22:28:37 INFO - PROCESS | 14281 | 22:28:37 INFO - PROCESS | 14281 | [#5] Earley Cycles:1 Average:545.55 Median:545.55 stddev:0.00 (0.0%) 22:28:37 INFO - PROCESS | 14281 | Values: 545.6 22:28:37 INFO - PROCESS | 14281 | 22:28:37 INFO - PROCESS | 14281 | [#6] Boyer Cycles:1 Average:11247.19 Median:11247.19 stddev:0.00 (0.0%) 22:28:37 INFO - PROCESS | 14281 | Values: 11247.2 22:28:37 INFO - PROCESS | 14281 | 22:28:37 INFO - PROCESS | 14281 | [#7] RegExp Cycles:1 Average:40180.00 Median:40180.00 stddev:0.00 (0.0%) 22:28:37 INFO - PROCESS | 14281 | Values: 40180.0 22:28:37 INFO - PROCESS | 14281 | 22:28:37 INFO - PROCESS | 14281 | [#8] Splay Cycles:1 Average:504.26 Median:504.26 stddev:0.00 (0.0%) 22:28:37 INFO - PROCESS | 14281 | Values: 504.3 22:28:37 INFO - PROCESS | 14281 | 22:28:37 INFO - PROCESS | 14281 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 22:28:37 INFO - PROCESS | 14281 | Values: 4822.1 22:28:37 INFO - PROCESS | 14281 | -------- Summary: end -------- 22:28:37 INFO - PROCESS | 14281 | 22:28:38 INFO - TEST-INFO | 14281: exit 0 22:28:38 INFO - TEST-OK | v8_7 | took 40751ms 22:28:38 INFO - SUITE-END | took 1209s 22:28:38 INFO - Completed test suite (00:20:09) 22:28:38 INFO - Working with test: dromaeo_css 22:28:38 INFO - Generating results file: dromaeo_css 22:28:38 INFO - Working with test: kraken 22:28:38 INFO - Generating results file: kraken 22:28:38 INFO - javascript benchmark 22:28:38 INFO - Working with test: v8_7 22:28:38 INFO - Generating results file: v8_7 22:28:38 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:28:39 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 22:28:39 INFO - process_Request line: dromaeo_css 7413.00 graph.html#tests=[[72,52,43]] 22:28:39 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:28:39 INFO - process_Request line: kraken 1495.00 graph.html#tests=[[232,52,43]] 22:28:39 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:28:39 INFO - process_Request line: v8_7 22022.75 graph.html#tests=[[230,52,43]] 22:28:39 INFO - RETURN: dromaeo_css: 7413.00 22:28:39 INFO - RETURN: kraken: 1495.00 22:28:39 INFO - RETURN: v8_7: 22022.75 22:28:39 INFO - javascript benchmark 22:28:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3381.2561236527968, 3422.2299982503923, 3424.7773894696857, 3443.655634436556, 3453.3093381323724, 5541.861453463665, 5560.916586251209, 5562.721863906803, 5571.582131340146, 5580.386157522679, 5523.309586301712, 5551.861203469915, 5577.163425486169, 5581.939431508021, 5587.608867379285, 5042.369703787036, 5077.365329333833, 5089.185730283156, 5115.155999260118, 5203.710367438334, 4984.875378115558, 5127.282180494733, 5136.306598609196, 5143.074246635623, 5173.224016397533, 5097.388313402397, 5201.843944681666, 5204.843854684365, 5222.373315202181, 5227.18978558324, 5144.536991670749, 5155.613329000321, 5157.123289040872, 5176.430592634807, 5185.274061631375, 4968.801247950078, 5042.344495215635, 5054.696718196883, 5060.1903695408555, 5109.3613298337705, 5361.356637203521, 5369.5167434931045, 5384.7846086156505, 5394.568434525228, 5398.217258497496, 5944.910826337608, 5954.821355359303, 5969.194158788551, 5998.97000514999, 6002.8499287517725, 5970.04479283317, 6024.909626355608, 6080.422359875804, 6085.726142323606, 6143.846403839895, 5591.30108736408, 5630.971845140748, 5646.57650676201, 5648.548116150698, 5661.745221465044, 6126.540509461719, 6142.477889379364, 6156.445919867234, 6159.969200153971, 6177.227846519185, 5833.562482813806, 5870.647761134345, 5879.911801322984, 5896.675682837399, 5996.370381110008, 6037.426444487766, 6045.909311360333, 6059.72731227087, 6084.330723620398, 6086.2958371656005, 5956.16613674086, 6016.819495415145, 6024.969875150684, 6025.096235564701, 6036.064410016366, 5789.507891829157, 5906.675132867647, 5952.4047595241, 5973.731182096816, 5979.730912108966, 4601.470830854428, 4606.516315786794, 4624.306354046853, 4643.3963584733765, 4649.418822647169, 4136.482939632546, 4148.253314403436, 4158.500979882433, 4168.333066709312, 4184.497860256789, 5653.462921022497, 5674.631148975386, 5747.252857128547, 5747.885042299131, 5750.453706897838, 6077.9392206078255, 6078.0882867569335, 6092.116643086728, 6094.268687757498, 6098.573099882966, 5716.342620598602, 5736.110902810071, 5764.855878602984, 5771.30744310677, 5785.450382213683, 5079.796808127633, 5126.769295381717, 5147.176451767699, 5165.61257905651, 5177.016366890279, 6329.7468101275435, 6339.873202536016, 6366.427021568081, 6388.648624325707, 6389.648569328731, 6071.9696401518595, 6127.84680382994, 6129.816105516842, 6132.754689812357, 6141.232345956755, 6166.075088736726, 6189.907151392643, 6283.120363149254, 6284.937150628435, 6369.713362898773, 5955.970220148872, 5988.9551227098245, 6009.338972712911, 6010.978133717191, 6054.969725151346, 6056.424639659225, 6095.664738439428, 6104.572679912363, 6107.144999699956, 6112.113743507255, 5808.361080281081, 5870.647761134345, 5890.970545147246, 5912.793052243151, 5975.611585246945, 5913.852153696192, 5918.674472904032, 5941.287045554561, 5946.762129514771, 5975.641461512323, 5693.5445164387575, 5825.475707186373, 5841.4450627190345, 5847.38602446737, 5850.0932355484965, 5829.504492118048, 5884.882302353843, 5948.821535353946, 5951.256092988377, 5978.432048955517, 5808.881248819959, 5818.272715910512, 5827.446392592697, 5851.414858514115, 5866.208061911758], "unit": "score", "name": "dojo.html", "value": 5565.2896309837115}, {"lowerIsBetter": false, "replicates": [557.7545879812882, 560.627182923356, 576.7577617400689, 578.1818726502, 579.2527639345245, 37188.44217336739, 37509.812450937774, 37985.0, 38003.80998095013, 38005.23989520208, 38480.422793658116, 39097.21805563894, 39257.60742392575, 39297.41053884194, 39371.803140984324, 8606.397552171366, 8847.42491738035, 8848.159424854628, 8878.42290251135, 8934.86597701035, 8751.299896008335, 8798.208161265486, 8874.112588741138, 8876.911230887674, 8887.95556022219, 8816.162464565856, 8872.512011839346, 8873.290136789074, 8913.1978121969, 8914.732558023237, 8808.163224493695, 8856.601452934634, 8875.28997680184, 8883.20051195389, 8931.910680893174, 8672.436291641023, 8771.780705482413, 8801.163889430494, 8825.602847871862, 8828.249598784047, 39198.0, 39736.0, 39786.20427591432, 39807.60192398097, 40026.79986600048, 3379.0876463355003, 3527.9294414111832, 4065.512138543364, 4132.028973191298, 4325.891852703676, 32415.83792081048, 32596.0, 32653.0, 32774.180645484055, 33956.6604333956, 4342.739435633841, 4346.456692913386, 4357.433533640638, 4362.432883725127, 4443.688941774077, 291380.0, 292184.0, 292560.0, 292640.0, 292982.0, 57882.131768023515, 58946.70526647339, 65357.673211633635, 67515.3248467509, 67606.0, 60054.69972650109, 60089.39910600925, 60380.39619603835, 60460.09309860355, 60605.0, 15785.68428631421, 15796.36814527406, 15928.442504512286, 15942.521724348288, 15995.200239987955, 11243.100551955824, 11263.718407039889, 11364.465797117284, 11600.129990250765, 11626.0, 21975.340739777832, 22308.21921232749, 22347.441313966956, 22367.776322236896, 22484.0, 7947.648899687067, 8039.919600803917, 8042.356611471068, 8072.394570407243, 8078.151794061657, 990.5537914644699, 1017.1862509991977, 1037.5672611887544, 1078.358376765823, 1107.6732363952653, 31122.377552449278, 31263.84368078145, 31412.0, 31934.680653193634, 32086.19784505406, 1076.7684947736118, 1157.6064138193055, 1163.0114402757758, 1206.6862615719801, 1250.0, 16187.90351170667, 16267.51197464078, 16436.1781910904, 16486.917565412095, 16524.75212871808, 526806.0, 531377.0, 532561.0, 534690.0, 537159.0, 57308.0, 57652.71173644105, 57684.71157644185, 57757.13364299539, 57989.710051449474, 1496.865282124614, 1504.247876061969, 1509.8565636264536, 1512.19853477657, 1517.6357674158123, 30987.225319367197, 31761.682383176798, 33057.173570659965, 34505.309893802485, 35094.82452587721, 51056.48943510517, 51301.74349128231, 51355.48644513507, 51747.482525174266, 51998.74000630124, 329093.0, 334653.0, 337795.0, 338050.2389952138, 338255.0, 46817.06365872732, 47210.29184562166, 47487.287690683974, 48089.0, 48474.75762621305, 49751.75124124356, 50145.24782128198, 50701.0, 51112.0, 51153.74423127861, 42307.7884610575, 42890.0, 43338.56661433345, 43579.0, 43911.78044109759, 41844.37233441562, 42276.0, 42575.7871210642, 42972.0, 43551.346729798446, 42950.78524607357, 43010.13979720451, 43238.135237295704, 43306.0, 43712.0, 32354.83822580872, 34327.82836085804, 35069.123271918404, 35095.0, 35403.82298088493, 27998.44003119967, 28432.57351139693, 28432.715672843005, 28539.857300713364, 28552.0], "unit": "score", "name": "ext.html", "value": 20291.78387718024}, {"lowerIsBetter": false, "replicates": [396.646984184076, 396.72824115480887, 397.3602499975041, 397.5090762907809, 400.7295075823818, 14987.0, 15192.544223673307, 16937.830621693778, 17304.22131004103, 17419.73870391945, 16086.517404477856, 17566.560835979108, 17604.38384656537, 17913.28346866127, 17963.91018044908, 5046.848594542161, 5210.635255532115, 5213.556847667953, 5228.346456692913, 5257.553107985826, 5060.165072762989, 5264.341957255343, 5408.296921400212, 5471.042567550682, 5472.452754724535, 5389.703566303851, 5418.729063546807, 5561.360443548983, 5814.796482123126, 5821.56338274629, 5882.647041177543, 5999.340072592011, 6041.24484439445, 6046.244219472566, 6174.135621013062, 5500.669959802384, 5501.064818980783, 5509.338879334466, 5526.613137080406, 5548.112302031696, 13924.094933829268, 15922.681546369007, 16073.517794466185, 21145.259915903025, 21267.36197914065, 2139.3902737719677, 2211.845170838042, 2225.6995305633695, 2257.808086312665, 2350.2831636350907, 9957.352772069793, 10036.197104231644, 10116.645917392929, 10183.236257280734, 10270.281080324381, 1890.3100368365585, 1933.4103098554936, 1950.288144827142, 1951.414575627306, 1992.3524854422371, 55553.72223138899, 56433.0, 61148.38851611471, 63141.368586314005, 63321.68339158321, 10497.10774584169, 10793.29843560166, 10813.67558973232, 10844.403557804239, 11248.662540123645, 14625.0493717908, 14635.341409636592, 14644.0, 14701.485448009482, 14719.705605887822, 7472.887906681404, 7488.625568721543, 7541.944127822109, 7546.471746977769, 7555.471117021756, 6976.7209311627985, 7048.753293634698, 7049.8237544060785, 7059.329363710439, 7101.467389945671, 4673.7429441381055, 4785.3300537924715, 4845.5881250094135, 4869.9269510957365, 4908.509149085063, 1902.9048547572565, 1936.1964784614227, 1951.9414417567211, 1952.3947576251408, 2000.1799262302677, 509.34803451582036, 514.4125050993508, 984.0503913723292, 987.4174237200086, 1094.3379255550278, 10917.56329746817, 17021.48935531936, 18705.625887482172, 18712.90643546801, 18952.52618684544, 1043.634727845248, 1052.1057101463848, 1056.0759335581367, 1071.4589132488043, 1118.9440527973568, 10316.123129534073, 10594.099501542301, 10636.255462117577, 10639.840402393971, 10645.627403041011, 600629.0, 610116.0, 614286.0, 624860.0, 630343.0, 78767.60616196998, 79582.0, 80231.59884200658, 81070.18929810745, 82001.76997345044, 1199.094683513959, 1222.834917286155, 1224.797908345131, 1226.1478272600634, 1230.809224570175, 15258.542243732705, 16081.437149699705, 16320.428784992468, 16328.428505002743, 16495.752563711314, 32830.507542386404, 33092.83453582717, 33972.0, 34174.0, 38497.23005539818, 45374.54625453703, 46118.53881461143, 46208.53791462177, 47778.522214777404, 49028.754856226915, 7928.048634163937, 8061.314788243065, 8099.797505062184, 8116.83766324682, 8171.83656326882, 11669.88330116722, 11794.705132371759, 12275.0, 12291.446884890023, 12341.75316493683, 10823.0, 10940.726481838017, 11026.44867756593, 11029.0, 11178.832317515082, 10801.24391292602, 11056.170787190831, 11065.225434219848, 11079.113670906469, 11213.383263920236, 10284.228682848667, 10467.319624224401, 10997.252432171117, 11062.944685276521, 11198.608048718255, 7611.238876112345, 7635.198304178203, 7995.920040799518, 8034.55809930436, 8124.959375203086, 8621.69824056155, 9935.701928942144, 10352.0, 10716.089132423831, 10752.569897204337], "unit": "score", "name": "jquery.html", "value": 8649.730080374771}, {"lowerIsBetter": false, "replicates": [1571.842815718428, 1590.3320605345757, 1828.7439758433823, 1881.5202123458516, 1938.7673479182492, 8276.420650554455, 8368.037675667292, 8368.623411946463, 8472.661093556258, 8670.43642163259, 8388.454750441217, 8410.327173826094, 8436.0, 8440.0, 8456.06983231844, 2357.116081469449, 2398.580248456522, 2404.326788499214, 2419.661247425362, 2428.4171798768257, 2394.0782798622567, 2453.031052734169, 2497.6628155198996, 2499.1253061428447, 2502.5745623244, 2104.4002459299104, 2149.0973791007737, 2356.140008896749, 2430.6718592989896, 2449.4121410861444, 2335.9182428615004, 2346.6597343385197, 2348.3189874936247, 2354.5173239485866, 2359.00921612923, 2315.733690625566, 2369.869657168855, 2383.749706280833, 2387.164492427654, 2390.067873529325, 8378.581070946428, 8485.0, 8488.363372747068, 8538.316934645214, 8544.316454683672, 4978.0, 5105.693658380509, 5111.6677415968215, 5127.7948882044675, 5151.974240128776, 3451.861925523001, 3463.913402164966, 3543.2204914918675, 3565.6790888819874, 3583.337082639694, 1132.4733998690565, 1138.4990604134236, 1146.3752255021034, 1169.8947094761427, 1192.9105317101166, 11677.474513646906, 11788.587399440978, 11815.172937894351, 11823.34971576563, 11865.703357416134, 4531.8187272509385, 4533.206688829442, 4635.3278774578175, 4653.278741795028, 4673.859784206479, 9553.856692149624, 9565.139137477661, 9590.520473976274, 9607.0, 9608.423494590346, 5102.897942041139, 5119.8720031998755, 5167.069927413102, 5181.35233095863, 5195.350581177353, 4659.464161621389, 4668.206404911173, 4697.365855609517, 4734.810607575727, 4735.83424580138, 3785.0348161218712, 3804.885853424402, 3809.6761775249415, 3823.0824602095295, 3856.7878766668105, 1155.9017483513828, 1156.6414411532453, 1158.368689064445, 1163.9941800290944, 1166.650004998497, 1129.2716198052374, 1148.2306854407566, 1165.9242149260272, 1173.4895320535595, 1181.7459246262094, 7904.446688731734, 7913.169117242606, 7942.960285198537, 7963.562004089715, 8038.437309388287, 1138.231693606812, 1174.4597485156924, 1188.2692144331174, 1201.5434135028809, 1212.5452955141823, 6140.907886381708, 6166.136740856284, 6193.163922870445, 6213.347598502182, 6222.315545290015, 9835.3115281931, 10057.849132263022, 10066.345687530433, 10096.14182794456, 10177.796444071226, 9910.504474776233, 9988.650397236062, 10021.79956400868, 10030.799384012278, 10056.29605927578, 8091.190880911861, 8105.148959359182, 8119.066307374727, 8147.103818579952, 8191.79520511992, 7821.92178078212, 7855.921440785519, 7879.448438609243, 7942.483738556975, 8075.676972921017, 9152.0, 9184.540772961458, 9248.121428464285, 9376.156145946898, 9426.811463770824, 9312.534373281444, 9435.622575097193, 9456.432614043179, 9649.13157815772, 9715.854262185932, 7700.922990770021, 7759.961200193963, 7782.49413788102, 7813.0, 7829.373650108091, 7745.419093567893, 7950.7217247396065, 7966.880496792669, 7979.561124137996, 7990.121086680577, 7500.174980752004, 7508.774736757906, 7573.394128469819, 7663.808404789702, 7675.961620192087, 7316.707331706672, 7446.292602202782, 7473.51422157558, 7524.05949256343, 7528.849423011399, 7447.925520744723, 7477.364424023801, 7491.850162996819, 7518.173000969779, 7537.434692397982, 6943.270956549692, 6953.1656201254145, 6977.965110174417, 7016.22821489646, 7019.052427922165, 6788.490863185182, 7077.079979602619, 7131.286871313035, 7138.321859423347, 7165.856682866209], "unit": "score", "name": "mootools.html", "value": 4843.822192270625}, {"lowerIsBetter": false, "replicates": [380.05935310107503, 380.3097378258461, 381.10630571310287, 386.5110635046665, 388.6909906624234, 6265.749370025199, 6283.246010478738, 6285.748570057198, 6379.0, 6424.293327733945, 6208.348123447041, 6317.652529110897, 6369.936300636992, 6380.106785050085, 6383.0744542041375, 4864.586510146624, 4897.8775530611665, 4937.950620493803, 4940.975295123538, 4964.925526117111, 4947.307376967227, 4952.3561936948145, 4954.628402869781, 4961.677490963094, 4963.776630051639, 4690.616268200872, 4823.541763532477, 4832.420109586837, 4840.394950631171, 4870.439899411577, 4781.593564547018, 4801.61587073035, 4835.274708793674, 4838.177509823338, 4839.7096174229655, 4256.978715106436, 4261.552536983603, 4262.701610887239, 4271.273883439822, 4285.3786201000685, 5876.676782776945, 5958.880822383571, 5973.0, 5988.0, 6013.188219590343, 5663.377028526858, 5686.3744988051285, 5689.715514224314, 5693.77224911003, 5694.487496125369, 6653.068570400148, 6670.899936500957, 6671.2995135510555, 6677.699503522354, 6703.826830304677, 4736.455307639631, 4737.407824021997, 4738.241881298975, 4746.074515469485, 4747.52524747526, 6928.376446119823, 7021.82445438863, 7089.929100708979, 7102.005719199316, 7104.6447677615915, 4846.75766211688, 4852.975735121372, 4857.80568777252, 4861.854144375674, 4863.416390033219, 4914.90170196594, 4918.262260660929, 4925.87685307863, 4931.926021109686, 4941.530554597308, 5477.616566840283, 5642.210090587321, 5655.688937108499, 5674.092145256739, 5683.204351390808, 6762.289959554274, 6803.829904252433, 6851.07510486088, 6852.074969879102, 6872.518923675295, 1702.838230368113, 1731.1430841733422, 1738.721804511272, 1740.8346207110305, 1746.4847869878417, 1167.737259116692, 1181.2794195540714, 1185.0874826383636, 1201.3212534917743, 1206.831043653889, 6419.2296924369375, 6446.645434501147, 6450.129232553639, 6460.741570337133, 6465.15952926126, 6855.691493882788, 6867.690953907087, 6870.862582748317, 6898.586084834826, 6910.7581234656545, 6331.271903731038, 6355.523335749745, 6415.0, 6440.452561532322, 6442.871142577123, 3719.237556300952, 3726.06848287928, 3748.775073495599, 3751.5123034005405, 3761.153740408441, 7179.282071792779, 7202.4238060954995, 7214.639268036577, 7226.241244669339, 7246.166690830517, 6949.339812717783, 7025.297470252934, 7027.5080744348425, 7077.893831592531, 7099.935009748579, 7196.712131514785, 7207.13514378278, 7215.422766178693, 7223.819404514824, 7233.204347521663, 6867.931320686729, 6874.896876546756, 6896.7586134485055, 6900.068490753684, 6907.102076729993, 6639.933600664125, 6767.932320676927, 6776.6950487227205, 6817.386435220854, 6838.179418469816, 7186.0, 7209.0628218331285, 7220.169680486812, 7235.842265237537, 7252.093488313961, 4875.853724388274, 4876.536729010738, 4884.096442158212, 4887.706737595756, 4896.632752543503, 6704.4301234395625, 6879.105716256855, 6889.517733758789, 6896.206936202401, 6990.23107458169, 6790.185177778698, 6804.4896632753735, 6826.0, 6853.93763966586, 6862.828429289308, 6779.864402712017, 6809.489288303298, 6836.316368363124, 6842.7605033823575, 6867.07294515254, 6607.669616519251, 6730.32696730323, 6737.393634572912, 6745.25802161752, 6757.932420675927, 6849.178098627997, 6878.209005964378, 6882.8967565485555, 6883.862322753617, 6890.035395044598, 6677.165354330708, 6680.83297917556, 6705.765298214539, 6712.295209002984, 6714.160729908762], "unit": "score", "name": "prototype.html", "value": 5117.991820924119}, {"lowerIsBetter": false, "replicates": [900.3292547052445, 911.4030310146857, 912.9771755706106, 916.9403988740736, 932.1750251027838, 14834.10995340279, 15138.167400792952, 15144.167070811101, 16920.0, 17043.57391065221, 15157.393704251845, 15263.847361526381, 15344.923275383635, 15392.153431561259, 15522.767158492632, 868.5049521772593, 873.1399571422144, 876.6493402638963, 886.685226744506, 892.1970226795871, 885.026470882031, 885.313881741649, 887.7913690282811, 892.7723430525207, 893.8703887936246, 925.1904583489446, 927.7402327348319, 927.9396839205464, 929.4841363043508, 929.8093890752414, 918.2332752151962, 920.4753290624346, 922.0963455813273, 925.3615005646117, 929.2380248196414, 684.7603338831419, 684.7740245718901, 687.7524091327168, 689.0938415982966, 690.858374033327, 15022.699546009128, 15060.171690557125, 15062.096274223582, 15079.849201507954, 15083.0, 13732.107413018222, 13800.447982080705, 13844.93077534616, 13846.376913038837, 13995.370208340548, 10988.615398461096, 11079.72300692489, 11080.944595277053, 11240.662780116609, 11303.434828258554, 3748.850045998157, 3772.3021241070214, 3791.563970143441, 3830.195658911632, 3838.098046958962, 52895.0, 53306.20040699393, 53497.1975420369, 53875.191872121555, 53948.0, 10731.678049658523, 10803.83794243087, 10877.292975956538, 11256.380899050631, 11492.425378731197, 19097.331593394163, 19102.808971910104, 19269.61460770805, 19283.807161928482, 19321.0, 7948.503213593761, 8052.557109358924, 8160.469569477965, 8226.712065077812, 8273.46222495548, 4381.627561657231, 4388.736675799462, 4407.757573333497, 4497.9325310120375, 4647.512011238771, 3401.3027329397414, 3401.9659803402146, 3416.8974930752115, 3432.4508078707286, 3446.5174875517446, 618.6420806330062, 620.7796232337546, 625.337142628815, 638.4636904999822, 651.6285717141184, 557.8075563930438, 576.3803910795912, 648.4602780954037, 700.6811900585324, 718.9496735228588, 8130.878036829452, 8506.040174881233, 8518.574071296534, 8520.488770673779, 8724.43291186071, 552.0235080747068, 576.4034224577542, 608.4128815692877, 724.2974314914525, 779.3570304498811, 4374.868753937387, 4510.8421205257655, 4524.7511386873375, 4630.58324750774, 4636.436276468252, 63384.04923926145, 63729.36270637234, 64174.35825641777, 64192.0, 64254.357456424834, 55520.0, 55661.721691391285, 57173.42826571681, 57495.0, 57527.424725753044, 49701.50298496969, 50510.0, 50591.747041264556, 50850.237246441335, 51223.48776512262, 9131.543422828965, 9292.814143717223, 9363.892511873019, 9373.625054997723, 9403.623855045995, 35616.0, 35686.821565892, 35830.64169358377, 36366.63633363633, 36389.81805090958, 45118.548814511436, 49205.26192107193, 49477.75261123671, 49854.750726247585, 50124.0, 11179.0, 11419.885801142214, 11454.828177577176, 11556.47995840206, 11643.243189192675, 11505.597304094317, 11624.07007439386, 11640.650780476599, 11795.882041179822, 11879.0, 11979.940100299791, 12283.877161228631, 12362.320072396105, 12769.936150319189, 14063.507777227747, 12392.256464612152, 12574.937125314314, 12754.48982040745, 12913.741725165632, 13137.948964083042, 12872.292023938773, 13011.804822927854, 13049.34753262314, 13215.15947020271, 13875.236861972688, 9900.257480688833, 9920.305578609428, 9976.20190384753, 10294.794104118026, 10372.481375931324, 10592.89407105919, 11004.834927476255, 11058.0, 11193.0, 11318.490667920129], "unit": "score", "name": "yui.html", "value": 6852.207820220012}], "name": "dromaeo_css", "value": 7413.002508900774}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 110.0, 109.0, 110.0, 121.0, 110.0, 109.0, 108.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [153.0, 124.0, 147.0, 167.0, 128.0, 163.0, 155.0, 124.0, 162.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.0}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 161.0, 163.0, 161.0, 161.0, 163.0, 165.0, 164.0], "unit": "score", "name": "audio-dft", "value": 162.5}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 77.0, 154.0, 72.0, 73.0, 72.0, 76.0, 159.0, 75.0], "unit": "score", "name": "audio-fft", "value": 90.8}, {"lowerIsBetter": true, "replicates": [101.0, 96.0, 143.0, 94.0, 95.0, 96.0, 141.0, 94.0, 95.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [149.0, 146.0, 147.0, 147.0, 147.0, 150.0, 147.0, 147.0, 150.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 57.0, 57.0, 57.0, 57.0, 60.0, 62.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 57.0}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 67.0, 65.0, 65.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.3}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 85.0, 84.0, 84.0, 82.0, 82.0, 83.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [112.0, 113.0, 112.0, 112.0, 117.0, 126.0, 117.0, 114.0, 116.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.1}, {"lowerIsBetter": true, "replicates": [140.0, 129.0, 135.0, 140.0, 126.0, 137.0, 138.0, 138.0, 139.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.1}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 65.0, 64.0, 67.0, 65.0, 67.0, 65.0, 66.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.1}], "name": "kraken", "value": 1494.9999999999995}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.80567139282735], "unit": "score", "name": "Richards", "value": 211.6354900000001}, {"lowerIsBetter": false, "replicates": [170.64846416382252], "unit": "score", "name": "DeltaBlue", "value": 387.45148000000006}, {"lowerIsBetter": false, "replicates": [278.55153203342616], "unit": "score", "name": "Encrypt", "value": 955.5897900000004}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [955.1098376313277], "unit": "score", "name": "RayTrace", "value": 774.7684829999998}, {"lowerIsBetter": false, "replicates": [545.5537370430987], "unit": "score", "name": "Earley", "value": 1221.626679}, {"lowerIsBetter": false, "replicates": [11247.191011235955], "unit": "score", "name": "Boyer", "value": 59.25595104895108}, {"lowerIsBetter": false, "replicates": [40180.0], "unit": "score", "name": "RegExp", "value": 22.672598307615722}, {"lowerIsBetter": false, "replicates": [504.2606516290727], "unit": "score", "name": "Splay", "value": 161.6049155069582}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 22022.745040959962}]} 22:28:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "22022.75"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1495.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7413.00"}}} 22:28:39 INFO - Return code: 0 22:28:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:28:39 INFO - # TBPL SUCCESS # 22:28:39 INFO - Running post-action listener: _resource_record_post_action 22:28:39 INFO - Running post-run listener: _resource_record_post_run 22:28:40 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 262144; Write bytes: 509911040; Read time: 20; Write time: 276588 22:28:40 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 239288320; Read time: 0; Write time: 163200 22:28:40 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 262144; Write bytes: 270622720; Read time: 20; Write time: 113388 22:28:40 INFO - Running post-run listener: _upload_blobber_files 22:28:40 INFO - Blob upload gear active. 22:28:40 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:28:40 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:28:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:28:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:28:40 INFO - (blobuploader) - INFO - Open directory for files ... 22:28:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:28:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:28:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:28:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:28:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:28:41 INFO - (blobuploader) - INFO - Done attempting. 22:28:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:28:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:28:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:28:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:28:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:28:42 INFO - (blobuploader) - INFO - Done attempting. 22:28:42 INFO - (blobuploader) - INFO - Iteration through files over. 22:28:42 INFO - Return code: 0 22:28:42 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:28:42 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:28:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/10f051a4c079d16289508b6d04c9567fe35ae4f02beac1df9417e1bf32121f36e105fb7a97092071199a5257be8e9e39757b25f4cb37d632223e953de9727539", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1cf167318545ff3d7587d248e8cc6f5384e0e0ddd2db9754661b24109f0bc700dd9fac335dad3f19accc00acb9a526ab492d1c04d3bc4350606edd82d1f490bf"} 22:28:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:28:42 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:28:42 INFO - Contents: 22:28:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/10f051a4c079d16289508b6d04c9567fe35ae4f02beac1df9417e1bf32121f36e105fb7a97092071199a5257be8e9e39757b25f4cb37d632223e953de9727539", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1cf167318545ff3d7587d248e8cc6f5384e0e0ddd2db9754661b24109f0bc700dd9fac335dad3f19accc00acb9a526ab492d1c04d3bc4350606edd82d1f490bf"} 22:28:42 INFO - Running post-run listener: copy_logs_to_upload_dir 22:28:42 INFO - Copying logs to upload dir... 22:28:42 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:28:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.862997 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-02-02 22:28:42.333307) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-02 22:28:42.336750) ========= 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=03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896 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/10f051a4c079d16289508b6d04c9567fe35ae4f02beac1df9417e1bf32121f36e105fb7a97092071199a5257be8e9e39757b25f4cb37d632223e953de9727539", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1cf167318545ff3d7587d248e8cc6f5384e0e0ddd2db9754661b24109f0bc700dd9fac335dad3f19accc00acb9a526ab492d1c04d3bc4350606edd82d1f490bf"} build_url:https://queue.taskcluster.net/v1/task/A9JWdZQ1SUGWD188G2NSIQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011361 build_url: 'https://queue.taskcluster.net/v1/task/A9JWdZQ1SUGWD188G2NSIQ/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/10f051a4c079d16289508b6d04c9567fe35ae4f02beac1df9417e1bf32121f36e105fb7a97092071199a5257be8e9e39757b25f4cb37d632223e953de9727539", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1cf167318545ff3d7587d248e8cc6f5384e0e0ddd2db9754661b24109f0bc700dd9fac335dad3f19accc00acb9a526ab492d1c04d3bc4350606edd82d1f490bf"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-02 22:28:42.362178) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 22:28:42.362517) ========= 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=03627c79f6bb3d1578c4a402000001ba-1454478796.616081-1018337896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 22:28:42.445172) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-02 22:28:42.445492) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-02 22:28:42.445774) ========= ========= Total master_lag: 0.39 =========