builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-021 starttime: 1467561060.52 results: success (0) buildid: 20160703080822 builduid: 9b5d3847fcf74129a2483514142509f1 revision: 99bab2d812fc9619c122fcdd84c6f085ced8c1e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-03 08:51:00.516916) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-03 08:51:00.517465) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-03 08:51:00.517800) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-03 08:51:00.532382) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 08:51:00.532657) ========= 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=df17445c3590ff7897617a0e00000225-1467551213.188260-173911275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-03 08:51:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 81.2M=0s 2016-07-03 08:51:01 (81.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123359 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 08:51:00.670290) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 08:51:00.670627) ========= 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=df17445c3590ff7897617a0e00000225-1467551213.188260-173911275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022371 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 08:51:00.720037) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 08:51:00.720344) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 99bab2d812fc9619c122fcdd84c6f085ced8c1e8 --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 99bab2d812fc9619c122fcdd84c6f085ced8c1e8 --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=df17445c3590ff7897617a0e00000225-1467551213.188260-173911275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-03 08:51:01,414 truncating revision to first 12 chars 2016-07-03 08:51:01,414 Setting DEBUG logging. 2016-07-03 08:51:01,414 attempt 1/10 2016-07-03 08:51:01,414 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/99bab2d812fc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-03 08:51:01,900 unpacking tar archive at: fx-team-99bab2d812fc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.830546 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 08:51:01.566339) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-03 08:51:01.566646) ========= script_repo_revision: 99bab2d812fc9619c122fcdd84c6f085ced8c1e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-03 08:51:01.567050) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-03 08:51:01.567315) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-03 08:51:01.674425) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-03 08:51:01.674721) ========= /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=df17445c3590ff7897617a0e00000225-1467551213.188260-173911275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:51:02 INFO - MultiFileLogger online at 20160703 08:51:02 in /builds/slave/test 08:51:02 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:51:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:51:02 INFO - {'append_to_log': False, 08:51:02 INFO - 'base_work_dir': '/builds/slave/test', 08:51:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:51:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:51:02 INFO - 'branch': 'Fx-Team-Non-PGO', 08:51:02 INFO - 'buildbot_json_path': 'buildprops.json', 08:51:02 INFO - 'config_files': ('talos/linux_config.py',), 08:51:02 INFO - 'default_actions': ('clobber', 08:51:02 INFO - 'read-buildbot-config', 08:51:02 INFO - 'download-and-extract', 08:51:02 INFO - 'populate-webroot', 08:51:02 INFO - 'create-virtualenv', 08:51:02 INFO - 'install', 08:51:02 INFO - 'run-tests'), 08:51:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:51:02 INFO - 'download_minidump_stackwalk': True, 08:51:02 INFO - 'download_symbols': 'ondemand', 08:51:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:51:02 INFO - 'tooltool.py': '/tools/tooltool.py', 08:51:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:51:02 INFO - '/tools/misc-python/virtualenv.py')}, 08:51:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:51:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:51:02 INFO - 'installer_path': 'installer.exe', 08:51:02 INFO - 'log_level': 'info', 08:51:02 INFO - 'log_name': 'talos', 08:51:02 INFO - 'log_to_console': True, 08:51:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:51:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:51:02 INFO - 'opt_config_files': (), 08:51:02 INFO - 'pip_index': False, 08:51:02 INFO - 'sps_profile': False, 08:51:02 INFO - 'sps_profile_interval': 0, 08:51:02 INFO - 'suite': 'dromaeojs', 08:51:02 INFO - 'system_bits': '32', 08:51:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:51:02 INFO - 'title': 'talos-linux64-ix-021', 08:51:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:51:02 INFO - 'use_talos_json': True, 08:51:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:51:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:51:02 INFO - 'work_dir': 'build'} 08:51:02 INFO - ##### 08:51:02 INFO - ##### Running clobber step. 08:51:02 INFO - ##### 08:51:02 INFO - Running pre-action listener: _resource_record_pre_action 08:51:02 INFO - Running main action method: clobber 08:51:02 INFO - rmtree: /builds/slave/test/build 08:51:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:51:02 INFO - Running post-action listener: _resource_record_post_action 08:51:02 INFO - ##### 08:51:02 INFO - ##### Finished clobber step (success) 08:51:02 INFO - ##### 08:51:02 INFO - ##### 08:51:02 INFO - ##### Running read-buildbot-config step. 08:51:02 INFO - ##### 08:51:02 INFO - Running pre-action listener: _resource_record_pre_action 08:51:02 INFO - Running main action method: read_buildbot_config 08:51:02 INFO - Using buildbot properties: 08:51:02 INFO - { 08:51:02 INFO - "project": "", 08:51:02 INFO - "product": "firefox", 08:51:02 INFO - "script_repo_revision": "production", 08:51:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:51:02 INFO - "repository": "", 08:51:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:51:02 INFO - "buildid": "20160703080822", 08:51:02 INFO - "pgo_build": "False", 08:51:02 INFO - "basedir": "/builds/slave/test", 08:51:02 INFO - "buildnumber": 1926, 08:51:02 INFO - "slavename": "talos-linux64-ix-021", 08:51:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:51:02 INFO - "platform": "ubuntu64_hw", 08:51:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:51:02 INFO - "branch": "fx-team", 08:51:02 INFO - "repo_path": "integration/fx-team", 08:51:02 INFO - "revision": "99bab2d812fc9619c122fcdd84c6f085ced8c1e8", 08:51:02 INFO - "stage_platform": "linux64", 08:51:02 INFO - "builduid": "9b5d3847fcf74129a2483514142509f1", 08:51:02 INFO - "slavebuilddir": "test" 08:51:02 INFO - } 08:51:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/RDuPuFCARFuoCVSOkZmYGg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:51:02 INFO - Running post-action listener: _resource_record_post_action 08:51:02 INFO - ##### 08:51:02 INFO - ##### Finished read-buildbot-config step (success) 08:51:02 INFO - ##### 08:51:02 INFO - ##### 08:51:02 INFO - ##### Running download-and-extract step. 08:51:02 INFO - ##### 08:51:02 INFO - Running pre-action listener: _resource_record_pre_action 08:51:02 INFO - Running main action method: download_and_extract 08:51:02 INFO - mkdir: /builds/slave/test/build/tests 08:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:02 INFO - https://queue.taskcluster.net/v1/task/RDuPuFCARFuoCVSOkZmYGg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:51:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDuPuFCARFuoCVSOkZmYGg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:51:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDuPuFCARFuoCVSOkZmYGg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:51:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDuPuFCARFuoCVSOkZmYGg/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:51:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDuPuFCARFuoCVSOkZmYGg/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:51:03 INFO - Downloaded 1361 bytes. 08:51:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:51:03 INFO - Using the following test package requirements: 08:51:03 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:51:03 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:51:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:51:03 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:51:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:51:03 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:51:03 INFO - u'jsshell-linux-x86_64.zip'], 08:51:03 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:51:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:51:03 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:51:03 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:51:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:51:03 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:51:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:51:03 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:51:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:51:03 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:51:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:51:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:51: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:51:03 INFO - https://queue.taskcluster.net/v1/task/RDuPuFCARFuoCVSOkZmYGg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:51:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDuPuFCARFuoCVSOkZmYGg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:51:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDuPuFCARFuoCVSOkZmYGg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:51:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDuPuFCARFuoCVSOkZmYGg/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:51:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDuPuFCARFuoCVSOkZmYGg/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:51:07 INFO - Downloaded 22705886 bytes. 08:51:07 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:51:07 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:51:08 INFO - Return code: 0 08:51:08 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:51:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:08 INFO - https://queue.taskcluster.net/v1/task/RDuPuFCARFuoCVSOkZmYGg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:51:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDuPuFCARFuoCVSOkZmYGg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:51:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDuPuFCARFuoCVSOkZmYGg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:51:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDuPuFCARFuoCVSOkZmYGg/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:51:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDuPuFCARFuoCVSOkZmYGg/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:51:09 INFO - Downloaded 22705886 bytes. 08:51:09 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:51:09 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:51:10 INFO - Return code: 0 08:51:10 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:51:10 INFO - https://queue.taskcluster.net/v1/task/RDuPuFCARFuoCVSOkZmYGg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:51:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDuPuFCARFuoCVSOkZmYGg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:51:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDuPuFCARFuoCVSOkZmYGg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:51:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDuPuFCARFuoCVSOkZmYGg/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:51:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDuPuFCARFuoCVSOkZmYGg/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:51:12 INFO - Downloaded 14405327 bytes. 08:51:12 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:51:12 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:51:12 INFO - Return code: 0 08:51:12 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:51:12 INFO - https://queue.taskcluster.net/v1/task/RDuPuFCARFuoCVSOkZmYGg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:51:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDuPuFCARFuoCVSOkZmYGg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:51:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDuPuFCARFuoCVSOkZmYGg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:51:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDuPuFCARFuoCVSOkZmYGg/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:51:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RDuPuFCARFuoCVSOkZmYGg/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:51:17 INFO - Downloaded 56478841 bytes. 08:51:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RDuPuFCARFuoCVSOkZmYGg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:51:17 INFO - mkdir: /builds/slave/test/properties 08:51:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:51:17 INFO - Writing to file /builds/slave/test/properties/build_url 08:51:17 INFO - Contents: 08:51:17 INFO - build_url:https://queue.taskcluster.net/v1/task/RDuPuFCARFuoCVSOkZmYGg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:51:18 INFO - Running post-action listener: _resource_record_post_action 08:51:18 INFO - Running post-action listener: set_extra_try_arguments 08:51:18 INFO - ##### 08:51:18 INFO - ##### Finished download-and-extract step (success) 08:51:18 INFO - ##### 08:51:18 INFO - ##### 08:51:18 INFO - ##### Running populate-webroot step. 08:51:18 INFO - ##### 08:51:18 INFO - Running pre-action listener: _resource_record_pre_action 08:51:18 INFO - Running main action method: populate_webroot 08:51:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:51:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:51:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:51:18 INFO - '--tppagecycles', 08:51:18 INFO - '7'], 08:51:18 INFO - 'tests': ['tsvgm']}}, 08:51:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:51:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:51:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:51:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:51:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:51:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:51:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:18 INFO - 'talos_options': ['--disable-e10s'], 08:51:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:51:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:51:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:18 INFO - 'talos_options': ['--disable-e10s'], 08:51:18 INFO - 'tests': ['damp', 'tps']}, 08:51:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:18 INFO - 'tests': ['damp', 'tps']}, 08:51:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:51:18 INFO - 'tests': ['dromaeo_dom']}, 08:51:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:51:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:51:18 INFO - 'tests': ['basic_compositor_video']}, 08:51:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:51:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:51:18 INFO - 'tests': ['a11yr', 08:51:18 INFO - 'ts_paint', 08:51:18 INFO - 'tpaint', 08:51:18 INFO - 'sessionrestore', 08:51:18 INFO - 'sessionrestore_no_auto_restore', 08:51:18 INFO - 'tabpaint']}, 08:51:18 INFO - 'other-e10s': {'tests': ['a11yr', 08:51:18 INFO - 'ts_paint', 08:51:18 INFO - 'tpaint', 08:51:18 INFO - 'sessionrestore', 08:51:18 INFO - 'sessionrestore_no_auto_restore', 08:51:18 INFO - 'tabpaint']}, 08:51:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:51:18 INFO - 'ts_paint', 08:51:18 INFO - 'tpaint', 08:51:18 INFO - 'sessionrestore', 08:51:18 INFO - 'sessionrestore_no_auto_restore', 08:51:18 INFO - 'tabpaint']}, 08:51:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:51:18 INFO - 'ts_paint', 08:51:18 INFO - 'tpaint', 08:51:18 INFO - 'sessionrestore', 08:51:18 INFO - 'sessionrestore_no_auto_restore', 08:51:18 INFO - 'tabpaint']}, 08:51:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:51:18 INFO - 'tests': ['a11yr', 08:51:18 INFO - 'ts_paint', 08:51:18 INFO - 'tpaint', 08:51:18 INFO - 'sessionrestore', 08:51:18 INFO - 'sessionrestore_no_auto_restore', 08:51:18 INFO - 'tabpaint']}, 08:51:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:51:18 INFO - 'tests': ['a11yr', 08:51:18 INFO - 'ts_paint', 08:51:18 INFO - 'tpaint', 08:51:18 INFO - 'sessionrestore', 08:51:18 INFO - 'sessionrestore_no_auto_restore', 08:51:18 INFO - 'tabpaint']}, 08:51:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:51:18 INFO - 'tests': ['tsvgx', 08:51:18 INFO - 'tsvgr_opacity', 08:51:18 INFO - 'tart', 08:51:18 INFO - 'tscrollx', 08:51:18 INFO - 'cart']}, 08:51:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:51:18 INFO - 'tsvgr_opacity', 08:51:18 INFO - 'tart', 08:51:18 INFO - 'tscrollx', 08:51:18 INFO - 'cart']}, 08:51:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:18 INFO - 'talos_options': ['--disable-e10s'], 08:51:18 INFO - 'tests': ['tp5o']}, 08:51:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:18 INFO - 'tests': ['tp5o']}, 08:51:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:18 INFO - 'talos_options': ['--disable-e10s', 08:51:18 INFO - '--xperf_path', 08:51:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:51:18 INFO - 'tests': ['tp5n']}, 08:51:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:18 INFO - 'talos_options': ['--xperf_path', 08:51:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:51:18 INFO - 'tests': ['tp5n']}}, 08:51:18 INFO - 'talos.zip': {'path': '', 08:51:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:51:18 INFO - Running post-action listener: _resource_record_post_action 08:51:18 INFO - ##### 08:51:18 INFO - ##### Finished populate-webroot step (success) 08:51:18 INFO - ##### 08:51:18 INFO - ##### 08:51:18 INFO - ##### Running create-virtualenv step. 08:51:18 INFO - ##### 08:51:18 INFO - Running pre-action listener: _resource_record_pre_action 08:51:18 INFO - Running main action method: create_virtualenv 08:51:18 INFO - Creating virtualenv /builds/slave/test/build/venv 08:51:18 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:51:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:51:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:51:18 INFO - Using real prefix '/usr' 08:51:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:51:18 INFO - Installing distribute.............................................................................................................................................................................................done. 08:51:20 INFO - Installing pip.................done. 08:51:20 INFO - Return code: 0 08:51:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:20 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 0x21da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24993b0>, '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 0x249a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a740>, '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': 'df17445c3590ff7897617a0e00000225-1467551213.188260-173911275', '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:51:20 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:51:20 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:51:20 INFO - Using env: {'DISPLAY': ':0', 08:51:20 INFO - 'HOME': '/home/cltbld', 08:51:20 INFO - 'LANG': 'en_US.UTF-8', 08:51:20 INFO - 'LANGUAGE': 'en_US:en', 08:51:20 INFO - 'LOGNAME': 'cltbld', 08:51:20 INFO - 'MAIL': '/var/mail/cltbld', 08:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:20 INFO - 'MOZ_NO_REMOTE': '1', 08:51:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:20 INFO - 'NO_EM_RESTART': '1', 08:51:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:20 INFO - 'PWD': '/builds/slave/test', 08:51:20 INFO - 'SHELL': '/bin/bash', 08:51:20 INFO - 'SHLVL': '1', 08:51:20 INFO - 'TERM': 'linux', 08:51:20 INFO - 'TMOUT': '86400', 08:51:20 INFO - 'USER': 'cltbld', 08:51:20 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467551213.188260-173911275', 08:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:20 INFO - '_': '/tools/buildbot/bin/python'} 08:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:21 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:51:21 INFO - Cleaning up... 08:51:21 INFO - Return code: 0 08:51:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:21 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 0x21da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24993b0>, '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 0x249a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a740>, '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': 'df17445c3590ff7897617a0e00000225-1467551213.188260-173911275', '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:51:21 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:51:21 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:51:21 INFO - Using env: {'DISPLAY': ':0', 08:51:21 INFO - 'HOME': '/home/cltbld', 08:51:21 INFO - 'LANG': 'en_US.UTF-8', 08:51:21 INFO - 'LANGUAGE': 'en_US:en', 08:51:21 INFO - 'LOGNAME': 'cltbld', 08:51:21 INFO - 'MAIL': '/var/mail/cltbld', 08:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:21 INFO - 'MOZ_NO_REMOTE': '1', 08:51:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:21 INFO - 'NO_EM_RESTART': '1', 08:51:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:21 INFO - 'PWD': '/builds/slave/test', 08:51:21 INFO - 'SHELL': '/bin/bash', 08:51:21 INFO - 'SHLVL': '1', 08:51:21 INFO - 'TERM': 'linux', 08:51:21 INFO - 'TMOUT': '86400', 08:51:21 INFO - 'USER': 'cltbld', 08:51:21 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467551213.188260-173911275', 08:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:21 INFO - '_': '/tools/buildbot/bin/python'} 08:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:21 INFO - Downloading/unpacking psutil>=3.1.1 08:51: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:51: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:51: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:51: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:51: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:51: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:51:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:51:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:51:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:51:23 INFO - Installing collected packages: psutil 08:51:23 INFO - Running setup.py install for psutil 08:51:23 INFO - building 'psutil._psutil_linux' extension 08:51:23 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:51:23 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:51:23 INFO - building 'psutil._psutil_posix' extension 08:51:23 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:51:23 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:51:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:51:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:51:23 INFO - Successfully installed psutil 08:51:23 INFO - Cleaning up... 08:51:23 INFO - Return code: 0 08:51:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:51:23 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:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:23 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:51:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:23 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 0x21da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24993b0>, '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 0x249a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a740>, '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': 'df17445c3590ff7897617a0e00000225-1467551213.188260-173911275', '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:51:23 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:51:23 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:51:23 INFO - Using env: {'DISPLAY': ':0', 08:51:23 INFO - 'HOME': '/home/cltbld', 08:51:23 INFO - 'LANG': 'en_US.UTF-8', 08:51:23 INFO - 'LANGUAGE': 'en_US:en', 08:51:23 INFO - 'LOGNAME': 'cltbld', 08:51:23 INFO - 'MAIL': '/var/mail/cltbld', 08:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:23 INFO - 'MOZ_NO_REMOTE': '1', 08:51:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:23 INFO - 'NO_EM_RESTART': '1', 08:51:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:23 INFO - 'PWD': '/builds/slave/test', 08:51:23 INFO - 'SHELL': '/bin/bash', 08:51:23 INFO - 'SHLVL': '1', 08:51:23 INFO - 'TERM': 'linux', 08:51:23 INFO - 'TMOUT': '86400', 08:51:23 INFO - 'USER': 'cltbld', 08:51:23 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467551213.188260-173911275', 08:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:23 INFO - '_': '/tools/buildbot/bin/python'} 08:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:51:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:51:26 INFO - Installing collected packages: mozsystemmonitor 08:51:26 INFO - Running setup.py install for mozsystemmonitor 08:51:26 INFO - Successfully installed mozsystemmonitor 08:51:26 INFO - Cleaning up... 08:51:26 INFO - Return code: 0 08:51:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:26 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 0x21da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24993b0>, '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 0x249a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a740>, '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': 'df17445c3590ff7897617a0e00000225-1467551213.188260-173911275', '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:51:26 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:51:26 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:51:26 INFO - Using env: {'DISPLAY': ':0', 08:51:26 INFO - 'HOME': '/home/cltbld', 08:51:26 INFO - 'LANG': 'en_US.UTF-8', 08:51:26 INFO - 'LANGUAGE': 'en_US:en', 08:51:26 INFO - 'LOGNAME': 'cltbld', 08:51:26 INFO - 'MAIL': '/var/mail/cltbld', 08:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:26 INFO - 'MOZ_NO_REMOTE': '1', 08:51:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:26 INFO - 'NO_EM_RESTART': '1', 08:51:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:26 INFO - 'PWD': '/builds/slave/test', 08:51:26 INFO - 'SHELL': '/bin/bash', 08:51:26 INFO - 'SHLVL': '1', 08:51:26 INFO - 'TERM': 'linux', 08:51:26 INFO - 'TMOUT': '86400', 08:51:26 INFO - 'USER': 'cltbld', 08:51:26 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467551213.188260-173911275', 08:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:26 INFO - '_': '/tools/buildbot/bin/python'} 08:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:26 INFO - Downloading/unpacking jsonschema==2.5.1 08:51:26 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:51:26 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:51:26 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:51:26 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:51:26 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:51:26 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:51:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:51:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:51:28 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:51:28 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:51:28 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:51:28 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:51:28 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:51:28 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:51:28 INFO - Downloading functools32-3.2.3-2.tar.gz 08:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:51:28 INFO - warning: no files found matching '*.txt' 08:51:28 INFO - no previously-included directories found matching 'build' 08:51:28 INFO - no previously-included directories found matching 'dist' 08:51:28 INFO - no previously-included directories found matching '.git*' 08:51:28 INFO - Installing collected packages: jsonschema, functools32 08:51:28 INFO - Running setup.py install for functools32 08:51:28 INFO - warning: no files found matching '*.txt' 08:51:28 INFO - no previously-included directories found matching 'build' 08:51:28 INFO - no previously-included directories found matching 'dist' 08:51:28 INFO - no previously-included directories found matching '.git*' 08:51:28 INFO - Successfully installed jsonschema functools32 08:51:28 INFO - Cleaning up... 08:51:28 INFO - Return code: 0 08:51:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:28 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 0x21da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24993b0>, '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 0x249a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a740>, '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': 'df17445c3590ff7897617a0e00000225-1467551213.188260-173911275', '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:51:28 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:51:28 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:51:28 INFO - Using env: {'DISPLAY': ':0', 08:51:28 INFO - 'HOME': '/home/cltbld', 08:51:28 INFO - 'LANG': 'en_US.UTF-8', 08:51:28 INFO - 'LANGUAGE': 'en_US:en', 08:51:28 INFO - 'LOGNAME': 'cltbld', 08:51:28 INFO - 'MAIL': '/var/mail/cltbld', 08:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:28 INFO - 'MOZ_NO_REMOTE': '1', 08:51:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:28 INFO - 'NO_EM_RESTART': '1', 08:51:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:28 INFO - 'PWD': '/builds/slave/test', 08:51:28 INFO - 'SHELL': '/bin/bash', 08:51:28 INFO - 'SHLVL': '1', 08:51:28 INFO - 'TERM': 'linux', 08:51:28 INFO - 'TMOUT': '86400', 08:51:28 INFO - 'USER': 'cltbld', 08:51:28 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467551213.188260-173911275', 08:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:28 INFO - '_': '/tools/buildbot/bin/python'} 08:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:28 INFO - Downloading/unpacking blobuploader==1.2.4 08:51:28 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:51:28 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:51:28 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:51:28 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:51:28 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:51:28 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:51:30 INFO - Downloading blobuploader-1.2.4.tar.gz 08:51:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:51:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:51:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:31 INFO - Downloading docopt-0.6.1.tar.gz 08:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:51:31 INFO - Installing collected packages: blobuploader, requests, docopt 08:51:31 INFO - Running setup.py install for blobuploader 08:51:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:51:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:51:31 INFO - Running setup.py install for requests 08:51:32 INFO - Running setup.py install for docopt 08:51:32 INFO - Successfully installed blobuploader requests docopt 08:51:32 INFO - Cleaning up... 08:51:32 INFO - Return code: 0 08:51:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:32 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 0x21da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24993b0>, '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 0x249a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a740>, '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': 'df17445c3590ff7897617a0e00000225-1467551213.188260-173911275', '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:51:32 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:51:32 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:51:32 INFO - Using env: {'DISPLAY': ':0', 08:51:32 INFO - 'HOME': '/home/cltbld', 08:51:32 INFO - 'LANG': 'en_US.UTF-8', 08:51:32 INFO - 'LANGUAGE': 'en_US:en', 08:51:32 INFO - 'LOGNAME': 'cltbld', 08:51:32 INFO - 'MAIL': '/var/mail/cltbld', 08:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:32 INFO - 'MOZ_NO_REMOTE': '1', 08:51:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:32 INFO - 'NO_EM_RESTART': '1', 08:51:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:32 INFO - 'PWD': '/builds/slave/test', 08:51:32 INFO - 'SHELL': '/bin/bash', 08:51:32 INFO - 'SHLVL': '1', 08:51:32 INFO - 'TERM': 'linux', 08:51:32 INFO - 'TMOUT': '86400', 08:51:32 INFO - 'USER': 'cltbld', 08:51:32 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467551213.188260-173911275', 08:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:32 INFO - '_': '/tools/buildbot/bin/python'} 08:51:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:51:32 INFO - Running setup.py (path:/tmp/pip-D8t6rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:51:32 INFO - Running setup.py (path:/tmp/pip-Clr5Yt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:51:32 INFO - Running setup.py (path:/tmp/pip-D3Ciw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:51:32 INFO - Running setup.py (path:/tmp/pip-airs7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:51:32 INFO - Running setup.py (path:/tmp/pip-5sWHat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:51:32 INFO - Running setup.py (path:/tmp/pip-7OW4kI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:51:32 INFO - Running setup.py (path:/tmp/pip-3bMpzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:51:32 INFO - Running setup.py (path:/tmp/pip-HTEXEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:51:33 INFO - Running setup.py (path:/tmp/pip-_F9HQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:51:33 INFO - Running setup.py (path:/tmp/pip-nfASI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:51:33 INFO - Running setup.py (path:/tmp/pip-m2PNQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:51:33 INFO - Running setup.py (path:/tmp/pip-Br9XYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:51:33 INFO - Running setup.py (path:/tmp/pip-c7krN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:51:33 INFO - Running setup.py (path:/tmp/pip-hl2KSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:33 INFO - Running setup.py (path:/tmp/pip-ODDVTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:51:33 INFO - Running setup.py (path:/tmp/pip-xFfcg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:51:33 INFO - Running setup.py (path:/tmp/pip-8tEi1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:51:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:51:33 INFO - Running setup.py install for manifestparser 08:51:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:51:33 INFO - Running setup.py install for mozcrash 08:51:33 INFO - Running setup.py install for mozdebug 08:51:33 INFO - Running setup.py install for mozdevice 08:51:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:51:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:51:34 INFO - Running setup.py install for mozfile 08:51:34 INFO - Running setup.py install for mozhttpd 08:51:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:51:34 INFO - Running setup.py install for mozinfo 08:51:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:51:34 INFO - Running setup.py install for mozInstall 08:51:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:51:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:51:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:51:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:51:34 INFO - Running setup.py install for mozleak 08:51:34 INFO - Running setup.py install for mozlog 08:51:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:51:34 INFO - Running setup.py install for moznetwork 08:51:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:51:34 INFO - Running setup.py install for mozprocess 08:51:34 INFO - Running setup.py install for mozprofile 08:51:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:51:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:51:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:51:35 INFO - Running setup.py install for mozrunner 08:51:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:51:35 INFO - Running setup.py install for mozscreenshot 08:51:35 INFO - Running setup.py install for moztest 08:51:35 INFO - Running setup.py install for mozversion 08:51:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:51:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:51:35 INFO - Cleaning up... 08:51:35 INFO - Return code: 0 08:51:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:35 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 0x21da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24993b0>, '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 0x249a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a740>, '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': 'df17445c3590ff7897617a0e00000225-1467551213.188260-173911275', '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:51:35 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:51:35 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:51:35 INFO - Using env: {'DISPLAY': ':0', 08:51:35 INFO - 'HOME': '/home/cltbld', 08:51:35 INFO - 'LANG': 'en_US.UTF-8', 08:51:35 INFO - 'LANGUAGE': 'en_US:en', 08:51:35 INFO - 'LOGNAME': 'cltbld', 08:51:35 INFO - 'MAIL': '/var/mail/cltbld', 08:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:35 INFO - 'MOZ_NO_REMOTE': '1', 08:51:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:35 INFO - 'NO_EM_RESTART': '1', 08:51:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:35 INFO - 'PWD': '/builds/slave/test', 08:51:35 INFO - 'SHELL': '/bin/bash', 08:51:35 INFO - 'SHLVL': '1', 08:51:35 INFO - 'TERM': 'linux', 08:51:35 INFO - 'TMOUT': '86400', 08:51:35 INFO - 'USER': 'cltbld', 08:51:35 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467551213.188260-173911275', 08:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:35 INFO - '_': '/tools/buildbot/bin/python'} 08:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:51:35 INFO - Running setup.py (path:/tmp/pip-DvXepg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:51:35 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:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:51:35 INFO - Running setup.py (path:/tmp/pip-hxEv6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:51:35 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:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:51:35 INFO - Running setup.py (path:/tmp/pip-FwRM75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:51:35 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:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:51:35 INFO - Running setup.py (path:/tmp/pip-4QhKtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:51:36 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:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:51:36 INFO - Running setup.py (path:/tmp/pip-ZKDoHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:51:36 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:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:51:36 INFO - Running setup.py (path:/tmp/pip-T3PHTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:51:36 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:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:51:36 INFO - Running setup.py (path:/tmp/pip-1iYymU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:51:36 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:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:51:36 INFO - Running setup.py (path:/tmp/pip-pikpEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:51:36 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:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:51:36 INFO - Running setup.py (path:/tmp/pip-VN1DUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:51:36 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:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:51:36 INFO - Running setup.py (path:/tmp/pip-bzRZjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:51:36 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:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:51:36 INFO - Running setup.py (path:/tmp/pip-FmdwbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:51:36 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:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:51:36 INFO - Running setup.py (path:/tmp/pip-5Q06qV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:51:36 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:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:51:36 INFO - Running setup.py (path:/tmp/pip-vXMA3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:51:36 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:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:51:36 INFO - Running setup.py (path:/tmp/pip-pJtSAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:51:36 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:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:36 INFO - Running setup.py (path:/tmp/pip-O3NWtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:36 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:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:51:36 INFO - Running setup.py (path:/tmp/pip-dEApSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:51:36 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:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:51:36 INFO - Running setup.py (path:/tmp/pip-RoP1QK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:51:36 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:51:36 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:51:36 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:51:36 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:51:36 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:51:36 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:51:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:38 INFO - Downloading blessings-1.6.tar.gz 08:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:51:38 INFO - Installing collected packages: blessings 08:51:38 INFO - Running setup.py install for blessings 08:51:39 INFO - Successfully installed blessings 08:51:39 INFO - Cleaning up... 08:51:39 INFO - Return code: 0 08:51:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:51:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:51:39 INFO - Reading from file tmpfile_stdout 08:51:39 INFO - Current package versions: 08:51:39 INFO - argparse == 1.2.1 08:51:39 INFO - blessings == 1.6 08:51:39 INFO - blobuploader == 1.2.4 08:51:39 INFO - docopt == 0.6.1 08:51:39 INFO - functools32 == 3.2.3-2 08:51:39 INFO - jsonschema == 2.5.1 08:51:39 INFO - manifestparser == 1.1 08:51:39 INFO - mozInstall == 1.12 08:51:39 INFO - mozcrash == 0.17 08:51:39 INFO - mozdebug == 0.1 08:51:39 INFO - mozdevice == 0.48 08:51:39 INFO - mozfile == 1.2 08:51:39 INFO - mozhttpd == 0.7 08:51:39 INFO - mozinfo == 0.9 08:51:39 INFO - mozleak == 0.1 08:51:39 INFO - mozlog == 3.2 08:51:39 INFO - moznetwork == 0.27 08:51:39 INFO - mozprocess == 0.22 08:51:39 INFO - mozprofile == 0.28 08:51:39 INFO - mozrunner == 6.11 08:51:39 INFO - mozscreenshot == 0.1 08:51:39 INFO - mozsystemmonitor == 0.3 08:51:39 INFO - moztest == 0.7 08:51:39 INFO - mozversion == 1.4 08:51:39 INFO - psutil == 3.1.1 08:51:39 INFO - requests == 1.2.3 08:51:39 INFO - wsgiref == 0.1.2 08:51:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:39 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 0x21da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24993b0>, '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 0x249a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a740>, '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': 'df17445c3590ff7897617a0e00000225-1467551213.188260-173911275', '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:51:39 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:51:39 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:51:39 INFO - Using env: {'DISPLAY': ':0', 08:51:39 INFO - 'HOME': '/home/cltbld', 08:51:39 INFO - 'LANG': 'en_US.UTF-8', 08:51:39 INFO - 'LANGUAGE': 'en_US:en', 08:51:39 INFO - 'LOGNAME': 'cltbld', 08:51:39 INFO - 'MAIL': '/var/mail/cltbld', 08:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:39 INFO - 'MOZ_NO_REMOTE': '1', 08:51:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:39 INFO - 'NO_EM_RESTART': '1', 08:51:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:39 INFO - 'PWD': '/builds/slave/test', 08:51:39 INFO - 'SHELL': '/bin/bash', 08:51:39 INFO - 'SHLVL': '1', 08:51:39 INFO - 'TERM': 'linux', 08:51:39 INFO - 'TMOUT': '86400', 08:51:39 INFO - 'USER': 'cltbld', 08:51:39 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467551213.188260-173911275', 08:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:39 INFO - '_': '/tools/buildbot/bin/python'} 08:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:39 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:51:39 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:51:39 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:51:39 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:51:39 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:51:39 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:51:39 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:51:39 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:51:39 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:51:39 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:51:39 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:51:39 INFO - Cleaning up... 08:51:39 INFO - Return code: 0 08:51:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:39 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 0x21da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x249b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24993b0>, '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 0x249a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a740>, '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': 'df17445c3590ff7897617a0e00000225-1467551213.188260-173911275', '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:51:39 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:51:39 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:51:39 INFO - Using env: {'DISPLAY': ':0', 08:51:39 INFO - 'HOME': '/home/cltbld', 08:51:39 INFO - 'LANG': 'en_US.UTF-8', 08:51:39 INFO - 'LANGUAGE': 'en_US:en', 08:51:39 INFO - 'LOGNAME': 'cltbld', 08:51:39 INFO - 'MAIL': '/var/mail/cltbld', 08:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:39 INFO - 'MOZ_NO_REMOTE': '1', 08:51:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:39 INFO - 'NO_EM_RESTART': '1', 08:51:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:39 INFO - 'PWD': '/builds/slave/test', 08:51:39 INFO - 'SHELL': '/bin/bash', 08:51:39 INFO - 'SHLVL': '1', 08:51:39 INFO - 'TERM': 'linux', 08:51:39 INFO - 'TMOUT': '86400', 08:51:39 INFO - 'USER': 'cltbld', 08:51:39 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467551213.188260-173911275', 08:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:39 INFO - '_': '/tools/buildbot/bin/python'} 08:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:51:39 INFO - Cleaning up... 08:51:39 INFO - Return code: 0 08:51:39 INFO - Running post-action listener: _resource_record_post_action 08:51:39 INFO - Running post-action listener: _start_resource_monitoring 08:51:39 INFO - Starting resource monitoring. 08:51:39 INFO - ##### 08:51:39 INFO - ##### Finished create-virtualenv step (success) 08:51:39 INFO - ##### 08:51:39 INFO - ##### 08:51:39 INFO - ##### Running install step. 08:51:39 INFO - ##### 08:51:39 INFO - Running pre-action listener: _resource_record_pre_action 08:51:39 INFO - Running main action method: install 08:51:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:51:39 INFO - Reading from file tmpfile_stdout 08:51:39 INFO - Detecting whether we're running mozinstall >=1.0... 08:51:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:51:40 INFO - Reading from file tmpfile_stdout 08:51:40 INFO - Output received: 08:51:40 INFO - Usage: mozinstall [options] installer 08:51:40 INFO - Options: 08:51:40 INFO - -h, --help show this help message and exit 08:51:40 INFO - -d DEST, --destination=DEST 08:51:40 INFO - Directory to install application into. [default: 08:51:40 INFO - "/builds/slave/test"] 08:51:40 INFO - --app=APP Application being installed. [default: firefox] 08:51:40 INFO - mkdir: /builds/slave/test/build/application 08:51:40 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:51:40 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:51:57 INFO - Reading from file tmpfile_stdout 08:51:57 INFO - Output received: 08:51:57 INFO - /builds/slave/test/build/application/firefox/firefox 08:51:57 INFO - Running post-action listener: _resource_record_post_action 08:51:57 INFO - ##### 08:51:57 INFO - ##### Finished install step (success) 08:51:57 INFO - ##### 08:51:57 INFO - ##### 08:51:57 INFO - ##### Running run-tests step. 08:51:57 INFO - ##### 08:51:57 INFO - Running pre-action listener: _resource_record_pre_action 08:51:57 INFO - Running main action method: run_tests 08:51:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:51:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:51:57 INFO - Python 2.7.3 08:51:57 INFO - Return code: 0 08:51:57 INFO - grabbing minidump binary from tooltool 08:51:57 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:51:57 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 0x24993b0>, '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 0x249a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x249a740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:51:57 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:51:57 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:51:57 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:51:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:51:57 INFO - Return code: 0 08:51:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:51:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:51:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:51:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:51:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:51:57 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/RDuPuFCARFuoCVSOkZmYGg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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:51:57 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/RDuPuFCARFuoCVSOkZmYGg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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:51:57 INFO - Using env: {'DISPLAY': ':0', 08:51:57 INFO - 'HOME': '/home/cltbld', 08:51:57 INFO - 'LANG': 'en_US.UTF-8', 08:51:57 INFO - 'LANGUAGE': 'en_US:en', 08:51:57 INFO - 'LOGNAME': 'cltbld', 08:51:57 INFO - 'MAIL': '/var/mail/cltbld', 08:51:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:51:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:51:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:57 INFO - 'MOZ_NO_REMOTE': '1', 08:51:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:51:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:57 INFO - 'NO_EM_RESTART': '1', 08:51:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:57 INFO - 'PWD': '/builds/slave/test', 08:51:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:51:57 INFO - 'SHELL': '/bin/bash', 08:51:57 INFO - 'SHLVL': '1', 08:51:57 INFO - 'TERM': 'linux', 08:51:57 INFO - 'TMOUT': '86400', 08:51:57 INFO - 'USER': 'cltbld', 08:51:57 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467551213.188260-173911275', 08:51:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:57 INFO - '_': '/tools/buildbot/bin/python'} 08:51:57 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/RDuPuFCARFuoCVSOkZmYGg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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:51:57 INFO - mozversion application_buildid: 20160703080822 08:51:57 INFO - mozversion application_changeset: 99bab2d812fc9619c122fcdd84c6f085ced8c1e8 08:51:57 INFO - mozversion application_display_name: Nightly 08:51:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:51:57 INFO - mozversion application_name: Firefox 08:51:57 INFO - mozversion application_remotingname: firefox 08:51:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:51:57 INFO - mozversion application_vendor: Mozilla 08:51:57 INFO - mozversion application_version: 50.0a1 08:51:57 INFO - mozversion platform_buildid: 20160703080822 08:51:57 INFO - mozversion platform_changeset: 99bab2d812fc9619c122fcdd84c6f085ced8c1e8 08:51:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:51:57 INFO - mozversion platform_version: 50.0a1 08:51:57 INFO - using testdate: 1467561117 08:51:57 INFO - actual date: 1467561117 08:51:57 INFO - starting webserver on 'localhost:48219' 08:51:57 INFO - SUITE-START | Running 2 tests 08:51:57 INFO - TEST-START | dromaeo_css 08:51:57 INFO - operating with platform_type : linux_ 08:51:57 INFO - Initialising browser for dromaeo_css test... 08:51:57 INFO - TEST-INFO | started process 23689 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkcTulr/profile http://localhost:48219/getInfo.html) 08:52:02 INFO - PROCESS | 23689 | __metrics Screen width/height:1600/1200 08:52:02 INFO - PROCESS | 23689 | colorDepth:24 08:52:02 INFO - PROCESS | 23689 | Browser inner width/height: 1024/697 08:52:02 INFO - PROCESS | 23689 | __metrics 08:52:04 INFO - PROCESS | 23689 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:52:05 INFO - TEST-INFO | 23689: exit 0 08:52:05 INFO - Browser initialized. 08:52:05 INFO - Running cycle 1/1 for dromaeo_css test... 08:52:05 INFO - TEST-INFO | started process 23771 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkcTulr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:52:17 INFO - PROCESS | 23771 | RSS: Main: 159297536 08:52:17 INFO - PROCESS | 23771 | 08:53:08 INFO - PROCESS | 23771 | 1467561188420 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:55:21 INFO - PROCESS | 23771 | Cycle 1(1): loaded http://localhost:48219/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48219/tests/dromaeo/cssquery-ext.html) 08:55:22 INFO - PROCESS | 23771 | RSS: Main: 274718720 08:55:22 INFO - PROCESS | 23771 | 08:58:25 INFO - PROCESS | 23771 | Cycle 1(1): loaded http://localhost:48219/tests/dromaeo/cssquery-ext.html (next: http://localhost:48219/tests/dromaeo/cssquery-jquery.html) 08:58:26 INFO - PROCESS | 23771 | RSS: Main: 231841792 08:58:26 INFO - PROCESS | 23771 | 09:01:28 INFO - PROCESS | 23771 | Cycle 1(1): loaded http://localhost:48219/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48219/tests/dromaeo/cssquery-mootools.html) 09:01:29 INFO - PROCESS | 23771 | RSS: Main: 241377280 09:01:29 INFO - PROCESS | 23771 | 09:04:31 INFO - PROCESS | 23771 | Cycle 1(1): loaded http://localhost:48219/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48219/tests/dromaeo/cssquery-prototype.html) 09:04:31 INFO - PROCESS | 23771 | RSS: Main: 241135616 09:04:31 INFO - PROCESS | 23771 | 09:07:34 INFO - PROCESS | 23771 | Cycle 1(1): loaded http://localhost:48219/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48219/tests/dromaeo/cssquery-yui.html) 09:07:35 INFO - PROCESS | 23771 | RSS: Main: 212013056 09:07:35 INFO - PROCESS | 23771 | 09:10:38 INFO - PROCESS | 23771 | Cycle 1(1): loaded http://localhost:48219/tests/dromaeo/cssquery-yui.html (next: http://localhost:48219/tests/dromaeo/cssquery-dojo.html) 09:10:38 INFO - PROCESS | 23771 | RSS: Main: 272674816 09:10:38 INFO - PROCESS | 23771 | 09:10:38 INFO - PROCESS | 23771 | __start_tp_report 09:10:38 INFO - PROCESS | 23771 | _x_x_mozilla_page_load 09:10:38 INFO - PROCESS | 23771 | _x_x_mozilla_page_load_details 09:10:38 INFO - PROCESS | 23771 | |i|pagename|runs| 09:10:38 INFO - PROCESS | 23771 | |0;dojo.html;2634.249238966894;2637.3670319123416;2664.8267862588937;2684.4362683836393;2690.4215593647364;4769.475357710658;4801.375821143255;4837.709737415757;4878.243872199806;4916.139675556777;4830.347903033089;4838.34682317887;4843.249296359061;4855.854324370274;4881.707097574148;4376.452943382077;4437.35658329542;4463.821447142127;4526.841560545382;4634.189016922042;4524.68327217095;4563.429571303587;4579.267317229244;4586.954130458686;4616.3537104805355;4192.224438478891;4354.869353919387;4391.253486907233;4399.208142534342;4484.775761211927;4399.824007039714;4405.933910991338;4408.845690400853;4463.419755431805;4506.526814684444;4424.380586717862;4427.579379958899;4459.420275364214;4488.192125417424;4503.076869241798;4813.133635945528;4819.734914579697;4883.096627123993;4890.853274401774;4892.094962431962;5224.39919409269;5276.657017293864;5299.019681358961;5303.840884773463;5317.042932272189;5283.9471605284225;5304.973475132639;5310.0441920454305;5312.282841816383;5324.254604355355;4711.434627844681;4804.879878003008;4859.198232291703;4864.975675121602;4939.950600493985;5332.066888294533;5332.573394128461;5339.86650333737;5388.8113916013535;5388.976094542025;5097.541221290027;5123.846284611468;5125.051865404912;5171.741412929338;5176.611754118456;5104.9744751276;5134;5171.482851714798;5188.299579556787;5216.478352164829;5121.180611102281;5146.125158722951;5153.819616313411;5155.200943853709;5188.584913206934;5019.924701129486;5136.794528218904;5147.536721695065;5150.0472412603785;5152.124138896396;4392.7364358137975;4399.560043995639;4450.799714012877;4452.30989196675;4474.149911516802;3857.672097871712;3868.2650296443585;3874.748141370802;3906.5898080701118;3917.4319723639915;4503;4504.031633198812;4513.052259025641;4515.277555591089;4547.727136371828;5099.796008159707;5104.642675012714;5133.486651334837;5151.639385243072;5157.149070403417;4436.378906953029;4460.50934397216;4462;4466.553344665507;4503.752293623882;4586.3579098926175;4664.183767840615;4668.85993420198;4671.462781780071;4716.221823399169;4868.659193856467;4904.313396124617;4914.557689807934;4918.6556941015215;4927.334809800775;5218.739063046756;5220.973895130652;5252.89494210106;5256.369235691742;5307.389650190277;4782.043591281688;4807.567318941172;4921.434035086011;4928.408590969107;4930.112579735682;5062.797488100582;5092.643514954066;5118.795248190179;5120.103981803095;5168.328117344721;5185.688858668492;5202.453742357149;5205.167173252262;5212.061828870839;5253.001929633358;4983.651144419856;5029.119904016856;5035.974820126023;5038.967011762506;5050.39395272555;5035.244713293036;5065.974670126626;5069;5069.6197785167;5108.029474399852;5006;5017.147084995487;5047.87380315495;5068.341115654941;5082.313887625123;4988.8752781180765;4991.80032798684;5048.444671086104;5048.974755126201;5104.795808167632;4910.091633047898;4912.410510738591;4928.039032388793;4950.8762280943265;4966.056449274771 09:10:38 INFO - PROCESS | 23771 | |1;ext.html;538.7510770486598;581.482480592273;591.1841658511255;592.9673867937262;600.9969950150248;27458.862705686468;40252.194956100895;40682;41544.169116617646;41604.79197604016;37708.81145594275;41542.79228603853;41570.16859662805;41655.375169372404;41675.95810104749;7528.096628404599;7850.097238817552;7992.560409177493;7999.760007199764;10248.180145588334;10078;10213;10481.737956551071;10485.213608979318;10488.842667359995;10504.212184086224;10564.630237941674;10568.101711354506;10575.312604680672;10592.364458132537;10404.687859364194;10446.9477652612;10463.372197668165;10466.63366782159;10469.68590942273;10345.844812327747;10350.068493835592;10413.062824345845;10418.11446027081;10432.687019389354;40093.79953100245;40223.59776402228;40238;40252;40432.59567404347;2829.952917420547;3021.561873528326;3472.461768425898;3482.6343233960324;3488.476728490721;29257.41485170306;29539.852300738574;29833.70166298331;30408;31261.84369078163;3535.222251104753;3584.426491761306;3612.187257866959;3683.4658974448553;3690.0036990012813;263663;264296;267601;268024.999999998;268176;58079.41920580825;58338.70830645905;58346;58462;58745.412545874846;60770.65761383167;60878.39121608727;60987;61023.69488152619;61188;14825.629359266104;15352.769708454382;15356.616084597974;15368.538943831703;15371.61570960735;10332.638357657446;11360.147988900866;11649.242799218024;11739.765204696028;12060;19127.13927873249;19133;19145.617087658167;19173.424797255826;19177.424677259703;5742.856428589235;6879.862402751917;6936.237013928464;6943.79168624942;7202.171750248684;837.3510529339688;907.9682211122711;989.1345073061071;1027.2347101409498;1042;28432.85783571069;29007.274818129714;29033.838646453903;29626;29689.25776855596;944.7968686732386;949.002350053142;957.9329446938787;970.8834939807268;982.3123813330698;14626.268686565842;15120;15385.84614153844;15419.845801541842;15698.450554230547;374317;374494;379089;379296;380182;50701.74649126731;51198;51302.74348628233;51352;51463.48536514587;1058.4601853054996;1127.132108276606;1132.3432409202642;1189.2448295332354;1192.9880701193224;28325.433491329644;29432.705672942997;29490.410191796473;29511.55732663969;30090.84954575213;43527.78236108926;44001.799910005015;44072;44107.338389923534;44127;289984;294438;295090;295103;296891;32465.675343246265;36962.8151859239;37755.43366849444;38859.41710874395;41529.79235103805;42256;42818.14363712646;43271.783641081594;43275;43441.56558434375;36684;36766.81616592007;36896;37102;37424.43863341997;36962.26075478529;37052.44421333628;37060.81469592742;37453;37598;35738.28523429569;36421.81789091037;36928;37022.62977370192;37460.625393745715;32093.518597221526;32436.189095271864;33146.33707325792;33321;33389.66610333963;25256.45383830928;25420.745792542577;25440;25660.358491037874;26082.73917260803 09:10:38 INFO - PROCESS | 23771 | |2;jquery.html;377.83941824724485;378.30580884077716;381.9369803982343;391.3640334456508;393.9015246188453;16709.83290167098;16857.40999065033;17378.21798019089;17993.91003044986;18029.549261268457;10871.619493317736;11183.664490065312;11189.048930840889;11199.216054876162;11204.551817927273;4466.598006179452;4554.747444452769;5180.2488639147305;5193.272941788134;5193.376794784613;5153.716545589991;5233.162693968966;5269.973650131744;5277.6305658603915;5279.762410691509;4703.129920964632;4719.4100737407825;4724.078804633098;4835.443923948756;5268.973655131719;4754.049190161982;4755.167845627001;4757.238841785298;4775.498572649856;4781.474037855833;4629.3518907353;4651.279051746985;4790.592799612003;5158.793648254065;5159.58723302135;12710;12768.872311276862;12791.48834046637;12907.870921290762;22168.11327546896;1705.0877780387557;1762.6827171109196;2229.1306390507716;2257.808086312665;2283.6346184610384;9495.952520237355;9694.903050969471;9710.417374957526;9850.064243896819;10847.945760271226;1716.4335769196136;1724.3619860651638;1729.8356656117649;1739.3390511605635;1792.8117547657569;71181.28818711799;75803.62098189474;75852;77037;77540.22459775387;10115.342502737298;10228.181745460346;10511;10531.578736850593;10706.357618542912;14424.783628245585;14446.566603001927;14457.349419276157;14488.34802433893;14501.927490362481;7244.673989670478;7683.193264707237;7694.846103077907;7703.075630924325;7737.3036426721865;7354.558726476428;7360.411167106618;7526.059242594676;7538.434617403716;7560.092788865371;4337.132573485315;4432.246518091868;4473.597376236155;4535.614472769786;4601.746903920316;1770.4600096970548;1793.5516120969758;1825.6896327624336;1844.843188329007;1879.1355976250804;807.5598798654747;845.1084106267823;861.8836457078214;916.6608354908593;960.6013504395597;16639.50081497557;17293.13534323304;17863.106844657716;17865.821341786675;18428.90785546064;810.8337790753;854.9444286121383;880.3001613716982;884.6151923913119;888.493558671564;9308.627654893864;9740.415575065519;10063.39619622825;10108.1408080314;10116.949415252877;414583;418404;421292;422153;425269;62429.68785156136;75508.62245688736;79803.60098199472;83464;89119;857.1685465098844;876.5704804645806;898.3980732908967;931.9813603727888;935.1957316707626;15970.840291596935;16827.915860421108;17003.234854431827;17172.656546869242;17320.566985825455;27451.039213627428;34132.97601071972;38802.223955521295;39757.2048559033;40962.385564217155;54827.72586137203;55107.72446137744;55565;57123.714381427824;57130.428695714174;7801.180876008165;7831.921680783119;7871.409644276588;7913.525188488479;7995.560244186626;11440.94279528597;12489.125761196628;12524.37378131108;12640.810387844374;12675.429605667952;9924.15644670211;10586.947065264932;10892.945535272273;10902.618408355669;10963;7749;10472.528736207041;10611.787764244826;11044.723881902695;11055.0603198729;10418.843717344398;10895.128389728961;11016.449177541252;11050.447477625925;11100.944495277796;7678.769636910902;7830.686772529263;7998.440109192301;8037.959810201145;8371.581420929051;10555.89444105549;10777.137828973506;10814.621488247874;10855;10925.289856159325 09:10:38 INFO - PROCESS | 23771 | |3;mootools.html;1361.5711051018927;1403.810485584446;1437.4896911596384;1655.8758093143;1663.4760050584066;7635.656395462203;8053.838923221547;8159;8161.469504482212;8169.795755106125;6973.965130174354;7690.3078722914925;7918.683252669886;7947.4834135781275;7976.96011519943;2271.3072512883564;2298.333483289844;2304.435413323738;2304.758000409958;2306.1582522379294;2265.660150977358;2280.407094155515;2298.6552017197387;2301.838871279011;2303.0327262549768;1890.867639265245;1968.0553334399426;1968.7046942958527;1974.7334109895123;2202.581509513195;2227.9777202227933;2259.423846919025;2275.055851821492;2277.977220227793;2280.692106565609;2221.5334779696122;2229.888505574731;2248.190651365507;2314.0165429692483;2319.431739223884;8033.718819841278;8068.435209535276;8095.1904809519165;8095.919040809576;8096.10942796292;4474.642028637733;4601.585857272861;4708.0113176233035;4785.49752276013;4794.5205479452125;2978.568107624404;3034.408290383376;3084.830334331611;3094.4584697677815;3095.411871744361;915.2220612479339;931.03637734944;940.0693313619536;948.0661548374845;951.9952400238024;10948.562057517769;10985.450727463594;10989.780204395867;10990.120790336834;10994.670159895137;4287.571242875688;4403.4495688039;4495.955040449619;4500.977495112504;4503.211937910853;9217;9219.723408297761;9221.81556368869;9234.49210293427;9240.722778316662;4823.807047718122;4826.565609095198;4826.855194344175;4830.29960655703;4833.709977401367;4280.59334363235;4403.009322902385;4403.713758605681;4408.25059739845;4440.822367105344;3778.1876896466842;3793.6016718244737;3872.457855900176;3884.3979183226643;3902.23906338267;1208.9093318001185;1214.8845859643498;1221.4137214137263;1238.8327575777334;1271.0784681106124;717.8564287142488;814.9918500815035;845.6659619450405;853.6628031927354;888.7111688701198;5381.919271210857;5472.534834539029;5556.97221513898;5573.191887176417;5598.216249725042;404.8906795165289;408.9488813898263;410.99383509246786;422.4719101123595;427.80534856640156;3786.8863934082024;3800.638939300817;3906.3554513504955;3908.2965066288343;3912.4522566840665;9517.5717092731;9600.711978640651;9750.317477776487;9917.256205784452;9919.156871665846;9704.514774261259;9800.509974501247;9815.460149691835;9845.360051596623;9851.950740246253;7294.270572942663;7304.379127774198;7453.627318634047;7464.70141194357;7479.289467500579;5386.622936394571;5410.215518749838;5522.5581953442825;5683.090705487102;5782.190493330853;9153.908460915305;9170.220531254652;9172.770680733034;9212.263018958332;9232.723018309462;9055.36612437123;9216.723498295061;9234.769130771785;9242.584083716383;9350;7019.613921234381;7092.326229008236;7145.214026456982;7157.964210178916;7167.7132914682825;7495.362894154058;7519.8496030077995;7563.584002879895;7634.236576342321;7636.465447418627;5053.29253904461;6731.461483081243;6967.372936435542;7034.366906978396;7136.536125151849;6791.2190098139345;6852.417544508772;6862.725490980305;6976.162860456778;6981.057557229709;6578.868422631616;6684.197896252481;6685.53201275906;6685.665716714242;6689.5986240825705;4704.600108990638;4718.386609740849;4820.566149046603;4866;4890.853274401631;4858.58702010333;4870.2938073979785;4874.171390863491;4905.460399355997;4951.8266860659705 09:10:38 INFO - PROCESS | 23771 | |4;prototype.html;301.3340517456421;308.4432599158519;311.6244924865537;317.5015226095032;319.9968000319998;4979.427365852924;4995.350604421429;4996.625253106014;5008.874778130548;5025.045241404131;4866.489018653044;4880.926786098203;4899.864086984333;4950.504949505057;4986.728384262008;3647.945280820783;3768.189839184575;3784.6593806557403;3798.9620103799025;3809.7047004018627;3690.5202323698018;3793.525809273841;3839.9424008639894;3853.323804145206;3876.5154355705536;3771.358868992278;3787.5833658297565;3810.8094595270263;3814.713896457763;3822.9426558601645;3640.7087433005295;3796.468494410785;3810.276047550984;3818.2363527294515;3840.7695538267653;3337.215754297738;3337.6829201225846;3341.6107483149663;3341.8830340937952;3353.748468864845;4790.4251489821445;4801.759912004386;4807.807687692488;4818.204996175627;4882.6826256293225;4384.583464570861;4405.11897620474;4407.140607581523;4415.911681766379;4416.1609294233995;4989.201727723583;5144.4083930348115;5148.330717006766;5213.296205012351;5216.947830521684;3660.5058317127377;3677.8528858845616;3689.206820533598;3690.2619476104887;3701.648343407372;5431.972840135813;5440.809571665012;5441.945580544223;5462.453754624546;5469.480399362054;3606.981254040067;3631.128529153037;3678.8528458861347;3699.1491956849536;3807.923841523154;3719.8326075326136;3737.7944213068;3749.4000959846294;3749.962500374961;3756.6055564165918;4333.111712099012;4335.783210839445;4339.826406943687;4350.586694264103;4351.760653164107;5084.822031228963;5120.434663214471;5156.819511317086;5209.166533354645;5231.8168864089575;1317.762802695524;1321.9206847589176;1326.4495234477583;1331.8801307882336;1340.1958824705098;795.6315137962695;835.9791005224796;842.650300125441;843.7763992541982;848.5545088828414;4481.75350355727;4553.977230113828;4562.498125206224;4578.908421831545;4597.310403439444;5292.52367286946;5304.522592966651;5305.973470132624;5307.124324486494;5309.787608495617;4443.289073748185;4554.294084416854;4555.430571178603;4597.977010114928;4606.608438282784;2803.6915939246664;2821.548552231633;2835.3478699899138;2837.744602985741;2838.7587055100134;4985.401751789808;4988.850334489971;4994.275830004629;5002;5009.947910938671;5160.8967820643375;5445.9727701362035;5451.209574611659;5459.344878614592;5465.836024919259;4975.253711943237;4978.850634480971;4979.875503112378;4984.177610694195;4999.3000979862845;5284.841454756363;5291.973540132275;5373.758180881948;5376.274202982548;5378.220158076979;4967.528084831935;5167.741612919263;5209.921851172311;5237.2667826505085;5251.52736253739;4935.851924442272;4958.553730164303;4972.65191436596;4995.475475075064;5001.07415678705;3761.8683346082757;3764.7741135531955;3779.5842457330223;3791.677707394792;3811.6760075393904;5199.454057324077;5201.855591769805;5298.655587386807;5372.516473517402;5389.039056293543;5132.871678208075;5135.075686376488;5148.845534633817;5166.4316925138955;5168.121419358643;5141.28022076902;5147;5171.146760784429;5194.97402512985;5216.165413533817;4843.183806072722;5088.313077734459;5114.514121158484;5192.636515443883;5199.48005199477;4976.253561965734;5089.389273287081;5257.553107985864;5262.263283140287;5268.894622107613;5147.794088236428;5157.922631160461;5216.869578260574;5227.686338819683;5239.528442440199 09:10:38 INFO - PROCESS | 23771 | |5;yui.html;634.4131678197667;685.5475386245082;710.2484379501137;735.4961851131978;760.0081893129467;12723.236605803646;14860.777088343684;15431.305591248392;15484.690306193883;15525.456609018687;14849.03481273719;14911.403543858232;14976.775348369783;14993.175375354378;15049.548513544583;627.8367624417662;763.3931024835241;777.7899967008918;790.6521130702502;794.5868148562744;792.4848848248627;795.9761207163765;798.6805277888833;798.9600519973978;798.9760307190794;840.8276303357827;841.146236569882;841.4194205997873;842.3555979675554;842.873568964654;653.7025653327725;785.6071964017963;813.3411936331531;814.4014149600039;818.1450384348311;604.4046614085123;604.5284677951205;604.7006731667809;604.9425304596057;605.2283338743093;11699.766004679945;11705.70735731605;11747.353895535742;11786.646400607995;11787.764244715057;12440.81338779919;12830.230186188859;12837.807432888514;13039.282839443827;13079.346032698328;11813.254065395997;12055.15613907018;12093.274403535816;12112.878871211264;12189.146759726822;4150.564190759957;4177.519585247705;4178.498580170369;4181.6236538711355;4232.25935461293;61087;61423.69288153531;61449.38550614481;61546.0768088479;61854;9957.352772069793;10242.897571024194;10276.332038417479;10643.46782660864;11008.504617292241;18547.35084272044;18933.715994260096;18949.24203031891;18961.24155033811;19067.427977160707;6969.0940177776565;6985.126859142607;7043.084399028094;7049.7885063448175;7127.786166415016;3794.487744154559;3812.085099576137;3843.530471927776;3854.209886973164;3982.6415622594104;2922.1379692990618;3031.227037105568;3040.7263346298496;3043.0566524377514;3044.360684256331;438.7762241256918;505.4970304546926;514.7271945868696;514.8455463360976;568.982930512077;586.9354371019184;619.6003577692453;622.8785386849612;626;638.9648569328639;8541.829163416696;8689.826203475895;8741;8806.86789698155;9050.094990500897;485.7377016411169;518.7069305842188;570.4381184533231;572.4275724275724;576.9884602307931;4376.387305777193;4386.561343865652;4407.867763967022;4442.42248507692;4515;99159.50420247852;105642;106775.46612266889;110100.449497752;110223;92593.5370323144;96221.51889240649;96379.51810241044;96718.51640741751;96892;81680;83662.16337836544;83795;85320;85522.99999999875;8356.456830306011;8405.579721014046;8410.201030902055;8559.144085591392;8577.099404562681;46941.295880561134;48017;48903.75548122237;48927.510724892294;49063.50936490589;38765.41851872168;39154.216915662095;40129;48593;61706.38293617006;11735.354555499529;12030.699232519257;12042.819357709466;12125.75748485043;12190.695232619255;13250.403731832284;13323.200607963554;13365.732685346044;13657.590272291847;13798.793018104536;12467.189632673848;12650.430730617329;12726.300053497147;12824.422900969665;13347.66630834237;11874.821877672015;11908.345041022827;12947.870521294666;12998.870011299767;13058.477660893837;12329.321887296284;12741.617751467471;12914.289714065817;13065.477380904656;13251.469941202244;9380.718578442658;9565.282603804604;9790.461524616214;9867.950660246654;10057.74278215223;10096.596136154472;10234.48827558634;10516.369017858648;10623.256372053882;10636.787264254826 09:10:38 INFO - PROCESS | 23771 | __end_tp_report 09:10:38 INFO - PROCESS | 23771 | __start_cc_report 09:10:38 INFO - PROCESS | 23771 | _x_x_mozilla_cycle_collect,1150 09:10:38 INFO - PROCESS | 23771 | __end_cc_report 09:10:38 INFO - PROCESS | 23771 | __startTimestamp1467562238490__endTimestamp 09:10:38 INFO - PROCESS | 23771 | 09:10:38 INFO - PROCESS | 23771 | ------- Summary: start ------- 09:10:38 INFO - PROCESS | 23771 | Number of tests: 6 09:10:38 INFO - PROCESS | 23771 | 09:10:38 INFO - PROCESS | 23771 | [#0] dojo.html Cycles:165 Average:4801.70 Median:4921.43 stddev:510.00 (10.4%) stddev-sans-first:482.39 09:10:38 INFO - PROCESS | 23771 | Values: 2634.2 2637.4 2664.8 2684.4 2690.4 4769.5 4801.4 4837.7 4878.2 4916.1 4830.3 4838.3 4843.2 4855.9 4881.7 4376.5 4437.4 4463.8 4526.8 4634.2 4524.7 4563.4 4579.3 4587.0 4616.4 4192.2 4354.9 4391.3 4399.2 4484.8 4399.8 4405.9 4408.8 4463.4 4506.5 4424.4 4427.6 4459.4 4488.2 4503.1 4813.1 4819.7 4883.1 4890.9 4892.1 5224.4 5276.7 5299.0 5303.8 5317.0 5283.9 5305.0 5310.0 5312.3 5324.3 4711.4 4804.9 4859.2 4865.0 4940.0 5332.1 5332.6 5339.9 5388.8 5389.0 5097.5 5123.8 5125.1 5171.7 5176.6 5105.0 5134.0 5171.5 5188.3 5216.5 5121.2 5146.1 5153.8 5155.2 5188.6 5019.9 5136.8 5147.5 5150.0 5152.1 4392.7 4399.6 4450.8 4452.3 4474.1 3857.7 3868.3 3874.7 3906.6 3917.4 4503.0 4504.0 4513.1 4515.3 4547.7 5099.8 5104.6 5133.5 5151.6 5157.1 4436.4 4460.5 4462.0 4466.6 4503.8 4586.4 4664.2 4668.9 4671.5 4716.2 4868.7 4904.3 4914.6 4918.7 4927.3 5218.7 5221.0 5252.9 5256.4 5307.4 4782.0 4807.6 4921.4 4928.4 4930.1 5062.8 5092.6 5118.8 5120.1 5168.3 5185.7 5202.5 5205.2 5212.1 5253.0 4983.7 5029.1 5036.0 5039.0 5050.4 5035.2 5066.0 5069.0 5069.6 5108.0 5006.0 5017.1 5047.9 5068.3 5082.3 4988.9 4991.8 5048.4 5049.0 5104.8 4910.1 4912.4 4928.0 4950.9 4966.1 09:10:38 INFO - PROCESS | 23771 | 09:10:38 INFO - PROCESS | 23771 | [#1] ext.html Cycles:180 Average:48304.29 Median:19636.75 stddev:82859.63 (422.0%) stddev-sans-first:83014.46 09:10:38 INFO - PROCESS | 23771 | Values: 538.8 581.5 591.2 593.0 601.0 27458.9 40252.2 40682.0 41544.2 41604.8 37708.8 41542.8 41570.2 41655.4 41676.0 7528.1 7850.1 7992.6 7999.8 10248.2 10078.0 10213.0 10481.7 10485.2 10488.8 10504.2 10564.6 10568.1 10575.3 10592.4 10404.7 10446.9 10463.4 10466.6 10469.7 10345.8 10350.1 10413.1 10418.1 10432.7 40093.8 40223.6 40238.0 40252.0 40432.6 2830.0 3021.6 3472.5 3482.6 3488.5 29257.4 29539.9 29833.7 30408.0 31261.8 3535.2 3584.4 3612.2 3683.5 3690.0 263663.0 264296.0 267601.0 268025.0 268176.0 58079.4 58338.7 58346.0 58462.0 58745.4 60770.7 60878.4 60987.0 61023.7 61188.0 14825.6 15352.8 15356.6 15368.5 15371.6 10332.6 11360.1 11649.2 11739.8 12060.0 19127.1 19133.0 19145.6 19173.4 19177.4 5742.9 6879.9 6936.2 6943.8 7202.2 837.4 908.0 989.1 1027.2 1042.0 28432.9 29007.3 29033.8 29626.0 29689.3 944.8 949.0 957.9 970.9 982.3 14626.3 15120.0 15385.8 15419.8 15698.5 374317.0 374494.0 379089.0 379296.0 380182.0 50701.7 51198.0 51302.7 51352.0 51463.5 1058.5 1127.1 1132.3 1189.2 1193.0 28325.4 29432.7 29490.4 29511.6 30090.8 43527.8 44001.8 44072.0 44107.3 44127.0 289984.0 294438.0 295090.0 295103.0 296891.0 32465.7 36962.8 37755.4 38859.4 41529.8 42256.0 42818.1 43271.8 43275.0 43441.6 36684.0 36766.8 36896.0 37102.0 37424.4 36962.3 37052.4 37060.8 37453.0 37598.0 35738.3 36421.8 36928.0 37022.6 37460.6 32093.5 32436.2 33146.3 33321.0 33389.7 25256.5 25420.7 25440.0 25660.4 26082.7 09:10:38 INFO - PROCESS | 23771 | 09:10:38 INFO - PROCESS | 23771 | [#2] jquery.html Cycles:180 Average:25333.06 Median:423711.00 stddev:69456.84 (16.4%) stddev-sans-first:69626.41 09:10:38 INFO - PROCESS | 23771 | Values: 377.8 378.3 381.9 391.4 393.9 16709.8 16857.4 17378.2 17993.9 18029.5 10871.6 11183.7 11189.0 11199.2 11204.6 4466.6 4554.7 5180.2 5193.3 5193.4 5153.7 5233.2 5270.0 5277.6 5279.8 4703.1 4719.4 4724.1 4835.4 5269.0 4754.0 4755.2 4757.2 4775.5 4781.5 4629.4 4651.3 4790.6 5158.8 5159.6 12710.0 12768.9 12791.5 12907.9 22168.1 1705.1 1762.7 2229.1 2257.8 2283.6 9496.0 9694.9 9710.4 9850.1 10847.9 1716.4 1724.4 1729.8 1739.3 1792.8 71181.3 75803.6 75852.0 77037.0 77540.2 10115.3 10228.2 10511.0 10531.6 10706.4 14424.8 14446.6 14457.3 14488.3 14501.9 7244.7 7683.2 7694.8 7703.1 7737.3 7354.6 7360.4 7526.1 7538.4 7560.1 4337.1 4432.2 4473.6 4535.6 4601.7 1770.5 1793.6 1825.7 1844.8 1879.1 807.6 845.1 861.9 916.7 960.6 16639.5 17293.1 17863.1 17865.8 18428.9 810.8 854.9 880.3 884.6 888.5 9308.6 9740.4 10063.4 10108.1 10116.9 414583.0 418404.0 421292.0 422153.0 425269.0 62429.7 75508.6 79803.6 83464.0 89119.0 857.2 876.6 898.4 932.0 935.2 15970.8 16827.9 17003.2 17172.7 17320.6 27451.0 34133.0 38802.2 39757.2 40962.4 54827.7 55107.7 55565.0 57123.7 57130.4 7801.2 7831.9 7871.4 7913.5 7995.6 11440.9 12489.1 12524.4 12640.8 12675.4 9924.2 10586.9 10892.9 10902.6 10963.0 7749.0 10472.5 10611.8 11044.7 11055.1 10418.8 10895.1 11016.4 11050.4 11100.9 7678.8 7830.7 7998.4 8038.0 8371.6 10555.9 10777.1 10814.6 10855.0 10925.3 09:10:38 INFO - PROCESS | 23771 | 09:10:38 INFO - PROCESS | 23771 | [#3] mootools.html Cycles:180 Average:5280.39 Median:5217.61 stddev:2953.11 (56.6%) stddev-sans-first:2946.71 09:10:38 INFO - PROCESS | 23771 | Values: 1361.6 1403.8 1437.5 1655.9 1663.5 7635.7 8053.8 8159.0 8161.5 8169.8 6974.0 7690.3 7918.7 7947.5 7977.0 2271.3 2298.3 2304.4 2304.8 2306.2 2265.7 2280.4 2298.7 2301.8 2303.0 1890.9 1968.1 1968.7 1974.7 2202.6 2228.0 2259.4 2275.1 2278.0 2280.7 2221.5 2229.9 2248.2 2314.0 2319.4 8033.7 8068.4 8095.2 8095.9 8096.1 4474.6 4601.6 4708.0 4785.5 4794.5 2978.6 3034.4 3084.8 3094.5 3095.4 915.2 931.0 940.1 948.1 952.0 10948.6 10985.5 10989.8 10990.1 10994.7 4287.6 4403.4 4496.0 4501.0 4503.2 9217.0 9219.7 9221.8 9234.5 9240.7 4823.8 4826.6 4826.9 4830.3 4833.7 4280.6 4403.0 4403.7 4408.3 4440.8 3778.2 3793.6 3872.5 3884.4 3902.2 1208.9 1214.9 1221.4 1238.8 1271.1 717.9 815.0 845.7 853.7 888.7 5381.9 5472.5 5557.0 5573.2 5598.2 404.9 408.9 411.0 422.5 427.8 3786.9 3800.6 3906.4 3908.3 3912.5 9517.6 9600.7 9750.3 9917.3 9919.2 9704.5 9800.5 9815.5 9845.4 9852.0 7294.3 7304.4 7453.6 7464.7 7479.3 5386.6 5410.2 5522.6 5683.1 5782.2 9153.9 9170.2 9172.8 9212.3 9232.7 9055.4 9216.7 9234.8 9242.6 9350.0 7019.6 7092.3 7145.2 7158.0 7167.7 7495.4 7519.8 7563.6 7634.2 7636.5 5053.3 6731.5 6967.4 7034.4 7136.5 6791.2 6852.4 6862.7 6976.2 6981.1 6578.9 6684.2 6685.5 6685.7 6689.6 4704.6 4718.4 4820.6 4866.0 4890.9 4858.6 4870.3 4874.2 4905.5 4951.8 09:10:38 INFO - PROCESS | 23771 | 09:10:38 INFO - PROCESS | 23771 | [#4] prototype.html Cycles:180 Average:4285.28 Median:4954.53 stddev:1256.12 (25.4%) stddev-sans-first:1223.54 09:10:38 INFO - PROCESS | 23771 | Values: 301.3 308.4 311.6 317.5 320.0 4979.4 4995.4 4996.6 5008.9 5025.0 4866.5 4880.9 4899.9 4950.5 4986.7 3647.9 3768.2 3784.7 3799.0 3809.7 3690.5 3793.5 3839.9 3853.3 3876.5 3771.4 3787.6 3810.8 3814.7 3822.9 3640.7 3796.5 3810.3 3818.2 3840.8 3337.2 3337.7 3341.6 3341.9 3353.7 4790.4 4801.8 4807.8 4818.2 4882.7 4384.6 4405.1 4407.1 4415.9 4416.2 4989.2 5144.4 5148.3 5213.3 5216.9 3660.5 3677.9 3689.2 3690.3 3701.6 5432.0 5440.8 5441.9 5462.5 5469.5 3607.0 3631.1 3678.9 3699.1 3807.9 3719.8 3737.8 3749.4 3750.0 3756.6 4333.1 4335.8 4339.8 4350.6 4351.8 5084.8 5120.4 5156.8 5209.2 5231.8 1317.8 1321.9 1326.4 1331.9 1340.2 795.6 836.0 842.7 843.8 848.6 4481.8 4554.0 4562.5 4578.9 4597.3 5292.5 5304.5 5306.0 5307.1 5309.8 4443.3 4554.3 4555.4 4598.0 4606.6 2803.7 2821.5 2835.3 2837.7 2838.8 4985.4 4988.9 4994.3 5002.0 5009.9 5160.9 5446.0 5451.2 5459.3 5465.8 4975.3 4978.9 4979.9 4984.2 4999.3 5284.8 5292.0 5373.8 5376.3 5378.2 4967.5 5167.7 5209.9 5237.3 5251.5 4935.9 4958.6 4972.7 4995.5 5001.1 3761.9 3764.8 3779.6 3791.7 3811.7 5199.5 5201.9 5298.7 5372.5 5389.0 5132.9 5135.1 5148.8 5166.4 5168.1 5141.3 5147.0 5171.1 5195.0 5216.2 4843.2 5088.3 5114.5 5192.6 5199.5 4976.3 5089.4 5257.6 5262.3 5268.9 5147.8 5157.9 5216.9 5227.7 5239.5 09:10:38 INFO - PROCESS | 23771 | 09:10:38 INFO - PROCESS | 23771 | [#5] yui.html Cycles:180 Average:18531.83 Median:4425.15 stddev:27011.56 (610.4%) stddev-sans-first:27053.91 09:10:38 INFO - PROCESS | 23771 | Values: 634.4 685.5 710.2 735.5 760.0 12723.2 14860.8 15431.3 15484.7 15525.5 14849.0 14911.4 14976.8 14993.2 15049.5 627.8 763.4 777.8 790.7 794.6 792.5 796.0 798.7 799.0 799.0 840.8 841.1 841.4 842.4 842.9 653.7 785.6 813.3 814.4 818.1 604.4 604.5 604.7 604.9 605.2 11699.8 11705.7 11747.4 11786.6 11787.8 12440.8 12830.2 12837.8 13039.3 13079.3 11813.3 12055.2 12093.3 12112.9 12189.1 4150.6 4177.5 4178.5 4181.6 4232.3 61087.0 61423.7 61449.4 61546.1 61854.0 9957.4 10242.9 10276.3 10643.5 11008.5 18547.4 18933.7 18949.2 18961.2 19067.4 6969.1 6985.1 7043.1 7049.8 7127.8 3794.5 3812.1 3843.5 3854.2 3982.6 2922.1 3031.2 3040.7 3043.1 3044.4 438.8 505.5 514.7 514.8 569.0 586.9 619.6 622.9 626.0 639.0 8541.8 8689.8 8741.0 8806.9 9050.1 485.7 518.7 570.4 572.4 577.0 4376.4 4386.6 4407.9 4442.4 4515.0 99159.5 105642.0 106775.5 110100.4 110223.0 92593.5 96221.5 96379.5 96718.5 96892.0 81680.0 83662.2 83795.0 85320.0 85523.0 8356.5 8405.6 8410.2 8559.1 8577.1 46941.3 48017.0 48903.8 48927.5 49063.5 38765.4 39154.2 40129.0 48593.0 61706.4 11735.4 12030.7 12042.8 12125.8 12190.7 13250.4 13323.2 13365.7 13657.6 13798.8 12467.2 12650.4 12726.3 12824.4 13347.7 11874.8 11908.3 12947.9 12998.9 13058.5 12329.3 12741.6 12914.3 13065.5 13251.5 9380.7 9565.3 9790.5 9868.0 10057.7 10096.6 10234.5 10516.4 10623.3 10636.8 09:10:38 INFO - PROCESS | 23771 | -------- Summary: end -------- 09:10:38 INFO - PROCESS | 23771 | 09:10:39 INFO - TEST-INFO | 23771: exit 0 09:10:39 INFO - TEST-OK | dromaeo_css | took 1121969ms 09:10:39 INFO - TEST-START | kraken 09:10:39 INFO - operating with platform_type : linux_ 09:10:39 INFO - Initialising browser for kraken test... 09:10:39 INFO - TEST-INFO | started process 23961 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_iJA0e/profile http://localhost:48219/getInfo.html) 09:10:44 INFO - PROCESS | 23961 | __metrics Screen width/height:1600/1200 09:10:44 INFO - PROCESS | 23961 | colorDepth:24 09:10:44 INFO - PROCESS | 23961 | Browser inner width/height: 1024/697 09:10:44 INFO - PROCESS | 23961 | __metrics 09:10:45 INFO - PROCESS | 23961 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:10:46 INFO - TEST-INFO | 23961: exit 0 09:10:46 INFO - Browser initialized. 09:10:46 INFO - Running cycle 1/1 for kraken test... 09:10:46 INFO - TEST-INFO | started process 24042 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_iJA0e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:10:58 INFO - PROCESS | 24042 | RSS: Main: 159039488 09:10:58 INFO - PROCESS | 24042 | 09:11:01 INFO - PROCESS | 24042 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48219/tests/kraken/driver.html?testName=audio-beat-detection) 09:11:02 INFO - PROCESS | 24042 | RSS: Main: 216588288 09:11:02 INFO - PROCESS | 24042 | 09:11:04 INFO - PROCESS | 24042 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48219/tests/kraken/driver.html?testName=audio-dft) 09:11:05 INFO - PROCESS | 24042 | RSS: Main: 204480512 09:11:05 INFO - PROCESS | 24042 | 09:11:08 INFO - PROCESS | 24042 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48219/tests/kraken/driver.html?testName=audio-fft) 09:11:09 INFO - PROCESS | 24042 | RSS: Main: 271339520 09:11:09 INFO - PROCESS | 24042 | 09:11:11 INFO - PROCESS | 24042 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48219/tests/kraken/driver.html?testName=audio-oscillator) 09:11:11 INFO - PROCESS | 24042 | RSS: Main: 181714944 09:11:11 INFO - PROCESS | 24042 | 09:11:14 INFO - PROCESS | 24042 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48219/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:11:14 INFO - PROCESS | 24042 | RSS: Main: 185532416 09:11:14 INFO - PROCESS | 24042 | 09:11:17 INFO - PROCESS | 24042 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48219/tests/kraken/driver.html?testName=imaging-darkroom) 09:11:18 INFO - PROCESS | 24042 | RSS: Main: 221925376 09:11:18 INFO - PROCESS | 24042 | 09:11:22 INFO - PROCESS | 24042 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48219/tests/kraken/driver.html?testName=imaging-desaturate) 09:11:22 INFO - PROCESS | 24042 | RSS: Main: 222494720 09:11:22 INFO - PROCESS | 24042 | 09:11:25 INFO - PROCESS | 24042 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48219/tests/kraken/driver.html?testName=json-parse-financial) 09:11:26 INFO - PROCESS | 24042 | RSS: Main: 222101504 09:11:26 INFO - PROCESS | 24042 | 09:11:27 INFO - PROCESS | 24042 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48219/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:11:28 INFO - PROCESS | 24042 | RSS: Main: 209547264 09:11:28 INFO - PROCESS | 24042 | 09:11:30 INFO - PROCESS | 24042 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48219/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:11:31 INFO - PROCESS | 24042 | RSS: Main: 214204416 09:11:31 INFO - PROCESS | 24042 | 09:11:33 INFO - PROCESS | 24042 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48219/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:11:33 INFO - PROCESS | 24042 | RSS: Main: 213471232 09:11:33 INFO - PROCESS | 24042 | 09:11:36 INFO - PROCESS | 24042 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48219/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:11:37 INFO - PROCESS | 24042 | RSS: Main: 225779712 09:11:37 INFO - PROCESS | 24042 | 09:11:40 INFO - PROCESS | 24042 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48219/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:11:40 INFO - PROCESS | 24042 | RSS: Main: 227794944 09:11:40 INFO - PROCESS | 24042 | 09:11:42 INFO - PROCESS | 24042 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48219/tests/kraken/driver.html?testName=ai-astar) 09:11:42 INFO - PROCESS | 24042 | RSS: Main: 269692928 09:11:42 INFO - PROCESS | 24042 | 09:11:42 INFO - PROCESS | 24042 | __start_tp_report 09:11:42 INFO - PROCESS | 24042 | _x_x_mozilla_page_load 09:11:42 INFO - PROCESS | 24042 | _x_x_mozilla_page_load_details 09:11:42 INFO - PROCESS | 24042 | |i|pagename|runs| 09:11:42 INFO - PROCESS | 24042 | |0;ai-astar;103;114;114;114;114;113;112;112;113;113 09:11:42 INFO - PROCESS | 24042 | |1;audio-beat-detection;149;126;123;174;123;122;149;127;167;122 09:11:42 INFO - PROCESS | 24042 | |2;audio-dft;162;161;161;161;164;161;161;160;162;160 09:11:42 INFO - PROCESS | 24042 | |3;audio-fft;75;75;76;126;75;77;75;75;99;77 09:11:42 INFO - PROCESS | 24042 | |4;audio-oscillator;84;86;125;84;86;85;116;84;90;121 09:11:42 INFO - PROCESS | 24042 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;116;117;117 09:11:42 INFO - PROCESS | 24042 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;146 09:11:42 INFO - PROCESS | 24042 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;95;95 09:11:42 INFO - PROCESS | 24042 | |8;json-parse-financial;63;63;63;64;64;64;65;64;65;64 09:11:42 INFO - PROCESS | 24042 | |9;json-stringify-tinderbox;65;65;65;75;65;65;65;65;65;65 09:11:42 INFO - PROCESS | 24042 | |10;stanford-crypto-aes;82;85;79;78;89;82;79;80;79;82 09:11:42 INFO - PROCESS | 24042 | |11;stanford-crypto-ccm;131;133;135;128;128;129;128;128;176;140 09:11:42 INFO - PROCESS | 24042 | |12;stanford-crypto-pbkdf2;170;168;166;165;166;166;167;164;171;165 09:11:42 INFO - PROCESS | 24042 | |13;stanford-crypto-sha256-iterative;67;69;67;67;67;67;67;66;66;67 09:11:42 INFO - PROCESS | 24042 | __end_tp_report 09:11:42 INFO - PROCESS | 24042 | __start_cc_report 09:11:42 INFO - PROCESS | 24042 | _x_x_mozilla_cycle_collect,1912 09:11:42 INFO - PROCESS | 24042 | __end_cc_report 09:11:42 INFO - PROCESS | 24042 | __startTimestamp1467562302652__endTimestamp 09:11:42 INFO - PROCESS | 24042 | 09:11:42 INFO - PROCESS | 24042 | ------- Summary: start ------- 09:11:42 INFO - PROCESS | 24042 | Number of tests: 14 09:11:42 INFO - PROCESS | 24042 | 09:11:42 INFO - PROCESS | 24042 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.50 stddev:3.33 (2.9%) stddev-sans-first:0.83 09:11:42 INFO - PROCESS | 24042 | Values: 103.0 114.0 114.0 114.0 114.0 113.0 112.0 112.0 113.0 113.0 09:11:42 INFO - PROCESS | 24042 | 09:11:42 INFO - PROCESS | 24042 | [#1] audio-beat-detection Cycles:10 Average:138.20 Median:138.00 stddev:20.02 (14.5%) stddev-sans-first:20.84 09:11:42 INFO - PROCESS | 24042 | Values: 149.0 126.0 123.0 174.0 123.0 122.0 149.0 127.0 167.0 122.0 09:11:42 INFO - PROCESS | 24042 | 09:11:42 INFO - PROCESS | 24042 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 09:11:42 INFO - PROCESS | 24042 | Values: 162.0 161.0 161.0 161.0 164.0 161.0 161.0 160.0 162.0 160.0 09:11:42 INFO - PROCESS | 24042 | 09:11:42 INFO - PROCESS | 24042 | [#3] audio-fft Cycles:10 Average:83.00 Median:75.50 stddev:16.82 (22.3%) stddev-sans-first:17.59 09:11:42 INFO - PROCESS | 24042 | Values: 75.0 75.0 76.0 126.0 75.0 77.0 75.0 75.0 99.0 77.0 09:11:42 INFO - PROCESS | 24042 | 09:11:42 INFO - PROCESS | 24042 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:84.50 stddev:17.18 (20.3%) stddev-sans-first:17.65 09:11:42 INFO - PROCESS | 24042 | Values: 84.0 86.0 125.0 84.0 86.0 85.0 116.0 84.0 90.0 121.0 09:11:42 INFO - PROCESS | 24042 | 09:11:42 INFO - PROCESS | 24042 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:11:42 INFO - PROCESS | 24042 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 09:11:42 INFO - PROCESS | 24042 | 09:11:42 INFO - PROCESS | 24042 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 09:11:42 INFO - PROCESS | 24042 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 09:11:42 INFO - PROCESS | 24042 | 09:11:42 INFO - PROCESS | 24042 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:11:42 INFO - PROCESS | 24042 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 09:11:42 INFO - PROCESS | 24042 | 09:11:42 INFO - PROCESS | 24042 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 09:11:42 INFO - PROCESS | 24042 | Values: 63.0 63.0 63.0 64.0 64.0 64.0 65.0 64.0 65.0 64.0 09:11:42 INFO - PROCESS | 24042 | 09:11:42 INFO - PROCESS | 24042 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:65.00 stddev:3.16 (4.9%) stddev-sans-first:3.33 09:11:42 INFO - PROCESS | 24042 | Values: 65.0 65.0 65.0 75.0 65.0 65.0 65.0 65.0 65.0 65.0 09:11:42 INFO - PROCESS | 24042 | 09:11:42 INFO - PROCESS | 24042 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:82.00 stddev:3.37 (4.1%) stddev-sans-first:3.57 09:11:42 INFO - PROCESS | 24042 | Values: 82.0 85.0 79.0 78.0 89.0 82.0 79.0 80.0 79.0 82.0 09:11:42 INFO - PROCESS | 24042 | 09:11:42 INFO - PROCESS | 24042 | [#11] stanford-crypto-ccm Cycles:10 Average:135.60 Median:132.00 stddev:14.74 (11.2%) stddev-sans-first:15.54 09:11:42 INFO - PROCESS | 24042 | Values: 131.0 133.0 135.0 128.0 128.0 129.0 128.0 128.0 176.0 140.0 09:11:42 INFO - PROCESS | 24042 | 09:11:42 INFO - PROCESS | 24042 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:166.50 stddev:2.25 (1.4%) stddev-sans-first:2.07 09:11:42 INFO - PROCESS | 24042 | Values: 170.0 168.0 166.0 165.0 166.0 166.0 167.0 164.0 171.0 165.0 09:11:42 INFO - PROCESS | 24042 | 09:11:42 INFO - PROCESS | 24042 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 09:11:42 INFO - PROCESS | 24042 | Values: 67.0 69.0 67.0 67.0 67.0 67.0 67.0 66.0 66.0 67.0 09:11:42 INFO - PROCESS | 24042 | -------- Summary: end -------- 09:11:42 INFO - PROCESS | 24042 | 09:11:43 INFO - TEST-INFO | 24042: exit 0 09:11:43 INFO - TEST-OK | kraken | took 64426ms 09:11:43 INFO - SUITE-END | took 1186s 09:11:43 INFO - Completed test suite (00:19:46) 09:11:43 INFO - javascript benchmark 09:11:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2634.249238966894, 2637.3670319123416, 2664.8267862588937, 2684.4362683836393, 2690.4215593647364, 4769.475357710658, 4801.375821143255, 4837.709737415757, 4878.243872199806, 4916.139675556777, 4830.347903033089, 4838.34682317887, 4843.249296359061, 4855.854324370274, 4881.707097574148, 4376.452943382077, 4437.35658329542, 4463.821447142127, 4526.841560545382, 4634.189016922042, 4524.68327217095, 4563.429571303587, 4579.267317229244, 4586.954130458686, 4616.3537104805355, 4192.224438478891, 4354.869353919387, 4391.253486907233, 4399.208142534342, 4484.775761211927, 4399.824007039714, 4405.933910991338, 4408.845690400853, 4463.419755431805, 4506.526814684444, 4424.380586717862, 4427.579379958899, 4459.420275364214, 4488.192125417424, 4503.076869241798, 4813.133635945528, 4819.734914579697, 4883.096627123993, 4890.853274401774, 4892.094962431962, 5224.39919409269, 5276.657017293864, 5299.019681358961, 5303.840884773463, 5317.042932272189, 5283.9471605284225, 5304.973475132639, 5310.0441920454305, 5312.282841816383, 5324.254604355355, 4711.434627844681, 4804.879878003008, 4859.198232291703, 4864.975675121602, 4939.950600493985, 5332.066888294533, 5332.573394128461, 5339.86650333737, 5388.8113916013535, 5388.976094542025, 5097.541221290027, 5123.846284611468, 5125.051865404912, 5171.741412929338, 5176.611754118456, 5104.9744751276, 5134.0, 5171.482851714798, 5188.299579556787, 5216.478352164829, 5121.180611102281, 5146.125158722951, 5153.819616313411, 5155.200943853709, 5188.584913206934, 5019.924701129486, 5136.794528218904, 5147.536721695065, 5150.0472412603785, 5152.124138896396, 4392.7364358137975, 4399.560043995639, 4450.799714012877, 4452.30989196675, 4474.149911516802, 3857.672097871712, 3868.2650296443585, 3874.748141370802, 3906.5898080701118, 3917.4319723639915, 4503.0, 4504.031633198812, 4513.052259025641, 4515.277555591089, 4547.727136371828, 5099.796008159707, 5104.642675012714, 5133.486651334837, 5151.639385243072, 5157.149070403417, 4436.378906953029, 4460.50934397216, 4462.0, 4466.553344665507, 4503.752293623882, 4586.3579098926175, 4664.183767840615, 4668.85993420198, 4671.462781780071, 4716.221823399169, 4868.659193856467, 4904.313396124617, 4914.557689807934, 4918.6556941015215, 4927.334809800775, 5218.739063046756, 5220.973895130652, 5252.89494210106, 5256.369235691742, 5307.389650190277, 4782.043591281688, 4807.567318941172, 4921.434035086011, 4928.408590969107, 4930.112579735682, 5062.797488100582, 5092.643514954066, 5118.795248190179, 5120.103981803095, 5168.328117344721, 5185.688858668492, 5202.453742357149, 5205.167173252262, 5212.061828870839, 5253.001929633358, 4983.651144419856, 5029.119904016856, 5035.974820126023, 5038.967011762506, 5050.39395272555, 5035.244713293036, 5065.974670126626, 5069.0, 5069.6197785167, 5108.029474399852, 5006.0, 5017.147084995487, 5047.87380315495, 5068.341115654941, 5082.313887625123, 4988.8752781180765, 4991.80032798684, 5048.444671086104, 5048.974755126201, 5104.795808167632, 4910.091633047898, 4912.410510738591, 4928.039032388793, 4950.8762280943265, 4966.056449274771], "value": 4768.343362842353, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.7510770486598, 581.482480592273, 591.1841658511255, 592.9673867937262, 600.9969950150248, 27458.862705686468, 40252.194956100895, 40682.0, 41544.169116617646, 41604.79197604016, 37708.81145594275, 41542.79228603853, 41570.16859662805, 41655.375169372404, 41675.95810104749, 7528.096628404599, 7850.097238817552, 7992.560409177493, 7999.760007199764, 10248.180145588334, 10078.0, 10213.0, 10481.737956551071, 10485.213608979318, 10488.842667359995, 10504.212184086224, 10564.630237941674, 10568.101711354506, 10575.312604680672, 10592.364458132537, 10404.687859364194, 10446.9477652612, 10463.372197668165, 10466.63366782159, 10469.68590942273, 10345.844812327747, 10350.068493835592, 10413.062824345845, 10418.11446027081, 10432.687019389354, 40093.79953100245, 40223.59776402228, 40238.0, 40252.0, 40432.59567404347, 2829.952917420547, 3021.561873528326, 3472.461768425898, 3482.6343233960324, 3488.476728490721, 29257.41485170306, 29539.852300738574, 29833.70166298331, 30408.0, 31261.84369078163, 3535.222251104753, 3584.426491761306, 3612.187257866959, 3683.4658974448553, 3690.0036990012813, 263663.0, 264296.0, 267601.0, 268024.999999998, 268176.0, 58079.41920580825, 58338.70830645905, 58346.0, 58462.0, 58745.412545874846, 60770.65761383167, 60878.39121608727, 60987.0, 61023.69488152619, 61188.0, 14825.629359266104, 15352.769708454382, 15356.616084597974, 15368.538943831703, 15371.61570960735, 10332.638357657446, 11360.147988900866, 11649.242799218024, 11739.765204696028, 12060.0, 19127.13927873249, 19133.0, 19145.617087658167, 19173.424797255826, 19177.424677259703, 5742.856428589235, 6879.862402751917, 6936.237013928464, 6943.79168624942, 7202.171750248684, 837.3510529339688, 907.9682211122711, 989.1345073061071, 1027.2347101409498, 1042.0, 28432.85783571069, 29007.274818129714, 29033.838646453903, 29626.0, 29689.25776855596, 944.7968686732386, 949.002350053142, 957.9329446938787, 970.8834939807268, 982.3123813330698, 14626.268686565842, 15120.0, 15385.84614153844, 15419.845801541842, 15698.450554230547, 374317.0, 374494.0, 379089.0, 379296.0, 380182.0, 50701.74649126731, 51198.0, 51302.74348628233, 51352.0, 51463.48536514587, 1058.4601853054996, 1127.132108276606, 1132.3432409202642, 1189.2448295332354, 1192.9880701193224, 28325.433491329644, 29432.705672942997, 29490.410191796473, 29511.55732663969, 30090.84954575213, 43527.78236108926, 44001.799910005015, 44072.0, 44107.338389923534, 44127.0, 289984.0, 294438.0, 295090.0, 295103.0, 296891.0, 32465.675343246265, 36962.8151859239, 37755.43366849444, 38859.41710874395, 41529.79235103805, 42256.0, 42818.14363712646, 43271.783641081594, 43275.0, 43441.56558434375, 36684.0, 36766.81616592007, 36896.0, 37102.0, 37424.43863341997, 36962.26075478529, 37052.44421333628, 37060.81469592742, 37453.0, 37598.0, 35738.28523429569, 36421.81789091037, 36928.0, 37022.62977370192, 37460.625393745715, 32093.518597221526, 32436.189095271864, 33146.33707325792, 33321.0, 33389.66610333963, 25256.45383830928, 25420.745792542577, 25440.0, 25660.358491037874, 26082.73917260803], "value": 18730.23821329832, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.83941824724485, 378.30580884077716, 381.9369803982343, 391.3640334456508, 393.9015246188453, 16709.83290167098, 16857.40999065033, 17378.21798019089, 17993.91003044986, 18029.549261268457, 10871.619493317736, 11183.664490065312, 11189.048930840889, 11199.216054876162, 11204.551817927273, 4466.598006179452, 4554.747444452769, 5180.2488639147305, 5193.272941788134, 5193.376794784613, 5153.716545589991, 5233.162693968966, 5269.973650131744, 5277.6305658603915, 5279.762410691509, 4703.129920964632, 4719.4100737407825, 4724.078804633098, 4835.443923948756, 5268.973655131719, 4754.049190161982, 4755.167845627001, 4757.238841785298, 4775.498572649856, 4781.474037855833, 4629.3518907353, 4651.279051746985, 4790.592799612003, 5158.793648254065, 5159.58723302135, 12710.0, 12768.872311276862, 12791.48834046637, 12907.870921290762, 22168.11327546896, 1705.0877780387557, 1762.6827171109196, 2229.1306390507716, 2257.808086312665, 2283.6346184610384, 9495.952520237355, 9694.903050969471, 9710.417374957526, 9850.064243896819, 10847.945760271226, 1716.4335769196136, 1724.3619860651638, 1729.8356656117649, 1739.3390511605635, 1792.8117547657569, 71181.28818711799, 75803.62098189474, 75852.0, 77037.0, 77540.22459775387, 10115.342502737298, 10228.181745460346, 10511.0, 10531.578736850593, 10706.357618542912, 14424.783628245585, 14446.566603001927, 14457.349419276157, 14488.34802433893, 14501.927490362481, 7244.673989670478, 7683.193264707237, 7694.846103077907, 7703.075630924325, 7737.3036426721865, 7354.558726476428, 7360.411167106618, 7526.059242594676, 7538.434617403716, 7560.092788865371, 4337.132573485315, 4432.246518091868, 4473.597376236155, 4535.614472769786, 4601.746903920316, 1770.4600096970548, 1793.5516120969758, 1825.6896327624336, 1844.843188329007, 1879.1355976250804, 807.5598798654747, 845.1084106267823, 861.8836457078214, 916.6608354908593, 960.6013504395597, 16639.50081497557, 17293.13534323304, 17863.106844657716, 17865.821341786675, 18428.90785546064, 810.8337790753, 854.9444286121383, 880.3001613716982, 884.6151923913119, 888.493558671564, 9308.627654893864, 9740.415575065519, 10063.39619622825, 10108.1408080314, 10116.949415252877, 414583.0, 418404.0, 421292.0, 422153.0, 425269.0, 62429.68785156136, 75508.62245688736, 79803.60098199472, 83464.0, 89119.0, 857.1685465098844, 876.5704804645806, 898.3980732908967, 931.9813603727888, 935.1957316707626, 15970.840291596935, 16827.915860421108, 17003.234854431827, 17172.656546869242, 17320.566985825455, 27451.039213627428, 34132.97601071972, 38802.223955521295, 39757.2048559033, 40962.385564217155, 54827.72586137203, 55107.72446137744, 55565.0, 57123.714381427824, 57130.428695714174, 7801.180876008165, 7831.921680783119, 7871.409644276588, 7913.525188488479, 7995.560244186626, 11440.94279528597, 12489.125761196628, 12524.37378131108, 12640.810387844374, 12675.429605667952, 9924.15644670211, 10586.947065264932, 10892.945535272273, 10902.618408355669, 10963.0, 7749.0, 10472.528736207041, 10611.787764244826, 11044.723881902695, 11055.0603198729, 10418.843717344398, 10895.128389728961, 11016.449177541252, 11050.447477625925, 11100.944495277796, 7678.769636910902, 7830.686772529263, 7998.440109192301, 8037.959810201145, 8371.581420929051, 10555.89444105549, 10777.137828973506, 10814.621488247874, 10855.0, 10925.289856159325], "value": 8199.11867925217, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.5711051018927, 1403.810485584446, 1437.4896911596384, 1655.8758093143, 1663.4760050584066, 7635.656395462203, 8053.838923221547, 8159.0, 8161.469504482212, 8169.795755106125, 6973.965130174354, 7690.3078722914925, 7918.683252669886, 7947.4834135781275, 7976.96011519943, 2271.3072512883564, 2298.333483289844, 2304.435413323738, 2304.758000409958, 2306.1582522379294, 2265.660150977358, 2280.407094155515, 2298.6552017197387, 2301.838871279011, 2303.0327262549768, 1890.867639265245, 1968.0553334399426, 1968.7046942958527, 1974.7334109895123, 2202.581509513195, 2227.9777202227933, 2259.423846919025, 2275.055851821492, 2277.977220227793, 2280.692106565609, 2221.5334779696122, 2229.888505574731, 2248.190651365507, 2314.0165429692483, 2319.431739223884, 8033.718819841278, 8068.435209535276, 8095.1904809519165, 8095.919040809576, 8096.10942796292, 4474.642028637733, 4601.585857272861, 4708.0113176233035, 4785.49752276013, 4794.5205479452125, 2978.568107624404, 3034.408290383376, 3084.830334331611, 3094.4584697677815, 3095.411871744361, 915.2220612479339, 931.03637734944, 940.0693313619536, 948.0661548374845, 951.9952400238024, 10948.562057517769, 10985.450727463594, 10989.780204395867, 10990.120790336834, 10994.670159895137, 4287.571242875688, 4403.4495688039, 4495.955040449619, 4500.977495112504, 4503.211937910853, 9217.0, 9219.723408297761, 9221.81556368869, 9234.49210293427, 9240.722778316662, 4823.807047718122, 4826.565609095198, 4826.855194344175, 4830.29960655703, 4833.709977401367, 4280.59334363235, 4403.009322902385, 4403.713758605681, 4408.25059739845, 4440.822367105344, 3778.1876896466842, 3793.6016718244737, 3872.457855900176, 3884.3979183226643, 3902.23906338267, 1208.9093318001185, 1214.8845859643498, 1221.4137214137263, 1238.8327575777334, 1271.0784681106124, 717.8564287142488, 814.9918500815035, 845.6659619450405, 853.6628031927354, 888.7111688701198, 5381.919271210857, 5472.534834539029, 5556.97221513898, 5573.191887176417, 5598.216249725042, 404.8906795165289, 408.9488813898263, 410.99383509246786, 422.4719101123595, 427.80534856640156, 3786.8863934082024, 3800.638939300817, 3906.3554513504955, 3908.2965066288343, 3912.4522566840665, 9517.5717092731, 9600.711978640651, 9750.317477776487, 9917.256205784452, 9919.156871665846, 9704.514774261259, 9800.509974501247, 9815.460149691835, 9845.360051596623, 9851.950740246253, 7294.270572942663, 7304.379127774198, 7453.627318634047, 7464.70141194357, 7479.289467500579, 5386.622936394571, 5410.215518749838, 5522.5581953442825, 5683.090705487102, 5782.190493330853, 9153.908460915305, 9170.220531254652, 9172.770680733034, 9212.263018958332, 9232.723018309462, 9055.36612437123, 9216.723498295061, 9234.769130771785, 9242.584083716383, 9350.0, 7019.613921234381, 7092.326229008236, 7145.214026456982, 7157.964210178916, 7167.7132914682825, 7495.362894154058, 7519.8496030077995, 7563.584002879895, 7634.236576342321, 7636.465447418627, 5053.29253904461, 6731.461483081243, 6967.372936435542, 7034.366906978396, 7136.536125151849, 6791.2190098139345, 6852.417544508772, 6862.725490980305, 6976.162860456778, 6981.057557229709, 6578.868422631616, 6684.197896252481, 6685.53201275906, 6685.665716714242, 6689.5986240825705, 4704.600108990638, 4718.386609740849, 4820.566149046603, 4866.0, 4890.853274401631, 4858.58702010333, 4870.2938073979785, 4874.171390863491, 4905.460399355997, 4951.8266860659705], "value": 4179.132473196628, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.3340517456421, 308.4432599158519, 311.6244924865537, 317.5015226095032, 319.9968000319998, 4979.427365852924, 4995.350604421429, 4996.625253106014, 5008.874778130548, 5025.045241404131, 4866.489018653044, 4880.926786098203, 4899.864086984333, 4950.504949505057, 4986.728384262008, 3647.945280820783, 3768.189839184575, 3784.6593806557403, 3798.9620103799025, 3809.7047004018627, 3690.5202323698018, 3793.525809273841, 3839.9424008639894, 3853.323804145206, 3876.5154355705536, 3771.358868992278, 3787.5833658297565, 3810.8094595270263, 3814.713896457763, 3822.9426558601645, 3640.7087433005295, 3796.468494410785, 3810.276047550984, 3818.2363527294515, 3840.7695538267653, 3337.215754297738, 3337.6829201225846, 3341.6107483149663, 3341.8830340937952, 3353.748468864845, 4790.4251489821445, 4801.759912004386, 4807.807687692488, 4818.204996175627, 4882.6826256293225, 4384.583464570861, 4405.11897620474, 4407.140607581523, 4415.911681766379, 4416.1609294233995, 4989.201727723583, 5144.4083930348115, 5148.330717006766, 5213.296205012351, 5216.947830521684, 3660.5058317127377, 3677.8528858845616, 3689.206820533598, 3690.2619476104887, 3701.648343407372, 5431.972840135813, 5440.809571665012, 5441.945580544223, 5462.453754624546, 5469.480399362054, 3606.981254040067, 3631.128529153037, 3678.8528458861347, 3699.1491956849536, 3807.923841523154, 3719.8326075326136, 3737.7944213068, 3749.4000959846294, 3749.962500374961, 3756.6055564165918, 4333.111712099012, 4335.783210839445, 4339.826406943687, 4350.586694264103, 4351.760653164107, 5084.822031228963, 5120.434663214471, 5156.819511317086, 5209.166533354645, 5231.8168864089575, 1317.762802695524, 1321.9206847589176, 1326.4495234477583, 1331.8801307882336, 1340.1958824705098, 795.6315137962695, 835.9791005224796, 842.650300125441, 843.7763992541982, 848.5545088828414, 4481.75350355727, 4553.977230113828, 4562.498125206224, 4578.908421831545, 4597.310403439444, 5292.52367286946, 5304.522592966651, 5305.973470132624, 5307.124324486494, 5309.787608495617, 4443.289073748185, 4554.294084416854, 4555.430571178603, 4597.977010114928, 4606.608438282784, 2803.6915939246664, 2821.548552231633, 2835.3478699899138, 2837.744602985741, 2838.7587055100134, 4985.401751789808, 4988.850334489971, 4994.275830004629, 5002.0, 5009.947910938671, 5160.8967820643375, 5445.9727701362035, 5451.209574611659, 5459.344878614592, 5465.836024919259, 4975.253711943237, 4978.850634480971, 4979.875503112378, 4984.177610694195, 4999.3000979862845, 5284.841454756363, 5291.973540132275, 5373.758180881948, 5376.274202982548, 5378.220158076979, 4967.528084831935, 5167.741612919263, 5209.921851172311, 5237.2667826505085, 5251.52736253739, 4935.851924442272, 4958.553730164303, 4972.65191436596, 4995.475475075064, 5001.07415678705, 3761.8683346082757, 3764.7741135531955, 3779.5842457330223, 3791.677707394792, 3811.6760075393904, 5199.454057324077, 5201.855591769805, 5298.655587386807, 5372.516473517402, 5389.039056293543, 5132.871678208075, 5135.075686376488, 5148.845534633817, 5166.4316925138955, 5168.121419358643, 5141.28022076902, 5147.0, 5171.146760784429, 5194.97402512985, 5216.165413533817, 4843.183806072722, 5088.313077734459, 5114.514121158484, 5192.636515443883, 5199.48005199477, 4976.253561965734, 5089.389273287081, 5257.553107985864, 5262.263283140287, 5268.894622107613, 5147.794088236428, 5157.922631160461, 5216.869578260574, 5227.686338819683, 5239.528442440199], "value": 3885.526603256022, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.4131678197667, 685.5475386245082, 710.2484379501137, 735.4961851131978, 760.0081893129467, 12723.236605803646, 14860.777088343684, 15431.305591248392, 15484.690306193883, 15525.456609018687, 14849.03481273719, 14911.403543858232, 14976.775348369783, 14993.175375354378, 15049.548513544583, 627.8367624417662, 763.3931024835241, 777.7899967008918, 790.6521130702502, 794.5868148562744, 792.4848848248627, 795.9761207163765, 798.6805277888833, 798.9600519973978, 798.9760307190794, 840.8276303357827, 841.146236569882, 841.4194205997873, 842.3555979675554, 842.873568964654, 653.7025653327725, 785.6071964017963, 813.3411936331531, 814.4014149600039, 818.1450384348311, 604.4046614085123, 604.5284677951205, 604.7006731667809, 604.9425304596057, 605.2283338743093, 11699.766004679945, 11705.70735731605, 11747.353895535742, 11786.646400607995, 11787.764244715057, 12440.81338779919, 12830.230186188859, 12837.807432888514, 13039.282839443827, 13079.346032698328, 11813.254065395997, 12055.15613907018, 12093.274403535816, 12112.878871211264, 12189.146759726822, 4150.564190759957, 4177.519585247705, 4178.498580170369, 4181.6236538711355, 4232.25935461293, 61087.0, 61423.69288153531, 61449.38550614481, 61546.0768088479, 61854.0, 9957.352772069793, 10242.897571024194, 10276.332038417479, 10643.46782660864, 11008.504617292241, 18547.35084272044, 18933.715994260096, 18949.24203031891, 18961.24155033811, 19067.427977160707, 6969.0940177776565, 6985.126859142607, 7043.084399028094, 7049.7885063448175, 7127.786166415016, 3794.487744154559, 3812.085099576137, 3843.530471927776, 3854.209886973164, 3982.6415622594104, 2922.1379692990618, 3031.227037105568, 3040.7263346298496, 3043.0566524377514, 3044.360684256331, 438.7762241256918, 505.4970304546926, 514.7271945868696, 514.8455463360976, 568.982930512077, 586.9354371019184, 619.6003577692453, 622.8785386849612, 626.0, 638.9648569328639, 8541.829163416696, 8689.826203475895, 8741.0, 8806.86789698155, 9050.094990500897, 485.7377016411169, 518.7069305842188, 570.4381184533231, 572.4275724275724, 576.9884602307931, 4376.387305777193, 4386.561343865652, 4407.867763967022, 4442.42248507692, 4515.0, 99159.50420247852, 105642.0, 106775.46612266889, 110100.449497752, 110223.0, 92593.5370323144, 96221.51889240649, 96379.51810241044, 96718.51640741751, 96892.0, 81680.0, 83662.16337836544, 83795.0, 85320.0, 85522.99999999875, 8356.456830306011, 8405.579721014046, 8410.201030902055, 8559.144085591392, 8577.099404562681, 46941.295880561134, 48017.0, 48903.75548122237, 48927.510724892294, 49063.50936490589, 38765.41851872168, 39154.216915662095, 40129.0, 48593.0, 61706.38293617006, 11735.354555499529, 12030.699232519257, 12042.819357709466, 12125.75748485043, 12190.695232619255, 13250.403731832284, 13323.200607963554, 13365.732685346044, 13657.590272291847, 13798.793018104536, 12467.189632673848, 12650.430730617329, 12726.300053497147, 12824.422900969665, 13347.66630834237, 11874.821877672015, 11908.345041022827, 12947.870521294666, 12998.870011299767, 13058.477660893837, 12329.321887296284, 12741.617751467471, 12914.289714065817, 13065.477380904656, 13251.469941202244, 9380.718578442658, 9565.282603804604, 9790.461524616214, 9867.950660246654, 10057.74278215223, 10096.596136154472, 10234.48827558634, 10516.369017858648, 10623.256372053882, 10636.787264254826], "value": 6816.503217735855, "unit": "score"}], "name": "dromaeo_css", "value": 6578.663895940558, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 114.0, 114.0, 114.0, 113.0, 112.0, 112.0, 113.0, 113.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 123.0, 174.0, 123.0, 122.0, 149.0, 127.0, 167.0, 122.0], "value": 138.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 164.0, 161.0, 161.0, 160.0, 162.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 126.0, 75.0, 77.0, 75.0, 75.0, 99.0, 77.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 125.0, 84.0, 86.0, 85.0, 116.0, 84.0, 90.0, 121.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 64.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 75.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 79.0, 78.0, 89.0, 82.0, 79.0, 80.0, 79.0, 82.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 133.0, 135.0, 128.0, 128.0, 129.0, 128.0, 128.0, 176.0, 140.0], "value": 135.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 166.0, 165.0, 166.0, 166.0, 167.0, 164.0, 171.0, 165.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 66.0, 67.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1529.2999999999997, "alertThreshold": 2.0}]} 09:11:43 INFO - Return code: 0 09:11:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:11:43 INFO - # TBPL SUCCESS # 09:11:43 INFO - Running post-action listener: _resource_record_post_action 09:11:43 INFO - ##### 09:11:43 INFO - ##### Finished run-tests step (success) 09:11:43 INFO - ##### 09:11:43 INFO - Running post-run listener: _resource_record_post_run 09:11:44 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 53248; Write bytes: 554610688; Read time: 84; Write time: 1651388 09:11:44 INFO - TinderboxPrint: CPU usage
13.1% 09:11:44 INFO - TinderboxPrint: I/O read bytes / time
53,248 / 84 09:11:44 INFO - TinderboxPrint: I/O write bytes / time
554,610,688 / 1,651,388 09:11:44 INFO - TinderboxPrint: CPU idle
8,350.9 (86.9%) 09:11:44 INFO - TinderboxPrint: CPU user
1,200.7 (12.5%) 09:11:44 INFO - TinderboxPrint: Swap in / out
0 / 0 09:11:44 INFO - install - Wall time: 17s; CPU: 20.0%; Read bytes: 36864; Write bytes: 260136960; Read time: 52; Write time: 1067212 09:11:44 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 12288; Write bytes: 294473728; Read time: 20; Write time: 584176 09:11:44 INFO - Running post-run listener: _upload_blobber_files 09:11:44 INFO - Blob upload gear active. 09:11:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:11:44 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 09:11:44 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'] 09:11:44 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 09:11:44 INFO - (blobuploader) - INFO - Open directory for files ... 09:11:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:11:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:11:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:48 INFO - (blobuploader) - INFO - Done attempting. 09:11:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:11:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:11:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:49 INFO - (blobuploader) - INFO - Done attempting. 09:11:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:11:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:11:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:50 INFO - (blobuploader) - INFO - Done attempting. 09:11:50 INFO - (blobuploader) - INFO - Iteration through files over. 09:11:50 INFO - Return code: 0 09:11:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:11:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:11:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/889080dca9441656887d7a0c3a97d1a47d78e081558b2973296c851e2c1cc0d3eabc3a9ac74b0b2452656ff876445709b248b04a00e12bda90400f6ad36c4f0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20748241558d2c2c977e595a07b60ab2ce4528a17d4b0258e9a8a6672feb6d50b0f6dae527c07b690a72a5000f07233544ced490a15841412cf82eeed3c9eac9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/325ae4f945c96ecf3f9152c4ca480ba784da155122114c2c438717f9c95d0256e767b54af7662910eb875382c946306dda2738a4bf747598d4f07c9f49560c0d"} 09:11:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:11:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:11:50 INFO - Contents: 09:11:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/889080dca9441656887d7a0c3a97d1a47d78e081558b2973296c851e2c1cc0d3eabc3a9ac74b0b2452656ff876445709b248b04a00e12bda90400f6ad36c4f0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20748241558d2c2c977e595a07b60ab2ce4528a17d4b0258e9a8a6672feb6d50b0f6dae527c07b690a72a5000f07233544ced490a15841412cf82eeed3c9eac9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/325ae4f945c96ecf3f9152c4ca480ba784da155122114c2c438717f9c95d0256e767b54af7662910eb875382c946306dda2738a4bf747598d4f07c9f49560c0d"} 09:11:50 INFO - Running post-run listener: copy_logs_to_upload_dir 09:11:50 INFO - Copying logs to upload dir... 09:11:50 INFO - mkdir: /builds/slave/test/build/upload/logs 09:11:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.085953 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-03 09:11:49.779660) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 09:11:49.784894) ========= 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=df17445c3590ff7897617a0e00000225-1467551213.188260-173911275 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/889080dca9441656887d7a0c3a97d1a47d78e081558b2973296c851e2c1cc0d3eabc3a9ac74b0b2452656ff876445709b248b04a00e12bda90400f6ad36c4f0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20748241558d2c2c977e595a07b60ab2ce4528a17d4b0258e9a8a6672feb6d50b0f6dae527c07b690a72a5000f07233544ced490a15841412cf82eeed3c9eac9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/325ae4f945c96ecf3f9152c4ca480ba784da155122114c2c438717f9c95d0256e767b54af7662910eb875382c946306dda2738a4bf747598d4f07c9f49560c0d"} build_url:https://queue.taskcluster.net/v1/task/RDuPuFCARFuoCVSOkZmYGg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011284 build_url: 'https://queue.taskcluster.net/v1/task/RDuPuFCARFuoCVSOkZmYGg/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/889080dca9441656887d7a0c3a97d1a47d78e081558b2973296c851e2c1cc0d3eabc3a9ac74b0b2452656ff876445709b248b04a00e12bda90400f6ad36c4f0f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20748241558d2c2c977e595a07b60ab2ce4528a17d4b0258e9a8a6672feb6d50b0f6dae527c07b690a72a5000f07233544ced490a15841412cf82eeed3c9eac9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/325ae4f945c96ecf3f9152c4ca480ba784da155122114c2c438717f9c95d0256e767b54af7662910eb875382c946306dda2738a4bf747598d4f07c9f49560c0d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 09:11:49.809705) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 09:11:49.809997) ========= 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=df17445c3590ff7897617a0e00000225-1467551213.188260-173911275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 09:11:49.894211) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 09:11:49.894532) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 09:11:49.894809) ========= ========= Total master_lag: 0.17 =========