builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-038 starttime: 1455905938.68 results: success (0) buildid: 20160219074815 builduid: 273a8737fb8b4b2aa372f824f463cd21 revision: 97126e4bc6380071750a619dbad4f5d174df2f46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-19 10:18:58.677061) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-19 10:18:58.677489) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-19 10:18:58.677787) ========= 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=8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006798 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-19 10:18:58.700050) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-19 10:18:58.700415) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-19 10:18:58.735679) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 10:18:58.735958) ========= 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=8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004616 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 10:18:58.786538) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-19 10:18:58.786911) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-19 10:18:58.787288) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 10:18:58.787594) ========= 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=8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-19 10:18:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 60.7M=0s 2016-02-19 10:18:59 (60.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.227327 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 10:18:59.027292) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 10:18:59.027582) ========= 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=8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017620 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 10:18:59.077303) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-19 10:18:59.077607) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 97126e4bc6380071750a619dbad4f5d174df2f46 --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 97126e4bc6380071750a619dbad4f5d174df2f46 --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=8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-19 10:18:59,634 truncating revision to first 12 chars 2016-02-19 10:18:59,634 Setting DEBUG logging. 2016-02-19 10:18:59,635 attempt 1/10 2016-02-19 10:18:59,635 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/97126e4bc638?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-19 10:19:00,478 unpacking tar archive at: mozilla-aurora-97126e4bc638/testing/mozharness/ program finished with exit code 0 elapsedTime=1.131171 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-19 10:19:00.220920) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-19 10:19:00.221244) ========= echo 97126e4bc6380071750a619dbad4f5d174df2f46 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'97126e4bc6380071750a619dbad4f5d174df2f46'] 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=8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 97126e4bc6380071750a619dbad4f5d174df2f46 program finished with exit code 0 elapsedTime=0.004151 script_repo_revision: '97126e4bc6380071750a619dbad4f5d174df2f46' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-19 10:19:00.271337) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-19 10:19:00.271639) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-19 10:19:00.281801) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-02-19 10:19:00.282311) ========= /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=8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:19:00 INFO - MultiFileLogger online at 20160219 10:19:00 in /builds/slave/test-pgo 10:19:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:19:00 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:19:00 INFO - {'append_to_log': False, 10:19:00 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:19:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:19:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:19:00 INFO - 'branch': 'Mozilla-Aurora', 10:19:00 INFO - 'buildbot_json_path': 'buildprops.json', 10:19:00 INFO - 'config_files': ('talos/linux_config.py',), 10:19:00 INFO - 'default_actions': ('clobber', 10:19:00 INFO - 'read-buildbot-config', 10:19:00 INFO - 'download-and-extract', 10:19:00 INFO - 'populate-webroot', 10:19:00 INFO - 'create-virtualenv', 10:19:00 INFO - 'install', 10:19:00 INFO - 'run-tests'), 10:19:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:19:00 INFO - 'download_minidump_stackwalk': True, 10:19:00 INFO - 'download_symbols': 'ondemand', 10:19:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:19:00 INFO - 'tooltool.py': '/tools/tooltool.py', 10:19:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:19:00 INFO - '/tools/misc-python/virtualenv.py')}, 10:19:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:19:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:19:00 INFO - 'installer_path': 'installer.exe', 10:19:00 INFO - 'log_level': 'info', 10:19:00 INFO - 'log_name': 'talos', 10:19:00 INFO - 'log_to_console': True, 10:19:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:19:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:19:00 INFO - 'opt_config_files': (), 10:19:00 INFO - 'pip_index': False, 10:19:00 INFO - 'sps_profile': False, 10:19:00 INFO - 'sps_profile_interval': 0, 10:19:00 INFO - 'suite': 'dromaeojs-e10s', 10:19:00 INFO - 'system_bits': '32', 10:19:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:19:00 INFO - 'title': 'talos-linux64-ix-038', 10:19:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:19:00 INFO - 'use_talos_json': True, 10:19:00 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:19:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:19:00 INFO - 'work_dir': 'build'} 10:19:00 INFO - ##### 10:19:00 INFO - ##### Running clobber step. 10:19:00 INFO - ##### 10:19:00 INFO - Running pre-action listener: _resource_record_pre_action 10:19:00 INFO - Running main action method: clobber 10:19:00 INFO - rmtree: /builds/slave/test-pgo/build 10:19:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:19:01 INFO - Running post-action listener: _resource_record_post_action 10:19:01 INFO - ##### 10:19:01 INFO - ##### Running read-buildbot-config step. 10:19:01 INFO - ##### 10:19:01 INFO - Running pre-action listener: _resource_record_pre_action 10:19:01 INFO - Running main action method: read_buildbot_config 10:19:01 INFO - Using buildbot properties: 10:19:01 INFO - { 10:19:01 INFO - "project": "", 10:19:01 INFO - "product": "firefox", 10:19:01 INFO - "script_repo_revision": "production", 10:19:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 10:19:01 INFO - "repository": "", 10:19:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 10:19:01 INFO - "buildid": "20160219074815", 10:19:01 INFO - "pgo_build": "True", 10:19:01 INFO - "basedir": "/builds/slave/test-pgo", 10:19:01 INFO - "buildnumber": 149, 10:19:01 INFO - "slavename": "talos-linux64-ix-038", 10:19:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:19:01 INFO - "platform": "ubuntu64_hw", 10:19:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:19:01 INFO - "branch": "mozilla-aurora", 10:19:01 INFO - "repo_path": "releases/mozilla-aurora", 10:19:01 INFO - "revision": "97126e4bc6380071750a619dbad4f5d174df2f46", 10:19:01 INFO - "stage_platform": "linux64-pgo", 10:19:01 INFO - "builduid": "273a8737fb8b4b2aa372f824f463cd21", 10:19:01 INFO - "slavebuilddir": "test" 10:19:01 INFO - } 10:19:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 10:19:01 INFO - Running post-action listener: _resource_record_post_action 10:19:01 INFO - ##### 10:19:01 INFO - ##### Running download-and-extract step. 10:19:01 INFO - ##### 10:19:01 INFO - Running pre-action listener: _resource_record_pre_action 10:19:01 INFO - Running main action method: download_and_extract 10:19:01 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:01 INFO - https://queue.taskcluster.net/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:19:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/test_packages.json 10:19:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/test_packages.json 10:19:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:19:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:19:02 INFO - Downloaded 1448 bytes. 10:19:02 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:19:02 INFO - Using the following test package requirements: 10:19:02 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 10:19:02 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:19:02 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:19:02 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:19:02 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:19:02 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:19:02 INFO - u'jsshell-linux-x86_64.zip'], 10:19:02 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:19:02 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:19:02 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 10:19:02 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:19:02 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:19:02 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:19:02 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:19:02 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:19:02 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:19:02 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 10:19:02 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 10:19:02 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:19:02 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:02 INFO - https://queue.taskcluster.net/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:19:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 10:19:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 10:19:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 10:19:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:19:04 INFO - Downloaded 23079311 bytes. 10:19:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:19:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 10:19:05 INFO - Return code: 0 10:19:05 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:05 INFO - https://queue.taskcluster.net/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:19:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 10:19:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 10:19:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 10:19:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:19:16 INFO - Downloaded 23079311 bytes. 10:19:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:19:16 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 10:19:17 INFO - Return code: 0 10:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:17 INFO - https://queue.taskcluster.net/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:19:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 10:19:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 10:19:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 10:19:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:19:19 INFO - Downloaded 10706572 bytes. 10:19:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:19:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 10:19:19 INFO - Return code: 0 10:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:19 INFO - https://queue.taskcluster.net/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:19:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 10:19:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 10:19:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 10:19:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:19:20 INFO - Downloaded 59962382 bytes. 10:19:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 10:19:20 INFO - mkdir: /builds/slave/test-pgo/properties 10:19:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:19:20 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:19:20 INFO - Contents: 10:19:20 INFO - build_url:https://queue.taskcluster.net/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 10:19:21 INFO - Running post-action listener: _resource_record_post_action 10:19:21 INFO - Running post-action listener: set_extra_try_arguments 10:19:21 INFO - ##### 10:19:21 INFO - ##### Running populate-webroot step. 10:19:21 INFO - ##### 10:19:21 INFO - Running pre-action listener: _resource_record_pre_action 10:19:21 INFO - Running main action method: populate_webroot 10:19:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:19:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:19:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:19:21 INFO - '--tppagecycles', 10:19:21 INFO - '7'], 10:19:21 INFO - 'tests': ['tsvgm']}}, 10:19:21 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:19:21 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:19:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:19:21 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:19:21 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:19:21 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:19:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:21 INFO - 'talos_options': ['--e10s'], 10:19:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:21 INFO - 'tests': ['damp', 'tps']}, 10:19:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:21 INFO - 'talos_options': ['--e10s'], 10:19:21 INFO - 'tests': ['damp', 'tps']}, 10:19:21 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:19:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:19:21 INFO - 'other': {'tests': ['a11yr', 10:19:21 INFO - 'ts_paint', 10:19:21 INFO - 'tpaint', 10:19:21 INFO - 'sessionrestore', 10:19:21 INFO - 'sessionrestore_no_auto_restore']}, 10:19:21 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:19:21 INFO - 'tests': ['a11yr', 10:19:21 INFO - 'ts_paint', 10:19:21 INFO - 'tpaint', 10:19:21 INFO - 'sessionrestore', 10:19:21 INFO - 'sessionrestore_no_auto_restore']}, 10:19:21 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:19:21 INFO - 'tests': ['a11yr', 10:19:21 INFO - 'ts_paint', 10:19:21 INFO - 'tpaint', 10:19:21 INFO - 'sessionrestore', 10:19:21 INFO - 'sessionrestore_no_auto_restore']}, 10:19:21 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:19:21 INFO - 'tests': ['a11yr', 10:19:21 INFO - 'ts_paint', 10:19:21 INFO - 'tpaint', 10:19:21 INFO - 'sessionrestore', 10:19:21 INFO - 'sessionrestore_no_auto_restore']}, 10:19:21 INFO - 'other_l64': {'tests': ['a11yr', 10:19:21 INFO - 'ts_paint', 10:19:21 INFO - 'tpaint', 10:19:21 INFO - 'sessionrestore', 10:19:21 INFO - 'sessionrestore_no_auto_restore']}, 10:19:21 INFO - 'other_nol64': {'tests': ['a11yr', 10:19:21 INFO - 'ts_paint', 10:19:21 INFO - 'tpaint', 10:19:21 INFO - 'sessionrestore', 10:19:21 INFO - 'sessionrestore_no_auto_restore']}, 10:19:21 INFO - 'svgr': {'tests': ['tsvgx', 10:19:21 INFO - 'tsvgr_opacity', 10:19:21 INFO - 'tart', 10:19:21 INFO - 'tscrollx', 10:19:21 INFO - 'cart']}, 10:19:21 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:19:21 INFO - 'tests': ['tsvgx', 10:19:21 INFO - 'tsvgr_opacity', 10:19:21 INFO - 'tart', 10:19:21 INFO - 'tscrollx', 10:19:21 INFO - 'cart']}, 10:19:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:21 INFO - 'tests': ['tp5o']}, 10:19:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:21 INFO - 'talos_options': ['--e10s'], 10:19:21 INFO - 'tests': ['tp5o']}, 10:19:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:21 INFO - 'talos_options': ['--xperf_path', 10:19:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:21 INFO - 'tests': ['tp5n']}, 10:19:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:21 INFO - 'talos_options': ['--e10s', 10:19:21 INFO - '--xperf_path', 10:19:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:21 INFO - 'tests': ['tp5n']}}, 10:19:21 INFO - 'talos.zip': {'path': '', 10:19:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:19:21 INFO - Running post-action listener: _resource_record_post_action 10:19:21 INFO - ##### 10:19:21 INFO - ##### Running create-virtualenv step. 10:19:21 INFO - ##### 10:19:21 INFO - Running pre-action listener: _resource_record_pre_action 10:19:21 INFO - Running main action method: create_virtualenv 10:19:21 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:19:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 10:19:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:19:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:19:21 INFO - Using real prefix '/usr' 10:19:21 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:19:22 INFO - Installing distribute.............................................................................................................................................................................................done. 10:19:24 INFO - Installing pip.................done. 10:19:24 INFO - Return code: 0 10:19:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:24 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 0x7f35a791ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fc230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e7f0>, '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 0x18fa2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fa760>, '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': '8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:19:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 10:19:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:19:24 INFO - Using env: {'DISPLAY': ':0', 10:19:24 INFO - 'HOME': '/home/cltbld', 10:19:24 INFO - 'LANG': 'en_US.UTF-8', 10:19:24 INFO - 'LANGUAGE': 'en_US:en', 10:19:24 INFO - 'LOGNAME': 'cltbld', 10:19:24 INFO - 'MAIL': '/var/mail/cltbld', 10:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:24 INFO - 'MOZ_NO_REMOTE': '1', 10:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:24 INFO - 'NO_EM_RESTART': '1', 10:19:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:19:24 INFO - 'PWD': '/builds/slave/test-pgo', 10:19:24 INFO - 'SHELL': '/bin/bash', 10:19:24 INFO - 'SHLVL': '1', 10:19:24 INFO - 'TERM': 'linux', 10:19:24 INFO - 'TMOUT': '86400', 10:19:24 INFO - 'USER': 'cltbld', 10:19:24 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639', 10:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:24 INFO - '_': '/tools/buildbot/bin/python'} 10:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:19:24 INFO - Cleaning up... 10:19:24 INFO - Return code: 0 10:19:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:24 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 0x7f35a791ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fc230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e7f0>, '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 0x18fa2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fa760>, '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': '8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:19:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 10:19:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:19:24 INFO - Using env: {'DISPLAY': ':0', 10:19:24 INFO - 'HOME': '/home/cltbld', 10:19:24 INFO - 'LANG': 'en_US.UTF-8', 10:19:24 INFO - 'LANGUAGE': 'en_US:en', 10:19:24 INFO - 'LOGNAME': 'cltbld', 10:19:24 INFO - 'MAIL': '/var/mail/cltbld', 10:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:24 INFO - 'MOZ_NO_REMOTE': '1', 10:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:24 INFO - 'NO_EM_RESTART': '1', 10:19:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:19:24 INFO - 'PWD': '/builds/slave/test-pgo', 10:19:24 INFO - 'SHELL': '/bin/bash', 10:19:24 INFO - 'SHLVL': '1', 10:19:24 INFO - 'TERM': 'linux', 10:19:24 INFO - 'TMOUT': '86400', 10:19:24 INFO - 'USER': 'cltbld', 10:19:24 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639', 10:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:24 INFO - '_': '/tools/buildbot/bin/python'} 10:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:24 INFO - Downloading/unpacking psutil>=0.7.1 10:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:19:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:19:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:19:26 INFO - Installing collected packages: psutil 10:19:26 INFO - Running setup.py install for psutil 10:19:26 INFO - building 'psutil._psutil_linux' extension 10:19:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:19:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:19:26 INFO - building 'psutil._psutil_posix' extension 10:19:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:19:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:19:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:19:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:19:27 INFO - Successfully installed psutil 10:19:27 INFO - Cleaning up... 10:19:27 INFO - Return code: 0 10:19:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:27 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f35a791ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fc230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e7f0>, '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 0x18fa2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fa760>, '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': '8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:19:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:19:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:19:27 INFO - Using env: {'DISPLAY': ':0', 10:19:27 INFO - 'HOME': '/home/cltbld', 10:19:27 INFO - 'LANG': 'en_US.UTF-8', 10:19:27 INFO - 'LANGUAGE': 'en_US:en', 10:19:27 INFO - 'LOGNAME': 'cltbld', 10:19:27 INFO - 'MAIL': '/var/mail/cltbld', 10:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:27 INFO - 'MOZ_NO_REMOTE': '1', 10:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:27 INFO - 'NO_EM_RESTART': '1', 10:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:19:27 INFO - 'PWD': '/builds/slave/test-pgo', 10:19:27 INFO - 'SHELL': '/bin/bash', 10:19:27 INFO - 'SHLVL': '1', 10:19:27 INFO - 'TERM': 'linux', 10:19:27 INFO - 'TMOUT': '86400', 10:19:27 INFO - 'USER': 'cltbld', 10:19:27 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639', 10:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:27 INFO - '_': '/tools/buildbot/bin/python'} 10:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:19:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:19:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:19:29 INFO - Installing collected packages: mozsystemmonitor 10:19:29 INFO - Running setup.py install for mozsystemmonitor 10:19:29 INFO - Successfully installed mozsystemmonitor 10:19:29 INFO - Cleaning up... 10:19:29 INFO - Return code: 0 10:19:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f35a791ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fc230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e7f0>, '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 0x18fa2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fa760>, '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': '8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:19:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 10:19:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:19:29 INFO - Using env: {'DISPLAY': ':0', 10:19:29 INFO - 'HOME': '/home/cltbld', 10:19:29 INFO - 'LANG': 'en_US.UTF-8', 10:19:29 INFO - 'LANGUAGE': 'en_US:en', 10:19:29 INFO - 'LOGNAME': 'cltbld', 10:19:29 INFO - 'MAIL': '/var/mail/cltbld', 10:19:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:29 INFO - 'MOZ_NO_REMOTE': '1', 10:19:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:29 INFO - 'NO_EM_RESTART': '1', 10:19:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:19:29 INFO - 'PWD': '/builds/slave/test-pgo', 10:19:29 INFO - 'SHELL': '/bin/bash', 10:19:29 INFO - 'SHLVL': '1', 10:19:29 INFO - 'TERM': 'linux', 10:19:29 INFO - 'TMOUT': '86400', 10:19:29 INFO - 'USER': 'cltbld', 10:19:29 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639', 10:19:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:29 INFO - '_': '/tools/buildbot/bin/python'} 10:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:29 INFO - Downloading/unpacking blobuploader==1.2.4 10:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:31 INFO - Downloading blobuploader-1.2.4.tar.gz 10:19:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:19:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:19:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:32 INFO - Downloading docopt-0.6.1.tar.gz 10:19:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:19:32 INFO - Installing collected packages: blobuploader, requests, docopt 10:19:32 INFO - Running setup.py install for blobuploader 10:19:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:19:32 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:19:32 INFO - Running setup.py install for requests 10:19:32 INFO - Running setup.py install for docopt 10:19:32 INFO - Successfully installed blobuploader requests docopt 10:19:32 INFO - Cleaning up... 10:19:32 INFO - Return code: 0 10:19:32 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:32 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 0x7f35a791ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fc230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e7f0>, '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 0x18fa2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fa760>, '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': '8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:19:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 10:19:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:19:32 INFO - Using env: {'DISPLAY': ':0', 10:19:32 INFO - 'HOME': '/home/cltbld', 10:19:32 INFO - 'LANG': 'en_US.UTF-8', 10:19:32 INFO - 'LANGUAGE': 'en_US:en', 10:19:32 INFO - 'LOGNAME': 'cltbld', 10:19:32 INFO - 'MAIL': '/var/mail/cltbld', 10:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:32 INFO - 'MOZ_NO_REMOTE': '1', 10:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:32 INFO - 'NO_EM_RESTART': '1', 10:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:19:32 INFO - 'PWD': '/builds/slave/test-pgo', 10:19:32 INFO - 'SHELL': '/bin/bash', 10:19:32 INFO - 'SHLVL': '1', 10:19:32 INFO - 'TERM': 'linux', 10:19:32 INFO - 'TMOUT': '86400', 10:19:32 INFO - 'USER': 'cltbld', 10:19:32 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639', 10:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:32 INFO - '_': '/tools/buildbot/bin/python'} 10:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:19:32 INFO - Running setup.py (path:/tmp/pip-2pBmhu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:19:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:19:33 INFO - Running setup.py (path:/tmp/pip-ghrOQ2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:19:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:19:33 INFO - Running setup.py (path:/tmp/pip-pjR7eR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:19:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:19:33 INFO - Running setup.py (path:/tmp/pip-jSUYbm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:19:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:19:33 INFO - Running setup.py (path:/tmp/pip-dDNHwW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:19:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:19:33 INFO - Running setup.py (path:/tmp/pip-Hx8PhE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:19:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:19:33 INFO - Running setup.py (path:/tmp/pip-tM4WaS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:19:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:19:33 INFO - Running setup.py (path:/tmp/pip-lUeuA_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:19:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:19:33 INFO - Running setup.py (path:/tmp/pip-SxXr3q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:19:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:19:33 INFO - Running setup.py (path:/tmp/pip-BTFivE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:19:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:19:33 INFO - Running setup.py (path:/tmp/pip-HqeVut-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:19:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:19:33 INFO - Running setup.py (path:/tmp/pip-ouBQNk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:19:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:19:33 INFO - Running setup.py (path:/tmp/pip-iVzUOn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:19:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:19:33 INFO - Running setup.py (path:/tmp/pip-2suXDC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:19:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:19:33 INFO - Running setup.py (path:/tmp/pip-33JIqN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:19:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:19:34 INFO - Running setup.py (path:/tmp/pip-ATIV62-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:19:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:19:34 INFO - Running setup.py (path:/tmp/pip-JD6bXR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:19:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:19:34 INFO - Running setup.py install for manifestparser 10:19:34 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:19:34 INFO - Running setup.py install for mozcrash 10:19:34 INFO - Running setup.py install for mozdebug 10:19:34 INFO - Running setup.py install for mozdevice 10:19:34 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:19:34 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:19:34 INFO - Running setup.py install for mozfile 10:19:34 INFO - Running setup.py install for mozhttpd 10:19:34 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:19:34 INFO - Running setup.py install for mozinfo 10:19:34 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:19:34 INFO - Running setup.py install for mozInstall 10:19:34 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:19:34 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:19:34 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:19:34 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:19:34 INFO - Running setup.py install for mozleak 10:19:35 INFO - Running setup.py install for mozlog 10:19:35 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:19:35 INFO - Running setup.py install for moznetwork 10:19:35 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:19:35 INFO - Running setup.py install for mozprocess 10:19:35 INFO - Running setup.py install for mozprofile 10:19:35 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:19:35 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:19:35 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:19:35 INFO - Running setup.py install for mozrunner 10:19:35 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:19:35 INFO - Running setup.py install for mozscreenshot 10:19:35 INFO - Running setup.py install for moztest 10:19:35 INFO - Running setup.py install for mozversion 10:19:35 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:19:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:19:35 INFO - Cleaning up... 10:19:35 INFO - Return code: 0 10:19:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:19:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:35 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 0x7f35a791ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fc230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e7f0>, '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 0x18fa2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fa760>, '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': '8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:19:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 10:19:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:19:35 INFO - Using env: {'DISPLAY': ':0', 10:19:35 INFO - 'HOME': '/home/cltbld', 10:19:35 INFO - 'LANG': 'en_US.UTF-8', 10:19:35 INFO - 'LANGUAGE': 'en_US:en', 10:19:35 INFO - 'LOGNAME': 'cltbld', 10:19:35 INFO - 'MAIL': '/var/mail/cltbld', 10:19:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:35 INFO - 'MOZ_NO_REMOTE': '1', 10:19:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:35 INFO - 'NO_EM_RESTART': '1', 10:19:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:19:35 INFO - 'PWD': '/builds/slave/test-pgo', 10:19:35 INFO - 'SHELL': '/bin/bash', 10:19:35 INFO - 'SHLVL': '1', 10:19:35 INFO - 'TERM': 'linux', 10:19:35 INFO - 'TMOUT': '86400', 10:19:35 INFO - 'USER': 'cltbld', 10:19:35 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639', 10:19:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:35 INFO - '_': '/tools/buildbot/bin/python'} 10:19:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:19:36 INFO - Running setup.py (path:/tmp/pip-lLPe6m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 10:19:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:19:36 INFO - Running setup.py (path:/tmp/pip-eWUJpL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:19:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:19:36 INFO - Running setup.py (path:/tmp/pip-ivIvLU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 10:19:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:19:36 INFO - Running setup.py (path:/tmp/pip-8pf3xh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:19:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:19:36 INFO - Running setup.py (path:/tmp/pip-ALTTwa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 10:19:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:19:36 INFO - Running setup.py (path:/tmp/pip-0EuxQ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 10:19:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:19:36 INFO - Running setup.py (path:/tmp/pip-_oujfJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 10:19:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:19:36 INFO - Running setup.py (path:/tmp/pip-6vLPN0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 10:19:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:19:36 INFO - Running setup.py (path:/tmp/pip-CEf4uq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 10:19:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:19:36 INFO - Running setup.py (path:/tmp/pip-tZhlaQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:19:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:19:36 INFO - Running setup.py (path:/tmp/pip-WLGtJA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 10:19:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:19:36 INFO - Running setup.py (path:/tmp/pip-5WRGOQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 10:19:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:19:37 INFO - Running setup.py (path:/tmp/pip-puueBz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 10:19:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:19:37 INFO - Running setup.py (path:/tmp/pip-QX21yg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 10:19:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:19:37 INFO - Running setup.py (path:/tmp/pip-KI6f59-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 10:19:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:19:37 INFO - Running setup.py (path:/tmp/pip-4neDVD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 10:19:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:19:37 INFO - Running setup.py (path:/tmp/pip-gCSFSZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 10:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 10:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:19:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:39 INFO - Downloading blessings-1.6.tar.gz 10:19:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:19:39 INFO - Installing collected packages: blessings 10:19:39 INFO - Running setup.py install for blessings 10:19:39 INFO - Successfully installed blessings 10:19:39 INFO - Cleaning up... 10:19:39 INFO - Return code: 0 10:19:39 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:19:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:19:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:19:39 INFO - Reading from file tmpfile_stdout 10:19:39 INFO - Current package versions: 10:19:39 INFO - argparse == 1.2.1 10:19:39 INFO - blessings == 1.6 10:19:39 INFO - blobuploader == 1.2.4 10:19:39 INFO - docopt == 0.6.1 10:19:39 INFO - manifestparser == 1.1 10:19:39 INFO - mozInstall == 1.12 10:19:39 INFO - mozcrash == 0.16 10:19:39 INFO - mozdebug == 0.1 10:19:39 INFO - mozdevice == 0.48 10:19:39 INFO - mozfile == 1.2 10:19:39 INFO - mozhttpd == 0.7 10:19:39 INFO - mozinfo == 0.9 10:19:39 INFO - mozleak == 0.1 10:19:39 INFO - mozlog == 3.1 10:19:39 INFO - moznetwork == 0.27 10:19:39 INFO - mozprocess == 0.22 10:19:39 INFO - mozprofile == 0.28 10:19:39 INFO - mozrunner == 6.11 10:19:39 INFO - mozscreenshot == 0.1 10:19:39 INFO - mozsystemmonitor == 0.0 10:19:39 INFO - moztest == 0.7 10:19:39 INFO - mozversion == 1.4 10:19:39 INFO - psutil == 3.1.1 10:19:39 INFO - requests == 1.2.3 10:19:39 INFO - wsgiref == 0.1.2 10:19:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:19:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f35a791ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fc230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e7f0>, '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 0x18fa2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fa760>, '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': '8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:19:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 10:19:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:19:39 INFO - Using env: {'DISPLAY': ':0', 10:19:39 INFO - 'HOME': '/home/cltbld', 10:19:39 INFO - 'LANG': 'en_US.UTF-8', 10:19:39 INFO - 'LANGUAGE': 'en_US:en', 10:19:39 INFO - 'LOGNAME': 'cltbld', 10:19:39 INFO - 'MAIL': '/var/mail/cltbld', 10:19:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:39 INFO - 'MOZ_NO_REMOTE': '1', 10:19:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:39 INFO - 'NO_EM_RESTART': '1', 10:19:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:19:39 INFO - 'PWD': '/builds/slave/test-pgo', 10:19:39 INFO - 'SHELL': '/bin/bash', 10:19:39 INFO - 'SHLVL': '1', 10:19:39 INFO - 'TERM': 'linux', 10:19:39 INFO - 'TMOUT': '86400', 10:19:39 INFO - 'USER': 'cltbld', 10:19:39 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639', 10:19:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:39 INFO - '_': '/tools/buildbot/bin/python'} 10:19:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 10:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 10:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 10:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 10:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 10:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 10:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 10:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 10:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 10:19:39 INFO - Cleaning up... 10:19:39 INFO - Return code: 0 10:19:39 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:19:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:39 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 0x7f35a791ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fc230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e7f0>, '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 0x18fa2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fa760>, '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': '8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:19:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 10:19:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:19:39 INFO - Using env: {'DISPLAY': ':0', 10:19:39 INFO - 'HOME': '/home/cltbld', 10:19:39 INFO - 'LANG': 'en_US.UTF-8', 10:19:39 INFO - 'LANGUAGE': 'en_US:en', 10:19:39 INFO - 'LOGNAME': 'cltbld', 10:19:39 INFO - 'MAIL': '/var/mail/cltbld', 10:19:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:39 INFO - 'MOZ_NO_REMOTE': '1', 10:19:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:39 INFO - 'NO_EM_RESTART': '1', 10:19:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:19:39 INFO - 'PWD': '/builds/slave/test-pgo', 10:19:39 INFO - 'SHELL': '/bin/bash', 10:19:39 INFO - 'SHLVL': '1', 10:19:39 INFO - 'TERM': 'linux', 10:19:39 INFO - 'TMOUT': '86400', 10:19:39 INFO - 'USER': 'cltbld', 10:19:39 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639', 10:19:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:39 INFO - '_': '/tools/buildbot/bin/python'} 10:19:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:40 INFO - Downloading/unpacking jsonschema 10:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:19:41 INFO - Downloading/unpacking functools32 (from jsonschema) 10:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:42 INFO - Downloading functools32-3.2.3-2.tar.gz 10:19:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:19:42 INFO - warning: no files found matching '*.txt' 10:19:42 INFO - no previously-included directories found matching 'build' 10:19:42 INFO - no previously-included directories found matching 'dist' 10:19:42 INFO - no previously-included directories found matching '.git*' 10:19:42 INFO - Installing collected packages: jsonschema, functools32 10:19:42 INFO - Running setup.py install for functools32 10:19:42 INFO - warning: no files found matching '*.txt' 10:19:42 INFO - no previously-included directories found matching 'build' 10:19:42 INFO - no previously-included directories found matching 'dist' 10:19:42 INFO - no previously-included directories found matching '.git*' 10:19:42 INFO - Successfully installed jsonschema functools32 10:19:42 INFO - Cleaning up... 10:19:42 INFO - Return code: 0 10:19:42 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:42 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 0x7f35a791ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fc230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198e7f0>, '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 0x18fa2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fa760>, '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': '8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:19:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 10:19:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:19:42 INFO - Using env: {'DISPLAY': ':0', 10:19:42 INFO - 'HOME': '/home/cltbld', 10:19:42 INFO - 'LANG': 'en_US.UTF-8', 10:19:42 INFO - 'LANGUAGE': 'en_US:en', 10:19:42 INFO - 'LOGNAME': 'cltbld', 10:19:42 INFO - 'MAIL': '/var/mail/cltbld', 10:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:42 INFO - 'MOZ_NO_REMOTE': '1', 10:19:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:42 INFO - 'NO_EM_RESTART': '1', 10:19:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:19:42 INFO - 'PWD': '/builds/slave/test-pgo', 10:19:42 INFO - 'SHELL': '/bin/bash', 10:19:42 INFO - 'SHLVL': '1', 10:19:42 INFO - 'TERM': 'linux', 10:19:42 INFO - 'TMOUT': '86400', 10:19:42 INFO - 'USER': 'cltbld', 10:19:42 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639', 10:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:42 INFO - '_': '/tools/buildbot/bin/python'} 10:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:42 INFO - Downloading/unpacking flake8 10:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:19:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:19:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:19:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:19:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:19:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:19:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:19:45 INFO - no previously-included directories found matching 'docs/_build' 10:19:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:19:45 INFO - Running setup.py install for pep8 10:19:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:19:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:19:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:19:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:19:45 INFO - no previously-included directories found matching 'docs/_build' 10:19:45 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:19:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:19:45 INFO - Cleaning up... 10:19:45 INFO - Return code: 0 10:19:45 INFO - Running post-action listener: _resource_record_post_action 10:19:45 INFO - Running post-action listener: _start_resource_monitoring 10:19:45 INFO - Starting resource monitoring. 10:19:45 INFO - ##### 10:19:45 INFO - ##### Running install step. 10:19:45 INFO - ##### 10:19:45 INFO - Running pre-action listener: _resource_record_pre_action 10:19:45 INFO - Running main action method: install 10:19:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:19:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:19:45 INFO - Reading from file tmpfile_stdout 10:19:45 INFO - Detecting whether we're running mozinstall >=1.0... 10:19:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:19:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:19:45 INFO - Reading from file tmpfile_stdout 10:19:45 INFO - Output received: 10:19:45 INFO - Usage: mozinstall [options] installer 10:19:45 INFO - Options: 10:19:45 INFO - -h, --help show this help message and exit 10:19:45 INFO - -d DEST, --destination=DEST 10:19:45 INFO - Directory to install application into. [default: 10:19:45 INFO - "/builds/slave/test-pgo"] 10:19:45 INFO - --app=APP Application being installed. [default: firefox] 10:19:45 INFO - mkdir: /builds/slave/test-pgo/build/application 10:19:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 10:19:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 10:20:01 INFO - Reading from file tmpfile_stdout 10:20:01 INFO - Output received: 10:20:01 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:20:01 INFO - Running post-action listener: _resource_record_post_action 10:20:01 INFO - ##### 10:20:01 INFO - ##### Running run-tests step. 10:20:01 INFO - ##### 10:20:01 INFO - Running pre-action listener: _resource_record_pre_action 10:20:01 INFO - Running main action method: run_tests 10:20:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:20:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:20:01 INFO - Python 2.7.3 10:20:01 INFO - Return code: 0 10:20:01 INFO - grabbing minidump binary from tooltool 10:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:20:01 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 0x198e7f0>, '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 0x18fa2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18fa760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:20:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 10:20:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:20:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:20:01 INFO - Return code: 0 10:20:01 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:20:01 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:20:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:20:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:20:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:20:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:20:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:20:02 INFO - Return code: 0 10:20:02 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/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 10:20:02 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/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:20:02 INFO - Using env: {'DISPLAY': ':0', 10:20:02 INFO - 'HOME': '/home/cltbld', 10:20:02 INFO - 'LANG': 'en_US.UTF-8', 10:20:02 INFO - 'LANGUAGE': 'en_US:en', 10:20:02 INFO - 'LOGNAME': 'cltbld', 10:20:02 INFO - 'MAIL': '/var/mail/cltbld', 10:20:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:20:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:02 INFO - 'MOZ_NO_REMOTE': '1', 10:20:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:02 INFO - 'NO_EM_RESTART': '1', 10:20:02 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:20:02 INFO - 'PWD': '/builds/slave/test-pgo', 10:20:02 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:20:02 INFO - 'SHELL': '/bin/bash', 10:20:02 INFO - 'SHLVL': '1', 10:20:02 INFO - 'TERM': 'linux', 10:20:02 INFO - 'TMOUT': '86400', 10:20:02 INFO - 'USER': 'cltbld', 10:20:02 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639', 10:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:02 INFO - '_': '/tools/buildbot/bin/python'} 10:20:02 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/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:20:03 INFO - mozversion application_buildid: 20160219074815 10:20:03 INFO - mozversion application_changeset: 97126e4bc6380071750a619dbad4f5d174df2f46 10:20:03 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:20:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:20:03 INFO - mozversion application_name: Firefox 10:20:03 INFO - mozversion application_remotingname: firefox-dev 10:20:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:20:03 INFO - mozversion application_vendor: Mozilla 10:20:03 INFO - mozversion application_version: 46.0a2 10:20:03 INFO - mozversion platform_buildid: 20160219074815 10:20:03 INFO - mozversion platform_changeset: 97126e4bc6380071750a619dbad4f5d174df2f46 10:20:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:20:03 INFO - mozversion platform_version: 46.0a2 10:20:03 INFO - using testdate: 1455906003 10:20:03 INFO - actual date: 1455906003 10:20:03 INFO - starting webserver on 'localhost:49108' 10:20:03 INFO - SUITE-START | Running 3 tests 10:20:03 INFO - TEST-START | dromaeo_css 10:20:03 INFO - operating with platform_type : linux_ 10:20:03 INFO - Initialising browser for dromaeo_css test... 10:20:03 INFO - TEST-INFO | started process 28248 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuqaazw/profile http://localhost:49108/getInfo.html) 10:20:07 INFO - PROCESS | 28248 | 10:20:07 INFO - PROCESS | 28248 | (process:28329): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:20:08 INFO - PROCESS | 28248 | __metrics Screen width/height:1600/1200 10:20:08 INFO - PROCESS | 28248 | colorDepth:24 10:20:08 INFO - PROCESS | 28248 | Browser inner width/height: 1024/697 10:20:08 INFO - PROCESS | 28248 | __metrics 10:20:09 INFO - TEST-INFO | 28248: exit 0 10:20:09 INFO - Browser initialized. 10:20:09 INFO - Running cycle 1/1 for dromaeo_css test... 10:20:09 INFO - TEST-INFO | started process 28378 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuqaazw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:20:10 INFO - PROCESS | 28378 | 10:20:10 INFO - PROCESS | 28378 | (process:28442): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:20:21 INFO - PROCESS | 28378 | RSS: Main: 140787712 10:20:21 INFO - PROCESS | 28378 | 10:21:10 INFO - PROCESS | 28378 | 1455906070884 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:23:19 INFO - PROCESS | 28378 | Cycle 1(1): loaded http://localhost:49108/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49108/tests/dromaeo/cssquery-ext.html) 10:23:20 INFO - PROCESS | 28378 | RSS: Main: 144703488 10:23:20 INFO - PROCESS | 28378 | 10:26:22 INFO - PROCESS | 28378 | Cycle 1(1): loaded http://localhost:49108/tests/dromaeo/cssquery-ext.html (next: http://localhost:49108/tests/dromaeo/cssquery-jquery.html) 10:26:22 INFO - PROCESS | 28378 | RSS: Main: 144142336 10:26:22 INFO - PROCESS | 28378 | 10:29:24 INFO - PROCESS | 28378 | Cycle 1(1): loaded http://localhost:49108/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49108/tests/dromaeo/cssquery-mootools.html) 10:29:25 INFO - PROCESS | 28378 | RSS: Main: 143560704 10:29:25 INFO - PROCESS | 28378 | 10:32:26 INFO - PROCESS | 28378 | Cycle 1(1): loaded http://localhost:49108/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49108/tests/dromaeo/cssquery-prototype.html) 10:32:27 INFO - PROCESS | 28378 | RSS: Main: 143753216 10:32:27 INFO - PROCESS | 28378 | 10:35:29 INFO - PROCESS | 28378 | Cycle 1(1): loaded http://localhost:49108/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49108/tests/dromaeo/cssquery-yui.html) 10:35:30 INFO - PROCESS | 28378 | RSS: Main: 143523840 10:35:30 INFO - PROCESS | 28378 | 10:38:32 INFO - PROCESS | 28378 | Cycle 1(1): loaded http://localhost:49108/tests/dromaeo/cssquery-yui.html (next: http://localhost:49108/tests/dromaeo/cssquery-dojo.html) 10:38:32 INFO - PROCESS | 28378 | RSS: Main: 145633280 10:38:32 INFO - PROCESS | 28378 | 10:38:32 INFO - PROCESS | 28378 | __start_tp_report 10:38:32 INFO - PROCESS | 28378 | _x_x_mozilla_page_load 10:38:32 INFO - PROCESS | 28378 | _x_x_mozilla_page_load_details 10:38:32 INFO - PROCESS | 28378 | |i|pagename|runs| 10:38:32 INFO - PROCESS | 28378 | |0;dojo.html;3410.7441941854363;3429.5370125033114;3434.965650343496;3456.0668619472726;3469.5663042119745;5600.299962504687;5625.859353516164;5652.4912757851735;5660.830175094743;5674.404187560303;5608.6073974821775;5660.264165658458;5663.150527420889;5666.490015898568;5669.659820410779;5128.153854613985;5168.870778230536;5224.242484839696;5252.185911183773;5270.578353731711;5063.74681265937;5169.896602067956;5187.533122019017;5192.532672059514;5257.053730328539;5232.869178270555;5233.2150177473495;5287.894242115155;5288.735563221823;5291.576673866081;5207.687538747668;5220.973895130538;5223.555997740196;5224.555912747421;5269.130593452076;5032.6980381177245;5035.320231768701;5044.646874718771;5119.180931051014;5140.3060586820675;5383;5431.185322201662;5454.263674403945;5456.590755693339;5488.039593071197;6075.058365953284;6076.240469941257;6107.908381374283;6125.969370153165;6177.289611694668;5969.850753731148;6016.78941237059;6093.512518998469;6134.19168101403;6175.197224360849;5765.279340082448;5768.3654797972185;5768.769249230026;5769;5772.682502462363;6253.906191407133;6264.843378915472;6268.811935641938;6271.310155882849;6279.3720627937755;5885.205497257901;5896.262967129109;6044.8186554402555;6087.147799308101;6131.908021379683;6051.878962420727;6077.453029227391;6085.878282434326;6097.908531372033;6106.816795496142;5937.435943585352;6012.30858451275;6064.272287325549;6064.605800622945;6070.028795392716;6013.128096425994;6099.695015249308;6109.6673337913735;6155.353687862799;6157.076438534166;4590.380298659705;4604.677672562955;4610.561996610317;4617.492075871652;4624.421947256593;4089.345704687236;4150.501939767187;4155.127423241153;4155.2728272552185;4164.68764842638;5623;5756.481916627524;5759.366469688331;5805.477507024304;5860.150278209636;6140.109684095781;6141.07883817422;6146.139540464339;6150.938490615126;6152.384761523812;5619.578531610064;5631.155326701028;5728.513076388554;5760.337561180518;5771.740271687784;5184.403793563789;5234.241035049897;5236.319278493771;5239.554637855825;5263.552598029134;6244.500439964792;6253.5622506424115;6257.405546473078;6259.342769009279;6262.499000079983;6048.304444988883;6048.758049677964;6071.058985857199;6141.815745527641;6158.199434073631;6197.96901015492;6219.067139928866;6248.562600617913;6250.843728906813;6265.718042688181;5985.730642121202;5988.910166347596;5989.131575921379;6000.399960004139;6075.483583895241;6010.068439391901;6010.068439391901;6046.455818976313;6100.511959043177;6131.468419844996;5969.970150149222;5984.760609575743;5995.250593675791;6003.3996600339615;6010.248718910137;5958.433948774859;5961.821145365646;5981.043033114681;5984.251968503937;5993.820185394445;5760.567957403127;5818.4763371296785;5890.617109887844;5960.910586341295;6005;5830.47525722687;5916.526677865846;5918.7928422505;5941.1088336749835;5943.167956486009;5794.101914203306;5813.680247586423;5823.563232757476;5824.534037276923;5833.82498525045 10:38:32 INFO - PROCESS | 28378 | |1;ext.html;559.3651205881325;565.8217661436647;581.3808294166711;584.9707514624267;597.3638075449646;32962.34075318498;33072.5039124413;33603;33660.831695841516;33673.831630841814;44865.77567112168;45215.321770173476;45533.08933821321;45613.31580026294;45713.54286457135;8931.821363572724;9087.681931132413;9099.04460031697;9131.0412406697;9142.954285228598;8808.735737927873;8942.882139732534;8969.910300897005;8996.100389961017;9003;9012.909870901305;9038.141376569216;9056.501892395916;9122.133397327243;9139.588718507683;8894.510801905924;8992.730218093468;9002.594883230206;9029.0519495453;9038.86441703375;8721.345899057533;8748.431351962103;8825.470471771714;8840.33697472692;8898.688545900926;41746;42076;42223.788881055705;42309.78845105786;42313.365299520534;3241.9027429177163;3671.4125739881492;3696.7597106188014;3749.1751814601016;3984.920301593981;30361.848190759127;30957;31332;31372.686273137206;31444.21389465259;4222.366645003243;4368.584984426474;4389.648828093745;4391.341298805173;4392.560743925614;239867;241369;242164;242270;242574;55041;55738.72130639402;57358.42641573615;61536.69231653813;62348;54095.72952135214;54223.45776542263;54404.45595543994;54522.18216726752;54531.72734136383;15385.846141538665;15553.922230389002;15586.688266234612;15598.610034748996;15604;10965.725856853642;11008.669739907815;11014.889851101547;11034.503447344889;11065.446727663584;20016.2994295199;20473.385798426072;20538.38384848457;20547.897260513902;20717.89641051815;7813.179616140337;7979.760607181794;8029.156938521488;8047.919520804834;8166.1833816619055;1039.667306461925;1070.1652710885521;1070.6520380876245;1082.695169399766;1262.5265525427965;30240.395192096035;30351.848240759096;30905.536416953764;30989.380212395627;31048.379032419678;1130.739929816147;1148.0643275730254;1173.143605168232;1206.8069108942527;1297.2087026913575;15802.288896999662;15891.443799466962;15933.123678197579;16089.195540222941;16278.75581866273;335822;348536;351215;351835;351836;51773.223401649004;51935;52107;52262;52409.47590524122;1425.030978934314;1429.0354011042505;1436.2316160854102;1442.02663202338;1450.2966061460183;29292.70707292985;30371;30373.507046689912;30630.846845765627;31442.842785785924;44817.77591112023;45015.324770127816;45082.54917450783;45096.77451612721;45313;267454;272658;273049;273529;274420;33239.50140747843;33388.66611333856;33577.16057098592;33650.32699346048;48987.75506122447;47406.28890566575;47828.28257576209;48008;48017.75991120162;48798.51201488082;41566.58433415748;42894.78552607217;43139;44787;45320.32019519776;39923.40114898337;40622.59377406188;40895.591044089175;42808.35787463253;44883.55116448925;42379.364309535995;43062.35406468843;43251.35122973095;43614.78192609017;43639.56360436355;37052.44421333628;37361.31006154002;37440.812795935846;38242.808785955895;38581.228375431776;28563.857180713963;29279.707202927697;29507;29861.850690746407;29975.55036674408 10:38:32 INFO - PROCESS | 28378 | |2;jquery.html;386.9632384923431;396.59349167103716;399.2175336340772;399.5804405374357;402.83982131461386;17776.733348999776;18216.635667286664;18344.174512146936;18609.90695046526;18922.33771817985;16176.35294588218;16203.432879849208;16302.347906083773;16723.331066757317;16817.579560510992;5215.478452154783;5401.081816091274;5418.078926582471;5419.187121931703;5422.105352616833;5173.379194496647;5269.6311258211945;5287.629865909388;5321.4412486688725;5327.627066105374;5297.973510132444;5333.653312534692;5387.919181212285;5530.640508366963;5580.86047848803;4999.975000124994;5364.168553874156;5539.41836107211;5584.944150558483;5625.80309689161;5103.311053007834;5365.812196573102;5386.3536375634785;5387.461253874581;5407.026735187665;12891.35543222835;13023.739525209538;13272.933635331858;13324.333783310893;13343.332083489564;2189.7372315322264;2224.143704673696;2247.078697733921;2321.651752237161;2356.5286942611547;9503.144716975436;9635.277354198393;9738.90261097394;9784.168345690625;9854.556544955423;1921.193098898466;1946.6787979983428;1948.7466629338237;1981.8414526837962;1986.801319868016;59147.704261478844;60638.69680651613;61006;61211;62598.37401626017;10173.338732982333;10594.682159535227;10804.567817287378;10824.404657743742;10852.45737713127;14056.297185140702;14101.083429577046;14139.64650883736;14159.78760318596;14289.356978935974;7552.622368881534;7585.6965721371635;7605.277498637621;7611.961940190264;7654.655540500691;7122.821929451805;7278.708851645875;7301;7337.046183996046;7338.596377199198;4582.037772067836;4699.083678682692;4713.599344055725;4731.124741922756;4755.690880092783;1904.6381187574316;1918.168149417303;1954.6383918975034;1985.2852972929734;1986.1261045140093;478.46650984153115;951.5908159491347;1004.6584161385164;1011.0688584802991;1140.5836869542557;10849.620263290904;11299.152563557765;11312.773744525228;11347.092232621371;11413;493.9678920870132;501.5461007787958;522.681164489661;523.2961666558473;527.7282199667175;6213.099100630383;6490.902636460457;6494.707738151795;6515.706793194223;6521.771737989147;416639;418728;561061;563350;564896;48088.27867581989;48835.267470987965;61993;72548.63725681338;79623.60188199022;1167.3404526442532;1198.4367347346733;1212.1575505023923;1213.7754515414676;1220.725336799213;15759.13324767103;15967.600809979844;16062.357505699641;16126.113063781135;16240.18799060066;33833.323333533684;33844.661553384154;34508.65491345155;34788.652113479555;35205.295894081464;44276.33585496156;44944.32583511315;47433.762831185624;51638.48361516487;53986.19020714771;9477.620895164117;10262.179025677779;10514.474276286002;10656.733581660521;11020.44897755125;6834.043233947152;11952.103592230791;12140.757184856076;12308.81536776967;12372.62882113538;7005.894911576229;7743.6515356810205;7801.336886364723;7984.24149705777;8148.877766833383;7317.2316906726155;7947.086085100056;8057;8062.677492900453;8174.7956301092945;7913.327367173854;7949.205079492004;8207.794805129919;8264.132266112212;8321.500709957421;11055.94472027667;11098.2786118902;11099.167562433011;11174.497147628213;11303.7739245213;10812.189085818753;11327.830082548604;11341.09271258281;11478.253913495597;11658.242214256046 10:38:32 INFO - PROCESS | 28378 | |3;mootools.html;1496.4537943650566;1543.1898253416955;1768.5490199998999;1864.6529479584144;1914.6840771272741;8131;8223.75328740138;8342.833143337144;8371.37214708897;8449.155084491555;8418.915810841905;8448.788780280496;8494.235518803307;8523.01985271694;8559;2444.05903727065;2451.6812814334203;2458.299384675368;2469.0370755405406;2474.270090323359;2468.962965555518;2515.069424313007;2522.2811498722867;2523.5836087045614;2530.266222795387;2325.511642555057;2371.134535894395;2384.3681424422543;2423.8909249083836;2438.6220135878966;2402.3753824005707;2408.915687950922;2428.3079322393123;2433;2442.560339138954;2426.8543887366636;2436.6954130733657;2440.341107900857;2449.5345884282106;2473.5547601431913;8310.376721745833;8311.418200725951;8369.916300836974;8373.246407823264;8382.329413646894;5070;5138.306328645623;5150.690958542462;5213.817516386908;5221.843344699665;3272.8527216275324;3312.6521715219797;3326.3513614845115;3336.7330613550857;3390.4066788312193;1050.144132531984;1063.3619828103153;1087.429099722652;1103.365564800243;1116.3246236027169;11935.641930742091;12054.758904821942;12072.215306005082;12077.15459917806;12094.032477401875;4370.453693288339;4374.934375984363;4376.212281789309;4516.051629157913;4560.065186636732;9678.75803104914;9707.6116955321;9717.222622190207;9740.025997400346;9773.31586788918;4764.737939413366;4774.259989701602;4788.928166077511;4792.544708252711;4806.735629540409;4326.091520780608;4354.216241076573;4378.233809083397;4393.51671316155;4401.625861801783;3662.4689420033947;3703.4815125882396;3740.8690695825517;3742.0644838790304;3743.794091325003;1072.254782925859;1076.7092884921028;1102.2009043443438;1104.320842681761;1166.1661911733152;1405.845357010728;1410.7954346619888;1415.363086611029;1420.985790142106;1445.5446534341859;7949.960250198827;7976.122626511079;8037.397195210383;8037.7990550235545;8041.517508949365;1166.9241499302518;1190.3036723516839;1204.27141579345;1206.119532741104;1209.8124790657462;6083.726232319556;6202.255729312421;6205.565610407228;6249.750009999549;6301.590396624205;10244.282900196915;10560.683179504627;10601.151907847354;10603.469826508644;10734.677959661223;9706.563204655666;10492.370457772558;10509.474526273656;10512.894871051345;10515.421651809223;7851.607419628996;7977.401694872908;8011.319037881845;8034.839303213903;8039.557824319719;7821.569813660303;7828.217178282126;7922.445428819928;7973.760787176394;8003.959980200062;9131.589078491617;9289.674861379819;9408.482533460725;9456.574454149717;9575;9626.374285671409;9656;9688.806223875625;9776.902230977883;9816.2147028239;7305.634718263959;7673.731419400294;7798.298153166243;7824.256695613907;7870.881936771068;8028.959855200686;8073.111957684532;8084.919150808417;8108.918910811052;8144;7458.5151965122095;7530.5858177798555;7620.085589729268;7627.466077374753;7667.0416197975255;7396.593187374746;7448.664810083667;7506.812329691801;7568.886466702894;7675.846483070196;7306.490456381874;7371.668274927534;7667.69329226847;7767.300942915164;7787.766367008999;7186.640667966476;7186.748463803742;7210.170830354366;7217.025701530226;7219.639018049182;7065.6113913735235;7146.785596432115;7190.245024272376;7200.459965502713;7226.168990566152 10:38:32 INFO - PROCESS | 28378 | |4;prototype.html;368.51540224604645;379.1847527815199;379.2888334373051;379.69244911621604;380.22054787685255;6357.777477788279;6359.046143078541;6385.904211436832;6453.322401147876;6542.345765423455;6336.809895703124;6362.204724409449;6378.936210637892;6387.690523442695;6422.389872962061;4908.410990681124;4920.384951881015;4924.729139897313;4926.211806111023;4929.975350123244;4917.09033828741;4924.581410580105;4929.4824043475455;4930.063287975291;4950.826721064764;4685.859424217262;4728.598069164125;4800;4802.87992800181;4844.927326090112;4727.432708075053;4755.048990201939;4798.920242945327;4803.039392121555;4808.278758186265;4213.894652633678;4229.175310814392;4239.59723826236;4265.7440553566885;4273.7008409411355;5993.130996005599;6021.397860213988;6028.638281703112;6037.577369584131;6042.093685947143;5654.660720356792;5696.430356964312;5756.251687280626;5766.0774276116035;5781.103928891029;6785.762498312584;6804.115464989569;6820.658967051628;6822.5565338253355;6834.521583489158;4748.762561871893;4770.61835053195;4771.761411929389;4776.355192049064;4786.904261914742;6983.9650801745665;7003.82490437738;7057;7075.221725610128;7116.395106415961;4874.025194960951;4888.242322439956;4889.217725163957;4891.290762839369;4902.068606964665;4940.6788558743565;4947.604191664658;4949.678270912379;4962.230854217602;4966.925496117561;5697.230873832063;5711.371749107595;5716.57125715573;5719.48524632785;5723.828285151452;6717.865642687118;6800.013997970266;6825.55633883796;6851.314868513109;6859.314068593101;1736.0712019069738;1760.2167035669004;1761.4363403710945;1764.7441121037377;1764.8146944570892;1171.4611278811672;1189.0368801270997;1196.1387800783423;1201.6875612340855;1212.7271363943219;6491.51313651478;6508.772192973223;6510.511711621647;6522.119513865662;6522.282548919615;6998.265182155902;7008.614526201108;7030.086088808423;7055.717771289091;7065.89401158983;6386.489080873519;6437.519370544707;6483.416492515602;6540.05169250456;6610.933890661032;3799.1262009737916;3837.2325534893134;3843.2121415109837;3853.094522787143;3867.961320386816;7300.853982920312;7332.450066245053;7333.559986400833;7350.338469537767;7355.485116041826;7171.49799514029;7311.0130132432505;7337.376323012603;7344.192138864827;7364;7245.275472452818;7296.562206267641;7339.70641174347;7349.191588925214;7356.816079597946;7063;7079.327463890922;7090.539114957512;7106.609136497542;7110.680019399243;6823.590584564942;7014.929850701632;7024.543404678884;7039.964800175966;7044.894326585003;7318.6706598202145;7346.4122870169185;7355.963220183865;7371.741989030358;7407.629618518945;4870.95129048705;4918.581920536794;4919.778609962632;4939.876503087452;4953.876153096201;6877.2091209509545;7088.936659501116;7118.893216601651;7144.3570078693165;7146.464015198985;6888.552244104118;6912.792616221522;6915.481338899704;6928.272531384334;6940.479464040116;6683.231428385603;6850.143732033496;6880.208775990625;6907.93092069093;6925.065116209247;6725.831854203684;6780;6797.830054248683;6800.795976120724;6810.31896810315;6899;6920.826979325557;6934.549254298455;6936.7225310987;6952.791416257521;6621.33786621334;6694.096297000037;6713.865722685421;6743.35938085881;6744.055832183596 10:38:32 INFO - PROCESS | 28378 | |5;yui.html;835.7659855240535;855.3627547477131;904.4482865452073;910.5811326789676;941.7363138321268;13765.931170344147;13951.651208719775;14113.506027289048;14469.34887930043;14492.782608260859;14409.207493587848;14470.855291447082;14472.131672099655;14477.2761361932;14501.709965800677;858.0689951402735;861.4400639584258;871.1984973824098;872.3326655108847;872.9650813967434;863.2532859076916;871.1071152069148;874.0341922176;876.5529579914225;878.2885862451403;912.2337236721153;914.9771255718593;916.2120576304372;921.617528725578;929.9023602521705;905.3933864310927;909.0273407454027;910.0080911806164;911.4166933162782;923.044648788504;680.8263892707378;687.1959807025742;687.5805758487319;688.4114082459475;689.0387908867102;15130.621734456616;15207.543773686808;15222.771658425021;15228.695426091415;15375.846241537552;13602.455901764017;13695.383707733175;13729.862701372958;13732.65668358289;13852.16886986784;11583.07335413165;11603.07175425964;11605.6518304451;11848.289102653782;12120.151589388746;3915.960840391617;3948.9012774680577;4004.3192657248337;4004.918671958584;4037.4347591337237;53589;54024;54058.72970635161;54341.72829135829;54550.72724636391;10787.56849726018;10949.726256843642;10996.725081872857;11167.106631469464;11306.604268850551;17953.551161221076;17991.280348786164;18055.54861128456;18101.185446654934;18426.170822313026;8004.759857204293;8028.638711258008;8077.151899050633;8088.474249173785;8092.473989190684;4535.047639995571;4596.655250856133;4648.65135114861;4660.86017419478;4669.322948172564;3174.2857856982455;3193.3134376109247;3193.4730769422786;3200.567923330367;3233.8706451742137;573.4580821123998;609.3510411411921;611.5902345428574;628.5819929746667;645.8256270806855;551.7820460917915;580.9564282678816;592.9940700592939;633.822529691687;651.7588492257801;8641.567921603895;8899.377043606886;8928.017918029012;8941.195292423714;9028.458292502472;621.9768480849068;658.2463079773632;701.9468055936468;727.7707522130512;734.229059487536;3910.022494376406;4054.959450405458;4478.596926276651;4518.88702782433;4621.838235661803;61359;61803.38196618066;61849.69075154595;62100.37899621036;62254.37745622576;48801.75599121982;49314.506854930994;49586;50368.74815625972;50510.49489505131;49416.25875611869;49781.50218497841;50380.244296335586;50389;51224.23163652548;8888.777780555538;9087.36388452802;9389.436633801994;9750.219982401533;9804.950975245078;35978.28043439169;36514;37013.25973480461;37852.621473786014;37914.8104259477;45175.54824451714;46810.765946171414;47183.292250616956;47916.520834791205;48370;11014.724631884266;11660.06719462458;11697.590584329508;11763.941180294043;11797.52809887595;12680.175788573713;12715.80926286088;12805.871941280468;12811.743765124831;12964.546240881524;11491.597794077166;11615.18340288704;11918.821217681569;11932.58235961772;12244.510219591117;11357.977876790694;11367.20429569922;12086;12109.33398663082;12293.262404255773;11254.774904502028;11428.542858285575;11435.656930292105;11449;12182.025437964765;9140.588673509841;9260.583273752833;9276.443413395218;9747.756306092404;9765.609375624896;9358;9733.853992190265;9797.412155270707;10004.299699021;10076.22903701488 10:38:32 INFO - PROCESS | 28378 | __end_tp_report 10:38:32 INFO - PROCESS | 28378 | __start_cc_report 10:38:32 INFO - PROCESS | 28378 | _x_x_mozilla_cycle_collect,300 10:38:32 INFO - PROCESS | 28378 | __end_cc_report 10:38:32 INFO - PROCESS | 28378 | __startTimestamp1455907112567__endTimestamp 10:38:32 INFO - PROCESS | 28378 | 10:38:32 INFO - PROCESS | 28378 | ------- Summary: start ------- 10:38:32 INFO - PROCESS | 28378 | Number of tests: 6 10:38:32 INFO - PROCESS | 28378 | 10:38:32 INFO - PROCESS | 28378 | [#0] dojo.html Cycles:165 Average:5649.08 Median:5860.15 stddev:627.10 (10.7%) stddev-sans-first:603.94 10:38:32 INFO - PROCESS | 28378 | Values: 3410.7 3429.5 3435.0 3456.1 3469.6 5600.3 5625.9 5652.5 5660.8 5674.4 5608.6 5660.3 5663.2 5666.5 5669.7 5128.2 5168.9 5224.2 5252.2 5270.6 5063.7 5169.9 5187.5 5192.5 5257.1 5232.9 5233.2 5287.9 5288.7 5291.6 5207.7 5221.0 5223.6 5224.6 5269.1 5032.7 5035.3 5044.6 5119.2 5140.3 5383.0 5431.2 5454.3 5456.6 5488.0 6075.1 6076.2 6107.9 6126.0 6177.3 5969.9 6016.8 6093.5 6134.2 6175.2 5765.3 5768.4 5768.8 5769.0 5772.7 6253.9 6264.8 6268.8 6271.3 6279.4 5885.2 5896.3 6044.8 6087.1 6131.9 6051.9 6077.5 6085.9 6097.9 6106.8 5937.4 6012.3 6064.3 6064.6 6070.0 6013.1 6099.7 6109.7 6155.4 6157.1 4590.4 4604.7 4610.6 4617.5 4624.4 4089.3 4150.5 4155.1 4155.3 4164.7 5623.0 5756.5 5759.4 5805.5 5860.2 6140.1 6141.1 6146.1 6150.9 6152.4 5619.6 5631.2 5728.5 5760.3 5771.7 5184.4 5234.2 5236.3 5239.6 5263.6 6244.5 6253.6 6257.4 6259.3 6262.5 6048.3 6048.8 6071.1 6141.8 6158.2 6198.0 6219.1 6248.6 6250.8 6265.7 5985.7 5988.9 5989.1 6000.4 6075.5 6010.1 6010.1 6046.5 6100.5 6131.5 5970.0 5984.8 5995.3 6003.4 6010.2 5958.4 5961.8 5981.0 5984.3 5993.8 5760.6 5818.5 5890.6 5960.9 6005.0 5830.5 5916.5 5918.8 5941.1 5943.2 5794.1 5813.7 5823.6 5824.5 5833.8 10:38:32 INFO - PROCESS | 28378 | 10:38:32 INFO - PROCESS | 28378 | [#1] ext.html Cycles:180 Average:47037.47 Median:40759.09 stddev:75824.85 (186.0%) stddev-sans-first:75957.25 10:38:32 INFO - PROCESS | 28378 | Values: 559.4 565.8 581.4 585.0 597.4 32962.3 33072.5 33603.0 33660.8 33673.8 44865.8 45215.3 45533.1 45613.3 45713.5 8931.8 9087.7 9099.0 9131.0 9143.0 8808.7 8942.9 8969.9 8996.1 9003.0 9012.9 9038.1 9056.5 9122.1 9139.6 8894.5 8992.7 9002.6 9029.1 9038.9 8721.3 8748.4 8825.5 8840.3 8898.7 41746.0 42076.0 42223.8 42309.8 42313.4 3241.9 3671.4 3696.8 3749.2 3984.9 30361.8 30957.0 31332.0 31372.7 31444.2 4222.4 4368.6 4389.6 4391.3 4392.6 239867.0 241369.0 242164.0 242270.0 242574.0 55041.0 55738.7 57358.4 61536.7 62348.0 54095.7 54223.5 54404.5 54522.2 54531.7 15385.8 15553.9 15586.7 15598.6 15604.0 10965.7 11008.7 11014.9 11034.5 11065.4 20016.3 20473.4 20538.4 20547.9 20717.9 7813.2 7979.8 8029.2 8047.9 8166.2 1039.7 1070.2 1070.7 1082.7 1262.5 30240.4 30351.8 30905.5 30989.4 31048.4 1130.7 1148.1 1173.1 1206.8 1297.2 15802.3 15891.4 15933.1 16089.2 16278.8 335822.0 348536.0 351215.0 351835.0 351836.0 51773.2 51935.0 52107.0 52262.0 52409.5 1425.0 1429.0 1436.2 1442.0 1450.3 29292.7 30371.0 30373.5 30630.8 31442.8 44817.8 45015.3 45082.5 45096.8 45313.0 267454.0 272658.0 273049.0 273529.0 274420.0 33239.5 33388.7 33577.2 33650.3 48987.8 47406.3 47828.3 48008.0 48017.8 48798.5 41566.6 42894.8 43139.0 44787.0 45320.3 39923.4 40622.6 40895.6 42808.4 44883.6 42379.4 43062.4 43251.4 43614.8 43639.6 37052.4 37361.3 37440.8 38242.8 38581.2 28563.9 29279.7 29507.0 29861.9 29975.6 10:38:32 INFO - PROCESS | 28378 | 10:38:32 INFO - PROCESS | 28378 | [#2] jquery.html Cycles:180 Average:26404.07 Median:4640.56 stddev:83367.09 (1796.5%) stddev-sans-first:83578.07 10:38:32 INFO - PROCESS | 28378 | Values: 387.0 396.6 399.2 399.6 402.8 17776.7 18216.6 18344.2 18609.9 18922.3 16176.4 16203.4 16302.3 16723.3 16817.6 5215.5 5401.1 5418.1 5419.2 5422.1 5173.4 5269.6 5287.6 5321.4 5327.6 5298.0 5333.7 5387.9 5530.6 5580.9 5000.0 5364.2 5539.4 5584.9 5625.8 5103.3 5365.8 5386.4 5387.5 5407.0 12891.4 13023.7 13272.9 13324.3 13343.3 2189.7 2224.1 2247.1 2321.7 2356.5 9503.1 9635.3 9738.9 9784.2 9854.6 1921.2 1946.7 1948.7 1981.8 1986.8 59147.7 60638.7 61006.0 61211.0 62598.4 10173.3 10594.7 10804.6 10824.4 10852.5 14056.3 14101.1 14139.6 14159.8 14289.4 7552.6 7585.7 7605.3 7612.0 7654.7 7122.8 7278.7 7301.0 7337.0 7338.6 4582.0 4699.1 4713.6 4731.1 4755.7 1904.6 1918.2 1954.6 1985.3 1986.1 478.5 951.6 1004.7 1011.1 1140.6 10849.6 11299.2 11312.8 11347.1 11413.0 494.0 501.5 522.7 523.3 527.7 6213.1 6490.9 6494.7 6515.7 6521.8 416639.0 418728.0 561061.0 563350.0 564896.0 48088.3 48835.3 61993.0 72548.6 79623.6 1167.3 1198.4 1212.2 1213.8 1220.7 15759.1 15967.6 16062.4 16126.1 16240.2 33833.3 33844.7 34508.7 34788.7 35205.3 44276.3 44944.3 47433.8 51638.5 53986.2 9477.6 10262.2 10514.5 10656.7 11020.4 6834.0 11952.1 12140.8 12308.8 12372.6 7005.9 7743.7 7801.3 7984.2 8148.9 7317.2 7947.1 8057.0 8062.7 8174.8 7913.3 7949.2 8207.8 8264.1 8321.5 11055.9 11098.3 11099.2 11174.5 11303.8 10812.2 11327.8 11341.1 11478.3 11658.2 10:38:32 INFO - PROCESS | 28378 | 10:38:32 INFO - PROCESS | 28378 | [#3] mootools.html Cycles:180 Average:5955.19 Median:5144.50 stddev:3148.10 (61.2%) stddev-sans-first:3139.09 10:38:32 INFO - PROCESS | 28378 | Values: 1496.5 1543.2 1768.5 1864.7 1914.7 8131.0 8223.8 8342.8 8371.4 8449.2 8418.9 8448.8 8494.2 8523.0 8559.0 2444.1 2451.7 2458.3 2469.0 2474.3 2469.0 2515.1 2522.3 2523.6 2530.3 2325.5 2371.1 2384.4 2423.9 2438.6 2402.4 2408.9 2428.3 2433.0 2442.6 2426.9 2436.7 2440.3 2449.5 2473.6 8310.4 8311.4 8369.9 8373.2 8382.3 5070.0 5138.3 5150.7 5213.8 5221.8 3272.9 3312.7 3326.4 3336.7 3390.4 1050.1 1063.4 1087.4 1103.4 1116.3 11935.6 12054.8 12072.2 12077.2 12094.0 4370.5 4374.9 4376.2 4516.1 4560.1 9678.8 9707.6 9717.2 9740.0 9773.3 4764.7 4774.3 4788.9 4792.5 4806.7 4326.1 4354.2 4378.2 4393.5 4401.6 3662.5 3703.5 3740.9 3742.1 3743.8 1072.3 1076.7 1102.2 1104.3 1166.2 1405.8 1410.8 1415.4 1421.0 1445.5 7950.0 7976.1 8037.4 8037.8 8041.5 1166.9 1190.3 1204.3 1206.1 1209.8 6083.7 6202.3 6205.6 6249.8 6301.6 10244.3 10560.7 10601.2 10603.5 10734.7 9706.6 10492.4 10509.5 10512.9 10515.4 7851.6 7977.4 8011.3 8034.8 8039.6 7821.6 7828.2 7922.4 7973.8 8004.0 9131.6 9289.7 9408.5 9456.6 9575.0 9626.4 9656.0 9688.8 9776.9 9816.2 7305.6 7673.7 7798.3 7824.3 7870.9 8029.0 8073.1 8084.9 8108.9 8144.0 7458.5 7530.6 7620.1 7627.5 7667.0 7396.6 7448.7 7506.8 7568.9 7675.8 7306.5 7371.7 7667.7 7767.3 7787.8 7186.6 7186.7 7210.2 7217.0 7219.6 7065.6 7146.8 7190.2 7200.5 7226.2 10:38:32 INFO - PROCESS | 28378 | 10:38:32 INFO - PROCESS | 28378 | [#4] prototype.html Cycles:180 Average:5721.59 Median:6468.37 stddev:1724.17 (26.7%) stddev-sans-first:1681.54 10:38:32 INFO - PROCESS | 28378 | Values: 368.5 379.2 379.3 379.7 380.2 6357.8 6359.0 6385.9 6453.3 6542.3 6336.8 6362.2 6378.9 6387.7 6422.4 4908.4 4920.4 4924.7 4926.2 4930.0 4917.1 4924.6 4929.5 4930.1 4950.8 4685.9 4728.6 4800.0 4802.9 4844.9 4727.4 4755.0 4798.9 4803.0 4808.3 4213.9 4229.2 4239.6 4265.7 4273.7 5993.1 6021.4 6028.6 6037.6 6042.1 5654.7 5696.4 5756.3 5766.1 5781.1 6785.8 6804.1 6820.7 6822.6 6834.5 4748.8 4770.6 4771.8 4776.4 4786.9 6984.0 7003.8 7057.0 7075.2 7116.4 4874.0 4888.2 4889.2 4891.3 4902.1 4940.7 4947.6 4949.7 4962.2 4966.9 5697.2 5711.4 5716.6 5719.5 5723.8 6717.9 6800.0 6825.6 6851.3 6859.3 1736.1 1760.2 1761.4 1764.7 1764.8 1171.5 1189.0 1196.1 1201.7 1212.7 6491.5 6508.8 6510.5 6522.1 6522.3 6998.3 7008.6 7030.1 7055.7 7065.9 6386.5 6437.5 6483.4 6540.1 6610.9 3799.1 3837.2 3843.2 3853.1 3868.0 7300.9 7332.5 7333.6 7350.3 7355.5 7171.5 7311.0 7337.4 7344.2 7364.0 7245.3 7296.6 7339.7 7349.2 7356.8 7063.0 7079.3 7090.5 7106.6 7110.7 6823.6 7014.9 7024.5 7040.0 7044.9 7318.7 7346.4 7356.0 7371.7 7407.6 4871.0 4918.6 4919.8 4939.9 4953.9 6877.2 7088.9 7118.9 7144.4 7146.5 6888.6 6912.8 6915.5 6928.3 6940.5 6683.2 6850.1 6880.2 6907.9 6925.1 6725.8 6780.0 6797.8 6800.8 6810.3 6899.0 6920.8 6934.5 6936.7 6952.8 6621.3 6694.1 6713.9 6743.4 6744.1 10:38:32 INFO - PROCESS | 28378 | 10:38:32 INFO - PROCESS | 28378 | [#5] yui.html Cycles:180 Average:14636.56 Median:48143.26 stddev:16923.07 (35.2%) stddev-sans-first:16938.81 10:38:32 INFO - PROCESS | 28378 | Values: 835.8 855.4 904.4 910.6 941.7 13765.9 13951.7 14113.5 14469.3 14492.8 14409.2 14470.9 14472.1 14477.3 14501.7 858.1 861.4 871.2 872.3 873.0 863.3 871.1 874.0 876.6 878.3 912.2 915.0 916.2 921.6 929.9 905.4 909.0 910.0 911.4 923.0 680.8 687.2 687.6 688.4 689.0 15130.6 15207.5 15222.8 15228.7 15375.8 13602.5 13695.4 13729.9 13732.7 13852.2 11583.1 11603.1 11605.7 11848.3 12120.2 3916.0 3948.9 4004.3 4004.9 4037.4 53589.0 54024.0 54058.7 54341.7 54550.7 10787.6 10949.7 10996.7 11167.1 11306.6 17953.6 17991.3 18055.5 18101.2 18426.2 8004.8 8028.6 8077.2 8088.5 8092.5 4535.0 4596.7 4648.7 4660.9 4669.3 3174.3 3193.3 3193.5 3200.6 3233.9 573.5 609.4 611.6 628.6 645.8 551.8 581.0 593.0 633.8 651.8 8641.6 8899.4 8928.0 8941.2 9028.5 622.0 658.2 701.9 727.8 734.2 3910.0 4055.0 4478.6 4518.9 4621.8 61359.0 61803.4 61849.7 62100.4 62254.4 48801.8 49314.5 49586.0 50368.7 50510.5 49416.3 49781.5 50380.2 50389.0 51224.2 8888.8 9087.4 9389.4 9750.2 9805.0 35978.3 36514.0 37013.3 37852.6 37914.8 45175.5 46810.8 47183.3 47916.5 48370.0 11014.7 11660.1 11697.6 11763.9 11797.5 12680.2 12715.8 12805.9 12811.7 12964.5 11491.6 11615.2 11918.8 11932.6 12244.5 11358.0 11367.2 12086.0 12109.3 12293.3 11254.8 11428.5 11435.7 11449.0 12182.0 9140.6 9260.6 9276.4 9747.8 9765.6 9358.0 9733.9 9797.4 10004.3 10076.2 10:38:32 INFO - PROCESS | 28378 | -------- Summary: end -------- 10:38:32 INFO - PROCESS | 28378 | 10:38:33 INFO - TEST-INFO | 28378: exit 0 10:38:33 INFO - TEST-OK | dromaeo_css | took 1110161ms 10:38:33 INFO - TEST-START | kraken 10:38:33 INFO - operating with platform_type : linux_ 10:38:33 INFO - Initialising browser for kraken test... 10:38:33 INFO - TEST-INFO | started process 28627 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnkvmU2/profile http://localhost:49108/getInfo.html) 10:38:37 INFO - PROCESS | 28627 | 10:38:37 INFO - PROCESS | 28627 | (process:28705): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:38:38 INFO - PROCESS | 28627 | __metrics Screen width/height:1600/1200 10:38:38 INFO - PROCESS | 28627 | colorDepth:24 10:38:38 INFO - PROCESS | 28627 | Browser inner width/height: 1024/697 10:38:38 INFO - PROCESS | 28627 | __metrics 10:38:39 INFO - TEST-INFO | 28627: exit 0 10:38:39 INFO - Browser initialized. 10:38:39 INFO - Running cycle 1/1 for kraken test... 10:38:39 INFO - TEST-INFO | started process 28754 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnkvmU2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:38:40 INFO - PROCESS | 28754 | 10:38:40 INFO - PROCESS | 28754 | (process:28820): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:38:51 INFO - PROCESS | 28754 | RSS: Main: 141639680 10:38:51 INFO - PROCESS | 28754 | 10:38:53 INFO - PROCESS | 28754 | Cycle 1(1): loaded http://localhost:49108/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49108/tests/kraken/driver.html?testName=audio-beat-detection) 10:38:54 INFO - PROCESS | 28754 | RSS: Main: 146305024 10:38:54 INFO - PROCESS | 28754 | 10:38:56 INFO - PROCESS | 28754 | Cycle 1(1): loaded http://localhost:49108/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49108/tests/kraken/driver.html?testName=audio-dft) 10:38:57 INFO - PROCESS | 28754 | RSS: Main: 145580032 10:38:57 INFO - PROCESS | 28754 | 10:39:00 INFO - PROCESS | 28754 | Cycle 1(1): loaded http://localhost:49108/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49108/tests/kraken/driver.html?testName=audio-fft) 10:39:00 INFO - PROCESS | 28754 | RSS: Main: 146006016 10:39:00 INFO - PROCESS | 28754 | 10:39:02 INFO - PROCESS | 28754 | Cycle 1(1): loaded http://localhost:49108/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49108/tests/kraken/driver.html?testName=audio-oscillator) 10:39:03 INFO - PROCESS | 28754 | RSS: Main: 145141760 10:39:03 INFO - PROCESS | 28754 | 10:39:05 INFO - PROCESS | 28754 | Cycle 1(1): loaded http://localhost:49108/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49108/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:39:06 INFO - PROCESS | 28754 | RSS: Main: 145051648 10:39:06 INFO - PROCESS | 28754 | 10:39:09 INFO - PROCESS | 28754 | Cycle 1(1): loaded http://localhost:49108/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49108/tests/kraken/driver.html?testName=imaging-darkroom) 10:39:09 INFO - PROCESS | 28754 | RSS: Main: 145752064 10:39:09 INFO - PROCESS | 28754 | 10:39:13 INFO - PROCESS | 28754 | Cycle 1(1): loaded http://localhost:49108/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49108/tests/kraken/driver.html?testName=imaging-desaturate) 10:39:13 INFO - PROCESS | 28754 | RSS: Main: 145141760 10:39:13 INFO - PROCESS | 28754 | 10:39:16 INFO - PROCESS | 28754 | Cycle 1(1): loaded http://localhost:49108/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49108/tests/kraken/driver.html?testName=json-parse-financial) 10:39:17 INFO - PROCESS | 28754 | RSS: Main: 145543168 10:39:17 INFO - PROCESS | 28754 | 10:39:18 INFO - PROCESS | 28754 | Cycle 1(1): loaded http://localhost:49108/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49108/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:39:19 INFO - PROCESS | 28754 | RSS: Main: 146452480 10:39:19 INFO - PROCESS | 28754 | 10:39:20 INFO - PROCESS | 28754 | Cycle 1(1): loaded http://localhost:49108/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49108/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:39:21 INFO - PROCESS | 28754 | RSS: Main: 147107840 10:39:21 INFO - PROCESS | 28754 | 10:39:23 INFO - PROCESS | 28754 | Cycle 1(1): loaded http://localhost:49108/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49108/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:39:24 INFO - PROCESS | 28754 | RSS: Main: 147419136 10:39:24 INFO - PROCESS | 28754 | 10:39:26 INFO - PROCESS | 28754 | Cycle 1(1): loaded http://localhost:49108/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49108/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:39:27 INFO - PROCESS | 28754 | RSS: Main: 145833984 10:39:27 INFO - PROCESS | 28754 | 10:39:29 INFO - PROCESS | 28754 | Cycle 1(1): loaded http://localhost:49108/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49108/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:39:30 INFO - PROCESS | 28754 | RSS: Main: 146104320 10:39:30 INFO - PROCESS | 28754 | 10:39:31 INFO - PROCESS | 28754 | Cycle 1(1): loaded http://localhost:49108/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49108/tests/kraken/driver.html?testName=ai-astar) 10:39:32 INFO - PROCESS | 28754 | RSS: Main: 146956288 10:39:32 INFO - PROCESS | 28754 | 10:39:32 INFO - PROCESS | 28754 | __start_tp_report 10:39:32 INFO - PROCESS | 28754 | _x_x_mozilla_page_load 10:39:32 INFO - PROCESS | 28754 | _x_x_mozilla_page_load_details 10:39:32 INFO - PROCESS | 28754 | |i|pagename|runs| 10:39:32 INFO - PROCESS | 28754 | |0;ai-astar;111;106;111;112;112;121;109;109;113;111 10:39:32 INFO - PROCESS | 28754 | |1;audio-beat-detection;160;133;153;163;125;151;149;135;173;127 10:39:32 INFO - PROCESS | 28754 | |2;audio-dft;163;162;162;161;164;161;161;160;164;160 10:39:32 INFO - PROCESS | 28754 | |3;audio-fft;75;77;76;165;73;72;75;77;157;77 10:39:32 INFO - PROCESS | 28754 | |4;audio-oscillator;95;94;138;95;96;96;142;95;95;144 10:39:32 INFO - PROCESS | 28754 | |5;imaging-gaussian-blur;109;111;109;111;110;112;110;110;109;110 10:39:32 INFO - PROCESS | 28754 | |6;imaging-darkroom;149;146;147;148;146;146;147;147;146;147 10:39:32 INFO - PROCESS | 28754 | |7;imaging-desaturate;96;96;96;97;97;97;97;97;96;95 10:39:32 INFO - PROCESS | 28754 | |8;json-parse-financial;52;60;56;54;54;56;55;63;53;56 10:39:32 INFO - PROCESS | 28754 | |9;json-stringify-tinderbox;63;66;64;63;64;65;64;63;64;64 10:39:32 INFO - PROCESS | 28754 | |10;stanford-crypto-aes;80;89;82;83;82;89;82;82;81;81 10:39:32 INFO - PROCESS | 28754 | |11;stanford-crypto-ccm;110;109;124;112;118;118;110;117;113;118 10:39:32 INFO - PROCESS | 28754 | |12;stanford-crypto-pbkdf2;151;137;148;136;138;135;128;138;138;141 10:39:32 INFO - PROCESS | 28754 | |13;stanford-crypto-sha256-iterative;68;73;65;66;70;64;63;63;64;65 10:39:32 INFO - PROCESS | 28754 | __end_tp_report 10:39:32 INFO - PROCESS | 28754 | __start_cc_report 10:39:32 INFO - PROCESS | 28754 | _x_x_mozilla_cycle_collect,726 10:39:32 INFO - PROCESS | 28754 | __end_cc_report 10:39:32 INFO - PROCESS | 28754 | __startTimestamp1455907172110__endTimestamp 10:39:32 INFO - PROCESS | 28754 | 10:39:32 INFO - PROCESS | 28754 | ------- Summary: start ------- 10:39:32 INFO - PROCESS | 28754 | Number of tests: 14 10:39:32 INFO - PROCESS | 28754 | 10:39:32 INFO - PROCESS | 28754 | [#0] ai-astar Cycles:10 Average:111.50 Median:111.50 stddev:3.89 (3.5%) stddev-sans-first:4.13 10:39:32 INFO - PROCESS | 28754 | Values: 111.0 106.0 111.0 112.0 112.0 121.0 109.0 109.0 113.0 111.0 10:39:32 INFO - PROCESS | 28754 | 10:39:32 INFO - PROCESS | 28754 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:152.00 stddev:16.26 (10.7%) stddev-sans-first:16.55 10:39:32 INFO - PROCESS | 28754 | Values: 160.0 133.0 153.0 163.0 125.0 151.0 149.0 135.0 173.0 127.0 10:39:32 INFO - PROCESS | 28754 | 10:39:32 INFO - PROCESS | 28754 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.48 (0.9%) stddev-sans-first:1.50 10:39:32 INFO - PROCESS | 28754 | Values: 163.0 162.0 162.0 161.0 164.0 161.0 161.0 160.0 164.0 160.0 10:39:32 INFO - PROCESS | 28754 | 10:39:32 INFO - PROCESS | 28754 | [#3] audio-fft Cycles:10 Average:92.40 Median:75.50 stddev:36.24 (48.0%) stddev-sans-first:37.89 10:39:32 INFO - PROCESS | 28754 | Values: 75.0 77.0 76.0 165.0 73.0 72.0 75.0 77.0 157.0 77.0 10:39:32 INFO - PROCESS | 28754 | 10:39:32 INFO - PROCESS | 28754 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:95.00 stddev:22.37 (23.5%) stddev-sans-first:23.14 10:39:32 INFO - PROCESS | 28754 | Values: 95.0 94.0 138.0 95.0 96.0 96.0 142.0 95.0 95.0 144.0 10:39:32 INFO - PROCESS | 28754 | 10:39:32 INFO - PROCESS | 28754 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.99 (0.9%) stddev-sans-first:0.97 10:39:32 INFO - PROCESS | 28754 | Values: 109.0 111.0 109.0 111.0 110.0 112.0 110.0 110.0 109.0 110.0 10:39:32 INFO - PROCESS | 28754 | 10:39:32 INFO - PROCESS | 28754 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:0.71 10:39:32 INFO - PROCESS | 28754 | Values: 149.0 146.0 147.0 148.0 146.0 146.0 147.0 147.0 146.0 147.0 10:39:32 INFO - PROCESS | 28754 | 10:39:32 INFO - PROCESS | 28754 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 10:39:32 INFO - PROCESS | 28754 | Values: 96.0 96.0 96.0 97.0 97.0 97.0 97.0 97.0 96.0 95.0 10:39:32 INFO - PROCESS | 28754 | 10:39:32 INFO - PROCESS | 28754 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:3.31 (5.9%) stddev-sans-first:3.20 10:39:32 INFO - PROCESS | 28754 | Values: 52.0 60.0 56.0 54.0 54.0 56.0 55.0 63.0 53.0 56.0 10:39:32 INFO - PROCESS | 28754 | 10:39:32 INFO - PROCESS | 28754 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.94 (1.5%) stddev-sans-first:0.93 10:39:32 INFO - PROCESS | 28754 | Values: 63.0 66.0 64.0 63.0 64.0 65.0 64.0 63.0 64.0 64.0 10:39:32 INFO - PROCESS | 28754 | 10:39:32 INFO - PROCESS | 28754 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:82.00 stddev:3.21 (3.9%) stddev-sans-first:3.21 10:39:32 INFO - PROCESS | 28754 | Values: 80.0 89.0 82.0 83.0 82.0 89.0 82.0 82.0 81.0 81.0 10:39:32 INFO - PROCESS | 28754 | 10:39:32 INFO - PROCESS | 28754 | [#11] stanford-crypto-ccm Cycles:10 Average:114.90 Median:117.50 stddev:4.84 (4.1%) stddev-sans-first:4.80 10:39:32 INFO - PROCESS | 28754 | Values: 110.0 109.0 124.0 112.0 118.0 118.0 110.0 117.0 113.0 118.0 10:39:32 INFO - PROCESS | 28754 | 10:39:32 INFO - PROCESS | 28754 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.00 Median:138.00 stddev:6.51 (4.7%) stddev-sans-first:5.27 10:39:32 INFO - PROCESS | 28754 | Values: 151.0 137.0 148.0 136.0 138.0 135.0 128.0 138.0 138.0 141.0 10:39:32 INFO - PROCESS | 28754 | 10:39:32 INFO - PROCESS | 28754 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:65.50 stddev:3.28 (5.0%) stddev-sans-first:3.41 10:39:32 INFO - PROCESS | 28754 | Values: 68.0 73.0 65.0 66.0 70.0 64.0 63.0 63.0 64.0 65.0 10:39:32 INFO - PROCESS | 28754 | -------- Summary: end -------- 10:39:32 INFO - PROCESS | 28754 | 10:39:33 INFO - TEST-INFO | 28754: exit 0 10:39:33 INFO - TEST-OK | kraken | took 60234ms 10:39:33 INFO - TEST-START | v8_7 10:39:33 INFO - operating with platform_type : linux_ 10:39:33 INFO - Initialising browser for v8_7 test... 10:39:33 INFO - TEST-INFO | started process 29048 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqpio1R/profile http://localhost:49108/getInfo.html) 10:39:37 INFO - PROCESS | 29048 | 10:39:37 INFO - PROCESS | 29048 | (process:29130): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:39:38 INFO - PROCESS | 29048 | __metrics Screen width/height:1600/1200 10:39:38 INFO - PROCESS | 29048 | colorDepth:24 10:39:38 INFO - PROCESS | 29048 | Browser inner width/height: 1024/697 10:39:38 INFO - PROCESS | 29048 | __metrics 10:39:39 INFO - TEST-INFO | 29048: exit 0 10:39:39 INFO - Browser initialized. 10:39:39 INFO - Running cycle 1/1 for v8_7 test... 10:39:39 INFO - TEST-INFO | started process 29179 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqpio1R/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:39:40 INFO - PROCESS | 29179 | 10:39:40 INFO - PROCESS | 29179 | (process:29240): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:39:51 INFO - PROCESS | 29179 | RSS: Main: 141049856 10:39:51 INFO - PROCESS | 29179 | 10:40:13 INFO - PROCESS | 29179 | Cycle 1(1): loaded http://localhost:49108/tests/v8_7/run.html (next: http://localhost:49108/tests/v8_7/run.html) 10:40:13 INFO - PROCESS | 29179 | RSS: Main: 144801792 10:40:13 INFO - PROCESS | 29179 | 10:40:13 INFO - PROCESS | 29179 | __start_tp_report 10:40:13 INFO - PROCESS | 29179 | _x_x_mozilla_page_load 10:40:13 INFO - PROCESS | 29179 | _x_x_mozilla_page_load_details 10:40:13 INFO - PROCESS | 29179 | |i|pagename|runs| 10:40:13 INFO - PROCESS | 29179 | |0;Richards;166.25103906899417 10:40:13 INFO - PROCESS | 29179 | |1;DeltaBlue;172.08742040956807 10:40:13 INFO - PROCESS | 29179 | |2;Encrypt;278.08676307007784 10:40:13 INFO - PROCESS | 29179 | |3;Decrypt;5213.541666666667 10:40:13 INFO - PROCESS | 29179 | |4;RayTrace;916.5902841429881 10:40:13 INFO - PROCESS | 29179 | |5;Earley;564.0157924421884 10:40:13 INFO - PROCESS | 29179 | |6;Boyer;11111.111111111111 10:40:13 INFO - PROCESS | 29179 | |7;RegExp;39211.53846153846 10:40:13 INFO - PROCESS | 29179 | |8;Splay;506.32911392405066 10:40:13 INFO - PROCESS | 29179 | |9;NavierStokes;4835.748792270531 10:40:13 INFO - PROCESS | 29179 | __end_tp_report 10:40:13 INFO - PROCESS | 29179 | __startTimestamp1455907213964__endTimestamp 10:40:13 INFO - PROCESS | 29179 | 10:40:13 INFO - PROCESS | 29179 | ------- Summary: start ------- 10:40:13 INFO - PROCESS | 29179 | Number of tests: 10 10:40:13 INFO - PROCESS | 29179 | 10:40:13 INFO - PROCESS | 29179 | [#0] Richards Cycles:1 Average:166.25 Median:166.25 stddev:0.00 (0.0%) 10:40:13 INFO - PROCESS | 29179 | Values: 166.3 10:40:13 INFO - PROCESS | 29179 | 10:40:13 INFO - PROCESS | 29179 | [#1] DeltaBlue Cycles:1 Average:172.09 Median:172.09 stddev:0.00 (0.0%) 10:40:13 INFO - PROCESS | 29179 | Values: 172.1 10:40:13 INFO - PROCESS | 29179 | 10:40:13 INFO - PROCESS | 29179 | [#2] Encrypt Cycles:1 Average:278.09 Median:278.09 stddev:0.00 (0.0%) 10:40:13 INFO - PROCESS | 29179 | Values: 278.1 10:40:13 INFO - PROCESS | 29179 | 10:40:13 INFO - PROCESS | 29179 | [#3] Decrypt Cycles:1 Average:5213.54 Median:5213.54 stddev:0.00 (0.0%) 10:40:13 INFO - PROCESS | 29179 | Values: 5213.5 10:40:13 INFO - PROCESS | 29179 | 10:40:13 INFO - PROCESS | 29179 | [#4] RayTrace Cycles:1 Average:916.59 Median:916.59 stddev:0.00 (0.0%) 10:40:13 INFO - PROCESS | 29179 | Values: 916.6 10:40:13 INFO - PROCESS | 29179 | 10:40:13 INFO - PROCESS | 29179 | [#5] Earley Cycles:1 Average:564.02 Median:564.02 stddev:0.00 (0.0%) 10:40:13 INFO - PROCESS | 29179 | Values: 564.0 10:40:13 INFO - PROCESS | 29179 | 10:40:13 INFO - PROCESS | 29179 | [#6] Boyer Cycles:1 Average:11111.11 Median:11111.11 stddev:0.00 (0.0%) 10:40:13 INFO - PROCESS | 29179 | Values: 11111.1 10:40:13 INFO - PROCESS | 29179 | 10:40:13 INFO - PROCESS | 29179 | [#7] RegExp Cycles:1 Average:39211.54 Median:39211.54 stddev:0.00 (0.0%) 10:40:13 INFO - PROCESS | 29179 | Values: 39211.5 10:40:13 INFO - PROCESS | 29179 | 10:40:13 INFO - PROCESS | 29179 | [#8] Splay Cycles:1 Average:506.33 Median:506.33 stddev:0.00 (0.0%) 10:40:13 INFO - PROCESS | 29179 | Values: 506.3 10:40:13 INFO - PROCESS | 29179 | 10:40:13 INFO - PROCESS | 29179 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 10:40:13 INFO - PROCESS | 29179 | Values: 4835.7 10:40:13 INFO - PROCESS | 29179 | -------- Summary: end -------- 10:40:13 INFO - PROCESS | 29179 | 10:40:14 INFO - TEST-INFO | 29179: exit 0 10:40:14 INFO - TEST-OK | v8_7 | took 41435ms 10:40:14 INFO - SUITE-END | took 1211s 10:40:15 INFO - Completed test suite (00:20:12) 10:40:15 INFO - Working with test: dromaeo_css 10:40:15 INFO - Generating results file: dromaeo_css 10:40:15 INFO - Working with test: kraken 10:40:15 INFO - Generating results file: kraken 10:40:15 INFO - javascript benchmark 10:40:15 INFO - Working with test: v8_7 10:40:15 INFO - Generating results file: v8_7 10:40:15 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:40:15 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 10:40:15 INFO - process_Request line: dromaeo_css 7264.32 graph.html#tests=[[72,52,43]] 10:40:15 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:40:15 INFO - process_Request line: kraken 1498.00 graph.html#tests=[[232,52,43]] 10:40:15 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:40:15 INFO - process_Request line: v8_7 22084.43 graph.html#tests=[[230,52,43]] 10:40:15 INFO - RETURN: dromaeo_css: 7264.32 10:40:15 INFO - RETURN: kraken: 1498.00 10:40:15 INFO - RETURN: v8_7: 22084.43 10:40:15 INFO - javascript benchmark 10:40:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3410.7441941854363, 3429.5370125033114, 3434.965650343496, 3456.0668619472726, 3469.5663042119745, 5600.299962504687, 5625.859353516164, 5652.4912757851735, 5660.830175094743, 5674.404187560303, 5608.6073974821775, 5660.264165658458, 5663.150527420889, 5666.490015898568, 5669.659820410779, 5128.153854613985, 5168.870778230536, 5224.242484839696, 5252.185911183773, 5270.578353731711, 5063.74681265937, 5169.896602067956, 5187.533122019017, 5192.532672059514, 5257.053730328539, 5232.869178270555, 5233.2150177473495, 5287.894242115155, 5288.735563221823, 5291.576673866081, 5207.687538747668, 5220.973895130538, 5223.555997740196, 5224.555912747421, 5269.130593452076, 5032.6980381177245, 5035.320231768701, 5044.646874718771, 5119.180931051014, 5140.3060586820675, 5383.0, 5431.185322201662, 5454.263674403945, 5456.590755693339, 5488.039593071197, 6075.058365953284, 6076.240469941257, 6107.908381374283, 6125.969370153165, 6177.289611694668, 5969.850753731148, 6016.78941237059, 6093.512518998469, 6134.19168101403, 6175.197224360849, 5765.279340082448, 5768.3654797972185, 5768.769249230026, 5769.0, 5772.682502462363, 6253.906191407133, 6264.843378915472, 6268.811935641938, 6271.310155882849, 6279.3720627937755, 5885.205497257901, 5896.262967129109, 6044.8186554402555, 6087.147799308101, 6131.908021379683, 6051.878962420727, 6077.453029227391, 6085.878282434326, 6097.908531372033, 6106.816795496142, 5937.435943585352, 6012.30858451275, 6064.272287325549, 6064.605800622945, 6070.028795392716, 6013.128096425994, 6099.695015249308, 6109.6673337913735, 6155.353687862799, 6157.076438534166, 4590.380298659705, 4604.677672562955, 4610.561996610317, 4617.492075871652, 4624.421947256593, 4089.345704687236, 4150.501939767187, 4155.127423241153, 4155.2728272552185, 4164.68764842638, 5623.0, 5756.481916627524, 5759.366469688331, 5805.477507024304, 5860.150278209636, 6140.109684095781, 6141.07883817422, 6146.139540464339, 6150.938490615126, 6152.384761523812, 5619.578531610064, 5631.155326701028, 5728.513076388554, 5760.337561180518, 5771.740271687784, 5184.403793563789, 5234.241035049897, 5236.319278493771, 5239.554637855825, 5263.552598029134, 6244.500439964792, 6253.5622506424115, 6257.405546473078, 6259.342769009279, 6262.499000079983, 6048.304444988883, 6048.758049677964, 6071.058985857199, 6141.815745527641, 6158.199434073631, 6197.96901015492, 6219.067139928866, 6248.562600617913, 6250.843728906813, 6265.718042688181, 5985.730642121202, 5988.910166347596, 5989.131575921379, 6000.399960004139, 6075.483583895241, 6010.068439391901, 6010.068439391901, 6046.455818976313, 6100.511959043177, 6131.468419844996, 5969.970150149222, 5984.760609575743, 5995.250593675791, 6003.3996600339615, 6010.248718910137, 5958.433948774859, 5961.821145365646, 5981.043033114681, 5984.251968503937, 5993.820185394445, 5760.567957403127, 5818.4763371296785, 5890.617109887844, 5960.910586341295, 6005.0, 5830.47525722687, 5916.526677865846, 5918.7928422505, 5941.1088336749835, 5943.167956486009, 5794.101914203306, 5813.680247586423, 5823.563232757476, 5824.534037276923, 5833.82498525045], "unit": "score", "name": "dojo.html", "value": 5608.422233205209}, {"lowerIsBetter": false, "replicates": [559.3651205881325, 565.8217661436647, 581.3808294166711, 584.9707514624267, 597.3638075449646, 32962.34075318498, 33072.5039124413, 33603.0, 33660.831695841516, 33673.831630841814, 44865.77567112168, 45215.321770173476, 45533.08933821321, 45613.31580026294, 45713.54286457135, 8931.821363572724, 9087.681931132413, 9099.04460031697, 9131.0412406697, 9142.954285228598, 8808.735737927873, 8942.882139732534, 8969.910300897005, 8996.100389961017, 9003.0, 9012.909870901305, 9038.141376569216, 9056.501892395916, 9122.133397327243, 9139.588718507683, 8894.510801905924, 8992.730218093468, 9002.594883230206, 9029.0519495453, 9038.86441703375, 8721.345899057533, 8748.431351962103, 8825.470471771714, 8840.33697472692, 8898.688545900926, 41746.0, 42076.0, 42223.788881055705, 42309.78845105786, 42313.365299520534, 3241.9027429177163, 3671.4125739881492, 3696.7597106188014, 3749.1751814601016, 3984.920301593981, 30361.848190759127, 30957.0, 31332.0, 31372.686273137206, 31444.21389465259, 4222.366645003243, 4368.584984426474, 4389.648828093745, 4391.341298805173, 4392.560743925614, 239867.0, 241369.0, 242164.0, 242270.0, 242574.0, 55041.0, 55738.72130639402, 57358.42641573615, 61536.69231653813, 62348.0, 54095.72952135214, 54223.45776542263, 54404.45595543994, 54522.18216726752, 54531.72734136383, 15385.846141538665, 15553.922230389002, 15586.688266234612, 15598.610034748996, 15604.0, 10965.725856853642, 11008.669739907815, 11014.889851101547, 11034.503447344889, 11065.446727663584, 20016.2994295199, 20473.385798426072, 20538.38384848457, 20547.897260513902, 20717.89641051815, 7813.179616140337, 7979.760607181794, 8029.156938521488, 8047.919520804834, 8166.1833816619055, 1039.667306461925, 1070.1652710885521, 1070.6520380876245, 1082.695169399766, 1262.5265525427965, 30240.395192096035, 30351.848240759096, 30905.536416953764, 30989.380212395627, 31048.379032419678, 1130.739929816147, 1148.0643275730254, 1173.143605168232, 1206.8069108942527, 1297.2087026913575, 15802.288896999662, 15891.443799466962, 15933.123678197579, 16089.195540222941, 16278.75581866273, 335822.0, 348536.0, 351215.0, 351835.0, 351836.0, 51773.223401649004, 51935.0, 52107.0, 52262.0, 52409.47590524122, 1425.030978934314, 1429.0354011042505, 1436.2316160854102, 1442.02663202338, 1450.2966061460183, 29292.70707292985, 30371.0, 30373.507046689912, 30630.846845765627, 31442.842785785924, 44817.77591112023, 45015.324770127816, 45082.54917450783, 45096.77451612721, 45313.0, 267454.0, 272658.0, 273049.0, 273529.0, 274420.0, 33239.50140747843, 33388.66611333856, 33577.16057098592, 33650.32699346048, 48987.75506122447, 47406.28890566575, 47828.28257576209, 48008.0, 48017.75991120162, 48798.51201488082, 41566.58433415748, 42894.78552607217, 43139.0, 44787.0, 45320.32019519776, 39923.40114898337, 40622.59377406188, 40895.591044089175, 42808.35787463253, 44883.55116448925, 42379.364309535995, 43062.35406468843, 43251.35122973095, 43614.78192609017, 43639.56360436355, 37052.44421333628, 37361.31006154002, 37440.812795935846, 38242.808785955895, 38581.228375431776, 28563.857180713963, 29279.707202927697, 29507.0, 29861.850690746407, 29975.55036674408], "unit": "score", "name": "ext.html", "value": 19383.812438836434}, {"lowerIsBetter": false, "replicates": [386.9632384923431, 396.59349167103716, 399.2175336340772, 399.5804405374357, 402.83982131461386, 17776.733348999776, 18216.635667286664, 18344.174512146936, 18609.90695046526, 18922.33771817985, 16176.35294588218, 16203.432879849208, 16302.347906083773, 16723.331066757317, 16817.579560510992, 5215.478452154783, 5401.081816091274, 5418.078926582471, 5419.187121931703, 5422.105352616833, 5173.379194496647, 5269.6311258211945, 5287.629865909388, 5321.4412486688725, 5327.627066105374, 5297.973510132444, 5333.653312534692, 5387.919181212285, 5530.640508366963, 5580.86047848803, 4999.975000124994, 5364.168553874156, 5539.41836107211, 5584.944150558483, 5625.80309689161, 5103.311053007834, 5365.812196573102, 5386.3536375634785, 5387.461253874581, 5407.026735187665, 12891.35543222835, 13023.739525209538, 13272.933635331858, 13324.333783310893, 13343.332083489564, 2189.7372315322264, 2224.143704673696, 2247.078697733921, 2321.651752237161, 2356.5286942611547, 9503.144716975436, 9635.277354198393, 9738.90261097394, 9784.168345690625, 9854.556544955423, 1921.193098898466, 1946.6787979983428, 1948.7466629338237, 1981.8414526837962, 1986.801319868016, 59147.704261478844, 60638.69680651613, 61006.0, 61211.0, 62598.37401626017, 10173.338732982333, 10594.682159535227, 10804.567817287378, 10824.404657743742, 10852.45737713127, 14056.297185140702, 14101.083429577046, 14139.64650883736, 14159.78760318596, 14289.356978935974, 7552.622368881534, 7585.6965721371635, 7605.277498637621, 7611.961940190264, 7654.655540500691, 7122.821929451805, 7278.708851645875, 7301.0, 7337.046183996046, 7338.596377199198, 4582.037772067836, 4699.083678682692, 4713.599344055725, 4731.124741922756, 4755.690880092783, 1904.6381187574316, 1918.168149417303, 1954.6383918975034, 1985.2852972929734, 1986.1261045140093, 478.46650984153115, 951.5908159491347, 1004.6584161385164, 1011.0688584802991, 1140.5836869542557, 10849.620263290904, 11299.152563557765, 11312.773744525228, 11347.092232621371, 11413.0, 493.9678920870132, 501.5461007787958, 522.681164489661, 523.2961666558473, 527.7282199667175, 6213.099100630383, 6490.902636460457, 6494.707738151795, 6515.706793194223, 6521.771737989147, 416639.0, 418728.0, 561061.0, 563350.0, 564896.0, 48088.27867581989, 48835.267470987965, 61993.0, 72548.63725681338, 79623.60188199022, 1167.3404526442532, 1198.4367347346733, 1212.1575505023923, 1213.7754515414676, 1220.725336799213, 15759.13324767103, 15967.600809979844, 16062.357505699641, 16126.113063781135, 16240.18799060066, 33833.323333533684, 33844.661553384154, 34508.65491345155, 34788.652113479555, 35205.295894081464, 44276.33585496156, 44944.32583511315, 47433.762831185624, 51638.48361516487, 53986.19020714771, 9477.620895164117, 10262.179025677779, 10514.474276286002, 10656.733581660521, 11020.44897755125, 6834.043233947152, 11952.103592230791, 12140.757184856076, 12308.81536776967, 12372.62882113538, 7005.894911576229, 7743.6515356810205, 7801.336886364723, 7984.24149705777, 8148.877766833383, 7317.2316906726155, 7947.086085100056, 8057.0, 8062.677492900453, 8174.7956301092945, 7913.327367173854, 7949.205079492004, 8207.794805129919, 8264.132266112212, 8321.500709957421, 11055.94472027667, 11098.2786118902, 11099.167562433011, 11174.497147628213, 11303.7739245213, 10812.189085818753, 11327.830082548604, 11341.09271258281, 11478.253913495597, 11658.242214256046], "unit": "score", "name": "jquery.html", "value": 8019.869916965283}, {"lowerIsBetter": false, "replicates": [1496.4537943650566, 1543.1898253416955, 1768.5490199998999, 1864.6529479584144, 1914.6840771272741, 8131.0, 8223.75328740138, 8342.833143337144, 8371.37214708897, 8449.155084491555, 8418.915810841905, 8448.788780280496, 8494.235518803307, 8523.01985271694, 8559.0, 2444.05903727065, 2451.6812814334203, 2458.299384675368, 2469.0370755405406, 2474.270090323359, 2468.962965555518, 2515.069424313007, 2522.2811498722867, 2523.5836087045614, 2530.266222795387, 2325.511642555057, 2371.134535894395, 2384.3681424422543, 2423.8909249083836, 2438.6220135878966, 2402.3753824005707, 2408.915687950922, 2428.3079322393123, 2433.0, 2442.560339138954, 2426.8543887366636, 2436.6954130733657, 2440.341107900857, 2449.5345884282106, 2473.5547601431913, 8310.376721745833, 8311.418200725951, 8369.916300836974, 8373.246407823264, 8382.329413646894, 5070.0, 5138.306328645623, 5150.690958542462, 5213.817516386908, 5221.843344699665, 3272.8527216275324, 3312.6521715219797, 3326.3513614845115, 3336.7330613550857, 3390.4066788312193, 1050.144132531984, 1063.3619828103153, 1087.429099722652, 1103.365564800243, 1116.3246236027169, 11935.641930742091, 12054.758904821942, 12072.215306005082, 12077.15459917806, 12094.032477401875, 4370.453693288339, 4374.934375984363, 4376.212281789309, 4516.051629157913, 4560.065186636732, 9678.75803104914, 9707.6116955321, 9717.222622190207, 9740.025997400346, 9773.31586788918, 4764.737939413366, 4774.259989701602, 4788.928166077511, 4792.544708252711, 4806.735629540409, 4326.091520780608, 4354.216241076573, 4378.233809083397, 4393.51671316155, 4401.625861801783, 3662.4689420033947, 3703.4815125882396, 3740.8690695825517, 3742.0644838790304, 3743.794091325003, 1072.254782925859, 1076.7092884921028, 1102.2009043443438, 1104.320842681761, 1166.1661911733152, 1405.845357010728, 1410.7954346619888, 1415.363086611029, 1420.985790142106, 1445.5446534341859, 7949.960250198827, 7976.122626511079, 8037.397195210383, 8037.7990550235545, 8041.517508949365, 1166.9241499302518, 1190.3036723516839, 1204.27141579345, 1206.119532741104, 1209.8124790657462, 6083.726232319556, 6202.255729312421, 6205.565610407228, 6249.750009999549, 6301.590396624205, 10244.282900196915, 10560.683179504627, 10601.151907847354, 10603.469826508644, 10734.677959661223, 9706.563204655666, 10492.370457772558, 10509.474526273656, 10512.894871051345, 10515.421651809223, 7851.607419628996, 7977.401694872908, 8011.319037881845, 8034.839303213903, 8039.557824319719, 7821.569813660303, 7828.217178282126, 7922.445428819928, 7973.760787176394, 8003.959980200062, 9131.589078491617, 9289.674861379819, 9408.482533460725, 9456.574454149717, 9575.0, 9626.374285671409, 9656.0, 9688.806223875625, 9776.902230977883, 9816.2147028239, 7305.634718263959, 7673.731419400294, 7798.298153166243, 7824.256695613907, 7870.881936771068, 8028.959855200686, 8073.111957684532, 8084.919150808417, 8108.918910811052, 8144.0, 7458.5151965122095, 7530.5858177798555, 7620.085589729268, 7627.466077374753, 7667.0416197975255, 7396.593187374746, 7448.664810083667, 7506.812329691801, 7568.886466702894, 7675.846483070196, 7306.490456381874, 7371.668274927534, 7667.69329226847, 7767.300942915164, 7787.766367008999, 7186.640667966476, 7186.748463803742, 7210.170830354366, 7217.025701530226, 7219.639018049182, 7065.6113913735235, 7146.785596432115, 7190.245024272376, 7200.459965502713, 7226.168990566152], "unit": "score", "name": "mootools.html", "value": 4864.547753148179}, {"lowerIsBetter": false, "replicates": [368.51540224604645, 379.1847527815199, 379.2888334373051, 379.69244911621604, 380.22054787685255, 6357.777477788279, 6359.046143078541, 6385.904211436832, 6453.322401147876, 6542.345765423455, 6336.809895703124, 6362.204724409449, 6378.936210637892, 6387.690523442695, 6422.389872962061, 4908.410990681124, 4920.384951881015, 4924.729139897313, 4926.211806111023, 4929.975350123244, 4917.09033828741, 4924.581410580105, 4929.4824043475455, 4930.063287975291, 4950.826721064764, 4685.859424217262, 4728.598069164125, 4800.0, 4802.87992800181, 4844.927326090112, 4727.432708075053, 4755.048990201939, 4798.920242945327, 4803.039392121555, 4808.278758186265, 4213.894652633678, 4229.175310814392, 4239.59723826236, 4265.7440553566885, 4273.7008409411355, 5993.130996005599, 6021.397860213988, 6028.638281703112, 6037.577369584131, 6042.093685947143, 5654.660720356792, 5696.430356964312, 5756.251687280626, 5766.0774276116035, 5781.103928891029, 6785.762498312584, 6804.115464989569, 6820.658967051628, 6822.5565338253355, 6834.521583489158, 4748.762561871893, 4770.61835053195, 4771.761411929389, 4776.355192049064, 4786.904261914742, 6983.9650801745665, 7003.82490437738, 7057.0, 7075.221725610128, 7116.395106415961, 4874.025194960951, 4888.242322439956, 4889.217725163957, 4891.290762839369, 4902.068606964665, 4940.6788558743565, 4947.604191664658, 4949.678270912379, 4962.230854217602, 4966.925496117561, 5697.230873832063, 5711.371749107595, 5716.57125715573, 5719.48524632785, 5723.828285151452, 6717.865642687118, 6800.013997970266, 6825.55633883796, 6851.314868513109, 6859.314068593101, 1736.0712019069738, 1760.2167035669004, 1761.4363403710945, 1764.7441121037377, 1764.8146944570892, 1171.4611278811672, 1189.0368801270997, 1196.1387800783423, 1201.6875612340855, 1212.7271363943219, 6491.51313651478, 6508.772192973223, 6510.511711621647, 6522.119513865662, 6522.282548919615, 6998.265182155902, 7008.614526201108, 7030.086088808423, 7055.717771289091, 7065.89401158983, 6386.489080873519, 6437.519370544707, 6483.416492515602, 6540.05169250456, 6610.933890661032, 3799.1262009737916, 3837.2325534893134, 3843.2121415109837, 3853.094522787143, 3867.961320386816, 7300.853982920312, 7332.450066245053, 7333.559986400833, 7350.338469537767, 7355.485116041826, 7171.49799514029, 7311.0130132432505, 7337.376323012603, 7344.192138864827, 7364.0, 7245.275472452818, 7296.562206267641, 7339.70641174347, 7349.191588925214, 7356.816079597946, 7063.0, 7079.327463890922, 7090.539114957512, 7106.609136497542, 7110.680019399243, 6823.590584564942, 7014.929850701632, 7024.543404678884, 7039.964800175966, 7044.894326585003, 7318.6706598202145, 7346.4122870169185, 7355.963220183865, 7371.741989030358, 7407.629618518945, 4870.95129048705, 4918.581920536794, 4919.778609962632, 4939.876503087452, 4953.876153096201, 6877.2091209509545, 7088.936659501116, 7118.893216601651, 7144.3570078693165, 7146.464015198985, 6888.552244104118, 6912.792616221522, 6915.481338899704, 6928.272531384334, 6940.479464040116, 6683.231428385603, 6850.143732033496, 6880.208775990625, 6907.93092069093, 6925.065116209247, 6725.831854203684, 6780.0, 6797.830054248683, 6800.795976120724, 6810.31896810315, 6899.0, 6920.826979325557, 6934.549254298455, 6936.7225310987, 6952.791416257521, 6621.33786621334, 6694.096297000037, 6713.865722685421, 6743.35938085881, 6744.055832183596], "unit": "score", "name": "prototype.html", "value": 5169.386586648014}, {"lowerIsBetter": false, "replicates": [835.7659855240535, 855.3627547477131, 904.4482865452073, 910.5811326789676, 941.7363138321268, 13765.931170344147, 13951.651208719775, 14113.506027289048, 14469.34887930043, 14492.782608260859, 14409.207493587848, 14470.855291447082, 14472.131672099655, 14477.2761361932, 14501.709965800677, 858.0689951402735, 861.4400639584258, 871.1984973824098, 872.3326655108847, 872.9650813967434, 863.2532859076916, 871.1071152069148, 874.0341922176, 876.5529579914225, 878.2885862451403, 912.2337236721153, 914.9771255718593, 916.2120576304372, 921.617528725578, 929.9023602521705, 905.3933864310927, 909.0273407454027, 910.0080911806164, 911.4166933162782, 923.044648788504, 680.8263892707378, 687.1959807025742, 687.5805758487319, 688.4114082459475, 689.0387908867102, 15130.621734456616, 15207.543773686808, 15222.771658425021, 15228.695426091415, 15375.846241537552, 13602.455901764017, 13695.383707733175, 13729.862701372958, 13732.65668358289, 13852.16886986784, 11583.07335413165, 11603.07175425964, 11605.6518304451, 11848.289102653782, 12120.151589388746, 3915.960840391617, 3948.9012774680577, 4004.3192657248337, 4004.918671958584, 4037.4347591337237, 53589.0, 54024.0, 54058.72970635161, 54341.72829135829, 54550.72724636391, 10787.56849726018, 10949.726256843642, 10996.725081872857, 11167.106631469464, 11306.604268850551, 17953.551161221076, 17991.280348786164, 18055.54861128456, 18101.185446654934, 18426.170822313026, 8004.759857204293, 8028.638711258008, 8077.151899050633, 8088.474249173785, 8092.473989190684, 4535.047639995571, 4596.655250856133, 4648.65135114861, 4660.86017419478, 4669.322948172564, 3174.2857856982455, 3193.3134376109247, 3193.4730769422786, 3200.567923330367, 3233.8706451742137, 573.4580821123998, 609.3510411411921, 611.5902345428574, 628.5819929746667, 645.8256270806855, 551.7820460917915, 580.9564282678816, 592.9940700592939, 633.822529691687, 651.7588492257801, 8641.567921603895, 8899.377043606886, 8928.017918029012, 8941.195292423714, 9028.458292502472, 621.9768480849068, 658.2463079773632, 701.9468055936468, 727.7707522130512, 734.229059487536, 3910.022494376406, 4054.959450405458, 4478.596926276651, 4518.88702782433, 4621.838235661803, 61359.0, 61803.38196618066, 61849.69075154595, 62100.37899621036, 62254.37745622576, 48801.75599121982, 49314.506854930994, 49586.0, 50368.74815625972, 50510.49489505131, 49416.25875611869, 49781.50218497841, 50380.244296335586, 50389.0, 51224.23163652548, 8888.777780555538, 9087.36388452802, 9389.436633801994, 9750.219982401533, 9804.950975245078, 35978.28043439169, 36514.0, 37013.25973480461, 37852.621473786014, 37914.8104259477, 45175.54824451714, 46810.765946171414, 47183.292250616956, 47916.520834791205, 48370.0, 11014.724631884266, 11660.06719462458, 11697.590584329508, 11763.941180294043, 11797.52809887595, 12680.175788573713, 12715.80926286088, 12805.871941280468, 12811.743765124831, 12964.546240881524, 11491.597794077166, 11615.18340288704, 11918.821217681569, 11932.58235961772, 12244.510219591117, 11357.977876790694, 11367.20429569922, 12086.0, 12109.33398663082, 12293.262404255773, 11254.774904502028, 11428.542858285575, 11435.656930292105, 11449.0, 12182.025437964765, 9140.588673509841, 9260.583273752833, 9276.443413395218, 9747.756306092404, 9765.609375624896, 9358.0, 9733.853992190265, 9797.412155270707, 10004.299699021, 10076.22903701488], "unit": "score", "name": "yui.html", "value": 6702.030438325724}], "name": "dromaeo_css", "value": 7264.316291383875}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 111.0, 112.0, 112.0, 121.0, 109.0, 109.0, 113.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [160.0, 133.0, 153.0, 163.0, 125.0, 151.0, 149.0, 135.0, 173.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 146.9}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 162.0, 161.0, 164.0, 161.0, 161.0, 160.0, 164.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [75.0, 77.0, 76.0, 165.0, 73.0, 72.0, 75.0, 77.0, 157.0, 77.0], "unit": "score", "name": "audio-fft", "value": 92.4}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 138.0, 95.0, 96.0, 96.0, 142.0, 95.0, 95.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [109.0, 111.0, 109.0, 111.0, 110.0, 112.0, 110.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [149.0, 146.0, 147.0, 148.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 97.0, 97.0, 97.0, 97.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [52.0, 60.0, 56.0, 54.0, 54.0, 56.0, 55.0, 63.0, 53.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 55.9}, {"lowerIsBetter": true, "replicates": [63.0, 66.0, 64.0, 63.0, 64.0, 65.0, 64.0, 63.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.0}, {"lowerIsBetter": true, "replicates": [80.0, 89.0, 82.0, 83.0, 82.0, 89.0, 82.0, 82.0, 81.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.1}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 124.0, 112.0, 118.0, 118.0, 110.0, 117.0, 113.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.9}, {"lowerIsBetter": true, "replicates": [151.0, 137.0, 148.0, 136.0, 138.0, 135.0, 128.0, 138.0, 138.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.0}, {"lowerIsBetter": true, "replicates": [68.0, 73.0, 65.0, 66.0, 70.0, 64.0, 63.0, 63.0, 64.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.1}], "name": "kraken", "value": 1498.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.25103906899417], "unit": "score", "name": "Richards", "value": 212.3415300000001}, {"lowerIsBetter": false, "replicates": [172.08742040956807], "unit": "score", "name": "DeltaBlue", "value": 384.21169799999984}, {"lowerIsBetter": false, "replicates": [278.08676307007784], "unit": "score", "name": "Encrypt", "value": 957.1868759999999}, {"lowerIsBetter": false, "replicates": [5213.541666666667], "unit": "score", "name": "Decrypt", "value": 51.05569630369634}, {"lowerIsBetter": false, "replicates": [916.5902841429881], "unit": "score", "name": "RayTrace", "value": 807.327999}, {"lowerIsBetter": false, "replicates": [564.0157924421884], "unit": "score", "name": "Earley", "value": 1181.6388990000003}, {"lowerIsBetter": false, "replicates": [11111.111111111111], "unit": "score", "name": "Boyer", "value": 59.98166999999996}, {"lowerIsBetter": false, "replicates": [39211.53846153846], "unit": "score", "name": "RegExp", "value": 23.232574791564506}, {"lowerIsBetter": false, "replicates": [506.32911392405066], "unit": "score", "name": "Splay", "value": 160.94472500000003}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 22084.425528888543}]} 10:40:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "22084.43"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1498.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7264.32"}}} 10:40:15 INFO - Return code: 0 10:40:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:40:15 INFO - # TBPL SUCCESS # 10:40:15 INFO - Running post-action listener: _resource_record_post_action 10:40:15 INFO - Running post-run listener: _resource_record_post_run 10:40:16 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 16384; Write bytes: 510390272; Read time: 104; Write time: 1232556 10:40:16 INFO - install - Wall time: 16s; CPU: 18.0%; Read bytes: 0; Write bytes: 242204672; Read time: 0; Write time: 820540 10:40:16 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 16384; Write bytes: 268185600; Read time: 104; Write time: 412016 10:40:16 INFO - Running post-run listener: _upload_blobber_files 10:40:16 INFO - Blob upload gear active. 10:40:16 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 10:40:16 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 10:40:16 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'] 10:40:16 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 10:40:16 INFO - (blobuploader) - INFO - Open directory for files ... 10:40:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:40:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:40:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:40:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:40:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:40:17 INFO - (blobuploader) - INFO - Done attempting. 10:40:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:40:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:40:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:40:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:40:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:40:18 INFO - (blobuploader) - INFO - Done attempting. 10:40:18 INFO - (blobuploader) - INFO - Iteration through files over. 10:40:18 INFO - Return code: 0 10:40:18 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 10:40:18 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 10:40:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0fde7509083ba5ab7d561430ef6039c43a4e7264c5a217e744760287784e7de0bfb70b261d0377bcbc589f13ffb6248a2e1e9666495a92d8d07ae8aa751b7cab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2912b80acb933b3ce2e8e059fcba0fda93b72e05967205ab8ab41580339f67a4d7ba4e389c360ba28d219b87a3366a7756c9bd0a76dfbf7597fc646ff18ad5f5"} 10:40:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 10:40:18 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 10:40:18 INFO - Contents: 10:40:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0fde7509083ba5ab7d561430ef6039c43a4e7264c5a217e744760287784e7de0bfb70b261d0377bcbc589f13ffb6248a2e1e9666495a92d8d07ae8aa751b7cab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2912b80acb933b3ce2e8e059fcba0fda93b72e05967205ab8ab41580339f67a4d7ba4e389c360ba28d219b87a3366a7756c9bd0a76dfbf7597fc646ff18ad5f5"} 10:40:18 INFO - Running post-run listener: copy_logs_to_upload_dir 10:40:18 INFO - Copying logs to upload dir... 10:40:18 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 10:40:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.758411 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-02-19 10:40:18.067722) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-19 10:40:18.071392) ========= 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=8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639 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/0fde7509083ba5ab7d561430ef6039c43a4e7264c5a217e744760287784e7de0bfb70b261d0377bcbc589f13ffb6248a2e1e9666495a92d8d07ae8aa751b7cab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2912b80acb933b3ce2e8e059fcba0fda93b72e05967205ab8ab41580339f67a4d7ba4e389c360ba28d219b87a3366a7756c9bd0a76dfbf7597fc646ff18ad5f5"} build_url:https://queue.taskcluster.net/v1/task/ZlkGt-6vRiGiABFGvuWVqw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011336 build_url: 'https://queue.taskcluster.net/v1/task/ZlkGt-6vRiGiABFGvuWVqw/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/0fde7509083ba5ab7d561430ef6039c43a4e7264c5a217e744760287784e7de0bfb70b261d0377bcbc589f13ffb6248a2e1e9666495a92d8d07ae8aa751b7cab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2912b80acb933b3ce2e8e059fcba0fda93b72e05967205ab8ab41580339f67a4d7ba4e389c360ba28d219b87a3366a7756c9bd0a76dfbf7597fc646ff18ad5f5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-19 10:40:18.100275) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 10:40:18.100669) ========= 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=8783db0840cc980e80bb0bd400000236-1455904904.801424-559102639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 10:40:18.183238) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-19 10:40:18.183631) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-19 10:40:18.184095) ========= ========= Total master_lag: 0.29 =========