builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-005 starttime: 1455211316.55 results: success (0) buildid: 20160211063231 builduid: 8abe04d6c95842ab98d44d698fd808c5 revision: 8e11eaf0cafbed22c0960cae5b810e7085da16f3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 09:21:56.546229) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 09:21:56.546626) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 09:21:56.546934) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006480 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 09:21:56.616413) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 09:21:56.616685) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 09:21:56.711553) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 09:21:56.711806) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.025380 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 09:21:56.766218) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 09:21:56.766509) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 09:21:56.766856) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 09:21:56.767145) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-11 09:21:57-- 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% 223M=0s 2016-02-11 09:21:57 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106251 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 09:21:56.886989) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 09:21:56.887322) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.032942 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 09:21:56.938575) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 09:21:56.939221) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8e11eaf0cafbed22c0960cae5b810e7085da16f3 --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 8e11eaf0cafbed22c0960cae5b810e7085da16f3 --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=7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-11 09:21:57,227 truncating revision to first 12 chars 2016-02-11 09:21:57,227 Setting DEBUG logging. 2016-02-11 09:21:57,227 attempt 1/10 2016-02-11 09:21:57,227 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8e11eaf0cafb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-11 09:21:57,455 unpacking tar archive at: mozilla-aurora-8e11eaf0cafb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.498736 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 09:21:57.451864) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 09:21:57.452217) ========= echo 8e11eaf0cafbed22c0960cae5b810e7085da16f3 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8e11eaf0cafbed22c0960cae5b810e7085da16f3'] 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=7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 8e11eaf0cafbed22c0960cae5b810e7085da16f3 program finished with exit code 0 elapsedTime=0.004639 script_repo_revision: '8e11eaf0cafbed22c0960cae5b810e7085da16f3' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 09:21:57.504488) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 09:21:57.504806) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 09:21:57.514494) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-02-11 09:21:57.514827) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:21:57 INFO - MultiFileLogger online at 20160211 09:21:57 in /builds/slave/test-pgo 09:21:57 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 09:21:57 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:21:57 INFO - {'append_to_log': False, 09:21:57 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:21:57 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:21:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:21:57 INFO - 'branch': 'Mozilla-Aurora', 09:21:57 INFO - 'buildbot_json_path': 'buildprops.json', 09:21:57 INFO - 'config_files': ('talos/linux_config.py',), 09:21:57 INFO - 'default_actions': ('clobber', 09:21:57 INFO - 'read-buildbot-config', 09:21:57 INFO - 'download-and-extract', 09:21:57 INFO - 'populate-webroot', 09:21:57 INFO - 'create-virtualenv', 09:21:57 INFO - 'install', 09:21:57 INFO - 'run-tests'), 09:21:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:21:57 INFO - 'download_minidump_stackwalk': True, 09:21:57 INFO - 'download_symbols': 'ondemand', 09:21:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:21:57 INFO - 'tooltool.py': '/tools/tooltool.py', 09:21:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:21:57 INFO - '/tools/misc-python/virtualenv.py')}, 09:21:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:21:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:21:57 INFO - 'installer_path': 'installer.exe', 09:21:57 INFO - 'log_level': 'info', 09:21:57 INFO - 'log_name': 'talos', 09:21:57 INFO - 'log_to_console': True, 09:21:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:21:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:21:57 INFO - 'opt_config_files': (), 09:21:57 INFO - 'pip_index': False, 09:21:57 INFO - 'sps_profile': False, 09:21:57 INFO - 'sps_profile_interval': 0, 09:21:57 INFO - 'suite': 'dromaeojs-e10s', 09:21:57 INFO - 'system_bits': '32', 09:21:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:21:57 INFO - 'title': 'talos-linux64-ix-005', 09:21:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:21:57 INFO - 'use_talos_json': True, 09:21:57 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:21:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:21:57 INFO - 'work_dir': 'build'} 09:21:57 INFO - ##### 09:21:57 INFO - ##### Running clobber step. 09:21:57 INFO - ##### 09:21:57 INFO - Running pre-action listener: _resource_record_pre_action 09:21:57 INFO - Running main action method: clobber 09:21:57 INFO - rmtree: /builds/slave/test-pgo/build 09:21:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:22:03 INFO - Running post-action listener: _resource_record_post_action 09:22:03 INFO - ##### 09:22:03 INFO - ##### Running read-buildbot-config step. 09:22:03 INFO - ##### 09:22:03 INFO - Running pre-action listener: _resource_record_pre_action 09:22:03 INFO - Running main action method: read_buildbot_config 09:22:03 INFO - Using buildbot properties: 09:22:03 INFO - { 09:22:03 INFO - "project": "", 09:22:03 INFO - "product": "firefox", 09:22:03 INFO - "script_repo_revision": "production", 09:22:03 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:22:03 INFO - "repository": "", 09:22:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:22:03 INFO - "buildid": "20160211063231", 09:22:03 INFO - "pgo_build": "True", 09:22:03 INFO - "basedir": "/builds/slave/test-pgo", 09:22:03 INFO - "buildnumber": 121, 09:22:03 INFO - "slavename": "talos-linux64-ix-005", 09:22:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:22:03 INFO - "platform": "ubuntu64_hw", 09:22:03 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:22:03 INFO - "branch": "mozilla-aurora", 09:22:03 INFO - "repo_path": "releases/mozilla-aurora", 09:22:03 INFO - "revision": "8e11eaf0cafbed22c0960cae5b810e7085da16f3", 09:22:03 INFO - "stage_platform": "linux64-pgo", 09:22:03 INFO - "builduid": "8abe04d6c95842ab98d44d698fd808c5", 09:22:03 INFO - "slavebuilddir": "test" 09:22:03 INFO - } 09:22:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/QD0qQJndTUe8VGGFKSGAng/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 09:22:03 INFO - Running post-action listener: _resource_record_post_action 09:22:03 INFO - ##### 09:22:03 INFO - ##### Running download-and-extract step. 09:22:03 INFO - ##### 09:22:03 INFO - Running pre-action listener: _resource_record_pre_action 09:22:03 INFO - Running main action method: download_and_extract 09:22:03 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:03 INFO - https://queue.taskcluster.net/v1/task/QD0qQJndTUe8VGGFKSGAng/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:22:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QD0qQJndTUe8VGGFKSGAng/artifacts/public/build/test_packages.json 09:22:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QD0qQJndTUe8VGGFKSGAng/artifacts/public/build/test_packages.json 09:22:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QD0qQJndTUe8VGGFKSGAng/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:22:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QD0qQJndTUe8VGGFKSGAng/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:22:08 INFO - Downloaded 1448 bytes. 09:22:08 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:22:08 INFO - Using the following test package requirements: 09:22:08 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 09:22:08 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:22:08 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:22:08 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:22:08 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:22:08 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:22:08 INFO - u'jsshell-linux-x86_64.zip'], 09:22:08 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:22:08 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:22:08 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 09:22:08 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:22:08 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:22:08 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:22:08 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:22:08 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:22:08 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:22:08 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 09:22:08 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:22:08 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:22:08 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:08 INFO - https://queue.taskcluster.net/v1/task/QD0qQJndTUe8VGGFKSGAng/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:22:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QD0qQJndTUe8VGGFKSGAng/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:22:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QD0qQJndTUe8VGGFKSGAng/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:22:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QD0qQJndTUe8VGGFKSGAng/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 09:22:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QD0qQJndTUe8VGGFKSGAng/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 09:22:17 INFO - Downloaded 22397615 bytes. 09:22:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:22:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 09:22:19 INFO - Return code: 0 09:22:19 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 09:22: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')]} 09:22:19 INFO - https://queue.taskcluster.net/v1/task/QD0qQJndTUe8VGGFKSGAng/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:22:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QD0qQJndTUe8VGGFKSGAng/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:22:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QD0qQJndTUe8VGGFKSGAng/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:22:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QD0qQJndTUe8VGGFKSGAng/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 09:22:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QD0qQJndTUe8VGGFKSGAng/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 09:22:20 INFO - Downloaded 22397615 bytes. 09:22:20 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'] 09:22:20 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 09:22:21 INFO - Return code: 0 09:22:21 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')]} 09:22:21 INFO - https://queue.taskcluster.net/v1/task/QD0qQJndTUe8VGGFKSGAng/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:22:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QD0qQJndTUe8VGGFKSGAng/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 09:22:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QD0qQJndTUe8VGGFKSGAng/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 09:22:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QD0qQJndTUe8VGGFKSGAng/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 09:22:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QD0qQJndTUe8VGGFKSGAng/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 09:22:22 INFO - Downloaded 10706572 bytes. 09:22:22 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'] 09:22:22 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 09:22:22 INFO - Return code: 0 09:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:22 INFO - https://queue.taskcluster.net/v1/task/QD0qQJndTUe8VGGFKSGAng/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:22:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QD0qQJndTUe8VGGFKSGAng/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:22:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QD0qQJndTUe8VGGFKSGAng/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:22:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QD0qQJndTUe8VGGFKSGAng/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 09:22:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QD0qQJndTUe8VGGFKSGAng/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 09:22:25 INFO - Downloaded 59593917 bytes. 09:22:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QD0qQJndTUe8VGGFKSGAng/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:22:25 INFO - mkdir: /builds/slave/test-pgo/properties 09:22:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:22:25 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:22:25 INFO - Contents: 09:22:25 INFO - build_url:https://queue.taskcluster.net/v1/task/QD0qQJndTUe8VGGFKSGAng/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:22:26 INFO - Running post-action listener: _resource_record_post_action 09:22:26 INFO - Running post-action listener: set_extra_try_arguments 09:22:26 INFO - ##### 09:22:26 INFO - ##### Running populate-webroot step. 09:22:26 INFO - ##### 09:22:26 INFO - Running pre-action listener: _resource_record_pre_action 09:22:26 INFO - Running main action method: populate_webroot 09:22:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:22:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:22:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:22:26 INFO - '--tppagecycles', 09:22:26 INFO - '7'], 09:22:26 INFO - 'tests': ['tsvgm']}}, 09:22:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:22:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:22:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:22:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:22:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:22:26 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:22:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:22:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:26 INFO - 'talos_options': ['--e10s'], 09:22:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:22:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:26 INFO - 'tests': ['damp', 'tps']}, 09:22:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:26 INFO - 'talos_options': ['--e10s'], 09:22:26 INFO - 'tests': ['damp', 'tps']}, 09:22:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:22:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:22:26 INFO - 'other': {'tests': ['a11yr', 09:22:26 INFO - 'ts_paint', 09:22:26 INFO - 'tpaint', 09:22:26 INFO - 'sessionrestore', 09:22:26 INFO - 'sessionrestore_no_auto_restore']}, 09:22:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:22:26 INFO - 'tests': ['a11yr', 09:22:26 INFO - 'ts_paint', 09:22:26 INFO - 'tpaint', 09:22:26 INFO - 'sessionrestore', 09:22:26 INFO - 'sessionrestore_no_auto_restore']}, 09:22:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:22:26 INFO - 'tests': ['a11yr', 09:22:26 INFO - 'ts_paint', 09:22:26 INFO - 'tpaint', 09:22:26 INFO - 'sessionrestore', 09:22:26 INFO - 'sessionrestore_no_auto_restore']}, 09:22:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:22:26 INFO - 'tests': ['a11yr', 09:22:26 INFO - 'ts_paint', 09:22:26 INFO - 'tpaint', 09:22:26 INFO - 'sessionrestore', 09:22:26 INFO - 'sessionrestore_no_auto_restore']}, 09:22:26 INFO - 'other_l64': {'tests': ['a11yr', 09:22:26 INFO - 'ts_paint', 09:22:26 INFO - 'tpaint', 09:22:26 INFO - 'sessionrestore', 09:22:26 INFO - 'sessionrestore_no_auto_restore']}, 09:22:26 INFO - 'other_nol64': {'tests': ['a11yr', 09:22:26 INFO - 'ts_paint', 09:22:26 INFO - 'tpaint', 09:22:26 INFO - 'sessionrestore', 09:22:26 INFO - 'sessionrestore_no_auto_restore']}, 09:22:26 INFO - 'svgr': {'tests': ['tsvgx', 09:22:26 INFO - 'tsvgr_opacity', 09:22:26 INFO - 'tart', 09:22:26 INFO - 'tscrollx', 09:22:26 INFO - 'cart']}, 09:22:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:22:26 INFO - 'tests': ['tsvgx', 09:22:26 INFO - 'tsvgr_opacity', 09:22:26 INFO - 'tart', 09:22:26 INFO - 'tscrollx', 09:22:26 INFO - 'cart']}, 09:22:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:26 INFO - 'tests': ['tp5o']}, 09:22:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:26 INFO - 'talos_options': ['--e10s'], 09:22:26 INFO - 'tests': ['tp5o']}, 09:22:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:26 INFO - 'talos_options': ['--xperf_path', 09:22:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:22:26 INFO - 'tests': ['tp5n']}, 09:22:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:26 INFO - 'talos_options': ['--e10s', 09:22:26 INFO - '--xperf_path', 09:22:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:22:26 INFO - 'tests': ['tp5n']}}, 09:22:26 INFO - 'talos.zip': {'path': '', 09:22:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:22:26 INFO - Running post-action listener: _resource_record_post_action 09:22:26 INFO - ##### 09:22:26 INFO - ##### Running create-virtualenv step. 09:22:26 INFO - ##### 09:22:26 INFO - Running pre-action listener: _resource_record_pre_action 09:22:26 INFO - Running main action method: create_virtualenv 09:22:26 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:22:26 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 09:22:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:22:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:22:26 INFO - Using real prefix '/usr' 09:22:26 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:22:26 INFO - Installing distribute.............................................................................................................................................................................................done. 09:22:28 INFO - Installing pip.................done. 09:22:28 INFO - Return code: 0 09:22:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe882bbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a927f0>, '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 0x29fe2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fe760>, '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': '7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488', '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 09:22:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 09:22:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:22:28 INFO - Using env: {'DISPLAY': ':0', 09:22:28 INFO - 'HOME': '/home/cltbld', 09:22:28 INFO - 'LANG': 'en_US.UTF-8', 09:22:28 INFO - 'LANGUAGE': 'en_US:en', 09:22:28 INFO - 'LOGNAME': 'cltbld', 09:22:28 INFO - 'MAIL': '/var/mail/cltbld', 09:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:28 INFO - 'MOZ_NO_REMOTE': '1', 09:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:28 INFO - 'NO_EM_RESTART': '1', 09:22:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:22:28 INFO - 'PWD': '/builds/slave/test-pgo', 09:22:28 INFO - 'SHELL': '/bin/bash', 09:22:28 INFO - 'SHLVL': '1', 09:22:28 INFO - 'TERM': 'linux', 09:22:28 INFO - 'TMOUT': '86400', 09:22:28 INFO - 'USER': 'cltbld', 09:22:28 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488', 09:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:28 INFO - '_': '/tools/buildbot/bin/python'} 09:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:28 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 09:22:28 INFO - Cleaning up... 09:22:28 INFO - Return code: 0 09:22:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe882bbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a927f0>, '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 0x29fe2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fe760>, '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': '7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488', '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 09:22:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 09:22:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:22:28 INFO - Using env: {'DISPLAY': ':0', 09:22:28 INFO - 'HOME': '/home/cltbld', 09:22:28 INFO - 'LANG': 'en_US.UTF-8', 09:22:28 INFO - 'LANGUAGE': 'en_US:en', 09:22:28 INFO - 'LOGNAME': 'cltbld', 09:22:28 INFO - 'MAIL': '/var/mail/cltbld', 09:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:28 INFO - 'MOZ_NO_REMOTE': '1', 09:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:28 INFO - 'NO_EM_RESTART': '1', 09:22:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:22:28 INFO - 'PWD': '/builds/slave/test-pgo', 09:22:28 INFO - 'SHELL': '/bin/bash', 09:22:28 INFO - 'SHLVL': '1', 09:22:28 INFO - 'TERM': 'linux', 09:22:28 INFO - 'TMOUT': '86400', 09:22:28 INFO - 'USER': 'cltbld', 09:22:28 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488', 09:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:28 INFO - '_': '/tools/buildbot/bin/python'} 09:22:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:29 INFO - Downloading/unpacking psutil>=0.7.1 09:22: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 09:22: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 09:22: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 09:22: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 09:22: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 09:22: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 09:22:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:22:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:22:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:22:30 INFO - Installing collected packages: psutil 09:22:30 INFO - Running setup.py install for psutil 09:22:31 INFO - building 'psutil._psutil_linux' extension 09:22:31 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 09:22:31 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 09:22:31 INFO - building 'psutil._psutil_posix' extension 09:22:31 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 09:22:31 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 09:22:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:22:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:22:31 INFO - Successfully installed psutil 09:22:31 INFO - Cleaning up... 09:22:31 INFO - Return code: 0 09:22:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:31 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 0x7fe882bbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a927f0>, '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 0x29fe2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fe760>, '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': '7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488', '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 09:22:31 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 09:22:31 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 09:22:31 INFO - Using env: {'DISPLAY': ':0', 09:22:31 INFO - 'HOME': '/home/cltbld', 09:22:31 INFO - 'LANG': 'en_US.UTF-8', 09:22:31 INFO - 'LANGUAGE': 'en_US:en', 09:22:31 INFO - 'LOGNAME': 'cltbld', 09:22:31 INFO - 'MAIL': '/var/mail/cltbld', 09:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:31 INFO - 'MOZ_NO_REMOTE': '1', 09:22:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:31 INFO - 'NO_EM_RESTART': '1', 09:22:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:22:31 INFO - 'PWD': '/builds/slave/test-pgo', 09:22:31 INFO - 'SHELL': '/bin/bash', 09:22:31 INFO - 'SHLVL': '1', 09:22:31 INFO - 'TERM': 'linux', 09:22:31 INFO - 'TMOUT': '86400', 09:22:31 INFO - 'USER': 'cltbld', 09:22:31 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488', 09:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:31 INFO - '_': '/tools/buildbot/bin/python'} 09:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:22: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 09:22: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 09:22: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 09:22: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 09:22: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 09:22: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 09:22:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:22:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:22:33 INFO - Installing collected packages: mozsystemmonitor 09:22:33 INFO - Running setup.py install for mozsystemmonitor 09:22:33 INFO - Successfully installed mozsystemmonitor 09:22:33 INFO - Cleaning up... 09:22:33 INFO - Return code: 0 09:22:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:22:33 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')]} 09:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:33 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')]} 09:22:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:33 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 0x7fe882bbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a927f0>, '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 0x29fe2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fe760>, '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': '7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488', '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 09:22:33 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 09:22:33 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 09:22:33 INFO - Using env: {'DISPLAY': ':0', 09:22:33 INFO - 'HOME': '/home/cltbld', 09:22:33 INFO - 'LANG': 'en_US.UTF-8', 09:22:33 INFO - 'LANGUAGE': 'en_US:en', 09:22:33 INFO - 'LOGNAME': 'cltbld', 09:22:33 INFO - 'MAIL': '/var/mail/cltbld', 09:22:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:33 INFO - 'MOZ_NO_REMOTE': '1', 09:22:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:33 INFO - 'NO_EM_RESTART': '1', 09:22:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:22:33 INFO - 'PWD': '/builds/slave/test-pgo', 09:22:33 INFO - 'SHELL': '/bin/bash', 09:22:33 INFO - 'SHLVL': '1', 09:22:33 INFO - 'TERM': 'linux', 09:22:33 INFO - 'TMOUT': '86400', 09:22:33 INFO - 'USER': 'cltbld', 09:22:33 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488', 09:22:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:33 INFO - '_': '/tools/buildbot/bin/python'} 09:22:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:33 INFO - Downloading/unpacking blobuploader==1.2.4 09:22:33 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 09:22:33 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 09:22:33 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 09:22:33 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 09:22:33 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 09:22:33 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 09:22:35 INFO - Downloading blobuploader-1.2.4.tar.gz 09:22:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:22:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:22:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:22:36 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 09:22:36 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 09:22:36 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 09:22:36 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 09:22:36 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 09:22:36 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 09:22:36 INFO - Downloading docopt-0.6.1.tar.gz 09:22:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:22:36 INFO - Installing collected packages: blobuploader, requests, docopt 09:22:36 INFO - Running setup.py install for blobuploader 09:22:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:22:36 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:22:36 INFO - Running setup.py install for requests 09:22:36 INFO - Running setup.py install for docopt 09:22:36 INFO - Successfully installed blobuploader requests docopt 09:22:36 INFO - Cleaning up... 09:22:37 INFO - Return code: 0 09:22:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:22:37 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')]} 09:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:37 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')]} 09:22:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:37 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 0x7fe882bbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a927f0>, '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 0x29fe2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fe760>, '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': '7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488', '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 09:22:37 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 09:22:37 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 09:22:37 INFO - Using env: {'DISPLAY': ':0', 09:22:37 INFO - 'HOME': '/home/cltbld', 09:22:37 INFO - 'LANG': 'en_US.UTF-8', 09:22:37 INFO - 'LANGUAGE': 'en_US:en', 09:22:37 INFO - 'LOGNAME': 'cltbld', 09:22:37 INFO - 'MAIL': '/var/mail/cltbld', 09:22:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:37 INFO - 'MOZ_NO_REMOTE': '1', 09:22:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:37 INFO - 'NO_EM_RESTART': '1', 09:22:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:22:37 INFO - 'PWD': '/builds/slave/test-pgo', 09:22:37 INFO - 'SHELL': '/bin/bash', 09:22:37 INFO - 'SHLVL': '1', 09:22:37 INFO - 'TERM': 'linux', 09:22:37 INFO - 'TMOUT': '86400', 09:22:37 INFO - 'USER': 'cltbld', 09:22:37 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488', 09:22:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:37 INFO - '_': '/tools/buildbot/bin/python'} 09:22:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:22:37 INFO - Running setup.py (path:/tmp/pip-jAm8gc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:22:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:22:37 INFO - Running setup.py (path:/tmp/pip-9Dl9he-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:22:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:22:37 INFO - Running setup.py (path:/tmp/pip-_djIcZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:22:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:22:37 INFO - Running setup.py (path:/tmp/pip-3VMy5j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:22:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:22:37 INFO - Running setup.py (path:/tmp/pip-6roREn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:22:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:22:37 INFO - Running setup.py (path:/tmp/pip-MzUyqR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:22:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:22:37 INFO - Running setup.py (path:/tmp/pip-FpVG19-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:22:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:22:37 INFO - Running setup.py (path:/tmp/pip-UNOYRO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:22:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:22:37 INFO - Running setup.py (path:/tmp/pip-HeIOMU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:22:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:22:37 INFO - Running setup.py (path:/tmp/pip-__Xu_i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:22:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:22:37 INFO - Running setup.py (path:/tmp/pip-MypHXJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:22:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:22:38 INFO - Running setup.py (path:/tmp/pip-ptmFfq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:22:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:22:38 INFO - Running setup.py (path:/tmp/pip-rZTvQ3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:22:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:22:38 INFO - Running setup.py (path:/tmp/pip-GInE4W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:22:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:22:38 INFO - Running setup.py (path:/tmp/pip-jAbXWA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:22:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:22:38 INFO - Running setup.py (path:/tmp/pip-r6oDtX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:22:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:22:38 INFO - Running setup.py (path:/tmp/pip-91grRC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:22:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:22:38 INFO - Running setup.py install for manifestparser 09:22:38 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:22:38 INFO - Running setup.py install for mozcrash 09:22:38 INFO - Running setup.py install for mozdebug 09:22:38 INFO - Running setup.py install for mozdevice 09:22:38 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:22:38 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:22:38 INFO - Running setup.py install for mozfile 09:22:38 INFO - Running setup.py install for mozhttpd 09:22:39 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:22:39 INFO - Running setup.py install for mozinfo 09:22:39 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:22:39 INFO - Running setup.py install for mozInstall 09:22:39 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:22:39 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:22:39 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:22:39 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:22:39 INFO - Running setup.py install for mozleak 09:22:39 INFO - Running setup.py install for mozlog 09:22:39 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:22:39 INFO - Running setup.py install for moznetwork 09:22:39 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:22:39 INFO - Running setup.py install for mozprocess 09:22:39 INFO - Running setup.py install for mozprofile 09:22:39 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:22:39 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:22:39 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:22:39 INFO - Running setup.py install for mozrunner 09:22:39 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:22:39 INFO - Running setup.py install for mozscreenshot 09:22:40 INFO - Running setup.py install for moztest 09:22:40 INFO - Running setup.py install for mozversion 09:22:40 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:22:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:22:40 INFO - Cleaning up... 09:22:40 INFO - Return code: 0 09:22:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:22:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:40 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 0x7fe882bbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a927f0>, '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 0x29fe2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fe760>, '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': '7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488', '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 09:22:40 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 09:22:40 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 09:22:40 INFO - Using env: {'DISPLAY': ':0', 09:22:40 INFO - 'HOME': '/home/cltbld', 09:22:40 INFO - 'LANG': 'en_US.UTF-8', 09:22:40 INFO - 'LANGUAGE': 'en_US:en', 09:22:40 INFO - 'LOGNAME': 'cltbld', 09:22:40 INFO - 'MAIL': '/var/mail/cltbld', 09:22:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:40 INFO - 'MOZ_NO_REMOTE': '1', 09:22:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:40 INFO - 'NO_EM_RESTART': '1', 09:22:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:22:40 INFO - 'PWD': '/builds/slave/test-pgo', 09:22:40 INFO - 'SHELL': '/bin/bash', 09:22:40 INFO - 'SHLVL': '1', 09:22:40 INFO - 'TERM': 'linux', 09:22:40 INFO - 'TMOUT': '86400', 09:22:40 INFO - 'USER': 'cltbld', 09:22:40 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488', 09:22:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:40 INFO - '_': '/tools/buildbot/bin/python'} 09:22:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:22:40 INFO - Running setup.py (path:/tmp/pip-gJENoH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:22:40 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)) 09:22:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:22:40 INFO - Running setup.py (path:/tmp/pip-Ne9Uac-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:22:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:22:40 INFO - Running setup.py (path:/tmp/pip-4hqGhZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 09:22:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:22:40 INFO - Running setup.py (path:/tmp/pip-Egqn3U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:22:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:22:40 INFO - Running setup.py (path:/tmp/pip-HndmEa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 09:22:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:22:40 INFO - Running setup.py (path:/tmp/pip-S_8Dzb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 09:22:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:22:40 INFO - Running setup.py (path:/tmp/pip-GHXaDS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 09:22:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:22:40 INFO - Running setup.py (path:/tmp/pip-gPtVhx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:22:41 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)) 09:22:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:22:41 INFO - Running setup.py (path:/tmp/pip-O_Tpco-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:22:41 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)) 09:22:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:22:41 INFO - Running setup.py (path:/tmp/pip-RSOav8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:22:41 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)) 09:22:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:22:41 INFO - Running setup.py (path:/tmp/pip-9sHOzS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:22:41 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)) 09:22:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:22:41 INFO - Running setup.py (path:/tmp/pip-Q_BWiz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:22:41 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)) 09:22:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:22:41 INFO - Running setup.py (path:/tmp/pip-DJt7Up-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:22:41 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)) 09:22:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:22:41 INFO - Running setup.py (path:/tmp/pip-ooX51I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:22:41 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)) 09:22:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:22:41 INFO - Running setup.py (path:/tmp/pip-YdsSWQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 09:22:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:22:41 INFO - Running setup.py (path:/tmp/pip-jLNgUi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 09:22:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:22:41 INFO - Running setup.py (path:/tmp/pip-HzpFlx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 09:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 09:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:22:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:22: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 09:22: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 09:22: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 09:22: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 09:22: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 09:22: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 09:22:43 INFO - Downloading blessings-1.6.tar.gz 09:22:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:22:43 INFO - Installing collected packages: blessings 09:22:43 INFO - Running setup.py install for blessings 09:22:43 INFO - Successfully installed blessings 09:22:43 INFO - Cleaning up... 09:22:43 INFO - Return code: 0 09:22:43 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:22:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:22:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:22:43 INFO - Reading from file tmpfile_stdout 09:22:43 INFO - Current package versions: 09:22:43 INFO - argparse == 1.2.1 09:22:43 INFO - blessings == 1.6 09:22:43 INFO - blobuploader == 1.2.4 09:22:43 INFO - docopt == 0.6.1 09:22:43 INFO - manifestparser == 1.1 09:22:43 INFO - mozInstall == 1.12 09:22:43 INFO - mozcrash == 0.16 09:22:43 INFO - mozdebug == 0.1 09:22:43 INFO - mozdevice == 0.48 09:22:43 INFO - mozfile == 1.2 09:22:43 INFO - mozhttpd == 0.7 09:22:43 INFO - mozinfo == 0.9 09:22:43 INFO - mozleak == 0.1 09:22:43 INFO - mozlog == 3.1 09:22:43 INFO - moznetwork == 0.27 09:22:43 INFO - mozprocess == 0.22 09:22:43 INFO - mozprofile == 0.28 09:22:43 INFO - mozrunner == 6.11 09:22:43 INFO - mozscreenshot == 0.1 09:22:43 INFO - mozsystemmonitor == 0.0 09:22:43 INFO - moztest == 0.7 09:22:43 INFO - mozversion == 1.4 09:22:43 INFO - psutil == 3.1.1 09:22:43 INFO - requests == 1.2.3 09:22:43 INFO - wsgiref == 0.1.2 09:22:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe882bbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a927f0>, '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 0x29fe2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fe760>, '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': '7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488', '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 09:22:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 09:22:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:22:43 INFO - Using env: {'DISPLAY': ':0', 09:22:43 INFO - 'HOME': '/home/cltbld', 09:22:43 INFO - 'LANG': 'en_US.UTF-8', 09:22:43 INFO - 'LANGUAGE': 'en_US:en', 09:22:43 INFO - 'LOGNAME': 'cltbld', 09:22:43 INFO - 'MAIL': '/var/mail/cltbld', 09:22:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:43 INFO - 'MOZ_NO_REMOTE': '1', 09:22:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:43 INFO - 'NO_EM_RESTART': '1', 09:22:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:22:43 INFO - 'PWD': '/builds/slave/test-pgo', 09:22:43 INFO - 'SHELL': '/bin/bash', 09:22:43 INFO - 'SHLVL': '1', 09:22:43 INFO - 'TERM': 'linux', 09:22:43 INFO - 'TMOUT': '86400', 09:22:43 INFO - 'USER': 'cltbld', 09:22:43 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488', 09:22:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:43 INFO - '_': '/tools/buildbot/bin/python'} 09:22:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:44 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)) 09:22:44 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)) 09:22:44 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)) 09:22:44 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)) 09:22:44 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)) 09:22:44 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)) 09:22:44 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)) 09:22:44 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)) 09:22:44 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)) 09:22:44 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)) 09:22:44 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)) 09:22:44 INFO - Cleaning up... 09:22:44 INFO - Return code: 0 09:22:44 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:22:44 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')]} 09:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:44 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')]} 09:22:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:44 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 0x7fe882bbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a927f0>, '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 0x29fe2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fe760>, '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': '7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488', '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 09:22:44 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 09:22:44 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 09:22:44 INFO - Using env: {'DISPLAY': ':0', 09:22:44 INFO - 'HOME': '/home/cltbld', 09:22:44 INFO - 'LANG': 'en_US.UTF-8', 09:22:44 INFO - 'LANGUAGE': 'en_US:en', 09:22:44 INFO - 'LOGNAME': 'cltbld', 09:22:44 INFO - 'MAIL': '/var/mail/cltbld', 09:22:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:44 INFO - 'MOZ_NO_REMOTE': '1', 09:22:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:44 INFO - 'NO_EM_RESTART': '1', 09:22:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:22:44 INFO - 'PWD': '/builds/slave/test-pgo', 09:22:44 INFO - 'SHELL': '/bin/bash', 09:22:44 INFO - 'SHLVL': '1', 09:22:44 INFO - 'TERM': 'linux', 09:22:44 INFO - 'TMOUT': '86400', 09:22:44 INFO - 'USER': 'cltbld', 09:22:44 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488', 09:22:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:44 INFO - '_': '/tools/buildbot/bin/python'} 09:22:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:44 INFO - Downloading/unpacking jsonschema 09:22: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 09:22: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 09:22: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 09:22: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 09:22: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 09:22: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 09:22:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:22:46 INFO - Downloading/unpacking functools32 (from jsonschema) 09:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:46 INFO - Downloading functools32-3.2.3-2.tar.gz 09:22:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:22:46 INFO - warning: no files found matching '*.txt' 09:22:46 INFO - no previously-included directories found matching 'build' 09:22:46 INFO - no previously-included directories found matching 'dist' 09:22:46 INFO - no previously-included directories found matching '.git*' 09:22:46 INFO - Installing collected packages: jsonschema, functools32 09:22:46 INFO - Running setup.py install for functools32 09:22:46 INFO - warning: no files found matching '*.txt' 09:22:46 INFO - no previously-included directories found matching 'build' 09:22:46 INFO - no previously-included directories found matching 'dist' 09:22:46 INFO - no previously-included directories found matching '.git*' 09:22:46 INFO - Successfully installed jsonschema functools32 09:22:46 INFO - Cleaning up... 09:22:46 INFO - Return code: 0 09:22:46 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe882bbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a927f0>, '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 0x29fe2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fe760>, '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': '7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488', '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 09:22:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 09:22:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:22:46 INFO - Using env: {'DISPLAY': ':0', 09:22:46 INFO - 'HOME': '/home/cltbld', 09:22:46 INFO - 'LANG': 'en_US.UTF-8', 09:22:46 INFO - 'LANGUAGE': 'en_US:en', 09:22:46 INFO - 'LOGNAME': 'cltbld', 09:22:46 INFO - 'MAIL': '/var/mail/cltbld', 09:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:46 INFO - 'MOZ_NO_REMOTE': '1', 09:22:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:46 INFO - 'NO_EM_RESTART': '1', 09:22:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:22:46 INFO - 'PWD': '/builds/slave/test-pgo', 09:22:46 INFO - 'SHELL': '/bin/bash', 09:22:46 INFO - 'SHLVL': '1', 09:22:46 INFO - 'TERM': 'linux', 09:22:46 INFO - 'TMOUT': '86400', 09:22:46 INFO - 'USER': 'cltbld', 09:22:46 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488', 09:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:46 INFO - '_': '/tools/buildbot/bin/python'} 09:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:46 INFO - Downloading/unpacking flake8 09:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:22:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:22:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:22:49 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 09:22:49 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 09:22:49 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 09:22:49 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 09:22:49 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 09:22:49 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 09:22:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:22:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:22:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:22:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:22:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:22:49 INFO - no previously-included directories found matching 'docs/_build' 09:22:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:22:49 INFO - Running setup.py install for pep8 09:22:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:22:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:22:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:22:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:22:49 INFO - no previously-included directories found matching 'docs/_build' 09:22:49 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:22:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:22:49 INFO - Cleaning up... 09:22:49 INFO - Return code: 0 09:22:49 INFO - Running post-action listener: _resource_record_post_action 09:22:49 INFO - Running post-action listener: _start_resource_monitoring 09:22:49 INFO - Starting resource monitoring. 09:22:49 INFO - ##### 09:22:49 INFO - ##### Running install step. 09:22:49 INFO - ##### 09:22:49 INFO - Running pre-action listener: _resource_record_pre_action 09:22:49 INFO - Running main action method: install 09:22:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:22:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:22:49 INFO - Reading from file tmpfile_stdout 09:22:49 INFO - Detecting whether we're running mozinstall >=1.0... 09:22:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:22:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:22:49 INFO - Reading from file tmpfile_stdout 09:22:49 INFO - Output received: 09:22:49 INFO - Usage: mozinstall [options] installer 09:22:49 INFO - Options: 09:22:49 INFO - -h, --help show this help message and exit 09:22:49 INFO - -d DEST, --destination=DEST 09:22:49 INFO - Directory to install application into. [default: 09:22:49 INFO - "/builds/slave/test-pgo"] 09:22:49 INFO - --app=APP Application being installed. [default: firefox] 09:22:49 INFO - mkdir: /builds/slave/test-pgo/build/application 09:22:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 09:22:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 09:23:04 INFO - Reading from file tmpfile_stdout 09:23:04 INFO - Output received: 09:23:04 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:23:04 INFO - Running post-action listener: _resource_record_post_action 09:23:04 INFO - ##### 09:23:04 INFO - ##### Running run-tests step. 09:23:04 INFO - ##### 09:23:04 INFO - Running pre-action listener: _resource_record_pre_action 09:23:04 INFO - Running main action method: run_tests 09:23:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:23:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:23:04 INFO - Python 2.7.3 09:23:04 INFO - Return code: 0 09:23:04 INFO - grabbing minidump binary from tooltool 09:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:04 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a927f0>, '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 0x29fe2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fe760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:23:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 09:23:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:23:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:23:04 INFO - Return code: 0 09:23:04 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:23:04 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:23:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:23:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:23:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:23:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:23:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:23:05 INFO - Return code: 0 09:23:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QD0qQJndTUe8VGGFKSGAng/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 09:23:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QD0qQJndTUe8VGGFKSGAng/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 09:23:05 INFO - Using env: {'DISPLAY': ':0', 09:23:05 INFO - 'HOME': '/home/cltbld', 09:23:05 INFO - 'LANG': 'en_US.UTF-8', 09:23:05 INFO - 'LANGUAGE': 'en_US:en', 09:23:05 INFO - 'LOGNAME': 'cltbld', 09:23:05 INFO - 'MAIL': '/var/mail/cltbld', 09:23:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:23:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:05 INFO - 'MOZ_NO_REMOTE': '1', 09:23:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:05 INFO - 'NO_EM_RESTART': '1', 09:23:05 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:23:05 INFO - 'PWD': '/builds/slave/test-pgo', 09:23:05 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:23:05 INFO - 'SHELL': '/bin/bash', 09:23:05 INFO - 'SHLVL': '1', 09:23:05 INFO - 'TERM': 'linux', 09:23:05 INFO - 'TMOUT': '86400', 09:23:05 INFO - 'USER': 'cltbld', 09:23:05 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488', 09:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:05 INFO - '_': '/tools/buildbot/bin/python'} 09:23:05 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QD0qQJndTUe8VGGFKSGAng/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 09:23:06 INFO - mozversion application_buildid: 20160211063231 09:23:06 INFO - mozversion application_changeset: 8e11eaf0cafbed22c0960cae5b810e7085da16f3 09:23:06 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:23:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:23:06 INFO - mozversion application_name: Firefox 09:23:06 INFO - mozversion application_remotingname: firefox-dev 09:23:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:23:06 INFO - mozversion application_vendor: Mozilla 09:23:06 INFO - mozversion application_version: 46.0a2 09:23:06 INFO - mozversion platform_buildid: 20160211063231 09:23:06 INFO - mozversion platform_changeset: 8e11eaf0cafbed22c0960cae5b810e7085da16f3 09:23:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:23:06 INFO - mozversion platform_version: 46.0a2 09:23:06 INFO - using testdate: 1455211386 09:23:06 INFO - actual date: 1455211386 09:23:06 INFO - starting webserver on 'localhost:44108' 09:23:06 INFO - SUITE-START | Running 3 tests 09:23:06 INFO - TEST-START | dromaeo_css 09:23:06 INFO - operating with platform_type : linux_ 09:23:06 INFO - Initialising browser for dromaeo_css test... 09:23:06 INFO - TEST-INFO | started process 10003 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAVbwrS/profile http://localhost:44108/getInfo.html) 09:23:09 INFO - PROCESS | 10003 | 09:23:09 INFO - PROCESS | 10003 | (process:10082): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:23:10 INFO - PROCESS | 10003 | __metrics Screen width/height:1600/1200 09:23:10 INFO - PROCESS | 10003 | colorDepth:24 09:23:10 INFO - PROCESS | 10003 | Browser inner width/height: 1024/697 09:23:10 INFO - PROCESS | 10003 | __metrics 09:23:11 INFO - TEST-INFO | 10003: exit 0 09:23:11 INFO - Browser initialized. 09:23:11 INFO - Running cycle 1/1 for dromaeo_css test... 09:23:11 INFO - TEST-INFO | started process 10131 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAVbwrS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:23:12 INFO - PROCESS | 10131 | 09:23:12 INFO - PROCESS | 10131 | (process:10193): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:23:23 INFO - PROCESS | 10131 | RSS: Main: 140800000 09:23:23 INFO - PROCESS | 10131 | 09:24:13 INFO - PROCESS | 10131 | 1455211453139 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] 09:26:20 INFO - PROCESS | 10131 | Cycle 1(1): loaded http://localhost:44108/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44108/tests/dromaeo/cssquery-ext.html) 09:26:21 INFO - PROCESS | 10131 | RSS: Main: 146214912 09:26:21 INFO - PROCESS | 10131 | 09:29:23 INFO - PROCESS | 10131 | Cycle 1(1): loaded http://localhost:44108/tests/dromaeo/cssquery-ext.html (next: http://localhost:44108/tests/dromaeo/cssquery-jquery.html) 09:29:24 INFO - PROCESS | 10131 | RSS: Main: 144150528 09:29:24 INFO - PROCESS | 10131 | 09:32:25 INFO - PROCESS | 10131 | Cycle 1(1): loaded http://localhost:44108/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44108/tests/dromaeo/cssquery-mootools.html) 09:32:26 INFO - PROCESS | 10131 | RSS: Main: 142405632 09:32:26 INFO - PROCESS | 10131 | 09:35:28 INFO - PROCESS | 10131 | Cycle 1(1): loaded http://localhost:44108/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44108/tests/dromaeo/cssquery-prototype.html) 09:35:28 INFO - PROCESS | 10131 | RSS: Main: 143339520 09:35:28 INFO - PROCESS | 10131 | 09:38:30 INFO - PROCESS | 10131 | Cycle 1(1): loaded http://localhost:44108/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44108/tests/dromaeo/cssquery-yui.html) 09:38:31 INFO - PROCESS | 10131 | RSS: Main: 143175680 09:38:31 INFO - PROCESS | 10131 | 09:41:33 INFO - PROCESS | 10131 | Cycle 1(1): loaded http://localhost:44108/tests/dromaeo/cssquery-yui.html (next: http://localhost:44108/tests/dromaeo/cssquery-dojo.html) 09:41:33 INFO - PROCESS | 10131 | RSS: Main: 146628608 09:41:33 INFO - PROCESS | 10131 | 09:41:33 INFO - PROCESS | 10131 | __start_tp_report 09:41:33 INFO - PROCESS | 10131 | _x_x_mozilla_page_load 09:41:33 INFO - PROCESS | 10131 | _x_x_mozilla_page_load_details 09:41:33 INFO - PROCESS | 10131 | |i|pagename|runs| 09:41:33 INFO - PROCESS | 10131 | |0;dojo.html;3359.5296658467814;3383.018924511892;3386.2042420031303;3401.2347221875075;3407.4548072308435;5468.152436372364;5473.781048758055;5478.45215478452;5492.176173573966;5516.3380394352735;5487.780488780454;5501;5505.146702261156;5539.086050801623;5570.777168913249;4958.157113290731;4973.925391119127;5060.7722652480725;5110.591152707793;5118.232265160219;4851.684640498374;4935.062338155739;5055.090083784918;5063.873403164932;5074.974625126869;4996.400431948153;5019.272205530196;5055.216441451581;5062.519060689247;5063.544281014708;4994.600431965434;4996.775145118479;5004.649674522785;5006.774695138727;5032.119379108642;4857.878553036167;4881.731504767236;4907.582855457291;4917.631177661654;4949.455559888409;5242.947570524284;5268.998890210848;5276.15581506957;5282.049231138432;5312.229726689647;5848.766049358063;5854.356020837705;5862.062070068811;5875.1187321901625;5879.588428809985;5803.303603567599;5864.794732184396;5915.911261331084;5932.139839723259;5942.049272116441;5444.646098003656;5456.91814622781;5460.808871689472;5471.5896307776675;5481.397046324901;5868.735906884115;5879.265091863517;5880.588358814927;5887.646741195542;5898.557608179403;5758.942410575841;5762.1068734346245;5846.4153584642045;5846.912296315559;5902.439268269508;5845.415458454206;5846.356900740915;5846.736896839652;5849.356570777211;5854.034084376115;5781.392953739881;5805.6806875621405;5813;5818.33089194748;5820.156077368758;5813.970930145322;5861.267341582302;5923.289205295306;5926.555508336892;5949.315828679671;4442.68901176921;4484.192845287879;4497.685162038626;4500.347449619787;4526.32105184225;3968.861089861841;4034.536028356718;4051.2505186540584;4084.3873418986796;4096.91806163875;5507.862303442366;5544.7782088716;5547.389787123413;5575.52608028314;5585.3297604287745;5880.088586269135;5904.143899134688;5905.232319798399;5906.114082887601;5906.645601263938;5394.676319420847;5453.400125986138;5541.722913854291;5543.1408131739645;5548.0845660466375;5039.244113383022;5049.065922804293;5051.217061355495;5055.949440505621;5060.3168572242275;5977.043673012297;6034.306054803666;6039.849003774941;6055.061465472859;6056.9697151513965;5796.884062318814;5875.177475153568;5878.588498805043;5885.264341957255;5947.762089516371;5931.110333450017;6005.969970150296;6027.30685971119;6069.362716914837;6092.543059270483;5729.770809167753;5739.9139012915675;5759.94240057594;5774.711264436677;5776.653400795965;5762.827115186551;5854.443827836349;5856.297244330707;5856.7950121747235;5861.1501332307425;5747.3103227612955;5763.740631671669;5857.531397488276;5860.853478663067;5882.441168089024;5635.126555383922;5643.774249030157;5658.717064146858;5687.374388817144;5700;5579.944200557942;5592.161175823659;5609.298837645294;5615.522680572034;5630.465105814941;5820.621659592113;5838.912416313844;5854.326752423526;5866.911996320144;5916.822495325147;5593.468620481048;5650.0677388232125;5650.180723795109;5659.85850353728;5672.2342483765815 09:41:33 INFO - PROCESS | 10131 | |1;ext.html;557.9107342825149;565.3329071695399;570.3237340173331;586.9941300586993;633.7401665317219;32820;41868.37197442037;42201;42209.78895105528;42239.155216895684;44695;44931;45148.77425612875;45387.319190212176;45583;8788.69239576615;8985.640574377017;8989.820203595924;8995.41529800564;8997.550122493882;8773.736787896341;8935.59789809457;8961.834961455002;8966.955165224164;8980.685676001342;8913.376063675545;8914.643414263453;8957.14907083826;8996.055414181516;9019.278457723367;8862.468251904875;8909.777255568597;8914.732558023237;8931.598078086468;8943.68697095605;8813.250873675745;8929.241014513775;8941.865872011926;8947.284217262604;8964.238039766627;42325.57674423247;42371.788141059405;42448;42824.78587607073;42949.35575966363;3550.6626870447267;3631.346357655621;3699.519062521882;3970.3250447424007;4272.209641216354;32265.83867080673;32439;32456.513152302734;32483.350332993206;32611.18472038218;4064.654504367132;4068.4304197412384;4136.193442278757;4178.7984212543315;4199.286121359346;210973;211963;212428;332203;335961.3201933999;59991.10013349803;60493.09260361098;60617.69691151516;60729.39270607326;60845.39154608486;67599;68631.31368686249;68741.65629171922;69010;69292;18219.45341639753;18335.816641833677;18362.08189590515;18400.355987540373;18414.263429462673;14370.784438233435;14378.496752613608;14438.278086095654;14474.782878256834;14477.710445791025;21251.46871328229;21448.356549303546;21494.78505214959;21603.89198054031;21659.35021949344;8345.54099524532;8464.365172612079;8534.402591818513;8537.18896704812;8559.700410485602;1069.2835800014009;1091.4542728635681;1171.344047333496;1188.3167178872184;1215.7568486302775;30780.84609576938;30917;30955.8452207742;33507.32985340279;33921.32157356839;1140.4411838199223;1193.4331192683405;1211.5902495358268;1216.4343580235234;1250.1811313589612;15254;15971;16045.438409655606;16148.031118132949;16458.09480478561;520202;536076;541581;542972;550606;53143.46856531462;53721.73139134357;54136.18795718067;54243.18635220396;54309.1853622196;1373.2378529915993;1460.189594774889;1462.6197188731007;1479.0386248938062;1483.6839663352398;30507.084787456413;31832.52251216187;31871.203219919687;32905;32910;47789;48311.75844120757;48390.516094838604;48452.7577362111;48514.757426214055;331199;332807;332990;333407;333471;33527.83236083804;49045.75477122592;49209.26186107283;49486.50513494819;49825.252621209984;46790.532094678616;47556;48161;48500;48584;40537.79731101326;42686.78656606697;43616.34575481307;43939.12121757611;45012.54987450084;41927.790361048;42737.5726242746;46856.7657161712;48144.75927620479;48174;44978.3253251195;45103.32345014762;45336.31995520136;45388.319175211735;45508.54491455043;37452.43821342628;38151;38468.807655961544;39050;39090;29404.411911761217;29616.23026184272;30312.84843575768;30314.69685303207;30432 09:41:33 INFO - PROCESS | 10131 | |2;jquery.html;381.66222892739927;382.2298069390179;383.7985057844633;387.1270285506184;390.40853107542097;15039.473618423357;15818.367265309389;17590.384336548224;17738.20178091986;17845.910770446146;17371.131443427843;17654.205560749764;17912.462626121203;18672.906635466803;18772.71840922387;5561.6663000220115;5740.397258287882;5771.624844385123;5781.508571771384;5782.913256301138;3880.417937309398;4015.4177644241568;5436.728163591804;5633.183188437674;5657.745401456944;5430.91853622196;5572.442755724435;5635.802746903859;5641.746121424525;5691.544676425897;5691.4877661010505;5701.173329867146;5720.771169153229;5721.056025755766;5754.2807149106575;5228;5389.973050134724;5391.973040134774;5436.565074794046;5507.531859791922;13486.190828550318;16463;20517.38447846567;20600;20620.484487887774;2226.543558570489;2282.2354511238755;2299.379167624732;2384.1297926256966;2475.801935845128;10043.397396156253;10228.846567301496;10388.636397726043;10456.52945617449;10623.25637205396;1753.4126067767313;1886.9056547172586;1898.781640111391;1964.7936966618586;1974.5853370792152;60522;60567.69716151435;61363.07955380628;63119.36880631181;63547.68226158886;10743.409112498732;10962.945185274182;10988.670339889815;10997.230193886351;11029.889701103048;14117.435302587986;14670.119792812466;14678.853211467962;14782.26088695561;14813.925930370278;7848.489848159851;8091.919080809234;8198.672053117809;8238.917610823815;8350.749477515685;7959.084705258853;7976.122626511079;8054.879176812353;8093.190680931977;8098.190180981855;4701.106789709944;4704.176769065469;4775.952240477551;4802.903941921142;4831.830885918976;1944.6955357900933;1962.4112766170092;1967.2917749610128;1995.820376166152;2015.9899200504196;966.4781018250206;1022.5608696731191;1037.621268237088;1047.0628787235382;1097.8353247012851;17057.31770729182;18021.909890450726;18268.725969110474;18470.168842402123;18680.53298667517;1019.5870672377699;1035.699647102347;1037.408677054087;1057.4554104636118;1074.9844042420461;9483.478408687588;9952.402855828674;10646.627368042236;10708.464576771286;10739.892601074045;536960;572746;593071;627768;631997;76492.23507764963;77068;78010;81258;81998.59000704958;1232.8520577530574;1234.7283597608512;1248.9196844729245;1253.410896878484;1254.5609036837216;15535.45625903088;16178.919105404868;16422.507324780276;16736.497905062868;16849.578760531083;34928.30143397169;35446.822765886005;36007;36361.81819090994;37016.81491592525;43710.56289437065;43730;44202.11595768002;44517.77741111274;46401.76799115983;7260.600666963156;7903;7943.960280198562;8002.5598592077995;8299.875501867356;10516.053555180071;10806;10938.179636527133;11323.418300393632;12014.879851201376;10373.495843102557;10584.841227381441;10705;10765.084967777826;10780.29928054674;9597.23222142213;9859.260555458226;10010.349327293703;10367.27429079957;10382.896171038496;9915.801683966425;10000.749981250236;10159.949200253952;10481.947590262;10503;7646.15892251863;7858.489198202098;7877.487963282369;7900.68397264103;7906.367490600853;10073.597056117966;10723.571057157626;10819.459027048773;10864.782704345711;10922.672319830417 09:41:33 INFO - PROCESS | 10131 | |3;mootools.html;1529.6328881068544;1536.431520337475;1764.523578633768;1845.1604519943428;1890.366727146406;8033.91966080339;8234.341252699785;8309.626066826992;8319.126491718373;8404.873926891101;8341.20758527939;8389.035260944993;8440.32477401808;8468.830623387528;8477.830443391129;2499;2526.115859449187;2526.166365099513;2531.1267612673596;2533.290678609983;2526.1916186820226;2597.1169802267227;2599.233226198276;2602.531544322021;2605.700344460383;2491.4394261291154;2527.1534036097837;2549.0823303610687;2549.8725063746833;2561.9359516012155;2523.8990440382363;2539.200151952129;2557.271177714361;2564.358910272432;2567.9358016049655;2579.43252484455;2586.754258345473;2594.040205124097;2594.8443093414458;2602.2973797074683;8174.059983101901;8183.14077021916;8208.794780130485;8229.79425514367;8274.048484424247;5165.483451654842;5292.867678308035;5312.787488500456;5351.331083614548;5359.705216213107;3497.615262321143;3507.9824600877087;3543;3577.159367548624;3614.6385361463645;1140.116409782417;1145.4673576786834;1157.1090260499368;1158.6813626252763;1170.8829117088308;11078.390688512129;11115.610953616666;11141.777164456747;11142.442877856074;11257.268277562014;4602.654800889946;4605.631549476101;4684.859454216379;4694.460137084211;4726.196546587088;8882.15619516145;9027.277817774562;9032.774180645405;9075.636974521078;9081.68214112516;5096.61775366849;5136.614753893473;5142;5147.536721695065;5159;4736.881577960578;4756.619470442356;4786.1624215762795;4787.162246606899;4788.3056956741075;3753.418220175877;3789.791561464146;3792.3742582473583;3798.2213646202463;3819.3698039823116;1162.2968104296947;1167.7430965187646;1171.800793865045;1175.8236264560214;1193.659806955031;1123.3428444359977;1127.475723788426;1167.2062997161843;1354.7219398507464;1437.116173553278;7747;7802.375809935192;7829.491083079582;7991.0810256821205;8148.714794982147;1197.8921897029136;1204.1691233049169;1211.7576484703095;1219.8963088137607;1236.8701286364983;6216.409441103088;6249.406306400884;6326.335734747877;6330.39861213184;6370.267419246753;9827.508624568743;10056.949715251378;10097.798044039226;10156.085952264331;10270;9614.759631009141;10136;10287.434191119411;10333.431661258552;10382.740431489274;7853.646585903648;7908.920910790818;7932.524048557105;7941.76174714748;7968.243016913384;7365.189829118685;7426.108866936002;7433.256674332523;7696.653650585625;7848.136704962335;8521.147885211429;8738.257248133725;8766.298696104168;8807.251383632463;8819.823603528022;8767.386282960131;8946.463212207289;8989.325800564853;9209.585568649562;9296.767580810534;7225.6387180641805;7273.927260727325;7304.306090921354;7314.34170924598;7328.487005909536;7895.565743884142;8005.59972001386;8031.277185053374;8079.83840323202;8083.878741818759;7462.776116716507;7546.471746977659;7556.4710470266555;7636.274553917369;7736.265054820008;7434.59109748969;7494.850102997801;7520.8495830082;7528;7686.6541005656;7414.073240844895;7485.363744081814;7504.362129218859;7514.211007844317;7538.170801211972;6860.622665753432;6865.41643960269;6871.106756121672;6900.654967251718;6914.0666010088;6869.072675188786;6917.723291068301;6951.548149370275;7052.647367631701;7060.43516518667 09:41:33 INFO - PROCESS | 10131 | |4;prototype.html;367.86940636074195;371.9739618226722;372.51758972131086;376.27191384670647;377.8205352457583;6334.366563343663;6352.618842869431;6377.840553986147;6414.486841052716;6517.67411629419;6239;6378.649174295412;6415.967920160404;6424.646644434554;6431.2282526096815;4944.752762361885;4955.182394904837;4956.876078098058;4962.454130045701;4965.851024469272;4883.413990321149;4963.106640804654;4976.178930476467;4978.029284289565;4984.451710311862;4895.8776030599165;4903.632227582928;4923.18767403378;4923.58149557288;4924.433690125627;4908.509149085098;4911.607071434277;4919.237518184669;4921.212605983043;4932.062908047459;4352.651787856964;4359.760213188273;4366;4367.759773212472;4374.912501749947;5995.250593675791;6076.392360763933;6090.908636370458;6095.878082438327;6097.481714054311;5696.629719068289;5712.314522257314;5718.370979192286;5718.799842005551;5726.942730572682;6802.795916122524;6844.863102737967;6850.869606514919;6855.006024126474;6861.862762744717;4733.905321893577;4748.287756836502;4755.239161734141;4760.928586071212;4767.570918617306;6938.618375989318;7057.153141623038;7121;7124.073870396815;7135.143782746052;4851.781669824866;4861.732604706775;4864.927026094611;4866.075445665312;4867.367242258484;4912.582430493377;4916.72957987307;4926.211806111077;4930.778114984834;4931.112399768004;5571.582131340166;5644.3508996465935;5662.235598194191;5679.119736440858;5693.743781529841;6869.416099631488;6873.793786186422;6894;6896.27589103147;6905.274946130685;1634.7302695055182;1655.6192075822387;1710.7433884917114;1740.9390671326444;1743.0674589094774;1166.6208482243305;1167.6963989362828;1176.1766763265748;1176.8293597428326;1186.4542310537076;6371.840703982438;6415.67921603918;6434.581752186093;6435.066915297256;6466.450351720063;6910.792676219721;6917.965410172917;6946.93053069473;6975.860482790417;6977.93022069783;6400;6451.580647257913;6480.740770369132;6530.249021362604;6548.8035358939305;3823.789691566935;3835.2137811748526;3860.2435891669224;3863.014931192528;3884.3396622574232;7299.124105107315;7333.413326933833;7369.189389167187;7378.667959941816;7385.8153546161775;7118.394936430462;7301;7320.67056982437;7337.19290878003;7359.337659610661;7172.175199852084;7187.460940429489;7250.347468727734;7254.419646428273;7290.45321600882;7106.7157313706875;7112.395446387115;7116.082406213634;7118.572885626879;7158.498905076594;6933.930660693329;7062.8234294141;7064.576125432491;7066.505344625827;7070.257622949516;7286.162091359562;7330.266973302841;7345.485815992829;7349.448791340564;7354.374878135419;4865.1242776300605;4869.926951095666;4871.3423687803115;4887.266909963534;4889.511048895082;7006.579605223703;7007.894881576883;7120.964395177991;7140.964295178491;7151.642417878981;6926.168859736864;6942.757003504853;6950.026996220432;6955.791326260221;6958.269381715049;6863.897041544281;6871.793846184622;6888.242293347627;6895.103636527219;6915.239323674291;6679.1984961802955;6778.084958530535;6800.761973330909;6806.115205023315;6811.557248778813;6895.241523432318;6938.791836244921;6950.374466298057;6957.79126626202;6968.059311992816;6678.3989440950545;6704.094947182068;6764.2559318475915;6774;6784.491163162881 09:41:33 INFO - PROCESS | 10131 | |5;yui.html;761.5544906229856;824.9175082491752;860.2816648098838;884.4825776920501;931.9161275485208;14529.78205326921;14614.269286535657;14638.853611463883;14653.926730366333;14675.633109172262;13858.792118118236;13917;15317.770233446507;15640.139792311418;15641.608959776011;874.8337815814975;881.5195718333507;890.0432035561764;917.2753524715466;917.7843206846386;911.1617312072909;913.0093848174738;915.4187091197072;915.8763566918448;918.6784625381097;934.3226161033265;939.7415710679584;942.7454587261435;943.1888575824785;946.8248374050788;932.8507438809792;933.7852293972425;935.2517985611552;938.8779458670364;939.8496240601539;694.2398074108843;695.4644923408947;696.022088965005;697.0450482838493;699;13756.65608359789;13797.655058623513;13800.240986745725;13826.723465530733;13843.30783460833;13888.513902013381;13931.233782141979;14039.298035098307;14061.859381406259;14086.631635731599;11444.313341199555;11450.656480305604;11496.655100347003;11647.417629118594;12291.938540307241;3951.229510245503;3975.383815508601;4003.199360127986;4024.074462873526;4066;49591;49593.75203123997;49829.75085124551;50430.243546346836;50952.49047509515;9970.850437243447;10160.390376577428;10183.898161018444;10296.691099267035;10352.637657681946;18841;18894.716579251322;19496.512587185432;19565.1195696194;19634.410967670992;7978.760637180894;8113.716019939274;8133.349332053422;8162.347012239006;8403;4547.090581883636;4614.815407383667;4622.098690755271;4634;4642.9535704643195;3361.7646764726233;3366.225768073308;3369.865205391806;3402.5406570113214;3403;592.9080992446178;600.2227115884939;602.0607851751282;616.2204810914197;617.8856911471393;752.3454594502817;753.6608526163249;757.1822431773671;758.1622307350409;772.6793380746927;9172.403793753385;9704.854427183598;9715.222782177409;9775.706728798148;9788.804223915624;611.461913516103;619.1146660275759;708.5182076188241;721.8339781850204;761.5621017914722;4448.755318457451;4502.774861256924;4575.290829921368;4879.4388645305535;4894.681845680019;60655;60777.39222607806;61114.38885611087;62011.069833952526;62229;50271.24593131106;54507.45492545103;55024;55048.44951550513;55333.72333138309;48162.759186203846;49098;49888;49948.50051499511;50332;9535.809283814424;9606.327557070937;9721.70834874955;9790.559424826042;9909.603615855573;35669.82165089158;36329.81835090808;36613.450798238584;37122.44316335311;37231.44152837764;46013;48926.26610600773;49059.264111039076;50146.7492662549;50304.74847625739;12194;12350.197237179555;12385.504579816707;12419.813702794285;12809.935950320189;12677.936610316889;12939.935300323437;12999.740005200032;13015.609531714064;13167.144135631153;11770.52917883275;12034.63896083119;12179.817302740643;12194.512219511475;12489;12802.039847011698;12849.614511564669;12887.93556032214;12888.226706397647;12949.158304710163;12726.300053497147;12809.935950320189;12859.906907912933;13002.739945200854;13022;9640.228781697308;9852.359596626196;9879.259055570717;10235.283530152818;10339.9660033996;10333.638322658671;10778.29941053829;10834.957277769197;10916.399598022184;11091.944540277247 09:41:33 INFO - PROCESS | 10131 | __end_tp_report 09:41:33 INFO - PROCESS | 10131 | __start_cc_report 09:41:33 INFO - PROCESS | 10131 | _x_x_mozilla_cycle_collect,302 09:41:33 INFO - PROCESS | 10131 | __end_cc_report 09:41:33 INFO - PROCESS | 10131 | __startTimestamp1455212493894__endTimestamp 09:41:33 INFO - PROCESS | 10131 | 09:41:33 INFO - PROCESS | 10131 | ------- Summary: start ------- 09:41:33 INFO - PROCESS | 10131 | Number of tests: 6 09:41:33 INFO - PROCESS | 10131 | 09:41:33 INFO - PROCESS | 10131 | [#0] dojo.html Cycles:165 Average:5448.49 Median:5643.77 stddev:587.60 (10.4%) stddev-sans-first:566.09 09:41:33 INFO - PROCESS | 10131 | Values: 3359.5 3383.0 3386.2 3401.2 3407.5 5468.2 5473.8 5478.5 5492.2 5516.3 5487.8 5501.0 5505.1 5539.1 5570.8 4958.2 4973.9 5060.8 5110.6 5118.2 4851.7 4935.1 5055.1 5063.9 5075.0 4996.4 5019.3 5055.2 5062.5 5063.5 4994.6 4996.8 5004.6 5006.8 5032.1 4857.9 4881.7 4907.6 4917.6 4949.5 5242.9 5269.0 5276.2 5282.0 5312.2 5848.8 5854.4 5862.1 5875.1 5879.6 5803.3 5864.8 5915.9 5932.1 5942.0 5444.6 5456.9 5460.8 5471.6 5481.4 5868.7 5879.3 5880.6 5887.6 5898.6 5758.9 5762.1 5846.4 5846.9 5902.4 5845.4 5846.4 5846.7 5849.4 5854.0 5781.4 5805.7 5813.0 5818.3 5820.2 5814.0 5861.3 5923.3 5926.6 5949.3 4442.7 4484.2 4497.7 4500.3 4526.3 3968.9 4034.5 4051.3 4084.4 4096.9 5507.9 5544.8 5547.4 5575.5 5585.3 5880.1 5904.1 5905.2 5906.1 5906.6 5394.7 5453.4 5541.7 5543.1 5548.1 5039.2 5049.1 5051.2 5055.9 5060.3 5977.0 6034.3 6039.8 6055.1 6057.0 5796.9 5875.2 5878.6 5885.3 5947.8 5931.1 6006.0 6027.3 6069.4 6092.5 5729.8 5739.9 5759.9 5774.7 5776.7 5762.8 5854.4 5856.3 5856.8 5861.2 5747.3 5763.7 5857.5 5860.9 5882.4 5635.1 5643.8 5658.7 5687.4 5700.0 5579.9 5592.2 5609.3 5615.5 5630.5 5820.6 5838.9 5854.3 5866.9 5916.8 5593.5 5650.1 5650.2 5659.9 5672.2 09:41:33 INFO - PROCESS | 10131 | 09:41:33 INFO - PROCESS | 10131 | [#1] ext.html Cycles:180 Average:56109.84 Median:23479.50 stddev:105126.32 (447.7%) stddev-sans-first:105338.49 09:41:33 INFO - PROCESS | 10131 | Values: 557.9 565.3 570.3 587.0 633.7 32820.0 41868.4 42201.0 42209.8 42239.2 44695.0 44931.0 45148.8 45387.3 45583.0 8788.7 8985.6 8989.8 8995.4 8997.6 8773.7 8935.6 8961.8 8967.0 8980.7 8913.4 8914.6 8957.1 8996.1 9019.3 8862.5 8909.8 8914.7 8931.6 8943.7 8813.3 8929.2 8941.9 8947.3 8964.2 42325.6 42371.8 42448.0 42824.8 42949.4 3550.7 3631.3 3699.5 3970.3 4272.2 32265.8 32439.0 32456.5 32483.4 32611.2 4064.7 4068.4 4136.2 4178.8 4199.3 210973.0 211963.0 212428.0 332203.0 335961.3 59991.1 60493.1 60617.7 60729.4 60845.4 67599.0 68631.3 68741.7 69010.0 69292.0 18219.5 18335.8 18362.1 18400.4 18414.3 14370.8 14378.5 14438.3 14474.8 14477.7 21251.5 21448.4 21494.8 21603.9 21659.4 8345.5 8464.4 8534.4 8537.2 8559.7 1069.3 1091.5 1171.3 1188.3 1215.8 30780.8 30917.0 30955.8 33507.3 33921.3 1140.4 1193.4 1211.6 1216.4 1250.2 15254.0 15971.0 16045.4 16148.0 16458.1 520202.0 536076.0 541581.0 542972.0 550606.0 53143.5 53721.7 54136.2 54243.2 54309.2 1373.2 1460.2 1462.6 1479.0 1483.7 30507.1 31832.5 31871.2 32905.0 32910.0 47789.0 48311.8 48390.5 48452.8 48514.8 331199.0 332807.0 332990.0 333407.0 333471.0 33527.8 49045.8 49209.3 49486.5 49825.3 46790.5 47556.0 48161.0 48500.0 48584.0 40537.8 42686.8 43616.3 43939.1 45012.5 41927.8 42737.6 46856.8 48144.8 48174.0 44978.3 45103.3 45336.3 45388.3 45508.5 37452.4 38151.0 38468.8 39050.0 39090.0 29404.4 29616.2 30312.8 30314.7 30432.0 09:41:33 INFO - PROCESS | 10131 | 09:41:33 INFO - PROCESS | 10131 | [#2] jquery.html Cycles:180 Average:29840.91 Median:2290.81 stddev:96980.10 (4233.4%) stddev-sans-first:97226.92 09:41:33 INFO - PROCESS | 10131 | Values: 381.7 382.2 383.8 387.1 390.4 15039.5 15818.4 17590.4 17738.2 17845.9 17371.1 17654.2 17912.5 18672.9 18772.7 5561.7 5740.4 5771.6 5781.5 5782.9 3880.4 4015.4 5436.7 5633.2 5657.7 5430.9 5572.4 5635.8 5641.7 5691.5 5691.5 5701.2 5720.8 5721.1 5754.3 5228.0 5390.0 5392.0 5436.6 5507.5 13486.2 16463.0 20517.4 20600.0 20620.5 2226.5 2282.2 2299.4 2384.1 2475.8 10043.4 10228.8 10388.6 10456.5 10623.3 1753.4 1886.9 1898.8 1964.8 1974.6 60522.0 60567.7 61363.1 63119.4 63547.7 10743.4 10962.9 10988.7 10997.2 11029.9 14117.4 14670.1 14678.9 14782.3 14813.9 7848.5 8091.9 8198.7 8238.9 8350.7 7959.1 7976.1 8054.9 8093.2 8098.2 4701.1 4704.2 4776.0 4802.9 4831.8 1944.7 1962.4 1967.3 1995.8 2016.0 966.5 1022.6 1037.6 1047.1 1097.8 17057.3 18021.9 18268.7 18470.2 18680.5 1019.6 1035.7 1037.4 1057.5 1075.0 9483.5 9952.4 10646.6 10708.5 10739.9 536960.0 572746.0 593071.0 627768.0 631997.0 76492.2 77068.0 78010.0 81258.0 81998.6 1232.9 1234.7 1248.9 1253.4 1254.6 15535.5 16178.9 16422.5 16736.5 16849.6 34928.3 35446.8 36007.0 36361.8 37016.8 43710.6 43730.0 44202.1 44517.8 46401.8 7260.6 7903.0 7944.0 8002.6 8299.9 10516.1 10806.0 10938.2 11323.4 12014.9 10373.5 10584.8 10705.0 10765.1 10780.3 9597.2 9859.3 10010.3 10367.3 10382.9 9915.8 10000.7 10159.9 10481.9 10503.0 7646.2 7858.5 7877.5 7900.7 7906.4 10073.6 10723.6 10819.5 10864.8 10922.7 09:41:33 INFO - PROCESS | 10131 | 09:41:33 INFO - PROCESS | 10131 | [#3] mootools.html Cycles:180 Average:5861.41 Median:5332.06 stddev:2949.65 (55.3%) stddev-sans-first:2939.95 09:41:33 INFO - PROCESS | 10131 | Values: 1529.6 1536.4 1764.5 1845.2 1890.4 8033.9 8234.3 8309.6 8319.1 8404.9 8341.2 8389.0 8440.3 8468.8 8477.8 2499.0 2526.1 2526.2 2531.1 2533.3 2526.2 2597.1 2599.2 2602.5 2605.7 2491.4 2527.2 2549.1 2549.9 2561.9 2523.9 2539.2 2557.3 2564.4 2567.9 2579.4 2586.8 2594.0 2594.8 2602.3 8174.1 8183.1 8208.8 8229.8 8274.0 5165.5 5292.9 5312.8 5351.3 5359.7 3497.6 3508.0 3543.0 3577.2 3614.6 1140.1 1145.5 1157.1 1158.7 1170.9 11078.4 11115.6 11141.8 11142.4 11257.3 4602.7 4605.6 4684.9 4694.5 4726.2 8882.2 9027.3 9032.8 9075.6 9081.7 5096.6 5136.6 5142.0 5147.5 5159.0 4736.9 4756.6 4786.2 4787.2 4788.3 3753.4 3789.8 3792.4 3798.2 3819.4 1162.3 1167.7 1171.8 1175.8 1193.7 1123.3 1127.5 1167.2 1354.7 1437.1 7747.0 7802.4 7829.5 7991.1 8148.7 1197.9 1204.2 1211.8 1219.9 1236.9 6216.4 6249.4 6326.3 6330.4 6370.3 9827.5 10056.9 10097.8 10156.1 10270.0 9614.8 10136.0 10287.4 10333.4 10382.7 7853.6 7908.9 7932.5 7941.8 7968.2 7365.2 7426.1 7433.3 7696.7 7848.1 8521.1 8738.3 8766.3 8807.3 8819.8 8767.4 8946.5 8989.3 9209.6 9296.8 7225.6 7273.9 7304.3 7314.3 7328.5 7895.6 8005.6 8031.3 8079.8 8083.9 7462.8 7546.5 7556.5 7636.3 7736.3 7434.6 7494.9 7520.8 7528.0 7686.7 7414.1 7485.4 7504.4 7514.2 7538.2 6860.6 6865.4 6871.1 6900.7 6914.1 6869.1 6917.7 6951.5 7052.6 7060.4 09:41:33 INFO - PROCESS | 10131 | 09:41:33 INFO - PROCESS | 10131 | [#4] prototype.html Cycles:180 Average:5728.92 Median:6427.94 stddev:1724.27 (26.8%) stddev-sans-first:1681.50 09:41:33 INFO - PROCESS | 10131 | Values: 367.9 372.0 372.5 376.3 377.8 6334.4 6352.6 6377.8 6414.5 6517.7 6239.0 6378.6 6416.0 6424.6 6431.2 4944.8 4955.2 4956.9 4962.5 4965.9 4883.4 4963.1 4976.2 4978.0 4984.5 4895.9 4903.6 4923.2 4923.6 4924.4 4908.5 4911.6 4919.2 4921.2 4932.1 4352.7 4359.8 4366.0 4367.8 4374.9 5995.3 6076.4 6090.9 6095.9 6097.5 5696.6 5712.3 5718.4 5718.8 5726.9 6802.8 6844.9 6850.9 6855.0 6861.9 4733.9 4748.3 4755.2 4760.9 4767.6 6938.6 7057.2 7121.0 7124.1 7135.1 4851.8 4861.7 4864.9 4866.1 4867.4 4912.6 4916.7 4926.2 4930.8 4931.1 5571.6 5644.4 5662.2 5679.1 5693.7 6869.4 6873.8 6894.0 6896.3 6905.3 1634.7 1655.6 1710.7 1740.9 1743.1 1166.6 1167.7 1176.2 1176.8 1186.5 6371.8 6415.7 6434.6 6435.1 6466.5 6910.8 6918.0 6946.9 6975.9 6977.9 6400.0 6451.6 6480.7 6530.2 6548.8 3823.8 3835.2 3860.2 3863.0 3884.3 7299.1 7333.4 7369.2 7378.7 7385.8 7118.4 7301.0 7320.7 7337.2 7359.3 7172.2 7187.5 7250.3 7254.4 7290.5 7106.7 7112.4 7116.1 7118.6 7158.5 6933.9 7062.8 7064.6 7066.5 7070.3 7286.2 7330.3 7345.5 7349.4 7354.4 4865.1 4869.9 4871.3 4887.3 4889.5 7006.6 7007.9 7121.0 7141.0 7151.6 6926.2 6942.8 6950.0 6955.8 6958.3 6863.9 6871.8 6888.2 6895.1 6915.2 6679.2 6778.1 6800.8 6806.1 6811.6 6895.2 6938.8 6950.4 6957.8 6968.1 6678.4 6704.1 6764.3 6774.0 6784.5 09:41:33 INFO - PROCESS | 10131 | 09:41:33 INFO - PROCESS | 10131 | [#5] yui.html Cycles:180 Average:14844.57 Median:26521.10 stddev:16902.87 (63.7%) stddev-sans-first:16917.20 09:41:33 INFO - PROCESS | 10131 | Values: 761.6 824.9 860.3 884.5 931.9 14529.8 14614.3 14638.9 14653.9 14675.6 13858.8 13917.0 15317.8 15640.1 15641.6 874.8 881.5 890.0 917.3 917.8 911.2 913.0 915.4 915.9 918.7 934.3 939.7 942.7 943.2 946.8 932.9 933.8 935.3 938.9 939.8 694.2 695.5 696.0 697.0 699.0 13756.7 13797.7 13800.2 13826.7 13843.3 13888.5 13931.2 14039.3 14061.9 14086.6 11444.3 11450.7 11496.7 11647.4 12291.9 3951.2 3975.4 4003.2 4024.1 4066.0 49591.0 49593.8 49829.8 50430.2 50952.5 9970.9 10160.4 10183.9 10296.7 10352.6 18841.0 18894.7 19496.5 19565.1 19634.4 7978.8 8113.7 8133.3 8162.3 8403.0 4547.1 4614.8 4622.1 4634.0 4643.0 3361.8 3366.2 3369.9 3402.5 3403.0 592.9 600.2 602.1 616.2 617.9 752.3 753.7 757.2 758.2 772.7 9172.4 9704.9 9715.2 9775.7 9788.8 611.5 619.1 708.5 721.8 761.6 4448.8 4502.8 4575.3 4879.4 4894.7 60655.0 60777.4 61114.4 62011.1 62229.0 50271.2 54507.5 55024.0 55048.4 55333.7 48162.8 49098.0 49888.0 49948.5 50332.0 9535.8 9606.3 9721.7 9790.6 9909.6 35669.8 36329.8 36613.5 37122.4 37231.4 46013.0 48926.3 49059.3 50146.7 50304.7 12194.0 12350.2 12385.5 12419.8 12809.9 12677.9 12939.9 12999.7 13015.6 13167.1 11770.5 12034.6 12179.8 12194.5 12489.0 12802.0 12849.6 12887.9 12888.2 12949.2 12726.3 12809.9 12859.9 13002.7 13022.0 9640.2 9852.4 9879.3 10235.3 10340.0 10333.6 10778.3 10835.0 10916.4 11091.9 09:41:33 INFO - PROCESS | 10131 | -------- Summary: end -------- 09:41:33 INFO - PROCESS | 10131 | 09:41:34 INFO - TEST-INFO | 10131: exit 0 09:41:34 INFO - TEST-OK | dromaeo_css | took 1108441ms 09:41:34 INFO - TEST-START | kraken 09:41:34 INFO - operating with platform_type : linux_ 09:41:34 INFO - Initialising browser for kraken test... 09:41:34 INFO - TEST-INFO | started process 10375 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnAbNIH/profile http://localhost:44108/getInfo.html) 09:41:38 INFO - PROCESS | 10375 | 09:41:38 INFO - PROCESS | 10375 | (process:10452): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:41:38 INFO - PROCESS | 10375 | __metrics Screen width/height:1600/1200 09:41:38 INFO - PROCESS | 10375 | colorDepth:24 09:41:38 INFO - PROCESS | 10375 | Browser inner width/height: 1024/697 09:41:38 INFO - PROCESS | 10375 | __metrics 09:41:39 INFO - TEST-INFO | 10375: exit 0 09:41:39 INFO - Browser initialized. 09:41:39 INFO - Running cycle 1/1 for kraken test... 09:41:39 INFO - TEST-INFO | started process 10502 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnAbNIH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:41:41 INFO - PROCESS | 10502 | 09:41:41 INFO - PROCESS | 10502 | (process:10568): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:41:51 INFO - PROCESS | 10502 | RSS: Main: 140353536 09:41:51 INFO - PROCESS | 10502 | 09:41:54 INFO - PROCESS | 10502 | Cycle 1(1): loaded http://localhost:44108/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44108/tests/kraken/driver.html?testName=audio-beat-detection) 09:41:54 INFO - PROCESS | 10502 | RSS: Main: 144502784 09:41:54 INFO - PROCESS | 10502 | 09:41:57 INFO - PROCESS | 10502 | Cycle 1(1): loaded http://localhost:44108/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44108/tests/kraken/driver.html?testName=audio-dft) 09:41:58 INFO - PROCESS | 10502 | RSS: Main: 144314368 09:41:58 INFO - PROCESS | 10502 | 09:42:00 INFO - PROCESS | 10502 | Cycle 1(1): loaded http://localhost:44108/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44108/tests/kraken/driver.html?testName=audio-fft) 09:42:01 INFO - PROCESS | 10502 | RSS: Main: 146305024 09:42:01 INFO - PROCESS | 10502 | 09:42:03 INFO - PROCESS | 10502 | Cycle 1(1): loaded http://localhost:44108/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44108/tests/kraken/driver.html?testName=audio-oscillator) 09:42:04 INFO - PROCESS | 10502 | RSS: Main: 146280448 09:42:04 INFO - PROCESS | 10502 | 09:42:06 INFO - PROCESS | 10502 | Cycle 1(1): loaded http://localhost:44108/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44108/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:42:06 INFO - PROCESS | 10502 | RSS: Main: 146604032 09:42:06 INFO - PROCESS | 10502 | 09:42:09 INFO - PROCESS | 10502 | Cycle 1(1): loaded http://localhost:44108/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44108/tests/kraken/driver.html?testName=imaging-darkroom) 09:42:10 INFO - PROCESS | 10502 | RSS: Main: 146128896 09:42:10 INFO - PROCESS | 10502 | 09:42:13 INFO - PROCESS | 10502 | Cycle 1(1): loaded http://localhost:44108/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44108/tests/kraken/driver.html?testName=imaging-desaturate) 09:42:14 INFO - PROCESS | 10502 | RSS: Main: 146284544 09:42:14 INFO - PROCESS | 10502 | 09:42:17 INFO - PROCESS | 10502 | Cycle 1(1): loaded http://localhost:44108/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44108/tests/kraken/driver.html?testName=json-parse-financial) 09:42:17 INFO - PROCESS | 10502 | RSS: Main: 146649088 09:42:17 INFO - PROCESS | 10502 | 09:42:19 INFO - PROCESS | 10502 | Cycle 1(1): loaded http://localhost:44108/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44108/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:42:19 INFO - PROCESS | 10502 | RSS: Main: 145817600 09:42:19 INFO - PROCESS | 10502 | 09:42:21 INFO - PROCESS | 10502 | Cycle 1(1): loaded http://localhost:44108/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44108/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:42:22 INFO - PROCESS | 10502 | RSS: Main: 146796544 09:42:22 INFO - PROCESS | 10502 | 09:42:24 INFO - PROCESS | 10502 | Cycle 1(1): loaded http://localhost:44108/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44108/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:42:24 INFO - PROCESS | 10502 | RSS: Main: 145891328 09:42:24 INFO - PROCESS | 10502 | 09:42:27 INFO - PROCESS | 10502 | Cycle 1(1): loaded http://localhost:44108/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44108/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:42:27 INFO - PROCESS | 10502 | RSS: Main: 146358272 09:42:27 INFO - PROCESS | 10502 | 09:42:30 INFO - PROCESS | 10502 | Cycle 1(1): loaded http://localhost:44108/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44108/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:42:30 INFO - PROCESS | 10502 | RSS: Main: 146305024 09:42:30 INFO - PROCESS | 10502 | 09:42:32 INFO - PROCESS | 10502 | Cycle 1(1): loaded http://localhost:44108/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44108/tests/kraken/driver.html?testName=ai-astar) 09:42:32 INFO - PROCESS | 10502 | RSS: Main: 146919424 09:42:32 INFO - PROCESS | 10502 | 09:42:32 INFO - PROCESS | 10502 | __start_tp_report 09:42:32 INFO - PROCESS | 10502 | _x_x_mozilla_page_load 09:42:32 INFO - PROCESS | 10502 | _x_x_mozilla_page_load_details 09:42:32 INFO - PROCESS | 10502 | |i|pagename|runs| 09:42:32 INFO - PROCESS | 10502 | |0;ai-astar;110;105;109;109;110;120;109;111;110;109 09:42:32 INFO - PROCESS | 10502 | |1;audio-beat-detection;154;128;166;165;133;149;147;129;164;124 09:42:32 INFO - PROCESS | 10502 | |2;audio-dft;164;163;167;163;166;164;166;166;167;161 09:42:32 INFO - PROCESS | 10502 | |3;audio-fft;76;76;72;165;78;73;75;76;161;76 09:42:32 INFO - PROCESS | 10502 | |4;audio-oscillator;95;95;153;95;97;94;139;94;95;143 09:42:32 INFO - PROCESS | 10502 | |5;imaging-gaussian-blur;110;110;109;110;109;110;111;111;110;110 09:42:32 INFO - PROCESS | 10502 | |6;imaging-darkroom;148;145;147;148;148;147;146;146;147;146 09:42:32 INFO - PROCESS | 10502 | |7;imaging-desaturate;96;97;96;96;97;96;96;96;96;97 09:42:32 INFO - PROCESS | 10502 | |8;json-parse-financial;53;60;58;54;54;58;55;60;52;58 09:42:32 INFO - PROCESS | 10502 | |9;json-stringify-tinderbox;64;64;67;64;65;64;64;64;65;64 09:42:32 INFO - PROCESS | 10502 | |10;stanford-crypto-aes;82;88;81;84;84;81;81;88;83;82 09:42:32 INFO - PROCESS | 10502 | |11;stanford-crypto-ccm;114;115;111;116;118;117;112;117;126;114 09:42:32 INFO - PROCESS | 10502 | |12;stanford-crypto-pbkdf2;126;150;142;138;139;137;140;143;133;141 09:42:32 INFO - PROCESS | 10502 | |13;stanford-crypto-sha256-iterative;69;64;64;66;66;65;65;67;65;63 09:42:32 INFO - PROCESS | 10502 | __end_tp_report 09:42:32 INFO - PROCESS | 10502 | __start_cc_report 09:42:32 INFO - PROCESS | 10502 | _x_x_mozilla_cycle_collect,754 09:42:32 INFO - PROCESS | 10502 | __end_cc_report 09:42:32 INFO - PROCESS | 10502 | __startTimestamp1455212552703__endTimestamp 09:42:32 INFO - PROCESS | 10502 | 09:42:32 INFO - PROCESS | 10502 | ------- Summary: start ------- 09:42:32 INFO - PROCESS | 10502 | Number of tests: 14 09:42:32 INFO - PROCESS | 10502 | 09:42:32 INFO - PROCESS | 10502 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.00 stddev:3.79 (3.4%) stddev-sans-first:4.02 09:42:32 INFO - PROCESS | 10502 | Values: 110.0 105.0 109.0 109.0 110.0 120.0 109.0 111.0 110.0 109.0 09:42:32 INFO - PROCESS | 10502 | 09:42:32 INFO - PROCESS | 10502 | [#1] audio-beat-detection Cycles:10 Average:145.90 Median:151.50 stddev:16.41 (10.8%) stddev-sans-first:17.15 09:42:32 INFO - PROCESS | 10502 | Values: 154.0 128.0 166.0 165.0 133.0 149.0 147.0 129.0 164.0 124.0 09:42:32 INFO - PROCESS | 10502 | 09:42:32 INFO - PROCESS | 10502 | [#2] audio-dft Cycles:10 Average:164.70 Median:166.00 stddev:2.00 (1.2%) stddev-sans-first:2.11 09:42:32 INFO - PROCESS | 10502 | Values: 164.0 163.0 167.0 163.0 166.0 164.0 166.0 166.0 167.0 161.0 09:42:32 INFO - PROCESS | 10502 | 09:42:32 INFO - PROCESS | 10502 | [#3] audio-fft Cycles:10 Average:92.80 Median:76.00 stddev:37.05 (48.7%) stddev-sans-first:38.79 09:42:32 INFO - PROCESS | 10502 | Values: 76.0 76.0 72.0 165.0 78.0 73.0 75.0 76.0 161.0 76.0 09:42:32 INFO - PROCESS | 10502 | 09:42:32 INFO - PROCESS | 10502 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:95.00 stddev:24.40 (25.7%) stddev-sans-first:25.27 09:42:32 INFO - PROCESS | 10502 | Values: 95.0 95.0 153.0 95.0 97.0 94.0 139.0 94.0 95.0 143.0 09:42:32 INFO - PROCESS | 10502 | 09:42:32 INFO - PROCESS | 10502 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 09:42:32 INFO - PROCESS | 10502 | Values: 110.0 110.0 109.0 110.0 109.0 110.0 111.0 111.0 110.0 110.0 09:42:32 INFO - PROCESS | 10502 | 09:42:32 INFO - PROCESS | 10502 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:1.03 (0.7%) stddev-sans-first:1.00 09:42:32 INFO - PROCESS | 10502 | Values: 148.0 145.0 147.0 148.0 148.0 147.0 146.0 146.0 147.0 146.0 09:42:32 INFO - PROCESS | 10502 | 09:42:32 INFO - PROCESS | 10502 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 09:42:32 INFO - PROCESS | 10502 | Values: 96.0 97.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 97.0 09:42:32 INFO - PROCESS | 10502 | 09:42:32 INFO - PROCESS | 10502 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:58.00 stddev:2.94 (5.1%) stddev-sans-first:2.88 09:42:32 INFO - PROCESS | 10502 | Values: 53.0 60.0 58.0 54.0 54.0 58.0 55.0 60.0 52.0 58.0 09:42:32 INFO - PROCESS | 10502 | 09:42:32 INFO - PROCESS | 10502 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:64.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 09:42:32 INFO - PROCESS | 10502 | Values: 64.0 64.0 67.0 64.0 65.0 64.0 64.0 64.0 65.0 64.0 09:42:32 INFO - PROCESS | 10502 | 09:42:32 INFO - PROCESS | 10502 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.50 stddev:2.67 (3.2%) stddev-sans-first:2.79 09:42:32 INFO - PROCESS | 10502 | Values: 82.0 88.0 81.0 84.0 84.0 81.0 81.0 88.0 83.0 82.0 09:42:32 INFO - PROCESS | 10502 | 09:42:32 INFO - PROCESS | 10502 | [#11] stanford-crypto-ccm Cycles:10 Average:116.00 Median:116.50 stddev:4.16 (3.6%) stddev-sans-first:4.35 09:42:32 INFO - PROCESS | 10502 | Values: 114.0 115.0 111.0 116.0 118.0 117.0 112.0 117.0 126.0 114.0 09:42:32 INFO - PROCESS | 10502 | 09:42:32 INFO - PROCESS | 10502 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.90 Median:140.50 stddev:6.33 (4.5%) stddev-sans-first:4.69 09:42:32 INFO - PROCESS | 10502 | Values: 126.0 150.0 142.0 138.0 139.0 137.0 140.0 143.0 133.0 141.0 09:42:32 INFO - PROCESS | 10502 | 09:42:32 INFO - PROCESS | 10502 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.50 stddev:1.71 (2.6%) stddev-sans-first:1.22 09:42:32 INFO - PROCESS | 10502 | Values: 69.0 64.0 64.0 66.0 66.0 65.0 65.0 67.0 65.0 63.0 09:42:32 INFO - PROCESS | 10502 | -------- Summary: end -------- 09:42:32 INFO - PROCESS | 10502 | 09:42:33 INFO - TEST-INFO | 10502: exit 0 09:42:33 INFO - TEST-OK | kraken | took 59050ms 09:42:33 INFO - TEST-START | v8_7 09:42:33 INFO - operating with platform_type : linux_ 09:42:33 INFO - Initialising browser for v8_7 test... 09:42:33 INFO - TEST-INFO | started process 10798 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdcQj7S/profile http://localhost:44108/getInfo.html) 09:42:37 INFO - PROCESS | 10798 | 09:42:37 INFO - PROCESS | 10798 | (process:10879): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:42:37 INFO - PROCESS | 10798 | __metrics Screen width/height:1600/1200 09:42:37 INFO - PROCESS | 10798 | colorDepth:24 09:42:37 INFO - PROCESS | 10798 | Browser inner width/height: 1024/697 09:42:37 INFO - PROCESS | 10798 | __metrics 09:42:38 INFO - TEST-INFO | 10798: exit 0 09:42:38 INFO - Browser initialized. 09:42:38 INFO - Running cycle 1/1 for v8_7 test... 09:42:38 INFO - TEST-INFO | started process 10928 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdcQj7S/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:42:40 INFO - PROCESS | 10928 | 09:42:40 INFO - PROCESS | 10928 | (process:10990): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:42:50 INFO - PROCESS | 10928 | RSS: Main: 140292096 09:42:50 INFO - PROCESS | 10928 | 09:43:13 INFO - PROCESS | 10928 | Cycle 1(1): loaded http://localhost:44108/tests/v8_7/run.html (next: http://localhost:44108/tests/v8_7/run.html) 09:43:13 INFO - PROCESS | 10928 | RSS: Main: 144375808 09:43:13 INFO - PROCESS | 10928 | 09:43:13 INFO - PROCESS | 10928 | __start_tp_report 09:43:13 INFO - PROCESS | 10928 | _x_x_mozilla_page_load 09:43:13 INFO - PROCESS | 10928 | _x_x_mozilla_page_load_details 09:43:13 INFO - PROCESS | 10928 | |i|pagename|runs| 09:43:13 INFO - PROCESS | 10928 | |0;Richards;167.2800267648043 09:43:13 INFO - PROCESS | 10928 | |1;DeltaBlue;170.50298380221653 09:43:13 INFO - PROCESS | 10928 | |2;Encrypt;277.9321845469705 09:43:13 INFO - PROCESS | 10928 | |3;Decrypt;5191.709844559586 09:43:13 INFO - PROCESS | 10928 | |4;RayTrace;954.1984732824427 09:43:13 INFO - PROCESS | 10928 | |5;Earley;565.6108597285067 09:43:13 INFO - PROCESS | 10928 | |6;Boyer;11133.333333333334 09:43:13 INFO - PROCESS | 10928 | |7;RegExp;39076.92307692308 09:43:13 INFO - PROCESS | 10928 | |8;Splay;521.9206680584551 09:43:13 INFO - PROCESS | 10928 | |9;NavierStokes;4859.223300970873 09:43:13 INFO - PROCESS | 10928 | __end_tp_report 09:43:13 INFO - PROCESS | 10928 | __startTimestamp1455212593302__endTimestamp 09:43:13 INFO - PROCESS | 10928 | 09:43:13 INFO - PROCESS | 10928 | ------- Summary: start ------- 09:43:13 INFO - PROCESS | 10928 | Number of tests: 10 09:43:13 INFO - PROCESS | 10928 | 09:43:13 INFO - PROCESS | 10928 | [#0] Richards Cycles:1 Average:167.28 Median:167.28 stddev:0.00 (0.0%) 09:43:13 INFO - PROCESS | 10928 | Values: 167.3 09:43:13 INFO - PROCESS | 10928 | 09:43:13 INFO - PROCESS | 10928 | [#1] DeltaBlue Cycles:1 Average:170.50 Median:170.50 stddev:0.00 (0.0%) 09:43:13 INFO - PROCESS | 10928 | Values: 170.5 09:43:13 INFO - PROCESS | 10928 | 09:43:13 INFO - PROCESS | 10928 | [#2] Encrypt Cycles:1 Average:277.93 Median:277.93 stddev:0.00 (0.0%) 09:43:13 INFO - PROCESS | 10928 | Values: 277.9 09:43:13 INFO - PROCESS | 10928 | 09:43:13 INFO - PROCESS | 10928 | [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 09:43:13 INFO - PROCESS | 10928 | Values: 5191.7 09:43:13 INFO - PROCESS | 10928 | 09:43:13 INFO - PROCESS | 10928 | [#4] RayTrace Cycles:1 Average:954.20 Median:954.20 stddev:0.00 (0.0%) 09:43:13 INFO - PROCESS | 10928 | Values: 954.2 09:43:13 INFO - PROCESS | 10928 | 09:43:13 INFO - PROCESS | 10928 | [#5] Earley Cycles:1 Average:565.61 Median:565.61 stddev:0.00 (0.0%) 09:43:13 INFO - PROCESS | 10928 | Values: 565.6 09:43:13 INFO - PROCESS | 10928 | 09:43:13 INFO - PROCESS | 10928 | [#6] Boyer Cycles:1 Average:11133.33 Median:11133.33 stddev:0.00 (0.0%) 09:43:13 INFO - PROCESS | 10928 | Values: 11133.3 09:43:13 INFO - PROCESS | 10928 | 09:43:13 INFO - PROCESS | 10928 | [#7] RegExp Cycles:1 Average:39076.92 Median:39076.92 stddev:0.00 (0.0%) 09:43:13 INFO - PROCESS | 10928 | Values: 39076.9 09:43:13 INFO - PROCESS | 10928 | 09:43:13 INFO - PROCESS | 10928 | [#8] Splay Cycles:1 Average:521.92 Median:521.92 stddev:0.00 (0.0%) 09:43:13 INFO - PROCESS | 10928 | Values: 521.9 09:43:13 INFO - PROCESS | 10928 | 09:43:13 INFO - PROCESS | 10928 | [#9] NavierStokes Cycles:1 Average:4859.22 Median:4859.22 stddev:0.00 (0.0%) 09:43:13 INFO - PROCESS | 10928 | Values: 4859.2 09:43:13 INFO - PROCESS | 10928 | -------- Summary: end -------- 09:43:13 INFO - PROCESS | 10928 | 09:43:14 INFO - TEST-INFO | 10928: exit 0 09:43:14 INFO - TEST-OK | v8_7 | took 40536ms 09:43:14 INFO - SUITE-END | took 1208s 09:43:14 INFO - Completed test suite (00:20:08) 09:43:14 INFO - Working with test: dromaeo_css 09:43:14 INFO - Generating results file: dromaeo_css 09:43:14 INFO - Working with test: kraken 09:43:14 INFO - Generating results file: kraken 09:43:14 INFO - javascript benchmark 09:43:14 INFO - Working with test: v8_7 09:43:14 INFO - Generating results file: v8_7 09:43:14 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:43:14 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 09:43:14 INFO - process_Request line: dromaeo_css 7436.83 graph.html#tests=[[72,52,43]] 09:43:14 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:43:14 INFO - process_Request line: kraken 1501.10 graph.html#tests=[[232,52,43]] 09:43:14 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:43:14 INFO - process_Request line: v8_7 21932.19 graph.html#tests=[[230,52,43]] 09:43:14 INFO - RETURN: dromaeo_css: 7436.83 09:43:14 INFO - RETURN: kraken: 1501.10 09:43:14 INFO - RETURN: v8_7: 21932.19 09:43:14 INFO - javascript benchmark 09:43:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3359.5296658467814, 3383.018924511892, 3386.2042420031303, 3401.2347221875075, 3407.4548072308435, 5468.152436372364, 5473.781048758055, 5478.45215478452, 5492.176173573966, 5516.3380394352735, 5487.780488780454, 5501.0, 5505.146702261156, 5539.086050801623, 5570.777168913249, 4958.157113290731, 4973.925391119127, 5060.7722652480725, 5110.591152707793, 5118.232265160219, 4851.684640498374, 4935.062338155739, 5055.090083784918, 5063.873403164932, 5074.974625126869, 4996.400431948153, 5019.272205530196, 5055.216441451581, 5062.519060689247, 5063.544281014708, 4994.600431965434, 4996.775145118479, 5004.649674522785, 5006.774695138727, 5032.119379108642, 4857.878553036167, 4881.731504767236, 4907.582855457291, 4917.631177661654, 4949.455559888409, 5242.947570524284, 5268.998890210848, 5276.15581506957, 5282.049231138432, 5312.229726689647, 5848.766049358063, 5854.356020837705, 5862.062070068811, 5875.1187321901625, 5879.588428809985, 5803.303603567599, 5864.794732184396, 5915.911261331084, 5932.139839723259, 5942.049272116441, 5444.646098003656, 5456.91814622781, 5460.808871689472, 5471.5896307776675, 5481.397046324901, 5868.735906884115, 5879.265091863517, 5880.588358814927, 5887.646741195542, 5898.557608179403, 5758.942410575841, 5762.1068734346245, 5846.4153584642045, 5846.912296315559, 5902.439268269508, 5845.415458454206, 5846.356900740915, 5846.736896839652, 5849.356570777211, 5854.034084376115, 5781.392953739881, 5805.6806875621405, 5813.0, 5818.33089194748, 5820.156077368758, 5813.970930145322, 5861.267341582302, 5923.289205295306, 5926.555508336892, 5949.315828679671, 4442.68901176921, 4484.192845287879, 4497.685162038626, 4500.347449619787, 4526.32105184225, 3968.861089861841, 4034.536028356718, 4051.2505186540584, 4084.3873418986796, 4096.91806163875, 5507.862303442366, 5544.7782088716, 5547.389787123413, 5575.52608028314, 5585.3297604287745, 5880.088586269135, 5904.143899134688, 5905.232319798399, 5906.114082887601, 5906.645601263938, 5394.676319420847, 5453.400125986138, 5541.722913854291, 5543.1408131739645, 5548.0845660466375, 5039.244113383022, 5049.065922804293, 5051.217061355495, 5055.949440505621, 5060.3168572242275, 5977.043673012297, 6034.306054803666, 6039.849003774941, 6055.061465472859, 6056.9697151513965, 5796.884062318814, 5875.177475153568, 5878.588498805043, 5885.264341957255, 5947.762089516371, 5931.110333450017, 6005.969970150296, 6027.30685971119, 6069.362716914837, 6092.543059270483, 5729.770809167753, 5739.9139012915675, 5759.94240057594, 5774.711264436677, 5776.653400795965, 5762.827115186551, 5854.443827836349, 5856.297244330707, 5856.7950121747235, 5861.1501332307425, 5747.3103227612955, 5763.740631671669, 5857.531397488276, 5860.853478663067, 5882.441168089024, 5635.126555383922, 5643.774249030157, 5658.717064146858, 5687.374388817144, 5700.0, 5579.944200557942, 5592.161175823659, 5609.298837645294, 5615.522680572034, 5630.465105814941, 5820.621659592113, 5838.912416313844, 5854.326752423526, 5866.911996320144, 5916.822495325147, 5593.468620481048, 5650.0677388232125, 5650.180723795109, 5659.85850353728, 5672.2342483765815], "unit": "score", "name": "dojo.html", "value": 5411.767663152477}, {"lowerIsBetter": false, "replicates": [557.9107342825149, 565.3329071695399, 570.3237340173331, 586.9941300586993, 633.7401665317219, 32820.0, 41868.37197442037, 42201.0, 42209.78895105528, 42239.155216895684, 44695.0, 44931.0, 45148.77425612875, 45387.319190212176, 45583.0, 8788.69239576615, 8985.640574377017, 8989.820203595924, 8995.41529800564, 8997.550122493882, 8773.736787896341, 8935.59789809457, 8961.834961455002, 8966.955165224164, 8980.685676001342, 8913.376063675545, 8914.643414263453, 8957.14907083826, 8996.055414181516, 9019.278457723367, 8862.468251904875, 8909.777255568597, 8914.732558023237, 8931.598078086468, 8943.68697095605, 8813.250873675745, 8929.241014513775, 8941.865872011926, 8947.284217262604, 8964.238039766627, 42325.57674423247, 42371.788141059405, 42448.0, 42824.78587607073, 42949.35575966363, 3550.6626870447267, 3631.346357655621, 3699.519062521882, 3970.3250447424007, 4272.209641216354, 32265.83867080673, 32439.0, 32456.513152302734, 32483.350332993206, 32611.18472038218, 4064.654504367132, 4068.4304197412384, 4136.193442278757, 4178.7984212543315, 4199.286121359346, 210973.0, 211963.0, 212428.0, 332203.0, 335961.3201933999, 59991.10013349803, 60493.09260361098, 60617.69691151516, 60729.39270607326, 60845.39154608486, 67599.0, 68631.31368686249, 68741.65629171922, 69010.0, 69292.0, 18219.45341639753, 18335.816641833677, 18362.08189590515, 18400.355987540373, 18414.263429462673, 14370.784438233435, 14378.496752613608, 14438.278086095654, 14474.782878256834, 14477.710445791025, 21251.46871328229, 21448.356549303546, 21494.78505214959, 21603.89198054031, 21659.35021949344, 8345.54099524532, 8464.365172612079, 8534.402591818513, 8537.18896704812, 8559.700410485602, 1069.2835800014009, 1091.4542728635681, 1171.344047333496, 1188.3167178872184, 1215.7568486302775, 30780.84609576938, 30917.0, 30955.8452207742, 33507.32985340279, 33921.32157356839, 1140.4411838199223, 1193.4331192683405, 1211.5902495358268, 1216.4343580235234, 1250.1811313589612, 15254.0, 15971.0, 16045.438409655606, 16148.031118132949, 16458.09480478561, 520202.0, 536076.0, 541581.0, 542972.0, 550606.0, 53143.46856531462, 53721.73139134357, 54136.18795718067, 54243.18635220396, 54309.1853622196, 1373.2378529915993, 1460.189594774889, 1462.6197188731007, 1479.0386248938062, 1483.6839663352398, 30507.084787456413, 31832.52251216187, 31871.203219919687, 32905.0, 32910.0, 47789.0, 48311.75844120757, 48390.516094838604, 48452.7577362111, 48514.757426214055, 331199.0, 332807.0, 332990.0, 333407.0, 333471.0, 33527.83236083804, 49045.75477122592, 49209.26186107283, 49486.50513494819, 49825.252621209984, 46790.532094678616, 47556.0, 48161.0, 48500.0, 48584.0, 40537.79731101326, 42686.78656606697, 43616.34575481307, 43939.12121757611, 45012.54987450084, 41927.790361048, 42737.5726242746, 46856.7657161712, 48144.75927620479, 48174.0, 44978.3253251195, 45103.32345014762, 45336.31995520136, 45388.319175211735, 45508.54491455043, 37452.43821342628, 38151.0, 38468.807655961544, 39050.0, 39090.0, 29404.411911761217, 29616.23026184272, 30312.84843575768, 30314.69685303207, 30432.0], "unit": "score", "name": "ext.html", "value": 20708.075233326028}, {"lowerIsBetter": false, "replicates": [381.66222892739927, 382.2298069390179, 383.7985057844633, 387.1270285506184, 390.40853107542097, 15039.473618423357, 15818.367265309389, 17590.384336548224, 17738.20178091986, 17845.910770446146, 17371.131443427843, 17654.205560749764, 17912.462626121203, 18672.906635466803, 18772.71840922387, 5561.6663000220115, 5740.397258287882, 5771.624844385123, 5781.508571771384, 5782.913256301138, 3880.417937309398, 4015.4177644241568, 5436.728163591804, 5633.183188437674, 5657.745401456944, 5430.91853622196, 5572.442755724435, 5635.802746903859, 5641.746121424525, 5691.544676425897, 5691.4877661010505, 5701.173329867146, 5720.771169153229, 5721.056025755766, 5754.2807149106575, 5228.0, 5389.973050134724, 5391.973040134774, 5436.565074794046, 5507.531859791922, 13486.190828550318, 16463.0, 20517.38447846567, 20600.0, 20620.484487887774, 2226.543558570489, 2282.2354511238755, 2299.379167624732, 2384.1297926256966, 2475.801935845128, 10043.397396156253, 10228.846567301496, 10388.636397726043, 10456.52945617449, 10623.25637205396, 1753.4126067767313, 1886.9056547172586, 1898.781640111391, 1964.7936966618586, 1974.5853370792152, 60522.0, 60567.69716151435, 61363.07955380628, 63119.36880631181, 63547.68226158886, 10743.409112498732, 10962.945185274182, 10988.670339889815, 10997.230193886351, 11029.889701103048, 14117.435302587986, 14670.119792812466, 14678.853211467962, 14782.26088695561, 14813.925930370278, 7848.489848159851, 8091.919080809234, 8198.672053117809, 8238.917610823815, 8350.749477515685, 7959.084705258853, 7976.122626511079, 8054.879176812353, 8093.190680931977, 8098.190180981855, 4701.106789709944, 4704.176769065469, 4775.952240477551, 4802.903941921142, 4831.830885918976, 1944.6955357900933, 1962.4112766170092, 1967.2917749610128, 1995.820376166152, 2015.9899200504196, 966.4781018250206, 1022.5608696731191, 1037.621268237088, 1047.0628787235382, 1097.8353247012851, 17057.31770729182, 18021.909890450726, 18268.725969110474, 18470.168842402123, 18680.53298667517, 1019.5870672377699, 1035.699647102347, 1037.408677054087, 1057.4554104636118, 1074.9844042420461, 9483.478408687588, 9952.402855828674, 10646.627368042236, 10708.464576771286, 10739.892601074045, 536960.0, 572746.0, 593071.0, 627768.0, 631997.0, 76492.23507764963, 77068.0, 78010.0, 81258.0, 81998.59000704958, 1232.8520577530574, 1234.7283597608512, 1248.9196844729245, 1253.410896878484, 1254.5609036837216, 15535.45625903088, 16178.919105404868, 16422.507324780276, 16736.497905062868, 16849.578760531083, 34928.30143397169, 35446.822765886005, 36007.0, 36361.81819090994, 37016.81491592525, 43710.56289437065, 43730.0, 44202.11595768002, 44517.77741111274, 46401.76799115983, 7260.600666963156, 7903.0, 7943.960280198562, 8002.5598592077995, 8299.875501867356, 10516.053555180071, 10806.0, 10938.179636527133, 11323.418300393632, 12014.879851201376, 10373.495843102557, 10584.841227381441, 10705.0, 10765.084967777826, 10780.29928054674, 9597.23222142213, 9859.260555458226, 10010.349327293703, 10367.27429079957, 10382.896171038496, 9915.801683966425, 10000.749981250236, 10159.949200253952, 10481.947590262, 10503.0, 7646.15892251863, 7858.489198202098, 7877.487963282369, 7900.68397264103, 7906.367490600853, 10073.597056117966, 10723.571057157626, 10819.459027048773, 10864.782704345711, 10922.672319830417], "unit": "score", "name": "jquery.html", "value": 8719.355144544701}, {"lowerIsBetter": false, "replicates": [1529.6328881068544, 1536.431520337475, 1764.523578633768, 1845.1604519943428, 1890.366727146406, 8033.91966080339, 8234.341252699785, 8309.626066826992, 8319.126491718373, 8404.873926891101, 8341.20758527939, 8389.035260944993, 8440.32477401808, 8468.830623387528, 8477.830443391129, 2499.0, 2526.115859449187, 2526.166365099513, 2531.1267612673596, 2533.290678609983, 2526.1916186820226, 2597.1169802267227, 2599.233226198276, 2602.531544322021, 2605.700344460383, 2491.4394261291154, 2527.1534036097837, 2549.0823303610687, 2549.8725063746833, 2561.9359516012155, 2523.8990440382363, 2539.200151952129, 2557.271177714361, 2564.358910272432, 2567.9358016049655, 2579.43252484455, 2586.754258345473, 2594.040205124097, 2594.8443093414458, 2602.2973797074683, 8174.059983101901, 8183.14077021916, 8208.794780130485, 8229.79425514367, 8274.048484424247, 5165.483451654842, 5292.867678308035, 5312.787488500456, 5351.331083614548, 5359.705216213107, 3497.615262321143, 3507.9824600877087, 3543.0, 3577.159367548624, 3614.6385361463645, 1140.116409782417, 1145.4673576786834, 1157.1090260499368, 1158.6813626252763, 1170.8829117088308, 11078.390688512129, 11115.610953616666, 11141.777164456747, 11142.442877856074, 11257.268277562014, 4602.654800889946, 4605.631549476101, 4684.859454216379, 4694.460137084211, 4726.196546587088, 8882.15619516145, 9027.277817774562, 9032.774180645405, 9075.636974521078, 9081.68214112516, 5096.61775366849, 5136.614753893473, 5142.0, 5147.536721695065, 5159.0, 4736.881577960578, 4756.619470442356, 4786.1624215762795, 4787.162246606899, 4788.3056956741075, 3753.418220175877, 3789.791561464146, 3792.3742582473583, 3798.2213646202463, 3819.3698039823116, 1162.2968104296947, 1167.7430965187646, 1171.800793865045, 1175.8236264560214, 1193.659806955031, 1123.3428444359977, 1127.475723788426, 1167.2062997161843, 1354.7219398507464, 1437.116173553278, 7747.0, 7802.375809935192, 7829.491083079582, 7991.0810256821205, 8148.714794982147, 1197.8921897029136, 1204.1691233049169, 1211.7576484703095, 1219.8963088137607, 1236.8701286364983, 6216.409441103088, 6249.406306400884, 6326.335734747877, 6330.39861213184, 6370.267419246753, 9827.508624568743, 10056.949715251378, 10097.798044039226, 10156.085952264331, 10270.0, 9614.759631009141, 10136.0, 10287.434191119411, 10333.431661258552, 10382.740431489274, 7853.646585903648, 7908.920910790818, 7932.524048557105, 7941.76174714748, 7968.243016913384, 7365.189829118685, 7426.108866936002, 7433.256674332523, 7696.653650585625, 7848.136704962335, 8521.147885211429, 8738.257248133725, 8766.298696104168, 8807.251383632463, 8819.823603528022, 8767.386282960131, 8946.463212207289, 8989.325800564853, 9209.585568649562, 9296.767580810534, 7225.6387180641805, 7273.927260727325, 7304.306090921354, 7314.34170924598, 7328.487005909536, 7895.565743884142, 8005.59972001386, 8031.277185053374, 8079.83840323202, 8083.878741818759, 7462.776116716507, 7546.471746977659, 7556.4710470266555, 7636.274553917369, 7736.265054820008, 7434.59109748969, 7494.850102997801, 7520.8495830082, 7528.0, 7686.6541005656, 7414.073240844895, 7485.363744081814, 7504.362129218859, 7514.211007844317, 7538.170801211972, 6860.622665753432, 6865.41643960269, 6871.106756121672, 6900.654967251718, 6914.0666010088, 6869.072675188786, 6917.723291068301, 6951.548149370275, 7052.647367631701, 7060.43516518667], "unit": "score", "name": "mootools.html", "value": 4858.7984615272035}, {"lowerIsBetter": false, "replicates": [367.86940636074195, 371.9739618226722, 372.51758972131086, 376.27191384670647, 377.8205352457583, 6334.366563343663, 6352.618842869431, 6377.840553986147, 6414.486841052716, 6517.67411629419, 6239.0, 6378.649174295412, 6415.967920160404, 6424.646644434554, 6431.2282526096815, 4944.752762361885, 4955.182394904837, 4956.876078098058, 4962.454130045701, 4965.851024469272, 4883.413990321149, 4963.106640804654, 4976.178930476467, 4978.029284289565, 4984.451710311862, 4895.8776030599165, 4903.632227582928, 4923.18767403378, 4923.58149557288, 4924.433690125627, 4908.509149085098, 4911.607071434277, 4919.237518184669, 4921.212605983043, 4932.062908047459, 4352.651787856964, 4359.760213188273, 4366.0, 4367.759773212472, 4374.912501749947, 5995.250593675791, 6076.392360763933, 6090.908636370458, 6095.878082438327, 6097.481714054311, 5696.629719068289, 5712.314522257314, 5718.370979192286, 5718.799842005551, 5726.942730572682, 6802.795916122524, 6844.863102737967, 6850.869606514919, 6855.006024126474, 6861.862762744717, 4733.905321893577, 4748.287756836502, 4755.239161734141, 4760.928586071212, 4767.570918617306, 6938.618375989318, 7057.153141623038, 7121.0, 7124.073870396815, 7135.143782746052, 4851.781669824866, 4861.732604706775, 4864.927026094611, 4866.075445665312, 4867.367242258484, 4912.582430493377, 4916.72957987307, 4926.211806111077, 4930.778114984834, 4931.112399768004, 5571.582131340166, 5644.3508996465935, 5662.235598194191, 5679.119736440858, 5693.743781529841, 6869.416099631488, 6873.793786186422, 6894.0, 6896.27589103147, 6905.274946130685, 1634.7302695055182, 1655.6192075822387, 1710.7433884917114, 1740.9390671326444, 1743.0674589094774, 1166.6208482243305, 1167.6963989362828, 1176.1766763265748, 1176.8293597428326, 1186.4542310537076, 6371.840703982438, 6415.67921603918, 6434.581752186093, 6435.066915297256, 6466.450351720063, 6910.792676219721, 6917.965410172917, 6946.93053069473, 6975.860482790417, 6977.93022069783, 6400.0, 6451.580647257913, 6480.740770369132, 6530.249021362604, 6548.8035358939305, 3823.789691566935, 3835.2137811748526, 3860.2435891669224, 3863.014931192528, 3884.3396622574232, 7299.124105107315, 7333.413326933833, 7369.189389167187, 7378.667959941816, 7385.8153546161775, 7118.394936430462, 7301.0, 7320.67056982437, 7337.19290878003, 7359.337659610661, 7172.175199852084, 7187.460940429489, 7250.347468727734, 7254.419646428273, 7290.45321600882, 7106.7157313706875, 7112.395446387115, 7116.082406213634, 7118.572885626879, 7158.498905076594, 6933.930660693329, 7062.8234294141, 7064.576125432491, 7066.505344625827, 7070.257622949516, 7286.162091359562, 7330.266973302841, 7345.485815992829, 7349.448791340564, 7354.374878135419, 4865.1242776300605, 4869.926951095666, 4871.3423687803115, 4887.266909963534, 4889.511048895082, 7006.579605223703, 7007.894881576883, 7120.964395177991, 7140.964295178491, 7151.642417878981, 6926.168859736864, 6942.757003504853, 6950.026996220432, 6955.791326260221, 6958.269381715049, 6863.897041544281, 6871.793846184622, 6888.242293347627, 6895.103636527219, 6915.239323674291, 6679.1984961802955, 6778.084958530535, 6800.761973330909, 6806.115205023315, 6811.557248778813, 6895.241523432318, 6938.791836244921, 6950.374466298057, 6957.79126626202, 6968.059311992816, 6678.3989440950545, 6704.094947182068, 6764.2559318475915, 6774.0, 6784.491163162881], "unit": "score", "name": "prototype.html", "value": 5171.131313199289}, {"lowerIsBetter": false, "replicates": [761.5544906229856, 824.9175082491752, 860.2816648098838, 884.4825776920501, 931.9161275485208, 14529.78205326921, 14614.269286535657, 14638.853611463883, 14653.926730366333, 14675.633109172262, 13858.792118118236, 13917.0, 15317.770233446507, 15640.139792311418, 15641.608959776011, 874.8337815814975, 881.5195718333507, 890.0432035561764, 917.2753524715466, 917.7843206846386, 911.1617312072909, 913.0093848174738, 915.4187091197072, 915.8763566918448, 918.6784625381097, 934.3226161033265, 939.7415710679584, 942.7454587261435, 943.1888575824785, 946.8248374050788, 932.8507438809792, 933.7852293972425, 935.2517985611552, 938.8779458670364, 939.8496240601539, 694.2398074108843, 695.4644923408947, 696.022088965005, 697.0450482838493, 699.0, 13756.65608359789, 13797.655058623513, 13800.240986745725, 13826.723465530733, 13843.30783460833, 13888.513902013381, 13931.233782141979, 14039.298035098307, 14061.859381406259, 14086.631635731599, 11444.313341199555, 11450.656480305604, 11496.655100347003, 11647.417629118594, 12291.938540307241, 3951.229510245503, 3975.383815508601, 4003.199360127986, 4024.074462873526, 4066.0, 49591.0, 49593.75203123997, 49829.75085124551, 50430.243546346836, 50952.49047509515, 9970.850437243447, 10160.390376577428, 10183.898161018444, 10296.691099267035, 10352.637657681946, 18841.0, 18894.716579251322, 19496.512587185432, 19565.1195696194, 19634.410967670992, 7978.760637180894, 8113.716019939274, 8133.349332053422, 8162.347012239006, 8403.0, 4547.090581883636, 4614.815407383667, 4622.098690755271, 4634.0, 4642.9535704643195, 3361.7646764726233, 3366.225768073308, 3369.865205391806, 3402.5406570113214, 3403.0, 592.9080992446178, 600.2227115884939, 602.0607851751282, 616.2204810914197, 617.8856911471393, 752.3454594502817, 753.6608526163249, 757.1822431773671, 758.1622307350409, 772.6793380746927, 9172.403793753385, 9704.854427183598, 9715.222782177409, 9775.706728798148, 9788.804223915624, 611.461913516103, 619.1146660275759, 708.5182076188241, 721.8339781850204, 761.5621017914722, 4448.755318457451, 4502.774861256924, 4575.290829921368, 4879.4388645305535, 4894.681845680019, 60655.0, 60777.39222607806, 61114.38885611087, 62011.069833952526, 62229.0, 50271.24593131106, 54507.45492545103, 55024.0, 55048.44951550513, 55333.72333138309, 48162.759186203846, 49098.0, 49888.0, 49948.50051499511, 50332.0, 9535.809283814424, 9606.327557070937, 9721.70834874955, 9790.559424826042, 9909.603615855573, 35669.82165089158, 36329.81835090808, 36613.450798238584, 37122.44316335311, 37231.44152837764, 46013.0, 48926.26610600773, 49059.264111039076, 50146.7492662549, 50304.74847625739, 12194.0, 12350.197237179555, 12385.504579816707, 12419.813702794285, 12809.935950320189, 12677.936610316889, 12939.935300323437, 12999.740005200032, 13015.609531714064, 13167.144135631153, 11770.52917883275, 12034.63896083119, 12179.817302740643, 12194.512219511475, 12489.0, 12802.039847011698, 12849.614511564669, 12887.93556032214, 12888.226706397647, 12949.158304710163, 12726.300053497147, 12809.935950320189, 12859.906907912933, 13002.739945200854, 13022.0, 9640.228781697308, 9852.359596626196, 9879.259055570717, 10235.283530152818, 10339.9660033996, 10333.638322658671, 10778.29941053829, 10834.957277769197, 10916.399598022184, 11091.944540277247], "unit": "score", "name": "yui.html", "value": 6889.869936277787}], "name": "dromaeo_css", "value": 7436.826093704792}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 105.0, 109.0, 109.0, 110.0, 120.0, 109.0, 111.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [154.0, 128.0, 166.0, 165.0, 133.0, 149.0, 147.0, 129.0, 164.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 145.9}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 167.0, 163.0, 166.0, 164.0, 166.0, 166.0, 167.0, 161.0], "unit": "score", "name": "audio-dft", "value": 164.7}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 72.0, 165.0, 78.0, 73.0, 75.0, 76.0, 161.0, 76.0], "unit": "score", "name": "audio-fft", "value": 92.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 153.0, 95.0, 97.0, 94.0, 139.0, 94.0, 95.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 111.0, 111.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 145.0, 147.0, 148.0, 148.0, 147.0, 146.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [53.0, 60.0, 58.0, 54.0, 54.0, 58.0, 55.0, 60.0, 52.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 56.2}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 67.0, 64.0, 65.0, 64.0, 64.0, 64.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [82.0, 88.0, 81.0, 84.0, 84.0, 81.0, 81.0, 88.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [114.0, 115.0, 111.0, 116.0, 118.0, 117.0, 112.0, 117.0, 126.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.0}, {"lowerIsBetter": true, "replicates": [126.0, 150.0, 142.0, 138.0, 139.0, 137.0, 140.0, 143.0, 133.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.9}, {"lowerIsBetter": true, "replicates": [69.0, 64.0, 64.0, 66.0, 66.0, 65.0, 65.0, 67.0, 65.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.4}], "name": "kraken", "value": 1501.1000000000004}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.2800267648043], "unit": "score", "name": "Richards", "value": 211.03535600000004}, {"lowerIsBetter": false, "replicates": [170.50298380221653], "unit": "score", "name": "DeltaBlue", "value": 387.78207000000015}, {"lowerIsBetter": false, "replicates": [277.9321845469705], "unit": "score", "name": "Encrypt", "value": 957.7192379999997}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [954.1984732824427], "unit": "score", "name": "RayTrace", "value": 775.5084720000002}, {"lowerIsBetter": false, "replicates": [565.6108597285067], "unit": "score", "name": "Earley", "value": 1178.3065839999997}, {"lowerIsBetter": false, "replicates": [11133.333333333334], "unit": "score", "name": "Boyer", "value": 59.86194610778439}, {"lowerIsBetter": false, "replicates": [39076.92307692308], "unit": "score", "name": "RegExp", "value": 23.312608267716538}, {"lowerIsBetter": false, "replicates": [521.9206680584551], "unit": "score", "name": "Splay", "value": 156.13675599999996}, {"lowerIsBetter": false, "replicates": [4859.223300970873], "unit": "score", "name": "NavierStokes", "value": 305.39860139860156}], "name": "v8_7", "value": 21932.189502280125}]} 09:43:14 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "21932.19"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1501.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7436.83"}}} 09:43:14 INFO - Return code: 0 09:43:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:43:14 INFO - # TBPL SUCCESS # 09:43:14 INFO - Running post-action listener: _resource_record_post_action 09:43:14 INFO - Running post-run listener: _resource_record_post_run 09:43:15 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 430080; Write bytes: 497991680; Read time: 372; Write time: 322716 09:43:15 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 4096; Write bytes: 239239168; Read time: 156; Write time: 184780 09:43:15 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 425984; Write bytes: 258752512; Read time: 216; Write time: 137936 09:43:15 INFO - Running post-run listener: _upload_blobber_files 09:43:15 INFO - Blob upload gear active. 09:43:15 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 09:43:15 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:43:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 09:43:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 09:43:16 INFO - (blobuploader) - INFO - Open directory for files ... 09:43:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:43:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:43:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:43:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:43:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:43:16 INFO - (blobuploader) - INFO - Done attempting. 09:43:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:43:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:43:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:43:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:43:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:43:17 INFO - (blobuploader) - INFO - Done attempting. 09:43:17 INFO - (blobuploader) - INFO - Iteration through files over. 09:43:17 INFO - Return code: 0 09:43:17 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 09:43:17 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 09:43:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a88ed8a0f296ee78ba44394a34cd52afbc65a4fcc2a960b88ee397d5c845eef226cfdf4e7345afbdccec09b649ab90a310b38b25011c5f2ec1c93253c51c57b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46a9aa9844b58d3ed6d12445f60ce9685f6b0f74d28fb3226e49a417332d511cd6140589c653225b262eb5a9d062ebbb2ec18be0858d8028f74b150d08ad3b3e"} 09:43:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 09:43:17 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 09:43:17 INFO - Contents: 09:43:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a88ed8a0f296ee78ba44394a34cd52afbc65a4fcc2a960b88ee397d5c845eef226cfdf4e7345afbdccec09b649ab90a310b38b25011c5f2ec1c93253c51c57b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46a9aa9844b58d3ed6d12445f60ce9685f6b0f74d28fb3226e49a417332d511cd6140589c653225b262eb5a9d062ebbb2ec18be0858d8028f74b150d08ad3b3e"} 09:43:17 INFO - Running post-run listener: copy_logs_to_upload_dir 09:43:17 INFO - Copying logs to upload dir... 09:43:17 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 09:43:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.168568 ========= master_lag: 0.51 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-02-11 09:43:18.190140) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-11 09:43:18.193284) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488 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/a88ed8a0f296ee78ba44394a34cd52afbc65a4fcc2a960b88ee397d5c845eef226cfdf4e7345afbdccec09b649ab90a310b38b25011c5f2ec1c93253c51c57b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46a9aa9844b58d3ed6d12445f60ce9685f6b0f74d28fb3226e49a417332d511cd6140589c653225b262eb5a9d062ebbb2ec18be0858d8028f74b150d08ad3b3e"} build_url:https://queue.taskcluster.net/v1/task/QD0qQJndTUe8VGGFKSGAng/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010144 build_url: 'https://queue.taskcluster.net/v1/task/QD0qQJndTUe8VGGFKSGAng/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/a88ed8a0f296ee78ba44394a34cd52afbc65a4fcc2a960b88ee397d5c845eef226cfdf4e7345afbdccec09b649ab90a310b38b25011c5f2ec1c93253c51c57b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46a9aa9844b58d3ed6d12445f60ce9685f6b0f74d28fb3226e49a417332d511cd6140589c653225b262eb5a9d062ebbb2ec18be0858d8028f74b150d08ad3b3e"}' ========= master_lag: 0.35 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-11 09:43:18.551422) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 09:43:18.551864) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1455209850.362634-1196502488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004600 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 09:43:18.569994) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 09:43:18.570312) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 09:43:18.570663) ========= ========= Total master_lag: 1.05 =========