builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1467255840.95 results: success (0) buildid: 20160629173007 builduid: e8c934793dd14f30acf817aa1e0cb29d revision: 196a5285e75c5f5b75c0029c49a9662f7e5822de ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 20:04:00.951520) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 20:04:00.951936) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 20:04:00.952243) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 20:04:00.968383) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 20:04:00.968641) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1467253861.786744-1310156976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-29 20:04: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 87.1M=0s 2016-06-29 20:04:01 (87.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127526 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 20:04:01.111274) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 20:04:01.111550) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1467253861.786744-1310156976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016837 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 20:04:01.163693) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-29 20:04:01.164305) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 196a5285e75c5f5b75c0029c49a9662f7e5822de --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 196a5285e75c5f5b75c0029c49a9662f7e5822de --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=e0e61f6f900f4dc42e3e8956000001ad-1467253861.786744-1310156976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 20:04:02,123 truncating revision to first 12 chars 2016-06-29 20:04:02,123 Setting DEBUG logging. 2016-06-29 20:04:02,123 attempt 1/10 2016-06-29 20:04:02,123 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/196a5285e75c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 20:04:02,987 unpacking tar archive at: fx-team-196a5285e75c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.318336 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-29 20:04:02.499784) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 20:04:02.500110) ========= script_repo_revision: 196a5285e75c5f5b75c0029c49a9662f7e5822de ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 20:04:02.500525) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 20:04:02.500829) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 20:04:02.511661) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-29 20:04:02.512044) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=e0e61f6f900f4dc42e3e8956000001ad-1467253861.786744-1310156976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:04:03 INFO - MultiFileLogger online at 20160629 20:04:03 in /builds/slave/test 20:04:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:04:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:04:03 INFO - {'append_to_log': False, 20:04:03 INFO - 'base_work_dir': '/builds/slave/test', 20:04:03 INFO - 'blob_upload_branch': 'Fx-Team', 20:04:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:04:03 INFO - 'branch': 'Fx-Team', 20:04:03 INFO - 'buildbot_json_path': 'buildprops.json', 20:04:03 INFO - 'config_files': ('talos/linux_config.py',), 20:04:03 INFO - 'default_actions': ('clobber', 20:04:03 INFO - 'read-buildbot-config', 20:04:03 INFO - 'download-and-extract', 20:04:03 INFO - 'populate-webroot', 20:04:03 INFO - 'create-virtualenv', 20:04:03 INFO - 'install', 20:04:03 INFO - 'run-tests'), 20:04:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:04:03 INFO - 'download_minidump_stackwalk': True, 20:04:03 INFO - 'download_symbols': 'ondemand', 20:04:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:04:03 INFO - 'tooltool.py': '/tools/tooltool.py', 20:04:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:04:03 INFO - '/tools/misc-python/virtualenv.py')}, 20:04:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:04:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:04:03 INFO - 'installer_path': 'installer.exe', 20:04:03 INFO - 'log_level': 'info', 20:04:03 INFO - 'log_name': 'talos', 20:04:03 INFO - 'log_to_console': True, 20:04:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:04:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:04:03 INFO - 'opt_config_files': (), 20:04:03 INFO - 'pip_index': False, 20:04:03 INFO - 'sps_profile': False, 20:04:03 INFO - 'sps_profile_interval': 0, 20:04:03 INFO - 'suite': 'dromaeojs', 20:04:03 INFO - 'system_bits': '32', 20:04:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:04:03 INFO - 'title': 'talos-linux64-ix-067', 20:04:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:04:03 INFO - 'use_talos_json': True, 20:04:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:04:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:04:03 INFO - 'work_dir': 'build'} 20:04:03 INFO - ##### 20:04:03 INFO - ##### Running clobber step. 20:04:03 INFO - ##### 20:04:03 INFO - Running pre-action listener: _resource_record_pre_action 20:04:03 INFO - Running main action method: clobber 20:04:03 INFO - rmtree: /builds/slave/test/build 20:04:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:04:04 INFO - Running post-action listener: _resource_record_post_action 20:04:04 INFO - ##### 20:04:04 INFO - ##### Finished clobber step (success) 20:04:04 INFO - ##### 20:04:04 INFO - ##### 20:04:04 INFO - ##### Running read-buildbot-config step. 20:04:04 INFO - ##### 20:04:04 INFO - Running pre-action listener: _resource_record_pre_action 20:04:04 INFO - Running main action method: read_buildbot_config 20:04:04 INFO - Using buildbot properties: 20:04:04 INFO - { 20:04:04 INFO - "project": "", 20:04:04 INFO - "product": "firefox", 20:04:04 INFO - "script_repo_revision": "production", 20:04:04 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:04:04 INFO - "repository": "", 20:04:04 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:04:04 INFO - "buildid": "20160629173007", 20:04:04 INFO - "pgo_build": "True", 20:04:04 INFO - "basedir": "/builds/slave/test", 20:04:04 INFO - "buildnumber": 1290, 20:04:04 INFO - "slavename": "talos-linux64-ix-067", 20:04:04 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:04:04 INFO - "platform": "ubuntu64_hw", 20:04:04 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:04:04 INFO - "branch": "fx-team", 20:04:04 INFO - "repo_path": "integration/fx-team", 20:04:04 INFO - "revision": "196a5285e75c5f5b75c0029c49a9662f7e5822de", 20:04:04 INFO - "stage_platform": "linux64-pgo", 20:04:04 INFO - "builduid": "e8c934793dd14f30acf817aa1e0cb29d", 20:04:04 INFO - "slavebuilddir": "test" 20:04:04 INFO - } 20:04:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:04:04 INFO - Running post-action listener: _resource_record_post_action 20:04:04 INFO - ##### 20:04:04 INFO - ##### Finished read-buildbot-config step (success) 20:04:04 INFO - ##### 20:04:04 INFO - ##### 20:04:04 INFO - ##### Running download-and-extract step. 20:04:04 INFO - ##### 20:04:04 INFO - Running pre-action listener: _resource_record_pre_action 20:04:04 INFO - Running main action method: download_and_extract 20:04:04 INFO - mkdir: /builds/slave/test/build/tests 20:04:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:04 INFO - https://queue.taskcluster.net/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:04:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:04:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:04:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/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 20:04:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/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 20:04:08 INFO - Downloaded 1361 bytes. 20:04:08 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:04:08 INFO - Using the following test package requirements: 20:04:08 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:04:08 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:04:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:04:08 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:04:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:04:08 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:04:08 INFO - u'jsshell-linux-x86_64.zip'], 20:04:08 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:04:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:04:08 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:04:08 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:04:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:04:08 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:04:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:04:08 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:04:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:04:08 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:04:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:04:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:04: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')]} 20:04:08 INFO - https://queue.taskcluster.net/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:04:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:04:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:04:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/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 20:04:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/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 20:04:09 INFO - Downloaded 24268203 bytes. 20:04: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'] 20:04: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 20:04:11 INFO - Return code: 0 20:04:11 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 20:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:11 INFO - https://queue.taskcluster.net/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:04:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:04:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:04:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/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 20:04:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/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 20:04:18 INFO - Downloaded 24268203 bytes. 20:04:18 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'] 20:04:18 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 20:04:20 INFO - Return code: 0 20:04: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')]} 20:04:20 INFO - https://queue.taskcluster.net/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:04:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:04:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:04:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/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 20:04:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/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 20:04:21 INFO - Downloaded 14405245 bytes. 20:04:21 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'] 20:04:21 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 20:04:21 INFO - Return code: 0 20:04: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')]} 20:04:21 INFO - https://queue.taskcluster.net/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:04:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:04:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:04:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/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 20:04:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/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 20:04:27 INFO - Downloaded 60340868 bytes. 20:04:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:04:27 INFO - mkdir: /builds/slave/test/properties 20:04:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:04:27 INFO - Writing to file /builds/slave/test/properties/build_url 20:04:27 INFO - Contents: 20:04:27 INFO - build_url:https://queue.taskcluster.net/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:04:27 INFO - Running post-action listener: _resource_record_post_action 20:04:27 INFO - Running post-action listener: set_extra_try_arguments 20:04:27 INFO - ##### 20:04:27 INFO - ##### Finished download-and-extract step (success) 20:04:27 INFO - ##### 20:04:27 INFO - ##### 20:04:27 INFO - ##### Running populate-webroot step. 20:04:27 INFO - ##### 20:04:27 INFO - Running pre-action listener: _resource_record_pre_action 20:04:27 INFO - Running main action method: populate_webroot 20:04:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:04:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:04:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:04:27 INFO - '--tppagecycles', 20:04:27 INFO - '7'], 20:04:27 INFO - 'tests': ['tsvgm']}}, 20:04:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:04:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:04:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:04:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:04:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:04:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:04:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:04:27 INFO - 'talos_options': ['--disable-e10s'], 20:04:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:04:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:04:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:04:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:04:27 INFO - 'talos_options': ['--disable-e10s'], 20:04:27 INFO - 'tests': ['damp', 'tps']}, 20:04:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:04:27 INFO - 'tests': ['damp', 'tps']}, 20:04:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:04:27 INFO - 'tests': ['dromaeo_dom']}, 20:04:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:04:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:04:27 INFO - 'tests': ['basic_compositor_video']}, 20:04:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:04:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:04:27 INFO - 'tests': ['a11yr', 20:04:27 INFO - 'ts_paint', 20:04:27 INFO - 'tpaint', 20:04:27 INFO - 'sessionrestore', 20:04:27 INFO - 'sessionrestore_no_auto_restore', 20:04:27 INFO - 'tabpaint']}, 20:04:27 INFO - 'other-e10s': {'tests': ['a11yr', 20:04:27 INFO - 'ts_paint', 20:04:27 INFO - 'tpaint', 20:04:27 INFO - 'sessionrestore', 20:04:27 INFO - 'sessionrestore_no_auto_restore', 20:04:27 INFO - 'tabpaint']}, 20:04:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:04:27 INFO - 'ts_paint', 20:04:27 INFO - 'tpaint', 20:04:27 INFO - 'sessionrestore', 20:04:27 INFO - 'sessionrestore_no_auto_restore', 20:04:27 INFO - 'tabpaint']}, 20:04:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:04:27 INFO - 'ts_paint', 20:04:27 INFO - 'tpaint', 20:04:27 INFO - 'sessionrestore', 20:04:27 INFO - 'sessionrestore_no_auto_restore', 20:04:27 INFO - 'tabpaint']}, 20:04:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:04:27 INFO - 'tests': ['a11yr', 20:04:27 INFO - 'ts_paint', 20:04:27 INFO - 'tpaint', 20:04:27 INFO - 'sessionrestore', 20:04:27 INFO - 'sessionrestore_no_auto_restore', 20:04:27 INFO - 'tabpaint']}, 20:04:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:04:27 INFO - 'tests': ['a11yr', 20:04:27 INFO - 'ts_paint', 20:04:27 INFO - 'tpaint', 20:04:27 INFO - 'sessionrestore', 20:04:27 INFO - 'sessionrestore_no_auto_restore', 20:04:27 INFO - 'tabpaint']}, 20:04:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:04:27 INFO - 'tests': ['tsvgx', 20:04:27 INFO - 'tsvgr_opacity', 20:04:27 INFO - 'tart', 20:04:27 INFO - 'tscrollx', 20:04:27 INFO - 'cart']}, 20:04:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:04:27 INFO - 'tsvgr_opacity', 20:04:27 INFO - 'tart', 20:04:27 INFO - 'tscrollx', 20:04:27 INFO - 'cart']}, 20:04:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:04:27 INFO - 'talos_options': ['--disable-e10s'], 20:04:27 INFO - 'tests': ['tp5o']}, 20:04:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:04:27 INFO - 'tests': ['tp5o']}, 20:04:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:04:27 INFO - 'talos_options': ['--disable-e10s', 20:04:27 INFO - '--xperf_path', 20:04:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:04:27 INFO - 'tests': ['tp5n']}, 20:04:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:04:27 INFO - 'talos_options': ['--xperf_path', 20:04:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:04:27 INFO - 'tests': ['tp5n']}}, 20:04:27 INFO - 'talos.zip': {'path': '', 20:04:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:04:27 INFO - Running post-action listener: _resource_record_post_action 20:04:27 INFO - ##### 20:04:27 INFO - ##### Finished populate-webroot step (success) 20:04:27 INFO - ##### 20:04:27 INFO - ##### 20:04:27 INFO - ##### Running create-virtualenv step. 20:04:27 INFO - ##### 20:04:27 INFO - Running pre-action listener: _resource_record_pre_action 20:04:27 INFO - Running main action method: create_virtualenv 20:04:27 INFO - Creating virtualenv /builds/slave/test/build/venv 20:04:27 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 20:04:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:04:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:04:28 INFO - Using real prefix '/usr' 20:04:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:04:28 INFO - Installing distribute.............................................................................................................................................................................................done. 20:04:30 INFO - Installing pip.................done. 20:04:30 INFO - Return code: 0 20:04:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1681030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1942180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19403b0>, '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 0x19412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1941740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467253861.786744-1310156976', '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 20:04:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:04:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:04:30 INFO - Using env: {'DISPLAY': ':0', 20:04:30 INFO - 'HOME': '/home/cltbld', 20:04:30 INFO - 'LANG': 'en_US.UTF-8', 20:04:30 INFO - 'LANGUAGE': 'en_US:en', 20:04:30 INFO - 'LOGNAME': 'cltbld', 20:04:30 INFO - 'MAIL': '/var/mail/cltbld', 20:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:30 INFO - 'MOZ_NO_REMOTE': '1', 20:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:30 INFO - 'NO_EM_RESTART': '1', 20:04:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:30 INFO - 'PWD': '/builds/slave/test', 20:04:30 INFO - 'SHELL': '/bin/bash', 20:04:30 INFO - 'SHLVL': '1', 20:04:30 INFO - 'TERM': 'linux', 20:04:30 INFO - 'TMOUT': '86400', 20:04:30 INFO - 'USER': 'cltbld', 20:04:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467253861.786744-1310156976', 20:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:30 INFO - '_': '/tools/buildbot/bin/python'} 20:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:30 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 20:04:30 INFO - Cleaning up... 20:04:30 INFO - Return code: 0 20:04:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1681030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1942180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19403b0>, '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 0x19412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1941740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467253861.786744-1310156976', '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 20:04:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:04:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:04:30 INFO - Using env: {'DISPLAY': ':0', 20:04:30 INFO - 'HOME': '/home/cltbld', 20:04:30 INFO - 'LANG': 'en_US.UTF-8', 20:04:30 INFO - 'LANGUAGE': 'en_US:en', 20:04:30 INFO - 'LOGNAME': 'cltbld', 20:04:30 INFO - 'MAIL': '/var/mail/cltbld', 20:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:30 INFO - 'MOZ_NO_REMOTE': '1', 20:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:30 INFO - 'NO_EM_RESTART': '1', 20:04:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:30 INFO - 'PWD': '/builds/slave/test', 20:04:30 INFO - 'SHELL': '/bin/bash', 20:04:30 INFO - 'SHLVL': '1', 20:04:30 INFO - 'TERM': 'linux', 20:04:30 INFO - 'TMOUT': '86400', 20:04:30 INFO - 'USER': 'cltbld', 20:04:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467253861.786744-1310156976', 20:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:30 INFO - '_': '/tools/buildbot/bin/python'} 20:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:30 INFO - Downloading/unpacking psutil>=3.1.1 20:04: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 20:04: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 20:04: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 20:04: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 20:04: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 20:04: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 20:04:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:04:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:04:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:04:32 INFO - Installing collected packages: psutil 20:04:32 INFO - Running setup.py install for psutil 20:04:33 INFO - building 'psutil._psutil_linux' extension 20:04:33 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 20:04:33 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 20:04:33 INFO - building 'psutil._psutil_posix' extension 20:04:33 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 20:04:33 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 20:04:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:04:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:04:33 INFO - Successfully installed psutil 20:04:33 INFO - Cleaning up... 20:04:33 INFO - Return code: 0 20:04:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:04:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:33 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 0x1681030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1942180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19403b0>, '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 0x19412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1941740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467253861.786744-1310156976', '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 20:04:33 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 20:04:33 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 20:04:33 INFO - Using env: {'DISPLAY': ':0', 20:04:33 INFO - 'HOME': '/home/cltbld', 20:04:33 INFO - 'LANG': 'en_US.UTF-8', 20:04:33 INFO - 'LANGUAGE': 'en_US:en', 20:04:33 INFO - 'LOGNAME': 'cltbld', 20:04:33 INFO - 'MAIL': '/var/mail/cltbld', 20:04:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:33 INFO - 'MOZ_NO_REMOTE': '1', 20:04:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:33 INFO - 'NO_EM_RESTART': '1', 20:04:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:33 INFO - 'PWD': '/builds/slave/test', 20:04:33 INFO - 'SHELL': '/bin/bash', 20:04:33 INFO - 'SHLVL': '1', 20:04:33 INFO - 'TERM': 'linux', 20:04:33 INFO - 'TMOUT': '86400', 20:04:33 INFO - 'USER': 'cltbld', 20:04:33 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467253861.786744-1310156976', 20:04:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:33 INFO - '_': '/tools/buildbot/bin/python'} 20:04:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:04:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:04:35 INFO - Installing collected packages: mozsystemmonitor 20:04:35 INFO - Running setup.py install for mozsystemmonitor 20:04:35 INFO - Successfully installed mozsystemmonitor 20:04:35 INFO - Cleaning up... 20:04:35 INFO - Return code: 0 20:04:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:04: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')]} 20:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04: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')]} 20:04:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:35 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 0x1681030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1942180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19403b0>, '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 0x19412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1941740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467253861.786744-1310156976', '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 20:04:35 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 20:04:35 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 20:04:35 INFO - Using env: {'DISPLAY': ':0', 20:04:35 INFO - 'HOME': '/home/cltbld', 20:04:35 INFO - 'LANG': 'en_US.UTF-8', 20:04:35 INFO - 'LANGUAGE': 'en_US:en', 20:04:35 INFO - 'LOGNAME': 'cltbld', 20:04:35 INFO - 'MAIL': '/var/mail/cltbld', 20:04:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:35 INFO - 'MOZ_NO_REMOTE': '1', 20:04:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:35 INFO - 'NO_EM_RESTART': '1', 20:04:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:35 INFO - 'PWD': '/builds/slave/test', 20:04:35 INFO - 'SHELL': '/bin/bash', 20:04:35 INFO - 'SHLVL': '1', 20:04:35 INFO - 'TERM': 'linux', 20:04:35 INFO - 'TMOUT': '86400', 20:04:35 INFO - 'USER': 'cltbld', 20:04:35 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467253861.786744-1310156976', 20:04:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:35 INFO - '_': '/tools/buildbot/bin/python'} 20:04:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:36 INFO - Downloading/unpacking jsonschema==2.5.1 20:04: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 20:04: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 20:04: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 20:04: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 20:04: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 20:04: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 20:04:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:04:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:38 INFO - Downloading functools32-3.2.3-2.tar.gz 20:04:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:04:38 INFO - warning: no files found matching '*.txt' 20:04:38 INFO - no previously-included directories found matching 'build' 20:04:38 INFO - no previously-included directories found matching 'dist' 20:04:38 INFO - no previously-included directories found matching '.git*' 20:04:38 INFO - Installing collected packages: jsonschema, functools32 20:04:38 INFO - Running setup.py install for functools32 20:04:38 INFO - warning: no files found matching '*.txt' 20:04:38 INFO - no previously-included directories found matching 'build' 20:04:38 INFO - no previously-included directories found matching 'dist' 20:04:38 INFO - no previously-included directories found matching '.git*' 20:04:38 INFO - Successfully installed jsonschema functools32 20:04:38 INFO - Cleaning up... 20:04:38 INFO - Return code: 0 20:04:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:04:38 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')]} 20:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:38 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')]} 20:04:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:38 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 0x1681030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1942180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19403b0>, '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 0x19412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1941740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467253861.786744-1310156976', '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 20:04:38 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 20:04:38 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 20:04:38 INFO - Using env: {'DISPLAY': ':0', 20:04:38 INFO - 'HOME': '/home/cltbld', 20:04:38 INFO - 'LANG': 'en_US.UTF-8', 20:04:38 INFO - 'LANGUAGE': 'en_US:en', 20:04:38 INFO - 'LOGNAME': 'cltbld', 20:04:38 INFO - 'MAIL': '/var/mail/cltbld', 20:04:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:38 INFO - 'MOZ_NO_REMOTE': '1', 20:04:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:38 INFO - 'NO_EM_RESTART': '1', 20:04:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:38 INFO - 'PWD': '/builds/slave/test', 20:04:38 INFO - 'SHELL': '/bin/bash', 20:04:38 INFO - 'SHLVL': '1', 20:04:38 INFO - 'TERM': 'linux', 20:04:38 INFO - 'TMOUT': '86400', 20:04:38 INFO - 'USER': 'cltbld', 20:04:38 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467253861.786744-1310156976', 20:04:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:38 INFO - '_': '/tools/buildbot/bin/python'} 20:04:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:38 INFO - Downloading/unpacking blobuploader==1.2.4 20:04:38 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 20:04:38 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 20:04:38 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 20:04:38 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 20:04:38 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 20:04:38 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 20:04:40 INFO - Downloading blobuploader-1.2.4.tar.gz 20:04:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:04:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:04:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:41 INFO - Downloading docopt-0.6.1.tar.gz 20:04:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:04:41 INFO - Installing collected packages: blobuploader, requests, docopt 20:04:41 INFO - Running setup.py install for blobuploader 20:04:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:04:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:04:41 INFO - Running setup.py install for requests 20:04:41 INFO - Running setup.py install for docopt 20:04:41 INFO - Successfully installed blobuploader requests docopt 20:04:41 INFO - Cleaning up... 20:04:41 INFO - Return code: 0 20:04:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:04:41 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')]} 20:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:41 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')]} 20:04:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:41 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 0x1681030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1942180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19403b0>, '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 0x19412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1941740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467253861.786744-1310156976', '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 20:04:41 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 20:04:41 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 20:04:41 INFO - Using env: {'DISPLAY': ':0', 20:04:41 INFO - 'HOME': '/home/cltbld', 20:04:41 INFO - 'LANG': 'en_US.UTF-8', 20:04:41 INFO - 'LANGUAGE': 'en_US:en', 20:04:41 INFO - 'LOGNAME': 'cltbld', 20:04:41 INFO - 'MAIL': '/var/mail/cltbld', 20:04:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:41 INFO - 'MOZ_NO_REMOTE': '1', 20:04:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:41 INFO - 'NO_EM_RESTART': '1', 20:04:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:41 INFO - 'PWD': '/builds/slave/test', 20:04:41 INFO - 'SHELL': '/bin/bash', 20:04:41 INFO - 'SHLVL': '1', 20:04:41 INFO - 'TERM': 'linux', 20:04:41 INFO - 'TMOUT': '86400', 20:04:41 INFO - 'USER': 'cltbld', 20:04:41 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467253861.786744-1310156976', 20:04:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:41 INFO - '_': '/tools/buildbot/bin/python'} 20:04:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:04:42 INFO - Running setup.py (path:/tmp/pip-LwKrLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:04:42 INFO - Running setup.py (path:/tmp/pip-O9Y_QH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:04:42 INFO - Running setup.py (path:/tmp/pip-rF8P97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:04:42 INFO - Running setup.py (path:/tmp/pip-Z0fIk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:04:42 INFO - Running setup.py (path:/tmp/pip-wlk3Z3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:04:42 INFO - Running setup.py (path:/tmp/pip-MDDB3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:04:42 INFO - Running setup.py (path:/tmp/pip-kHqRzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:04:42 INFO - Running setup.py (path:/tmp/pip-USNmEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:04:42 INFO - Running setup.py (path:/tmp/pip-n0RCpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:04:42 INFO - Running setup.py (path:/tmp/pip-fbXBQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:04:42 INFO - Running setup.py (path:/tmp/pip-edibms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:04:42 INFO - Running setup.py (path:/tmp/pip-TyR9H4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:04:42 INFO - Running setup.py (path:/tmp/pip-RJ3axL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:04:42 INFO - Running setup.py (path:/tmp/pip-uIQKDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:04:43 INFO - Running setup.py (path:/tmp/pip-mx1BT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:04:43 INFO - Running setup.py (path:/tmp/pip-RLazrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:04:43 INFO - Running setup.py (path:/tmp/pip-Ya6z_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:04:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:04:43 INFO - Running setup.py install for manifestparser 20:04:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:04:43 INFO - Running setup.py install for mozcrash 20:04:43 INFO - Running setup.py install for mozdebug 20:04:43 INFO - Running setup.py install for mozdevice 20:04:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:04:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:04:43 INFO - Running setup.py install for mozfile 20:04:43 INFO - Running setup.py install for mozhttpd 20:04:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:04:43 INFO - Running setup.py install for mozinfo 20:04:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:04:43 INFO - Running setup.py install for mozInstall 20:04:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:04:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:04:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:04:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:04:44 INFO - Running setup.py install for mozleak 20:04:44 INFO - Running setup.py install for mozlog 20:04:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:04:44 INFO - Running setup.py install for moznetwork 20:04:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:04:44 INFO - Running setup.py install for mozprocess 20:04:44 INFO - Running setup.py install for mozprofile 20:04:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:04:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:04:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:04:44 INFO - Running setup.py install for mozrunner 20:04:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:04:44 INFO - Running setup.py install for mozscreenshot 20:04:44 INFO - Running setup.py install for moztest 20:04:44 INFO - Running setup.py install for mozversion 20:04:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:04:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:04:45 INFO - Cleaning up... 20:04:45 INFO - Return code: 0 20:04:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:45 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 0x1681030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1942180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19403b0>, '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 0x19412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1941740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467253861.786744-1310156976', '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 20:04:45 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 20:04:45 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 20:04:45 INFO - Using env: {'DISPLAY': ':0', 20:04:45 INFO - 'HOME': '/home/cltbld', 20:04:45 INFO - 'LANG': 'en_US.UTF-8', 20:04:45 INFO - 'LANGUAGE': 'en_US:en', 20:04:45 INFO - 'LOGNAME': 'cltbld', 20:04:45 INFO - 'MAIL': '/var/mail/cltbld', 20:04:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:45 INFO - 'MOZ_NO_REMOTE': '1', 20:04:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:45 INFO - 'NO_EM_RESTART': '1', 20:04:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:45 INFO - 'PWD': '/builds/slave/test', 20:04:45 INFO - 'SHELL': '/bin/bash', 20:04:45 INFO - 'SHLVL': '1', 20:04:45 INFO - 'TERM': 'linux', 20:04:45 INFO - 'TMOUT': '86400', 20:04:45 INFO - 'USER': 'cltbld', 20:04:45 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467253861.786744-1310156976', 20:04:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:45 INFO - '_': '/tools/buildbot/bin/python'} 20:04:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:04:45 INFO - Running setup.py (path:/tmp/pip-vZFUJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:04:45 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)) 20:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:04:45 INFO - Running setup.py (path:/tmp/pip-bVBP1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:04:45 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)) 20:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:04:45 INFO - Running setup.py (path:/tmp/pip-K8MVRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:04:45 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)) 20:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:04:45 INFO - Running setup.py (path:/tmp/pip-iSJd4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:04:45 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)) 20:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:04:45 INFO - Running setup.py (path:/tmp/pip-qV2qvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:04:45 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)) 20:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:04:45 INFO - Running setup.py (path:/tmp/pip-RGj03I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:04:45 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)) 20:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:04:45 INFO - Running setup.py (path:/tmp/pip-917tGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:04:45 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)) 20:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:04:45 INFO - Running setup.py (path:/tmp/pip-ph_LPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:04:45 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)) 20:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:04:45 INFO - Running setup.py (path:/tmp/pip-j2rxwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:04:45 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)) 20:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:04:45 INFO - Running setup.py (path:/tmp/pip-ibfZzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:04:45 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)) 20:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:04:46 INFO - Running setup.py (path:/tmp/pip-vLhOIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:04:46 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)) 20:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:04:46 INFO - Running setup.py (path:/tmp/pip-HL2m27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:04:46 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)) 20:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:04:46 INFO - Running setup.py (path:/tmp/pip-JhhY60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:04:46 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)) 20:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:04:46 INFO - Running setup.py (path:/tmp/pip-2_lAOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:04:46 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)) 20:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:04:46 INFO - Running setup.py (path:/tmp/pip-PjadnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:04:46 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)) 20:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:04:46 INFO - Running setup.py (path:/tmp/pip-bkiBot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:04:46 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)) 20:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:04:46 INFO - Running setup.py (path:/tmp/pip-AmtOEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:04:46 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)) 20:04:46 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)) 20:04:46 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)) 20:04:46 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)) 20:04:46 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)) 20:04:46 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)) 20:04:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:48 INFO - Downloading blessings-1.6.tar.gz 20:04:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:04:48 INFO - Installing collected packages: blessings 20:04:48 INFO - Running setup.py install for blessings 20:04:48 INFO - Successfully installed blessings 20:04:48 INFO - Cleaning up... 20:04:48 INFO - Return code: 0 20:04:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:04:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:04:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:04:48 INFO - Reading from file tmpfile_stdout 20:04:48 INFO - Current package versions: 20:04:48 INFO - argparse == 1.2.1 20:04:48 INFO - blessings == 1.6 20:04:48 INFO - blobuploader == 1.2.4 20:04:48 INFO - docopt == 0.6.1 20:04:48 INFO - functools32 == 3.2.3-2 20:04:48 INFO - jsonschema == 2.5.1 20:04:48 INFO - manifestparser == 1.1 20:04:48 INFO - mozInstall == 1.12 20:04:48 INFO - mozcrash == 0.17 20:04:48 INFO - mozdebug == 0.1 20:04:48 INFO - mozdevice == 0.48 20:04:48 INFO - mozfile == 1.2 20:04:48 INFO - mozhttpd == 0.7 20:04:48 INFO - mozinfo == 0.9 20:04:48 INFO - mozleak == 0.1 20:04:48 INFO - mozlog == 3.2 20:04:48 INFO - moznetwork == 0.27 20:04:48 INFO - mozprocess == 0.22 20:04:48 INFO - mozprofile == 0.28 20:04:48 INFO - mozrunner == 6.11 20:04:48 INFO - mozscreenshot == 0.1 20:04:48 INFO - mozsystemmonitor == 0.3 20:04:48 INFO - moztest == 0.7 20:04:48 INFO - mozversion == 1.4 20:04:48 INFO - psutil == 3.1.1 20:04:48 INFO - requests == 1.2.3 20:04:48 INFO - wsgiref == 0.1.2 20:04:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:04:48 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')]} 20:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:48 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')]} 20:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:48 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 0x1681030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1942180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19403b0>, '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 0x19412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1941740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467253861.786744-1310156976', '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 20:04:48 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 20:04:48 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 20:04:48 INFO - Using env: {'DISPLAY': ':0', 20:04:48 INFO - 'HOME': '/home/cltbld', 20:04:48 INFO - 'LANG': 'en_US.UTF-8', 20:04:48 INFO - 'LANGUAGE': 'en_US:en', 20:04:48 INFO - 'LOGNAME': 'cltbld', 20:04:48 INFO - 'MAIL': '/var/mail/cltbld', 20:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:48 INFO - 'MOZ_NO_REMOTE': '1', 20:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:48 INFO - 'NO_EM_RESTART': '1', 20:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:48 INFO - 'PWD': '/builds/slave/test', 20:04:48 INFO - 'SHELL': '/bin/bash', 20:04:48 INFO - 'SHLVL': '1', 20:04:48 INFO - 'TERM': 'linux', 20:04:48 INFO - 'TMOUT': '86400', 20:04:48 INFO - 'USER': 'cltbld', 20:04:48 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467253861.786744-1310156976', 20:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:48 INFO - '_': '/tools/buildbot/bin/python'} 20:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:49 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)) 20:04:49 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)) 20:04:49 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)) 20:04:49 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)) 20:04:49 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)) 20:04:49 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)) 20:04:49 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)) 20:04:49 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)) 20:04:49 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)) 20:04:49 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)) 20:04:49 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)) 20:04:49 INFO - Cleaning up... 20:04:49 INFO - Return code: 0 20:04:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:04:49 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')]} 20:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:49 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')]} 20:04:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:49 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 0x1681030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1942180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19403b0>, '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 0x19412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1941740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1467253861.786744-1310156976', '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 20:04:49 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 20:04:49 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 20:04:49 INFO - Using env: {'DISPLAY': ':0', 20:04:49 INFO - 'HOME': '/home/cltbld', 20:04:49 INFO - 'LANG': 'en_US.UTF-8', 20:04:49 INFO - 'LANGUAGE': 'en_US:en', 20:04:49 INFO - 'LOGNAME': 'cltbld', 20:04:49 INFO - 'MAIL': '/var/mail/cltbld', 20:04:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:49 INFO - 'MOZ_NO_REMOTE': '1', 20:04:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:49 INFO - 'NO_EM_RESTART': '1', 20:04:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:49 INFO - 'PWD': '/builds/slave/test', 20:04:49 INFO - 'SHELL': '/bin/bash', 20:04:49 INFO - 'SHLVL': '1', 20:04:49 INFO - 'TERM': 'linux', 20:04:49 INFO - 'TMOUT': '86400', 20:04:49 INFO - 'USER': 'cltbld', 20:04:49 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467253861.786744-1310156976', 20:04:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:49 INFO - '_': '/tools/buildbot/bin/python'} 20:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:04:49 INFO - Cleaning up... 20:04:49 INFO - Return code: 0 20:04:49 INFO - Running post-action listener: _resource_record_post_action 20:04:49 INFO - Running post-action listener: _start_resource_monitoring 20:04:49 INFO - Starting resource monitoring. 20:04:49 INFO - ##### 20:04:49 INFO - ##### Finished create-virtualenv step (success) 20:04:49 INFO - ##### 20:04:49 INFO - ##### 20:04:49 INFO - ##### Running install step. 20:04:49 INFO - ##### 20:04:49 INFO - Running pre-action listener: _resource_record_pre_action 20:04:49 INFO - Running main action method: install 20:04:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:04:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:04:49 INFO - Reading from file tmpfile_stdout 20:04:49 INFO - Detecting whether we're running mozinstall >=1.0... 20:04:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:04:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:04:49 INFO - Reading from file tmpfile_stdout 20:04:49 INFO - Output received: 20:04:49 INFO - Usage: mozinstall [options] installer 20:04:49 INFO - Options: 20:04:49 INFO - -h, --help show this help message and exit 20:04:49 INFO - -d DEST, --destination=DEST 20:04:49 INFO - Directory to install application into. [default: 20:04:49 INFO - "/builds/slave/test"] 20:04:49 INFO - --app=APP Application being installed. [default: firefox] 20:04:49 INFO - mkdir: /builds/slave/test/build/application 20:04:49 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'] 20:04:49 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 20:05:06 INFO - Reading from file tmpfile_stdout 20:05:06 INFO - Output received: 20:05:06 INFO - /builds/slave/test/build/application/firefox/firefox 20:05:06 INFO - Running post-action listener: _resource_record_post_action 20:05:06 INFO - ##### 20:05:06 INFO - ##### Finished install step (success) 20:05:06 INFO - ##### 20:05:06 INFO - ##### 20:05:06 INFO - ##### Running run-tests step. 20:05:06 INFO - ##### 20:05:06 INFO - Running pre-action listener: _resource_record_pre_action 20:05:06 INFO - Running main action method: run_tests 20:05:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:05:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:05:06 INFO - Python 2.7.3 20:05:06 INFO - Return code: 0 20:05:06 INFO - grabbing minidump binary from tooltool 20:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:06 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 0x19403b0>, '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 0x19412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1941740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:05:06 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 20:05:06 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 20:05:06 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 20:05:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:05:06 INFO - Return code: 0 20:05:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:05:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:05:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:05:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:05:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:05:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 20:05:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 20:05:06 INFO - Using env: {'DISPLAY': ':0', 20:05:06 INFO - 'HOME': '/home/cltbld', 20:05:06 INFO - 'LANG': 'en_US.UTF-8', 20:05:06 INFO - 'LANGUAGE': 'en_US:en', 20:05:06 INFO - 'LOGNAME': 'cltbld', 20:05:06 INFO - 'MAIL': '/var/mail/cltbld', 20:05:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:05:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:06 INFO - 'MOZ_NO_REMOTE': '1', 20:05:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:05:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:06 INFO - 'NO_EM_RESTART': '1', 20:05:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:06 INFO - 'PWD': '/builds/slave/test', 20:05:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:05:06 INFO - 'SHELL': '/bin/bash', 20:05:06 INFO - 'SHLVL': '1', 20:05:06 INFO - 'TERM': 'linux', 20:05:06 INFO - 'TMOUT': '86400', 20:05:06 INFO - 'USER': 'cltbld', 20:05:06 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1467253861.786744-1310156976', 20:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:06 INFO - '_': '/tools/buildbot/bin/python'} 20:05:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 20:05:07 INFO - mozversion application_buildid: 20160629173007 20:05:07 INFO - mozversion application_changeset: 196a5285e75c5f5b75c0029c49a9662f7e5822de 20:05:07 INFO - mozversion application_display_name: Nightly 20:05:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:05:07 INFO - mozversion application_name: Firefox 20:05:07 INFO - mozversion application_remotingname: firefox 20:05:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:05:07 INFO - mozversion application_vendor: Mozilla 20:05:07 INFO - mozversion application_version: 50.0a1 20:05:07 INFO - mozversion platform_buildid: 20160629173007 20:05:07 INFO - mozversion platform_changeset: 196a5285e75c5f5b75c0029c49a9662f7e5822de 20:05:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:05:07 INFO - mozversion platform_version: 50.0a1 20:05:07 INFO - using testdate: 1467255907 20:05:07 INFO - actual date: 1467255907 20:05:07 INFO - starting webserver on 'localhost:40769' 20:05:07 INFO - SUITE-START | Running 2 tests 20:05:07 INFO - TEST-START | dromaeo_css 20:05:07 INFO - operating with platform_type : linux_ 20:05:07 INFO - Initialising browser for dromaeo_css test... 20:05:07 INFO - TEST-INFO | started process 7350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6B1qiL/profile http://localhost:40769/getInfo.html) 20:05:10 INFO - PROCESS | 7350 | __metrics Screen width/height:1600/1200 20:05:10 INFO - PROCESS | 7350 | colorDepth:24 20:05:10 INFO - PROCESS | 7350 | Browser inner width/height: 1024/697 20:05:10 INFO - PROCESS | 7350 | __metrics 20:05:11 INFO - PROCESS | 7350 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:05:12 INFO - TEST-INFO | 7350: exit 0 20:05:12 INFO - Browser initialized. 20:05:12 INFO - Running cycle 1/1 for dromaeo_css test... 20:05:12 INFO - TEST-INFO | started process 7434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6B1qiL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:05:23 INFO - PROCESS | 7434 | RSS: Main: 157638656 20:05:23 INFO - PROCESS | 7434 | 20:06:15 INFO - PROCESS | 7434 | 1467255975541 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] 20:08:23 INFO - PROCESS | 7434 | Cycle 1(1): loaded http://localhost:40769/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40769/tests/dromaeo/cssquery-ext.html) 20:08:24 INFO - PROCESS | 7434 | RSS: Main: 259256320 20:08:24 INFO - PROCESS | 7434 | 20:11:26 INFO - PROCESS | 7434 | Cycle 1(1): loaded http://localhost:40769/tests/dromaeo/cssquery-ext.html (next: http://localhost:40769/tests/dromaeo/cssquery-jquery.html) 20:11:27 INFO - PROCESS | 7434 | RSS: Main: 245932032 20:11:27 INFO - PROCESS | 7434 | 20:14:29 INFO - PROCESS | 7434 | Cycle 1(1): loaded http://localhost:40769/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40769/tests/dromaeo/cssquery-mootools.html) 20:14:29 INFO - PROCESS | 7434 | RSS: Main: 242364416 20:14:29 INFO - PROCESS | 7434 | 20:17:31 INFO - PROCESS | 7434 | Cycle 1(1): loaded http://localhost:40769/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40769/tests/dromaeo/cssquery-prototype.html) 20:17:32 INFO - PROCESS | 7434 | RSS: Main: 242696192 20:17:32 INFO - PROCESS | 7434 | 20:20:35 INFO - PROCESS | 7434 | Cycle 1(1): loaded http://localhost:40769/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40769/tests/dromaeo/cssquery-yui.html) 20:20:35 INFO - PROCESS | 7434 | RSS: Main: 225107968 20:20:35 INFO - PROCESS | 7434 | 20:23:38 INFO - PROCESS | 7434 | Cycle 1(1): loaded http://localhost:40769/tests/dromaeo/cssquery-yui.html (next: http://localhost:40769/tests/dromaeo/cssquery-dojo.html) 20:23:38 INFO - PROCESS | 7434 | RSS: Main: 265990144 20:23:38 INFO - PROCESS | 7434 | 20:23:38 INFO - PROCESS | 7434 | __start_tp_report 20:23:38 INFO - PROCESS | 7434 | _x_x_mozilla_page_load 20:23:38 INFO - PROCESS | 7434 | _x_x_mozilla_page_load_details 20:23:38 INFO - PROCESS | 7434 | |i|pagename|runs| 20:23:38 INFO - PROCESS | 7434 | |0;dojo.html;3105.285784269618;3125.4061728271613;3136.2943337749;3156.0058581546796;3181.9976707337187;5239.161734122541;5337.332833395825;5354.518093371596;5433.6196466247375;5468.835934921954;5291.68249905006;5297.761600727967;5359.651622644536;5392.110301800199;5435.2934118564535;4745.644076694236;4843.467218605951;4850.199717046683;4861.538153875376;5136.486351364871;5048.722320272402;5054.570361519275;5084.745762711868;5111.13110771168;5116.744162791864;4694.530546945312;4858.344123543312;4887.926681099786;4890.217565189588;4892.437369702494;4898.485659005789;4974.028486805881;4981.676191047606;4987;5009.974950125263;4762.166620841339;4802.327674125625;4945.975270123662;4960.107180707471;5000.62495312853;5356.0894647909945;5428.185772134172;5441.891162176735;5449.809256675997;5454.61817672763;5812.476877081083;5818.272715910512;5819.039858423355;5835.270591176103;5843.035899076647;5599.888002239933;5844.064949608042;5869.559783016291;5897.705114744245;5924.229850119457;5552.944470555242;5599.80400685974;5612.438756124396;5615.1857980592995;5615.241942337773;6051.116374483393;6053.127168202941;6054.878867607297;6090.908636370458;6109.450149486567;5550.278463799761;5634.887302253932;5675.2054712340305;5692.48767610917;5856.531477481792;5846;5858.033424484997;5861.853453663693;5863.765449381977;5865;5728.140778883201;5770.798022069207;5773.3072031356505;5778.27771528559;5782.653040817564;5550.028744969614;5750.7987220447085;5811.476967072984;5827.59206855516;5876.324222714443;4448.822047118079;4455;4461.955380446154;4463.977680111643;4490.438695163105;3894.5131858517684;3960.20795840833;3961.207758448264;3963.6630886374405;4017.7589344639414;5304.867378315573;5323.787048518094;5362.195670649434;5385.78456861729;5421.186821976657;5793.826185214366;5794.362620111784;5794.681292528951;5797.072468405035;5815.098659707752;5377.085895397791;5378.78484860609;5395.62230643859;5400.21696853954;5401.1358182691365;4752.52474752522;4967.105920934267;5032.220005899091;5034.874128146826;5040.79836806531;6042.4561789438285;6052.092186172109;6056.485198758067;6058.636481811105;6059.242594675666;5629.831105066854;5846;5857.853553661193;5859.94140058594;5861.912071318849;5976.103584462366;6035.879282414415;6050.21347224858;6097.756089756537;6104.084387341757;5773.3072031356505;5797.507211887037;5802.303723553201;5802.506786923159;5812.912806307824;5493.697846618475;5777.480026797609;5896;5907.734151963086;5908.261467316585;5700.771969121189;5749.655020698771;5750.6837123958585;5754;5796.1305804129715;5679.914801278067;5716.399778023414;5732.082866741468;5732.283464566929;5736.397678243724;5345.22494238341;5538.0585300499815;5626.88746225065;5629.8592535186945;5641.069223578063;5739.540836733135;5784.82645520635;5825.621334613236;5843.707814609167;5844.736986835517;5617.831465056055;5651.971740141273;5657.2079908811975;5660.801871934463;5669.6314739541795 20:23:38 INFO - PROCESS | 7434 | |1;ext.html;594.0376589924323;621.465539635913;629.6064959400375;632.4308122689575;632.6235889645662;32687.83656081719;42562.57437425625;43193.56806431935;43205.7839710801;43357.78321108394;44611;44972.55027449725;44997;45009.77495112528;45051.774741126246;8892.510911899843;9036.593353299084;9037.864432033524;9042.954785226098;9043.186113249807;8886.822263554724;8958.417702849327;8976.820463590724;8978.955105224464;8980.775480613005;9018.143276388733;9061.093890610951;9067.637294508211;9070.591823367964;9071.591778369957;8979.461232326048;9007.504587247699;9009.909900900973;9024.413413128126;9029.819403611924;8854.158854908774;8895.243904268145;8917.821643567157;8939.061398553124;8944.10558944107;42375.36436953448;42721.14557708828;42765;42826.35760463595;42833.78583107064;3215.3569286142865;3223.503213017827;3239.8380080995857;3273.247153154764;3287.2439338952177;30818.691813081805;33171.170720731934;33555.328893421996;33593.832030839934;35313;4297.505786834523;4366.454193225847;4476.444355863381;4517;4573.131105090022;362554;362620;362928.40965337167;364656;365274;63199;63285.683571581845;63649;63686.36313636897;63750.36249637537;55968.16047759287;62808.37191628117;64178.35821641724;64310.67844660841;71123.64438177776;17980.9100954497;18052.09739513019;18147.72778408325;18164;18165.636687266182;12504.124711270306;13782.862171378358;13878.93060534711;13900.16599004063;13901.443942242398;19027.714584281246;19587.51031224231;19587.51031224231;19706.31027914016;19984.300549480697;7266.818329541698;7359.190489046201;7361.411087113125;7423.8144046399275;7551.244875512405;973.8490533967247;988.5304480371766;988.6687959533493;1001.2940876681922;1087.4073629871739;33236.66763332384;33320.1669958253;33342.16644583905;33508;33735.15662108418;1068.1241382066787;1084.2572837606265;1112.777444511101;1115.6039605939936;1120.019982515299;17063.269876819897;17392.739108913378;17666.470005899842;17700.380486683163;17717.46847594574;541237;543118;544076;544814;545362;37109;37128.07179820526;61240.69379653073;61275.69362153161;61398;1305.145129939891;1362.7410791949499;1387.7224555088821;1391.7494850926728;1398.7132637809225;31511.84244078765;32094.518582221754;32602;32651.020469385956;32994.67005329916;53899.73050134724;54165.45834541762;54218;54249.18626220689;54300.185497216786;447638;447926;451239;453348;455309;24782.504349913263;24889.751102489467;29140.27149321284;29531;29907.55138672965;49518.257226142356;49550;50275.49724502708;50638.2404263929;50987;39778.425481070044;42183.578164217965;42571.574284258;42626;42704.71476351632;42354.576454235066;42519.5748042528;42539.14921701487;42659.786701066296;42974.355384668626;41427;41496.792516037225;41986.580134198266;41995;42873.35689964715;37467.6253237475;38029.809850950565;38279.23441531098;38530.422043669925;39068.413973790986;28106;28321.858390707916;28445.857770711842;28475.715242847305;28580 20:23:38 INFO - PROCESS | 7434 | |2;jquery.html;411.62336462137137;412.61214458409114;414.7366422321826;415.0681719539634;424.60723830456817;18890.33883814067;20420.387388378334;20923.895380523096;21288.787112128874;21546.461338466546;19894.303699370525;20120.295789647364;20403.48991275219;20420.591588168227;20509.38471845847;5742.79900203494;5931.762729490815;5972.641641501524;5973.940260597404;5977.402259774031;5576.972115139419;5854.121881717734;5857.121431785245;5868.706564671771;5871.383504732005;5927.1998280232265;5933.851653708649;5941.613795103326;5957.285125784891;5961.374055724152;5502.257195278647;5836.416358364172;5881.7353219105025;5887;5922.052471604544;5634.915476267859;5711.286089238845;5716.314042314949;5718.7426565804635;5723;15162.848371516255;15192.240387980557;15391.461298854487;15405.075695458196;15442.922785386114;2303.8502497337618;2318.6058370077126;2775.764060054898;2995.7303842654264;3038.103759390985;10722.839157412645;11269.549218031269;11297.774044519147;11407.030402415805;11480.368579728112;1939.8351140153104;1996.7603887533444;2001.2495314257153;2003.4991252186953;2047.09927631843;72977.6351118241;73370.63314683446;76488.61755691242;85735.57132214299;89574;11550.768984620428;11568.363739994213;11664.88335116638;11722.238054526599;12292.938535307267;16453.91773041151;16643.167841607872;16656.08391538477;16691.749623755655;16696.332146713994;7745.419093568005;7900.604969751489;8358.540280284642;8362.205590468895;8551.957240213884;7798.922010779819;7825.843483130306;7944;8098.433109682265;8158.4289099762445;5150.381954165524;5150.40770311419;5178.533931946143;5186.196139598368;5265.657732247391;2034.8096363627444;2038.6228547718422;2042.5795432412342;2082.344061620585;2098.8635738676935;907.8638204269413;929.6049179098991;932.7201839448138;938.380668758616;946.3659348236698;19347.734431189816;20805.375838724558;20887.26894558683;20892.37322880316;21015.78984210169;957.9616815327448;979.5298256836759;980.3921568627354;994.597188138805;1047.8061558611682;10971.396573188551;11637.359945203096;11749.118816088827;11759.118066145073;11760.235584686969;467514;477260;477687;478231;478511;99297.50351248342;101143.49428252812;101342;101863.49068254759;101960.49019755003;938.1931538876561;940.9059094090674;948.5162567090833;987.8320685483485;992.9950350248203;18661.533461663566;18805.529861753017;18842.434726958214;18976.810231897503;18989.71515427242;44430.11139777251;45387;46010.53989460196;46377.53622463867;46563;63520.364796351445;65642.34357656362;65751.67124164349;66439.33560664332;67047;7870.84258314819;8373.853050710326;8455.534945578052;8565.95717021411;9217.262618990599;10249.418157481998;13740.65648358799;14062.718745625234;14220.288985550475;14465.566033019026;11697.649070527897;12342.506299747909;12445.62663120108;12503.749925001632;12609.243445393306;11828.940855295668;11980.400979950793;12212.206206596542;12323.876761232274;12474.937625311815;11810.40947952616;12167.209131406431;12609.747805043664;12766.872331276569;13172.868271317164;9502.192313653417;9524.428534287965;9549.809003820024;9626.133647971716;9714.125728684452;9492.335536512377;12145.271283723005;12568.120231583702;12795.61613151607;12836.743265134832 20:23:38 INFO - PROCESS | 7434 | |3;mootools.html;1460.9488667896626;1513.6518600721834;1609.9114548699818;1764.7000009998299;1773.6364045370692;8826.735197944065;9353.719388418358;9437.197838183754;9448.527573621326;9449.102335278138;7999.4800337977995;8757.255633271163;9009.504477253748;9097.363184577065;9186.311026672993;2362.7164740231156;2390.6175011998084;2391.151141344824;2392.079049565912;2397.2328854766483;2057.609054279682;2347.3099368454687;2368.7039120109985;2391.342380845264;2399.196269249803;2279.2364557873047;2347.2606129069372;2347.647852822073;2361.0437772702085;2361.917332893349;2395.185636883459;2401.1955994741784;2402.387391215246;2432.549978254011;2434.7686969737847;2366.6923299970895;2366.7633236676365;2375.477394973103;2390.1395497620842;2435.6346548017764;9312.487813170274;9434.245260379223;9444.527773611291;9452.52737363136;9458;5333.519983201491;5499.780008799643;5503.3120859892515;5506;5507.421720719347;3297.7032067114073;3341.866325346983;3378.6283508814013;3472.722182225416;3477.8608855645743;1041.9218558608059;1043.4417586591212;1057.5611121384616;1081.4376524207446;1090.8254679251281;12702.491900324068;12777.808332875014;12792.61622151337;12812.487500499969;12821.423035963404;4485.842995495142;4711.505291944365;4735.289706543977;4802.183628783116;4841.201201801734;10660.94669526663;10730.35617862915;10842.403667798348;10853.186011049045;10865.945670271756;5303.0454518186325;5313.362396512366;5321.2018197269945;5323.2015197719875;5338.839834804962;4831.347768051339;4888.169011268093;4904.288878112654;4911.68074075184;5016.498350164954;3903.2974064668633;3930.0567863712504;4027.859024934113;4028.576999415078;4043.8180281887385;1054.3199636234585;1138.3966497756037;1168.3223730236443;1178.9233699809486;1203.0916657923212;800.931920786728;804.3685706720197;869.4609342207872;945.6359301668907;978.1392374710209;5623.465770751772;5684.63049901755;5781.335146458211;5805.10020946754;5819.185314056035;957.9089986451276;959.8032403357295;960.8991055939166;986.8125056239435;1010.7372083258406;3778.1876896466842;3790.8483660653264;3866.7873266970587;3931.803409829497;3976;11216.943915280372;11406.201565890475;11548.826767598493;11576.594819181288;11584.826227606593;10181.134603558632;10772.245942784086;11174.720631984103;11429.714257143472;11517.76964460706;8399.202075802912;8476.957615212008;8496.362772792065;8632.266257368068;8680.78298042554;5995.2206213192;6002.189704389852;6045.183900173421;6112.938870611237;6136.110264011782;10664.560284361512;10674.199435042558;10759.08547773448;10778.407187604756;10803.351798891777;10555.63055293061;10624.8937510627;10709.892901070889;10909.890901090888;10943.781124377309;7734.071911370672;7748.34139098183;7843.254890785366;7848.725294614661;7856.607169641381;8987.281017518451;9012.2790176787;9087.09129087086;9097.818043639223;9151.496667683341;6485.28661847187;7894.250046245597;7905.960470197612;8236.929199204305;8351.373646976623;7798.610069496616;7876.251756083163;7897.881531776913;8029.397795165502;8142.715004974797;7278.745243916437;7327.194008659149;7412.62936853166;7419.851602967802;7436.814079648052;5049.2173713074535;5070.264811602371;5112.412072611549;5138.820141295037;5146.408163061295;5195.9740201298755;5216.713080780593;5271.446498117796;5336.039512887717;5408.972955135199 20:23:38 INFO - PROCESS | 7434 | |4;prototype.html;328.4695217224184;332.18283023761546;335.24067986011687;337.868231389758;341.30203733365266;5190.143626301656;5295.464315348544;5375.865603359918;5376.704281264529;5449.754761035753;5348.11201950946;5348.973255133728;5358.401175429924;5381.569474442045;5391.649542779716;4234.386014027964;4250.744955302692;4263.531011588722;4283.700140990132;4303.24693178694;4004.9599504005023;4028.8388464461386;4128.483939507561;4273.124009578045;4280.143971205755;4167.3330667733;4178.206140833247;4216.5572614875455;4231.1114665920195;4241.936370954438;4201.957980420202;4202.474690663667;4219.514755803091;4221.324588065925;4232.132412855357;3674.236366544047;3763.8118094095457;3766.679832214265;3773.2642134783728;3783.148791521913;5160.793568257265;5167.224916262553;5188.481151884781;5198.116320225571;5207.3230480037355;4772.546608072227;4807.230843065093;4808.206645903421;4845.854624361275;4857.514248575149;5327.46725327468;5541.806036788693;5553.416891226444;5588.7704704965245;5604.859878503029;4077.673786097105;4113.773742444165;4128.318827393477;4131;4155.31437312843;5795.1886735857015;5817.650940943557;5867.207926929853;5876.7355469004;5900;4019.6382325590253;4187.97906010468;4223.239816832999;4229.111886503807;4246.853349595592;4201.138766552849;4223.239816832999;4237.427947227146;4243.490781106225;4259.9787001065415;4809.254565542346;4822.324874517571;4832;4834.492378300228;4838.854834354975;5386.407495175527;5605.971970140124;5620.634658747168;5628.296462942132;5665.450547253752;1365.2968721108637;1404.4171668757351;1423.9676234729739;1434.2685230532295;1437.1018113678952;955.5652178258875;979.8481235408523;990.390909590611;992.950352482373;995.6564985080136;5322;5322.574194064543;5324.361076670824;5324.4675532446445;5355.518003379714;5653.265075540236;5678.3186017678145;5678.971605141948;5684.431556844283;5729.427057294237;5141.820036298712;5291.814786482455;5312.9734351328;5345.1982202669915;5355.839324820262;2654.2170059832397;2660.884596745592;2678.8614838693866;2683.7852971762213;2695.528282550546;5177.990291893045;5185.818496352685;5200.76596553156;5201.531862132426;5228.843134705889;4805.783739731721;5075.873103172376;5100.515451032146;5110.514501122388;5154.484551544815;5146.202338637517;5160.329157209539;5173.301604283449;5197.0125676121415;5207.297014903015;4968.7081358846235;5024;5027;5059.342285502861;5062.797488100582;4791.736454494897;4989.501049894981;5000.499950004971;5004.549590536869;5010.144217795967;5120.820771272987;5150.793968241228;5187.325647665779;5225.824189557471;5237.580993520433;3705.27747089315;3724.776513409204;3760.4359346098304;3760.8871733848027;3796.5633952095864;5115.974420127875;5406.675599464044;5550.639208451437;5657.745401457027;5775.364709881826;5445.292112025411;5525.502704756591;5525.806596769094;5533.750981205775;5598.524125449382;5571.303587051619;5573.21974923503;5589.413111623384;5604.439556044363;5607.635503692411;5288.788448462018;5532.1701744737;5541.16882467617;5546.916796247979;5551.863197293516;5588.5630337343055;5615.747291371979;5625.915611265917;5632.605717599728;5650.915236271541;5255.448177941261;5500.917486237629;5522.6134170607675;5534.39121696605;5534.446555344594 20:23:38 INFO - PROCESS | 7434 | |5;yui.html;729.1978823294376;773.1688434932449;799.8200404908896;818.7707441916258;840.4411066640686;14629.780553291695;15763.21183940804;15768.842311576895;15777.763333549978;15813.920930395347;11585.07319414447;14567.417303307882;14829.406823727066;14847.703045939075;14871.851281487181;772.8377040821421;804.7304153108686;810.7324582887662;814.0516298512226;814.3892080939296;792.627465091409;794.682127149142;796.9840603187932;799.2207597592359;801.1027649033091;686.7115811359216;817.4114637461048;843.2073850580465;846.8010017645848;847.0343808058818;825.1789469477848;831.7380025292014;838.7483754873514;839.0602525171786;839.2530647723501;617.4381313005189;617.6232498176109;617.941295576924;618;618.0821480102045;14385.85614143866;14397.136171829723;14411.78382324266;14417.639559011108;14429;14642.707145857023;14643;14654.487092951802;14910;14973.475928342565;12398.31809250491;12567.245965242024;12582.748345033047;13487.527936522174;13880.4447822088;3867.497225360685;3940.7647914790027;3976.8011599419915;3982.1637456134245;4003.079291762911;65810;68853.65573172102;68921.65539172322;74232;75814;11188.216824822348;11601.709957251136;11664.883351166549;11894.286342819458;11919.702007449883;21794.128234870746;22010.669839952414;22029.118835246732;22083;22138.003789829498;8395.538245396561;8833.867491987625;8905.866412003825;8930.330225233134;9325.580348884316;4787.234042553175;4835.6131509479155;4844.15227335222;4976.402831660224;5031.547160755549;3513.8418771154847;3660.7986560739414;3665.780053196817;3666.578343490533;3670.5595328560744;649.857031453089;652.1391762873056;655.0763423572739;677.1670844860848;678.7997540725498;631.6999425272959;650.2164891305965;655.2922843329193;663.9269680335159;668.8695704337607;8679.305655547541;9599.952000240093;9648.951755241178;9695.70912872615;9839.114479696862;589.1222079102107;653.3303364051885;705.7494589420785;721.7906807026009;728.6429649471827;4409.294512877988;4606.355110284563;4624.768761561909;4644.535546445396;4730.668853180245;70833.64583177051;89204.10795892088;113415;120454;120540.39729801295;102719;104356.47821760843;105037;105180;105535;89443.55278223567;89714;90535.54732226429;91921.54039229761;92776;8607.139286071342;8644.697435589724;8709.738707838775;8858.955705221433;8870.334724895529;49169.26246106383;49451;50458;50567.74716126543;51056.48943510666;70492.64753676199;76677.84983225368;78414.60792696;79348;79649.60175199086;11721.179517433698;11843.1709780318;11975.940120299343;12443.875561244271;12723;13841.4463421462;14124.223167725873;14255.50105746294;14453.421863125357;15453;13436.375164123025;14025;14049.508267210598;14143.434262629791;14228;13604.319784010957;13682.93158534201;14469.49356772508;14492.782608261095;14965.775513367525;13235.470581176645;13374.598762037154;13384.130031547918;13660.180389176681;13792;11310.717232069264;11515.694889563667;11707.356095414834;11772.646820595395;11800;10357.779001632405;11168.776624467628;11187.496562654538;11234.3259404436;11682.47428865686 20:23:38 INFO - PROCESS | 7434 | __end_tp_report 20:23:38 INFO - PROCESS | 7434 | __start_cc_report 20:23:38 INFO - PROCESS | 7434 | _x_x_mozilla_cycle_collect,848 20:23:38 INFO - PROCESS | 7434 | __end_cc_report 20:23:38 INFO - PROCESS | 7434 | __startTimestamp1467257018730__endTimestamp 20:23:38 INFO - PROCESS | 7434 | 20:23:38 INFO - PROCESS | 7434 | ------- Summary: start ------- 20:23:38 INFO - PROCESS | 7434 | Number of tests: 6 20:23:38 INFO - PROCESS | 7434 | 20:23:38 INFO - PROCESS | 7434 | [#0] dojo.html Cycles:165 Average:5402.99 Median:5626.89 stddev:627.09 (11.1%) stddev-sans-first:602.55 20:23:38 INFO - PROCESS | 7434 | Values: 3105.3 3125.4 3136.3 3156.0 3182.0 5239.2 5337.3 5354.5 5433.6 5468.8 5291.7 5297.8 5359.7 5392.1 5435.3 4745.6 4843.5 4850.2 4861.5 5136.5 5048.7 5054.6 5084.7 5111.1 5116.7 4694.5 4858.3 4887.9 4890.2 4892.4 4898.5 4974.0 4981.7 4987.0 5010.0 4762.2 4802.3 4946.0 4960.1 5000.6 5356.1 5428.2 5441.9 5449.8 5454.6 5812.5 5818.3 5819.0 5835.3 5843.0 5599.9 5844.1 5869.6 5897.7 5924.2 5552.9 5599.8 5612.4 5615.2 5615.2 6051.1 6053.1 6054.9 6090.9 6109.5 5550.3 5634.9 5675.2 5692.5 5856.5 5846.0 5858.0 5861.9 5863.8 5865.0 5728.1 5770.8 5773.3 5778.3 5782.7 5550.0 5750.8 5811.5 5827.6 5876.3 4448.8 4455.0 4462.0 4464.0 4490.4 3894.5 3960.2 3961.2 3963.7 4017.8 5304.9 5323.8 5362.2 5385.8 5421.2 5793.8 5794.4 5794.7 5797.1 5815.1 5377.1 5378.8 5395.6 5400.2 5401.1 4752.5 4967.1 5032.2 5034.9 5040.8 6042.5 6052.1 6056.5 6058.6 6059.2 5629.8 5846.0 5857.9 5859.9 5861.9 5976.1 6035.9 6050.2 6097.8 6104.1 5773.3 5797.5 5802.3 5802.5 5812.9 5493.7 5777.5 5896.0 5907.7 5908.3 5700.8 5749.7 5750.7 5754.0 5796.1 5679.9 5716.4 5732.1 5732.3 5736.4 5345.2 5538.1 5626.9 5629.9 5641.1 5739.5 5784.8 5825.6 5843.7 5844.7 5617.8 5652.0 5657.2 5660.8 5669.6 20:23:38 INFO - PROCESS | 7434 | 20:23:38 INFO - PROCESS | 7434 | [#1] ext.html Cycles:180 Average:61752.47 Median:42743.07 stddev:121595.87 (284.5%) stddev-sans-first:121850.28 20:23:38 INFO - PROCESS | 7434 | Values: 594.0 621.5 629.6 632.4 632.6 32687.8 42562.6 43193.6 43205.8 43357.8 44611.0 44972.6 44997.0 45009.8 45051.8 8892.5 9036.6 9037.9 9043.0 9043.2 8886.8 8958.4 8976.8 8979.0 8980.8 9018.1 9061.1 9067.6 9070.6 9071.6 8979.5 9007.5 9009.9 9024.4 9029.8 8854.2 8895.2 8917.8 8939.1 8944.1 42375.4 42721.1 42765.0 42826.4 42833.8 3215.4 3223.5 3239.8 3273.2 3287.2 30818.7 33171.2 33555.3 33593.8 35313.0 4297.5 4366.5 4476.4 4517.0 4573.1 362554.0 362620.0 362928.4 364656.0 365274.0 63199.0 63285.7 63649.0 63686.4 63750.4 55968.2 62808.4 64178.4 64310.7 71123.6 17980.9 18052.1 18147.7 18164.0 18165.6 12504.1 13782.9 13878.9 13900.2 13901.4 19027.7 19587.5 19587.5 19706.3 19984.3 7266.8 7359.2 7361.4 7423.8 7551.2 973.8 988.5 988.7 1001.3 1087.4 33236.7 33320.2 33342.2 33508.0 33735.2 1068.1 1084.3 1112.8 1115.6 1120.0 17063.3 17392.7 17666.5 17700.4 17717.5 541237.0 543118.0 544076.0 544814.0 545362.0 37109.0 37128.1 61240.7 61275.7 61398.0 1305.1 1362.7 1387.7 1391.7 1398.7 31511.8 32094.5 32602.0 32651.0 32994.7 53899.7 54165.5 54218.0 54249.2 54300.2 447638.0 447926.0 451239.0 453348.0 455309.0 24782.5 24889.8 29140.3 29531.0 29907.6 49518.3 49550.0 50275.5 50638.2 50987.0 39778.4 42183.6 42571.6 42626.0 42704.7 42354.6 42519.6 42539.1 42659.8 42974.4 41427.0 41496.8 41986.6 41995.0 42873.4 37467.6 38029.8 38279.2 38530.4 39068.4 28106.0 28321.9 28445.9 28475.7 28580.0 20:23:38 INFO - PROCESS | 7434 | 20:23:38 INFO - PROCESS | 7434 | [#2] jquery.html Cycles:180 Average:29328.10 Median:413.67 stddev:78803.61 (19049.7%) stddev-sans-first:78994.76 20:23:38 INFO - PROCESS | 7434 | Values: 411.6 412.6 414.7 415.1 424.6 18890.3 20420.4 20923.9 21288.8 21546.5 19894.3 20120.3 20403.5 20420.6 20509.4 5742.8 5931.8 5972.6 5973.9 5977.4 5577.0 5854.1 5857.1 5868.7 5871.4 5927.2 5933.9 5941.6 5957.3 5961.4 5502.3 5836.4 5881.7 5887.0 5922.1 5634.9 5711.3 5716.3 5718.7 5723.0 15162.8 15192.2 15391.5 15405.1 15442.9 2303.9 2318.6 2775.8 2995.7 3038.1 10722.8 11269.5 11297.8 11407.0 11480.4 1939.8 1996.8 2001.2 2003.5 2047.1 72977.6 73370.6 76488.6 85735.6 89574.0 11550.8 11568.4 11664.9 11722.2 12292.9 16453.9 16643.2 16656.1 16691.7 16696.3 7745.4 7900.6 8358.5 8362.2 8552.0 7798.9 7825.8 7944.0 8098.4 8158.4 5150.4 5150.4 5178.5 5186.2 5265.7 2034.8 2038.6 2042.6 2082.3 2098.9 907.9 929.6 932.7 938.4 946.4 19347.7 20805.4 20887.3 20892.4 21015.8 958.0 979.5 980.4 994.6 1047.8 10971.4 11637.4 11749.1 11759.1 11760.2 467514.0 477260.0 477687.0 478231.0 478511.0 99297.5 101143.5 101342.0 101863.5 101960.5 938.2 940.9 948.5 987.8 993.0 18661.5 18805.5 18842.4 18976.8 18989.7 44430.1 45387.0 46010.5 46377.5 46563.0 63520.4 65642.3 65751.7 66439.3 67047.0 7870.8 8373.9 8455.5 8566.0 9217.3 10249.4 13740.7 14062.7 14220.3 14465.6 11697.6 12342.5 12445.6 12503.7 12609.2 11828.9 11980.4 12212.2 12323.9 12474.9 11810.4 12167.2 12609.7 12766.9 13172.9 9502.2 9524.4 9549.8 9626.1 9714.1 9492.3 12145.3 12568.1 12795.6 12836.7 20:23:38 INFO - PROCESS | 7434 | 20:23:38 INFO - PROCESS | 7434 | [#3] mootools.html Cycles:180 Average:5971.29 Median:4836.27 stddev:3479.15 (71.9%) stddev-sans-first:3472.40 20:23:38 INFO - PROCESS | 7434 | Values: 1460.9 1513.7 1609.9 1764.7 1773.6 8826.7 9353.7 9437.2 9448.5 9449.1 7999.5 8757.3 9009.5 9097.4 9186.3 2362.7 2390.6 2391.2 2392.1 2397.2 2057.6 2347.3 2368.7 2391.3 2399.2 2279.2 2347.3 2347.6 2361.0 2361.9 2395.2 2401.2 2402.4 2432.5 2434.8 2366.7 2366.8 2375.5 2390.1 2435.6 9312.5 9434.2 9444.5 9452.5 9458.0 5333.5 5499.8 5503.3 5506.0 5507.4 3297.7 3341.9 3378.6 3472.7 3477.9 1041.9 1043.4 1057.6 1081.4 1090.8 12702.5 12777.8 12792.6 12812.5 12821.4 4485.8 4711.5 4735.3 4802.2 4841.2 10660.9 10730.4 10842.4 10853.2 10865.9 5303.0 5313.4 5321.2 5323.2 5338.8 4831.3 4888.2 4904.3 4911.7 5016.5 3903.3 3930.1 4027.9 4028.6 4043.8 1054.3 1138.4 1168.3 1178.9 1203.1 800.9 804.4 869.5 945.6 978.1 5623.5 5684.6 5781.3 5805.1 5819.2 957.9 959.8 960.9 986.8 1010.7 3778.2 3790.8 3866.8 3931.8 3976.0 11216.9 11406.2 11548.8 11576.6 11584.8 10181.1 10772.2 11174.7 11429.7 11517.8 8399.2 8477.0 8496.4 8632.3 8680.8 5995.2 6002.2 6045.2 6112.9 6136.1 10664.6 10674.2 10759.1 10778.4 10803.4 10555.6 10624.9 10709.9 10909.9 10943.8 7734.1 7748.3 7843.3 7848.7 7856.6 8987.3 9012.3 9087.1 9097.8 9151.5 6485.3 7894.3 7906.0 8236.9 8351.4 7798.6 7876.3 7897.9 8029.4 8142.7 7278.7 7327.2 7412.6 7419.9 7436.8 5049.2 5070.3 5112.4 5138.8 5146.4 5196.0 5216.7 5271.4 5336.0 5409.0 20:23:38 INFO - PROCESS | 7434 | 20:23:38 INFO - PROCESS | 7434 | [#4] prototype.html Cycles:180 Average:4579.65 Median:5160.56 stddev:1314.13 (25.5%) stddev-sans-first:1278.50 20:23:38 INFO - PROCESS | 7434 | Values: 328.5 332.2 335.2 337.9 341.3 5190.1 5295.5 5375.9 5376.7 5449.8 5348.1 5349.0 5358.4 5381.6 5391.6 4234.4 4250.7 4263.5 4283.7 4303.2 4005.0 4028.8 4128.5 4273.1 4280.1 4167.3 4178.2 4216.6 4231.1 4241.9 4202.0 4202.5 4219.5 4221.3 4232.1 3674.2 3763.8 3766.7 3773.3 3783.1 5160.8 5167.2 5188.5 5198.1 5207.3 4772.5 4807.2 4808.2 4845.9 4857.5 5327.5 5541.8 5553.4 5588.8 5604.9 4077.7 4113.8 4128.3 4131.0 4155.3 5795.2 5817.7 5867.2 5876.7 5900.0 4019.6 4188.0 4223.2 4229.1 4246.9 4201.1 4223.2 4237.4 4243.5 4260.0 4809.3 4822.3 4832.0 4834.5 4838.9 5386.4 5606.0 5620.6 5628.3 5665.5 1365.3 1404.4 1424.0 1434.3 1437.1 955.6 979.8 990.4 993.0 995.7 5322.0 5322.6 5324.4 5324.5 5355.5 5653.3 5678.3 5679.0 5684.4 5729.4 5141.8 5291.8 5313.0 5345.2 5355.8 2654.2 2660.9 2678.9 2683.8 2695.5 5178.0 5185.8 5200.8 5201.5 5228.8 4805.8 5075.9 5100.5 5110.5 5154.5 5146.2 5160.3 5173.3 5197.0 5207.3 4968.7 5024.0 5027.0 5059.3 5062.8 4791.7 4989.5 5000.5 5004.5 5010.1 5120.8 5150.8 5187.3 5225.8 5237.6 3705.3 3724.8 3760.4 3760.9 3796.6 5116.0 5406.7 5550.6 5657.7 5775.4 5445.3 5525.5 5525.8 5533.8 5598.5 5571.3 5573.2 5589.4 5604.4 5607.6 5288.8 5532.2 5541.2 5546.9 5551.9 5588.6 5615.7 5625.9 5632.6 5650.9 5255.4 5500.9 5522.6 5534.4 5534.4 20:23:38 INFO - PROCESS | 7434 | 20:23:38 INFO - PROCESS | 7434 | [#5] yui.html Cycles:180 Average:20652.72 Median:4634.65 stddev:29640.47 (639.5%) stddev-sans-first:29685.87 20:23:38 INFO - PROCESS | 7434 | Values: 729.2 773.2 799.8 818.8 840.4 14629.8 15763.2 15768.8 15777.8 15813.9 11585.1 14567.4 14829.4 14847.7 14871.9 772.8 804.7 810.7 814.1 814.4 792.6 794.7 797.0 799.2 801.1 686.7 817.4 843.2 846.8 847.0 825.2 831.7 838.7 839.1 839.3 617.4 617.6 617.9 618.0 618.1 14385.9 14397.1 14411.8 14417.6 14429.0 14642.7 14643.0 14654.5 14910.0 14973.5 12398.3 12567.2 12582.7 13487.5 13880.4 3867.5 3940.8 3976.8 3982.2 4003.1 65810.0 68853.7 68921.7 74232.0 75814.0 11188.2 11601.7 11664.9 11894.3 11919.7 21794.1 22010.7 22029.1 22083.0 22138.0 8395.5 8833.9 8905.9 8930.3 9325.6 4787.2 4835.6 4844.2 4976.4 5031.5 3513.8 3660.8 3665.8 3666.6 3670.6 649.9 652.1 655.1 677.2 678.8 631.7 650.2 655.3 663.9 668.9 8679.3 9600.0 9649.0 9695.7 9839.1 589.1 653.3 705.7 721.8 728.6 4409.3 4606.4 4624.8 4644.5 4730.7 70833.6 89204.1 113415.0 120454.0 120540.4 102719.0 104356.5 105037.0 105180.0 105535.0 89443.6 89714.0 90535.5 91921.5 92776.0 8607.1 8644.7 8709.7 8859.0 8870.3 49169.3 49451.0 50458.0 50567.7 51056.5 70492.6 76677.8 78414.6 79348.0 79649.6 11721.2 11843.2 11975.9 12443.9 12723.0 13841.4 14124.2 14255.5 14453.4 15453.0 13436.4 14025.0 14049.5 14143.4 14228.0 13604.3 13682.9 14469.5 14492.8 14965.8 13235.5 13374.6 13384.1 13660.2 13792.0 11310.7 11515.7 11707.4 11772.6 11800.0 10357.8 11168.8 11187.5 11234.3 11682.5 20:23:38 INFO - PROCESS | 7434 | -------- Summary: end -------- 20:23:38 INFO - PROCESS | 7434 | 20:23:39 INFO - TEST-INFO | 7434: exit 0 20:23:39 INFO - TEST-OK | dromaeo_css | took 1112422ms 20:23:39 INFO - TEST-START | kraken 20:23:39 INFO - operating with platform_type : linux_ 20:23:39 INFO - Initialising browser for kraken test... 20:23:39 INFO - TEST-INFO | started process 7622 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBzGkWw/profile http://localhost:40769/getInfo.html) 20:23:42 INFO - PROCESS | 7622 | __metrics Screen width/height:1600/1200 20:23:42 INFO - PROCESS | 7622 | colorDepth:24 20:23:42 INFO - PROCESS | 7622 | Browser inner width/height: 1024/697 20:23:42 INFO - PROCESS | 7622 | __metrics 20:23:43 INFO - PROCESS | 7622 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:23:44 INFO - TEST-INFO | 7622: exit 0 20:23:44 INFO - Browser initialized. 20:23:44 INFO - Running cycle 1/1 for kraken test... 20:23:44 INFO - TEST-INFO | started process 7706 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBzGkWw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:23:56 INFO - PROCESS | 7706 | RSS: Main: 157310976 20:23:56 INFO - PROCESS | 7706 | 20:23:58 INFO - PROCESS | 7706 | Cycle 1(1): loaded http://localhost:40769/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40769/tests/kraken/driver.html?testName=audio-beat-detection) 20:23:59 INFO - PROCESS | 7706 | RSS: Main: 214896640 20:23:59 INFO - PROCESS | 7706 | 20:24:02 INFO - PROCESS | 7706 | Cycle 1(1): loaded http://localhost:40769/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40769/tests/kraken/driver.html?testName=audio-dft) 20:24:02 INFO - PROCESS | 7706 | RSS: Main: 203960320 20:24:02 INFO - PROCESS | 7706 | 20:24:05 INFO - PROCESS | 7706 | Cycle 1(1): loaded http://localhost:40769/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40769/tests/kraken/driver.html?testName=audio-fft) 20:24:06 INFO - PROCESS | 7706 | RSS: Main: 269152256 20:24:06 INFO - PROCESS | 7706 | 20:24:08 INFO - PROCESS | 7706 | Cycle 1(1): loaded http://localhost:40769/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40769/tests/kraken/driver.html?testName=audio-oscillator) 20:24:09 INFO - PROCESS | 7706 | RSS: Main: 180506624 20:24:09 INFO - PROCESS | 7706 | 20:24:11 INFO - PROCESS | 7706 | Cycle 1(1): loaded http://localhost:40769/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40769/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:24:11 INFO - PROCESS | 7706 | RSS: Main: 184471552 20:24:11 INFO - PROCESS | 7706 | 20:24:14 INFO - PROCESS | 7706 | Cycle 1(1): loaded http://localhost:40769/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40769/tests/kraken/driver.html?testName=imaging-darkroom) 20:24:15 INFO - PROCESS | 7706 | RSS: Main: 220581888 20:24:15 INFO - PROCESS | 7706 | 20:24:18 INFO - PROCESS | 7706 | Cycle 1(1): loaded http://localhost:40769/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40769/tests/kraken/driver.html?testName=imaging-desaturate) 20:24:19 INFO - PROCESS | 7706 | RSS: Main: 221466624 20:24:19 INFO - PROCESS | 7706 | 20:24:22 INFO - PROCESS | 7706 | Cycle 1(1): loaded http://localhost:40769/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40769/tests/kraken/driver.html?testName=json-parse-financial) 20:24:22 INFO - PROCESS | 7706 | RSS: Main: 221089792 20:24:22 INFO - PROCESS | 7706 | 20:24:24 INFO - PROCESS | 7706 | Cycle 1(1): loaded http://localhost:40769/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40769/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:24:24 INFO - PROCESS | 7706 | RSS: Main: 208130048 20:24:24 INFO - PROCESS | 7706 | 20:24:26 INFO - PROCESS | 7706 | Cycle 1(1): loaded http://localhost:40769/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40769/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:24:27 INFO - PROCESS | 7706 | RSS: Main: 211288064 20:24:27 INFO - PROCESS | 7706 | 20:24:29 INFO - PROCESS | 7706 | Cycle 1(1): loaded http://localhost:40769/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40769/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:24:29 INFO - PROCESS | 7706 | RSS: Main: 211050496 20:24:29 INFO - PROCESS | 7706 | 20:24:32 INFO - PROCESS | 7706 | Cycle 1(1): loaded http://localhost:40769/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:24:33 INFO - PROCESS | 7706 | RSS: Main: 223555584 20:24:33 INFO - PROCESS | 7706 | 20:24:35 INFO - PROCESS | 7706 | Cycle 1(1): loaded http://localhost:40769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:24:36 INFO - PROCESS | 7706 | RSS: Main: 223907840 20:24:36 INFO - PROCESS | 7706 | 20:24:37 INFO - PROCESS | 7706 | Cycle 1(1): loaded http://localhost:40769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40769/tests/kraken/driver.html?testName=ai-astar) 20:24:38 INFO - PROCESS | 7706 | RSS: Main: 266625024 20:24:38 INFO - PROCESS | 7706 | 20:24:38 INFO - PROCESS | 7706 | __start_tp_report 20:24:38 INFO - PROCESS | 7706 | _x_x_mozilla_page_load 20:24:38 INFO - PROCESS | 7706 | _x_x_mozilla_page_load_details 20:24:38 INFO - PROCESS | 7706 | |i|pagename|runs| 20:24:38 INFO - PROCESS | 7706 | |0;ai-astar;105;110;112;110;111;112;111;110;111;109 20:24:38 INFO - PROCESS | 7706 | |1;audio-beat-detection;142;117;121;168;120;119;144;117;153;117 20:24:38 INFO - PROCESS | 7706 | |2;audio-dft;161;161;164;162;163;162;161;162;161;159 20:24:38 INFO - PROCESS | 7706 | |3;audio-fft;77;73;76;130;77;77;74;75;103;76 20:24:38 INFO - PROCESS | 7706 | |4;audio-oscillator;84;85;116;84;84;84;122;83;84;131 20:24:38 INFO - PROCESS | 7706 | |5;imaging-gaussian-blur;117;116;117;117;117;117;116;117;116;117 20:24:38 INFO - PROCESS | 7706 | |6;imaging-darkroom;145;146;146;146;145;146;146;146;145;145 20:24:38 INFO - PROCESS | 7706 | |7;imaging-desaturate;95;95;95;95;95;95;94;94;95;95 20:24:38 INFO - PROCESS | 7706 | |8;json-parse-financial;52;51;52;52;53;52;53;53;52;52 20:24:38 INFO - PROCESS | 7706 | |9;json-stringify-tinderbox;59;60;60;60;60;64;61;60;62;61 20:24:38 INFO - PROCESS | 7706 | |10;stanford-crypto-aes;75;75;74;74;74;75;74;73;79;79 20:24:38 INFO - PROCESS | 7706 | |11;stanford-crypto-ccm;126;117;118;121;123;119;119;118;161;132 20:24:38 INFO - PROCESS | 7706 | |12;stanford-crypto-pbkdf2;157;153;155;158;155;152;157;157;154;152 20:24:38 INFO - PROCESS | 7706 | |13;stanford-crypto-sha256-iterative;63;62;62;62;63;62;61;61;67;64 20:24:38 INFO - PROCESS | 7706 | __end_tp_report 20:24:38 INFO - PROCESS | 7706 | __start_cc_report 20:24:38 INFO - PROCESS | 7706 | _x_x_mozilla_cycle_collect,1639 20:24:38 INFO - PROCESS | 7706 | __end_cc_report 20:24:38 INFO - PROCESS | 7706 | __startTimestamp1467257078204__endTimestamp 20:24:38 INFO - PROCESS | 7706 | 20:24:38 INFO - PROCESS | 7706 | ------- Summary: start ------- 20:24:38 INFO - PROCESS | 7706 | Number of tests: 14 20:24:38 INFO - PROCESS | 7706 | 20:24:38 INFO - PROCESS | 7706 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.02 (1.8%) stddev-sans-first:1.00 20:24:38 INFO - PROCESS | 7706 | Values: 105.0 110.0 112.0 110.0 111.0 112.0 111.0 110.0 111.0 109.0 20:24:38 INFO - PROCESS | 7706 | 20:24:38 INFO - PROCESS | 7706 | [#1] audio-beat-detection Cycles:10 Average:131.80 Median:131.50 stddev:18.53 (14.1%) stddev-sans-first:19.28 20:24:38 INFO - PROCESS | 7706 | Values: 142.0 117.0 121.0 168.0 120.0 119.0 144.0 117.0 153.0 117.0 20:24:38 INFO - PROCESS | 7706 | 20:24:38 INFO - PROCESS | 7706 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.35 (0.8%) stddev-sans-first:1.41 20:24:38 INFO - PROCESS | 7706 | Values: 161.0 161.0 164.0 162.0 163.0 162.0 161.0 162.0 161.0 159.0 20:24:38 INFO - PROCESS | 7706 | 20:24:38 INFO - PROCESS | 7706 | [#3] audio-fft Cycles:10 Average:83.80 Median:76.00 stddev:18.42 (24.2%) stddev-sans-first:19.37 20:24:38 INFO - PROCESS | 7706 | Values: 77.0 73.0 76.0 130.0 77.0 77.0 74.0 75.0 103.0 76.0 20:24:38 INFO - PROCESS | 7706 | 20:24:38 INFO - PROCESS | 7706 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:84.00 stddev:19.18 (22.8%) stddev-sans-first:19.87 20:24:38 INFO - PROCESS | 7706 | Values: 84.0 85.0 116.0 84.0 84.0 84.0 122.0 83.0 84.0 131.0 20:24:38 INFO - PROCESS | 7706 | 20:24:38 INFO - PROCESS | 7706 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 20:24:38 INFO - PROCESS | 7706 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 20:24:38 INFO - PROCESS | 7706 | 20:24:38 INFO - PROCESS | 7706 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 20:24:38 INFO - PROCESS | 7706 | Values: 145.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 145.0 20:24:38 INFO - PROCESS | 7706 | 20:24:38 INFO - PROCESS | 7706 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:24:38 INFO - PROCESS | 7706 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 20:24:38 INFO - PROCESS | 7706 | 20:24:38 INFO - PROCESS | 7706 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.00 stddev:0.63 (1.2%) stddev-sans-first:0.67 20:24:38 INFO - PROCESS | 7706 | Values: 52.0 51.0 52.0 52.0 53.0 52.0 53.0 53.0 52.0 52.0 20:24:38 INFO - PROCESS | 7706 | 20:24:38 INFO - PROCESS | 7706 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:60.50 stddev:1.42 (2.3%) stddev-sans-first:1.36 20:24:38 INFO - PROCESS | 7706 | Values: 59.0 60.0 60.0 60.0 60.0 64.0 61.0 60.0 62.0 61.0 20:24:38 INFO - PROCESS | 7706 | 20:24:38 INFO - PROCESS | 7706 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:75.00 stddev:2.10 (2.8%) stddev-sans-first:2.22 20:24:38 INFO - PROCESS | 7706 | Values: 75.0 75.0 74.0 74.0 74.0 75.0 74.0 73.0 79.0 79.0 20:24:38 INFO - PROCESS | 7706 | 20:24:38 INFO - PROCESS | 7706 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:122.00 stddev:13.33 (10.9%) stddev-sans-first:14.13 20:24:38 INFO - PROCESS | 7706 | Values: 126.0 117.0 118.0 121.0 123.0 119.0 119.0 118.0 161.0 132.0 20:24:38 INFO - PROCESS | 7706 | 20:24:38 INFO - PROCESS | 7706 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.00 Median:156.00 stddev:2.21 (1.4%) stddev-sans-first:2.22 20:24:38 INFO - PROCESS | 7706 | Values: 157.0 153.0 155.0 158.0 155.0 152.0 157.0 157.0 154.0 152.0 20:24:38 INFO - PROCESS | 7706 | 20:24:38 INFO - PROCESS | 7706 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.50 stddev:1.77 (2.8%) stddev-sans-first:1.87 20:24:38 INFO - PROCESS | 7706 | Values: 63.0 62.0 62.0 62.0 63.0 62.0 61.0 61.0 67.0 64.0 20:24:38 INFO - PROCESS | 7706 | -------- Summary: end -------- 20:24:38 INFO - PROCESS | 7706 | 20:24:39 INFO - TEST-INFO | 7706: exit 0 20:24:39 INFO - TEST-OK | kraken | took 59912ms 20:24:39 INFO - SUITE-END | took 1172s 20:24:39 INFO - Completed test suite (00:19:32) 20:24:39 INFO - javascript benchmark 20:24:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3105.285784269618, 3125.4061728271613, 3136.2943337749, 3156.0058581546796, 3181.9976707337187, 5239.161734122541, 5337.332833395825, 5354.518093371596, 5433.6196466247375, 5468.835934921954, 5291.68249905006, 5297.761600727967, 5359.651622644536, 5392.110301800199, 5435.2934118564535, 4745.644076694236, 4843.467218605951, 4850.199717046683, 4861.538153875376, 5136.486351364871, 5048.722320272402, 5054.570361519275, 5084.745762711868, 5111.13110771168, 5116.744162791864, 4694.530546945312, 4858.344123543312, 4887.926681099786, 4890.217565189588, 4892.437369702494, 4898.485659005789, 4974.028486805881, 4981.676191047606, 4987.0, 5009.974950125263, 4762.166620841339, 4802.327674125625, 4945.975270123662, 4960.107180707471, 5000.62495312853, 5356.0894647909945, 5428.185772134172, 5441.891162176735, 5449.809256675997, 5454.61817672763, 5812.476877081083, 5818.272715910512, 5819.039858423355, 5835.270591176103, 5843.035899076647, 5599.888002239933, 5844.064949608042, 5869.559783016291, 5897.705114744245, 5924.229850119457, 5552.944470555242, 5599.80400685974, 5612.438756124396, 5615.1857980592995, 5615.241942337773, 6051.116374483393, 6053.127168202941, 6054.878867607297, 6090.908636370458, 6109.450149486567, 5550.278463799761, 5634.887302253932, 5675.2054712340305, 5692.48767610917, 5856.531477481792, 5846.0, 5858.033424484997, 5861.853453663693, 5863.765449381977, 5865.0, 5728.140778883201, 5770.798022069207, 5773.3072031356505, 5778.27771528559, 5782.653040817564, 5550.028744969614, 5750.7987220447085, 5811.476967072984, 5827.59206855516, 5876.324222714443, 4448.822047118079, 4455.0, 4461.955380446154, 4463.977680111643, 4490.438695163105, 3894.5131858517684, 3960.20795840833, 3961.207758448264, 3963.6630886374405, 4017.7589344639414, 5304.867378315573, 5323.787048518094, 5362.195670649434, 5385.78456861729, 5421.186821976657, 5793.826185214366, 5794.362620111784, 5794.681292528951, 5797.072468405035, 5815.098659707752, 5377.085895397791, 5378.78484860609, 5395.62230643859, 5400.21696853954, 5401.1358182691365, 4752.52474752522, 4967.105920934267, 5032.220005899091, 5034.874128146826, 5040.79836806531, 6042.4561789438285, 6052.092186172109, 6056.485198758067, 6058.636481811105, 6059.242594675666, 5629.831105066854, 5846.0, 5857.853553661193, 5859.94140058594, 5861.912071318849, 5976.103584462366, 6035.879282414415, 6050.21347224858, 6097.756089756537, 6104.084387341757, 5773.3072031356505, 5797.507211887037, 5802.303723553201, 5802.506786923159, 5812.912806307824, 5493.697846618475, 5777.480026797609, 5896.0, 5907.734151963086, 5908.261467316585, 5700.771969121189, 5749.655020698771, 5750.6837123958585, 5754.0, 5796.1305804129715, 5679.914801278067, 5716.399778023414, 5732.082866741468, 5732.283464566929, 5736.397678243724, 5345.22494238341, 5538.0585300499815, 5626.88746225065, 5629.8592535186945, 5641.069223578063, 5739.540836733135, 5784.82645520635, 5825.621334613236, 5843.707814609167, 5844.736986835517, 5617.831465056055, 5651.971740141273, 5657.2079908811975, 5660.801871934463, 5669.6314739541795], "value": 5360.1593905017135, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.0376589924323, 621.465539635913, 629.6064959400375, 632.4308122689575, 632.6235889645662, 32687.83656081719, 42562.57437425625, 43193.56806431935, 43205.7839710801, 43357.78321108394, 44611.0, 44972.55027449725, 44997.0, 45009.77495112528, 45051.774741126246, 8892.510911899843, 9036.593353299084, 9037.864432033524, 9042.954785226098, 9043.186113249807, 8886.822263554724, 8958.417702849327, 8976.820463590724, 8978.955105224464, 8980.775480613005, 9018.143276388733, 9061.093890610951, 9067.637294508211, 9070.591823367964, 9071.591778369957, 8979.461232326048, 9007.504587247699, 9009.909900900973, 9024.413413128126, 9029.819403611924, 8854.158854908774, 8895.243904268145, 8917.821643567157, 8939.061398553124, 8944.10558944107, 42375.36436953448, 42721.14557708828, 42765.0, 42826.35760463595, 42833.78583107064, 3215.3569286142865, 3223.503213017827, 3239.8380080995857, 3273.247153154764, 3287.2439338952177, 30818.691813081805, 33171.170720731934, 33555.328893421996, 33593.832030839934, 35313.0, 4297.505786834523, 4366.454193225847, 4476.444355863381, 4517.0, 4573.131105090022, 362554.0, 362620.0, 362928.40965337167, 364656.0, 365274.0, 63199.0, 63285.683571581845, 63649.0, 63686.36313636897, 63750.36249637537, 55968.16047759287, 62808.37191628117, 64178.35821641724, 64310.67844660841, 71123.64438177776, 17980.9100954497, 18052.09739513019, 18147.72778408325, 18164.0, 18165.636687266182, 12504.124711270306, 13782.862171378358, 13878.93060534711, 13900.16599004063, 13901.443942242398, 19027.714584281246, 19587.51031224231, 19587.51031224231, 19706.31027914016, 19984.300549480697, 7266.818329541698, 7359.190489046201, 7361.411087113125, 7423.8144046399275, 7551.244875512405, 973.8490533967247, 988.5304480371766, 988.6687959533493, 1001.2940876681922, 1087.4073629871739, 33236.66763332384, 33320.1669958253, 33342.16644583905, 33508.0, 33735.15662108418, 1068.1241382066787, 1084.2572837606265, 1112.777444511101, 1115.6039605939936, 1120.019982515299, 17063.269876819897, 17392.739108913378, 17666.470005899842, 17700.380486683163, 17717.46847594574, 541237.0, 543118.0, 544076.0, 544814.0, 545362.0, 37109.0, 37128.07179820526, 61240.69379653073, 61275.69362153161, 61398.0, 1305.145129939891, 1362.7410791949499, 1387.7224555088821, 1391.7494850926728, 1398.7132637809225, 31511.84244078765, 32094.518582221754, 32602.0, 32651.020469385956, 32994.67005329916, 53899.73050134724, 54165.45834541762, 54218.0, 54249.18626220689, 54300.185497216786, 447638.0, 447926.0, 451239.0, 453348.0, 455309.0, 24782.504349913263, 24889.751102489467, 29140.27149321284, 29531.0, 29907.55138672965, 49518.257226142356, 49550.0, 50275.49724502708, 50638.2404263929, 50987.0, 39778.425481070044, 42183.578164217965, 42571.574284258, 42626.0, 42704.71476351632, 42354.576454235066, 42519.5748042528, 42539.14921701487, 42659.786701066296, 42974.355384668626, 41427.0, 41496.792516037225, 41986.580134198266, 41995.0, 42873.35689964715, 37467.6253237475, 38029.809850950565, 38279.23441531098, 38530.422043669925, 39068.413973790986, 28106.0, 28321.858390707916, 28445.857770711842, 28475.715242847305, 28580.0], "value": 20482.556056832214, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.62336462137137, 412.61214458409114, 414.7366422321826, 415.0681719539634, 424.60723830456817, 18890.33883814067, 20420.387388378334, 20923.895380523096, 21288.787112128874, 21546.461338466546, 19894.303699370525, 20120.295789647364, 20403.48991275219, 20420.591588168227, 20509.38471845847, 5742.79900203494, 5931.762729490815, 5972.641641501524, 5973.940260597404, 5977.402259774031, 5576.972115139419, 5854.121881717734, 5857.121431785245, 5868.706564671771, 5871.383504732005, 5927.1998280232265, 5933.851653708649, 5941.613795103326, 5957.285125784891, 5961.374055724152, 5502.257195278647, 5836.416358364172, 5881.7353219105025, 5887.0, 5922.052471604544, 5634.915476267859, 5711.286089238845, 5716.314042314949, 5718.7426565804635, 5723.0, 15162.848371516255, 15192.240387980557, 15391.461298854487, 15405.075695458196, 15442.922785386114, 2303.8502497337618, 2318.6058370077126, 2775.764060054898, 2995.7303842654264, 3038.103759390985, 10722.839157412645, 11269.549218031269, 11297.774044519147, 11407.030402415805, 11480.368579728112, 1939.8351140153104, 1996.7603887533444, 2001.2495314257153, 2003.4991252186953, 2047.09927631843, 72977.6351118241, 73370.63314683446, 76488.61755691242, 85735.57132214299, 89574.0, 11550.768984620428, 11568.363739994213, 11664.88335116638, 11722.238054526599, 12292.938535307267, 16453.91773041151, 16643.167841607872, 16656.08391538477, 16691.749623755655, 16696.332146713994, 7745.419093568005, 7900.604969751489, 8358.540280284642, 8362.205590468895, 8551.957240213884, 7798.922010779819, 7825.843483130306, 7944.0, 8098.433109682265, 8158.4289099762445, 5150.381954165524, 5150.40770311419, 5178.533931946143, 5186.196139598368, 5265.657732247391, 2034.8096363627444, 2038.6228547718422, 2042.5795432412342, 2082.344061620585, 2098.8635738676935, 907.8638204269413, 929.6049179098991, 932.7201839448138, 938.380668758616, 946.3659348236698, 19347.734431189816, 20805.375838724558, 20887.26894558683, 20892.37322880316, 21015.78984210169, 957.9616815327448, 979.5298256836759, 980.3921568627354, 994.597188138805, 1047.8061558611682, 10971.396573188551, 11637.359945203096, 11749.118816088827, 11759.118066145073, 11760.235584686969, 467514.0, 477260.0, 477687.0, 478231.0, 478511.0, 99297.50351248342, 101143.49428252812, 101342.0, 101863.49068254759, 101960.49019755003, 938.1931538876561, 940.9059094090674, 948.5162567090833, 987.8320685483485, 992.9950350248203, 18661.533461663566, 18805.529861753017, 18842.434726958214, 18976.810231897503, 18989.71515427242, 44430.11139777251, 45387.0, 46010.53989460196, 46377.53622463867, 46563.0, 63520.364796351445, 65642.34357656362, 65751.67124164349, 66439.33560664332, 67047.0, 7870.84258314819, 8373.853050710326, 8455.534945578052, 8565.95717021411, 9217.262618990599, 10249.418157481998, 13740.65648358799, 14062.718745625234, 14220.288985550475, 14465.566033019026, 11697.649070527897, 12342.506299747909, 12445.62663120108, 12503.749925001632, 12609.243445393306, 11828.940855295668, 11980.400979950793, 12212.206206596542, 12323.876761232274, 12474.937625311815, 11810.40947952616, 12167.209131406431, 12609.747805043664, 12766.872331276569, 13172.868271317164, 9502.192313653417, 9524.428534287965, 9549.809003820024, 9626.133647971716, 9714.125728684452, 9492.335536512377, 12145.271283723005, 12568.120231583702, 12795.61613151607, 12836.743265134832], "value": 9514.068307822607, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1460.9488667896626, 1513.6518600721834, 1609.9114548699818, 1764.7000009998299, 1773.6364045370692, 8826.735197944065, 9353.719388418358, 9437.197838183754, 9448.527573621326, 9449.102335278138, 7999.4800337977995, 8757.255633271163, 9009.504477253748, 9097.363184577065, 9186.311026672993, 2362.7164740231156, 2390.6175011998084, 2391.151141344824, 2392.079049565912, 2397.2328854766483, 2057.609054279682, 2347.3099368454687, 2368.7039120109985, 2391.342380845264, 2399.196269249803, 2279.2364557873047, 2347.2606129069372, 2347.647852822073, 2361.0437772702085, 2361.917332893349, 2395.185636883459, 2401.1955994741784, 2402.387391215246, 2432.549978254011, 2434.7686969737847, 2366.6923299970895, 2366.7633236676365, 2375.477394973103, 2390.1395497620842, 2435.6346548017764, 9312.487813170274, 9434.245260379223, 9444.527773611291, 9452.52737363136, 9458.0, 5333.519983201491, 5499.780008799643, 5503.3120859892515, 5506.0, 5507.421720719347, 3297.7032067114073, 3341.866325346983, 3378.6283508814013, 3472.722182225416, 3477.8608855645743, 1041.9218558608059, 1043.4417586591212, 1057.5611121384616, 1081.4376524207446, 1090.8254679251281, 12702.491900324068, 12777.808332875014, 12792.61622151337, 12812.487500499969, 12821.423035963404, 4485.842995495142, 4711.505291944365, 4735.289706543977, 4802.183628783116, 4841.201201801734, 10660.94669526663, 10730.35617862915, 10842.403667798348, 10853.186011049045, 10865.945670271756, 5303.0454518186325, 5313.362396512366, 5321.2018197269945, 5323.2015197719875, 5338.839834804962, 4831.347768051339, 4888.169011268093, 4904.288878112654, 4911.68074075184, 5016.498350164954, 3903.2974064668633, 3930.0567863712504, 4027.859024934113, 4028.576999415078, 4043.8180281887385, 1054.3199636234585, 1138.3966497756037, 1168.3223730236443, 1178.9233699809486, 1203.0916657923212, 800.931920786728, 804.3685706720197, 869.4609342207872, 945.6359301668907, 978.1392374710209, 5623.465770751772, 5684.63049901755, 5781.335146458211, 5805.10020946754, 5819.185314056035, 957.9089986451276, 959.8032403357295, 960.8991055939166, 986.8125056239435, 1010.7372083258406, 3778.1876896466842, 3790.8483660653264, 3866.7873266970587, 3931.803409829497, 3976.0, 11216.943915280372, 11406.201565890475, 11548.826767598493, 11576.594819181288, 11584.826227606593, 10181.134603558632, 10772.245942784086, 11174.720631984103, 11429.714257143472, 11517.76964460706, 8399.202075802912, 8476.957615212008, 8496.362772792065, 8632.266257368068, 8680.78298042554, 5995.2206213192, 6002.189704389852, 6045.183900173421, 6112.938870611237, 6136.110264011782, 10664.560284361512, 10674.199435042558, 10759.08547773448, 10778.407187604756, 10803.351798891777, 10555.63055293061, 10624.8937510627, 10709.892901070889, 10909.890901090888, 10943.781124377309, 7734.071911370672, 7748.34139098183, 7843.254890785366, 7848.725294614661, 7856.607169641381, 8987.281017518451, 9012.2790176787, 9087.09129087086, 9097.818043639223, 9151.496667683341, 6485.28661847187, 7894.250046245597, 7905.960470197612, 8236.929199204305, 8351.373646976623, 7798.610069496616, 7876.251756083163, 7897.881531776913, 8029.397795165502, 8142.715004974797, 7278.745243916437, 7327.194008659149, 7412.62936853166, 7419.851602967802, 7436.814079648052, 5049.2173713074535, 5070.264811602371, 5112.412072611549, 5138.820141295037, 5146.408163061295, 5195.9740201298755, 5216.713080780593, 5271.446498117796, 5336.039512887717, 5408.972955135199], "value": 4717.741676749595, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.4695217224184, 332.18283023761546, 335.24067986011687, 337.868231389758, 341.30203733365266, 5190.143626301656, 5295.464315348544, 5375.865603359918, 5376.704281264529, 5449.754761035753, 5348.11201950946, 5348.973255133728, 5358.401175429924, 5381.569474442045, 5391.649542779716, 4234.386014027964, 4250.744955302692, 4263.531011588722, 4283.700140990132, 4303.24693178694, 4004.9599504005023, 4028.8388464461386, 4128.483939507561, 4273.124009578045, 4280.143971205755, 4167.3330667733, 4178.206140833247, 4216.5572614875455, 4231.1114665920195, 4241.936370954438, 4201.957980420202, 4202.474690663667, 4219.514755803091, 4221.324588065925, 4232.132412855357, 3674.236366544047, 3763.8118094095457, 3766.679832214265, 3773.2642134783728, 3783.148791521913, 5160.793568257265, 5167.224916262553, 5188.481151884781, 5198.116320225571, 5207.3230480037355, 4772.546608072227, 4807.230843065093, 4808.206645903421, 4845.854624361275, 4857.514248575149, 5327.46725327468, 5541.806036788693, 5553.416891226444, 5588.7704704965245, 5604.859878503029, 4077.673786097105, 4113.773742444165, 4128.318827393477, 4131.0, 4155.31437312843, 5795.1886735857015, 5817.650940943557, 5867.207926929853, 5876.7355469004, 5900.0, 4019.6382325590253, 4187.97906010468, 4223.239816832999, 4229.111886503807, 4246.853349595592, 4201.138766552849, 4223.239816832999, 4237.427947227146, 4243.490781106225, 4259.9787001065415, 4809.254565542346, 4822.324874517571, 4832.0, 4834.492378300228, 4838.854834354975, 5386.407495175527, 5605.971970140124, 5620.634658747168, 5628.296462942132, 5665.450547253752, 1365.2968721108637, 1404.4171668757351, 1423.9676234729739, 1434.2685230532295, 1437.1018113678952, 955.5652178258875, 979.8481235408523, 990.390909590611, 992.950352482373, 995.6564985080136, 5322.0, 5322.574194064543, 5324.361076670824, 5324.4675532446445, 5355.518003379714, 5653.265075540236, 5678.3186017678145, 5678.971605141948, 5684.431556844283, 5729.427057294237, 5141.820036298712, 5291.814786482455, 5312.9734351328, 5345.1982202669915, 5355.839324820262, 2654.2170059832397, 2660.884596745592, 2678.8614838693866, 2683.7852971762213, 2695.528282550546, 5177.990291893045, 5185.818496352685, 5200.76596553156, 5201.531862132426, 5228.843134705889, 4805.783739731721, 5075.873103172376, 5100.515451032146, 5110.514501122388, 5154.484551544815, 5146.202338637517, 5160.329157209539, 5173.301604283449, 5197.0125676121415, 5207.297014903015, 4968.7081358846235, 5024.0, 5027.0, 5059.342285502861, 5062.797488100582, 4791.736454494897, 4989.501049894981, 5000.499950004971, 5004.549590536869, 5010.144217795967, 5120.820771272987, 5150.793968241228, 5187.325647665779, 5225.824189557471, 5237.580993520433, 3705.27747089315, 3724.776513409204, 3760.4359346098304, 3760.8871733848027, 3796.5633952095864, 5115.974420127875, 5406.675599464044, 5550.639208451437, 5657.745401457027, 5775.364709881826, 5445.292112025411, 5525.502704756591, 5525.806596769094, 5533.750981205775, 5598.524125449382, 5571.303587051619, 5573.21974923503, 5589.413111623384, 5604.439556044363, 5607.635503692411, 5288.788448462018, 5532.1701744737, 5541.16882467617, 5546.916796247979, 5551.863197293516, 5588.5630337343055, 5615.747291371979, 5625.915611265917, 5632.605717599728, 5650.915236271541, 5255.448177941261, 5500.917486237629, 5522.6134170607675, 5534.39121696605, 5534.446555344594], "value": 4164.899165170628, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.1978823294376, 773.1688434932449, 799.8200404908896, 818.7707441916258, 840.4411066640686, 14629.780553291695, 15763.21183940804, 15768.842311576895, 15777.763333549978, 15813.920930395347, 11585.07319414447, 14567.417303307882, 14829.406823727066, 14847.703045939075, 14871.851281487181, 772.8377040821421, 804.7304153108686, 810.7324582887662, 814.0516298512226, 814.3892080939296, 792.627465091409, 794.682127149142, 796.9840603187932, 799.2207597592359, 801.1027649033091, 686.7115811359216, 817.4114637461048, 843.2073850580465, 846.8010017645848, 847.0343808058818, 825.1789469477848, 831.7380025292014, 838.7483754873514, 839.0602525171786, 839.2530647723501, 617.4381313005189, 617.6232498176109, 617.941295576924, 618.0, 618.0821480102045, 14385.85614143866, 14397.136171829723, 14411.78382324266, 14417.639559011108, 14429.0, 14642.707145857023, 14643.0, 14654.487092951802, 14910.0, 14973.475928342565, 12398.31809250491, 12567.245965242024, 12582.748345033047, 13487.527936522174, 13880.4447822088, 3867.497225360685, 3940.7647914790027, 3976.8011599419915, 3982.1637456134245, 4003.079291762911, 65810.0, 68853.65573172102, 68921.65539172322, 74232.0, 75814.0, 11188.216824822348, 11601.709957251136, 11664.883351166549, 11894.286342819458, 11919.702007449883, 21794.128234870746, 22010.669839952414, 22029.118835246732, 22083.0, 22138.003789829498, 8395.538245396561, 8833.867491987625, 8905.866412003825, 8930.330225233134, 9325.580348884316, 4787.234042553175, 4835.6131509479155, 4844.15227335222, 4976.402831660224, 5031.547160755549, 3513.8418771154847, 3660.7986560739414, 3665.780053196817, 3666.578343490533, 3670.5595328560744, 649.857031453089, 652.1391762873056, 655.0763423572739, 677.1670844860848, 678.7997540725498, 631.6999425272959, 650.2164891305965, 655.2922843329193, 663.9269680335159, 668.8695704337607, 8679.305655547541, 9599.952000240093, 9648.951755241178, 9695.70912872615, 9839.114479696862, 589.1222079102107, 653.3303364051885, 705.7494589420785, 721.7906807026009, 728.6429649471827, 4409.294512877988, 4606.355110284563, 4624.768761561909, 4644.535546445396, 4730.668853180245, 70833.64583177051, 89204.10795892088, 113415.0, 120454.0, 120540.39729801295, 102719.0, 104356.47821760843, 105037.0, 105180.0, 105535.0, 89443.55278223567, 89714.0, 90535.54732226429, 91921.54039229761, 92776.0, 8607.139286071342, 8644.697435589724, 8709.738707838775, 8858.955705221433, 8870.334724895529, 49169.26246106383, 49451.0, 50458.0, 50567.74716126543, 51056.48943510666, 70492.64753676199, 76677.84983225368, 78414.60792696, 79348.0, 79649.60175199086, 11721.179517433698, 11843.1709780318, 11975.940120299343, 12443.875561244271, 12723.0, 13841.4463421462, 14124.223167725873, 14255.50105746294, 14453.421863125357, 15453.0, 13436.375164123025, 14025.0, 14049.508267210598, 14143.434262629791, 14228.0, 13604.319784010957, 13682.93158534201, 14469.49356772508, 14492.782608261095, 14965.775513367525, 13235.470581176645, 13374.598762037154, 13384.130031547918, 13660.180389176681, 13792.0, 11310.717232069264, 11515.694889563667, 11707.356095414834, 11772.646820595395, 11800.0, 10357.779001632405, 11168.776624467628, 11187.496562654538, 11234.3259404436, 11682.47428865686], "value": 7536.8015002754, "unit": "score"}], "name": "dromaeo_css", "value": 7326.83934974778, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 110.0, 112.0, 110.0, 111.0, 112.0, 111.0, 110.0, 111.0, 109.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 117.0, 121.0, 168.0, 120.0, 119.0, 144.0, 117.0, 153.0, 117.0], "value": 131.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 164.0, 162.0, 163.0, 162.0, 161.0, 162.0, 161.0, 159.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 76.0, 130.0, 77.0, 77.0, 74.0, 75.0, 103.0, 76.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 116.0, 84.0, 84.0, 84.0, 122.0, 83.0, 84.0, 131.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 52.0, 53.0, 52.0, 53.0, 53.0, 52.0, 52.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 60.0, 64.0, 61.0, 60.0, 62.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 74.0, 74.0, 75.0, 74.0, 73.0, 79.0, 79.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 117.0, 118.0, 121.0, 123.0, 119.0, 119.0, 118.0, 161.0, 132.0], "value": 125.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 153.0, 155.0, 158.0, 155.0, 152.0, 157.0, 157.0, 154.0, 152.0], "value": 155.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 63.0, 62.0, 61.0, 61.0, 67.0, 64.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1471.3000000000002, "alertThreshold": 2.0}]} 20:24:39 INFO - Return code: 0 20:24:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:24:39 INFO - # TBPL SUCCESS # 20:24:39 INFO - Running post-action listener: _resource_record_post_action 20:24:39 INFO - ##### 20:24:39 INFO - ##### Finished run-tests step (success) 20:24:39 INFO - ##### 20:24:39 INFO - Running post-run listener: _resource_record_post_run 20:24:40 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 556457984; Read time: 16; Write time: 453408 20:24:40 INFO - TinderboxPrint: CPU usage
13.0% 20:24:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 20:24:40 INFO - TinderboxPrint: I/O write bytes / time
556,457,984 / 453,408 20:24:40 INFO - TinderboxPrint: CPU idle
8,262.3 (87.0%) 20:24:40 INFO - TinderboxPrint: CPU user
1,192.9 (12.6%) 20:24:40 INFO - TinderboxPrint: Swap in / out
0 / 0 20:24:40 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 255475712; Read time: 0; Write time: 240824 20:24:40 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 300982272; Read time: 0; Write time: 212584 20:24:40 INFO - Running post-run listener: _upload_blobber_files 20:24:40 INFO - Blob upload gear active. 20:24:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:24:40 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 20:24:40 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:24:40 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:24:41 INFO - (blobuploader) - INFO - Open directory for files ... 20:24:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:24:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:24:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:24:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:24:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:24:45 INFO - (blobuploader) - INFO - Done attempting. 20:24:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:24:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:24:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:24:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:24:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:24:45 INFO - (blobuploader) - INFO - Done attempting. 20:24:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:24:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:24:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:24:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:24:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:24:46 INFO - (blobuploader) - INFO - Done attempting. 20:24:46 INFO - (blobuploader) - INFO - Iteration through files over. 20:24:46 INFO - Return code: 0 20:24:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:24:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:24:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e060a0bf559e5ad360d10703046d58e4de4277c02567b26aa903de55980fffba58893e637e61d23ac64e6eec17048155e3161dc35377cb52bb654f7ba857869", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2aeae7a68f2fcc096542e72873d2f0414af9fddf3ff96b91cff944d1f9660f13592c1e00112f853bf35b02e95b6c6ccc69faab0b905991c216bad957f0a3687", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e204c9ad9fb980a437d92231a9fafd328720631745ffa0d9ee6b108eb389b777da6506ad04d27a6f4017637422422a4369b00bbb08ebdfdd98782b51a2e7dfa0"} 20:24:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:24:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:24:46 INFO - Contents: 20:24:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e060a0bf559e5ad360d10703046d58e4de4277c02567b26aa903de55980fffba58893e637e61d23ac64e6eec17048155e3161dc35377cb52bb654f7ba857869", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2aeae7a68f2fcc096542e72873d2f0414af9fddf3ff96b91cff944d1f9660f13592c1e00112f853bf35b02e95b6c6ccc69faab0b905991c216bad957f0a3687", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e204c9ad9fb980a437d92231a9fafd328720631745ffa0d9ee6b108eb389b777da6506ad04d27a6f4017637422422a4369b00bbb08ebdfdd98782b51a2e7dfa0"} 20:24:46 INFO - Running post-run listener: copy_logs_to_upload_dir 20:24:46 INFO - Copying logs to upload dir... 20:24:46 INFO - mkdir: /builds/slave/test/build/upload/logs 20:24:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.410141 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-29 20:24:45.923574) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 20:24:45.927549) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1467253861.786744-1310156976 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/sha512/2e060a0bf559e5ad360d10703046d58e4de4277c02567b26aa903de55980fffba58893e637e61d23ac64e6eec17048155e3161dc35377cb52bb654f7ba857869", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2aeae7a68f2fcc096542e72873d2f0414af9fddf3ff96b91cff944d1f9660f13592c1e00112f853bf35b02e95b6c6ccc69faab0b905991c216bad957f0a3687", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e204c9ad9fb980a437d92231a9fafd328720631745ffa0d9ee6b108eb389b777da6506ad04d27a6f4017637422422a4369b00bbb08ebdfdd98782b51a2e7dfa0"} build_url:https://queue.taskcluster.net/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011252 build_url: 'https://queue.taskcluster.net/v1/task/RoyLrB2_QZ2QBrU5CG-pDA/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/sha512/2e060a0bf559e5ad360d10703046d58e4de4277c02567b26aa903de55980fffba58893e637e61d23ac64e6eec17048155e3161dc35377cb52bb654f7ba857869", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2aeae7a68f2fcc096542e72873d2f0414af9fddf3ff96b91cff944d1f9660f13592c1e00112f853bf35b02e95b6c6ccc69faab0b905991c216bad957f0a3687", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e204c9ad9fb980a437d92231a9fafd328720631745ffa0d9ee6b108eb389b777da6506ad04d27a6f4017637422422a4369b00bbb08ebdfdd98782b51a2e7dfa0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 20:24:45.954047) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 20:24:45.954405) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1467253861.786744-1310156976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004405 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 20:24:46.035350) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 20:24:46.035723) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 20:24:46.036118) ========= ========= Total master_lag: 0.16 =========