builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1468056324.3 results: success (0) buildid: 20160708233021 builduid: 10d500cb1d874b6fb6b25848e724f7ae revision: 95c5d3617db2355aed67724a9d8180d9c6cd0467 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:24.299007) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:24.299534) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:24.300140) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:24.337561) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:24.337871) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1468055835.498396-1611438415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-09 02:25:24-- 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% 225M=0s 2016-07-09 02:25:24 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122306 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:24.555986) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:24.556337) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1468055835.498396-1611438415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020991 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:24.601453) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:24.601801) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 95c5d3617db2355aed67724a9d8180d9c6cd0467 --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 95c5d3617db2355aed67724a9d8180d9c6cd0467 --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=82c74bd3bc9a11c5833d2010000001e6-1468055835.498396-1611438415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-09 02:25:24,914 truncating revision to first 12 chars 2016-07-09 02:25:24,914 Setting DEBUG logging. 2016-07-09 02:25:24,914 attempt 1/10 2016-07-09 02:25:24,914 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/95c5d3617db2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-09 02:25:25,422 unpacking tar archive at: fx-team-95c5d3617db2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.895653 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:25.517799) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:25.518123) ========= script_repo_revision: 95c5d3617db2355aed67724a9d8180d9c6cd0467 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:25.518512) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:25.518777) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-09 02:25:25.532526) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-09 02:25:25.532858) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1468055835.498396-1611438415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:25:25 INFO - MultiFileLogger online at 20160709 02:25:25 in /builds/slave/test 02:25:25 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 02:25:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:25:25 INFO - {'append_to_log': False, 02:25:25 INFO - 'base_work_dir': '/builds/slave/test', 02:25:25 INFO - 'blob_upload_branch': 'Fx-Team', 02:25:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:25:25 INFO - 'branch': 'Fx-Team', 02:25:25 INFO - 'buildbot_json_path': 'buildprops.json', 02:25:25 INFO - 'config_files': ('talos/linux_config.py',), 02:25:25 INFO - 'default_actions': ('clobber', 02:25:25 INFO - 'read-buildbot-config', 02:25:25 INFO - 'download-and-extract', 02:25:25 INFO - 'populate-webroot', 02:25:25 INFO - 'create-virtualenv', 02:25:25 INFO - 'install', 02:25:25 INFO - 'run-tests'), 02:25:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:25:25 INFO - 'download_minidump_stackwalk': True, 02:25:25 INFO - 'download_symbols': 'ondemand', 02:25:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:25:25 INFO - 'tooltool.py': '/tools/tooltool.py', 02:25:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:25:25 INFO - '/tools/misc-python/virtualenv.py')}, 02:25:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:25:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:25:25 INFO - 'installer_path': 'installer.exe', 02:25:25 INFO - 'log_level': 'info', 02:25:25 INFO - 'log_name': 'talos', 02:25:25 INFO - 'log_to_console': True, 02:25:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:25:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:25:25 INFO - 'opt_config_files': (), 02:25:25 INFO - 'pip_index': False, 02:25:25 INFO - 'sps_profile': False, 02:25:25 INFO - 'sps_profile_interval': 0, 02:25:25 INFO - 'suite': 'dromaeojs', 02:25:25 INFO - 'system_bits': '32', 02:25:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:25:25 INFO - 'title': 'talos-linux64-ix-066', 02:25:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:25:25 INFO - 'use_talos_json': True, 02:25:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:25:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:25:25 INFO - 'work_dir': 'build'} 02:25:25 INFO - ##### 02:25:25 INFO - ##### Running clobber step. 02:25:25 INFO - ##### 02:25:25 INFO - Running pre-action listener: _resource_record_pre_action 02:25:25 INFO - Running main action method: clobber 02:25:25 INFO - rmtree: /builds/slave/test/build 02:25:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:25:26 INFO - Running post-action listener: _resource_record_post_action 02:25:26 INFO - ##### 02:25:26 INFO - ##### Finished clobber step (success) 02:25:26 INFO - ##### 02:25:26 INFO - ##### 02:25:26 INFO - ##### Running read-buildbot-config step. 02:25:26 INFO - ##### 02:25:26 INFO - Running pre-action listener: _resource_record_pre_action 02:25:26 INFO - Running main action method: read_buildbot_config 02:25:26 INFO - Using buildbot properties: 02:25:26 INFO - { 02:25:26 INFO - "project": "", 02:25:26 INFO - "product": "firefox", 02:25:26 INFO - "script_repo_revision": "production", 02:25:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:25:26 INFO - "repository": "", 02:25:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:25:26 INFO - "buildid": "20160708233021", 02:25:26 INFO - "pgo_build": "True", 02:25:26 INFO - "basedir": "/builds/slave/test", 02:25:26 INFO - "buildnumber": 267, 02:25:26 INFO - "slavename": "talos-linux64-ix-066", 02:25:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:25:26 INFO - "platform": "ubuntu64_hw", 02:25:26 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:25:26 INFO - "branch": "fx-team", 02:25:26 INFO - "repo_path": "integration/fx-team", 02:25:26 INFO - "revision": "95c5d3617db2355aed67724a9d8180d9c6cd0467", 02:25:26 INFO - "stage_platform": "linux64-pgo", 02:25:26 INFO - "builduid": "10d500cb1d874b6fb6b25848e724f7ae", 02:25:26 INFO - "slavebuilddir": "test" 02:25:26 INFO - } 02:25:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:25:26 INFO - Running post-action listener: _resource_record_post_action 02:25:26 INFO - ##### 02:25:26 INFO - ##### Finished read-buildbot-config step (success) 02:25:26 INFO - ##### 02:25:26 INFO - ##### 02:25:26 INFO - ##### Running download-and-extract step. 02:25:26 INFO - ##### 02:25:26 INFO - Running pre-action listener: _resource_record_pre_action 02:25:26 INFO - Running main action method: download_and_extract 02:25:26 INFO - mkdir: /builds/slave/test/build/tests 02:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:26 INFO - https://queue.taskcluster.net/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:25:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:25:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:25:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/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 02:25:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/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 02:25:29 INFO - Downloaded 1361 bytes. 02:25:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:25:29 INFO - Using the following test package requirements: 02:25:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:25:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:25:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:25:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:25:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:25:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:25:29 INFO - u'jsshell-linux-x86_64.zip'], 02:25:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:25:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:25:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:25:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:25:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:25:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:25:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:25:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:25:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:25:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:25:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:25:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:25:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:29 INFO - https://queue.taskcluster.net/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:25:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:25:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:25:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/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 02:25:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/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 02:25:30 INFO - Downloaded 24305234 bytes. 02:25:30 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'] 02:25:30 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 02:25:31 INFO - Return code: 0 02:25:31 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 02:25:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:31 INFO - https://queue.taskcluster.net/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:25:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:25:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:25:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/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 02:25:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/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 02:25:33 INFO - Downloaded 24305234 bytes. 02:25:33 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'] 02:25:33 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 02:25:34 INFO - Return code: 0 02:25:34 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')]} 02:25:34 INFO - https://queue.taskcluster.net/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:25:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:25:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:25:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/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 02:25:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/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 02:25:35 INFO - Downloaded 14403333 bytes. 02:25:35 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'] 02:25:35 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 02:25:36 INFO - Return code: 0 02:25:36 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')]} 02:25:36 INFO - https://queue.taskcluster.net/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:25:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:25:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:25:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/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 02:25:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAziZyZ2S6qZn0XJgBrOqw/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 02:25:37 INFO - Downloaded 60461554 bytes. 02:25:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:25:37 INFO - mkdir: /builds/slave/test/properties 02:25:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:25:37 INFO - Writing to file /builds/slave/test/properties/build_url 02:25:37 INFO - Contents: 02:25:37 INFO - build_url:https://queue.taskcluster.net/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:25:38 INFO - Running post-action listener: _resource_record_post_action 02:25:38 INFO - Running post-action listener: set_extra_try_arguments 02:25:38 INFO - ##### 02:25:38 INFO - ##### Finished download-and-extract step (success) 02:25:38 INFO - ##### 02:25:38 INFO - ##### 02:25:38 INFO - ##### Running populate-webroot step. 02:25:38 INFO - ##### 02:25:38 INFO - Running pre-action listener: _resource_record_pre_action 02:25:38 INFO - Running main action method: populate_webroot 02:25:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:25:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:25:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:25:38 INFO - '--tppagecycles', 02:25:38 INFO - '7'], 02:25:38 INFO - 'tests': ['tsvgm']}}, 02:25:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:25:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:25:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:25:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:25:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:25:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:25:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:38 INFO - 'talos_options': ['--disable-e10s'], 02:25:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:25:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:25:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:38 INFO - 'talos_options': ['--disable-e10s'], 02:25:38 INFO - 'tests': ['damp', 'tps']}, 02:25:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:38 INFO - 'tests': ['damp', 'tps']}, 02:25:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:25:38 INFO - 'tests': ['dromaeo_dom']}, 02:25:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:25:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:25:38 INFO - 'tests': ['basic_compositor_video']}, 02:25:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:25:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:25:38 INFO - 'tests': ['a11yr', 02:25:38 INFO - 'ts_paint', 02:25:38 INFO - 'tpaint', 02:25:38 INFO - 'sessionrestore', 02:25:38 INFO - 'sessionrestore_no_auto_restore', 02:25:38 INFO - 'tabpaint']}, 02:25:38 INFO - 'other-e10s': {'tests': ['a11yr', 02:25:38 INFO - 'ts_paint', 02:25:38 INFO - 'tpaint', 02:25:38 INFO - 'sessionrestore', 02:25:38 INFO - 'sessionrestore_no_auto_restore', 02:25:38 INFO - 'tabpaint']}, 02:25:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:25:38 INFO - 'ts_paint', 02:25:38 INFO - 'tpaint', 02:25:38 INFO - 'sessionrestore', 02:25:38 INFO - 'sessionrestore_no_auto_restore', 02:25:38 INFO - 'tabpaint']}, 02:25:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:25:38 INFO - 'ts_paint', 02:25:38 INFO - 'tpaint', 02:25:38 INFO - 'sessionrestore', 02:25:38 INFO - 'sessionrestore_no_auto_restore', 02:25:38 INFO - 'tabpaint']}, 02:25:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:25:38 INFO - 'tests': ['a11yr', 02:25:38 INFO - 'ts_paint', 02:25:38 INFO - 'tpaint', 02:25:38 INFO - 'sessionrestore', 02:25:38 INFO - 'sessionrestore_no_auto_restore', 02:25:38 INFO - 'tabpaint']}, 02:25:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:25:38 INFO - 'tests': ['a11yr', 02:25:38 INFO - 'ts_paint', 02:25:38 INFO - 'tpaint', 02:25:38 INFO - 'sessionrestore', 02:25:38 INFO - 'sessionrestore_no_auto_restore', 02:25:38 INFO - 'tabpaint']}, 02:25:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:25:38 INFO - 'tests': ['tsvgx', 02:25:38 INFO - 'tsvgr_opacity', 02:25:38 INFO - 'tart', 02:25:38 INFO - 'tscrollx', 02:25:38 INFO - 'cart']}, 02:25:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:25:38 INFO - 'tsvgr_opacity', 02:25:38 INFO - 'tart', 02:25:38 INFO - 'tscrollx', 02:25:38 INFO - 'cart']}, 02:25:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:38 INFO - 'talos_options': ['--disable-e10s'], 02:25:38 INFO - 'tests': ['tp5o']}, 02:25:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:38 INFO - 'tests': ['tp5o']}, 02:25:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:38 INFO - 'talos_options': ['--disable-e10s', 02:25:38 INFO - '--xperf_path', 02:25:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:25:38 INFO - 'tests': ['tp5n']}, 02:25:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:38 INFO - 'talos_options': ['--xperf_path', 02:25:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:25:38 INFO - 'tests': ['tp5n']}}, 02:25:38 INFO - 'talos.zip': {'path': '', 02:25:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:25:38 INFO - Running post-action listener: _resource_record_post_action 02:25:38 INFO - ##### 02:25:38 INFO - ##### Finished populate-webroot step (success) 02:25:38 INFO - ##### 02:25:38 INFO - ##### 02:25:38 INFO - ##### Running create-virtualenv step. 02:25:38 INFO - ##### 02:25:38 INFO - Running pre-action listener: _resource_record_pre_action 02:25:38 INFO - Running main action method: create_virtualenv 02:25:38 INFO - Creating virtualenv /builds/slave/test/build/venv 02:25:38 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 02:25:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:25:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:25:38 INFO - Using real prefix '/usr' 02:25:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:25:39 INFO - Installing distribute.............................................................................................................................................................................................done. 02:25:41 INFO - Installing pip.................done. 02:25:41 INFO - Return code: 0 02:25:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:25: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')]} 02:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25: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')]} 02:25:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:41 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 0x262a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e93b0>, '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 0x28ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ea740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1468055835.498396-1611438415', '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 02:25:41 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 02:25:41 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 02:25:41 INFO - Using env: {'DISPLAY': ':0', 02:25:41 INFO - 'HOME': '/home/cltbld', 02:25:41 INFO - 'LANG': 'en_US.UTF-8', 02:25:41 INFO - 'LANGUAGE': 'en_US:en', 02:25:41 INFO - 'LOGNAME': 'cltbld', 02:25:41 INFO - 'MAIL': '/var/mail/cltbld', 02:25:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:41 INFO - 'MOZ_NO_REMOTE': '1', 02:25:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:41 INFO - 'NO_EM_RESTART': '1', 02:25:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:41 INFO - 'PWD': '/builds/slave/test', 02:25:41 INFO - 'SHELL': '/bin/bash', 02:25:41 INFO - 'SHLVL': '1', 02:25:41 INFO - 'TERM': 'linux', 02:25:41 INFO - 'TMOUT': '86400', 02:25:41 INFO - 'USER': 'cltbld', 02:25:41 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468055835.498396-1611438415', 02:25:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:41 INFO - '_': '/tools/buildbot/bin/python'} 02:25:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:41 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 02:25:41 INFO - Cleaning up... 02:25:41 INFO - Return code: 0 02:25:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:25: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')]} 02:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25: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')]} 02:25:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:41 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 0x262a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e93b0>, '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 0x28ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ea740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1468055835.498396-1611438415', '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 02:25:41 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 02:25:41 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 02:25:41 INFO - Using env: {'DISPLAY': ':0', 02:25:41 INFO - 'HOME': '/home/cltbld', 02:25:41 INFO - 'LANG': 'en_US.UTF-8', 02:25:41 INFO - 'LANGUAGE': 'en_US:en', 02:25:41 INFO - 'LOGNAME': 'cltbld', 02:25:41 INFO - 'MAIL': '/var/mail/cltbld', 02:25:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:41 INFO - 'MOZ_NO_REMOTE': '1', 02:25:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:41 INFO - 'NO_EM_RESTART': '1', 02:25:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:41 INFO - 'PWD': '/builds/slave/test', 02:25:41 INFO - 'SHELL': '/bin/bash', 02:25:41 INFO - 'SHLVL': '1', 02:25:41 INFO - 'TERM': 'linux', 02:25:41 INFO - 'TMOUT': '86400', 02:25:41 INFO - 'USER': 'cltbld', 02:25:41 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468055835.498396-1611438415', 02:25:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:41 INFO - '_': '/tools/buildbot/bin/python'} 02:25:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:41 INFO - Downloading/unpacking psutil>=3.1.1 02:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:25:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:25:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:25:43 INFO - Installing collected packages: psutil 02:25:43 INFO - Running setup.py install for psutil 02:25:43 INFO - building 'psutil._psutil_linux' extension 02:25:43 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 02:25:43 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 02:25:43 INFO - building 'psutil._psutil_posix' extension 02:25:43 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 02:25:44 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 02:25:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:25:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:25:44 INFO - Successfully installed psutil 02:25:44 INFO - Cleaning up... 02:25:44 INFO - Return code: 0 02:25:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:25:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:44 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 0x262a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e93b0>, '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 0x28ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ea740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1468055835.498396-1611438415', '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 02:25:44 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 02:25:44 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 02:25:44 INFO - Using env: {'DISPLAY': ':0', 02:25:44 INFO - 'HOME': '/home/cltbld', 02:25:44 INFO - 'LANG': 'en_US.UTF-8', 02:25:44 INFO - 'LANGUAGE': 'en_US:en', 02:25:44 INFO - 'LOGNAME': 'cltbld', 02:25:44 INFO - 'MAIL': '/var/mail/cltbld', 02:25:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:44 INFO - 'MOZ_NO_REMOTE': '1', 02:25:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:44 INFO - 'NO_EM_RESTART': '1', 02:25:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:44 INFO - 'PWD': '/builds/slave/test', 02:25:44 INFO - 'SHELL': '/bin/bash', 02:25:44 INFO - 'SHLVL': '1', 02:25:44 INFO - 'TERM': 'linux', 02:25:44 INFO - 'TMOUT': '86400', 02:25:44 INFO - 'USER': 'cltbld', 02:25:44 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468055835.498396-1611438415', 02:25:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:44 INFO - '_': '/tools/buildbot/bin/python'} 02:25:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:25:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:25:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:25:46 INFO - Installing collected packages: mozsystemmonitor 02:25:46 INFO - Running setup.py install for mozsystemmonitor 02:25:46 INFO - Successfully installed mozsystemmonitor 02:25:46 INFO - Cleaning up... 02:25:46 INFO - Return code: 0 02:25:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:46 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 0x262a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e93b0>, '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 0x28ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ea740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1468055835.498396-1611438415', '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 02:25:46 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 02:25:46 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 02:25:46 INFO - Using env: {'DISPLAY': ':0', 02:25:46 INFO - 'HOME': '/home/cltbld', 02:25:46 INFO - 'LANG': 'en_US.UTF-8', 02:25:46 INFO - 'LANGUAGE': 'en_US:en', 02:25:46 INFO - 'LOGNAME': 'cltbld', 02:25:46 INFO - 'MAIL': '/var/mail/cltbld', 02:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:46 INFO - 'MOZ_NO_REMOTE': '1', 02:25:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:46 INFO - 'NO_EM_RESTART': '1', 02:25:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:46 INFO - 'PWD': '/builds/slave/test', 02:25:46 INFO - 'SHELL': '/bin/bash', 02:25:46 INFO - 'SHLVL': '1', 02:25:46 INFO - 'TERM': 'linux', 02:25:46 INFO - 'TMOUT': '86400', 02:25:46 INFO - 'USER': 'cltbld', 02:25:46 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468055835.498396-1611438415', 02:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:46 INFO - '_': '/tools/buildbot/bin/python'} 02:25:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:46 INFO - Downloading/unpacking jsonschema==2.5.1 02:25: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 02:25: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 02:25: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 02:25: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 02:25: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 02:25: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 02:25:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:25:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:48 INFO - Downloading functools32-3.2.3-2.tar.gz 02:25:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:25:48 INFO - warning: no files found matching '*.txt' 02:25:48 INFO - no previously-included directories found matching 'build' 02:25:48 INFO - no previously-included directories found matching 'dist' 02:25:48 INFO - no previously-included directories found matching '.git*' 02:25:48 INFO - Installing collected packages: jsonschema, functools32 02:25:48 INFO - Running setup.py install for functools32 02:25:49 INFO - warning: no files found matching '*.txt' 02:25:49 INFO - no previously-included directories found matching 'build' 02:25:49 INFO - no previously-included directories found matching 'dist' 02:25:49 INFO - no previously-included directories found matching '.git*' 02:25:49 INFO - Successfully installed jsonschema functools32 02:25:49 INFO - Cleaning up... 02:25:49 INFO - Return code: 0 02:25:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:25: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')]} 02:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25: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')]} 02:25:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25: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', '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 0x262a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e93b0>, '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 0x28ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ea740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1468055835.498396-1611438415', '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 02:25: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:25: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 blobuploader==1.2.4 02:25:49 INFO - Using env: {'DISPLAY': ':0', 02:25:49 INFO - 'HOME': '/home/cltbld', 02:25:49 INFO - 'LANG': 'en_US.UTF-8', 02:25:49 INFO - 'LANGUAGE': 'en_US:en', 02:25:49 INFO - 'LOGNAME': 'cltbld', 02:25:49 INFO - 'MAIL': '/var/mail/cltbld', 02:25:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:49 INFO - 'MOZ_NO_REMOTE': '1', 02:25:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:49 INFO - 'NO_EM_RESTART': '1', 02:25:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:49 INFO - 'PWD': '/builds/slave/test', 02:25:49 INFO - 'SHELL': '/bin/bash', 02:25:49 INFO - 'SHLVL': '1', 02:25:49 INFO - 'TERM': 'linux', 02:25:49 INFO - 'TMOUT': '86400', 02:25:49 INFO - 'USER': 'cltbld', 02:25:49 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468055835.498396-1611438415', 02:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:49 INFO - '_': '/tools/buildbot/bin/python'} 02:25:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:49 INFO - Downloading/unpacking blobuploader==1.2.4 02:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:51 INFO - Downloading blobuploader-1.2.4.tar.gz 02:25:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:25:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:25:51 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 02:25:51 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 02:25:51 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 02:25:51 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 02:25:51 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 02:25:51 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 02:25:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:25:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:25:51 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 02:25:51 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 02:25:51 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 02:25:51 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 02:25:51 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 02:25:51 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 02:25:52 INFO - Downloading docopt-0.6.1.tar.gz 02:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:25:52 INFO - Installing collected packages: blobuploader, requests, docopt 02:25:52 INFO - Running setup.py install for blobuploader 02:25:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:25:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:25:52 INFO - Running setup.py install for requests 02:25:52 INFO - Running setup.py install for docopt 02:25:52 INFO - Successfully installed blobuploader requests docopt 02:25:52 INFO - Cleaning up... 02:25:52 INFO - Return code: 0 02:25:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:25:52 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')]} 02:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:52 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')]} 02:25:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:52 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 0x262a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e93b0>, '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 0x28ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ea740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1468055835.498396-1611438415', '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 02:25:52 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 02:25:52 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 02:25:52 INFO - Using env: {'DISPLAY': ':0', 02:25:52 INFO - 'HOME': '/home/cltbld', 02:25:52 INFO - 'LANG': 'en_US.UTF-8', 02:25:52 INFO - 'LANGUAGE': 'en_US:en', 02:25:52 INFO - 'LOGNAME': 'cltbld', 02:25:52 INFO - 'MAIL': '/var/mail/cltbld', 02:25:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:52 INFO - 'MOZ_NO_REMOTE': '1', 02:25:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:52 INFO - 'NO_EM_RESTART': '1', 02:25:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:52 INFO - 'PWD': '/builds/slave/test', 02:25:52 INFO - 'SHELL': '/bin/bash', 02:25:52 INFO - 'SHLVL': '1', 02:25:52 INFO - 'TERM': 'linux', 02:25:52 INFO - 'TMOUT': '86400', 02:25:52 INFO - 'USER': 'cltbld', 02:25:52 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468055835.498396-1611438415', 02:25:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:52 INFO - '_': '/tools/buildbot/bin/python'} 02:25:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:25:52 INFO - Running setup.py (path:/tmp/pip-8f2dxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:25:53 INFO - Running setup.py (path:/tmp/pip-Ku5Oxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:25:53 INFO - Running setup.py (path:/tmp/pip-zMEw4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:25:53 INFO - Running setup.py (path:/tmp/pip-8P2uVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:25:53 INFO - Running setup.py (path:/tmp/pip-TSFu_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:25:53 INFO - Running setup.py (path:/tmp/pip-qsxvD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:25:53 INFO - Running setup.py (path:/tmp/pip-EQzS3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:25:53 INFO - Running setup.py (path:/tmp/pip-wizkCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:25:53 INFO - Running setup.py (path:/tmp/pip-FwV4DW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:25:53 INFO - Running setup.py (path:/tmp/pip-ohKlhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:25:53 INFO - Running setup.py (path:/tmp/pip-h_LcFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:25:53 INFO - Running setup.py (path:/tmp/pip-fP10hi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:25:53 INFO - Running setup.py (path:/tmp/pip-8nayEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:25:53 INFO - Running setup.py (path:/tmp/pip-JbHeZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:25:53 INFO - Running setup.py (path:/tmp/pip-Mh2aqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:25:54 INFO - Running setup.py (path:/tmp/pip-WNf98m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:25:54 INFO - Running setup.py (path:/tmp/pip-nF0NBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:25:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:25:54 INFO - Running setup.py install for manifestparser 02:25:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:25:54 INFO - Running setup.py install for mozcrash 02:25:54 INFO - Running setup.py install for mozdebug 02:25:54 INFO - Running setup.py install for mozdevice 02:25:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:25:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:25:54 INFO - Running setup.py install for mozfile 02:25:54 INFO - Running setup.py install for mozhttpd 02:25:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:25:54 INFO - Running setup.py install for mozinfo 02:25:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:25:54 INFO - Running setup.py install for mozInstall 02:25:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:25:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:25:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:25:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:25:54 INFO - Running setup.py install for mozleak 02:25:55 INFO - Running setup.py install for mozlog 02:25:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:25:55 INFO - Running setup.py install for moznetwork 02:25:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:25:55 INFO - Running setup.py install for mozprocess 02:25:55 INFO - Running setup.py install for mozprofile 02:25:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:25:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:25:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:25:55 INFO - Running setup.py install for mozrunner 02:25:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:25:55 INFO - Running setup.py install for mozscreenshot 02:25:55 INFO - Running setup.py install for moztest 02:25:55 INFO - Running setup.py install for mozversion 02:25:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:25:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:25:55 INFO - Cleaning up... 02:25:55 INFO - Return code: 0 02:25:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:25:55 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')]} 02:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:55 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')]} 02:25:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:55 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 0x262a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e93b0>, '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 0x28ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ea740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1468055835.498396-1611438415', '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 02:25:55 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 02:25:55 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 02:25:55 INFO - Using env: {'DISPLAY': ':0', 02:25:55 INFO - 'HOME': '/home/cltbld', 02:25:55 INFO - 'LANG': 'en_US.UTF-8', 02:25:55 INFO - 'LANGUAGE': 'en_US:en', 02:25:55 INFO - 'LOGNAME': 'cltbld', 02:25:55 INFO - 'MAIL': '/var/mail/cltbld', 02:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:55 INFO - 'MOZ_NO_REMOTE': '1', 02:25:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:55 INFO - 'NO_EM_RESTART': '1', 02:25:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:55 INFO - 'PWD': '/builds/slave/test', 02:25:55 INFO - 'SHELL': '/bin/bash', 02:25:55 INFO - 'SHLVL': '1', 02:25:55 INFO - 'TERM': 'linux', 02:25:55 INFO - 'TMOUT': '86400', 02:25:55 INFO - 'USER': 'cltbld', 02:25:55 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468055835.498396-1611438415', 02:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:55 INFO - '_': '/tools/buildbot/bin/python'} 02:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:25:56 INFO - Running setup.py (path:/tmp/pip-5TDm_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:25:56 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)) 02:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:25:56 INFO - Running setup.py (path:/tmp/pip-3B5oJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:25:56 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)) 02:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:25:56 INFO - Running setup.py (path:/tmp/pip-p72Z9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:25:56 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)) 02:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:25:56 INFO - Running setup.py (path:/tmp/pip-U03gG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:25:56 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)) 02:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:25:56 INFO - Running setup.py (path:/tmp/pip-y8WKI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:25:56 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)) 02:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:25:56 INFO - Running setup.py (path:/tmp/pip-irm090-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:25:56 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)) 02:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:25:56 INFO - Running setup.py (path:/tmp/pip-bNwh7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:25:56 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)) 02:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:25:56 INFO - Running setup.py (path:/tmp/pip-JnB8Fj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:25:56 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)) 02:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:25:56 INFO - Running setup.py (path:/tmp/pip-anpPES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:25:56 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)) 02:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:25:56 INFO - Running setup.py (path:/tmp/pip-H79Ptd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:25:56 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)) 02:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:25:56 INFO - Running setup.py (path:/tmp/pip-RJSZdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:25:56 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)) 02:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:25:56 INFO - Running setup.py (path:/tmp/pip-UJHo3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:25:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 02:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:25:57 INFO - Running setup.py (path:/tmp/pip-4hs_BD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:25:57 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)) 02:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:25:57 INFO - Running setup.py (path:/tmp/pip-QHxVpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:25:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 02:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:25:57 INFO - Running setup.py (path:/tmp/pip-vX0rfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:25:57 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)) 02:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:25:57 INFO - Running setup.py (path:/tmp/pip-dMXf_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:25:57 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)) 02:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:25:57 INFO - Running setup.py (path:/tmp/pip-dwyHUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:25:57 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)) 02:25:57 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)) 02:25:57 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)) 02:25:57 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)) 02:25:57 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)) 02:25:57 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)) 02:25:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:25:57 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 02:25:57 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 02:25:57 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 02:25:57 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 02:25:57 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 02:25:57 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 02:25:59 INFO - Downloading blessings-1.6.tar.gz 02:25:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:25:59 INFO - Installing collected packages: blessings 02:25:59 INFO - Running setup.py install for blessings 02:25:59 INFO - Successfully installed blessings 02:25:59 INFO - Cleaning up... 02:25:59 INFO - Return code: 0 02:25:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:25:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:25:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:25:59 INFO - Reading from file tmpfile_stdout 02:25:59 INFO - Current package versions: 02:25:59 INFO - argparse == 1.2.1 02:25:59 INFO - blessings == 1.6 02:25:59 INFO - blobuploader == 1.2.4 02:25:59 INFO - docopt == 0.6.1 02:25:59 INFO - functools32 == 3.2.3-2 02:25:59 INFO - jsonschema == 2.5.1 02:25:59 INFO - manifestparser == 1.1 02:25:59 INFO - mozInstall == 1.12 02:25:59 INFO - mozcrash == 0.17 02:25:59 INFO - mozdebug == 0.1 02:25:59 INFO - mozdevice == 0.48 02:25:59 INFO - mozfile == 1.2 02:25:59 INFO - mozhttpd == 0.7 02:25:59 INFO - mozinfo == 0.9 02:25:59 INFO - mozleak == 0.1 02:25:59 INFO - mozlog == 3.2 02:25:59 INFO - moznetwork == 0.27 02:25:59 INFO - mozprocess == 0.23 02:25:59 INFO - mozprofile == 0.28 02:25:59 INFO - mozrunner == 6.12 02:25:59 INFO - mozscreenshot == 0.1 02:25:59 INFO - mozsystemmonitor == 0.3 02:25:59 INFO - moztest == 0.7 02:25:59 INFO - mozversion == 1.4 02:25:59 INFO - psutil == 3.1.1 02:25:59 INFO - requests == 1.2.3 02:25:59 INFO - wsgiref == 0.1.2 02:25:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:59 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 0x262a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e93b0>, '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 0x28ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ea740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1468055835.498396-1611438415', '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 02:25:59 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 02:26:00 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 02:26:00 INFO - Using env: {'DISPLAY': ':0', 02:26:00 INFO - 'HOME': '/home/cltbld', 02:26:00 INFO - 'LANG': 'en_US.UTF-8', 02:26:00 INFO - 'LANGUAGE': 'en_US:en', 02:26:00 INFO - 'LOGNAME': 'cltbld', 02:26:00 INFO - 'MAIL': '/var/mail/cltbld', 02:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:00 INFO - 'MOZ_NO_REMOTE': '1', 02:26:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:00 INFO - 'NO_EM_RESTART': '1', 02:26:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:00 INFO - 'PWD': '/builds/slave/test', 02:26:00 INFO - 'SHELL': '/bin/bash', 02:26:00 INFO - 'SHLVL': '1', 02:26:00 INFO - 'TERM': 'linux', 02:26:00 INFO - 'TMOUT': '86400', 02:26:00 INFO - 'USER': 'cltbld', 02:26:00 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468055835.498396-1611438415', 02:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:00 INFO - '_': '/tools/buildbot/bin/python'} 02:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:00 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)) 02:26:00 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)) 02:26:00 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)) 02:26:00 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)) 02:26:00 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)) 02:26:00 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)) 02:26:00 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)) 02:26:00 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)) 02:26:00 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)) 02:26:00 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)) 02:26:00 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)) 02:26:00 INFO - Cleaning up... 02:26:00 INFO - Return code: 0 02:26:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:00 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 0x262a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x278d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e93b0>, '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 0x28ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ea740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1468055835.498396-1611438415', '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 02:26:00 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 02:26:00 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 02:26:00 INFO - Using env: {'DISPLAY': ':0', 02:26:00 INFO - 'HOME': '/home/cltbld', 02:26:00 INFO - 'LANG': 'en_US.UTF-8', 02:26:00 INFO - 'LANGUAGE': 'en_US:en', 02:26:00 INFO - 'LOGNAME': 'cltbld', 02:26:00 INFO - 'MAIL': '/var/mail/cltbld', 02:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:00 INFO - 'MOZ_NO_REMOTE': '1', 02:26:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:00 INFO - 'NO_EM_RESTART': '1', 02:26:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:00 INFO - 'PWD': '/builds/slave/test', 02:26:00 INFO - 'SHELL': '/bin/bash', 02:26:00 INFO - 'SHLVL': '1', 02:26:00 INFO - 'TERM': 'linux', 02:26:00 INFO - 'TMOUT': '86400', 02:26:00 INFO - 'USER': 'cltbld', 02:26:00 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468055835.498396-1611438415', 02:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:00 INFO - '_': '/tools/buildbot/bin/python'} 02:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:26:00 INFO - Cleaning up... 02:26:00 INFO - Return code: 0 02:26:00 INFO - Running post-action listener: _resource_record_post_action 02:26:00 INFO - Running post-action listener: _start_resource_monitoring 02:26:00 INFO - Starting resource monitoring. 02:26:00 INFO - ##### 02:26:00 INFO - ##### Finished create-virtualenv step (success) 02:26:00 INFO - ##### 02:26:00 INFO - ##### 02:26:00 INFO - ##### Running install step. 02:26:00 INFO - ##### 02:26:00 INFO - Running pre-action listener: _resource_record_pre_action 02:26:00 INFO - Running main action method: install 02:26:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:26:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:26:00 INFO - Reading from file tmpfile_stdout 02:26:00 INFO - Detecting whether we're running mozinstall >=1.0... 02:26:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:26:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:26:00 INFO - Reading from file tmpfile_stdout 02:26:00 INFO - Output received: 02:26:00 INFO - Usage: mozinstall [options] installer 02:26:00 INFO - Options: 02:26:00 INFO - -h, --help show this help message and exit 02:26:00 INFO - -d DEST, --destination=DEST 02:26:00 INFO - Directory to install application into. [default: 02:26:00 INFO - "/builds/slave/test"] 02:26:00 INFO - --app=APP Application being installed. [default: firefox] 02:26:00 INFO - mkdir: /builds/slave/test/build/application 02:26:00 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'] 02:26:00 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 02:26:17 INFO - Reading from file tmpfile_stdout 02:26:17 INFO - Output received: 02:26:17 INFO - /builds/slave/test/build/application/firefox/firefox 02:26:17 INFO - Running post-action listener: _resource_record_post_action 02:26:17 INFO - ##### 02:26:17 INFO - ##### Finished install step (success) 02:26:17 INFO - ##### 02:26:17 INFO - ##### 02:26:17 INFO - ##### Running run-tests step. 02:26:17 INFO - ##### 02:26:17 INFO - Running pre-action listener: _resource_record_pre_action 02:26:17 INFO - Running main action method: run_tests 02:26:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:26:17 INFO - Python 2.7.3 02:26:17 INFO - Return code: 0 02:26:17 INFO - grabbing minidump binary from tooltool 02:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:17 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 0x28e93b0>, '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 0x28ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ea740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:26:17 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 02:26:17 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 02:26:17 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 02:26:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:26:18 INFO - Return code: 0 02:26:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:26:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:26:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:26:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:26:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:26:18 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/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 02:26:18 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/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 02:26:18 INFO - Using env: {'DISPLAY': ':0', 02:26:18 INFO - 'HOME': '/home/cltbld', 02:26:18 INFO - 'LANG': 'en_US.UTF-8', 02:26:18 INFO - 'LANGUAGE': 'en_US:en', 02:26:18 INFO - 'LOGNAME': 'cltbld', 02:26:18 INFO - 'MAIL': '/var/mail/cltbld', 02:26:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:26:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:26:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:18 INFO - 'MOZ_NO_REMOTE': '1', 02:26:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:26:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:18 INFO - 'NO_EM_RESTART': '1', 02:26:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:18 INFO - 'PWD': '/builds/slave/test', 02:26:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:26:18 INFO - 'SHELL': '/bin/bash', 02:26:18 INFO - 'SHLVL': '1', 02:26:18 INFO - 'TERM': 'linux', 02:26:18 INFO - 'TMOUT': '86400', 02:26:18 INFO - 'USER': 'cltbld', 02:26:18 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1468055835.498396-1611438415', 02:26:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:18 INFO - '_': '/tools/buildbot/bin/python'} 02:26:18 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/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 02:26:18 INFO - mozversion application_buildid: 20160708233021 02:26:18 INFO - mozversion application_changeset: 95c5d3617db2355aed67724a9d8180d9c6cd0467 02:26:18 INFO - mozversion application_display_name: Nightly 02:26:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:26:18 INFO - mozversion application_name: Firefox 02:26:18 INFO - mozversion application_remotingname: firefox 02:26:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:26:18 INFO - mozversion application_vendor: Mozilla 02:26:18 INFO - mozversion application_version: 50.0a1 02:26:18 INFO - mozversion platform_buildid: 20160708233021 02:26:18 INFO - mozversion platform_changeset: 95c5d3617db2355aed67724a9d8180d9c6cd0467 02:26:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:26:18 INFO - mozversion platform_version: 50.0a1 02:26:18 INFO - using testdate: 1468056378 02:26:18 INFO - actual date: 1468056378 02:26:18 INFO - starting webserver on 'localhost:59637' 02:26:18 INFO - SUITE-START | Running 2 tests 02:26:18 INFO - TEST-START | dromaeo_css 02:26:18 INFO - operating with platform_type : linux_ 02:26:18 INFO - Initialising browser for dromaeo_css test... 02:26:18 INFO - TEST-INFO | started process 15269 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplyj8p9/profile http://localhost:59637/getInfo.html) 02:26:22 INFO - PROCESS | 15269 | __metrics Screen width/height:1600/1200 02:26:22 INFO - PROCESS | 15269 | colorDepth:24 02:26:22 INFO - PROCESS | 15269 | Browser inner width/height: 1024/697 02:26:22 INFO - PROCESS | 15269 | __metrics 02:26:23 INFO - PROCESS | 15269 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:26:24 INFO - TEST-INFO | 15269: exit 0 02:26:24 INFO - Browser initialized. 02:26:24 INFO - Running cycle 1/1 for dromaeo_css test... 02:26:24 INFO - TEST-INFO | started process 15355 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplyj8p9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:26:36 INFO - PROCESS | 15355 | RSS: Main: 157175808 02:26:36 INFO - PROCESS | 15355 | 02:27:27 INFO - PROCESS | 15355 | 1468056447887 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] 02:29:35 INFO - PROCESS | 15355 | Cycle 1(1): loaded http://localhost:59637/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59637/tests/dromaeo/cssquery-ext.html) 02:29:36 INFO - PROCESS | 15355 | RSS: Main: 247672832 02:29:36 INFO - PROCESS | 15355 | 02:32:39 INFO - PROCESS | 15355 | Cycle 1(1): loaded http://localhost:59637/tests/dromaeo/cssquery-ext.html (next: http://localhost:59637/tests/dromaeo/cssquery-jquery.html) 02:32:39 INFO - PROCESS | 15355 | RSS: Main: 236429312 02:32:39 INFO - PROCESS | 15355 | 02:35:41 INFO - PROCESS | 15355 | Cycle 1(1): loaded http://localhost:59637/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59637/tests/dromaeo/cssquery-mootools.html) 02:35:42 INFO - PROCESS | 15355 | RSS: Main: 242774016 02:35:42 INFO - PROCESS | 15355 | 02:38:44 INFO - PROCESS | 15355 | Cycle 1(1): loaded http://localhost:59637/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59637/tests/dromaeo/cssquery-prototype.html) 02:38:44 INFO - PROCESS | 15355 | RSS: Main: 233062400 02:38:44 INFO - PROCESS | 15355 | 02:41:47 INFO - PROCESS | 15355 | Cycle 1(1): loaded http://localhost:59637/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59637/tests/dromaeo/cssquery-yui.html) 02:41:48 INFO - PROCESS | 15355 | RSS: Main: 204722176 02:41:48 INFO - PROCESS | 15355 | 02:44:50 INFO - PROCESS | 15355 | Cycle 1(1): loaded http://localhost:59637/tests/dromaeo/cssquery-yui.html (next: http://localhost:59637/tests/dromaeo/cssquery-dojo.html) 02:44:50 INFO - PROCESS | 15355 | RSS: Main: 273887232 02:44:50 INFO - PROCESS | 15355 | 02:44:50 INFO - PROCESS | 15355 | __start_tp_report 02:44:50 INFO - PROCESS | 15355 | _x_x_mozilla_page_load 02:44:50 INFO - PROCESS | 15355 | _x_x_mozilla_page_load_details 02:44:50 INFO - PROCESS | 15355 | |i|pagename|runs| 02:44:50 INFO - PROCESS | 15355 | |0;dojo.html;3016.049944267556;3033.666296707363;3058.2507285714996;3063.509838425851;3072.2012276808023;5271.841844744654;5329.520343169114;5348.679079255247;5384.138537833947;5423.05096608093;5350.8127215547465;5360.437154098822;5399.811006614769;5411.891762164764;5459.836204913859;4818.855434336975;4871.415430148387;4900.6569540132205;4908.0429316283335;5013.172826483626;4932.260160975864;4941.827036053739;4983.900321993558;4995.950040499585;5009.774560144802;4810.39870016248;4812.614990800745;4850.029994001196;4859.73271470069;4865.635077369176;4857.489963553811;4878.707277563358;4883.218685010417;4935.358403407534;4982.750862456863;4896.387951506062;4922.335484709554;4922.458529561745;4923.507649235084;4924.901501969976;5234.6335756497065;5277.102892508283;5355.946440535584;5414.35027796663;5435.809746658848;5737.454941780524;5767.192593036978;5774.076147816371;5784.710764461802;5794.536437085023;5600.635958662674;5723.370429252779;5743.827685169452;5797.217375654317;5799.652020878719;5355.705436201008;5393.083175860113;5407.972960135214;5459.426760190163;5475.780968761205;5972.940270597239;5976.163337132805;5980.760769569169;5984.880302393928;5985.431384018599;5477.67133971955;5604.747786349624;5715.942840571541;5740.42595740431;5749.108888122348;5725;5780.219670344533;5780.942190578125;5838.9124163137585;5841.240638717025;5700.37295897451;5736.483716465538;5750.4249575042995;5753.194552762617;5796.652200867961;5581.162825576196;5678.858028549319;5742.08126699726;5753.108268218432;5762.193292938992;4399.032212913154;4405.735655860659;4435.534268901783;4443.977780111079;4447.155040542287;3902.083010492532;3915.471411359487;3923.2349691810396;3926.2932672118723;3958.0698535844053;5330.280412144389;5397.2443857859935;5490.066688662937;5494.725263736797;5500;5667.80162694312;5738.741756620962;5794.913076303858;5844.152597873284;5847.532197424196;5506.779728810803;5519.337679478408;5521.806736764194;5524.088525393346;5530.695811730313;4719.292106184032;4742.810287588527;4784.2823576463115;4871.80512779492;4927.162382395001;5952.077427998754;5956.434138756811;5956.642601443928;5959.702014899238;5995.670238136944;5763;5774.56690748204;5777.653340799566;5780.988327042666;5781.421857814353;5809.94190058111;5835.358110607915;5877.853053673693;5907.704614769158;5942.881142377042;5643.435656434323;5657.2079908811975;5662.009148398932;5663.631863928831;5670.291213598301;5701.0593252114595;5758.107493338539;5761.107028410603;5769.480746732815;5769.480746732815;5420.566354691694;5551.417101204315;5580.832575022756;5616.326040875121;5640.464155905182;5625.381208067191;5628.493435590816;5630.183623374506;5638.097904335286;5640.32316122068;5416.9729151353995;5516.365617953987;5544.279243698294;5564.443555644403;5566.721663916707;5603.467670571289;5633.295838020247;5653.067243904709;5684.971575142264;5746.454086861741;5549.278593782782;5551.861203469945;5555.527780138734;5559.221708960829;5566.471185237396 02:44:50 INFO - PROCESS | 15355 | |1;ext.html;597.9133025711271;604.3503234023423;622.0637939900449;628.3057221769941;631.6904716688819;33674.158146046364;43947.12105757883;45087.54912450875;45149.09701805962;45152;46379.536204637945;46753;46796.76601616995;46826.76586617071;46939.530604693944;7790.493617914817;8953.418027828187;9094.136057074567;9098.135677110697;10408.739781505446;10516.737081572945;10896.346219226833;10914.345139291669;10926.289791163588;10927.398993055418;10985;11028.889711102907;11036.889631103706;11039.39283339416;11041.227114102016;8101.797455063641;8275.04836943753;8302.294304984083;10548.525316360781;10918.50866711;10507.159427245802;10561.471926403648;10569.682909512727;10573.682789516326;10575.73560660982;42699.7865010676;43042.78478607618;43141.56858431407;43157.568424315985;43167;3449.58604967403;3495.982520087409;3508.5088087667746;3524.8766293179874;3563.982180089109;33761.49357759635;33990.83004584986;34167.48748768771;34572.48141277883;35555.466668;4472.82108715651;4537.636989040901;4544.454665440136;4579.931301030487;4679;251204;254295;254340;363618;369895;34415.31169376648;35911;62317;62838.37161628325;62932.37067629265;37825.2434951305;37853.81073094617;37913;37956.43065354022;37980;16101.597460063593;16261.268242929096;16274.186290685418;16277.918610407109;16285.837141628668;13475.932620336836;13625.182489050689;13625.318734063258;13643.113197642122;13649.86350136486;8455.26667033269;8483.363747718946;8513.148685131437;8567.957160214284;8580;3258.7718859679594;3271.492918597621;3282.163048422637;3282.8017773512497;3295.8022518648477;1016.3241444439512;1030.7680771826429;1077.4020418667558;1132.5130194016488;1190.8273300371397;33103.50344744831;33532.49701254483;33601.815881967595;33754.831225843714;33858.83070584631;1054.6625079974335;1079.400932482464;1096.31480324797;1097.2154909239932;1124.4771181400688;17050.48848534546;17831.621038462104;17857.675964533184;17891.370628954126;17905.344968097026;630439;632643;638503;638580;641837;61345;61586.38413615896;61948;61971;62191.689041554506;1237.4431505822415;1338.116842883692;1372.979405308921;1390.3951780975308;1391.1792042694858;31228.843855780575;34720;34748.47877281792;34773.13067173341;34894.476582850766;44854.10291794211;45042.32436513389;45543.31685024794;45600.7719961398;45687;422854;424821.75178247824;424966;426110;426441;24781.25656230316;27378.315542111606;28387.716122839334;28678.713212867606;29116;48563.27155092606;48563.75718121387;49891.75054124851;51092;52221;43498;44491.332630011224;44539;44541.55458445374;44861.32708009317;42403;42935.60257131623;44551.33173002343;46154;46485;42873.35689964715;43023.78488107539;43526.56473435225;43591.34612980745;43963.12073758571;37653;38782.4182637255;38850.80574597109;39064.80467597644;39598.80200598978;29124.34299519357;29205.7079429203;29538.556921645762;29644.55533166961;29726.851365743034 02:44:50 INFO - PROCESS | 15355 | |2;jquery.html;384.80759620189906;394.6527056190552;398.9980050099749;404.7227649060394;420.48070632768525;13336.533221337255;19447.902760486195;20676.96615169243;21169.259075932325;21223.257185998493;15040;19352.612947741072;19464.12411441485;20187.69718454221;20532.178712851506;5759.712014399284;6002.459778619924;6009.008513595273;6010.96994515029;6025.849353766147;5917.378675239102;5932.317783454915;5939.940600594004;5943.4056594340655;5950.642961422329;4288.506821715496;4755.334253204554;6488.416042556169;6490.156279683634;6591.209054913417;6318.147050148217;6500.674966251669;6518.380753828355;6574.8685026299445;6581.24315703693;5550.222968784374;5562.054450743343;5605.663660180402;5616.354119276254;5617.21359009739;23651.763482365128;24631;24808.875955620108;24899.128530501526;25172.748272517405;2598.8180827342094;2603.1149409200775;2784.8050636455455;2803.285162283625;2912.228259511231;14604.196769177692;15329.386824527006;15471.149086800222;15727.606809829731;15947.521574352788;1970.546774241918;2066.4730493724155;2080.2719048333115;2151.87088774674;2214.8006679398773;75654.62172689156;80151.59924200342;81425.18574814295;83341.16658833394;86453.56773216157;11057.889421105847;11407.714807129889;11431.256968297033;11563.88436115645;11892.108091893142;15788.131652758979;15819.762703559456;15976.360945562279;15984.280707367963;16021;8408;8475.576221188916;8580.742577722678;8692.044290034819;8759.693410730593;8416.78958026042;8435.493870367674;8484.066752657203;8582.270507006975;8607.741767746978;4018.3972404139026;4693.718376897397;4868.68545492715;5007.7245751484015;5068.721220332917;1951.5804102118113;2001.9199232030555;2015.2644284835928;2026.8682535635137;2069.286096296775;990.782027953849;1019.1948360794889;1064.4411683866033;1073.1254027967182;1081.567373050786;19197.424077277705;19887.204511819364;20217.393478195383;20233.392998210078;20367.898160509398;1036.9118624916816;1043.1967385113571;1067.4662668665667;1067.8718553773597;1072.8605281313535;10869.67390978272;11023.503942322453;11043.668689939315;11104.777904441866;11130.49912753928;396397;397346;400135;481577;531229;60663.69668151719;77722.6113869427;88721.55639221762;92026.53986730157;97944;1016.1007508355159;1035.089121573011;1051.1013083813382;1056.5034433816095;1075.4407707991957;18455.261789528267;18608.34870779516;18953.526161846064;18977.810221897606;19205.615887681888;46187.30719039284;46544;46668.53331466642;46704.532954670016;47062.294065589726;59698.70150649219;63979;64591.677041614494;64904.70190596256;65642;7667.079950405987;8073.878891816745;8762.561871906251;9010.14403631654;9103.954480227821;14466;14496.782548261574;14602.780958285422;14899;14986.47547335838;11923.224990375598;12292.692682683004;12356;12367.876321237032;12746.617601471971;11479.253848500155;11818.527258909548;11899;11959.222650527689;11974.341411222118;12633.431495582905;12637.304948227937;12794.36028198605;12851.550195743479;12888.935555322163;8092.6762929482165;8157.469764465291;8407.663693452194;8468.830623387621;8668.91331086681;11923.582674606347;12149.331786751813;12361.752764944831;12370.75258494807;12385.504579816707 02:44:50 INFO - PROCESS | 15355 | |3;mootools.html;1314.2311747627637;1469.3461409672695;1483.9406423743048;1644.942427015054;1803.49502139401;8552.315814734822;8949.865752013726;8963.327750418712;9140.360174787767;9163.266938644909;8797.912020879789;9066.048064953184;9076.183143517082;9081.90918090819;9084.409513381626;1963.6465436221474;2019.6667549854255;2022.1911235505843;2303.493231489074;2360.209329874494;2015.8488113391481;2017.8385729141633;2247.4493749031512;2321.5124823787023;2325.965110523335;2295.185209250717;2307.9307620771406;2315.7568455312203;2317.4669825940045;2318.327684971356;1878.4552479780848;2286.4741109544816;2288.9885550572308;2295.988520057406;2297.471581536248;2248.1457046322294;2319.0491898321775;2320.7795259450495;2325.5697695926306;2329.4060014696315;8973.147550982647;9045.231155351803;9046.81906361869;9048.683296084671;9053.818923621557;5182.870428239325;5322.068637988336;5325.041492531343;5328.8401347959625;5338.466153384669;3436.1066122808;3471.5139880416764;3533.641903956166;3600.945985810215;3647.2340808430263;1159.727464045957;1175.5121624525812;1193.3078814287692;1195.7787809255315;1208.0456439412853;12611.936940315332;12618;12642;12650.74698506034;12651.557195498206;4346.847860324873;4485.215087359699;4658.604018658384;4658.976705116521;4699.107169637758;10632;10637.680869573926;10647;10650.94674526638;10657.786844263072;5290.047791397508;5297.443768404339;5308.761105750174;5311.017461769585;5319.7340132993195;4674.929876051862;4873.6832105913;4896.828610998598;4912.72979986097;4917.557419832232;3965.266425711253;4020.4974378202724;4071.97964010184;4087.4481944937647;4116.670666346685;1268.4101892619976;1288.2463758701078;1292.3086148910288;1292.3796577642784;1299.7920332746903;1028.7788125553043;1038.2576457832686;1043.4834756795435;1050.4537640426936;1050.5535147562255;6043.637381757108;6193.009118541012;6225.128482012522;6344.302126766052;6429;442.88484993901176;449.6560131499406;451.8463722334422;1039.184240371305;1041.8645576075062;4203.91592168155;4231.894202644959;4320.373545835836;4333.761643109596;4376.081022985209;11097.667069987914;11376;11496.482658280398;11496.597619083292;11503.942480287546;11230.3261804292;11234.15743819217;11355.318680879174;11360.48877800501;11388.658340249805;7965.4822436541435;8253.215944485264;8257.669693212325;8319.708810191614;8428.35647048832;5917.556183286185;6011.6994150293185;6169.722362493609;6172.135900973957;6205.627662340274;10525.315854469434;10532.842007369742;10754.462276885968;10757.569697212024;10776.67669969902;9495.620175192915;10674.199435042558;10907.618233361794;10911.127109831354;11078.778424431628;7371.778846634609;7547.50941188821;7558.395328373607;7672.194419586086;7700.730474433368;8173.100958894398;8203.466774659628;8292.253697167283;8471.534065626203;8473.533955632252;6408.391202835724;7844.254795794391;7864;7935.32549733256;8183.508989460652;7270.9636451817405;7286.599237042014;7371.078615173104;7485.214052524407;7693.846123077619;6925.757598484231;6930.3762661360715;6996.230414654486;6998.300169982961;7042.823929401806;5061.139606267017;5087.796488140433;5143.228515722672;5175.767090481013;5204.98502791952;5166.225066240094;5202.961424598928;5240.71176085319;5264.440653180673;5314.202869569595 02:44:50 INFO - PROCESS | 15355 | |4;prototype.html;322.24161180296664;324.982125983071;335.4649334311773;336.7794094867861;340.8091468777486;5361.463853614637;5421.593380496459;5422.972885135574;5456.236126942226;5468.781248750055;5109.565686916607;5170.53465188133;5356.143017117262;5378.354597448302;5381.165919282517;4168.729032612886;4195.160967806436;4205.63316922;4210.9893625529885;4232.894177645568;4192.8322867085435;4204.621584057434;4217.261979153636;4243.766592837393;4264.936025959613;3975.7216994810374;4033.8184781684895;4058.289799285128;4165.937510937339;4211.263028969934;4201.936970945439;4202.873913782591;4221.704480686353;4224.45082139323;4227.894302642443;3742.120601658608;3746.7002639788752;3749.6876093367378;3751.0809851586264;3756.722714277159;5062.594992400636;5197.740112994373;5214.270002199695;5228;5289.576833853321;4813.422389313269;4849.854504364875;4858.489858564835;4862.367892173995;4878.073166098466;5497;5521.4478552144865;5532.502074813246;5552.444755524415;5617.8033768817895;3980.323345031323;4030.887184012025;4055.3308704063793;4064.6138616831354;4074.185162967389;5706.489144776327;5729;5731.770729170828;5743.827685169452;5768.394318596529;4194.706370554093;4202.159568086395;4204.810783514749;4204.957950420518;4207.116505533811;4143.399207114951;4197.307444271661;4244.236037513278;4250.171216612793;4262.296721041055;4802.375691160197;4813.7593120344545;4819.831305904277;4819.903601927942;4822.348982887335;5599;5599.832005039855;5611.3266408031295;5668.922904648103;5682.943170568324;1371.6570857285678;1426.2227086238024;1438.1946110178333;1443.328852083765;1471.8675319221106;999.6850991937516;1021.867157269565;1030.8041472120274;1032.4373216596973;1033.6020632056711;5374.408815030343;5375.354957405137;5375.650582712111;5383.865403364869;5387.515123638891;5672.886542269214;5677.233573467612;5687.0427377763335;5693.146028095736;5713.200151978726;5125.897482050413;5354.866128346823;5355.785768569292;5362.302900622894;5385.515303622615;2955.9113226603235;2998.250437390652;2999.5500674898503;3007.5639032340187;3010.1270631517054;5806.68063256525;5837.387074357216;5925;5926.585139040226;5931.436513531207;5623.381428042912;5701.94341650942;5784.50831679312;5793.710314484259;5817.767289308465;5817;5868.530517558585;5870.5010074144175;5870.970645146747;5883.411658834168;5480.534154596904;5637.351704554028;5684.8578785529035;5723.31320241557;5771.394003629558;5579.246801681721;5598.21624972496;5627.803026894203;5658.971705141448;5661.264035675501;5816.331121921034;5850.824475265749;5861.476016235724;5862.475756303306;5887.733222709202;4054.716169868199;4124.731892427103;4133.966508372907;4166.999920019113;4174.499060112806;5566.832995010156;5606.747696353592;5642.548596112383;5646.153077038477;5648.915266270927;5338.599605029561;5464.426235245242;5469.371022332482;5474.479924407175;5488.259085023471;5136.948630513647;5513.807016754395;5515.972420137874;5538.556915446835;5570.108782594927;5503.972480137573;5525.392206857323;5536.335639723259;5540.307461567304;5540.806071787468;5446.564274857923;5619.325680918316;5638.21065050885;5665.178549110274;5682.687452190004;5453.836384908459;5456.399796022355;5503.504684578407;5544.584156188383;5562.471565201299 02:44:50 INFO - PROCESS | 15355 | |5;yui.html;779.7426849139785;789.5262842294622;800.3397197312219;814.6415577146055;822.4078663362377;14031.649208769773;15020.248987550605;15024.8731345149;15098.547043588696;15176.924115379421;14684.853151468482;14721.631959201026;14808;14813.55559333219;14889.851101488983;662.092932682226;801.9959900200491;819.7909533069089;833.4249367936135;836.0761358698642;803.5259197073725;809.1018968944496;809.9672917030804;812.6180695073306;816.9387295952797;696.8745625787357;864.7665130414815;865.1219012702112;865.9307255419583;867.2714919467646;706.8232941764559;710.7405796884152;823.6911158315602;849.2059923971107;854.5641722721394;637.1494055435999;637.3308026572128;637.3403527349171;637.5505268785495;637.5951270942985;15335.233238338038;15376.308066136939;15398.846011539854;15424.151671658054;15429.382824687;13238.86761132386;13410.86589134106;13552;13714.794278085838;13742.175469471864;12572.43424045911;12671.36643167838;12782.488700451971;12938.288394138319;12952;4264.168487145008;4359.716618419792;4367.978160109179;4368.912621747579;4378.671599630009;82408.58795706043;83939;84829.57585212096;85425.57287213586;85695.14304856934;11608.419579021016;11614.361210133355;11654.70863228426;11677.649670509898;11819.763604727857;21577.568448631253;21605.02777375022;21629.675554866688;21671.241506547194;21692;8610.311175105977;8840.160184782435;8917.1974522292;9012.954935225282;9079;4466.2630665940405;4530.320451932171;4667.159911216014;4684.6486513510945;4743.501932297128;3410.36908171989;3464.3937310970477;3512.4906888501023;3513.9648603514147;3538.363094642989;614.0420943328422;624.8406656302705;658.3613894522306;674.0967104080555;712.2948281201677;780.4965797060864;780.878963760618;784.6312233250363;805.90732065812;821.3142026408016;9590.760230994141;9813.264005199639;9921.454320012468;10094.545745441474;10493.9475302623;718.3175982816241;724.0595204850945;730.2223132364015;736.7384578474672;798.5049269452976;4807.95192048082;5046.571041461443;5100.336956195671;5100.642954993189;5129.153689641242;125091.37454312852;134308;136501;137302;138161;89873.55063224642;94044;94098.52950735202;106233.84544622857;107748.46125769478;60356.39643603595;60419.69790151109;101369.49315253376;102770.48614756878;104080.47959760153;10221.744456388353;10816.621418250637;10923.726906827393;10942.416221345517;11143.665690029313;46690.533094668615;49329.50670493249;49508.75245623749;50097.24854127264;50302.24546631877;57252.1412178826;60347.39652603418;77413;81220.59389703014;81680.18319816726;12468.5012599495;12572.434240459019;12859.807102893277;13682.973776966966;13880.861191388361;15188.696226075195;15214.16322102295;15573;15919.204039797733;16050.518484445485;14734.410623574937;14822.777658334919;15051.6989660204;15638;15707.057576545443;14478.322963377126;14574.417023318949;14605.561833145022;14960.775588365965;15054.698906021598;14232.644183895485;14599.635009124431;14661;14901.478448254258;14936.985213853157;11406.543738250377;11941.820872686743;12055.81916271239;12062.577809776616;12549.498020079094;11895.226810257305;12020.819687704867;12285.1400401971;12455.875441245471;12590.937045314715 02:44:50 INFO - PROCESS | 15355 | __end_tp_report 02:44:50 INFO - PROCESS | 15355 | __start_cc_report 02:44:50 INFO - PROCESS | 15355 | _x_x_mozilla_cycle_collect,774 02:44:50 INFO - PROCESS | 15355 | __end_cc_report 02:44:50 INFO - PROCESS | 15355 | __startTimestamp1468057490951__endTimestamp 02:44:50 INFO - PROCESS | 15355 | 02:44:50 INFO - PROCESS | 15355 | ------- Summary: start ------- 02:44:50 INFO - PROCESS | 15355 | Number of tests: 6 02:44:50 INFO - PROCESS | 15355 | 02:44:50 INFO - PROCESS | 15355 | [#0] dojo.html Cycles:165 Average:5343.93 Median:5551.86 stddev:615.88 (11.1%) stddev-sans-first:590.08 02:44:50 INFO - PROCESS | 15355 | Values: 3016.0 3033.7 3058.3 3063.5 3072.2 5271.8 5329.5 5348.7 5384.1 5423.1 5350.8 5360.4 5399.8 5411.9 5459.8 4818.9 4871.4 4900.7 4908.0 5013.2 4932.3 4941.8 4983.9 4996.0 5009.8 4810.4 4812.6 4850.0 4859.7 4865.6 4857.5 4878.7 4883.2 4935.4 4982.8 4896.4 4922.3 4922.5 4923.5 4924.9 5234.6 5277.1 5355.9 5414.4 5435.8 5737.5 5767.2 5774.1 5784.7 5794.5 5600.6 5723.4 5743.8 5797.2 5799.7 5355.7 5393.1 5408.0 5459.4 5475.8 5972.9 5976.2 5980.8 5984.9 5985.4 5477.7 5604.7 5715.9 5740.4 5749.1 5725.0 5780.2 5780.9 5838.9 5841.2 5700.4 5736.5 5750.4 5753.2 5796.7 5581.2 5678.9 5742.1 5753.1 5762.2 4399.0 4405.7 4435.5 4444.0 4447.2 3902.1 3915.5 3923.2 3926.3 3958.1 5330.3 5397.2 5490.1 5494.7 5500.0 5667.8 5738.7 5794.9 5844.2 5847.5 5506.8 5519.3 5521.8 5524.1 5530.7 4719.3 4742.8 4784.3 4871.8 4927.2 5952.1 5956.4 5956.6 5959.7 5995.7 5763.0 5774.6 5777.7 5781.0 5781.4 5809.9 5835.4 5877.9 5907.7 5942.9 5643.4 5657.2 5662.0 5663.6 5670.3 5701.1 5758.1 5761.1 5769.5 5769.5 5420.6 5551.4 5580.8 5616.3 5640.5 5625.4 5628.5 5630.2 5638.1 5640.3 5417.0 5516.4 5544.3 5564.4 5566.7 5603.5 5633.3 5653.1 5685.0 5746.5 5549.3 5551.9 5555.5 5559.2 5566.5 02:44:50 INFO - PROCESS | 15355 | 02:44:50 INFO - PROCESS | 15355 | [#1] ext.html Cycles:180 Average:60884.16 Median:203774.00 stddev:126947.16 (62.3%) stddev-sans-first:127222.59 02:44:50 INFO - PROCESS | 15355 | Values: 597.9 604.4 622.1 628.3 631.7 33674.2 43947.1 45087.5 45149.1 45152.0 46379.5 46753.0 46796.8 46826.8 46939.5 7790.5 8953.4 9094.1 9098.1 10408.7 10516.7 10896.3 10914.3 10926.3 10927.4 10985.0 11028.9 11036.9 11039.4 11041.2 8101.8 8275.0 8302.3 10548.5 10918.5 10507.2 10561.5 10569.7 10573.7 10575.7 42699.8 43042.8 43141.6 43157.6 43167.0 3449.6 3496.0 3508.5 3524.9 3564.0 33761.5 33990.8 34167.5 34572.5 35555.5 4472.8 4537.6 4544.5 4579.9 4679.0 251204.0 254295.0 254340.0 363618.0 369895.0 34415.3 35911.0 62317.0 62838.4 62932.4 37825.2 37853.8 37913.0 37956.4 37980.0 16101.6 16261.3 16274.2 16277.9 16285.8 13475.9 13625.2 13625.3 13643.1 13649.9 8455.3 8483.4 8513.1 8568.0 8580.0 3258.8 3271.5 3282.2 3282.8 3295.8 1016.3 1030.8 1077.4 1132.5 1190.8 33103.5 33532.5 33601.8 33754.8 33858.8 1054.7 1079.4 1096.3 1097.2 1124.5 17050.5 17831.6 17857.7 17891.4 17905.3 630439.0 632643.0 638503.0 638580.0 641837.0 61345.0 61586.4 61948.0 61971.0 62191.7 1237.4 1338.1 1373.0 1390.4 1391.2 31228.8 34720.0 34748.5 34773.1 34894.5 44854.1 45042.3 45543.3 45600.8 45687.0 422854.0 424821.8 424966.0 426110.0 426441.0 24781.3 27378.3 28387.7 28678.7 29116.0 48563.3 48563.8 49891.8 51092.0 52221.0 43498.0 44491.3 44539.0 44541.6 44861.3 42403.0 42935.6 44551.3 46154.0 46485.0 42873.4 43023.8 43526.6 43591.3 43963.1 37653.0 38782.4 38850.8 39064.8 39598.8 29124.3 29205.7 29538.6 29644.6 29726.9 02:44:50 INFO - PROCESS | 15355 | 02:44:50 INFO - PROCESS | 15355 | [#2] jquery.html Cycles:180 Average:28183.32 Median:24719.94 stddev:73508.09 (297.4%) stddev-sans-first:73684.66 02:44:50 INFO - PROCESS | 15355 | Values: 384.8 394.7 399.0 404.7 420.5 13336.5 19447.9 20677.0 21169.3 21223.3 15040.0 19352.6 19464.1 20187.7 20532.2 5759.7 6002.5 6009.0 6011.0 6025.8 5917.4 5932.3 5939.9 5943.4 5950.6 4288.5 4755.3 6488.4 6490.2 6591.2 6318.1 6500.7 6518.4 6574.9 6581.2 5550.2 5562.1 5605.7 5616.4 5617.2 23651.8 24631.0 24808.9 24899.1 25172.7 2598.8 2603.1 2784.8 2803.3 2912.2 14604.2 15329.4 15471.1 15727.6 15947.5 1970.5 2066.5 2080.3 2151.9 2214.8 75654.6 80151.6 81425.2 83341.2 86453.6 11057.9 11407.7 11431.3 11563.9 11892.1 15788.1 15819.8 15976.4 15984.3 16021.0 8408.0 8475.6 8580.7 8692.0 8759.7 8416.8 8435.5 8484.1 8582.3 8607.7 4018.4 4693.7 4868.7 5007.7 5068.7 1951.6 2001.9 2015.3 2026.9 2069.3 990.8 1019.2 1064.4 1073.1 1081.6 19197.4 19887.2 20217.4 20233.4 20367.9 1036.9 1043.2 1067.5 1067.9 1072.9 10869.7 11023.5 11043.7 11104.8 11130.5 396397.0 397346.0 400135.0 481577.0 531229.0 60663.7 77722.6 88721.6 92026.5 97944.0 1016.1 1035.1 1051.1 1056.5 1075.4 18455.3 18608.3 18953.5 18977.8 19205.6 46187.3 46544.0 46668.5 46704.5 47062.3 59698.7 63979.0 64591.7 64904.7 65642.0 7667.1 8073.9 8762.6 9010.1 9104.0 14466.0 14496.8 14602.8 14899.0 14986.5 11923.2 12292.7 12356.0 12367.9 12746.6 11479.3 11818.5 11899.0 11959.2 11974.3 12633.4 12637.3 12794.4 12851.6 12888.9 8092.7 8157.5 8407.7 8468.8 8668.9 11923.6 12149.3 12361.8 12370.8 12385.5 02:44:50 INFO - PROCESS | 15355 | 02:44:50 INFO - PROCESS | 15355 | [#3] mootools.html Cycles:180 Average:5888.51 Median:4361.46 stddev:3425.40 (78.5%) stddev-sans-first:3417.76 02:44:50 INFO - PROCESS | 15355 | Values: 1314.2 1469.3 1483.9 1644.9 1803.5 8552.3 8949.9 8963.3 9140.4 9163.3 8797.9 9066.0 9076.2 9081.9 9084.4 1963.6 2019.7 2022.2 2303.5 2360.2 2015.8 2017.8 2247.4 2321.5 2326.0 2295.2 2307.9 2315.8 2317.5 2318.3 1878.5 2286.5 2289.0 2296.0 2297.5 2248.1 2319.0 2320.8 2325.6 2329.4 8973.1 9045.2 9046.8 9048.7 9053.8 5182.9 5322.1 5325.0 5328.8 5338.5 3436.1 3471.5 3533.6 3600.9 3647.2 1159.7 1175.5 1193.3 1195.8 1208.0 12611.9 12618.0 12642.0 12650.7 12651.6 4346.8 4485.2 4658.6 4659.0 4699.1 10632.0 10637.7 10647.0 10650.9 10657.8 5290.0 5297.4 5308.8 5311.0 5319.7 4674.9 4873.7 4896.8 4912.7 4917.6 3965.3 4020.5 4072.0 4087.4 4116.7 1268.4 1288.2 1292.3 1292.4 1299.8 1028.8 1038.3 1043.5 1050.5 1050.6 6043.6 6193.0 6225.1 6344.3 6429.0 442.9 449.7 451.8 1039.2 1041.9 4203.9 4231.9 4320.4 4333.8 4376.1 11097.7 11376.0 11496.5 11496.6 11503.9 11230.3 11234.2 11355.3 11360.5 11388.7 7965.5 8253.2 8257.7 8319.7 8428.4 5917.6 6011.7 6169.7 6172.1 6205.6 10525.3 10532.8 10754.5 10757.6 10776.7 9495.6 10674.2 10907.6 10911.1 11078.8 7371.8 7547.5 7558.4 7672.2 7700.7 8173.1 8203.5 8292.3 8471.5 8473.5 6408.4 7844.3 7864.0 7935.3 8183.5 7271.0 7286.6 7371.1 7485.2 7693.8 6925.8 6930.4 6996.2 6998.3 7042.8 5061.1 5087.8 5143.2 5175.8 5205.0 5166.2 5203.0 5240.7 5264.4 5314.2 02:44:50 INFO - PROCESS | 15355 | 02:44:50 INFO - PROCESS | 15355 | [#4] prototype.html Cycles:180 Average:4709.05 Median:5375.50 stddev:1360.29 (25.3%) stddev-sans-first:1323.66 02:44:50 INFO - PROCESS | 15355 | Values: 322.2 325.0 335.5 336.8 340.8 5361.5 5421.6 5423.0 5456.2 5468.8 5109.6 5170.5 5356.1 5378.4 5381.2 4168.7 4195.2 4205.6 4211.0 4232.9 4192.8 4204.6 4217.3 4243.8 4264.9 3975.7 4033.8 4058.3 4165.9 4211.3 4201.9 4202.9 4221.7 4224.5 4227.9 3742.1 3746.7 3749.7 3751.1 3756.7 5062.6 5197.7 5214.3 5228.0 5289.6 4813.4 4849.9 4858.5 4862.4 4878.1 5497.0 5521.4 5532.5 5552.4 5617.8 3980.3 4030.9 4055.3 4064.6 4074.2 5706.5 5729.0 5731.8 5743.8 5768.4 4194.7 4202.2 4204.8 4205.0 4207.1 4143.4 4197.3 4244.2 4250.2 4262.3 4802.4 4813.8 4819.8 4819.9 4822.3 5599.0 5599.8 5611.3 5668.9 5682.9 1371.7 1426.2 1438.2 1443.3 1471.9 999.7 1021.9 1030.8 1032.4 1033.6 5374.4 5375.4 5375.7 5383.9 5387.5 5672.9 5677.2 5687.0 5693.1 5713.2 5125.9 5354.9 5355.8 5362.3 5385.5 2955.9 2998.3 2999.6 3007.6 3010.1 5806.7 5837.4 5925.0 5926.6 5931.4 5623.4 5701.9 5784.5 5793.7 5817.8 5817.0 5868.5 5870.5 5871.0 5883.4 5480.5 5637.4 5684.9 5723.3 5771.4 5579.2 5598.2 5627.8 5659.0 5661.3 5816.3 5850.8 5861.5 5862.5 5887.7 4054.7 4124.7 4134.0 4167.0 4174.5 5566.8 5606.7 5642.5 5646.2 5648.9 5338.6 5464.4 5469.4 5474.5 5488.3 5136.9 5513.8 5516.0 5538.6 5570.1 5504.0 5525.4 5536.3 5540.3 5540.8 5446.6 5619.3 5638.2 5665.2 5682.7 5453.8 5456.4 5503.5 5544.6 5562.5 02:44:50 INFO - PROCESS | 15355 | 02:44:50 INFO - PROCESS | 15355 | [#5] yui.html Cycles:180 Average:21664.65 Median:3526.16 stddev:32084.51 (909.9%) stddev-sans-first:32136.19 02:44:50 INFO - PROCESS | 15355 | Values: 779.7 789.5 800.3 814.6 822.4 14031.6 15020.2 15024.9 15098.5 15176.9 14684.9 14721.6 14808.0 14813.6 14889.9 662.1 802.0 819.8 833.4 836.1 803.5 809.1 810.0 812.6 816.9 696.9 864.8 865.1 865.9 867.3 706.8 710.7 823.7 849.2 854.6 637.1 637.3 637.3 637.6 637.6 15335.2 15376.3 15398.8 15424.2 15429.4 13238.9 13410.9 13552.0 13714.8 13742.2 12572.4 12671.4 12782.5 12938.3 12952.0 4264.2 4359.7 4368.0 4368.9 4378.7 82408.6 83939.0 84829.6 85425.6 85695.1 11608.4 11614.4 11654.7 11677.6 11819.8 21577.6 21605.0 21629.7 21671.2 21692.0 8610.3 8840.2 8917.2 9013.0 9079.0 4466.3 4530.3 4667.2 4684.6 4743.5 3410.4 3464.4 3512.5 3514.0 3538.4 614.0 624.8 658.4 674.1 712.3 780.5 780.9 784.6 805.9 821.3 9590.8 9813.3 9921.5 10094.5 10493.9 718.3 724.1 730.2 736.7 798.5 4808.0 5046.6 5100.3 5100.6 5129.2 125091.4 134308.0 136501.0 137302.0 138161.0 89873.6 94044.0 94098.5 106233.8 107748.5 60356.4 60419.7 101369.5 102770.5 104080.5 10221.7 10816.6 10923.7 10942.4 11143.7 46690.5 49329.5 49508.8 50097.2 50302.2 57252.1 60347.4 77413.0 81220.6 81680.2 12468.5 12572.4 12859.8 13683.0 13880.9 15188.7 15214.2 15573.0 15919.2 16050.5 14734.4 14822.8 15051.7 15638.0 15707.1 14478.3 14574.4 14605.6 14960.8 15054.7 14232.6 14599.6 14661.0 14901.5 14937.0 11406.5 11941.8 12055.8 12062.6 12549.5 11895.2 12020.8 12285.1 12455.9 12590.9 02:44:50 INFO - PROCESS | 15355 | -------- Summary: end -------- 02:44:50 INFO - PROCESS | 15355 | 02:44:51 INFO - TEST-INFO | 15355: exit 0 02:44:51 INFO - TEST-OK | dromaeo_css | took 1113490ms 02:44:51 INFO - TEST-START | kraken 02:44:51 INFO - operating with platform_type : linux_ 02:44:51 INFO - Initialising browser for kraken test... 02:44:51 INFO - TEST-INFO | started process 15539 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptMVGaQ/profile http://localhost:59637/getInfo.html) 02:44:55 INFO - PROCESS | 15539 | __metrics Screen width/height:1600/1200 02:44:55 INFO - PROCESS | 15539 | colorDepth:24 02:44:55 INFO - PROCESS | 15539 | Browser inner width/height: 1024/697 02:44:55 INFO - PROCESS | 15539 | __metrics 02:44:56 INFO - PROCESS | 15539 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:44:57 INFO - TEST-INFO | 15539: exit 0 02:44:57 INFO - Browser initialized. 02:44:57 INFO - Running cycle 1/1 for kraken test... 02:44:57 INFO - TEST-INFO | started process 15622 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptMVGaQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:45:09 INFO - PROCESS | 15622 | RSS: Main: 156758016 02:45:09 INFO - PROCESS | 15622 | 02:45:12 INFO - PROCESS | 15622 | Cycle 1(1): loaded http://localhost:59637/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59637/tests/kraken/driver.html?testName=audio-beat-detection) 02:45:12 INFO - PROCESS | 15622 | RSS: Main: 215187456 02:45:12 INFO - PROCESS | 15622 | 02:45:15 INFO - PROCESS | 15622 | Cycle 1(1): loaded http://localhost:59637/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59637/tests/kraken/driver.html?testName=audio-dft) 02:45:16 INFO - PROCESS | 15622 | RSS: Main: 203542528 02:45:16 INFO - PROCESS | 15622 | 02:45:19 INFO - PROCESS | 15622 | Cycle 1(1): loaded http://localhost:59637/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59637/tests/kraken/driver.html?testName=audio-fft) 02:45:19 INFO - PROCESS | 15622 | RSS: Main: 269324288 02:45:19 INFO - PROCESS | 15622 | 02:45:22 INFO - PROCESS | 15622 | Cycle 1(1): loaded http://localhost:59637/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59637/tests/kraken/driver.html?testName=audio-oscillator) 02:45:22 INFO - PROCESS | 15622 | RSS: Main: 180625408 02:45:22 INFO - PROCESS | 15622 | 02:45:24 INFO - PROCESS | 15622 | Cycle 1(1): loaded http://localhost:59637/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59637/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:45:25 INFO - PROCESS | 15622 | RSS: Main: 185143296 02:45:25 INFO - PROCESS | 15622 | 02:45:28 INFO - PROCESS | 15622 | Cycle 1(1): loaded http://localhost:59637/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59637/tests/kraken/driver.html?testName=imaging-darkroom) 02:45:29 INFO - PROCESS | 15622 | RSS: Main: 218898432 02:45:29 INFO - PROCESS | 15622 | 02:45:32 INFO - PROCESS | 15622 | Cycle 1(1): loaded http://localhost:59637/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59637/tests/kraken/driver.html?testName=imaging-desaturate) 02:45:32 INFO - PROCESS | 15622 | RSS: Main: 220413952 02:45:32 INFO - PROCESS | 15622 | 02:45:35 INFO - PROCESS | 15622 | Cycle 1(1): loaded http://localhost:59637/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59637/tests/kraken/driver.html?testName=json-parse-financial) 02:45:36 INFO - PROCESS | 15622 | RSS: Main: 221548544 02:45:36 INFO - PROCESS | 15622 | 02:45:37 INFO - PROCESS | 15622 | Cycle 1(1): loaded http://localhost:59637/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59637/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:45:38 INFO - PROCESS | 15622 | RSS: Main: 208855040 02:45:38 INFO - PROCESS | 15622 | 02:45:40 INFO - PROCESS | 15622 | Cycle 1(1): loaded http://localhost:59637/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59637/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:45:40 INFO - PROCESS | 15622 | RSS: Main: 212193280 02:45:40 INFO - PROCESS | 15622 | 02:45:42 INFO - PROCESS | 15622 | Cycle 1(1): loaded http://localhost:59637/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59637/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:45:43 INFO - PROCESS | 15622 | RSS: Main: 211800064 02:45:43 INFO - PROCESS | 15622 | 02:45:46 INFO - PROCESS | 15622 | Cycle 1(1): loaded http://localhost:59637/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59637/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:45:46 INFO - PROCESS | 15622 | RSS: Main: 223780864 02:45:46 INFO - PROCESS | 15622 | 02:45:49 INFO - PROCESS | 15622 | Cycle 1(1): loaded http://localhost:59637/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59637/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:45:49 INFO - PROCESS | 15622 | RSS: Main: 225636352 02:45:49 INFO - PROCESS | 15622 | 02:45:51 INFO - PROCESS | 15622 | Cycle 1(1): loaded http://localhost:59637/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59637/tests/kraken/driver.html?testName=ai-astar) 02:45:51 INFO - PROCESS | 15622 | RSS: Main: 267816960 02:45:51 INFO - PROCESS | 15622 | 02:45:51 INFO - PROCESS | 15622 | __start_tp_report 02:45:51 INFO - PROCESS | 15622 | _x_x_mozilla_page_load 02:45:51 INFO - PROCESS | 15622 | _x_x_mozilla_page_load_details 02:45:51 INFO - PROCESS | 15622 | |i|pagename|runs| 02:45:51 INFO - PROCESS | 15622 | |0;ai-astar;101;111;111;112;113;111;112;110;112;110 02:45:51 INFO - PROCESS | 15622 | |1;audio-beat-detection;145;118;123;165;118;118;158;118;153;118 02:45:51 INFO - PROCESS | 15622 | |2;audio-dft;161;163;161;161;162;160;163;162;161;162 02:45:51 INFO - PROCESS | 15622 | |3;audio-fft;76;75;75;129;76;75;73;73;97;77 02:45:51 INFO - PROCESS | 15622 | |4;audio-oscillator;84;85;109;84;84;83;110;84;85;121 02:45:51 INFO - PROCESS | 15622 | |5;imaging-gaussian-blur;117;118;116;117;117;116;117;117;117;116 02:45:51 INFO - PROCESS | 15622 | |6;imaging-darkroom;147;145;146;146;146;145;146;145;145;145 02:45:51 INFO - PROCESS | 15622 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 02:45:51 INFO - PROCESS | 15622 | |8;json-parse-financial;53;51;52;52;51;52;52;52;51;52 02:45:51 INFO - PROCESS | 15622 | |9;json-stringify-tinderbox;62;62;62;62;61;62;62;62;65;62 02:45:51 INFO - PROCESS | 15622 | |10;stanford-crypto-aes;75;74;80;75;84;76;79;80;80;75 02:45:51 INFO - PROCESS | 15622 | |11;stanford-crypto-ccm;131;118;125;125;126;124;121;128;158;120 02:45:51 INFO - PROCESS | 15622 | |12;stanford-crypto-pbkdf2;163;159;159;156;159;159;156;157;156;156 02:45:51 INFO - PROCESS | 15622 | |13;stanford-crypto-sha256-iterative;63;62;63;63;63;62;63;61;64;62 02:45:51 INFO - PROCESS | 15622 | __end_tp_report 02:45:51 INFO - PROCESS | 15622 | __start_cc_report 02:45:51 INFO - PROCESS | 15622 | _x_x_mozilla_cycle_collect,1664 02:45:51 INFO - PROCESS | 15622 | __end_cc_report 02:45:51 INFO - PROCESS | 15622 | __startTimestamp1468057551812__endTimestamp 02:45:51 INFO - PROCESS | 15622 | 02:45:51 INFO - PROCESS | 15622 | ------- Summary: start ------- 02:45:51 INFO - PROCESS | 15622 | Number of tests: 14 02:45:51 INFO - PROCESS | 15622 | 02:45:51 INFO - PROCESS | 15622 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:3.40 (3.1%) stddev-sans-first:1.00 02:45:51 INFO - PROCESS | 15622 | Values: 101.0 111.0 111.0 112.0 113.0 111.0 112.0 110.0 112.0 110.0 02:45:51 INFO - PROCESS | 15622 | 02:45:51 INFO - PROCESS | 15622 | [#1] audio-beat-detection Cycles:10 Average:133.40 Median:134.00 stddev:19.48 (14.5%) stddev-sans-first:20.21 02:45:51 INFO - PROCESS | 15622 | Values: 145.0 118.0 123.0 165.0 118.0 118.0 158.0 118.0 153.0 118.0 02:45:51 INFO - PROCESS | 15622 | 02:45:51 INFO - PROCESS | 15622 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 02:45:51 INFO - PROCESS | 15622 | Values: 161.0 163.0 161.0 161.0 162.0 160.0 163.0 162.0 161.0 162.0 02:45:51 INFO - PROCESS | 15622 | 02:45:51 INFO - PROCESS | 15622 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.50 stddev:17.75 (23.5%) stddev-sans-first:18.67 02:45:51 INFO - PROCESS | 15622 | Values: 76.0 75.0 75.0 129.0 76.0 75.0 73.0 73.0 97.0 77.0 02:45:51 INFO - PROCESS | 15622 | 02:45:51 INFO - PROCESS | 15622 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:84.00 stddev:14.46 (17.2%) stddev-sans-first:14.97 02:45:51 INFO - PROCESS | 15622 | Values: 84.0 85.0 109.0 84.0 84.0 83.0 110.0 84.0 85.0 121.0 02:45:51 INFO - PROCESS | 15622 | 02:45:51 INFO - PROCESS | 15622 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 02:45:51 INFO - PROCESS | 15622 | Values: 117.0 118.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 02:45:51 INFO - PROCESS | 15622 | 02:45:51 INFO - PROCESS | 15622 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 02:45:51 INFO - PROCESS | 15622 | Values: 147.0 145.0 146.0 146.0 146.0 145.0 146.0 145.0 145.0 145.0 02:45:51 INFO - PROCESS | 15622 | 02:45:51 INFO - PROCESS | 15622 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 02:45:51 INFO - PROCESS | 15622 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 02:45:51 INFO - PROCESS | 15622 | 02:45:51 INFO - PROCESS | 15622 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:0.63 (1.2%) stddev-sans-first:0.50 02:45:51 INFO - PROCESS | 15622 | Values: 53.0 51.0 52.0 52.0 51.0 52.0 52.0 52.0 51.0 52.0 02:45:51 INFO - PROCESS | 15622 | 02:45:51 INFO - PROCESS | 15622 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:1.03 (1.7%) stddev-sans-first:1.09 02:45:51 INFO - PROCESS | 15622 | Values: 62.0 62.0 62.0 62.0 61.0 62.0 62.0 62.0 65.0 62.0 02:45:51 INFO - PROCESS | 15622 | 02:45:51 INFO - PROCESS | 15622 | [#10] stanford-crypto-aes Cycles:10 Average:77.80 Median:79.50 stddev:3.26 (4.1%) stddev-sans-first:3.30 02:45:51 INFO - PROCESS | 15622 | Values: 75.0 74.0 80.0 75.0 84.0 76.0 79.0 80.0 80.0 75.0 02:45:51 INFO - PROCESS | 15622 | 02:45:51 INFO - PROCESS | 15622 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:125.50 stddev:11.35 (9.0%) stddev-sans-first:11.97 02:45:51 INFO - PROCESS | 15622 | Values: 131.0 118.0 125.0 125.0 126.0 124.0 121.0 128.0 158.0 120.0 02:45:51 INFO - PROCESS | 15622 | 02:45:51 INFO - PROCESS | 15622 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.00 Median:159.00 stddev:2.26 (1.4%) stddev-sans-first:1.51 02:45:51 INFO - PROCESS | 15622 | Values: 163.0 159.0 159.0 156.0 159.0 159.0 156.0 157.0 156.0 156.0 02:45:51 INFO - PROCESS | 15622 | 02:45:51 INFO - PROCESS | 15622 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:0.84 (1.3%) stddev-sans-first:0.88 02:45:51 INFO - PROCESS | 15622 | Values: 63.0 62.0 63.0 63.0 63.0 62.0 63.0 61.0 64.0 62.0 02:45:51 INFO - PROCESS | 15622 | -------- Summary: end -------- 02:45:51 INFO - PROCESS | 15622 | 02:45:52 INFO - TEST-INFO | 15622: exit 0 02:45:52 INFO - TEST-OK | kraken | took 61003ms 02:45:52 INFO - SUITE-END | took 1174s 02:45:52 INFO - Completed test suite (00:19:34) 02:45:52 INFO - javascript benchmark 02:45:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3016.049944267556, 3033.666296707363, 3058.2507285714996, 3063.509838425851, 3072.2012276808023, 5271.841844744654, 5329.520343169114, 5348.679079255247, 5384.138537833947, 5423.05096608093, 5350.8127215547465, 5360.437154098822, 5399.811006614769, 5411.891762164764, 5459.836204913859, 4818.855434336975, 4871.415430148387, 4900.6569540132205, 4908.0429316283335, 5013.172826483626, 4932.260160975864, 4941.827036053739, 4983.900321993558, 4995.950040499585, 5009.774560144802, 4810.39870016248, 4812.614990800745, 4850.029994001196, 4859.73271470069, 4865.635077369176, 4857.489963553811, 4878.707277563358, 4883.218685010417, 4935.358403407534, 4982.750862456863, 4896.387951506062, 4922.335484709554, 4922.458529561745, 4923.507649235084, 4924.901501969976, 5234.6335756497065, 5277.102892508283, 5355.946440535584, 5414.35027796663, 5435.809746658848, 5737.454941780524, 5767.192593036978, 5774.076147816371, 5784.710764461802, 5794.536437085023, 5600.635958662674, 5723.370429252779, 5743.827685169452, 5797.217375654317, 5799.652020878719, 5355.705436201008, 5393.083175860113, 5407.972960135214, 5459.426760190163, 5475.780968761205, 5972.940270597239, 5976.163337132805, 5980.760769569169, 5984.880302393928, 5985.431384018599, 5477.67133971955, 5604.747786349624, 5715.942840571541, 5740.42595740431, 5749.108888122348, 5725.0, 5780.219670344533, 5780.942190578125, 5838.9124163137585, 5841.240638717025, 5700.37295897451, 5736.483716465538, 5750.4249575042995, 5753.194552762617, 5796.652200867961, 5581.162825576196, 5678.858028549319, 5742.08126699726, 5753.108268218432, 5762.193292938992, 4399.032212913154, 4405.735655860659, 4435.534268901783, 4443.977780111079, 4447.155040542287, 3902.083010492532, 3915.471411359487, 3923.2349691810396, 3926.2932672118723, 3958.0698535844053, 5330.280412144389, 5397.2443857859935, 5490.066688662937, 5494.725263736797, 5500.0, 5667.80162694312, 5738.741756620962, 5794.913076303858, 5844.152597873284, 5847.532197424196, 5506.779728810803, 5519.337679478408, 5521.806736764194, 5524.088525393346, 5530.695811730313, 4719.292106184032, 4742.810287588527, 4784.2823576463115, 4871.80512779492, 4927.162382395001, 5952.077427998754, 5956.434138756811, 5956.642601443928, 5959.702014899238, 5995.670238136944, 5763.0, 5774.56690748204, 5777.653340799566, 5780.988327042666, 5781.421857814353, 5809.94190058111, 5835.358110607915, 5877.853053673693, 5907.704614769158, 5942.881142377042, 5643.435656434323, 5657.2079908811975, 5662.009148398932, 5663.631863928831, 5670.291213598301, 5701.0593252114595, 5758.107493338539, 5761.107028410603, 5769.480746732815, 5769.480746732815, 5420.566354691694, 5551.417101204315, 5580.832575022756, 5616.326040875121, 5640.464155905182, 5625.381208067191, 5628.493435590816, 5630.183623374506, 5638.097904335286, 5640.32316122068, 5416.9729151353995, 5516.365617953987, 5544.279243698294, 5564.443555644403, 5566.721663916707, 5603.467670571289, 5633.295838020247, 5653.067243904709, 5684.971575142264, 5746.454086861741, 5549.278593782782, 5551.861203469945, 5555.527780138734, 5559.221708960829, 5566.471185237396], "value": 5301.306015338856, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.9133025711271, 604.3503234023423, 622.0637939900449, 628.3057221769941, 631.6904716688819, 33674.158146046364, 43947.12105757883, 45087.54912450875, 45149.09701805962, 45152.0, 46379.536204637945, 46753.0, 46796.76601616995, 46826.76586617071, 46939.530604693944, 7790.493617914817, 8953.418027828187, 9094.136057074567, 9098.135677110697, 10408.739781505446, 10516.737081572945, 10896.346219226833, 10914.345139291669, 10926.289791163588, 10927.398993055418, 10985.0, 11028.889711102907, 11036.889631103706, 11039.39283339416, 11041.227114102016, 8101.797455063641, 8275.04836943753, 8302.294304984083, 10548.525316360781, 10918.50866711, 10507.159427245802, 10561.471926403648, 10569.682909512727, 10573.682789516326, 10575.73560660982, 42699.7865010676, 43042.78478607618, 43141.56858431407, 43157.568424315985, 43167.0, 3449.58604967403, 3495.982520087409, 3508.5088087667746, 3524.8766293179874, 3563.982180089109, 33761.49357759635, 33990.83004584986, 34167.48748768771, 34572.48141277883, 35555.466668, 4472.82108715651, 4537.636989040901, 4544.454665440136, 4579.931301030487, 4679.0, 251204.0, 254295.0, 254340.0, 363618.0, 369895.0, 34415.31169376648, 35911.0, 62317.0, 62838.37161628325, 62932.37067629265, 37825.2434951305, 37853.81073094617, 37913.0, 37956.43065354022, 37980.0, 16101.597460063593, 16261.268242929096, 16274.186290685418, 16277.918610407109, 16285.837141628668, 13475.932620336836, 13625.182489050689, 13625.318734063258, 13643.113197642122, 13649.86350136486, 8455.26667033269, 8483.363747718946, 8513.148685131437, 8567.957160214284, 8580.0, 3258.7718859679594, 3271.492918597621, 3282.163048422637, 3282.8017773512497, 3295.8022518648477, 1016.3241444439512, 1030.7680771826429, 1077.4020418667558, 1132.5130194016488, 1190.8273300371397, 33103.50344744831, 33532.49701254483, 33601.815881967595, 33754.831225843714, 33858.83070584631, 1054.6625079974335, 1079.400932482464, 1096.31480324797, 1097.2154909239932, 1124.4771181400688, 17050.48848534546, 17831.621038462104, 17857.675964533184, 17891.370628954126, 17905.344968097026, 630439.0, 632643.0, 638503.0, 638580.0, 641837.0, 61345.0, 61586.38413615896, 61948.0, 61971.0, 62191.689041554506, 1237.4431505822415, 1338.116842883692, 1372.979405308921, 1390.3951780975308, 1391.1792042694858, 31228.843855780575, 34720.0, 34748.47877281792, 34773.13067173341, 34894.476582850766, 44854.10291794211, 45042.32436513389, 45543.31685024794, 45600.7719961398, 45687.0, 422854.0, 424821.75178247824, 424966.0, 426110.0, 426441.0, 24781.25656230316, 27378.315542111606, 28387.716122839334, 28678.713212867606, 29116.0, 48563.27155092606, 48563.75718121387, 49891.75054124851, 51092.0, 52221.0, 43498.0, 44491.332630011224, 44539.0, 44541.55458445374, 44861.32708009317, 42403.0, 42935.60257131623, 44551.33173002343, 46154.0, 46485.0, 42873.35689964715, 43023.78488107539, 43526.56473435225, 43591.34612980745, 43963.12073758571, 37653.0, 38782.4182637255, 38850.80574597109, 39064.80467597644, 39598.80200598978, 29124.34299519357, 29205.7079429203, 29538.556921645762, 29644.55533166961, 29726.851365743034], "value": 19661.10033025284, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.80759620189906, 394.6527056190552, 398.9980050099749, 404.7227649060394, 420.48070632768525, 13336.533221337255, 19447.902760486195, 20676.96615169243, 21169.259075932325, 21223.257185998493, 15040.0, 19352.612947741072, 19464.12411441485, 20187.69718454221, 20532.178712851506, 5759.712014399284, 6002.459778619924, 6009.008513595273, 6010.96994515029, 6025.849353766147, 5917.378675239102, 5932.317783454915, 5939.940600594004, 5943.4056594340655, 5950.642961422329, 4288.506821715496, 4755.334253204554, 6488.416042556169, 6490.156279683634, 6591.209054913417, 6318.147050148217, 6500.674966251669, 6518.380753828355, 6574.8685026299445, 6581.24315703693, 5550.222968784374, 5562.054450743343, 5605.663660180402, 5616.354119276254, 5617.21359009739, 23651.763482365128, 24631.0, 24808.875955620108, 24899.128530501526, 25172.748272517405, 2598.8180827342094, 2603.1149409200775, 2784.8050636455455, 2803.285162283625, 2912.228259511231, 14604.196769177692, 15329.386824527006, 15471.149086800222, 15727.606809829731, 15947.521574352788, 1970.546774241918, 2066.4730493724155, 2080.2719048333115, 2151.87088774674, 2214.8006679398773, 75654.62172689156, 80151.59924200342, 81425.18574814295, 83341.16658833394, 86453.56773216157, 11057.889421105847, 11407.714807129889, 11431.256968297033, 11563.88436115645, 11892.108091893142, 15788.131652758979, 15819.762703559456, 15976.360945562279, 15984.280707367963, 16021.0, 8408.0, 8475.576221188916, 8580.742577722678, 8692.044290034819, 8759.693410730593, 8416.78958026042, 8435.493870367674, 8484.066752657203, 8582.270507006975, 8607.741767746978, 4018.3972404139026, 4693.718376897397, 4868.68545492715, 5007.7245751484015, 5068.721220332917, 1951.5804102118113, 2001.9199232030555, 2015.2644284835928, 2026.8682535635137, 2069.286096296775, 990.782027953849, 1019.1948360794889, 1064.4411683866033, 1073.1254027967182, 1081.567373050786, 19197.424077277705, 19887.204511819364, 20217.393478195383, 20233.392998210078, 20367.898160509398, 1036.9118624916816, 1043.1967385113571, 1067.4662668665667, 1067.8718553773597, 1072.8605281313535, 10869.67390978272, 11023.503942322453, 11043.668689939315, 11104.777904441866, 11130.49912753928, 396397.0, 397346.0, 400135.0, 481577.0, 531229.0, 60663.69668151719, 77722.6113869427, 88721.55639221762, 92026.53986730157, 97944.0, 1016.1007508355159, 1035.089121573011, 1051.1013083813382, 1056.5034433816095, 1075.4407707991957, 18455.261789528267, 18608.34870779516, 18953.526161846064, 18977.810221897606, 19205.615887681888, 46187.30719039284, 46544.0, 46668.53331466642, 46704.532954670016, 47062.294065589726, 59698.70150649219, 63979.0, 64591.677041614494, 64904.70190596256, 65642.0, 7667.079950405987, 8073.878891816745, 8762.561871906251, 9010.14403631654, 9103.954480227821, 14466.0, 14496.782548261574, 14602.780958285422, 14899.0, 14986.47547335838, 11923.224990375598, 12292.692682683004, 12356.0, 12367.876321237032, 12746.617601471971, 11479.253848500155, 11818.527258909548, 11899.0, 11959.222650527689, 11974.341411222118, 12633.431495582905, 12637.304948227937, 12794.36028198605, 12851.550195743479, 12888.935555322163, 8092.6762929482165, 8157.469764465291, 8407.663693452194, 8468.830623387621, 8668.91331086681, 11923.582674606347, 12149.331786751813, 12361.752764944831, 12370.75258494807, 12385.504579816707], "value": 9675.049526243658, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.2311747627637, 1469.3461409672695, 1483.9406423743048, 1644.942427015054, 1803.49502139401, 8552.315814734822, 8949.865752013726, 8963.327750418712, 9140.360174787767, 9163.266938644909, 8797.912020879789, 9066.048064953184, 9076.183143517082, 9081.90918090819, 9084.409513381626, 1963.6465436221474, 2019.6667549854255, 2022.1911235505843, 2303.493231489074, 2360.209329874494, 2015.8488113391481, 2017.8385729141633, 2247.4493749031512, 2321.5124823787023, 2325.965110523335, 2295.185209250717, 2307.9307620771406, 2315.7568455312203, 2317.4669825940045, 2318.327684971356, 1878.4552479780848, 2286.4741109544816, 2288.9885550572308, 2295.988520057406, 2297.471581536248, 2248.1457046322294, 2319.0491898321775, 2320.7795259450495, 2325.5697695926306, 2329.4060014696315, 8973.147550982647, 9045.231155351803, 9046.81906361869, 9048.683296084671, 9053.818923621557, 5182.870428239325, 5322.068637988336, 5325.041492531343, 5328.8401347959625, 5338.466153384669, 3436.1066122808, 3471.5139880416764, 3533.641903956166, 3600.945985810215, 3647.2340808430263, 1159.727464045957, 1175.5121624525812, 1193.3078814287692, 1195.7787809255315, 1208.0456439412853, 12611.936940315332, 12618.0, 12642.0, 12650.74698506034, 12651.557195498206, 4346.847860324873, 4485.215087359699, 4658.604018658384, 4658.976705116521, 4699.107169637758, 10632.0, 10637.680869573926, 10647.0, 10650.94674526638, 10657.786844263072, 5290.047791397508, 5297.443768404339, 5308.761105750174, 5311.017461769585, 5319.7340132993195, 4674.929876051862, 4873.6832105913, 4896.828610998598, 4912.72979986097, 4917.557419832232, 3965.266425711253, 4020.4974378202724, 4071.97964010184, 4087.4481944937647, 4116.670666346685, 1268.4101892619976, 1288.2463758701078, 1292.3086148910288, 1292.3796577642784, 1299.7920332746903, 1028.7788125553043, 1038.2576457832686, 1043.4834756795435, 1050.4537640426936, 1050.5535147562255, 6043.637381757108, 6193.009118541012, 6225.128482012522, 6344.302126766052, 6429.0, 442.88484993901176, 449.6560131499406, 451.8463722334422, 1039.184240371305, 1041.8645576075062, 4203.91592168155, 4231.894202644959, 4320.373545835836, 4333.761643109596, 4376.081022985209, 11097.667069987914, 11376.0, 11496.482658280398, 11496.597619083292, 11503.942480287546, 11230.3261804292, 11234.15743819217, 11355.318680879174, 11360.48877800501, 11388.658340249805, 7965.4822436541435, 8253.215944485264, 8257.669693212325, 8319.708810191614, 8428.35647048832, 5917.556183286185, 6011.6994150293185, 6169.722362493609, 6172.135900973957, 6205.627662340274, 10525.315854469434, 10532.842007369742, 10754.462276885968, 10757.569697212024, 10776.67669969902, 9495.620175192915, 10674.199435042558, 10907.618233361794, 10911.127109831354, 11078.778424431628, 7371.778846634609, 7547.50941188821, 7558.395328373607, 7672.194419586086, 7700.730474433368, 8173.100958894398, 8203.466774659628, 8292.253697167283, 8471.534065626203, 8473.533955632252, 6408.391202835724, 7844.254795794391, 7864.0, 7935.32549733256, 8183.508989460652, 7270.9636451817405, 7286.599237042014, 7371.078615173104, 7485.214052524407, 7693.846123077619, 6925.757598484231, 6930.3762661360715, 6996.230414654486, 6998.300169982961, 7042.823929401806, 5061.139606267017, 5087.796488140433, 5143.228515722672, 5175.767090481013, 5204.98502791952, 5166.225066240094, 5202.961424598928, 5240.71176085319, 5264.440653180673, 5314.202869569595], "value": 4651.099710925081, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.24161180296664, 324.982125983071, 335.4649334311773, 336.7794094867861, 340.8091468777486, 5361.463853614637, 5421.593380496459, 5422.972885135574, 5456.236126942226, 5468.781248750055, 5109.565686916607, 5170.53465188133, 5356.143017117262, 5378.354597448302, 5381.165919282517, 4168.729032612886, 4195.160967806436, 4205.63316922, 4210.9893625529885, 4232.894177645568, 4192.8322867085435, 4204.621584057434, 4217.261979153636, 4243.766592837393, 4264.936025959613, 3975.7216994810374, 4033.8184781684895, 4058.289799285128, 4165.937510937339, 4211.263028969934, 4201.936970945439, 4202.873913782591, 4221.704480686353, 4224.45082139323, 4227.894302642443, 3742.120601658608, 3746.7002639788752, 3749.6876093367378, 3751.0809851586264, 3756.722714277159, 5062.594992400636, 5197.740112994373, 5214.270002199695, 5228.0, 5289.576833853321, 4813.422389313269, 4849.854504364875, 4858.489858564835, 4862.367892173995, 4878.073166098466, 5497.0, 5521.4478552144865, 5532.502074813246, 5552.444755524415, 5617.8033768817895, 3980.323345031323, 4030.887184012025, 4055.3308704063793, 4064.6138616831354, 4074.185162967389, 5706.489144776327, 5729.0, 5731.770729170828, 5743.827685169452, 5768.394318596529, 4194.706370554093, 4202.159568086395, 4204.810783514749, 4204.957950420518, 4207.116505533811, 4143.399207114951, 4197.307444271661, 4244.236037513278, 4250.171216612793, 4262.296721041055, 4802.375691160197, 4813.7593120344545, 4819.831305904277, 4819.903601927942, 4822.348982887335, 5599.0, 5599.832005039855, 5611.3266408031295, 5668.922904648103, 5682.943170568324, 1371.6570857285678, 1426.2227086238024, 1438.1946110178333, 1443.328852083765, 1471.8675319221106, 999.6850991937516, 1021.867157269565, 1030.8041472120274, 1032.4373216596973, 1033.6020632056711, 5374.408815030343, 5375.354957405137, 5375.650582712111, 5383.865403364869, 5387.515123638891, 5672.886542269214, 5677.233573467612, 5687.0427377763335, 5693.146028095736, 5713.200151978726, 5125.897482050413, 5354.866128346823, 5355.785768569292, 5362.302900622894, 5385.515303622615, 2955.9113226603235, 2998.250437390652, 2999.5500674898503, 3007.5639032340187, 3010.1270631517054, 5806.68063256525, 5837.387074357216, 5925.0, 5926.585139040226, 5931.436513531207, 5623.381428042912, 5701.94341650942, 5784.50831679312, 5793.710314484259, 5817.767289308465, 5817.0, 5868.530517558585, 5870.5010074144175, 5870.970645146747, 5883.411658834168, 5480.534154596904, 5637.351704554028, 5684.8578785529035, 5723.31320241557, 5771.394003629558, 5579.246801681721, 5598.21624972496, 5627.803026894203, 5658.971705141448, 5661.264035675501, 5816.331121921034, 5850.824475265749, 5861.476016235724, 5862.475756303306, 5887.733222709202, 4054.716169868199, 4124.731892427103, 4133.966508372907, 4166.999920019113, 4174.499060112806, 5566.832995010156, 5606.747696353592, 5642.548596112383, 5646.153077038477, 5648.915266270927, 5338.599605029561, 5464.426235245242, 5469.371022332482, 5474.479924407175, 5488.259085023471, 5136.948630513647, 5513.807016754395, 5515.972420137874, 5538.556915446835, 5570.108782594927, 5503.972480137573, 5525.392206857323, 5536.335639723259, 5540.307461567304, 5540.806071787468, 5446.564274857923, 5619.325680918316, 5638.21065050885, 5665.178549110274, 5682.687452190004, 5453.836384908459, 5456.399796022355, 5503.504684578407, 5544.584156188383, 5562.471565201299], "value": 4277.911859909428, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [779.7426849139785, 789.5262842294622, 800.3397197312219, 814.6415577146055, 822.4078663362377, 14031.649208769773, 15020.248987550605, 15024.8731345149, 15098.547043588696, 15176.924115379421, 14684.853151468482, 14721.631959201026, 14808.0, 14813.55559333219, 14889.851101488983, 662.092932682226, 801.9959900200491, 819.7909533069089, 833.4249367936135, 836.0761358698642, 803.5259197073725, 809.1018968944496, 809.9672917030804, 812.6180695073306, 816.9387295952797, 696.8745625787357, 864.7665130414815, 865.1219012702112, 865.9307255419583, 867.2714919467646, 706.8232941764559, 710.7405796884152, 823.6911158315602, 849.2059923971107, 854.5641722721394, 637.1494055435999, 637.3308026572128, 637.3403527349171, 637.5505268785495, 637.5951270942985, 15335.233238338038, 15376.308066136939, 15398.846011539854, 15424.151671658054, 15429.382824687, 13238.86761132386, 13410.86589134106, 13552.0, 13714.794278085838, 13742.175469471864, 12572.43424045911, 12671.36643167838, 12782.488700451971, 12938.288394138319, 12952.0, 4264.168487145008, 4359.716618419792, 4367.978160109179, 4368.912621747579, 4378.671599630009, 82408.58795706043, 83939.0, 84829.57585212096, 85425.57287213586, 85695.14304856934, 11608.419579021016, 11614.361210133355, 11654.70863228426, 11677.649670509898, 11819.763604727857, 21577.568448631253, 21605.02777375022, 21629.675554866688, 21671.241506547194, 21692.0, 8610.311175105977, 8840.160184782435, 8917.1974522292, 9012.954935225282, 9079.0, 4466.2630665940405, 4530.320451932171, 4667.159911216014, 4684.6486513510945, 4743.501932297128, 3410.36908171989, 3464.3937310970477, 3512.4906888501023, 3513.9648603514147, 3538.363094642989, 614.0420943328422, 624.8406656302705, 658.3613894522306, 674.0967104080555, 712.2948281201677, 780.4965797060864, 780.878963760618, 784.6312233250363, 805.90732065812, 821.3142026408016, 9590.760230994141, 9813.264005199639, 9921.454320012468, 10094.545745441474, 10493.9475302623, 718.3175982816241, 724.0595204850945, 730.2223132364015, 736.7384578474672, 798.5049269452976, 4807.95192048082, 5046.571041461443, 5100.336956195671, 5100.642954993189, 5129.153689641242, 125091.37454312852, 134308.0, 136501.0, 137302.0, 138161.0, 89873.55063224642, 94044.0, 94098.52950735202, 106233.84544622857, 107748.46125769478, 60356.39643603595, 60419.69790151109, 101369.49315253376, 102770.48614756878, 104080.47959760153, 10221.744456388353, 10816.621418250637, 10923.726906827393, 10942.416221345517, 11143.665690029313, 46690.533094668615, 49329.50670493249, 49508.75245623749, 50097.24854127264, 50302.24546631877, 57252.1412178826, 60347.39652603418, 77413.0, 81220.59389703014, 81680.18319816726, 12468.5012599495, 12572.434240459019, 12859.807102893277, 13682.973776966966, 13880.861191388361, 15188.696226075195, 15214.16322102295, 15573.0, 15919.204039797733, 16050.518484445485, 14734.410623574937, 14822.777658334919, 15051.6989660204, 15638.0, 15707.057576545443, 14478.322963377126, 14574.417023318949, 14605.561833145022, 14960.775588365965, 15054.698906021598, 14232.644183895485, 14599.635009124431, 14661.0, 14901.478448254258, 14936.985213853157, 11406.543738250377, 11941.820872686743, 12055.81916271239, 12062.577809776616, 12549.498020079094, 11895.226810257305, 12020.819687704867, 12285.1400401971, 12455.875441245471, 12590.937045314715], "value": 7814.62370389264, "unit": "score"}], "name": "dromaeo_css", "value": 7343.4023798844055, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 111.0, 112.0, 113.0, 111.0, 112.0, 110.0, 112.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 118.0, 123.0, 165.0, 118.0, 118.0, 158.0, 118.0, 153.0, 118.0], "value": 133.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 161.0, 162.0, 160.0, 163.0, 162.0, 161.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 129.0, 76.0, 75.0, 73.0, 73.0, 97.0, 77.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 109.0, 84.0, 84.0, 83.0, 110.0, 84.0, 85.0, 121.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 52.0, 52.0, 51.0, 52.0, 52.0, 52.0, 51.0, 52.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 65.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 80.0, 75.0, 84.0, 76.0, 79.0, 80.0, 80.0, 75.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 118.0, 125.0, 125.0, 126.0, 124.0, 121.0, 128.0, 158.0, 120.0], "value": 127.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 159.0, 159.0, 156.0, 159.0, 159.0, 156.0, 157.0, 156.0, 156.0], "value": 158.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 63.0, 63.0, 62.0, 63.0, 61.0, 64.0, 62.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1478.2999999999997, "alertThreshold": 2.0}]} 02:45:53 INFO - Return code: 0 02:45:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:45:53 INFO - # TBPL SUCCESS # 02:45:53 INFO - Running post-action listener: _resource_record_post_action 02:45:53 INFO - ##### 02:45:53 INFO - ##### Finished run-tests step (success) 02:45:53 INFO - ##### 02:45:53 INFO - Running post-run listener: _resource_record_post_run 02:45:53 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 560672768; Read time: 0; Write time: 618936 02:45:53 INFO - TinderboxPrint: CPU usage
13.0% 02:45:53 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:45:53 INFO - TinderboxPrint: I/O write bytes / time
560,672,768 / 618,936 02:45:53 INFO - TinderboxPrint: CPU idle
8,280.2 (87.0%) 02:45:53 INFO - TinderboxPrint: CPU user
1,189.4 (12.5%) 02:45:53 INFO - TinderboxPrint: Swap in / out
0 / 0 02:45:53 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 266809344; Read time: 0; Write time: 356216 02:45:53 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 293863424; Read time: 0; Write time: 262720 02:45:53 INFO - Running post-run listener: _upload_blobber_files 02:45:53 INFO - Blob upload gear active. 02:45:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:45:53 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 02:45:53 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'] 02:45:53 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 02:45:54 INFO - (blobuploader) - INFO - Open directory for files ... 02:45:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:45:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:45:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:45:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:45:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:45:57 INFO - (blobuploader) - INFO - Done attempting. 02:45:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:45:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:45:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:45:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:45:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:45:58 INFO - (blobuploader) - INFO - Done attempting. 02:45:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:45:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:45:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:45:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:45:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:45:59 INFO - (blobuploader) - INFO - Done attempting. 02:45:59 INFO - (blobuploader) - INFO - Iteration through files over. 02:45:59 INFO - Return code: 0 02:45:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:45:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:45:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bea067d5adb5d782b224c12e79678592a64147788804bc3a926eb2a4d711ee448c04a2b2dbd35d968ee6256467a71265f869422b1498b3b60e1f46bf9c686ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32aa805dd21e18ee389d5d45632f48b21c7ba3c3cba5fb7e10a99db18a47e6c450ec477cdbdff3cc52119196f2ac0e8231370e047f51a083b6e318f8936688c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eb611029ec5a8724fc1a7a0ee849ae270c1087bcce5f2ec266ab6ff0c6ad558acc263a1880307cacc1629d14aacff829fe4c857bcc3bb601dbf23435ac29ed02"} 02:45:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:45:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:45:59 INFO - Contents: 02:45:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bea067d5adb5d782b224c12e79678592a64147788804bc3a926eb2a4d711ee448c04a2b2dbd35d968ee6256467a71265f869422b1498b3b60e1f46bf9c686ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32aa805dd21e18ee389d5d45632f48b21c7ba3c3cba5fb7e10a99db18a47e6c450ec477cdbdff3cc52119196f2ac0e8231370e047f51a083b6e318f8936688c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eb611029ec5a8724fc1a7a0ee849ae270c1087bcce5f2ec266ab6ff0c6ad558acc263a1880307cacc1629d14aacff829fe4c857bcc3bb601dbf23435ac29ed02"} 02:45:59 INFO - Running post-run listener: copy_logs_to_upload_dir 02:45:59 INFO - Copying logs to upload dir... 02:45:59 INFO - mkdir: /builds/slave/test/build/upload/logs 02:45:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.312318 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-09 02:45:58.852965) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 02:45:58.860925) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1468055835.498396-1611438415 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/1bea067d5adb5d782b224c12e79678592a64147788804bc3a926eb2a4d711ee448c04a2b2dbd35d968ee6256467a71265f869422b1498b3b60e1f46bf9c686ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32aa805dd21e18ee389d5d45632f48b21c7ba3c3cba5fb7e10a99db18a47e6c450ec477cdbdff3cc52119196f2ac0e8231370e047f51a083b6e318f8936688c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eb611029ec5a8724fc1a7a0ee849ae270c1087bcce5f2ec266ab6ff0c6ad558acc263a1880307cacc1629d14aacff829fe4c857bcc3bb601dbf23435ac29ed02"} build_url:https://queue.taskcluster.net/v1/task/OAziZyZ2S6qZn0XJgBrOqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/OAziZyZ2S6qZn0XJgBrOqw/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/1bea067d5adb5d782b224c12e79678592a64147788804bc3a926eb2a4d711ee448c04a2b2dbd35d968ee6256467a71265f869422b1498b3b60e1f46bf9c686ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32aa805dd21e18ee389d5d45632f48b21c7ba3c3cba5fb7e10a99db18a47e6c450ec477cdbdff3cc52119196f2ac0e8231370e047f51a083b6e318f8936688c9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eb611029ec5a8724fc1a7a0ee849ae270c1087bcce5f2ec266ab6ff0c6ad558acc263a1880307cacc1629d14aacff829fe4c857bcc3bb601dbf23435ac29ed02"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 02:45:58.889006) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 02:45:58.889403) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1468055835.498396-1611438415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 02:45:58.968307) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 02:45:58.969895) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 02:45:58.970239) ========= ========= Total master_lag: 0.24 =========