builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-039 starttime: 1467128217.8 results: success (0) buildid: 20160628071624 builduid: de2552f199694fed9bfc0c38817d166e revision: e774866bf8a12537e451ccc4b38ffbf0610b5d49 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 08:36:57.802375) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 08:36:57.802861) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 08:36:57.803135) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 08:36:57.817918) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 08:36:57.818219) ========= 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/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1467128217.719284-1575136195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 08:36:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.9M=0s 2016-06-28 08:36:58 (45.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.071939 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 08:36:57.904450) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 08:36:57.904773) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1467128217.719284-1575136195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018136 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 08:36:57.954537) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 08:36:57.954890) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e774866bf8a12537e451ccc4b38ffbf0610b5d49 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e774866bf8a12537e451ccc4b38ffbf0610b5d49 --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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1467128217.719284-1575136195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 08:36:58,694 truncating revision to first 12 chars 2016-06-28 08:36:58,694 Setting DEBUG logging. 2016-06-28 08:36:58,694 attempt 1/10 2016-06-28 08:36:58,694 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e774866bf8a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 08:36:59,006 unpacking tar archive at: fx-team-e774866bf8a1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.686786 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 08:36:58.655389) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 08:36:58.655720) ========= script_repo_revision: e774866bf8a12537e451ccc4b38ffbf0610b5d49 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 08:36:58.656105) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 08:36:58.656370) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 08:36:58.664588) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-28 08:36:58.664899) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1467128217.719284-1575136195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:36:59 INFO - MultiFileLogger online at 20160628 08:36:59 in /builds/slave/test 08:36:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:36:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:36:59 INFO - {'append_to_log': False, 08:36:59 INFO - 'base_work_dir': '/builds/slave/test', 08:36:59 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:36:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:36:59 INFO - 'branch': 'Fx-Team-Non-PGO', 08:36:59 INFO - 'buildbot_json_path': 'buildprops.json', 08:36:59 INFO - 'config_files': ('talos/linux_config.py',), 08:36:59 INFO - 'default_actions': ('clobber', 08:36:59 INFO - 'read-buildbot-config', 08:36:59 INFO - 'download-and-extract', 08:36:59 INFO - 'populate-webroot', 08:36:59 INFO - 'create-virtualenv', 08:36:59 INFO - 'install', 08:36:59 INFO - 'run-tests'), 08:36:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:36:59 INFO - 'download_minidump_stackwalk': True, 08:36:59 INFO - 'download_symbols': 'ondemand', 08:36:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:36:59 INFO - 'tooltool.py': '/tools/tooltool.py', 08:36:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:36:59 INFO - '/tools/misc-python/virtualenv.py')}, 08:36:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:36:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:36:59 INFO - 'installer_path': 'installer.exe', 08:36:59 INFO - 'log_level': 'info', 08:36:59 INFO - 'log_name': 'talos', 08:36:59 INFO - 'log_to_console': True, 08:36:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:36:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:36:59 INFO - 'opt_config_files': (), 08:36:59 INFO - 'pip_index': False, 08:36:59 INFO - 'sps_profile': False, 08:36:59 INFO - 'sps_profile_interval': 0, 08:36:59 INFO - 'suite': 'dromaeojs', 08:36:59 INFO - 'system_bits': '32', 08:36:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:36:59 INFO - 'title': 'talos-linux64-ix-039', 08:36:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:36:59 INFO - 'use_talos_json': True, 08:36:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:36:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:36:59 INFO - 'work_dir': 'build'} 08:36:59 INFO - ##### 08:36:59 INFO - ##### Running clobber step. 08:36:59 INFO - ##### 08:36:59 INFO - Running pre-action listener: _resource_record_pre_action 08:36:59 INFO - Running main action method: clobber 08:36:59 INFO - rmtree: /builds/slave/test/build 08:36:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:36:59 INFO - Running post-action listener: _resource_record_post_action 08:36:59 INFO - ##### 08:36:59 INFO - ##### Finished clobber step (success) 08:36:59 INFO - ##### 08:36:59 INFO - ##### 08:36:59 INFO - ##### Running read-buildbot-config step. 08:36:59 INFO - ##### 08:36:59 INFO - Running pre-action listener: _resource_record_pre_action 08:36:59 INFO - Running main action method: read_buildbot_config 08:36:59 INFO - Using buildbot properties: 08:36:59 INFO - { 08:36:59 INFO - "project": "", 08:36:59 INFO - "product": "firefox", 08:36:59 INFO - "script_repo_revision": "production", 08:36:59 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:36:59 INFO - "repository": "", 08:36:59 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:36:59 INFO - "buildid": "20160628071624", 08:36:59 INFO - "pgo_build": "False", 08:36:59 INFO - "basedir": "/builds/slave/test", 08:36:59 INFO - "buildnumber": 1893, 08:36:59 INFO - "slavename": "talos-linux64-ix-039", 08:36:59 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:36:59 INFO - "platform": "ubuntu64_hw", 08:36:59 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:36:59 INFO - "branch": "fx-team", 08:36:59 INFO - "repo_path": "integration/fx-team", 08:36:59 INFO - "revision": "e774866bf8a12537e451ccc4b38ffbf0610b5d49", 08:36:59 INFO - "stage_platform": "linux64", 08:36:59 INFO - "builduid": "de2552f199694fed9bfc0c38817d166e", 08:36:59 INFO - "slavebuilddir": "test" 08:36:59 INFO - } 08:36:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:36:59 INFO - Running post-action listener: _resource_record_post_action 08:36:59 INFO - ##### 08:36:59 INFO - ##### Finished read-buildbot-config step (success) 08:36:59 INFO - ##### 08:36:59 INFO - ##### 08:36:59 INFO - ##### Running download-and-extract step. 08:36:59 INFO - ##### 08:36:59 INFO - Running pre-action listener: _resource_record_pre_action 08:36:59 INFO - Running main action method: download_and_extract 08:36:59 INFO - mkdir: /builds/slave/test/build/tests 08:36:59 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')]} 08:36:59 INFO - https://queue.taskcluster.net/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:36:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:36:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:36:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:36:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:37:00 INFO - Downloaded 1361 bytes. 08:37:00 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:37:00 INFO - Using the following test package requirements: 08:37:00 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:37:00 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:37:00 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:37:00 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:00 INFO - u'jsshell-linux-x86_64.zip'], 08:37:00 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:37:00 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:37:00 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:37:00 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:37:00 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:37:00 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:37:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:37:00 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:00 INFO - https://queue.taskcluster.net/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:37:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:37:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:37:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:37:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:37:01 INFO - Downloaded 22700118 bytes. 08:37:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:37:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:37:03 INFO - Return code: 0 08:37:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:37: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')]} 08:37:03 INFO - https://queue.taskcluster.net/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:37:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:37:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:37:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:37:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:37:04 INFO - Downloaded 22700118 bytes. 08:37:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:37:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:37:05 INFO - Return code: 0 08:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:05 INFO - https://queue.taskcluster.net/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:37:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:37:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:37:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:37:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:37:06 INFO - Downloaded 14405245 bytes. 08:37:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:37:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:37:06 INFO - Return code: 0 08:37:06 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')]} 08:37:06 INFO - https://queue.taskcluster.net/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:37:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:37:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:37:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:37:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:37:08 INFO - Downloaded 56449095 bytes. 08:37:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:37:08 INFO - mkdir: /builds/slave/test/properties 08:37:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:37:08 INFO - Writing to file /builds/slave/test/properties/build_url 08:37:08 INFO - Contents: 08:37:08 INFO - build_url:https://queue.taskcluster.net/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:37:08 INFO - Running post-action listener: _resource_record_post_action 08:37:08 INFO - Running post-action listener: set_extra_try_arguments 08:37:08 INFO - ##### 08:37:08 INFO - ##### Finished download-and-extract step (success) 08:37:08 INFO - ##### 08:37:08 INFO - ##### 08:37:08 INFO - ##### Running populate-webroot step. 08:37:08 INFO - ##### 08:37:08 INFO - Running pre-action listener: _resource_record_pre_action 08:37:08 INFO - Running main action method: populate_webroot 08:37:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:37:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:37:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:37:08 INFO - '--tppagecycles', 08:37:08 INFO - '7'], 08:37:08 INFO - 'tests': ['tsvgm']}}, 08:37:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:37:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:37:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:37:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:37:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:37:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:37:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:08 INFO - 'talos_options': ['--disable-e10s'], 08:37:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:37:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:37:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:08 INFO - 'talos_options': ['--disable-e10s'], 08:37:08 INFO - 'tests': ['damp', 'tps']}, 08:37:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:08 INFO - 'tests': ['damp', 'tps']}, 08:37:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:37:08 INFO - 'tests': ['dromaeo_dom']}, 08:37:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:37:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:37:08 INFO - 'tests': ['basic_compositor_video']}, 08:37:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:37:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:37:08 INFO - 'tests': ['a11yr', 08:37:08 INFO - 'ts_paint', 08:37:08 INFO - 'tpaint', 08:37:08 INFO - 'sessionrestore', 08:37:08 INFO - 'sessionrestore_no_auto_restore', 08:37:08 INFO - 'tabpaint']}, 08:37:08 INFO - 'other-e10s': {'tests': ['a11yr', 08:37:08 INFO - 'ts_paint', 08:37:08 INFO - 'tpaint', 08:37:08 INFO - 'sessionrestore', 08:37:08 INFO - 'sessionrestore_no_auto_restore', 08:37:08 INFO - 'tabpaint']}, 08:37:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:37:08 INFO - 'ts_paint', 08:37:08 INFO - 'tpaint', 08:37:08 INFO - 'sessionrestore', 08:37:08 INFO - 'sessionrestore_no_auto_restore', 08:37:08 INFO - 'tabpaint']}, 08:37:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:37:08 INFO - 'ts_paint', 08:37:08 INFO - 'tpaint', 08:37:08 INFO - 'sessionrestore', 08:37:08 INFO - 'sessionrestore_no_auto_restore', 08:37:08 INFO - 'tabpaint']}, 08:37:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:37:08 INFO - 'tests': ['a11yr', 08:37:08 INFO - 'ts_paint', 08:37:08 INFO - 'tpaint', 08:37:08 INFO - 'sessionrestore', 08:37:08 INFO - 'sessionrestore_no_auto_restore', 08:37:08 INFO - 'tabpaint']}, 08:37:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:37:08 INFO - 'tests': ['a11yr', 08:37:08 INFO - 'ts_paint', 08:37:08 INFO - 'tpaint', 08:37:08 INFO - 'sessionrestore', 08:37:08 INFO - 'sessionrestore_no_auto_restore', 08:37:08 INFO - 'tabpaint']}, 08:37:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:37:08 INFO - 'tests': ['tsvgx', 08:37:08 INFO - 'tsvgr_opacity', 08:37:08 INFO - 'tart', 08:37:08 INFO - 'tscrollx', 08:37:08 INFO - 'cart']}, 08:37:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:37:08 INFO - 'tsvgr_opacity', 08:37:08 INFO - 'tart', 08:37:08 INFO - 'tscrollx', 08:37:08 INFO - 'cart']}, 08:37:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:08 INFO - 'talos_options': ['--disable-e10s'], 08:37:08 INFO - 'tests': ['tp5o']}, 08:37:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:08 INFO - 'tests': ['tp5o']}, 08:37:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:08 INFO - 'talos_options': ['--disable-e10s', 08:37:08 INFO - '--xperf_path', 08:37:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:37:08 INFO - 'tests': ['tp5n']}, 08:37:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:37:08 INFO - 'talos_options': ['--xperf_path', 08:37:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:37:08 INFO - 'tests': ['tp5n']}}, 08:37:08 INFO - 'talos.zip': {'path': '', 08:37:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:37:08 INFO - Running post-action listener: _resource_record_post_action 08:37:08 INFO - ##### 08:37:08 INFO - ##### Finished populate-webroot step (success) 08:37:08 INFO - ##### 08:37:08 INFO - ##### 08:37:08 INFO - ##### Running create-virtualenv step. 08:37:08 INFO - ##### 08:37:08 INFO - Running pre-action listener: _resource_record_pre_action 08:37:08 INFO - Running main action method: create_virtualenv 08:37:08 INFO - Creating virtualenv /builds/slave/test/build/venv 08:37:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:37:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:37:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:37:08 INFO - Using real prefix '/usr' 08:37:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:37:09 INFO - Installing distribute.............................................................................................................................................................................................done. 08:37:11 INFO - Installing pip.................done. 08:37:11 INFO - Return code: 0 08:37:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:37:11 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')]} 08:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:11 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')]} 08:37:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0xb6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe30180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e3b0>, '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 0xe2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2f740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467128217.719284-1575136195', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:37:11 INFO - Running command: ['/builds/slave/test/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/build 08:37:11 INFO - Copy/paste: /builds/slave/test/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 08:37:11 INFO - Using env: {'DISPLAY': ':0', 08:37:11 INFO - 'HOME': '/home/cltbld', 08:37:11 INFO - 'LANG': 'en_US.UTF-8', 08:37:11 INFO - 'LANGUAGE': 'en_US:en', 08:37:11 INFO - 'LOGNAME': 'cltbld', 08:37:11 INFO - 'MAIL': '/var/mail/cltbld', 08:37:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:11 INFO - 'MOZ_NO_REMOTE': '1', 08:37:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:11 INFO - 'NO_EM_RESTART': '1', 08:37:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:11 INFO - 'PWD': '/builds/slave/test', 08:37:11 INFO - 'SHELL': '/bin/bash', 08:37:11 INFO - 'SHLVL': '1', 08:37:11 INFO - 'TERM': 'linux', 08:37:11 INFO - 'TMOUT': '86400', 08:37:11 INFO - 'USER': 'cltbld', 08:37:11 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467128217.719284-1575136195', 08:37:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:11 INFO - '_': '/tools/buildbot/bin/python'} 08:37:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:11 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 08:37:11 INFO - Cleaning up... 08:37:11 INFO - Return code: 0 08:37:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:37:11 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')]} 08:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:11 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')]} 08:37:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe30180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e3b0>, '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 0xe2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2f740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467128217.719284-1575136195', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:37:11 INFO - Running command: ['/builds/slave/test/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>=3.1.1'] in /builds/slave/test/build 08:37:11 INFO - Copy/paste: /builds/slave/test/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>=3.1.1 08:37:11 INFO - Using env: {'DISPLAY': ':0', 08:37:11 INFO - 'HOME': '/home/cltbld', 08:37:11 INFO - 'LANG': 'en_US.UTF-8', 08:37:11 INFO - 'LANGUAGE': 'en_US:en', 08:37:11 INFO - 'LOGNAME': 'cltbld', 08:37:11 INFO - 'MAIL': '/var/mail/cltbld', 08:37:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:11 INFO - 'MOZ_NO_REMOTE': '1', 08:37:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:11 INFO - 'NO_EM_RESTART': '1', 08:37:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:11 INFO - 'PWD': '/builds/slave/test', 08:37:11 INFO - 'SHELL': '/bin/bash', 08:37:11 INFO - 'SHLVL': '1', 08:37:11 INFO - 'TERM': 'linux', 08:37:11 INFO - 'TMOUT': '86400', 08:37:11 INFO - 'USER': 'cltbld', 08:37:11 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467128217.719284-1575136195', 08:37:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:11 INFO - '_': '/tools/buildbot/bin/python'} 08:37:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:11 INFO - Downloading/unpacking psutil>=3.1.1 08:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:37:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:37:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:37:13 INFO - Installing collected packages: psutil 08:37:13 INFO - Running setup.py install for psutil 08:37:13 INFO - building 'psutil._psutil_linux' extension 08:37:13 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 08:37:14 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 08:37:14 INFO - building 'psutil._psutil_posix' extension 08:37:14 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 08:37:14 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 08:37:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:37:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:37:14 INFO - Successfully installed psutil 08:37:14 INFO - Cleaning up... 08:37:14 INFO - Return code: 0 08:37:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe30180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e3b0>, '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 0xe2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2f740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467128217.719284-1575136195', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:37:14 INFO - Running command: ['/builds/slave/test/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.3'] in /builds/slave/test/build 08:37:14 INFO - Copy/paste: /builds/slave/test/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.3 08:37:14 INFO - Using env: {'DISPLAY': ':0', 08:37:14 INFO - 'HOME': '/home/cltbld', 08:37:14 INFO - 'LANG': 'en_US.UTF-8', 08:37:14 INFO - 'LANGUAGE': 'en_US:en', 08:37:14 INFO - 'LOGNAME': 'cltbld', 08:37:14 INFO - 'MAIL': '/var/mail/cltbld', 08:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:14 INFO - 'MOZ_NO_REMOTE': '1', 08:37:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:14 INFO - 'NO_EM_RESTART': '1', 08:37:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:14 INFO - 'PWD': '/builds/slave/test', 08:37:14 INFO - 'SHELL': '/bin/bash', 08:37:14 INFO - 'SHLVL': '1', 08:37:14 INFO - 'TERM': 'linux', 08:37:14 INFO - 'TMOUT': '86400', 08:37:14 INFO - 'USER': 'cltbld', 08:37:14 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467128217.719284-1575136195', 08:37:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:14 INFO - '_': '/tools/buildbot/bin/python'} 08:37:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:37:14 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 08:37:14 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 08:37:14 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 08:37:14 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 08:37:14 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 08:37:14 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 08:37:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:37:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:37:16 INFO - Installing collected packages: mozsystemmonitor 08:37:16 INFO - Running setup.py install for mozsystemmonitor 08:37:16 INFO - Successfully installed mozsystemmonitor 08:37:16 INFO - Cleaning up... 08:37:16 INFO - Return code: 0 08:37:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:37:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe30180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e3b0>, '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 0xe2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2f740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467128217.719284-1575136195', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:37:16 INFO - Running command: ['/builds/slave/test/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==2.5.1'] in /builds/slave/test/build 08:37:16 INFO - Copy/paste: /builds/slave/test/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==2.5.1 08:37:16 INFO - Using env: {'DISPLAY': ':0', 08:37:16 INFO - 'HOME': '/home/cltbld', 08:37:16 INFO - 'LANG': 'en_US.UTF-8', 08:37:16 INFO - 'LANGUAGE': 'en_US:en', 08:37:16 INFO - 'LOGNAME': 'cltbld', 08:37:16 INFO - 'MAIL': '/var/mail/cltbld', 08:37:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:16 INFO - 'MOZ_NO_REMOTE': '1', 08:37:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:16 INFO - 'NO_EM_RESTART': '1', 08:37:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:16 INFO - 'PWD': '/builds/slave/test', 08:37:16 INFO - 'SHELL': '/bin/bash', 08:37:16 INFO - 'SHLVL': '1', 08:37:16 INFO - 'TERM': 'linux', 08:37:16 INFO - 'TMOUT': '86400', 08:37:16 INFO - 'USER': 'cltbld', 08:37:16 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467128217.719284-1575136195', 08:37:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:16 INFO - '_': '/tools/buildbot/bin/python'} 08:37:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:16 INFO - Downloading/unpacking jsonschema==2.5.1 08:37:16 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 08:37:16 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 08:37:16 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 08:37:16 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 08:37:16 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 08:37:16 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 08:37:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:37:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:37:18 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 08:37:18 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 08:37:18 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 08:37:18 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 08:37:18 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 08:37:18 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 08:37:18 INFO - Downloading functools32-3.2.3-2.tar.gz 08:37:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:37:19 INFO - warning: no files found matching '*.txt' 08:37:19 INFO - no previously-included directories found matching 'build' 08:37:19 INFO - no previously-included directories found matching 'dist' 08:37:19 INFO - no previously-included directories found matching '.git*' 08:37:19 INFO - Installing collected packages: jsonschema, functools32 08:37:19 INFO - Running setup.py install for functools32 08:37:19 INFO - warning: no files found matching '*.txt' 08:37:19 INFO - no previously-included directories found matching 'build' 08:37:19 INFO - no previously-included directories found matching 'dist' 08:37:19 INFO - no previously-included directories found matching '.git*' 08:37:19 INFO - Successfully installed jsonschema functools32 08:37:19 INFO - Cleaning up... 08:37:19 INFO - Return code: 0 08:37:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:37: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')]} 08:37:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37: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')]} 08:37:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0xb6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe30180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e3b0>, '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 0xe2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2f740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467128217.719284-1575136195', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:37:19 INFO - Running command: ['/builds/slave/test/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/build 08:37:19 INFO - Copy/paste: /builds/slave/test/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 08:37:19 INFO - Using env: {'DISPLAY': ':0', 08:37:19 INFO - 'HOME': '/home/cltbld', 08:37:19 INFO - 'LANG': 'en_US.UTF-8', 08:37:19 INFO - 'LANGUAGE': 'en_US:en', 08:37:19 INFO - 'LOGNAME': 'cltbld', 08:37:19 INFO - 'MAIL': '/var/mail/cltbld', 08:37:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:19 INFO - 'MOZ_NO_REMOTE': '1', 08:37:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:19 INFO - 'NO_EM_RESTART': '1', 08:37:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:19 INFO - 'PWD': '/builds/slave/test', 08:37:19 INFO - 'SHELL': '/bin/bash', 08:37:19 INFO - 'SHLVL': '1', 08:37:19 INFO - 'TERM': 'linux', 08:37:19 INFO - 'TMOUT': '86400', 08:37:19 INFO - 'USER': 'cltbld', 08:37:19 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467128217.719284-1575136195', 08:37:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:19 INFO - '_': '/tools/buildbot/bin/python'} 08:37:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:19 INFO - Downloading/unpacking blobuploader==1.2.4 08:37:19 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 08:37:19 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 08:37:19 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 08:37:19 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 08:37:19 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 08:37:19 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 08:37:21 INFO - Downloading blobuploader-1.2.4.tar.gz 08:37:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:37:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:37:21 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 08:37:21 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 08:37:21 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 08:37:21 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 08:37:21 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 08:37:21 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 08:37:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:37:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:37:21 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 08:37:21 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 08:37:21 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 08:37:21 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 08:37:21 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 08:37:21 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 08:37:22 INFO - Downloading docopt-0.6.1.tar.gz 08:37:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:37:22 INFO - Installing collected packages: blobuploader, requests, docopt 08:37:22 INFO - Running setup.py install for blobuploader 08:37:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:37:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:37:22 INFO - Running setup.py install for requests 08:37:22 INFO - Running setup.py install for docopt 08:37:22 INFO - Successfully installed blobuploader requests docopt 08:37:22 INFO - Cleaning up... 08:37:22 INFO - Return code: 0 08:37:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:37: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')]} 08:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37: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')]} 08:37:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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 0xb6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe30180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e3b0>, '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 0xe2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2f740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467128217.719284-1575136195', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:37:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 08:37:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/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 08:37:22 INFO - Using env: {'DISPLAY': ':0', 08:37:22 INFO - 'HOME': '/home/cltbld', 08:37:22 INFO - 'LANG': 'en_US.UTF-8', 08:37:22 INFO - 'LANGUAGE': 'en_US:en', 08:37:22 INFO - 'LOGNAME': 'cltbld', 08:37:22 INFO - 'MAIL': '/var/mail/cltbld', 08:37:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:22 INFO - 'MOZ_NO_REMOTE': '1', 08:37:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:22 INFO - 'NO_EM_RESTART': '1', 08:37:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:22 INFO - 'PWD': '/builds/slave/test', 08:37:22 INFO - 'SHELL': '/bin/bash', 08:37:22 INFO - 'SHLVL': '1', 08:37:22 INFO - 'TERM': 'linux', 08:37:22 INFO - 'TMOUT': '86400', 08:37:22 INFO - 'USER': 'cltbld', 08:37:22 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467128217.719284-1575136195', 08:37:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:22 INFO - '_': '/tools/buildbot/bin/python'} 08:37:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:37:22 INFO - Running setup.py (path:/tmp/pip-TmFEmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:37:23 INFO - Running setup.py (path:/tmp/pip-pkl95H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:37:23 INFO - Running setup.py (path:/tmp/pip-CNBf_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:37:23 INFO - Running setup.py (path:/tmp/pip-F3rXqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:37:23 INFO - Running setup.py (path:/tmp/pip-Wy4PNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:37:23 INFO - Running setup.py (path:/tmp/pip-EscC3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:37:23 INFO - Running setup.py (path:/tmp/pip-LSRT0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:37:23 INFO - Running setup.py (path:/tmp/pip-xxsbnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:37:23 INFO - Running setup.py (path:/tmp/pip-sP7r9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:37:23 INFO - Running setup.py (path:/tmp/pip-nLoU9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:37:23 INFO - Running setup.py (path:/tmp/pip-6iVnv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:37:23 INFO - Running setup.py (path:/tmp/pip-9ILQpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:37:23 INFO - Running setup.py (path:/tmp/pip-j9QZbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:37:23 INFO - Running setup.py (path:/tmp/pip-owj4jE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:37:23 INFO - Running setup.py (path:/tmp/pip-2xdanj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:37:24 INFO - Running setup.py (path:/tmp/pip-xJdfUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:37:24 INFO - Running setup.py (path:/tmp/pip-F6g1ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:37:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:37:24 INFO - Running setup.py install for manifestparser 08:37:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:37:24 INFO - Running setup.py install for mozcrash 08:37:24 INFO - Running setup.py install for mozdebug 08:37:24 INFO - Running setup.py install for mozdevice 08:37:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:37:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:37:24 INFO - Running setup.py install for mozfile 08:37:24 INFO - Running setup.py install for mozhttpd 08:37:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:37:24 INFO - Running setup.py install for mozinfo 08:37:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:37:24 INFO - Running setup.py install for mozInstall 08:37:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:37:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:37:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:37:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:37:24 INFO - Running setup.py install for mozleak 08:37:25 INFO - Running setup.py install for mozlog 08:37:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:37:25 INFO - Running setup.py install for moznetwork 08:37:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:37:25 INFO - Running setup.py install for mozprocess 08:37:25 INFO - Running setup.py install for mozprofile 08:37:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:37:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:37:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:37:25 INFO - Running setup.py install for mozrunner 08:37:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:37:25 INFO - Running setup.py install for mozscreenshot 08:37:25 INFO - Running setup.py install for moztest 08:37:25 INFO - Running setup.py install for mozversion 08:37:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:37:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:37:25 INFO - Cleaning up... 08:37:25 INFO - Return code: 0 08:37:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:37:25 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')]} 08:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:25 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')]} 08:37:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0xb6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe30180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e3b0>, '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 0xe2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2f740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467128217.719284-1575136195', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:37:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 08:37:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/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 08:37:25 INFO - Using env: {'DISPLAY': ':0', 08:37:25 INFO - 'HOME': '/home/cltbld', 08:37:25 INFO - 'LANG': 'en_US.UTF-8', 08:37:25 INFO - 'LANGUAGE': 'en_US:en', 08:37:25 INFO - 'LOGNAME': 'cltbld', 08:37:25 INFO - 'MAIL': '/var/mail/cltbld', 08:37:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:25 INFO - 'MOZ_NO_REMOTE': '1', 08:37:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:25 INFO - 'NO_EM_RESTART': '1', 08:37:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:25 INFO - 'PWD': '/builds/slave/test', 08:37:25 INFO - 'SHELL': '/bin/bash', 08:37:25 INFO - 'SHLVL': '1', 08:37:25 INFO - 'TERM': 'linux', 08:37:25 INFO - 'TMOUT': '86400', 08:37:25 INFO - 'USER': 'cltbld', 08:37:25 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467128217.719284-1575136195', 08:37:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:25 INFO - '_': '/tools/buildbot/bin/python'} 08:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:37:26 INFO - Running setup.py (path:/tmp/pip-z8b0Wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:37:26 INFO - Running setup.py (path:/tmp/pip-j0LyTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:37:26 INFO - Running setup.py (path:/tmp/pip-XRb02_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:37:26 INFO - Running setup.py (path:/tmp/pip-2R0ClM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:37:26 INFO - Running setup.py (path:/tmp/pip-0vI0aX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:37:26 INFO - Running setup.py (path:/tmp/pip-FmMf4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:37:26 INFO - Running setup.py (path:/tmp/pip-v8lu7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:37:26 INFO - Running setup.py (path:/tmp/pip-wSMbmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:37:26 INFO - Running setup.py (path:/tmp/pip-t5xA_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:37:26 INFO - Running setup.py (path:/tmp/pip-PUb4Jw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:37:26 INFO - Running setup.py (path:/tmp/pip-Ae8Gkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:37:26 INFO - Running setup.py (path:/tmp/pip-nO2YOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:37:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:37:27 INFO - Running setup.py (path:/tmp/pip-VzaJ91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:37:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:37:27 INFO - Running setup.py (path:/tmp/pip-RQrkTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:37:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:37:27 INFO - Running setup.py (path:/tmp/pip-aoJRlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:37:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:37:27 INFO - Running setup.py (path:/tmp/pip-lDdbaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:37:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:37:27 INFO - Running setup.py (path:/tmp/pip-3F6pyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:37:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:37:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:37:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:37:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:37:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:37:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:37:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:29 INFO - Downloading blessings-1.6.tar.gz 08:37:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:37:29 INFO - Installing collected packages: blessings 08:37:29 INFO - Running setup.py install for blessings 08:37:29 INFO - Successfully installed blessings 08:37:29 INFO - Cleaning up... 08:37:29 INFO - Return code: 0 08:37:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:37:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:37:29 INFO - Reading from file tmpfile_stdout 08:37:29 INFO - Current package versions: 08:37:29 INFO - argparse == 1.2.1 08:37:29 INFO - blessings == 1.6 08:37:29 INFO - blobuploader == 1.2.4 08:37:29 INFO - docopt == 0.6.1 08:37:29 INFO - functools32 == 3.2.3-2 08:37:29 INFO - jsonschema == 2.5.1 08:37:29 INFO - manifestparser == 1.1 08:37:29 INFO - mozInstall == 1.12 08:37:29 INFO - mozcrash == 0.17 08:37:29 INFO - mozdebug == 0.1 08:37:29 INFO - mozdevice == 0.48 08:37:29 INFO - mozfile == 1.2 08:37:29 INFO - mozhttpd == 0.7 08:37:29 INFO - mozinfo == 0.9 08:37:29 INFO - mozleak == 0.1 08:37:29 INFO - mozlog == 3.2 08:37:29 INFO - moznetwork == 0.27 08:37:29 INFO - mozprocess == 0.22 08:37:29 INFO - mozprofile == 0.28 08:37:29 INFO - mozrunner == 6.11 08:37:29 INFO - mozscreenshot == 0.1 08:37:29 INFO - mozsystemmonitor == 0.3 08:37:29 INFO - moztest == 0.7 08:37:29 INFO - mozversion == 1.4 08:37:29 INFO - psutil == 3.1.1 08:37:29 INFO - requests == 1.2.3 08:37:29 INFO - wsgiref == 0.1.2 08:37:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0xb6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe30180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e3b0>, '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 0xe2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2f740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467128217.719284-1575136195', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:37:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/talos 08:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/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 08:37:29 INFO - Using env: {'DISPLAY': ':0', 08:37:29 INFO - 'HOME': '/home/cltbld', 08:37:29 INFO - 'LANG': 'en_US.UTF-8', 08:37:29 INFO - 'LANGUAGE': 'en_US:en', 08:37:29 INFO - 'LOGNAME': 'cltbld', 08:37:29 INFO - 'MAIL': '/var/mail/cltbld', 08:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:29 INFO - 'MOZ_NO_REMOTE': '1', 08:37:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:29 INFO - 'NO_EM_RESTART': '1', 08:37:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:29 INFO - 'PWD': '/builds/slave/test', 08:37:29 INFO - 'SHELL': '/bin/bash', 08:37:29 INFO - 'SHLVL': '1', 08:37:29 INFO - 'TERM': 'linux', 08:37:29 INFO - 'TMOUT': '86400', 08:37:29 INFO - 'USER': 'cltbld', 08:37:29 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467128217.719284-1575136195', 08:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:29 INFO - '_': '/tools/buildbot/bin/python'} 08:37:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:37:30 INFO - Cleaning up... 08:37:30 INFO - Return code: 0 08:37:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:37:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:37:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0xb6f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe30180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e3b0>, '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 0xe2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2f740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467128217.719284-1575136195', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:37:30 INFO - Running command: ['/builds/slave/test/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/build 08:37:30 INFO - Copy/paste: /builds/slave/test/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 08:37:30 INFO - Using env: {'DISPLAY': ':0', 08:37:30 INFO - 'HOME': '/home/cltbld', 08:37:30 INFO - 'LANG': 'en_US.UTF-8', 08:37:30 INFO - 'LANGUAGE': 'en_US:en', 08:37:30 INFO - 'LOGNAME': 'cltbld', 08:37:30 INFO - 'MAIL': '/var/mail/cltbld', 08:37:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:30 INFO - 'MOZ_NO_REMOTE': '1', 08:37:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:30 INFO - 'NO_EM_RESTART': '1', 08:37:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:30 INFO - 'PWD': '/builds/slave/test', 08:37:30 INFO - 'SHELL': '/bin/bash', 08:37:30 INFO - 'SHLVL': '1', 08:37:30 INFO - 'TERM': 'linux', 08:37:30 INFO - 'TMOUT': '86400', 08:37:30 INFO - 'USER': 'cltbld', 08:37:30 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467128217.719284-1575136195', 08:37:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:30 INFO - '_': '/tools/buildbot/bin/python'} 08:37:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:37:30 INFO - Cleaning up... 08:37:30 INFO - Return code: 0 08:37:30 INFO - Running post-action listener: _resource_record_post_action 08:37:30 INFO - Running post-action listener: _start_resource_monitoring 08:37:30 INFO - Starting resource monitoring. 08:37:30 INFO - ##### 08:37:30 INFO - ##### Finished create-virtualenv step (success) 08:37:30 INFO - ##### 08:37:30 INFO - ##### 08:37:30 INFO - ##### Running install step. 08:37:30 INFO - ##### 08:37:30 INFO - Running pre-action listener: _resource_record_pre_action 08:37:30 INFO - Running main action method: install 08:37:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:37:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:37:30 INFO - Reading from file tmpfile_stdout 08:37:30 INFO - Detecting whether we're running mozinstall >=1.0... 08:37:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:37:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:37:30 INFO - Reading from file tmpfile_stdout 08:37:30 INFO - Output received: 08:37:30 INFO - Usage: mozinstall [options] installer 08:37:30 INFO - Options: 08:37:30 INFO - -h, --help show this help message and exit 08:37:30 INFO - -d DEST, --destination=DEST 08:37:30 INFO - Directory to install application into. [default: 08:37:30 INFO - "/builds/slave/test"] 08:37:30 INFO - --app=APP Application being installed. [default: firefox] 08:37:30 INFO - mkdir: /builds/slave/test/build/application 08:37:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:37:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:37:46 INFO - Reading from file tmpfile_stdout 08:37:46 INFO - Output received: 08:37:46 INFO - /builds/slave/test/build/application/firefox/firefox 08:37:46 INFO - Running post-action listener: _resource_record_post_action 08:37:46 INFO - ##### 08:37:46 INFO - ##### Finished install step (success) 08:37:46 INFO - ##### 08:37:46 INFO - ##### 08:37:46 INFO - ##### Running run-tests step. 08:37:46 INFO - ##### 08:37:46 INFO - Running pre-action listener: _resource_record_pre_action 08:37:46 INFO - Running main action method: run_tests 08:37:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:37:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:37:46 INFO - Python 2.7.3 08:37:46 INFO - Return code: 0 08:37:46 INFO - grabbing minidump binary from tooltool 08:37: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')]} 08:37:46 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/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2e3b0>, '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 0xe2f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe2f740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:37:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:37:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:37:46 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:37:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:37:47 INFO - Return code: 0 08:37:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:37:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:37:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:37:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:37:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:37:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:37:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:37:47 INFO - Using env: {'DISPLAY': ':0', 08:37:47 INFO - 'HOME': '/home/cltbld', 08:37:47 INFO - 'LANG': 'en_US.UTF-8', 08:37:47 INFO - 'LANGUAGE': 'en_US:en', 08:37:47 INFO - 'LOGNAME': 'cltbld', 08:37:47 INFO - 'MAIL': '/var/mail/cltbld', 08:37:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:37:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:47 INFO - 'MOZ_NO_REMOTE': '1', 08:37:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:37:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:47 INFO - 'NO_EM_RESTART': '1', 08:37:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:47 INFO - 'PWD': '/builds/slave/test', 08:37:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:37:47 INFO - 'SHELL': '/bin/bash', 08:37:47 INFO - 'SHLVL': '1', 08:37:47 INFO - 'TERM': 'linux', 08:37:47 INFO - 'TMOUT': '86400', 08:37:47 INFO - 'USER': 'cltbld', 08:37:47 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1467128217.719284-1575136195', 08:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:47 INFO - '_': '/tools/buildbot/bin/python'} 08:37:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:37:47 INFO - mozversion application_buildid: 20160628071624 08:37:47 INFO - mozversion application_changeset: e774866bf8a12537e451ccc4b38ffbf0610b5d49 08:37:47 INFO - mozversion application_display_name: Nightly 08:37:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:37:47 INFO - mozversion application_name: Firefox 08:37:47 INFO - mozversion application_remotingname: firefox 08:37:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:37:47 INFO - mozversion application_vendor: Mozilla 08:37:47 INFO - mozversion application_version: 50.0a1 08:37:47 INFO - mozversion platform_buildid: 20160628071624 08:37:47 INFO - mozversion platform_changeset: e774866bf8a12537e451ccc4b38ffbf0610b5d49 08:37:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:37:47 INFO - mozversion platform_version: 50.0a1 08:37:47 INFO - using testdate: 1467128267 08:37:47 INFO - actual date: 1467128267 08:37:47 INFO - starting webserver on 'localhost:56102' 08:37:47 INFO - SUITE-START | Running 2 tests 08:37:47 INFO - TEST-START | dromaeo_css 08:37:47 INFO - operating with platform_type : linux_ 08:37:47 INFO - Initialising browser for dromaeo_css test... 08:37:47 INFO - TEST-INFO | started process 3394 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXmnRrt/profile http://localhost:56102/getInfo.html) 08:37:51 INFO - PROCESS | 3394 | __metrics Screen width/height:1600/1200 08:37:51 INFO - PROCESS | 3394 | colorDepth:24 08:37:51 INFO - PROCESS | 3394 | Browser inner width/height: 1024/697 08:37:51 INFO - PROCESS | 3394 | __metrics 08:37:52 INFO - PROCESS | 3394 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:37:53 INFO - TEST-INFO | 3394: exit 0 08:37:53 INFO - Browser initialized. 08:37:53 INFO - Running cycle 1/1 for dromaeo_css test... 08:37:53 INFO - TEST-INFO | started process 3477 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXmnRrt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:38:05 INFO - PROCESS | 3477 | RSS: Main: 158400512 08:38:05 INFO - PROCESS | 3477 | 08:38:57 INFO - PROCESS | 3477 | 1467128337567 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] 08:41:09 INFO - PROCESS | 3477 | Cycle 1(1): loaded http://localhost:56102/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56102/tests/dromaeo/cssquery-ext.html) 08:41:10 INFO - PROCESS | 3477 | RSS: Main: 263528448 08:41:10 INFO - PROCESS | 3477 | 08:44:13 INFO - PROCESS | 3477 | Cycle 1(1): loaded http://localhost:56102/tests/dromaeo/cssquery-ext.html (next: http://localhost:56102/tests/dromaeo/cssquery-jquery.html) 08:44:13 INFO - PROCESS | 3477 | RSS: Main: 246525952 08:44:13 INFO - PROCESS | 3477 | 08:47:16 INFO - PROCESS | 3477 | Cycle 1(1): loaded http://localhost:56102/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56102/tests/dromaeo/cssquery-mootools.html) 08:47:16 INFO - PROCESS | 3477 | RSS: Main: 239153152 08:47:16 INFO - PROCESS | 3477 | 08:50:18 INFO - PROCESS | 3477 | Cycle 1(1): loaded http://localhost:56102/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56102/tests/dromaeo/cssquery-prototype.html) 08:50:19 INFO - PROCESS | 3477 | RSS: Main: 243212288 08:50:19 INFO - PROCESS | 3477 | 08:53:22 INFO - PROCESS | 3477 | Cycle 1(1): loaded http://localhost:56102/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56102/tests/dromaeo/cssquery-yui.html) 08:53:23 INFO - PROCESS | 3477 | RSS: Main: 216498176 08:53:23 INFO - PROCESS | 3477 | 08:56:26 INFO - PROCESS | 3477 | Cycle 1(1): loaded http://localhost:56102/tests/dromaeo/cssquery-yui.html (next: http://localhost:56102/tests/dromaeo/cssquery-dojo.html) 08:56:26 INFO - PROCESS | 3477 | RSS: Main: 278073344 08:56:26 INFO - PROCESS | 3477 | 08:56:26 INFO - PROCESS | 3477 | __start_tp_report 08:56:26 INFO - PROCESS | 3477 | _x_x_mozilla_page_load 08:56:26 INFO - PROCESS | 3477 | _x_x_mozilla_page_load_details 08:56:26 INFO - PROCESS | 3477 | |i|pagename|runs| 08:56:26 INFO - PROCESS | 3477 | |0;dojo.html;2604.804639652026;2608.3870290481723;2646.7750241229487;2658.162678756192;2658.8138830281864;4590.150822097914;4638.350630911671;4662.463816661085;4726.740029298391;4776.092542416943;4695.272232803913;4711.528847115287;4735.952640473594;4737.692050016746;4796.208625576775;4272.594103560157;4277.572242775728;4327.177836211125;4390.319500477431;4449.332600109993;4383.715058521186;4409.4488188976375;4422.911541769163;4430.822767089328;4450.666200035011;4222.472190976128;4252.022034931983;4259.74441533509;4324.329728891996;4362.280223763059;4309.332053531708;4312.417823593837;4381.715188512769;4448.377227188196;4451.132029254297;4357.564243575649;4362.454693163355;4371.23503386906;4415.183191109655;4415.757133357664;4641.164590373732;4712.151812673717;4786.0906427778955;4820.060088282787;4835.854924352275;5029.572486338666;5075.720835354054;5081.441041485434;5130.1535246684625;5136.152534831748;5124.103281925648;5152.58779297659;5163.122269214243;5176.120059589841;5179.792808287664;4661.487236403993;4718.787654555554;4778.904421911612;4815.133276010281;4819.036192761391;5210.609204309616;5225.477452254744;5234.450382709761;5265.6840589564745;5272.762725677277;5020.071286811952;5024.572911302507;5057.848264552069;5069.9746501267255;5071.518205770446;4889.095517329305;5018.89962200754;5050.621203409759;5148.382194136652;5158.329417175743;5067.265246539231;5073.594112470993;5094.057599344059;5098.898022039539;5110.540051395392;5049.318342023853;5049.469805670426;5049.57078648319;5055.140626093573;5103;4168.0205151789305;4216.578342165821;4278.914421711548;4286.811145510836;4319.416878721395;3722.106694393326;3747.437884317374;3759.0226541098964;3779.4708740776314;3782.0733920189728;4355.564443555682;4358;4362.083962367875;4362.672799539983;4408.647308215399;4904.411470623548;5061.645684802029;5106.617003724736;5109.029284435946;5155.742212889416;4351.43431353922;4374.343848422762;4378.058717375779;4415.315626077963;4418.116376724668;4596.655250856199;4597.241455159928;4598.908021839545;4614.031053478807;4649.139909116824;4607.101615185007;4695.694779839299;4786.497417771084;4791.281307803857;4794.544518270759;5039.722815245197;5102.642815002914;5129.79480820763;5144.562712169358;5150.201718733602;4741.075490279362;4768.928466072943;4774.41984091892;4776.8566942991765;4831.516848315281;4880.731559764247;5032.798688052437;5036.949630503648;5038.571721403721;5089.389273287229;4999.675021123615;5006.974965125151;5049.671771334852;5063.645544811828;5065.39215294167;4926;4926.039422312615;4927.531884470969;4928.457869634409;4971.726555039508;4804.399450068741;4923.483034281349;4926.704397736147;4928.408590969107;4983.825566105169;4897.436794768647;4959.504049595012;4973.154563724248;4974.825881094289;4985.626078044089;5010.949890501049;5017.37282839645;5026.246063090565;5075.949240507695;5079.44126146131;4744.478107408113;4823.807047718052;4888.780004899717;4923.335349727741;4977.153883839684 08:56:26 INFO - PROCESS | 3477 | |1;ext.html;564.6329885574378;574.4054903175212;578.9884202315957;586.2905883880503;590.8552404660859;29305.413891722153;40762.184756304894;42176.78911605437;42299;45329.7733511332;41656.58343416565;41872.790636046775;41932;41968;41975.370369444485;7461.888071678929;7652.732154374584;7849.0581130264445;7850.743880979045;7854.842903141934;7357.227491113436;7571.129320128173;7572.810679732996;9992.400455972665;10168.084872361485;10184.541695623677;10269.948650256738;10270.127039201678;10272.948635256813;10278.7430314242;10238.283320167591;10313.84529232062;10314.381137131797;10316.535755890927;10317.019883111092;7406.629668516553;9855.605775768961;10210.18318534523;10210.438425886647;10504.107150892183;38573.807130964444;38903;38915.61084389148;38973.80513097445;39023.414648780294;3089.3821235752716;3095.1952492351925;3576.409892367756;3598.3702852000797;3669.2478042001594;29541.261468463246;30100;30328;30337.848310758305;30801.537976930365;3585.928281434357;3592.2995015971896;3603;3612.873549425784;3683.594804571495;248053;248722.7563862187;249261;249560;249607;47446;47542.76228618904;47599;47778.522214777404;47815;33455;34381.312373752386;34453.655463445546;36081.27837443237;56636.43363566394;16148.192590370434;16339.673206535803;16351.83648163527;16352.345906163859;16363.427280045142;11208.719782005515;12052.698682533006;12142.514299428101;12147.420835291356;12154.817677734842;18280.725789113174;18438.539036524195;18536.165872535497;19178.232870685297;19226.519337016405;6619.966900165468;6633.535652504278;6658.768127896355;6727.192736871509;6911.89632155518;821.8315245374683;900.0864122915247;933.3233405780754;999.8900120986685;1009.707184916366;27738.861305693343;28160.155195344174;28538.714612853604;28754.281142971176;28873;962.6486332488731;969.2536746704998;990.0990099010011;1005.261133067195;1040.5837664933936;14717.705645887236;15267.618309542127;15433.254918413422;15437;15528.611784705246;374525;376279;376657;377939;378517;51406.74296628493;51645;51697.224541631906;51709.482905170466;51746;1086.9130469562574;1125.617290121379;1163.4008485630077;1195.730960533873;1201.0931746531312;27132.593011104454;29164.27089322699;29817.25456863596;30259;30371.544426833174;42782.358264625436;43055.7847210762;43264.56735432606;43315.91710207144;43320.13359732724;299565;301284;301321;301487;302277;22709.545809084055;25057.87471062633;25199.87400062988;26034.869825650752;26036.739632603432;42817;43105.353419698105;43400.348994765736;44148.55851441444;44313.11373772571;36169.63830361768;36582;37318.81340593279;37416;37443;36187;36520.81739591285;37092.81453592715;37130.257394852495;37298;35777.64222357743;35922.64077359193;36271.818640906626;37387.6261237395;38331.23337533289;31595.84202078975;33508.32983340368;33773.66226337705;33975.83012085022;34088.48867267043;25532.48935021252;25662.61506077373;25691.743082569683;25812.741872581035;26263.60604590971 08:56:26 INFO - PROCESS | 3477 | |2;jquery.html;360.7330575374222;364.7373890798625;365.36426617685225;372.50084886252415;377.89796754876187;16140.515784526468;17541.473755787316;18031.27874885006;18063;18092.276308947643;16170.19149042549;17352;17574.736378954327;17679.116044197803;17740.733888991643;5015.222640490721;5288.973555132219;5321.813736519222;5330.493603107699;5334.119870221409;3788.2802267569214;3977.7215594908366;5165.199394093921;5893.145493903381;6192.845178870519;6217.875642487147;6256.468200202989;6259.280182778994;6268.780592679257;6269.028300613412;5952.077427998645;6122.785702500391;6175.197224360849;6177.196964394645;6182.536309776762;3419.3674170278327;5055.848324550269;5377.247185394048;5389.487998640123;5401.567874570025;20448.284310049225;21194;21243.893780531154;21381.465463363384;21525.67711484329;2057.2696692674185;2058.217877206667;2232.6427771556637;2237.2505210754252;2345.8592484450987;13209.735805283937;13439.932800336033;13513.527026554024;13552.59342219735;14030;1764.550039739871;1786.240847639748;1793.0855263815417;1829.1220214297211;1839.981600184008;67645;68898.3110168897;69019.99999999949;69543;69881.65059174671;9373.765655858659;9686.903130968742;9714.12572868431;9933.850992235122;9950.552225149886;13168.802467962989;13279.800802987962;13280.070395072253;13289.534866279828;13289.80065299002;7730.458867879194;7766.766996990099;7859.135495095535;7888.092869319987;7983.560904150211;7719.421043421766;7774.92225077742;7813.726519571901;7918.168592297841;7919.406044546682;6265.71804268809;6278.937210627835;6283.497320214372;6299.6850157491945;6535;1522.4595268679682;1622.1402656592024;1668.3743596151444;1749.3205674819806;1768.522498925283;842.3850589070013;898.4160295807646;900.1853322742928;919.7792529792802;977.4282045003611;17314;18031.368902088627;19081.522961925784;19497.902510487358;19749.111289991986;887.5207388010531;889.4263200235812;903.3134817538587;929.8326301265702;966.5022513405602;10641.308314959657;10754.569817207224;10849.457527123612;10895.782084358269;10941.398223097647;305878;310959;395419;397079;400774;81074.59462702766;81322.59338703386;84370.57814710887;84546.57726711327;85935.57032214924;866.1252135343349;875.5315905990265;894.4052205283543;904.0823564082461;905.4793493740993;15877.841221588098;16357.182140893146;16375;16526;16598.83401165973;31411.37177256488;33607.83196084004;37720.62279377171;37838.62161378351;38130.809345953094;50427;52734.208986866;53736;53866.73066634642;54267.72866135802;7654.425918056279;7689.88465173034;7735.613219339123;7812.453128281193;7874.291313781787;11228.66314010581;11305.660830175108;11458.770824583295;11594.71013224676;11638.592649257575;9500.47747373901;9813;9987.700368988943;10183;10241.436720980417;10128.848067279145;10222.6422075227;10271.94864025675;10772.946135269274;10921.836172457579;9788.314817962959;9966.50167491637;10040.096391324816;10489.318194317346;10551.472426378803;7646.502977306457;7654.923450765644;7759.844803104019;7832.843343132991;7874.05511338643;9588.56851441673;9681.515924203903;9708.805823883342;9721.659741909;10288.794224115625 08:56:26 INFO - PROCESS | 3477 | |3;mootools.html;1162.3258510064163;1368.0902200036974;1385.8406283277423;1486.5688950204442;1689.8563622092122;6605.801825945224;7443.813904652387;7699.345555627764;7701.152873183953;7975.282224599785;7691.807704807383;7695.384369250447;7747.651355688993;7752.069751629812;7757.379409647228;2206.150632006677;2238.6082435573708;2239.2498512998163;2243.270936945499;2243.349428665685;2109.915603375863;2129.4250552350854;2130.9771309771318;2134.978650213501;2155.9892200538975;2163.4375062483787;2188.770179131192;2189.1681161158735;2207.6798864164684;2209.304069218199;2169.1540299283292;2170.8697478151284;2176.9020394082304;2176.9564608707815;2178.0525471419983;2063.8555301128927;2100.7269055022903;2101.338078505266;2104.2635077722675;2105.989470052655;7579.279968402993;7682.731104411375;7791.961040194763;7803.414743894231;7810;4358.215521206182;4545.818167273305;4547.681662283641;4550.067236216568;4554.817807287704;2942.6763056063814;3055.5569442430947;3102.550130231104;3115.01876908773;3128.8592013359453;988.6440881282732;1002.2483137646765;1013.9847902281398;1014.5840205515777;1016.9440680762555;10414.427206503638;10447.216458765546;10456.163506919429;10509.159267258601;10563.78872422555;3959.604039596017;3998.820053097618;4120.608542188487;4125.773082480492;4125.97937010313;8338.04112527067;8378.49729016261;8388;8388.664453421918;8389.664413423394;4350.760708161081;4357.912841743211;4360.956390436118;4362.847300344472;4368.366586844953;3570.7500474967023;3583.211693427442;4054.79726013704;4124.175164967019;4169.687273454503;3364.52896594477;3383.3909896218424;3452.7410444216785;3470.0977745786277;3561.94657080144;1017.8778546574458;1023.9283250172565;1028.1158203944601;1028.8662473878348;1036.5180191211123;740.577870613745;835.6699103853944;838.1367191792464;866.2030931542996;868.9131086891387;5123.692578445305;5208.140656791663;5216.1393370094265;5238.73806309683;5240.580753539708;389.7077192105921;394.6053946053946;398.1936578428647;400.5233771811535;402.6597525091293;3371.3425881953276;3405.7105146062368;3440.208751987057;3550.7692000019915;3555.1112221944513;8936.285097192209;9304;9417.670381536613;9425.104615061558;9699.6120155193;9493.19307858826;9581.281403894736;9588.4179110446;9608.75978100553;9641.951790241144;7140.178879428829;7176.569405835667;7359.264073592705;7377.557346559223;7385.963070184722;5419.58302493205;5475.123980163155;5540.722963851872;5634.183043458757;5691.8861622768145;8835.381523293308;8903.910960890309;8983.955080224558;9009.999999999738;9014.639414423349;8736.606852691517;8879.289656827568;8903.3322500814;8991.865122023306;9020.548972551214;6039.396060393926;6234.376562343729;6238.500919926486;6387.904181437375;6559.639219842955;7234.240404757636;7521.661525231269;7532.698692052257;7533.1336896257635;7541.057367829021;6697.866042679217;6840.828979275558;6905.482088843457;6975.546589471871;7015.894761578683;6662.500312476487;6765.188177418544;6774.898376524257;6873.175218973755;6894.24163342042;6042.123892035543;6051.818445446644;6106.72519736604;6118.785842495491;6119.755209791559;4509.706869053501;4570.954290457053;4630.976845115752;4719.787609557647;4726.8109275628585;4520.932186017279;4616.976915115403;4693.5071817458675;4704.788284527136;4765.833195838268 08:56:26 INFO - PROCESS | 3477 | |4;prototype.html;295.17204242100905;296.2563964449233;304.180234268646;307.46347623397173;307.80608216823396;4731.597814185799;4839.685420447669;4900.264960255959;4921.286413470045;4922.581580565652;4433.492612511745;4818.686785358949;4826.131296366652;4826.431409791814;4851.611871050316;3804.619538046201;3821.6751426259193;3844.884983354838;3846.326892793757;3853.537575490931;3603.69368603669;3657.0491672165163;3800.0689830991446;3807.7244123218757;3835.293294483956;3751.8614389797826;3777.3389656810086;3779.8677046303383;3787.5833658297565;3795.7342985990854;3741.906452338686;3769.2649933263024;3770.8680196193277;3778.6410291022307;3788.488554045196;3331.783434076777;3339.1819004343847;3344.11380984037;3344.180675734436;3350.5644266245477;4610.893385587468;4745.501722319142;4767.1419144553965;4769.546893045155;4779.259214821708;4306.784660766949;4314.82740690372;4326.394304797331;4338.3275592282935;4349.673774466928;4876;5050.797968081272;5075.619328550337;5095.796168153306;5098.113697931752;3578.4274516077303;3595.1551385424405;3596.352656521825;3608.855645774166;3610.530631017977;5028.698278103289;5200.075971890387;5272.945410917793;5306.442823503554;5346.198070289488;3546.2730140321173;3552.964470355315;3578.0339308386588;3664.8534058637356;3692.5015122958594;3685.6130106338983;3705.370087085202;3714.4428335749853;3718.3492888744363;3724.2923844469465;4241.512226093977;4253.191893540217;4262.85080022204;4269.402283680287;4269.950423796595;4908.361912951294;5063.696178229318;5134.204198349262;5135.666181698178;5159.065350493565;1278.6291975327051;1281.6027031620229;1290.3548225887057;1300.8634093420244;1302.9869701303055;788.503242956945;828.6519661742083;831.2352635575285;839.9580020998926;845.6236974546268;4076.2255171517318;4088.9795551022053;4112.691548133902;4126.525449573277;4149.419081328617;4699.365585645963;4707.976460117678;4751.239801631722;4803.919118198377;4818.68678535894;4012.819423125908;4050.8177132029127;4064;4068.8372465101656;4104.651104656137;2531;2609.478104379094;2791.483575538532;2836.9007084751934;2844.360018995709;4920.507949205051;4944;4944.134776414113;4955.801767929314;4958.7024778513405;5259.947400525945;5380.3274590676165;5399.433059528693;5426.728663566806;5429.4299098594865;4898.338724272249;4909.582685471775;4945.455999840015;4967.627427942919;4968.478309777422;5249.186376111708;5263.631545791758;5286.8942621148135;5289.68261904287;5309.57523398135;4938.75306234694;5137.614678899023;5154.561862241751;5200.661956972936;5227.607929405386;4719.882002949954;4862.197737373293;4951.430585482715;4972.627052971114;4976.178930476431;3707.536557930259;3708.7589306694977;3719.628037196259;3737.439384092299;3738.94391584121;5328.70692111922;5346.358436987431;5367.704776237344;5380.408155102858;5389.924878921565;4952.257161425815;5089.821856235014;5108.693478391308;5184.507471790174;5199.532042116077;5077.365329333833;5087.287779710918;5109.923351149661;5124.309737387901;5134.743262836769;5042.319286896369;5051.772670229922;5053.974730126326;5073.771680274471;5099.209622508517;5005.4744251853035;5082.644214904921;5145.845624631117;5185.533302002687;5194.870128246673;5045.571126454292;5047.646664733434;5054.368203974504;5066.771995260296;5091.312672789126 08:56:26 INFO - PROCESS | 3477 | |5;yui.html;659.1859796594042;669.4644284572341;680.7141000779675;729.0376702752366;768.0744702633326;12058.336791476466;13005.414756335977;13008.934955325234;13052.934735326322;13065.869341306585;12134.393280335991;12153.878461215385;12167.513299468033;12216.816747748791;12361.443735031922;633.7211626884156;777.8172129549552;783.9333656639193;792.4730054513741;795.4153697032676;801.0907619851481;810.3152835853724;810.3476701255487;811.8985126859143;812.4515951732557;847.9618417171242;849.1041950741965;852.0542198160038;853.4282031039188;853.8804567360575;650.4113777031794;815.1725998111921;835.0897521701314;839.2740279658083;840.5545061117617;608.6530677513819;611.9326874043852;612.5405945540845;613.009988867975;615.5844804756771;13203.141795783244;13247.735045299136;13257.801132983013;13263.403146858318;13264.938804895584;12587.93706031464;13008.154469959421;13008.284544350057;13030.218186908722;13235.536756213583;11495.770084598262;11685.298882067018;11737.823932641017;11758.353290569015;12016.399180041051;4069.1454794493193;4076.164386300801;4154.148399578079;4190.643795277405;4195.035141917376;58783.70608146932;58892.70553647204;59364.70317648384;60735.69632151855;60881.39118608802;10200.642977495752;10456.372617642966;10586.735331616772;10593.735156620993;10911;18716;18727.531811704543;18760.624787504446;18850.245990160514;18868.24527018904;6815.114035175396;6904.654767261617;6976.5814051157095;7117.145942486831;7117.857642847114;3681.171736359351;3769.076576238839;3802.0874990002753;3877.5346958365176;3886.2421827743883;2803.257136858734;2883.639545056868;2894.6815850256453;2898.116074597268;2902.2454161918054;491.8081948040267;502.9321041659329;511.4067681489529;518.390890703422;520.5289213261929;494.2882249560621;563.7913971830367;586.0710773424086;594.1770647653032;598.4793229890023;8053.798655033554;8519.275861551838;8519.957400213083;8630.309575233967;8746.075863310061;476.3069733537694;527.4488159872942;565.4458630542092;571.4456976732563;596.6539407143846;3995.948164448638;3997.7401468904427;4080.4287399764057;4112.732672376286;4121.52602450716;91054.54472727726;92741.53629231811;93500.53249733707;96716.51641741746;96904.51547742216;81769;84998;85574;85747;87014.1298587006;72201.63899180575;74197;75473;76050.61974690201;77099.22900771032;7262.419006479363;7372.741954031583;7372.889406659012;7400.962995184989;7461.888071678821;42295.7885210572;42340.576594234895;42601.573984261;43298.567014330714;44341.11317773562;58327;61162;62036.68981655063;63173.36826631859;64484.677576611815;9228.307876909124;10437.16502679799;10466.63366782159;10552.894471055499;10787.730306742395;10465.68602941913;10495.317804342998;10516.158707303244;10716.839247411139;11083;9004.684836030969;11716.179867409199;11959.103067269816;11967;12033;11694.649160525198;11955.64133076009;12268.202566833128;12465.439055242354;12499.062570307082;11787.646370608896;12043.33761643083;12084.939575302067;12466.127371083938;12683.80974285368;9875.308728388944;10128.44293563861;10177.694669159937;10280.383177009404;10387.169026478015;8679.435836670596;10018.899811001796;10123.341982771097;10225.386476811414;10243.38539687621 08:56:26 INFO - PROCESS | 3477 | __end_tp_report 08:56:26 INFO - PROCESS | 3477 | __start_cc_report 08:56:26 INFO - PROCESS | 3477 | _x_x_mozilla_cycle_collect,998 08:56:26 INFO - PROCESS | 3477 | __end_cc_report 08:56:26 INFO - PROCESS | 3477 | __startTimestamp1467129386341__endTimestamp 08:56:26 INFO - PROCESS | 3477 | 08:56:26 INFO - PROCESS | 3477 | ------- Summary: start ------- 08:56:26 INFO - PROCESS | 3477 | Number of tests: 6 08:56:26 INFO - PROCESS | 3477 | 08:56:26 INFO - PROCESS | 3477 | [#0] dojo.html Cycles:165 Average:4696.09 Median:4815.13 stddev:501.73 (10.4%) stddev-sans-first:475.70 08:56:26 INFO - PROCESS | 3477 | Values: 2604.8 2608.4 2646.8 2658.2 2658.8 4590.2 4638.4 4662.5 4726.7 4776.1 4695.3 4711.5 4736.0 4737.7 4796.2 4272.6 4277.6 4327.2 4390.3 4449.3 4383.7 4409.4 4422.9 4430.8 4450.7 4222.5 4252.0 4259.7 4324.3 4362.3 4309.3 4312.4 4381.7 4448.4 4451.1 4357.6 4362.5 4371.2 4415.2 4415.8 4641.2 4712.2 4786.1 4820.1 4835.9 5029.6 5075.7 5081.4 5130.2 5136.2 5124.1 5152.6 5163.1 5176.1 5179.8 4661.5 4718.8 4778.9 4815.1 4819.0 5210.6 5225.5 5234.5 5265.7 5272.8 5020.1 5024.6 5057.8 5070.0 5071.5 4889.1 5018.9 5050.6 5148.4 5158.3 5067.3 5073.6 5094.1 5098.9 5110.5 5049.3 5049.5 5049.6 5055.1 5103.0 4168.0 4216.6 4278.9 4286.8 4319.4 3722.1 3747.4 3759.0 3779.5 3782.1 4355.6 4358.0 4362.1 4362.7 4408.6 4904.4 5061.6 5106.6 5109.0 5155.7 4351.4 4374.3 4378.1 4415.3 4418.1 4596.7 4597.2 4598.9 4614.0 4649.1 4607.1 4695.7 4786.5 4791.3 4794.5 5039.7 5102.6 5129.8 5144.6 5150.2 4741.1 4768.9 4774.4 4776.9 4831.5 4880.7 5032.8 5036.9 5038.6 5089.4 4999.7 5007.0 5049.7 5063.6 5065.4 4926.0 4926.0 4927.5 4928.5 4971.7 4804.4 4923.5 4926.7 4928.4 4983.8 4897.4 4959.5 4973.2 4974.8 4985.6 5010.9 5017.4 5026.2 5075.9 5079.4 4744.5 4823.8 4888.8 4923.3 4977.2 08:56:26 INFO - PROCESS | 3477 | 08:56:26 INFO - PROCESS | 3477 | [#1] ext.html Cycles:180 Average:46710.61 Median:3589.11 stddev:82204.19 (2290.4%) stddev-sans-first:82361.78 08:56:26 INFO - PROCESS | 3477 | Values: 564.6 574.4 579.0 586.3 590.9 29305.4 40762.2 42176.8 42299.0 45329.8 41656.6 41872.8 41932.0 41968.0 41975.4 7461.9 7652.7 7849.1 7850.7 7854.8 7357.2 7571.1 7572.8 9992.4 10168.1 10184.5 10269.9 10270.1 10272.9 10278.7 10238.3 10313.8 10314.4 10316.5 10317.0 7406.6 9855.6 10210.2 10210.4 10504.1 38573.8 38903.0 38915.6 38973.8 39023.4 3089.4 3095.2 3576.4 3598.4 3669.2 29541.3 30100.0 30328.0 30337.8 30801.5 3585.9 3592.3 3603.0 3612.9 3683.6 248053.0 248722.8 249261.0 249560.0 249607.0 47446.0 47542.8 47599.0 47778.5 47815.0 33455.0 34381.3 34453.7 36081.3 56636.4 16148.2 16339.7 16351.8 16352.3 16363.4 11208.7 12052.7 12142.5 12147.4 12154.8 18280.7 18438.5 18536.2 19178.2 19226.5 6620.0 6633.5 6658.8 6727.2 6911.9 821.8 900.1 933.3 999.9 1009.7 27738.9 28160.2 28538.7 28754.3 28873.0 962.6 969.3 990.1 1005.3 1040.6 14717.7 15267.6 15433.3 15437.0 15528.6 374525.0 376279.0 376657.0 377939.0 378517.0 51406.7 51645.0 51697.2 51709.5 51746.0 1086.9 1125.6 1163.4 1195.7 1201.1 27132.6 29164.3 29817.3 30259.0 30371.5 42782.4 43055.8 43264.6 43315.9 43320.1 299565.0 301284.0 301321.0 301487.0 302277.0 22709.5 25057.9 25199.9 26034.9 26036.7 42817.0 43105.4 43400.3 44148.6 44313.1 36169.6 36582.0 37318.8 37416.0 37443.0 36187.0 36520.8 37092.8 37130.3 37298.0 35777.6 35922.6 36271.8 37387.6 38331.2 31595.8 33508.3 33773.7 33975.8 34088.5 25532.5 25662.6 25691.7 25812.7 26263.6 08:56:26 INFO - PROCESS | 3477 | 08:56:26 INFO - PROCESS | 3477 | [#2] jquery.html Cycles:180 Average:24092.48 Median:27741.42 stddev:60525.73 (218.2%) stddev-sans-first:60669.29 08:56:26 INFO - PROCESS | 3477 | Values: 360.7 364.7 365.4 372.5 377.9 16140.5 17541.5 18031.3 18063.0 18092.3 16170.2 17352.0 17574.7 17679.1 17740.7 5015.2 5289.0 5321.8 5330.5 5334.1 3788.3 3977.7 5165.2 5893.1 6192.8 6217.9 6256.5 6259.3 6268.8 6269.0 5952.1 6122.8 6175.2 6177.2 6182.5 3419.4 5055.8 5377.2 5389.5 5401.6 20448.3 21194.0 21243.9 21381.5 21525.7 2057.3 2058.2 2232.6 2237.3 2345.9 13209.7 13439.9 13513.5 13552.6 14030.0 1764.6 1786.2 1793.1 1829.1 1840.0 67645.0 68898.3 69020.0 69543.0 69881.7 9373.8 9686.9 9714.1 9933.9 9950.6 13168.8 13279.8 13280.1 13289.5 13289.8 7730.5 7766.8 7859.1 7888.1 7983.6 7719.4 7774.9 7813.7 7918.2 7919.4 6265.7 6278.9 6283.5 6299.7 6535.0 1522.5 1622.1 1668.4 1749.3 1768.5 842.4 898.4 900.2 919.8 977.4 17314.0 18031.4 19081.5 19497.9 19749.1 887.5 889.4 903.3 929.8 966.5 10641.3 10754.6 10849.5 10895.8 10941.4 305878.0 310959.0 395419.0 397079.0 400774.0 81074.6 81322.6 84370.6 84546.6 85935.6 866.1 875.5 894.4 904.1 905.5 15877.8 16357.2 16375.0 16526.0 16598.8 31411.4 33607.8 37720.6 37838.6 38130.8 50427.0 52734.2 53736.0 53866.7 54267.7 7654.4 7689.9 7735.6 7812.5 7874.3 11228.7 11305.7 11458.8 11594.7 11638.6 9500.5 9813.0 9987.7 10183.0 10241.4 10128.8 10222.6 10271.9 10772.9 10921.8 9788.3 9966.5 10040.1 10489.3 10551.5 7646.5 7654.9 7759.8 7832.8 7874.1 9588.6 9681.5 9708.8 9721.7 10288.8 08:56:26 INFO - PROCESS | 3477 | 08:56:26 INFO - PROCESS | 3477 | [#3] mootools.html Cycles:180 Average:5049.84 Median:4712.29 stddev:2845.75 (60.4%) stddev-sans-first:2838.73 08:56:26 INFO - PROCESS | 3477 | Values: 1162.3 1368.1 1385.8 1486.6 1689.9 6605.8 7443.8 7699.3 7701.2 7975.3 7691.8 7695.4 7747.7 7752.1 7757.4 2206.2 2238.6 2239.2 2243.3 2243.3 2109.9 2129.4 2131.0 2135.0 2156.0 2163.4 2188.8 2189.2 2207.7 2209.3 2169.2 2170.9 2176.9 2177.0 2178.1 2063.9 2100.7 2101.3 2104.3 2106.0 7579.3 7682.7 7792.0 7803.4 7810.0 4358.2 4545.8 4547.7 4550.1 4554.8 2942.7 3055.6 3102.6 3115.0 3128.9 988.6 1002.2 1014.0 1014.6 1016.9 10414.4 10447.2 10456.2 10509.2 10563.8 3959.6 3998.8 4120.6 4125.8 4126.0 8338.0 8378.5 8388.0 8388.7 8389.7 4350.8 4357.9 4361.0 4362.8 4368.4 3570.8 3583.2 4054.8 4124.2 4169.7 3364.5 3383.4 3452.7 3470.1 3561.9 1017.9 1023.9 1028.1 1028.9 1036.5 740.6 835.7 838.1 866.2 868.9 5123.7 5208.1 5216.1 5238.7 5240.6 389.7 394.6 398.2 400.5 402.7 3371.3 3405.7 3440.2 3550.8 3555.1 8936.3 9304.0 9417.7 9425.1 9699.6 9493.2 9581.3 9588.4 9608.8 9642.0 7140.2 7176.6 7359.3 7377.6 7386.0 5419.6 5475.1 5540.7 5634.2 5691.9 8835.4 8903.9 8984.0 9010.0 9014.6 8736.6 8879.3 8903.3 8991.9 9020.5 6039.4 6234.4 6238.5 6387.9 6559.6 7234.2 7521.7 7532.7 7533.1 7541.1 6697.9 6840.8 6905.5 6975.5 7015.9 6662.5 6765.2 6774.9 6873.2 6894.2 6042.1 6051.8 6106.7 6118.8 6119.8 4509.7 4571.0 4631.0 4719.8 4726.8 4520.9 4617.0 4693.5 4704.8 4765.8 08:56:26 INFO - PROCESS | 3477 | 08:56:26 INFO - PROCESS | 3477 | [#4] prototype.html Cycles:180 Average:4190.33 Median:4791.59 stddev:1231.00 (25.7%) stddev-sans-first:1199.23 08:56:26 INFO - PROCESS | 3477 | Values: 295.2 296.3 304.2 307.5 307.8 4731.6 4839.7 4900.3 4921.3 4922.6 4433.5 4818.7 4826.1 4826.4 4851.6 3804.6 3821.7 3844.9 3846.3 3853.5 3603.7 3657.0 3800.1 3807.7 3835.3 3751.9 3777.3 3779.9 3787.6 3795.7 3741.9 3769.3 3770.9 3778.6 3788.5 3331.8 3339.2 3344.1 3344.2 3350.6 4610.9 4745.5 4767.1 4769.5 4779.3 4306.8 4314.8 4326.4 4338.3 4349.7 4876.0 5050.8 5075.6 5095.8 5098.1 3578.4 3595.2 3596.4 3608.9 3610.5 5028.7 5200.1 5272.9 5306.4 5346.2 3546.3 3553.0 3578.0 3664.9 3692.5 3685.6 3705.4 3714.4 3718.3 3724.3 4241.5 4253.2 4262.9 4269.4 4270.0 4908.4 5063.7 5134.2 5135.7 5159.1 1278.6 1281.6 1290.4 1300.9 1303.0 788.5 828.7 831.2 840.0 845.6 4076.2 4089.0 4112.7 4126.5 4149.4 4699.4 4708.0 4751.2 4803.9 4818.7 4012.8 4050.8 4064.0 4068.8 4104.7 2531.0 2609.5 2791.5 2836.9 2844.4 4920.5 4944.0 4944.1 4955.8 4958.7 5259.9 5380.3 5399.4 5426.7 5429.4 4898.3 4909.6 4945.5 4967.6 4968.5 5249.2 5263.6 5286.9 5289.7 5309.6 4938.8 5137.6 5154.6 5200.7 5227.6 4719.9 4862.2 4951.4 4972.6 4976.2 3707.5 3708.8 3719.6 3737.4 3738.9 5328.7 5346.4 5367.7 5380.4 5389.9 4952.3 5089.8 5108.7 5184.5 5199.5 5077.4 5087.3 5109.9 5124.3 5134.7 5042.3 5051.8 5054.0 5073.8 5099.2 5005.5 5082.6 5145.8 5185.5 5194.9 5045.6 5047.6 5054.4 5066.8 5091.3 08:56:26 INFO - PROCESS | 3477 | 08:56:26 INFO - PROCESS | 3477 | [#5] yui.html Cycles:180 Average:17546.63 Median:22408.71 stddev:24924.81 (111.2%) stddev-sans-first:24962.48 08:56:26 INFO - PROCESS | 3477 | Values: 659.2 669.5 680.7 729.0 768.1 12058.3 13005.4 13008.9 13052.9 13065.9 12134.4 12153.9 12167.5 12216.8 12361.4 633.7 777.8 783.9 792.5 795.4 801.1 810.3 810.3 811.9 812.5 848.0 849.1 852.1 853.4 853.9 650.4 815.2 835.1 839.3 840.6 608.7 611.9 612.5 613.0 615.6 13203.1 13247.7 13257.8 13263.4 13264.9 12587.9 13008.2 13008.3 13030.2 13235.5 11495.8 11685.3 11737.8 11758.4 12016.4 4069.1 4076.2 4154.1 4190.6 4195.0 58783.7 58892.7 59364.7 60735.7 60881.4 10200.6 10456.4 10586.7 10593.7 10911.0 18716.0 18727.5 18760.6 18850.2 18868.2 6815.1 6904.7 6976.6 7117.1 7117.9 3681.2 3769.1 3802.1 3877.5 3886.2 2803.3 2883.6 2894.7 2898.1 2902.2 491.8 502.9 511.4 518.4 520.5 494.3 563.8 586.1 594.2 598.5 8053.8 8519.3 8520.0 8630.3 8746.1 476.3 527.4 565.4 571.4 596.7 3995.9 3997.7 4080.4 4112.7 4121.5 91054.5 92741.5 93500.5 96716.5 96904.5 81769.0 84998.0 85574.0 85747.0 87014.1 72201.6 74197.0 75473.0 76050.6 77099.2 7262.4 7372.7 7372.9 7401.0 7461.9 42295.8 42340.6 42601.6 43298.6 44341.1 58327.0 61162.0 62036.7 63173.4 64484.7 9228.3 10437.2 10466.6 10552.9 10787.7 10465.7 10495.3 10516.2 10716.8 11083.0 9004.7 11716.2 11959.1 11967.0 12033.0 11694.6 11955.6 12268.2 12465.4 12499.1 11787.6 12043.3 12084.9 12466.1 12683.8 9875.3 10128.4 10177.7 10280.4 10387.2 8679.4 10018.9 10123.3 10225.4 10243.4 08:56:26 INFO - PROCESS | 3477 | -------- Summary: end -------- 08:56:26 INFO - PROCESS | 3477 | 08:56:27 INFO - TEST-INFO | 3477: exit 0 08:56:27 INFO - TEST-OK | dromaeo_css | took 1119951ms 08:56:27 INFO - TEST-START | kraken 08:56:27 INFO - operating with platform_type : linux_ 08:56:27 INFO - Initialising browser for kraken test... 08:56:27 INFO - TEST-INFO | started process 3656 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDP37t9/profile http://localhost:56102/getInfo.html) 08:56:31 INFO - PROCESS | 3656 | __metrics Screen width/height:1600/1200 08:56:31 INFO - PROCESS | 3656 | colorDepth:24 08:56:31 INFO - PROCESS | 3656 | Browser inner width/height: 1024/697 08:56:31 INFO - PROCESS | 3656 | __metrics 08:56:32 INFO - PROCESS | 3656 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:56:33 INFO - TEST-INFO | 3656: exit 0 08:56:33 INFO - Browser initialized. 08:56:33 INFO - Running cycle 1/1 for kraken test... 08:56:33 INFO - TEST-INFO | started process 3737 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDP37t9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:56:45 INFO - PROCESS | 3737 | RSS: Main: 158429184 08:56:45 INFO - PROCESS | 3737 | 08:56:48 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56102/tests/kraken/driver.html?testName=audio-beat-detection) 08:56:49 INFO - PROCESS | 3737 | RSS: Main: 216350720 08:56:49 INFO - PROCESS | 3737 | 08:56:51 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56102/tests/kraken/driver.html?testName=audio-dft) 08:56:52 INFO - PROCESS | 3737 | RSS: Main: 204865536 08:56:52 INFO - PROCESS | 3737 | 08:56:55 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56102/tests/kraken/driver.html?testName=audio-fft) 08:56:56 INFO - PROCESS | 3737 | RSS: Main: 271183872 08:56:56 INFO - PROCESS | 3737 | 08:56:58 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56102/tests/kraken/driver.html?testName=audio-oscillator) 08:56:59 INFO - PROCESS | 3737 | RSS: Main: 181587968 08:56:59 INFO - PROCESS | 3737 | 08:57:01 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56102/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:57:02 INFO - PROCESS | 3737 | RSS: Main: 185352192 08:57:02 INFO - PROCESS | 3737 | 08:57:05 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56102/tests/kraken/driver.html?testName=imaging-darkroom) 08:57:05 INFO - PROCESS | 3737 | RSS: Main: 222064640 08:57:05 INFO - PROCESS | 3737 | 08:57:09 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56102/tests/kraken/driver.html?testName=imaging-desaturate) 08:57:09 INFO - PROCESS | 3737 | RSS: Main: 217477120 08:57:09 INFO - PROCESS | 3737 | 08:57:12 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56102/tests/kraken/driver.html?testName=json-parse-financial) 08:57:13 INFO - PROCESS | 3737 | RSS: Main: 219615232 08:57:13 INFO - PROCESS | 3737 | 08:57:15 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56102/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:57:15 INFO - PROCESS | 3737 | RSS: Main: 204492800 08:57:15 INFO - PROCESS | 3737 | 08:57:17 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56102/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:57:18 INFO - PROCESS | 3737 | RSS: Main: 209092608 08:57:18 INFO - PROCESS | 3737 | 08:57:20 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56102/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:57:21 INFO - PROCESS | 3737 | RSS: Main: 218382336 08:57:21 INFO - PROCESS | 3737 | 08:57:23 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56102/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:57:24 INFO - PROCESS | 3737 | RSS: Main: 221655040 08:57:24 INFO - PROCESS | 3737 | 08:57:27 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56102/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:57:28 INFO - PROCESS | 3737 | RSS: Main: 222281728 08:57:28 INFO - PROCESS | 3737 | 08:57:29 INFO - PROCESS | 3737 | Cycle 1(1): loaded http://localhost:56102/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56102/tests/kraken/driver.html?testName=ai-astar) 08:57:30 INFO - PROCESS | 3737 | RSS: Main: 265584640 08:57:30 INFO - PROCESS | 3737 | 08:57:30 INFO - PROCESS | 3737 | __start_tp_report 08:57:30 INFO - PROCESS | 3737 | _x_x_mozilla_page_load 08:57:30 INFO - PROCESS | 3737 | _x_x_mozilla_page_load_details 08:57:30 INFO - PROCESS | 3737 | |i|pagename|runs| 08:57:30 INFO - PROCESS | 3737 | |0;ai-astar;104;114;112;112;113;112;112;112;112;112 08:57:30 INFO - PROCESS | 3737 | |1;audio-beat-detection;160;132;136;192;131;132;161;130;183;129 08:57:30 INFO - PROCESS | 3737 | |2;audio-dft;162;161;162;163;163;161;161;161;162;162 08:57:30 INFO - PROCESS | 3737 | |3;audio-fft;78;76;76;126;76;77;76;76;99;75 08:57:30 INFO - PROCESS | 3737 | |4;audio-oscillator;86;85;111;86;86;86;120;85;85;124 08:57:30 INFO - PROCESS | 3737 | |5;imaging-gaussian-blur;118;119;118;117;117;117;117;117;116;117 08:57:30 INFO - PROCESS | 3737 | |6;imaging-darkroom;149;149;149;149;148;149;152;150;150;147 08:57:30 INFO - PROCESS | 3737 | |7;imaging-desaturate;95;95;96;95;95;94;94;95;95;95 08:57:30 INFO - PROCESS | 3737 | |8;json-parse-financial;64;63;62;64;63;64;63;63;65;65 08:57:30 INFO - PROCESS | 3737 | |9;json-stringify-tinderbox;65;64;64;64;65;64;66;68;65;64 08:57:30 INFO - PROCESS | 3737 | |10;stanford-crypto-aes;83;84;82;82;86;82;85;89;93;83 08:57:30 INFO - PROCESS | 3737 | |11;stanford-crypto-ccm;132;130;144;142;136;129;131;130;136;141 08:57:30 INFO - PROCESS | 3737 | |12;stanford-crypto-pbkdf2;168;170;168;171;174;168;165;165;163;164 08:57:30 INFO - PROCESS | 3737 | |13;stanford-crypto-sha256-iterative;69;66;67;75;70;65;66;69;66;65 08:57:30 INFO - PROCESS | 3737 | __end_tp_report 08:57:30 INFO - PROCESS | 3737 | __start_cc_report 08:57:30 INFO - PROCESS | 3737 | _x_x_mozilla_cycle_collect,1889 08:57:30 INFO - PROCESS | 3737 | __end_cc_report 08:57:30 INFO - PROCESS | 3737 | __startTimestamp1467129450103__endTimestamp 08:57:30 INFO - PROCESS | 3737 | 08:57:30 INFO - PROCESS | 3737 | ------- Summary: start ------- 08:57:30 INFO - PROCESS | 3737 | Number of tests: 14 08:57:30 INFO - PROCESS | 3737 | 08:57:30 INFO - PROCESS | 3737 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:2.72 (2.4%) stddev-sans-first:0.71 08:57:30 INFO - PROCESS | 3737 | Values: 104.0 114.0 112.0 112.0 113.0 112.0 112.0 112.0 112.0 112.0 08:57:30 INFO - PROCESS | 3737 | 08:57:30 INFO - PROCESS | 3737 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:148.00 stddev:23.81 (16.1%) stddev-sans-first:24.89 08:57:30 INFO - PROCESS | 3737 | Values: 160.0 132.0 136.0 192.0 131.0 132.0 161.0 130.0 183.0 129.0 08:57:30 INFO - PROCESS | 3737 | 08:57:30 INFO - PROCESS | 3737 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 08:57:30 INFO - PROCESS | 3737 | Values: 162.0 161.0 162.0 163.0 163.0 161.0 161.0 161.0 162.0 162.0 08:57:30 INFO - PROCESS | 3737 | 08:57:30 INFO - PROCESS | 3737 | [#3] audio-fft Cycles:10 Average:83.50 Median:76.00 stddev:16.57 (21.8%) stddev-sans-first:17.46 08:57:30 INFO - PROCESS | 3737 | Values: 78.0 76.0 76.0 126.0 76.0 77.0 76.0 76.0 99.0 75.0 08:57:30 INFO - PROCESS | 3737 | 08:57:30 INFO - PROCESS | 3737 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:85.50 stddev:16.14 (18.9%) stddev-sans-first:16.76 08:57:30 INFO - PROCESS | 3737 | Values: 86.0 85.0 111.0 86.0 86.0 86.0 120.0 85.0 85.0 124.0 08:57:30 INFO - PROCESS | 3737 | 08:57:30 INFO - PROCESS | 3737 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 08:57:30 INFO - PROCESS | 3737 | Values: 118.0 119.0 118.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 08:57:30 INFO - PROCESS | 3737 | 08:57:30 INFO - PROCESS | 3737 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.00 stddev:1.32 (0.9%) stddev-sans-first:1.39 08:57:30 INFO - PROCESS | 3737 | Values: 149.0 149.0 149.0 149.0 148.0 149.0 152.0 150.0 150.0 147.0 08:57:30 INFO - PROCESS | 3737 | 08:57:30 INFO - PROCESS | 3737 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 08:57:30 INFO - PROCESS | 3737 | Values: 95.0 95.0 96.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 08:57:30 INFO - PROCESS | 3737 | 08:57:30 INFO - PROCESS | 3737 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:64.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 08:57:30 INFO - PROCESS | 3737 | Values: 64.0 63.0 62.0 64.0 63.0 64.0 63.0 63.0 65.0 65.0 08:57:30 INFO - PROCESS | 3737 | 08:57:30 INFO - PROCESS | 3737 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:1.29 (2.0%) stddev-sans-first:1.36 08:57:30 INFO - PROCESS | 3737 | Values: 65.0 64.0 64.0 64.0 65.0 64.0 66.0 68.0 65.0 64.0 08:57:30 INFO - PROCESS | 3737 | 08:57:30 INFO - PROCESS | 3737 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.50 stddev:3.60 (4.3%) stddev-sans-first:3.76 08:57:30 INFO - PROCESS | 3737 | Values: 83.0 84.0 82.0 82.0 86.0 82.0 85.0 89.0 93.0 83.0 08:57:30 INFO - PROCESS | 3737 | 08:57:30 INFO - PROCESS | 3737 | [#11] stanford-crypto-ccm Cycles:10 Average:135.10 Median:136.00 stddev:5.57 (4.1%) stddev-sans-first:5.79 08:57:30 INFO - PROCESS | 3737 | Values: 132.0 130.0 144.0 142.0 136.0 129.0 131.0 130.0 136.0 141.0 08:57:30 INFO - PROCESS | 3737 | 08:57:30 INFO - PROCESS | 3737 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.60 Median:168.00 stddev:3.44 (2.0%) stddev-sans-first:3.64 08:57:30 INFO - PROCESS | 3737 | Values: 168.0 170.0 168.0 171.0 174.0 168.0 165.0 165.0 163.0 164.0 08:57:30 INFO - PROCESS | 3737 | 08:57:30 INFO - PROCESS | 3737 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:3.08 (4.5%) stddev-sans-first:3.24 08:57:30 INFO - PROCESS | 3737 | Values: 69.0 66.0 67.0 75.0 70.0 65.0 66.0 69.0 66.0 65.0 08:57:30 INFO - PROCESS | 3737 | -------- Summary: end -------- 08:57:30 INFO - PROCESS | 3737 | 08:57:31 INFO - TEST-INFO | 3737: exit 0 08:57:31 INFO - TEST-OK | kraken | took 64019ms 08:57:31 INFO - SUITE-END | took 1183s 08:57:31 INFO - Completed test suite (00:19:44) 08:57:31 INFO - javascript benchmark 08:57:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2604.804639652026, 2608.3870290481723, 2646.7750241229487, 2658.162678756192, 2658.8138830281864, 4590.150822097914, 4638.350630911671, 4662.463816661085, 4726.740029298391, 4776.092542416943, 4695.272232803913, 4711.528847115287, 4735.952640473594, 4737.692050016746, 4796.208625576775, 4272.594103560157, 4277.572242775728, 4327.177836211125, 4390.319500477431, 4449.332600109993, 4383.715058521186, 4409.4488188976375, 4422.911541769163, 4430.822767089328, 4450.666200035011, 4222.472190976128, 4252.022034931983, 4259.74441533509, 4324.329728891996, 4362.280223763059, 4309.332053531708, 4312.417823593837, 4381.715188512769, 4448.377227188196, 4451.132029254297, 4357.564243575649, 4362.454693163355, 4371.23503386906, 4415.183191109655, 4415.757133357664, 4641.164590373732, 4712.151812673717, 4786.0906427778955, 4820.060088282787, 4835.854924352275, 5029.572486338666, 5075.720835354054, 5081.441041485434, 5130.1535246684625, 5136.152534831748, 5124.103281925648, 5152.58779297659, 5163.122269214243, 5176.120059589841, 5179.792808287664, 4661.487236403993, 4718.787654555554, 4778.904421911612, 4815.133276010281, 4819.036192761391, 5210.609204309616, 5225.477452254744, 5234.450382709761, 5265.6840589564745, 5272.762725677277, 5020.071286811952, 5024.572911302507, 5057.848264552069, 5069.9746501267255, 5071.518205770446, 4889.095517329305, 5018.89962200754, 5050.621203409759, 5148.382194136652, 5158.329417175743, 5067.265246539231, 5073.594112470993, 5094.057599344059, 5098.898022039539, 5110.540051395392, 5049.318342023853, 5049.469805670426, 5049.57078648319, 5055.140626093573, 5103.0, 4168.0205151789305, 4216.578342165821, 4278.914421711548, 4286.811145510836, 4319.416878721395, 3722.106694393326, 3747.437884317374, 3759.0226541098964, 3779.4708740776314, 3782.0733920189728, 4355.564443555682, 4358.0, 4362.083962367875, 4362.672799539983, 4408.647308215399, 4904.411470623548, 5061.645684802029, 5106.617003724736, 5109.029284435946, 5155.742212889416, 4351.43431353922, 4374.343848422762, 4378.058717375779, 4415.315626077963, 4418.116376724668, 4596.655250856199, 4597.241455159928, 4598.908021839545, 4614.031053478807, 4649.139909116824, 4607.101615185007, 4695.694779839299, 4786.497417771084, 4791.281307803857, 4794.544518270759, 5039.722815245197, 5102.642815002914, 5129.79480820763, 5144.562712169358, 5150.201718733602, 4741.075490279362, 4768.928466072943, 4774.41984091892, 4776.8566942991765, 4831.516848315281, 4880.731559764247, 5032.798688052437, 5036.949630503648, 5038.571721403721, 5089.389273287229, 4999.675021123615, 5006.974965125151, 5049.671771334852, 5063.645544811828, 5065.39215294167, 4926.0, 4926.039422312615, 4927.531884470969, 4928.457869634409, 4971.726555039508, 4804.399450068741, 4923.483034281349, 4926.704397736147, 4928.408590969107, 4983.825566105169, 4897.436794768647, 4959.504049595012, 4973.154563724248, 4974.825881094289, 4985.626078044089, 5010.949890501049, 5017.37282839645, 5026.246063090565, 5075.949240507695, 5079.44126146131, 4744.478107408113, 4823.807047718052, 4888.780004899717, 4923.335349727741, 4977.153883839684], "value": 4663.49888121872, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.6329885574378, 574.4054903175212, 578.9884202315957, 586.2905883880503, 590.8552404660859, 29305.413891722153, 40762.184756304894, 42176.78911605437, 42299.0, 45329.7733511332, 41656.58343416565, 41872.790636046775, 41932.0, 41968.0, 41975.370369444485, 7461.888071678929, 7652.732154374584, 7849.0581130264445, 7850.743880979045, 7854.842903141934, 7357.227491113436, 7571.129320128173, 7572.810679732996, 9992.400455972665, 10168.084872361485, 10184.541695623677, 10269.948650256738, 10270.127039201678, 10272.948635256813, 10278.7430314242, 10238.283320167591, 10313.84529232062, 10314.381137131797, 10316.535755890927, 10317.019883111092, 7406.629668516553, 9855.605775768961, 10210.18318534523, 10210.438425886647, 10504.107150892183, 38573.807130964444, 38903.0, 38915.61084389148, 38973.80513097445, 39023.414648780294, 3089.3821235752716, 3095.1952492351925, 3576.409892367756, 3598.3702852000797, 3669.2478042001594, 29541.261468463246, 30100.0, 30328.0, 30337.848310758305, 30801.537976930365, 3585.928281434357, 3592.2995015971896, 3603.0, 3612.873549425784, 3683.594804571495, 248053.0, 248722.7563862187, 249261.0, 249560.0, 249607.0, 47446.0, 47542.76228618904, 47599.0, 47778.522214777404, 47815.0, 33455.0, 34381.312373752386, 34453.655463445546, 36081.27837443237, 56636.43363566394, 16148.192590370434, 16339.673206535803, 16351.83648163527, 16352.345906163859, 16363.427280045142, 11208.719782005515, 12052.698682533006, 12142.514299428101, 12147.420835291356, 12154.817677734842, 18280.725789113174, 18438.539036524195, 18536.165872535497, 19178.232870685297, 19226.519337016405, 6619.966900165468, 6633.535652504278, 6658.768127896355, 6727.192736871509, 6911.89632155518, 821.8315245374683, 900.0864122915247, 933.3233405780754, 999.8900120986685, 1009.707184916366, 27738.861305693343, 28160.155195344174, 28538.714612853604, 28754.281142971176, 28873.0, 962.6486332488731, 969.2536746704998, 990.0990099010011, 1005.261133067195, 1040.5837664933936, 14717.705645887236, 15267.618309542127, 15433.254918413422, 15437.0, 15528.611784705246, 374525.0, 376279.0, 376657.0, 377939.0, 378517.0, 51406.74296628493, 51645.0, 51697.224541631906, 51709.482905170466, 51746.0, 1086.9130469562574, 1125.617290121379, 1163.4008485630077, 1195.730960533873, 1201.0931746531312, 27132.593011104454, 29164.27089322699, 29817.25456863596, 30259.0, 30371.544426833174, 42782.358264625436, 43055.7847210762, 43264.56735432606, 43315.91710207144, 43320.13359732724, 299565.0, 301284.0, 301321.0, 301487.0, 302277.0, 22709.545809084055, 25057.87471062633, 25199.87400062988, 26034.869825650752, 26036.739632603432, 42817.0, 43105.353419698105, 43400.348994765736, 44148.55851441444, 44313.11373772571, 36169.63830361768, 36582.0, 37318.81340593279, 37416.0, 37443.0, 36187.0, 36520.81739591285, 37092.81453592715, 37130.257394852495, 37298.0, 35777.64222357743, 35922.64077359193, 36271.818640906626, 37387.6261237395, 38331.23337533289, 31595.84202078975, 33508.32983340368, 33773.66226337705, 33975.83012085022, 34088.48867267043, 25532.48935021252, 25662.61506077373, 25691.743082569683, 25812.741872581035, 26263.60604590971], "value": 18057.377375496537, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.7330575374222, 364.7373890798625, 365.36426617685225, 372.50084886252415, 377.89796754876187, 16140.515784526468, 17541.473755787316, 18031.27874885006, 18063.0, 18092.276308947643, 16170.19149042549, 17352.0, 17574.736378954327, 17679.116044197803, 17740.733888991643, 5015.222640490721, 5288.973555132219, 5321.813736519222, 5330.493603107699, 5334.119870221409, 3788.2802267569214, 3977.7215594908366, 5165.199394093921, 5893.145493903381, 6192.845178870519, 6217.875642487147, 6256.468200202989, 6259.280182778994, 6268.780592679257, 6269.028300613412, 5952.077427998645, 6122.785702500391, 6175.197224360849, 6177.196964394645, 6182.536309776762, 3419.3674170278327, 5055.848324550269, 5377.247185394048, 5389.487998640123, 5401.567874570025, 20448.284310049225, 21194.0, 21243.893780531154, 21381.465463363384, 21525.67711484329, 2057.2696692674185, 2058.217877206667, 2232.6427771556637, 2237.2505210754252, 2345.8592484450987, 13209.735805283937, 13439.932800336033, 13513.527026554024, 13552.59342219735, 14030.0, 1764.550039739871, 1786.240847639748, 1793.0855263815417, 1829.1220214297211, 1839.981600184008, 67645.0, 68898.3110168897, 69019.99999999949, 69543.0, 69881.65059174671, 9373.765655858659, 9686.903130968742, 9714.12572868431, 9933.850992235122, 9950.552225149886, 13168.802467962989, 13279.800802987962, 13280.070395072253, 13289.534866279828, 13289.80065299002, 7730.458867879194, 7766.766996990099, 7859.135495095535, 7888.092869319987, 7983.560904150211, 7719.421043421766, 7774.92225077742, 7813.726519571901, 7918.168592297841, 7919.406044546682, 6265.71804268809, 6278.937210627835, 6283.497320214372, 6299.6850157491945, 6535.0, 1522.4595268679682, 1622.1402656592024, 1668.3743596151444, 1749.3205674819806, 1768.522498925283, 842.3850589070013, 898.4160295807646, 900.1853322742928, 919.7792529792802, 977.4282045003611, 17314.0, 18031.368902088627, 19081.522961925784, 19497.902510487358, 19749.111289991986, 887.5207388010531, 889.4263200235812, 903.3134817538587, 929.8326301265702, 966.5022513405602, 10641.308314959657, 10754.569817207224, 10849.457527123612, 10895.782084358269, 10941.398223097647, 305878.0, 310959.0, 395419.0, 397079.0, 400774.0, 81074.59462702766, 81322.59338703386, 84370.57814710887, 84546.57726711327, 85935.57032214924, 866.1252135343349, 875.5315905990265, 894.4052205283543, 904.0823564082461, 905.4793493740993, 15877.841221588098, 16357.182140893146, 16375.0, 16526.0, 16598.83401165973, 31411.37177256488, 33607.83196084004, 37720.62279377171, 37838.62161378351, 38130.809345953094, 50427.0, 52734.208986866, 53736.0, 53866.73066634642, 54267.72866135802, 7654.425918056279, 7689.88465173034, 7735.613219339123, 7812.453128281193, 7874.291313781787, 11228.66314010581, 11305.660830175108, 11458.770824583295, 11594.71013224676, 11638.592649257575, 9500.47747373901, 9813.0, 9987.700368988943, 10183.0, 10241.436720980417, 10128.848067279145, 10222.6422075227, 10271.94864025675, 10772.946135269274, 10921.836172457579, 9788.314817962959, 9966.50167491637, 10040.096391324816, 10489.318194317346, 10551.472426378803, 7646.502977306457, 7654.923450765644, 7759.844803104019, 7832.843343132991, 7874.05511338643, 9588.56851441673, 9681.515924203903, 9708.805823883342, 9721.659741909, 10288.794224115625], "value": 8555.873778899057, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1162.3258510064163, 1368.0902200036974, 1385.8406283277423, 1486.5688950204442, 1689.8563622092122, 6605.801825945224, 7443.813904652387, 7699.345555627764, 7701.152873183953, 7975.282224599785, 7691.807704807383, 7695.384369250447, 7747.651355688993, 7752.069751629812, 7757.379409647228, 2206.150632006677, 2238.6082435573708, 2239.2498512998163, 2243.270936945499, 2243.349428665685, 2109.915603375863, 2129.4250552350854, 2130.9771309771318, 2134.978650213501, 2155.9892200538975, 2163.4375062483787, 2188.770179131192, 2189.1681161158735, 2207.6798864164684, 2209.304069218199, 2169.1540299283292, 2170.8697478151284, 2176.9020394082304, 2176.9564608707815, 2178.0525471419983, 2063.8555301128927, 2100.7269055022903, 2101.338078505266, 2104.2635077722675, 2105.989470052655, 7579.279968402993, 7682.731104411375, 7791.961040194763, 7803.414743894231, 7810.0, 4358.215521206182, 4545.818167273305, 4547.681662283641, 4550.067236216568, 4554.817807287704, 2942.6763056063814, 3055.5569442430947, 3102.550130231104, 3115.01876908773, 3128.8592013359453, 988.6440881282732, 1002.2483137646765, 1013.9847902281398, 1014.5840205515777, 1016.9440680762555, 10414.427206503638, 10447.216458765546, 10456.163506919429, 10509.159267258601, 10563.78872422555, 3959.604039596017, 3998.820053097618, 4120.608542188487, 4125.773082480492, 4125.97937010313, 8338.04112527067, 8378.49729016261, 8388.0, 8388.664453421918, 8389.664413423394, 4350.760708161081, 4357.912841743211, 4360.956390436118, 4362.847300344472, 4368.366586844953, 3570.7500474967023, 3583.211693427442, 4054.79726013704, 4124.175164967019, 4169.687273454503, 3364.52896594477, 3383.3909896218424, 3452.7410444216785, 3470.0977745786277, 3561.94657080144, 1017.8778546574458, 1023.9283250172565, 1028.1158203944601, 1028.8662473878348, 1036.5180191211123, 740.577870613745, 835.6699103853944, 838.1367191792464, 866.2030931542996, 868.9131086891387, 5123.692578445305, 5208.140656791663, 5216.1393370094265, 5238.73806309683, 5240.580753539708, 389.7077192105921, 394.6053946053946, 398.1936578428647, 400.5233771811535, 402.6597525091293, 3371.3425881953276, 3405.7105146062368, 3440.208751987057, 3550.7692000019915, 3555.1112221944513, 8936.285097192209, 9304.0, 9417.670381536613, 9425.104615061558, 9699.6120155193, 9493.19307858826, 9581.281403894736, 9588.4179110446, 9608.75978100553, 9641.951790241144, 7140.178879428829, 7176.569405835667, 7359.264073592705, 7377.557346559223, 7385.963070184722, 5419.58302493205, 5475.123980163155, 5540.722963851872, 5634.183043458757, 5691.8861622768145, 8835.381523293308, 8903.910960890309, 8983.955080224558, 9009.999999999738, 9014.639414423349, 8736.606852691517, 8879.289656827568, 8903.3322500814, 8991.865122023306, 9020.548972551214, 6039.396060393926, 6234.376562343729, 6238.500919926486, 6387.904181437375, 6559.639219842955, 7234.240404757636, 7521.661525231269, 7532.698692052257, 7533.1336896257635, 7541.057367829021, 6697.866042679217, 6840.828979275558, 6905.482088843457, 6975.546589471871, 7015.894761578683, 6662.500312476487, 6765.188177418544, 6774.898376524257, 6873.175218973755, 6894.24163342042, 6042.123892035543, 6051.818445446644, 6106.72519736604, 6118.785842495491, 6119.755209791559, 4509.706869053501, 4570.954290457053, 4630.976845115752, 4719.787609557647, 4726.8109275628585, 4520.932186017279, 4616.976915115403, 4693.5071817458675, 4704.788284527136, 4765.833195838268], "value": 3994.990092586205, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.17204242100905, 296.2563964449233, 304.180234268646, 307.46347623397173, 307.80608216823396, 4731.597814185799, 4839.685420447669, 4900.264960255959, 4921.286413470045, 4922.581580565652, 4433.492612511745, 4818.686785358949, 4826.131296366652, 4826.431409791814, 4851.611871050316, 3804.619538046201, 3821.6751426259193, 3844.884983354838, 3846.326892793757, 3853.537575490931, 3603.69368603669, 3657.0491672165163, 3800.0689830991446, 3807.7244123218757, 3835.293294483956, 3751.8614389797826, 3777.3389656810086, 3779.8677046303383, 3787.5833658297565, 3795.7342985990854, 3741.906452338686, 3769.2649933263024, 3770.8680196193277, 3778.6410291022307, 3788.488554045196, 3331.783434076777, 3339.1819004343847, 3344.11380984037, 3344.180675734436, 3350.5644266245477, 4610.893385587468, 4745.501722319142, 4767.1419144553965, 4769.546893045155, 4779.259214821708, 4306.784660766949, 4314.82740690372, 4326.394304797331, 4338.3275592282935, 4349.673774466928, 4876.0, 5050.797968081272, 5075.619328550337, 5095.796168153306, 5098.113697931752, 3578.4274516077303, 3595.1551385424405, 3596.352656521825, 3608.855645774166, 3610.530631017977, 5028.698278103289, 5200.075971890387, 5272.945410917793, 5306.442823503554, 5346.198070289488, 3546.2730140321173, 3552.964470355315, 3578.0339308386588, 3664.8534058637356, 3692.5015122958594, 3685.6130106338983, 3705.370087085202, 3714.4428335749853, 3718.3492888744363, 3724.2923844469465, 4241.512226093977, 4253.191893540217, 4262.85080022204, 4269.402283680287, 4269.950423796595, 4908.361912951294, 5063.696178229318, 5134.204198349262, 5135.666181698178, 5159.065350493565, 1278.6291975327051, 1281.6027031620229, 1290.3548225887057, 1300.8634093420244, 1302.9869701303055, 788.503242956945, 828.6519661742083, 831.2352635575285, 839.9580020998926, 845.6236974546268, 4076.2255171517318, 4088.9795551022053, 4112.691548133902, 4126.525449573277, 4149.419081328617, 4699.365585645963, 4707.976460117678, 4751.239801631722, 4803.919118198377, 4818.68678535894, 4012.819423125908, 4050.8177132029127, 4064.0, 4068.8372465101656, 4104.651104656137, 2531.0, 2609.478104379094, 2791.483575538532, 2836.9007084751934, 2844.360018995709, 4920.507949205051, 4944.0, 4944.134776414113, 4955.801767929314, 4958.7024778513405, 5259.947400525945, 5380.3274590676165, 5399.433059528693, 5426.728663566806, 5429.4299098594865, 4898.338724272249, 4909.582685471775, 4945.455999840015, 4967.627427942919, 4968.478309777422, 5249.186376111708, 5263.631545791758, 5286.8942621148135, 5289.68261904287, 5309.57523398135, 4938.75306234694, 5137.614678899023, 5154.561862241751, 5200.661956972936, 5227.607929405386, 4719.882002949954, 4862.197737373293, 4951.430585482715, 4972.627052971114, 4976.178930476431, 3707.536557930259, 3708.7589306694977, 3719.628037196259, 3737.439384092299, 3738.94391584121, 5328.70692111922, 5346.358436987431, 5367.704776237344, 5380.408155102858, 5389.924878921565, 4952.257161425815, 5089.821856235014, 5108.693478391308, 5184.507471790174, 5199.532042116077, 5077.365329333833, 5087.287779710918, 5109.923351149661, 5124.309737387901, 5134.743262836769, 5042.319286896369, 5051.772670229922, 5053.974730126326, 5073.771680274471, 5099.209622508517, 5005.4744251853035, 5082.644214904921, 5145.845624631117, 5185.533302002687, 5194.870128246673, 5045.571126454292, 5047.646664733434, 5054.368203974504, 5066.771995260296, 5091.312672789126], "value": 3799.180252918911, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.1859796594042, 669.4644284572341, 680.7141000779675, 729.0376702752366, 768.0744702633326, 12058.336791476466, 13005.414756335977, 13008.934955325234, 13052.934735326322, 13065.869341306585, 12134.393280335991, 12153.878461215385, 12167.513299468033, 12216.816747748791, 12361.443735031922, 633.7211626884156, 777.8172129549552, 783.9333656639193, 792.4730054513741, 795.4153697032676, 801.0907619851481, 810.3152835853724, 810.3476701255487, 811.8985126859143, 812.4515951732557, 847.9618417171242, 849.1041950741965, 852.0542198160038, 853.4282031039188, 853.8804567360575, 650.4113777031794, 815.1725998111921, 835.0897521701314, 839.2740279658083, 840.5545061117617, 608.6530677513819, 611.9326874043852, 612.5405945540845, 613.009988867975, 615.5844804756771, 13203.141795783244, 13247.735045299136, 13257.801132983013, 13263.403146858318, 13264.938804895584, 12587.93706031464, 13008.154469959421, 13008.284544350057, 13030.218186908722, 13235.536756213583, 11495.770084598262, 11685.298882067018, 11737.823932641017, 11758.353290569015, 12016.399180041051, 4069.1454794493193, 4076.164386300801, 4154.148399578079, 4190.643795277405, 4195.035141917376, 58783.70608146932, 58892.70553647204, 59364.70317648384, 60735.69632151855, 60881.39118608802, 10200.642977495752, 10456.372617642966, 10586.735331616772, 10593.735156620993, 10911.0, 18716.0, 18727.531811704543, 18760.624787504446, 18850.245990160514, 18868.24527018904, 6815.114035175396, 6904.654767261617, 6976.5814051157095, 7117.145942486831, 7117.857642847114, 3681.171736359351, 3769.076576238839, 3802.0874990002753, 3877.5346958365176, 3886.2421827743883, 2803.257136858734, 2883.639545056868, 2894.6815850256453, 2898.116074597268, 2902.2454161918054, 491.8081948040267, 502.9321041659329, 511.4067681489529, 518.390890703422, 520.5289213261929, 494.2882249560621, 563.7913971830367, 586.0710773424086, 594.1770647653032, 598.4793229890023, 8053.798655033554, 8519.275861551838, 8519.957400213083, 8630.309575233967, 8746.075863310061, 476.3069733537694, 527.4488159872942, 565.4458630542092, 571.4456976732563, 596.6539407143846, 3995.948164448638, 3997.7401468904427, 4080.4287399764057, 4112.732672376286, 4121.52602450716, 91054.54472727726, 92741.53629231811, 93500.53249733707, 96716.51641741746, 96904.51547742216, 81769.0, 84998.0, 85574.0, 85747.0, 87014.1298587006, 72201.63899180575, 74197.0, 75473.0, 76050.61974690201, 77099.22900771032, 7262.419006479363, 7372.741954031583, 7372.889406659012, 7400.962995184989, 7461.888071678821, 42295.7885210572, 42340.576594234895, 42601.573984261, 43298.567014330714, 44341.11317773562, 58327.0, 61162.0, 62036.68981655063, 63173.36826631859, 64484.677576611815, 9228.307876909124, 10437.16502679799, 10466.63366782159, 10552.894471055499, 10787.730306742395, 10465.68602941913, 10495.317804342998, 10516.158707303244, 10716.839247411139, 11083.0, 9004.684836030969, 11716.179867409199, 11959.103067269816, 11967.0, 12033.0, 11694.649160525198, 11955.64133076009, 12268.202566833128, 12465.439055242354, 12499.062570307082, 11787.646370608896, 12043.33761643083, 12084.939575302067, 12466.127371083938, 12683.80974285368, 9875.308728388944, 10128.44293563861, 10177.694669159937, 10280.383177009404, 10387.169026478015, 8679.435836670596, 10018.899811001796, 10123.341982771097, 10225.386476811414, 10243.38539687621], "value": 6558.250240352038, "unit": "score"}], "name": "dromaeo_css", "value": 6445.8407221333, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 112.0, 112.0, 113.0, 112.0, 112.0, 112.0, 112.0, 112.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 132.0, 136.0, 192.0, 131.0, 132.0, 161.0, 130.0, 183.0, 129.0], "value": 148.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 163.0, 163.0, 161.0, 161.0, 161.0, 162.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 126.0, 76.0, 77.0, 76.0, 76.0, 99.0, 75.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 111.0, 86.0, 86.0, 86.0, 120.0, 85.0, 85.0, 124.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 149.0, 148.0, 149.0, 152.0, 150.0, 150.0, 147.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 64.0, 63.0, 64.0, 63.0, 63.0, 65.0, 65.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 65.0, 64.0, 66.0, 68.0, 65.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 82.0, 82.0, 86.0, 82.0, 85.0, 89.0, 93.0, 83.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 130.0, 144.0, 142.0, 136.0, 129.0, 131.0, 130.0, 136.0, 141.0], "value": 135.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 170.0, 168.0, 171.0, 174.0, 168.0, 165.0, 165.0, 163.0, 164.0], "value": 167.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 67.0, 75.0, 70.0, 65.0, 66.0, 69.0, 66.0, 65.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1546.1, "alertThreshold": 2.0}]} 08:57:31 INFO - Return code: 0 08:57:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:57:31 INFO - # TBPL SUCCESS # 08:57:31 INFO - Running post-action listener: _resource_record_post_action 08:57:31 INFO - ##### 08:57:31 INFO - ##### Finished run-tests step (success) 08:57:31 INFO - ##### 08:57:31 INFO - Running post-run listener: _resource_record_post_run 08:57:31 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 541962240; Read time: 28; Write time: 666696 08:57:31 INFO - TinderboxPrint: CPU usage
13.2% 08:57:31 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 28 08:57:31 INFO - TinderboxPrint: I/O write bytes / time
541,962,240 / 666,696 08:57:31 INFO - TinderboxPrint: CPU idle
8,316.0 (86.8%) 08:57:31 INFO - TinderboxPrint: CPU user
1,216.1 (12.7%) 08:57:31 INFO - TinderboxPrint: Swap in / out
0 / 0 08:57:31 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 253636608; Read time: 0; Write time: 323208 08:57:31 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287711232; Read time: 12; Write time: 343488 08:57:32 INFO - Running post-run listener: _upload_blobber_files 08:57:32 INFO - Blob upload gear active. 08:57:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:57:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:57:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:57:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:57:32 INFO - (blobuploader) - INFO - Open directory for files ... 08:57:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:57:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:57:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:57:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:57:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:57:36 INFO - (blobuploader) - INFO - Done attempting. 08:57:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:57:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:57:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:57:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:57:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:57:36 INFO - (blobuploader) - INFO - Done attempting. 08:57:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:57:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:57:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:57:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:57:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:57:37 INFO - (blobuploader) - INFO - Done attempting. 08:57:37 INFO - (blobuploader) - INFO - Iteration through files over. 08:57:37 INFO - Return code: 0 08:57:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:57:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:57:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1c99275ba58f0687e8256aa389b121be6035ba6c544fe4b2ce47f89201427340a3f012b84e5be538a2f93232a1258d04718c257579ccf521d86c90c17a51111", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65f50c45aa811c1509e7a6424d5bb5d3de9b404dbcc09cd6b2d7649b04fffa4e78f21e6455ec10c7e86275e5ada2425a9a041764434404a07481c17c29430739", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4e560a6742eaef9a0c59bfefa5ca4f2d439e9be6e7b2e212c2b40355730bb6af0f9d04dc39064cc668d1f59e0af55095885174191e8fb7cde90b3dc8211a178b"} 08:57:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:57:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:57:37 INFO - Contents: 08:57:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1c99275ba58f0687e8256aa389b121be6035ba6c544fe4b2ce47f89201427340a3f012b84e5be538a2f93232a1258d04718c257579ccf521d86c90c17a51111", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65f50c45aa811c1509e7a6424d5bb5d3de9b404dbcc09cd6b2d7649b04fffa4e78f21e6455ec10c7e86275e5ada2425a9a041764434404a07481c17c29430739", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4e560a6742eaef9a0c59bfefa5ca4f2d439e9be6e7b2e212c2b40355730bb6af0f9d04dc39064cc668d1f59e0af55095885174191e8fb7cde90b3dc8211a178b"} 08:57:37 INFO - Running post-run listener: copy_logs_to_upload_dir 08:57:37 INFO - Copying logs to upload dir... 08:57:37 INFO - mkdir: /builds/slave/test/build/upload/logs 08:57:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.365359 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-28 08:57:37.042339) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 08:57:37.045927) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/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/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1467128217.719284-1575136195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1c99275ba58f0687e8256aa389b121be6035ba6c544fe4b2ce47f89201427340a3f012b84e5be538a2f93232a1258d04718c257579ccf521d86c90c17a51111", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65f50c45aa811c1509e7a6424d5bb5d3de9b404dbcc09cd6b2d7649b04fffa4e78f21e6455ec10c7e86275e5ada2425a9a041764434404a07481c17c29430739", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4e560a6742eaef9a0c59bfefa5ca4f2d439e9be6e7b2e212c2b40355730bb6af0f9d04dc39064cc668d1f59e0af55095885174191e8fb7cde90b3dc8211a178b"} build_url:https://queue.taskcluster.net/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011317 build_url: 'https://queue.taskcluster.net/v1/task/dHnfeABETPiQ7J0Ivj4TGQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1c99275ba58f0687e8256aa389b121be6035ba6c544fe4b2ce47f89201427340a3f012b84e5be538a2f93232a1258d04718c257579ccf521d86c90c17a51111", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65f50c45aa811c1509e7a6424d5bb5d3de9b404dbcc09cd6b2d7649b04fffa4e78f21e6455ec10c7e86275e5ada2425a9a041764434404a07481c17c29430739", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4e560a6742eaef9a0c59bfefa5ca4f2d439e9be6e7b2e212c2b40355730bb6af0f9d04dc39064cc668d1f59e0af55095885174191e8fb7cde90b3dc8211a178b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 08:57:37.071479) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 08:57:37.071842) ========= rm -f oauth.txt in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1467128217.719284-1575136195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 08:57:37.157815) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 08:57:37.158137) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 08:57:37.158419) ========= ========= Total master_lag: 0.17 =========