builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-052 starttime: 1492509426.26 results: success (0) revision: 4b43e1c02d4ff32f7d45a6c614720660f52927d9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 02:57:06.260189) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 02:57:06.260610) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 02:57:06.260878) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 02:57:06.275518) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 02:57:06.275786) ========= 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=826874ccc97bd7bf541b4875000001d5-1492509426.52743-702675126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-18 02:57:06-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 85.6M=0s 2017-04-18 02:57:06 (85.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.154433 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 02:57:06.444909) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 02:57:06.445239) ========= 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=826874ccc97bd7bf541b4875000001d5-1492509426.52743-702675126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022062 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 02:57:06.495249) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-18 02:57:06.495619) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4b43e1c02d4ff32f7d45a6c614720660f52927d9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4b43e1c02d4ff32f7d45a6c614720660f52927d9 --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=826874ccc97bd7bf541b4875000001d5-1492509426.52743-702675126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-18 02:57:06,954 truncating revision to first 12 chars 2017-04-18 02:57:06,954 Setting DEBUG logging. 2017-04-18 02:57:06,954 attempt 1/10 2017-04-18 02:57:06,954 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4b43e1c02d4f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-18 02:57:08,257 unpacking tar archive at: mozilla-aurora-4b43e1c02d4f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.858262 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-18 02:57:08.366326) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 02:57:08.366640) ========= script_repo_revision: 4b43e1c02d4ff32f7d45a6c614720660f52927d9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 02:57:08.367008) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 02:57:08.367272) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 02:57:08.376599) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-04-18 02:57:08.377449) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1492509426.52743-702675126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:57:08 INFO - MultiFileLogger online at 20170418 02:57:08 in /builds/slave/test 02:57:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:57:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:57:08 INFO - {'append_to_log': False, 02:57:08 INFO - 'base_work_dir': '/builds/slave/test', 02:57:08 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:57:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:57:08 INFO - 'branch': 'Mozilla-Aurora', 02:57:08 INFO - 'buildbot_json_path': 'buildprops.json', 02:57:08 INFO - 'config_files': ('talos/linux_config.py',), 02:57:08 INFO - 'default_actions': ('clobber', 02:57:08 INFO - 'read-buildbot-config', 02:57:08 INFO - 'download-and-extract', 02:57:08 INFO - 'populate-webroot', 02:57:08 INFO - 'create-virtualenv', 02:57:08 INFO - 'install', 02:57:08 INFO - 'run-tests'), 02:57:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:57:08 INFO - 'download_minidump_stackwalk': True, 02:57:08 INFO - 'download_symbols': 'ondemand', 02:57:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:57:08 INFO - 'tooltool.py': '/tools/tooltool.py', 02:57:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:57:08 INFO - '/tools/misc-python/virtualenv.py')}, 02:57:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:57:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:57:08 INFO - 'gecko_profile': False, 02:57:08 INFO - 'gecko_profile_interval': 0, 02:57:08 INFO - 'installer_path': 'installer.exe', 02:57:08 INFO - 'log_level': 'info', 02:57:08 INFO - 'log_name': 'talos', 02:57:08 INFO - 'log_to_console': True, 02:57:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:57:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:57:08 INFO - 'opt_config_files': (), 02:57:08 INFO - 'pip_index': False, 02:57:08 INFO - 'suite': 'dromaeojs', 02:57:08 INFO - 'system_bits': '32', 02:57:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:57:08 INFO - 'title': 'talos-linux64-ix-052', 02:57:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:57:08 INFO - 'use_talos_json': True, 02:57:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:57:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:57:08 INFO - 'work_dir': 'build'} 02:57:08 INFO - [mozharness: 2017-04-18 09:57:08.938736Z] Running clobber step. 02:57:08 INFO - Running pre-action listener: _resource_record_pre_action 02:57:08 INFO - Running main action method: clobber 02:57:08 INFO - rmtree: /builds/slave/test/build 02:57:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:57:10 INFO - Running post-action listener: _resource_record_post_action 02:57:10 INFO - [mozharness: 2017-04-18 09:57:10.391122Z] Finished clobber step (success) 02:57:10 INFO - [mozharness: 2017-04-18 09:57:10.391220Z] Running read-buildbot-config step. 02:57:10 INFO - Running pre-action listener: _resource_record_pre_action 02:57:10 INFO - Running main action method: read_buildbot_config 02:57:10 INFO - Using buildbot properties: 02:57:10 INFO - { 02:57:10 INFO - "project": "", 02:57:10 INFO - "product": "firefox", 02:57:10 INFO - "who": "cbook@mozilla.com", 02:57:10 INFO - "installer_path": "public/build/target.tar.bz2", 02:57:10 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:57:10 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 02:57:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:57:10 INFO - "stage_platform": "linux64-pgo", 02:57:10 INFO - "basedir": "/builds/slave/test", 02:57:10 INFO - "buildnumber": 889, 02:57:10 INFO - "platform": "ubuntu64_hw", 02:57:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:57:10 INFO - "slavebuilddir": "test", 02:57:10 INFO - "taskId": "RgBXvvOLS5OdKATgsiDILg", 02:57:10 INFO - "branch": "mozilla-aurora", 02:57:10 INFO - "script_repo_revision": "production", 02:57:10 INFO - "revision": "4b43e1c02d4ff32f7d45a6c614720660f52927d9", 02:57:10 INFO - "slavename": "talos-linux64-ix-052", 02:57:10 INFO - "repo_path": "releases/mozilla-aurora" 02:57:10 INFO - } 02:57:10 INFO - Finding installer, test and symbols from parent task. 02:57:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RgBXvvOLS5OdKATgsiDILg'}, attempt #1 02:57:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RgBXvvOLS5OdKATgsiDILg'}, attempt #1 02:57:11 INFO - Task dependencies: OhNSSLPQRjmBcrb0lKJjAg 02:57:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OhNSSLPQRjmBcrb0lKJjAg'}, attempt #1 02:57:11 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OhNSSLPQRjmBcrb0lKJjAg/artifacts/public/build/target.tar.bz2 02:57:11 INFO - Set test_url: https://queue.taskcluster.net/v1/task/OhNSSLPQRjmBcrb0lKJjAg/artifacts/public/build/test_packages.json 02:57:11 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OhNSSLPQRjmBcrb0lKJjAg/artifacts/public/build/target.crashreporter-symbols.zip 02:57:11 INFO - Running post-action listener: _resource_record_post_action 02:57:11 INFO - [mozharness: 2017-04-18 09:57:11.835014Z] Finished read-buildbot-config step (success) 02:57:11 INFO - [mozharness: 2017-04-18 09:57:11.835232Z] Running download-and-extract step. 02:57:11 INFO - Running pre-action listener: _resource_record_pre_action 02:57:11 INFO - Running main action method: download_and_extract 02:57:11 INFO - mkdir: /builds/slave/test/build/tests 02:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:11 INFO - trying https://queue.taskcluster.net/v1/task/OhNSSLPQRjmBcrb0lKJjAg/artifacts/public/build/target.test_packages.json 02:57:11 INFO - Downloading https://queue.taskcluster.net/v1/task/OhNSSLPQRjmBcrb0lKJjAg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:57:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OhNSSLPQRjmBcrb0lKJjAg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:57:12 INFO - Downloaded 896 bytes. 02:57:12 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:57:12 INFO - Using the following test package requirements: 02:57:12 INFO - {u'common': [u'target.common.tests.zip'], 02:57:12 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:57:12 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:57:12 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:57:12 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:57:12 INFO - u'mozbase': [u'target.common.tests.zip'], 02:57:12 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:57:12 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:57:12 INFO - u'web-platform': [u'target.common.tests.zip', 02:57:12 INFO - u'target.web-platform.tests.zip'], 02:57:12 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:57:12 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:57:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OhNSSLPQRjmBcrb0lKJjAg/artifacts/public/build/target.common.tests.zip 02:57:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OhNSSLPQRjmBcrb0lKJjAg/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:57:12 INFO - Fetch https://queue.taskcluster.net/v1/task/OhNSSLPQRjmBcrb0lKJjAg/artifacts/public/build/target.common.tests.zip into memory 02:57:13 INFO - Expected file size: 59549705 02:57:13 INFO - Obtained file size: 59549705 02:57:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:57:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OhNSSLPQRjmBcrb0lKJjAg/artifacts/public/build/target.common.tests.zip 02:57:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OhNSSLPQRjmBcrb0lKJjAg/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:57:23 INFO - Fetch https://queue.taskcluster.net/v1/task/OhNSSLPQRjmBcrb0lKJjAg/artifacts/public/build/target.common.tests.zip into memory 02:57:24 INFO - Expected file size: 59549705 02:57:24 INFO - Obtained file size: 59549705 02:57:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OhNSSLPQRjmBcrb0lKJjAg/artifacts/public/build/target.talos.tests.zip 02:57:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OhNSSLPQRjmBcrb0lKJjAg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:57:35 INFO - Fetch https://queue.taskcluster.net/v1/task/OhNSSLPQRjmBcrb0lKJjAg/artifacts/public/build/target.talos.tests.zip into memory 02:57:35 INFO - Expected file size: 14404424 02:57:35 INFO - Obtained file size: 14404424 02:57: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:36 INFO - trying https://queue.taskcluster.net/v1/task/OhNSSLPQRjmBcrb0lKJjAg/artifacts/public/build/target.tar.bz2 02:57:36 INFO - Downloading https://queue.taskcluster.net/v1/task/OhNSSLPQRjmBcrb0lKJjAg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:57:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OhNSSLPQRjmBcrb0lKJjAg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:57:37 INFO - Downloaded 66798708 bytes. 02:57:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OhNSSLPQRjmBcrb0lKJjAg/artifacts/public/build/target.tar.bz2 02:57:37 INFO - mkdir: /builds/slave/test/properties 02:57:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:57:37 INFO - Writing to file /builds/slave/test/properties/build_url 02:57:37 INFO - Contents: 02:57:37 INFO - build_url:https://queue.taskcluster.net/v1/task/OhNSSLPQRjmBcrb0lKJjAg/artifacts/public/build/target.tar.bz2 02:57:37 INFO - Running post-action listener: _resource_record_post_action 02:57:37 INFO - Running post-action listener: set_extra_try_arguments 02:57:37 INFO - [mozharness: 2017-04-18 09:57:37.206373Z] Finished download-and-extract step (success) 02:57:37 INFO - [mozharness: 2017-04-18 09:57:37.206470Z] Running populate-webroot step. 02:57:37 INFO - Running pre-action listener: _resource_record_pre_action 02:57:37 INFO - Running main action method: populate_webroot 02:57:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:57:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:57:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:57:37 INFO - '--tppagecycles', 02:57:37 INFO - '7'], 02:57:37 INFO - 'tests': ['tsvgm']}}, 02:57:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:57:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:57:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:57:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:57:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:57:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:57:37 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:57:37 INFO - 'talos_options': ['--disable-e10s'], 02:57:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:57:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:57:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:57:37 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:57:37 INFO - 'talos_options': ['--disable-e10s'], 02:57:37 INFO - 'tests': ['damp', 'tps']}, 02:57:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:57:37 INFO - 'tests': ['damp', 'tps']}, 02:57:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:57:37 INFO - 'tests': ['dromaeo_dom']}, 02:57:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:57:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:57:37 INFO - 'tests': ['basic_compositor_video']}, 02:57:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:57:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:57:37 INFO - 'tests': ['a11yr', 02:57:37 INFO - 'ts_paint', 02:57:37 INFO - 'tpaint', 02:57:37 INFO - 'sessionrestore', 02:57:37 INFO - 'sessionrestore_no_auto_restore', 02:57:37 INFO - 'tabpaint']}, 02:57:37 INFO - 'other-e10s': {'tests': ['a11yr', 02:57:37 INFO - 'ts_paint', 02:57:37 INFO - 'tpaint', 02:57:37 INFO - 'sessionrestore', 02:57:37 INFO - 'sessionrestore_no_auto_restore', 02:57:37 INFO - 'tabpaint']}, 02:57:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:57:37 INFO - 'ts_paint', 02:57:37 INFO - 'tpaint', 02:57:37 INFO - 'sessionrestore', 02:57:37 INFO - 'sessionrestore_no_auto_restore', 02:57:37 INFO - 'tabpaint']}, 02:57:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:57:37 INFO - 'ts_paint', 02:57:37 INFO - 'tpaint', 02:57:37 INFO - 'sessionrestore', 02:57:37 INFO - 'sessionrestore_no_auto_restore', 02:57:37 INFO - 'tabpaint']}, 02:57:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:57:37 INFO - 'tests': ['a11yr', 02:57:37 INFO - 'ts_paint', 02:57:37 INFO - 'tpaint', 02:57:37 INFO - 'sessionrestore', 02:57:37 INFO - 'sessionrestore_no_auto_restore', 02:57:37 INFO - 'tabpaint']}, 02:57:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:57:37 INFO - 'tests': ['a11yr', 02:57:37 INFO - 'ts_paint', 02:57:37 INFO - 'tpaint', 02:57:37 INFO - 'sessionrestore', 02:57:37 INFO - 'sessionrestore_no_auto_restore', 02:57:37 INFO - 'tabpaint']}, 02:57:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:57:37 INFO - 'tests': ['tsvgx', 02:57:37 INFO - 'tsvgr_opacity', 02:57:37 INFO - 'tart', 02:57:37 INFO - 'tscrollx', 02:57:37 INFO - 'cart', 02:57:37 INFO - 'tsvg_static']}, 02:57:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:57:37 INFO - 'tsvgr_opacity', 02:57:37 INFO - 'tart', 02:57:37 INFO - 'tscrollx', 02:57:37 INFO - 'cart', 02:57:37 INFO - 'tsvg_static']}, 02:57:37 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:57:37 INFO - 'talos_options': ['--disable-e10s'], 02:57:37 INFO - 'tests': ['tp5o']}, 02:57:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:57:37 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:57:37 INFO - 'talos_options': ['--disable-e10s', 02:57:37 INFO - '--xperf_path', 02:57:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:57:37 INFO - 'tests': ['tp5n']}, 02:57:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:57:37 INFO - 'talos_options': ['--xperf_path', 02:57:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:57:37 INFO - 'tests': ['tp5n']}}, 02:57:37 INFO - 'talos.zip': {'path': '', 02:57:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:57:37 INFO - Running post-action listener: _resource_record_post_action 02:57:37 INFO - [mozharness: 2017-04-18 09:57:37.219579Z] Finished populate-webroot step (success) 02:57:37 INFO - [mozharness: 2017-04-18 09:57:37.219669Z] Running create-virtualenv step. 02:57:37 INFO - Running pre-action listener: _resource_record_pre_action 02:57:37 INFO - Running main action method: create_virtualenv 02:57:37 INFO - Creating virtualenv /builds/slave/test/build/venv 02:57:37 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:57:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:57:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:57:37 INFO - Using real prefix '/usr' 02:57:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:57:37 INFO - Installing distribute.............................................................................................................................................................................................done. 02:57:39 INFO - Installing pip.................done. 02:57:39 INFO - Return code: 0 02:57:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:57:39 INFO - Reading from file tmpfile_stdout 02:57:39 INFO - Output received: 02:57:39 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:57:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2290>, '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 0x1ff2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3040>, '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': '826874ccc97bd7bf541b4875000001d5-1492509426.52743-702675126', '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:57:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:57:39 INFO - Using env: {'DISPLAY': ':0', 02:57:39 INFO - 'HOME': '/home/cltbld', 02:57:39 INFO - 'LANG': 'en_US.UTF-8', 02:57:39 INFO - 'LANGUAGE': 'en_US:en', 02:57:39 INFO - 'LOGNAME': 'cltbld', 02:57:39 INFO - 'MAIL': '/var/mail/cltbld', 02:57:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:39 INFO - 'MOZ_NO_REMOTE': '1', 02:57:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:39 INFO - 'NO_EM_RESTART': '1', 02:57:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:39 INFO - 'PWD': '/builds/slave/test', 02:57:39 INFO - 'SHELL': '/bin/bash', 02:57:39 INFO - 'SHLVL': '1', 02:57:39 INFO - 'TERM': 'linux', 02:57:39 INFO - 'TMOUT': '86400', 02:57:39 INFO - 'USER': 'cltbld', 02:57:39 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1492509426.52743-702675126', 02:57:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:39 INFO - '_': '/tools/buildbot/bin/python'} 02:57:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:40 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:57:40 INFO - Cleaning up... 02:57:40 INFO - Return code: 0 02:57:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:40 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 0x1d571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2290>, '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 0x1ff2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3040>, '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': '826874ccc97bd7bf541b4875000001d5-1492509426.52743-702675126', '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:57:40 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:57:40 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:57:40 INFO - Using env: {'DISPLAY': ':0', 02:57:40 INFO - 'HOME': '/home/cltbld', 02:57:40 INFO - 'LANG': 'en_US.UTF-8', 02:57:40 INFO - 'LANGUAGE': 'en_US:en', 02:57:40 INFO - 'LOGNAME': 'cltbld', 02:57:40 INFO - 'MAIL': '/var/mail/cltbld', 02:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:40 INFO - 'MOZ_NO_REMOTE': '1', 02:57:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:40 INFO - 'NO_EM_RESTART': '1', 02:57:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:40 INFO - 'PWD': '/builds/slave/test', 02:57:40 INFO - 'SHELL': '/bin/bash', 02:57:40 INFO - 'SHLVL': '1', 02:57:40 INFO - 'TERM': 'linux', 02:57:40 INFO - 'TMOUT': '86400', 02:57:40 INFO - 'USER': 'cltbld', 02:57:40 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1492509426.52743-702675126', 02:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:40 INFO - '_': '/tools/buildbot/bin/python'} 02:57:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:40 INFO - Downloading/unpacking psutil>=3.1.1 02:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:57:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:57:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:57:42 INFO - Installing collected packages: psutil 02:57:42 INFO - Running setup.py install for psutil 02:57:42 INFO - building 'psutil._psutil_linux' extension 02:57:42 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:57:42 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:57:42 INFO - building 'psutil._psutil_posix' extension 02:57:42 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:57:42 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:57:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:57:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:57:43 INFO - Successfully installed psutil 02:57:43 INFO - Cleaning up... 02:57:43 INFO - Return code: 0 02:57:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:57:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:43 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 0x1d571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2290>, '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 0x1ff2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3040>, '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': '826874ccc97bd7bf541b4875000001d5-1492509426.52743-702675126', '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:57:43 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:57:43 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:57:43 INFO - Using env: {'DISPLAY': ':0', 02:57:43 INFO - 'HOME': '/home/cltbld', 02:57:43 INFO - 'LANG': 'en_US.UTF-8', 02:57:43 INFO - 'LANGUAGE': 'en_US:en', 02:57:43 INFO - 'LOGNAME': 'cltbld', 02:57:43 INFO - 'MAIL': '/var/mail/cltbld', 02:57:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:43 INFO - 'MOZ_NO_REMOTE': '1', 02:57:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:43 INFO - 'NO_EM_RESTART': '1', 02:57:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:43 INFO - 'PWD': '/builds/slave/test', 02:57:43 INFO - 'SHELL': '/bin/bash', 02:57:43 INFO - 'SHLVL': '1', 02:57:43 INFO - 'TERM': 'linux', 02:57:43 INFO - 'TMOUT': '86400', 02:57:43 INFO - 'USER': 'cltbld', 02:57:43 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1492509426.52743-702675126', 02:57:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:43 INFO - '_': '/tools/buildbot/bin/python'} 02:57:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:57:43 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:57:43 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:57:43 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:57:43 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:57:43 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:57:43 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:57:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:57:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:57:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:57:45 INFO - Installing collected packages: mozsystemmonitor 02:57:45 INFO - Running setup.py install for mozsystemmonitor 02:57:45 INFO - Successfully installed mozsystemmonitor 02:57:45 INFO - Cleaning up... 02:57:45 INFO - Return code: 0 02:57:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:45 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 0x1d571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2290>, '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 0x1ff2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3040>, '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': '826874ccc97bd7bf541b4875000001d5-1492509426.52743-702675126', '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:57:45 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:57:45 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:57:45 INFO - Using env: {'DISPLAY': ':0', 02:57:45 INFO - 'HOME': '/home/cltbld', 02:57:45 INFO - 'LANG': 'en_US.UTF-8', 02:57:45 INFO - 'LANGUAGE': 'en_US:en', 02:57:45 INFO - 'LOGNAME': 'cltbld', 02:57:45 INFO - 'MAIL': '/var/mail/cltbld', 02:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:45 INFO - 'MOZ_NO_REMOTE': '1', 02:57:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:45 INFO - 'NO_EM_RESTART': '1', 02:57:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:45 INFO - 'PWD': '/builds/slave/test', 02:57:45 INFO - 'SHELL': '/bin/bash', 02:57:45 INFO - 'SHLVL': '1', 02:57:45 INFO - 'TERM': 'linux', 02:57:45 INFO - 'TMOUT': '86400', 02:57:45 INFO - 'USER': 'cltbld', 02:57:45 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1492509426.52743-702675126', 02:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:45 INFO - '_': '/tools/buildbot/bin/python'} 02:57:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:45 INFO - Downloading/unpacking jsonschema==2.5.1 02:57:45 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:57:45 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:57:45 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:57:45 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:57:45 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:57:45 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:57:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:57:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:57:47 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:57:47 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:57:47 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:57:47 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:57:47 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:57:47 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:57:47 INFO - Downloading functools32-3.2.3-2.tar.gz 02:57:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:57:48 INFO - warning: no files found matching '*.txt' 02:57:48 INFO - no previously-included directories found matching 'build' 02:57:48 INFO - no previously-included directories found matching 'dist' 02:57:48 INFO - no previously-included directories found matching '.git*' 02:57:48 INFO - Installing collected packages: jsonschema, functools32 02:57:48 INFO - Running setup.py install for functools32 02:57:48 INFO - warning: no files found matching '*.txt' 02:57:48 INFO - no previously-included directories found matching 'build' 02:57:48 INFO - no previously-included directories found matching 'dist' 02:57:48 INFO - no previously-included directories found matching '.git*' 02:57:48 INFO - Successfully installed jsonschema functools32 02:57:48 INFO - Cleaning up... 02:57:48 INFO - Return code: 0 02:57:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:48 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2290>, '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 0x1ff2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3040>, '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': '826874ccc97bd7bf541b4875000001d5-1492509426.52743-702675126', '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:57:48 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:57:48 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 functools32==3.2.3-2 02:57:48 INFO - Using env: {'DISPLAY': ':0', 02:57:48 INFO - 'HOME': '/home/cltbld', 02:57:48 INFO - 'LANG': 'en_US.UTF-8', 02:57:48 INFO - 'LANGUAGE': 'en_US:en', 02:57:48 INFO - 'LOGNAME': 'cltbld', 02:57:48 INFO - 'MAIL': '/var/mail/cltbld', 02:57:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:48 INFO - 'MOZ_NO_REMOTE': '1', 02:57:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:48 INFO - 'NO_EM_RESTART': '1', 02:57:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:48 INFO - 'PWD': '/builds/slave/test', 02:57:48 INFO - 'SHELL': '/bin/bash', 02:57:48 INFO - 'SHLVL': '1', 02:57:48 INFO - 'TERM': 'linux', 02:57:48 INFO - 'TMOUT': '86400', 02:57:48 INFO - 'USER': 'cltbld', 02:57:48 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1492509426.52743-702675126', 02:57:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:48 INFO - '_': '/tools/buildbot/bin/python'} 02:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:57:48 INFO - Cleaning up... 02:57:48 INFO - Return code: 0 02:57:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:48 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 0x1d571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2290>, '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 0x1ff2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3040>, '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': '826874ccc97bd7bf541b4875000001d5-1492509426.52743-702675126', '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:57:48 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:57:48 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:57:48 INFO - Using env: {'DISPLAY': ':0', 02:57:48 INFO - 'HOME': '/home/cltbld', 02:57:48 INFO - 'LANG': 'en_US.UTF-8', 02:57:48 INFO - 'LANGUAGE': 'en_US:en', 02:57:48 INFO - 'LOGNAME': 'cltbld', 02:57:48 INFO - 'MAIL': '/var/mail/cltbld', 02:57:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:48 INFO - 'MOZ_NO_REMOTE': '1', 02:57:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:48 INFO - 'NO_EM_RESTART': '1', 02:57:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:48 INFO - 'PWD': '/builds/slave/test', 02:57:48 INFO - 'SHELL': '/bin/bash', 02:57:48 INFO - 'SHLVL': '1', 02:57:48 INFO - 'TERM': 'linux', 02:57:48 INFO - 'TMOUT': '86400', 02:57:48 INFO - 'USER': 'cltbld', 02:57:48 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1492509426.52743-702675126', 02:57:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:48 INFO - '_': '/tools/buildbot/bin/python'} 02:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:48 INFO - Downloading/unpacking blobuploader==1.2.4 02:57: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:57: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:57: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:57: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:57: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:57: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:57:50 INFO - Downloading blobuploader-1.2.4.tar.gz 02:57:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:57:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:57:50 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:57:50 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:57:50 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:57:50 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:57:50 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:57:50 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:57:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:57:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:57: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:57: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:57: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:57: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:57: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:57: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:57:51 INFO - Downloading docopt-0.6.1.tar.gz 02:57:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:57:51 INFO - Installing collected packages: blobuploader, requests, docopt 02:57:51 INFO - Running setup.py install for blobuploader 02:57:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:57:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:57:51 INFO - Running setup.py install for requests 02:57:51 INFO - Running setup.py install for docopt 02:57:52 INFO - Successfully installed blobuploader requests docopt 02:57:52 INFO - Cleaning up... 02:57:52 INFO - Return code: 0 02:57:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:57: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57: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 0x1d571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2290>, '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 0x1ff2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3040>, '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': '826874ccc97bd7bf541b4875000001d5-1492509426.52743-702675126', '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:57: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:57: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:57:52 INFO - Using env: {'DISPLAY': ':0', 02:57:52 INFO - 'HOME': '/home/cltbld', 02:57:52 INFO - 'LANG': 'en_US.UTF-8', 02:57:52 INFO - 'LANGUAGE': 'en_US:en', 02:57:52 INFO - 'LOGNAME': 'cltbld', 02:57:52 INFO - 'MAIL': '/var/mail/cltbld', 02:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:52 INFO - 'MOZ_NO_REMOTE': '1', 02:57:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:52 INFO - 'NO_EM_RESTART': '1', 02:57:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:52 INFO - 'PWD': '/builds/slave/test', 02:57:52 INFO - 'SHELL': '/bin/bash', 02:57:52 INFO - 'SHLVL': '1', 02:57:52 INFO - 'TERM': 'linux', 02:57:52 INFO - 'TMOUT': '86400', 02:57:52 INFO - 'USER': 'cltbld', 02:57:52 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1492509426.52743-702675126', 02:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:52 INFO - '_': '/tools/buildbot/bin/python'} 02:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:57:52 INFO - Running setup.py (path:/tmp/pip-6nPIh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:57:52 INFO - Running setup.py (path:/tmp/pip-QHyZE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:57:52 INFO - Running setup.py (path:/tmp/pip-hEphof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:57:52 INFO - Running setup.py (path:/tmp/pip-BAv2s4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:57:52 INFO - Running setup.py (path:/tmp/pip-DP5rBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:57:52 INFO - Running setup.py (path:/tmp/pip-ISZG4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:57:52 INFO - Running setup.py (path:/tmp/pip-BY4oO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:57:52 INFO - Running setup.py (path:/tmp/pip-6VbZde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:57:52 INFO - Running setup.py (path:/tmp/pip-IrcdG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:57:52 INFO - Running setup.py (path:/tmp/pip-qZtJbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:57:53 INFO - Running setup.py (path:/tmp/pip-Wx8_J0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:57:53 INFO - Running setup.py (path:/tmp/pip-h_JVO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:57:53 INFO - Running setup.py (path:/tmp/pip-emZvik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:57:53 INFO - Running setup.py (path:/tmp/pip-zWZlcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:53 INFO - Running setup.py (path:/tmp/pip-iE_GaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:57:53 INFO - Running setup.py (path:/tmp/pip-29ZUxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:57:53 INFO - Running setup.py (path:/tmp/pip-V_r1ZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:57:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:57:53 INFO - Running setup.py install for manifestparser 02:57:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:57:53 INFO - Running setup.py install for mozcrash 02:57:53 INFO - Running setup.py install for mozdebug 02:57:53 INFO - Running setup.py install for mozdevice 02:57:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:57:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:57:53 INFO - Running setup.py install for mozfile 02:57:54 INFO - Running setup.py install for mozhttpd 02:57:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:57:54 INFO - Running setup.py install for mozinfo 02:57:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:57:54 INFO - Running setup.py install for mozInstall 02:57:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:57:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:57:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:57:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:57:54 INFO - Running setup.py install for mozleak 02:57:54 INFO - Running setup.py install for mozlog 02:57:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:57:54 INFO - Running setup.py install for moznetwork 02:57:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:57:54 INFO - Running setup.py install for mozprocess 02:57:54 INFO - Running setup.py install for mozprofile 02:57:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:57:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:57:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:57:54 INFO - Running setup.py install for mozrunner 02:57:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:57:55 INFO - Running setup.py install for mozscreenshot 02:57:55 INFO - Running setup.py install for moztest 02:57:55 INFO - Running setup.py install for mozversion 02:57:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:57:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:57:55 INFO - Cleaning up... 02:57:55 INFO - Return code: 0 02:57:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:57: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57: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 0x1d571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2290>, '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 0x1ff2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3040>, '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': '826874ccc97bd7bf541b4875000001d5-1492509426.52743-702675126', '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:57: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:57: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:57:55 INFO - Using env: {'DISPLAY': ':0', 02:57:55 INFO - 'HOME': '/home/cltbld', 02:57:55 INFO - 'LANG': 'en_US.UTF-8', 02:57:55 INFO - 'LANGUAGE': 'en_US:en', 02:57:55 INFO - 'LOGNAME': 'cltbld', 02:57:55 INFO - 'MAIL': '/var/mail/cltbld', 02:57:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:55 INFO - 'MOZ_NO_REMOTE': '1', 02:57:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:55 INFO - 'NO_EM_RESTART': '1', 02:57:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:55 INFO - 'PWD': '/builds/slave/test', 02:57:55 INFO - 'SHELL': '/bin/bash', 02:57:55 INFO - 'SHLVL': '1', 02:57:55 INFO - 'TERM': 'linux', 02:57:55 INFO - 'TMOUT': '86400', 02:57:55 INFO - 'USER': 'cltbld', 02:57:55 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1492509426.52743-702675126', 02:57:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:55 INFO - '_': '/tools/buildbot/bin/python'} 02:57:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:57:55 INFO - Running setup.py (path:/tmp/pip-T_rEHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:57:55 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:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:57:55 INFO - Running setup.py (path:/tmp/pip-N3Ynts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:57:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:57:55 INFO - Running setup.py (path:/tmp/pip-dEvzlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:57:55 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:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:57:55 INFO - Running setup.py (path:/tmp/pip-ixBfCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:57:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:57:55 INFO - Running setup.py (path:/tmp/pip-tkoXl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:57:55 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:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:57:55 INFO - Running setup.py (path:/tmp/pip-Tv3NVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:57:55 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:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:57:55 INFO - Running setup.py (path:/tmp/pip-yYHT98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:57: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:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:57:56 INFO - Running setup.py (path:/tmp/pip-IPL3wp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:57: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:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:57:56 INFO - Running setup.py (path:/tmp/pip-ILsnYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:57: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:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:57:56 INFO - Running setup.py (path:/tmp/pip-lP_lbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:57:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:57:56 INFO - Running setup.py (path:/tmp/pip-Vi1rHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:57: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:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:57:56 INFO - Running setup.py (path:/tmp/pip-EjkHvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:57:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:57:56 INFO - Running setup.py (path:/tmp/pip-DFMH0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:57:56 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:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:57:56 INFO - Running setup.py (path:/tmp/pip-LmqleZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:57:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:56 INFO - Running setup.py (path:/tmp/pip-2LLnne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:56 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:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:57:56 INFO - Running setup.py (path:/tmp/pip-TsjxFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:57:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:57:56 INFO - Running setup.py (path:/tmp/pip-yAJJWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:57:56 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:57:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:57:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:57:56 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:57:56 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:57:56 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:57:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:57:56 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:57:56 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:57:56 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:57:56 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:57:56 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:57:56 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:57:58 INFO - Downloading blessings-1.6.tar.gz 02:57:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:57:58 INFO - Installing collected packages: blessings 02:57:58 INFO - Running setup.py install for blessings 02:57:58 INFO - Successfully installed blessings 02:57:58 INFO - Cleaning up... 02:57:59 INFO - Return code: 0 02:57:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:57:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:57:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:57:59 INFO - Reading from file tmpfile_stdout 02:57:59 INFO - Current package versions: 02:57:59 INFO - argparse == 1.2.1 02:57:59 INFO - blessings == 1.6 02:57:59 INFO - blobuploader == 1.2.4 02:57:59 INFO - docopt == 0.6.1 02:57:59 INFO - functools32 == 3.2.3-2 02:57:59 INFO - jsonschema == 2.5.1 02:57:59 INFO - manifestparser == 1.1 02:57:59 INFO - mozInstall == 1.12 02:57:59 INFO - mozcrash == 1.0 02:57:59 INFO - mozdebug == 0.1 02:57:59 INFO - mozdevice == 0.49 02:57:59 INFO - mozfile == 1.2 02:57:59 INFO - mozhttpd == 0.7 02:57:59 INFO - mozinfo == 0.9 02:57:59 INFO - mozleak == 0.1 02:57:59 INFO - mozlog == 3.4 02:57:59 INFO - moznetwork == 0.27 02:57:59 INFO - mozprocess == 0.25 02:57:59 INFO - mozprofile == 0.28 02:57:59 INFO - mozrunner == 6.13 02:57:59 INFO - mozscreenshot == 0.1 02:57:59 INFO - mozsystemmonitor == 0.3 02:57:59 INFO - moztest == 0.8 02:57:59 INFO - mozversion == 1.4 02:57:59 INFO - psutil == 3.1.1 02:57:59 INFO - requests == 1.2.3 02:57:59 INFO - wsgiref == 0.1.2 02:57:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:57: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57: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 0x1d571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2290>, '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 0x1ff2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3040>, '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': '826874ccc97bd7bf541b4875000001d5-1492509426.52743-702675126', '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:57: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:57:59 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:57:59 INFO - Using env: {'DISPLAY': ':0', 02:57:59 INFO - 'HOME': '/home/cltbld', 02:57:59 INFO - 'LANG': 'en_US.UTF-8', 02:57:59 INFO - 'LANGUAGE': 'en_US:en', 02:57:59 INFO - 'LOGNAME': 'cltbld', 02:57:59 INFO - 'MAIL': '/var/mail/cltbld', 02:57:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:59 INFO - 'MOZ_NO_REMOTE': '1', 02:57:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:59 INFO - 'NO_EM_RESTART': '1', 02:57:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:59 INFO - 'PWD': '/builds/slave/test', 02:57:59 INFO - 'SHELL': '/bin/bash', 02:57:59 INFO - 'SHLVL': '1', 02:57:59 INFO - 'TERM': 'linux', 02:57:59 INFO - 'TMOUT': '86400', 02:57:59 INFO - 'USER': 'cltbld', 02:57:59 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1492509426.52743-702675126', 02:57:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:59 INFO - '_': '/tools/buildbot/bin/python'} 02:57:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:59 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:57:59 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:57:59 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:57:59 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:57:59 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:57:59 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:57:59 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:57:59 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:57:59 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:57:59 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:57:59 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:57:59 INFO - Cleaning up... 02:57:59 INFO - Return code: 0 02:57:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:57: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:59 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 0x1d571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff4b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2290>, '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 0x1ff2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3040>, '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': '826874ccc97bd7bf541b4875000001d5-1492509426.52743-702675126', '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:57:59 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:57:59 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:57:59 INFO - Using env: {'DISPLAY': ':0', 02:57:59 INFO - 'HOME': '/home/cltbld', 02:57:59 INFO - 'LANG': 'en_US.UTF-8', 02:57:59 INFO - 'LANGUAGE': 'en_US:en', 02:57:59 INFO - 'LOGNAME': 'cltbld', 02:57:59 INFO - 'MAIL': '/var/mail/cltbld', 02:57:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:59 INFO - 'MOZ_NO_REMOTE': '1', 02:57:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:59 INFO - 'NO_EM_RESTART': '1', 02:57:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:59 INFO - 'PWD': '/builds/slave/test', 02:57:59 INFO - 'SHELL': '/bin/bash', 02:57:59 INFO - 'SHLVL': '1', 02:57:59 INFO - 'TERM': 'linux', 02:57:59 INFO - 'TMOUT': '86400', 02:57:59 INFO - 'USER': 'cltbld', 02:57:59 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1492509426.52743-702675126', 02:57:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:59 INFO - '_': '/tools/buildbot/bin/python'} 02:57:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:57:59 INFO - Cleaning up... 02:57:59 INFO - Return code: 0 02:57:59 INFO - Running post-action listener: _resource_record_post_action 02:57:59 INFO - Running post-action listener: _start_resource_monitoring 02:57:59 INFO - Starting resource monitoring. 02:57:59 INFO - [mozharness: 2017-04-18 09:57:59.783538Z] Finished create-virtualenv step (success) 02:57:59 INFO - [mozharness: 2017-04-18 09:57:59.784057Z] Running install step. 02:57:59 INFO - Running pre-action listener: _resource_record_pre_action 02:57:59 INFO - Running main action method: install 02:57:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:57:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:57:59 INFO - Reading from file tmpfile_stdout 02:57:59 INFO - Detecting whether we're running mozinstall >=1.0... 02:57:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:57:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:58:00 INFO - Reading from file tmpfile_stdout 02:58:00 INFO - Output received: 02:58:00 INFO - Usage: mozinstall [options] installer 02:58:00 INFO - Options: 02:58:00 INFO - -h, --help show this help message and exit 02:58:00 INFO - -d DEST, --destination=DEST 02:58:00 INFO - Directory to install application into. [default: 02:58:00 INFO - "/builds/slave/test"] 02:58:00 INFO - --app=APP Application being installed. [default: firefox] 02:58:00 INFO - mkdir: /builds/slave/test/build/application 02:58:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:58:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:58:16 INFO - Reading from file tmpfile_stdout 02:58:16 INFO - Output received: 02:58:16 INFO - /builds/slave/test/build/application/firefox/firefox 02:58:16 INFO - Running post-action listener: _resource_record_post_action 02:58:16 INFO - [mozharness: 2017-04-18 09:58:16.642830Z] Finished install step (success) 02:58:16 INFO - [mozharness: 2017-04-18 09:58:16.643108Z] Running run-tests step. 02:58:16 INFO - Running pre-action listener: _resource_record_pre_action 02:58:16 INFO - Running main action method: run_tests 02:58:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:58:16 INFO - Python 2.7.3 02:58:16 INFO - Return code: 0 02:58:16 INFO - grabbing minidump binary from tooltool 02:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:16 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 0x1ff2290>, '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 0x1ff2b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff3040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:58:16 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:58:16 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:58:16 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:58:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:58:16 INFO - Return code: 0 02:58:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:58:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:58:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:58:16 INFO - ENV: RUST_BACKTRACE is now 1 02:58:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:58:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:58:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OhNSSLPQRjmBcrb0lKJjAg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OhNSSLPQRjmBcrb0lKJjAg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-052 --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:58:16 INFO - Using env: {'DISPLAY': ':0', 02:58:16 INFO - 'HOME': '/home/cltbld', 02:58:16 INFO - 'LANG': 'en_US.UTF-8', 02:58:16 INFO - 'LANGUAGE': 'en_US:en', 02:58:16 INFO - 'LOGNAME': 'cltbld', 02:58:16 INFO - 'MAIL': '/var/mail/cltbld', 02:58:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:58:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:16 INFO - 'MOZ_NO_REMOTE': '1', 02:58:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:58:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:16 INFO - 'NO_EM_RESTART': '1', 02:58:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:16 INFO - 'PWD': '/builds/slave/test', 02:58:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:58:16 INFO - 'RUST_BACKTRACE': '1', 02:58:16 INFO - 'SHELL': '/bin/bash', 02:58:16 INFO - 'SHLVL': '1', 02:58:16 INFO - 'TERM': 'linux', 02:58:16 INFO - 'TMOUT': '86400', 02:58:16 INFO - 'USER': 'cltbld', 02:58:16 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1492509426.52743-702675126', 02:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:16 INFO - '_': '/tools/buildbot/bin/python'} 02:58:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OhNSSLPQRjmBcrb0lKJjAg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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:58:16 INFO - mozversion application_buildid: 20170418084933 02:58:16 INFO - mozversion application_changeset: 4b43e1c02d4ff32f7d45a6c614720660f52927d9 02:58:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:58:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:58:16 INFO - mozversion application_name: Firefox 02:58:16 INFO - mozversion application_remotingname: firefox-dev 02:58:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:58:16 INFO - mozversion application_vendor: Mozilla 02:58:16 INFO - mozversion application_version: 54.0a2 02:58:16 INFO - mozversion platform_buildid: 20170418084933 02:58:16 INFO - mozversion platform_changeset: 4b43e1c02d4ff32f7d45a6c614720660f52927d9 02:58:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:58:16 INFO - mozversion platform_version: 54.0a2 02:58:16 INFO - using testdate: 1492509496 02:58:16 INFO - actual date: 1492509496 02:58:16 INFO - starting webserver on 'localhost:53988' 02:58:16 INFO - SUITE-START | Running 2 tests 02:58:16 INFO - TEST-START | dromaeo_css 02:58:16 INFO - operating with platform_type : linux_ 02:58:16 INFO - Initialising browser for dromaeo_css test... 02:58:16 INFO - TEST-INFO | started process 5859 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEJRexf/profile http://localhost:53988/getInfo.html) 02:58:20 INFO - PROCESS | 5859 | __metrics Screen width/height:1600/1200 02:58:20 INFO - PROCESS | 5859 | colorDepth:24 02:58:20 INFO - PROCESS | 5859 | Browser inner width/height: 1024/697 02:58:20 INFO - PROCESS | 5859 | __metrics 02:58:21 INFO - PROCESS | 5859 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:58:21 INFO - PROCESS | 5859 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:58:22 INFO - TEST-INFO | 5859: exit 0 02:58:22 INFO - Browser initialized. 02:58:22 INFO - Running cycle 1/1 for dromaeo_css test... 02:58:22 INFO - TEST-INFO | started process 5951 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEJRexf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:58:34 INFO - PROCESS | 5951 | RSS: Main: 139636736 02:58:34 INFO - PROCESS | 5951 | 03:01:36 INFO - PROCESS | 5951 | Cycle 1(1): loaded http://localhost:53988/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53988/tests/dromaeo/cssquery-ext.html) 03:01:37 INFO - PROCESS | 5951 | RSS: Main: 293990400 03:01:37 INFO - PROCESS | 5951 | 03:03:24 INFO - PROCESS | 5951 | ************************* 03:03:24 INFO - PROCESS | 5951 | A coding exception was thrown and uncaught in a Task. 03:03:24 INFO - PROCESS | 5951 | 03:03:24 ERROR - PROCESS | 5951 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:03:24 INFO - PROCESS | 5951 | Full stack: 03:03:24 INFO - PROCESS | 5951 | ************************* 03:03:24 INFO - PROCESS | 5951 | ************************* 03:03:24 INFO - PROCESS | 5951 | A coding exception was thrown and uncaught in a Task. 03:03:24 INFO - PROCESS | 5951 | 03:03:24 ERROR - PROCESS | 5951 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:03:24 INFO - PROCESS | 5951 | Full stack: 03:03:24 INFO - PROCESS | 5951 | ************************* 03:03:24 INFO - PROCESS | 5951 | ************************* 03:03:24 INFO - PROCESS | 5951 | A coding exception was thrown and uncaught in a Task. 03:03:24 INFO - PROCESS | 5951 | 03:03:24 ERROR - PROCESS | 5951 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:03:24 INFO - PROCESS | 5951 | Full stack: 03:03:24 INFO - PROCESS | 5951 | ************************* 03:03:24 INFO - PROCESS | 5951 | ************************* 03:03:24 INFO - PROCESS | 5951 | A coding exception was thrown and uncaught in a Task. 03:03:24 INFO - PROCESS | 5951 | 03:03:24 ERROR - PROCESS | 5951 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:03:24 INFO - PROCESS | 5951 | Full stack: 03:03:24 INFO - PROCESS | 5951 | ************************* 03:04:39 INFO - PROCESS | 5951 | Cycle 1(1): loaded http://localhost:53988/tests/dromaeo/cssquery-ext.html (next: http://localhost:53988/tests/dromaeo/cssquery-jquery.html) 03:04:40 INFO - PROCESS | 5951 | RSS: Main: 228536320 03:04:40 INFO - PROCESS | 5951 | 03:07:42 INFO - PROCESS | 5951 | Cycle 1(1): loaded http://localhost:53988/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53988/tests/dromaeo/cssquery-mootools.html) 03:07:43 INFO - PROCESS | 5951 | RSS: Main: 170524672 03:07:43 INFO - PROCESS | 5951 | 03:10:45 INFO - PROCESS | 5951 | Cycle 1(1): loaded http://localhost:53988/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53988/tests/dromaeo/cssquery-prototype.html) 03:10:45 INFO - PROCESS | 5951 | RSS: Main: 170733568 03:10:45 INFO - PROCESS | 5951 | 03:13:48 INFO - PROCESS | 5951 | Cycle 1(1): loaded http://localhost:53988/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53988/tests/dromaeo/cssquery-yui.html) 03:13:48 INFO - PROCESS | 5951 | RSS: Main: 179167232 03:13:48 INFO - PROCESS | 5951 | 03:16:51 INFO - PROCESS | 5951 | Cycle 1(1): loaded http://localhost:53988/tests/dromaeo/cssquery-yui.html (next: http://localhost:53988/tests/dromaeo/cssquery-dojo.html) 03:16:51 INFO - PROCESS | 5951 | RSS: Main: 264798208 03:16:51 INFO - PROCESS | 5951 | 03:16:51 INFO - PROCESS | 5951 | __start_tp_report 03:16:51 INFO - PROCESS | 5951 | _x_x_mozilla_page_load 03:16:51 INFO - PROCESS | 5951 | _x_x_mozilla_page_load_details 03:16:51 INFO - PROCESS | 5951 | |i|pagename|runs| 03:16:51 INFO - PROCESS | 5951 | |0;dojo.html;3413.2490852012556;3449.741269404794;3467.7225821934258;3486.8256587170636;3507.333606614743;5785.247917770689;5836.824895253149;5842.0652695568715;5846.766129354826;5858.970705146474;5897.174395584621;5908.261467316585;5913.438223368784;5924.111383292508;5927.85180370491;5266.736663166846;5289.920651190235;5299.8410047698435;5364.195370694408;5371.838844834661;5143.897122057557;5422.078246698071;5425.83722488326;5426.565874730012;5432.429594892538;5170.870728231786;5241.371035475749;5301.0988132017455;5384.6769193848295;5402.027635025694;5387.919181212285;5403.918941215885;5404.513593776579;5415.756290966877;5416.1063424534905;5295.894082118374;5307.230451584499;5313.574914006909;5340.49265319794;5349.197620356938;5585.162225666142;5612.326520817487;5687.203791469197;5791.623544469596;5862.032764593837;6327.082573026885;6327.335629758901;6330.208723909512;6332.398422149889;6343.270523889765;6373.458256048241;6374.362563743635;6375.553711240215;6381.202349706286;6389.233292004989;5623.0721930881355;5650.434956504358;5828.358880523139;5869.325027621878;5909.2022576951995;6411.4229719325485;6460.773872914519;6466.838329041718;6473.838154046187;6485.7405703772265;6174.475169610633;6232.906506402408;6236.03341482071;6241.75032998684;6243.968780156161;6082.695865206722;6144.5084393248435;6169.167162433014;6361.173047503795;6373.3945275198785;6289.371062893674;6294.559380843297;6300.0234963580715;6322.778702745381;6322.873542529215;5986.790462333797;6024.578279520391;6030.969845150747;6137.420285946852;6296.811095667137;4708.976455117702;4714.104320179155;4746.644001699818;4769.260764581495;4783.425988881357;4111.280525907954;4119.237940980928;4249.107687385622;4262.296721040993;4295.78521073945;6028.819135425944;6071.089336599545;6110.224634763485;6130.122981477994;6144.77104579086;6337.302896681362;6354.26925903527;6359.650219237894;6363.7772677956045;6369.5222858285815;5843.474087332161;6151.138840562325;6152.600080994721;6160.10678451622;6165.383461653799;5175.767090480937;5179.896402072013;5195.012947539955;5279.577633789288;5291.973540132351;6618.338166183439;6648.700808463631;6652.501062420434;6660.56706314088;6670;6249.0626406039455;6272.686365681789;6312.652804095819;6322.936770632419;6327.082573026793;6233.906491402542;6270.028145637433;6481.675916204265;6557.901631475436;6635.270120286668;6161.630302181704;6176.629402235881;6199.225096862892;6211.0372892201785;6222.315545290105;6268.592541484789;6300.495960323072;6308.653024083719;6310.873782524232;6316.652584107918;5824.5631577631;5848.5028772553105;6067.24159480065;6104.847378815565;6121.239585875057;6164;6217.844553886189;6218.347073557392;6220.875582488235;6221.222347206599;6188.164597779242;6198.535109866688;6205.844853878689;6217.502599792097;6219.502439804714;5923.703814809329;5932.525397968066;5981.9401805983125;5992.310884248367;5996.760129594767;5936.257967754031;5948.405159484017;5949.881002380015;5951.464368206882;5951.702414879325 03:16:51 INFO - PROCESS | 5951 | |1;ext.html;771.8764997600382;821.121400101891;844.72968650032;914.9999999999995;930.139620850713;31746.888858889943;42006;42727;42859;43065.56934430655;45589.31616025754;45868;45878.31182532265;45956.310655340196;45958.310625340564;7716.614169291541;7882.881756773624;8890.59992300348;9024.684136055239;9032.593533291018;10392.220583456234;10614.310069845475;10620.78758424831;10627.946860265687;10939.671809845717;10676.199285053613;10710.41092739899;10719.088877445427;10720.195985301094;10732.892671073267;10638.734031649194;10677.199210059276;10678.51946662402;10690.412027338492;10690.572377104907;10447.738806529822;10492.21308401873;10510.632127875488;10515.631952881613;10516.526756295985;41413;41596;41676.79161604203;41681.1663766726;41765;4168.124693814302;4179.143275628519;4225.091605304874;4291.0130669945775;4331.068820203672;29562.556561651592;29951.700482995107;30090;30579.69420305791;31418.685813141805;4370.300751879716;4455.131249406367;4464.196444639963;4464.8214071437105;4556.5215652356355;234151;234260;234446;234693;234772;54559.45440545623;54564.45435545673;54640.18039729407;54658.45341546534;54724;56491;56497.5875603105;56935;56961.145582816294;57127;16420.096894670667;16759.07825069633;16761.245743941552;16775.664486710197;16794.6641067178;12920.41858116387;13166.670833229246;14322.928385358215;14897.553073407815;14898.553043408498;13395.531156409479;13411.597652070453;13512.93243533776;13543.45826166962;13560;5336.626436149432;5338.3593968724;5401.540869026098;5412.296401467863;5421.295231619864;1000.8949060348705;1027.091024443373;1033.075397519216;1041.4948749856314;1043.582566973217;28182.85908570444;28212.85893570519;28675.85662071718;28789.136325910255;28859.567106493418;1062.8724553053682;1097.5664612478186;1111.0557023886765;1120.3054106454051;1127.932324060559;14682.63293417673;15913.681726365408;16259;16990.745138822927;17118.828811711974;327250;328415;339448;478418;481130;50971.745141274056;51154;51171.232431513556;51328.48671513237;51344.48655513472;1483.9332230049674;1487.9628009299854;1508.8792896568248;1518.627936155649;1533.6855944531344;26857.597136043365;28746.62985784566;28753.712462875104;28974;29071;36522;36556.63443365532;36579.817100914326;36585.08537286589;36613;299925;300834;301286;301608;301979;29244;29464.410711786073;29556.704432956256;29947.70052299449;30035;39482.802585988036;39637;39673.80163099281;39700;40601.1879762409;30443;30562.694373056875;30574.388512230074;30937.690623094382;31280.843595781877;30434.543481847348;30786.69213307838;30875.382492350476;31000.379992400478;31127.53308700326;35005;35329;36203.45694814527;36844;36916.446253306756;30017.69982300149;30360.960634708248;30427.2393190172;30546.585573627348;30616.84691576528;24989.625155623045;25138.49723005493;25340;25381.238562843144;25623.87188064122 03:16:51 INFO - PROCESS | 5951 | |2;jquery.html;413.25201385492244;471.7216842063184;485.85181519636495;487.31146577110314;489.5814078962486;19148.712769308455;21011.2646057388;21474.89262553689;21659.45851353717;21759.6736048959;22063.889680551576;22080.337589872288;22204;22322.77677223227;22555;6564.671766411672;6600.504962127836;6734.764283250087;6769.69536370862;6847.794566163023;4060.3909413587903;4292.6780491463105;6668.733250669968;6741.966290168567;6813.659317034128;7442.292982166712;7672.194419585919;7693.807654808618;7706.884396734054;7914.24814642608;7664.386849052063;7707.267809558083;7784.910112584243;7831.451798374116;7832.686692532292;6886.139232595926;7140.5358651687475;7200.711971521133;7629.427792915498;7636.770896873103;23613.409664758346;24807.62788558173;24814.751852481426;25166.622500662506;25347;3053.9389212215633;3172.0959526534825;3240.5949256342956;3246.5130230465384;3319.3195394943978;14558.854411455855;15276.618084547865;15730.764038539432;15804.288807003597;16142.354305827752;2223.2329846203033;2270.7729227077325;2274.783895529922;2322.988385058064;2358.6344116661944;113034;115028.42485787517;115778.42110789477;115928;117959.41020294843;14090.156658589873;16119.758203626954;17055.232514536874;17354.652906941792;18220.36228731988;31040.379192416025;31308.217294567363;31352.686473134978;31414;31712.36575268482;10462.110720588684;10502.789944201073;10595.629152979609;10688;10786.78426431467;8967.237784788236;8971.955140224387;9026;9214.401063930824;9243.075692430837;9101.544922753836;9116.270698344117;9493.952530237304;9523.666671666459;9542.427454352623;3814.599467055975;3842.5773164951834;3895.2988462077096;3930.5479869815335;3962;989.4953573677476;996.411524927712;1000.2248257600418;1000.949952502372;1014.4572653630272;19340.516487087654;20424.591508169753;20470;20527.692084618742;20701.68947465789;1032.1845741863845;1032.2155162076876;1035.3994683083793;1037.5901518899993;1059.5814653212092;10920.12638988879;11376.715582110348;11430.657080287605;11460.598879039193;11497.827532587018;700613;742605;744476;751540;753195;109648;112114;112695;113376;115557;1230.1143176912608;1259.4458438287124;1291.7158225190442;1292.9418176182094;1298.1626850681257;13812.516561920285;17920;19145.04274786283;19316;19420.320288789826;49556.50443495663;52150;52166.47833521768;52180.47819521756;52199.73900130475;60394.09408858958;71316;71762.28237717556;72717.6364118176;73610;9889;12118.757624847278;12140.968017718593;13055.608331750063;13204.141730787467;13949.930250349089;14565.781513277097;14581.635459113608;14631.853681463475;14780.187089710169;12574;12634;12724.491020359452;12740.617781466572;12905.483780648668;6930.618815964968;11912.744155462498;12004.819927700917;12087;12353.567625133077;11944.16390852632;11995.580154694893;12083.39583020828;12195.634130976085;12244.938775306067;12894.935525322313;13068.869311307146;13175.407106680414;13241.602751917459;13509.459621615026;11515.136364772843;11550.191486596193;11848.052155827685;12232.204906681038;12286.754264914473 03:16:51 INFO - PROCESS | 5951 | |3;mootools.html;1577.1719847080274;1595.2741502616311;1608.2119761316956;1609.6217388913608;1617.547086815692;10742.355458672486;11519;11521.078313734892;11524.308541487517;11534.884651153496;11178.496967636456;11233.382163980978;11480.368579728132;11514.251573647727;11518.539258429653;2480.379905023744;2508.5108403861254;2514.1954574536157;2522.3946252899354;2522.4576716006054;2372.395039264985;2383.7854593086618;2402.3633737059695;2402.759724027601;2406.879656017201;2436.248177806185;2446.388402899275;2448.3144719478573;2486.7264600893886;2491.327341617762;2378.2746262389965;2413.963790543143;2428.295794219674;2431.744666809986;2436.232586735173;2339.5671800716923;2350.917717879866;2359.6814430051895;2360.881955902198;2363.869987150706;11560.132990025782;11785.705357366049;11789.941050294694;11799.528018879235;11801;5815.796447124372;5923.259592550931;5953.642781433085;5961.225040744719;5963.403659634002;3440.569928758905;3449.896503104911;3502.1419752160627;3527.1887465882733;3569.1790888095884;1326.2559733949824;1334.379513526215;1361.9523316683967;1374.8556401577791;1381.1436909116312;14822.888283378681;14831.851681483155;17137.91431042837;17450;17595.824041759548;4932.235503496964;4988.501149885055;5029.06962211992;5122.692638441706;5135.820246291437;10872.293300935415;11123.27698699582;12635;13395.397207125703;13398.330083495786;6070.817875463743;6283.497320214463;6297.685115744194;6299.874002519924;6310.05349197624;5786.218860453869;5799.072148456226;5827.504662103769;5829.5044921181325;5850;4210.915781684411;4253.468316460442;4300.182965236595;4349.391085248068;4353.172897149531;1051.4322265976286;1052.5159525069614;1066.8399740039056;1072.8337107748155;1073.061071562383;1015.2030655935056;1022.3405903192548;1025.108155904368;1035.9119474844572;1041.286718597763;7051.92948070523;7303.525270857377;7342.816429589303;7408.925910740823;7555.16893141754;1021.4126877045728;1029.562435964712;1036.5439206749006;1052.8052310322614;1078.7788503356794;4651.3023046543285;4673.836415725434;4735.408073990751;4804.327394164819;4874.95125048745;14444.205568693613;15104.622384440258;15110.244487775568;15143.697126057417;15144.318505667272;13864.861351386357;14416.85583144176;14880.107193568421;14929.776053358992;14992.250387480583;10664.306820056672;10861.891381086247;10897.455127243606;10905.890941090487;10910.127189824954;7337.0828646419195;7545.207753186056;7755;7825.647845846836;7846.372290216883;13295.268760218281;13489.865101348862;13492.380914289955;13527.458901644217;13563.050586458854;11796.587119450778;13763.793543097061;13814.930925345308;13990.580282591538;14176.645583860485;8939.508327042075;9992.250581206585;10045.397276163454;10125.139363154214;10134.746631334276;11332.376719280519;11389;11424.200305978502;11431.657050288171;11438.542458301576;9529.761755956157;9591.9040809591;9614.086661767122;9617.182539484222;9766;9187.402818816756;9334.906650933404;9358.859617105885;9454;9727.9027209727;8965.910340896507;8991;9028.729138125867;9034.186923176945;9148.908510915071;6631.436327911989;6763.289854565397;6807.89788153188;6841.452683785185;6910.654467276717;6783.660816959231;6812.386885180357;6831.863362732817;6859.108315918898;6911.032455456139 03:16:51 INFO - PROCESS | 5951 | |4;prototype.html;405.37572138906086;432.2932006169913;435.16882753939973;435.8496318770023;436.6310467654832;5103.668261562996;5111.744412779365;5189.195674670423;5194.272801807745;5195.142801437768;4836.395450568679;5097.5157360050825;5122.974385128078;5151.871203219921;5170.4312525622245;4220.860367700719;4258.488981322245;4264.722793018459;4287.7856107194675;4295.140971805636;4278.229918614648;4306.418633484486;4320.65434765218;4332.523422423531;4336.7181133226395;4322.7406355618605;4339.783010849461;4345.391645169679;4349.151915376503;4360.672949528782;4137.834486620532;4310.3965444837595;4322.011874537717;4334.371516130175;4396.450443694538;4087.5299340575916;4089.161721847014;4104.774237416941;4125.381192821071;4134.193832202722;5019.472955339674;5046.924296135561;5058.305467668336;5076.873078173038;5099.515546023122;4743.857684269477;4969.180085285923;4985.651004429691;5019.222020586815;5043.848684539433;5338.211699080813;5356.38401583819;5368.1679339702405;5370.194470829407;5379.488948549882;4468.19572476954;4522.547745225484;4523.36672865799;4546.636269098464;4564.748938808364;5514.944850551483;5586.396774080695;5587.161925711135;5629;5690.4025077367105;4613.65397595175;4621.676482646182;4624.213883639789;4625.676202665848;4659.813607455664;4680.46174689915;4702.31816386622;4702.659741973521;4714.740689262055;4718.4809670936165;4874.319124481521;4925.285833554186;4928.827491037797;4930.235813448921;5009.423916249605;5356.90183512379;5365.731713414391;5378.354597448331;5409.594280428905;5424.430434804368;1596.5449846793608;1614.2413065859027;1631.4534630898781;1639.401618409272;1643.5126210779265;1235.4502246500401;1260.7100366915477;1268.2580690296095;1273.3505911984769;1283.9471633260823;5369.831799238468;5394.865128371744;5397.8380648580605;5427.294451721251;5439.102548079522;5281.943611277759;5552.278203833556;5562;5576.191452239403;5640.605157639008;5372.838814835562;5390.649607775482;5449.6730196188355;5452.236686863842;5468.4531546845;2789.6373471448583;2907.8400687961944;2912.9854350728533;2924.5174546200064;2937.55936609506;5780.393058728857;5804.303483581997;5804.332501762351;5820.767169313265;5825.126231065374;5292.338457692788;5441.755121019563;5602.187682785973;5647.181158731961;5659.2456338535185;5567.832965011056;5667.829965101054;5734.6845923473775;5762.867738936537;5770.201452295633;5399.541039011728;5401.648892821954;5456.881339325508;5478.439014640357;5539.390667026704;5332.440093790251;5336.359636843604;5392.6225164239695;5404.702741349263;5423.345879506788;5676.4323567642905;5702.287214098238;5710.6300885132205;5730.853829234086;5738.799142030009;4464.013513986245;4546.204414227563;4552.499225085172;4590.517995610413;4644.953550464452;5492.697901615449;5502.80740174092;5516.731151835181;5561.221429000024;5565.248691426606;5387.191921211849;5392.793620975645;5395.244665746877;5398.866238090045;5412.891742165213;5185.844424667266;5329.866753331198;5411.428457218217;5419.783208671766;5460.372057213472;5301.701083234632;5340.5460535853335;5351.5451186648015;5360.919586206288;5366.436524164907;5310.1149092071755;5314.362276526687;5394.2987411637805;5412.269343638716;5414.593905457185;5027.3464449621315;5307.814226502054;5330.173823057432;5349.679019258857;5370.4629537045985 03:16:51 INFO - PROCESS | 5951 | |5;yui.html;801;843.9704610338639;900.85586306191;914.8627705844118;929.7954450020995;16345.591360216;16969.151542422875;17320.653586928285;17585.7362139568;18094;14773.48292809752;14948.925255373708;15137.621559460991;16616.66766664666;16806.159692015382;845.7758693946109;861.9525926074064;874.7288340614398;877.9868301975444;881.8500854854658;892.6027917576681;894.0433735902554;898.2006014646969;898.9550522473883;899.2626046641757;944.5324564340661;946.280826571807;946.7396465971844;946.8343039968013;946.9005754395793;931.0410277414275;938.9154976052188;939.4081728511063;939.7556635274843;939.8684184214216;684.3669605614837;684.5584597934354;684.8698747238009;684.934931181537;685.4413652872893;15847.920760396124;15971.281292341873;16012.759808602881;17723.113844307733;18016.819831801644;15442.382304707799;15523.379064837392;15633;15919.522414327588;16149.515514534583;13006.219626822327;13262.270575118364;13470.52853150135;13473.393697283645;13540.932295338558;3910.393888947189;3979.522457305142;4005.2790497710403;4075.7350772200007;4195.811188496525;49990.25014624783;50109.74945125287;53752.19371709428;69637.30362696359;84111;11014.559417623206;12153.756924861453;12505.93747031259;12579.023991384633;12707.682307942376;22172.667409988862;22347.55304893893;22496.21263255811;22590.661140082913;22690.432739181324;8665.740027799176;8684.43551169172;8747.475151490931;8827.955860220658;8951.865722014176;4939.2838038484215;5098.260752190911;5102.464241254689;5116.9744151279;5220.947790522122;3627.3108109459117;3669.486271921933;3680.35593771089;3683.1528748387486;3721.330160571069;596.7702434562725;600.7717067514317;608.8082254089948;615.2340336281359;615.3415845045758;763.4808330335314;765.6210175962823;767.1982777997007;772.8917951486796;781.1524495921989;10465.476726163814;11036.944815276032;11056.336619802838;11633.360165190827;11762.823557646641;697.7243988624465;714.5391222661355;716.4340171264747;719.3058698356007;721.5273995532934;5144.459831717691;5292.444293349143;5621.381648018714;5850.5612079094235;6029.758809647653;80366.19633803586;80883;81073.59463202764;81201;83834.58082709547;70582.64708676527;70591.6470417655;71152.2884771156;71657.64171179215;73450;65657.08547132321;66775.66612166908;66805;67458.66270668615;68341.65829170922;11710.70723231926;11797.115216358636;11826.940865295619;12044.879551204376;12137.514499420278;42459.575404246796;42915;43576;43921;44422.3336649944;51539.22691159711;51722.48277517177;52069.739651301505;53209.733951331546;54437;13444.529441469502;13445.663858403226;13481.730365392834;13568.321583920962;13614.52349167814;14742.189179595225;14861.108333500024;14929.402823886923;15104.471343502924;15206.847931520986;16000.839991599934;16019.519414417586;16279.267432965782;16423.42518011864;17415.042172680118;15247.542573722805;15351.61620959485;15629.921850390676;15862.85303973191;16018.27917743681;13869.861301386856;14283.42866285337;14398.784018239945;14918.104913705212;14941.85058149448;9293.581788819654;9388.483633399956;9435.150836424755;9480.758936537215;9619;11529.654110376701;11563.826542601699;11572.884271157182;11641.301521908712;11692.298462092302 03:16:51 INFO - PROCESS | 5951 | __end_tp_report 03:16:51 INFO - PROCESS | 5951 | __start_cc_report 03:16:51 INFO - PROCESS | 5951 | _x_x_mozilla_cycle_collect,1560 03:16:51 INFO - PROCESS | 5951 | __end_cc_report 03:16:51 INFO - PROCESS | 5951 | __startTimestamp1492510611789__endTimestamp 03:16:51 INFO - PROCESS | 5951 | 03:16:51 INFO - PROCESS | 5951 | ------- Summary: start ------- 03:16:51 INFO - PROCESS | 5951 | Number of tests: 6 03:16:51 INFO - PROCESS | 5951 | 03:16:51 INFO - PROCESS | 5951 | [#0] dojo.html Cycles:165 Average:5829.08 Median:6067.24 stddev:677.89 (11.2%) stddev-sans-first:652.94 03:16:51 INFO - PROCESS | 5951 | Values: 3413.2 3449.7 3467.7 3486.8 3507.3 5785.2 5836.8 5842.1 5846.8 5859.0 5897.2 5908.3 5913.4 5924.1 5927.9 5266.7 5289.9 5299.8 5364.2 5371.8 5143.9 5422.1 5425.8 5426.6 5432.4 5170.9 5241.4 5301.1 5384.7 5402.0 5387.9 5403.9 5404.5 5415.8 5416.1 5295.9 5307.2 5313.6 5340.5 5349.2 5585.2 5612.3 5687.2 5791.6 5862.0 6327.1 6327.3 6330.2 6332.4 6343.3 6373.5 6374.4 6375.6 6381.2 6389.2 5623.1 5650.4 5828.4 5869.3 5909.2 6411.4 6460.8 6466.8 6473.8 6485.7 6174.5 6232.9 6236.0 6241.8 6244.0 6082.7 6144.5 6169.2 6361.2 6373.4 6289.4 6294.6 6300.0 6322.8 6322.9 5986.8 6024.6 6031.0 6137.4 6296.8 4709.0 4714.1 4746.6 4769.3 4783.4 4111.3 4119.2 4249.1 4262.3 4295.8 6028.8 6071.1 6110.2 6130.1 6144.8 6337.3 6354.3 6359.7 6363.8 6369.5 5843.5 6151.1 6152.6 6160.1 6165.4 5175.8 5179.9 5195.0 5279.6 5292.0 6618.3 6648.7 6652.5 6660.6 6670.0 6249.1 6272.7 6312.7 6322.9 6327.1 6233.9 6270.0 6481.7 6557.9 6635.3 6161.6 6176.6 6199.2 6211.0 6222.3 6268.6 6300.5 6308.7 6310.9 6316.7 5824.6 5848.5 6067.2 6104.8 6121.2 6164.0 6217.8 6218.3 6220.9 6221.2 6188.2 6198.5 6205.8 6217.5 6219.5 5923.7 5932.5 5981.9 5992.3 5996.8 5936.3 5948.4 5949.9 5951.5 5951.7 03:16:51 INFO - PROCESS | 5951 | 03:16:51 INFO - PROCESS | 5951 | [#1] ext.html Cycles:180 Average:47052.11 Median:30430.89 stddev:83735.08 (275.2%) stddev-sans-first:83897.88 03:16:51 INFO - PROCESS | 5951 | Values: 771.9 821.1 844.7 915.0 930.1 31746.9 42006.0 42727.0 42859.0 43065.6 45589.3 45868.0 45878.3 45956.3 45958.3 7716.6 7882.9 8890.6 9024.7 9032.6 10392.2 10614.3 10620.8 10627.9 10939.7 10676.2 10710.4 10719.1 10720.2 10732.9 10638.7 10677.2 10678.5 10690.4 10690.6 10447.7 10492.2 10510.6 10515.6 10516.5 41413.0 41596.0 41676.8 41681.2 41765.0 4168.1 4179.1 4225.1 4291.0 4331.1 29562.6 29951.7 30090.0 30579.7 31418.7 4370.3 4455.1 4464.2 4464.8 4556.5 234151.0 234260.0 234446.0 234693.0 234772.0 54559.5 54564.5 54640.2 54658.5 54724.0 56491.0 56497.6 56935.0 56961.1 57127.0 16420.1 16759.1 16761.2 16775.7 16794.7 12920.4 13166.7 14322.9 14897.6 14898.6 13395.5 13411.6 13512.9 13543.5 13560.0 5336.6 5338.4 5401.5 5412.3 5421.3 1000.9 1027.1 1033.1 1041.5 1043.6 28182.9 28212.9 28675.9 28789.1 28859.6 1062.9 1097.6 1111.1 1120.3 1127.9 14682.6 15913.7 16259.0 16990.7 17118.8 327250.0 328415.0 339448.0 478418.0 481130.0 50971.7 51154.0 51171.2 51328.5 51344.5 1483.9 1488.0 1508.9 1518.6 1533.7 26857.6 28746.6 28753.7 28974.0 29071.0 36522.0 36556.6 36579.8 36585.1 36613.0 299925.0 300834.0 301286.0 301608.0 301979.0 29244.0 29464.4 29556.7 29947.7 30035.0 39482.8 39637.0 39673.8 39700.0 40601.2 30443.0 30562.7 30574.4 30937.7 31280.8 30434.5 30786.7 30875.4 31000.4 31127.5 35005.0 35329.0 36203.5 36844.0 36916.4 30017.7 30361.0 30427.2 30546.6 30616.8 24989.6 25138.5 25340.0 25381.2 25623.9 03:16:51 INFO - PROCESS | 5951 | 03:16:51 INFO - PROCESS | 5951 | [#2] jquery.html Cycles:180 Average:39839.26 Median:21911.78 stddev:121424.53 (554.2%) stddev-sans-first:121729.07 03:16:51 INFO - PROCESS | 5951 | Values: 413.3 471.7 485.9 487.3 489.6 19148.7 21011.3 21474.9 21659.5 21759.7 22063.9 22080.3 22204.0 22322.8 22555.0 6564.7 6600.5 6734.8 6769.7 6847.8 4060.4 4292.7 6668.7 6742.0 6813.7 7442.3 7672.2 7693.8 7706.9 7914.2 7664.4 7707.3 7784.9 7831.5 7832.7 6886.1 7140.5 7200.7 7629.4 7636.8 23613.4 24807.6 24814.8 25166.6 25347.0 3053.9 3172.1 3240.6 3246.5 3319.3 14558.9 15276.6 15730.8 15804.3 16142.4 2223.2 2270.8 2274.8 2323.0 2358.6 113034.0 115028.4 115778.4 115928.0 117959.4 14090.2 16119.8 17055.2 17354.7 18220.4 31040.4 31308.2 31352.7 31414.0 31712.4 10462.1 10502.8 10595.6 10688.0 10786.8 8967.2 8972.0 9026.0 9214.4 9243.1 9101.5 9116.3 9494.0 9523.7 9542.4 3814.6 3842.6 3895.3 3930.5 3962.0 989.5 996.4 1000.2 1000.9 1014.5 19340.5 20424.6 20470.0 20527.7 20701.7 1032.2 1032.2 1035.4 1037.6 1059.6 10920.1 11376.7 11430.7 11460.6 11497.8 700613.0 742605.0 744476.0 751540.0 753195.0 109648.0 112114.0 112695.0 113376.0 115557.0 1230.1 1259.4 1291.7 1292.9 1298.2 13812.5 17920.0 19145.0 19316.0 19420.3 49556.5 52150.0 52166.5 52180.5 52199.7 60394.1 71316.0 71762.3 72717.6 73610.0 9889.0 12118.8 12141.0 13055.6 13204.1 13949.9 14565.8 14581.6 14631.9 14780.2 12574.0 12634.0 12724.5 12740.6 12905.5 6930.6 11912.7 12004.8 12087.0 12353.6 11944.2 11995.6 12083.4 12195.6 12244.9 12894.9 13068.9 13175.4 13241.6 13509.5 11515.1 11550.2 11848.1 12232.2 12286.8 03:16:51 INFO - PROCESS | 5951 | 03:16:51 INFO - PROCESS | 5951 | [#3] mootools.html Cycles:180 Average:7287.23 Median:2393.07 stddev:4568.82 (190.9%) stddev-sans-first:4561.49 03:16:51 INFO - PROCESS | 5951 | Values: 1577.2 1595.3 1608.2 1609.6 1617.5 10742.4 11519.0 11521.1 11524.3 11534.9 11178.5 11233.4 11480.4 11514.3 11518.5 2480.4 2508.5 2514.2 2522.4 2522.5 2372.4 2383.8 2402.4 2402.8 2406.9 2436.2 2446.4 2448.3 2486.7 2491.3 2378.3 2414.0 2428.3 2431.7 2436.2 2339.6 2350.9 2359.7 2360.9 2363.9 11560.1 11785.7 11789.9 11799.5 11801.0 5815.8 5923.3 5953.6 5961.2 5963.4 3440.6 3449.9 3502.1 3527.2 3569.2 1326.3 1334.4 1362.0 1374.9 1381.1 14822.9 14831.9 17137.9 17450.0 17595.8 4932.2 4988.5 5029.1 5122.7 5135.8 10872.3 11123.3 12635.0 13395.4 13398.3 6070.8 6283.5 6297.7 6299.9 6310.1 5786.2 5799.1 5827.5 5829.5 5850.0 4210.9 4253.5 4300.2 4349.4 4353.2 1051.4 1052.5 1066.8 1072.8 1073.1 1015.2 1022.3 1025.1 1035.9 1041.3 7051.9 7303.5 7342.8 7408.9 7555.2 1021.4 1029.6 1036.5 1052.8 1078.8 4651.3 4673.8 4735.4 4804.3 4875.0 14444.2 15104.6 15110.2 15143.7 15144.3 13864.9 14416.9 14880.1 14929.8 14992.3 10664.3 10861.9 10897.5 10905.9 10910.1 7337.1 7545.2 7755.0 7825.6 7846.4 13295.3 13489.9 13492.4 13527.5 13563.1 11796.6 13763.8 13814.9 13990.6 14176.6 8939.5 9992.3 10045.4 10125.1 10134.7 11332.4 11389.0 11424.2 11431.7 11438.5 9529.8 9591.9 9614.1 9617.2 9766.0 9187.4 9334.9 9358.9 9454.0 9727.9 8965.9 8991.0 9028.7 9034.2 9148.9 6631.4 6763.3 6807.9 6841.5 6910.7 6783.7 6812.4 6831.9 6859.1 6911.0 03:16:51 INFO - PROCESS | 5951 | 03:16:51 INFO - PROCESS | 5951 | [#4] prototype.html Cycles:180 Average:4714.11 Median:5194.71 stddev:1247.46 (24.0%) stddev-sans-first:1208.31 03:16:51 INFO - PROCESS | 5951 | Values: 405.4 432.3 435.2 435.8 436.6 5103.7 5111.7 5189.2 5194.3 5195.1 4836.4 5097.5 5123.0 5151.9 5170.4 4220.9 4258.5 4264.7 4287.8 4295.1 4278.2 4306.4 4320.7 4332.5 4336.7 4322.7 4339.8 4345.4 4349.2 4360.7 4137.8 4310.4 4322.0 4334.4 4396.5 4087.5 4089.2 4104.8 4125.4 4134.2 5019.5 5046.9 5058.3 5076.9 5099.5 4743.9 4969.2 4985.7 5019.2 5043.8 5338.2 5356.4 5368.2 5370.2 5379.5 4468.2 4522.5 4523.4 4546.6 4564.7 5514.9 5586.4 5587.2 5629.0 5690.4 4613.7 4621.7 4624.2 4625.7 4659.8 4680.5 4702.3 4702.7 4714.7 4718.5 4874.3 4925.3 4928.8 4930.2 5009.4 5356.9 5365.7 5378.4 5409.6 5424.4 1596.5 1614.2 1631.5 1639.4 1643.5 1235.5 1260.7 1268.3 1273.4 1283.9 5369.8 5394.9 5397.8 5427.3 5439.1 5281.9 5552.3 5562.0 5576.2 5640.6 5372.8 5390.6 5449.7 5452.2 5468.5 2789.6 2907.8 2913.0 2924.5 2937.6 5780.4 5804.3 5804.3 5820.8 5825.1 5292.3 5441.8 5602.2 5647.2 5659.2 5567.8 5667.8 5734.7 5762.9 5770.2 5399.5 5401.6 5456.9 5478.4 5539.4 5332.4 5336.4 5392.6 5404.7 5423.3 5676.4 5702.3 5710.6 5730.9 5738.8 4464.0 4546.2 4552.5 4590.5 4645.0 5492.7 5502.8 5516.7 5561.2 5565.2 5387.2 5392.8 5395.2 5398.9 5412.9 5185.8 5329.9 5411.4 5419.8 5460.4 5301.7 5340.5 5351.5 5360.9 5366.4 5310.1 5314.4 5394.3 5412.3 5414.6 5027.3 5307.8 5330.2 5349.7 5370.5 03:16:51 INFO - PROCESS | 5951 | 03:16:51 INFO - PROCESS | 5951 | [#5] yui.html Cycles:180 Average:17903.67 Median:27464.77 stddev:21803.49 (79.4%) stddev-sans-first:21826.83 03:16:51 INFO - PROCESS | 5951 | Values: 801.0 844.0 900.9 914.9 929.8 16345.6 16969.2 17320.7 17585.7 18094.0 14773.5 14948.9 15137.6 16616.7 16806.2 845.8 862.0 874.7 878.0 881.9 892.6 894.0 898.2 899.0 899.3 944.5 946.3 946.7 946.8 946.9 931.0 938.9 939.4 939.8 939.9 684.4 684.6 684.9 684.9 685.4 15847.9 15971.3 16012.8 17723.1 18016.8 15442.4 15523.4 15633.0 15919.5 16149.5 13006.2 13262.3 13470.5 13473.4 13540.9 3910.4 3979.5 4005.3 4075.7 4195.8 49990.3 50109.7 53752.2 69637.3 84111.0 11014.6 12153.8 12505.9 12579.0 12707.7 22172.7 22347.6 22496.2 22590.7 22690.4 8665.7 8684.4 8747.5 8828.0 8951.9 4939.3 5098.3 5102.5 5117.0 5220.9 3627.3 3669.5 3680.4 3683.2 3721.3 596.8 600.8 608.8 615.2 615.3 763.5 765.6 767.2 772.9 781.2 10465.5 11036.9 11056.3 11633.4 11762.8 697.7 714.5 716.4 719.3 721.5 5144.5 5292.4 5621.4 5850.6 6029.8 80366.2 80883.0 81073.6 81201.0 83834.6 70582.6 70591.6 71152.3 71657.6 73450.0 65657.1 66775.7 66805.0 67458.7 68341.7 11710.7 11797.1 11826.9 12044.9 12137.5 42459.6 42915.0 43576.0 43921.0 44422.3 51539.2 51722.5 52069.7 53209.7 54437.0 13444.5 13445.7 13481.7 13568.3 13614.5 14742.2 14861.1 14929.4 15104.5 15206.8 16000.8 16019.5 16279.3 16423.4 17415.0 15247.5 15351.6 15629.9 15862.9 16018.3 13869.9 14283.4 14398.8 14918.1 14941.9 9293.6 9388.5 9435.2 9480.8 9619.0 11529.7 11563.8 11572.9 11641.3 11692.3 03:16:51 INFO - PROCESS | 5951 | -------- Summary: end -------- 03:16:51 INFO - PROCESS | 5951 | 03:16:52 INFO - TEST-INFO | 5951: exit 0 03:16:52 INFO - TEST-OK | dromaeo_css | took 1115515ms 03:16:52 INFO - TEST-START | kraken 03:16:52 INFO - operating with platform_type : linux_ 03:16:52 INFO - Initialising browser for kraken test... 03:16:52 INFO - TEST-INFO | started process 6270 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM5psGF/profile http://localhost:53988/getInfo.html) 03:16:56 INFO - PROCESS | 6270 | __metrics Screen width/height:1600/1200 03:16:56 INFO - PROCESS | 6270 | colorDepth:24 03:16:56 INFO - PROCESS | 6270 | Browser inner width/height: 1024/697 03:16:56 INFO - PROCESS | 6270 | __metrics 03:16:57 INFO - PROCESS | 6270 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:16:57 INFO - PROCESS | 6270 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:16:58 INFO - TEST-INFO | 6270: exit 0 03:16:58 INFO - Browser initialized. 03:16:58 INFO - Running cycle 1/1 for kraken test... 03:16:58 INFO - TEST-INFO | started process 6361 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM5psGF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:17:09 INFO - PROCESS | 6361 | RSS: Main: 139886592 03:17:09 INFO - PROCESS | 6361 | 03:17:12 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53988/tests/kraken/driver.html?testName=audio-beat-detection) 03:17:13 INFO - PROCESS | 6361 | RSS: Main: 183123968 03:17:13 INFO - PROCESS | 6361 | 03:17:15 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53988/tests/kraken/driver.html?testName=audio-dft) 03:17:16 INFO - PROCESS | 6361 | RSS: Main: 173674496 03:17:16 INFO - PROCESS | 6361 | 03:17:19 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53988/tests/kraken/driver.html?testName=audio-fft) 03:17:19 INFO - PROCESS | 6361 | RSS: Main: 266002432 03:17:19 INFO - PROCESS | 6361 | 03:17:21 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53988/tests/kraken/driver.html?testName=audio-oscillator) 03:17:22 INFO - PROCESS | 6361 | RSS: Main: 172187648 03:17:22 INFO - PROCESS | 6361 | 03:17:24 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53988/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:17:25 INFO - PROCESS | 6361 | RSS: Main: 174297088 03:17:25 INFO - PROCESS | 6361 | 03:17:27 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53988/tests/kraken/driver.html?testName=imaging-darkroom) 03:17:28 INFO - PROCESS | 6361 | RSS: Main: 213381120 03:17:28 INFO - PROCESS | 6361 | 03:17:31 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53988/tests/kraken/driver.html?testName=imaging-desaturate) 03:17:32 INFO - PROCESS | 6361 | RSS: Main: 212885504 03:17:32 INFO - PROCESS | 6361 | 03:17:35 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53988/tests/kraken/driver.html?testName=json-parse-financial) 03:17:35 INFO - PROCESS | 6361 | RSS: Main: 210849792 03:17:35 INFO - PROCESS | 6361 | 03:17:37 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53988/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:17:37 INFO - PROCESS | 6361 | RSS: Main: 173060096 03:17:37 INFO - PROCESS | 6361 | 03:17:39 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53988/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:17:40 INFO - PROCESS | 6361 | RSS: Main: 179494912 03:17:40 INFO - PROCESS | 6361 | 03:17:42 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53988/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:17:42 INFO - PROCESS | 6361 | RSS: Main: 189612032 03:17:42 INFO - PROCESS | 6361 | 03:17:45 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53988/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:17:46 INFO - PROCESS | 6361 | RSS: Main: 199053312 03:17:46 INFO - PROCESS | 6361 | 03:17:48 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53988/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:17:49 INFO - PROCESS | 6361 | RSS: Main: 195305472 03:17:49 INFO - PROCESS | 6361 | 03:17:51 INFO - PROCESS | 6361 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53988/tests/kraken/driver.html?testName=ai-astar) 03:17:51 INFO - PROCESS | 6361 | RSS: Main: 245538816 03:17:51 INFO - PROCESS | 6361 | 03:17:51 INFO - PROCESS | 6361 | __start_tp_report 03:17:51 INFO - PROCESS | 6361 | _x_x_mozilla_page_load 03:17:51 INFO - PROCESS | 6361 | _x_x_mozilla_page_load_details 03:17:51 INFO - PROCESS | 6361 | |i|pagename|runs| 03:17:51 INFO - PROCESS | 6361 | |0;ai-astar;102;114;112;112;112;114;114;113;110;112 03:17:51 INFO - PROCESS | 6361 | |1;audio-beat-detection;141;117;115;160;117;116;115;116;137;117 03:17:51 INFO - PROCESS | 6361 | |2;audio-dft;161;160;160;161;162;161;161;160;161;162 03:17:51 INFO - PROCESS | 6361 | |3;audio-fft;75;76;76;104;77;77;76;76;103;77 03:17:51 INFO - PROCESS | 6361 | |4;audio-oscillator;81;81;107;81;82;81;94;82;82;109 03:17:51 INFO - PROCESS | 6361 | |5;imaging-gaussian-blur;113;112;113;113;114;114;114;113;113;113 03:17:51 INFO - PROCESS | 6361 | |6;imaging-darkroom;146;146;146;145;146;147;146;146;146;147 03:17:51 INFO - PROCESS | 6361 | |7;imaging-desaturate;95;94;94;94;93;93;93;94;94;94 03:17:51 INFO - PROCESS | 6361 | |8;json-parse-financial;53;54;54;53;54;54;53;56;53;53 03:17:51 INFO - PROCESS | 6361 | |9;json-stringify-tinderbox;54;54;53;54;54;54;54;54;53;53 03:17:51 INFO - PROCESS | 6361 | |10;stanford-crypto-aes;79;76;86;78;83;75;80;81;82;74 03:17:51 INFO - PROCESS | 6361 | |11;stanford-crypto-ccm;124;121;123;119;129;138;118;118;160;121 03:17:51 INFO - PROCESS | 6361 | |12;stanford-crypto-pbkdf2;161;158;156;161;162;163;157;160;162;161 03:17:51 INFO - PROCESS | 6361 | |13;stanford-crypto-sha256-iterative;60;59;60;60;61;59;59;69;59;58 03:17:51 INFO - PROCESS | 6361 | __end_tp_report 03:17:51 INFO - PROCESS | 6361 | __start_cc_report 03:17:51 INFO - PROCESS | 6361 | _x_x_mozilla_cycle_collect,1666 03:17:51 INFO - PROCESS | 6361 | __end_cc_report 03:17:51 INFO - PROCESS | 6361 | __startTimestamp1492510671303__endTimestamp 03:17:51 INFO - PROCESS | 6361 | 03:17:51 INFO - PROCESS | 6361 | ------- Summary: start ------- 03:17:51 INFO - PROCESS | 6361 | Number of tests: 14 03:17:51 INFO - PROCESS | 6361 | 03:17:51 INFO - PROCESS | 6361 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.50 stddev:3.57 (3.2%) stddev-sans-first:1.33 03:17:51 INFO - PROCESS | 6361 | Values: 102.0 114.0 112.0 112.0 112.0 114.0 114.0 113.0 110.0 112.0 03:17:51 INFO - PROCESS | 6361 | 03:17:51 INFO - PROCESS | 6361 | [#1] audio-beat-detection Cycles:10 Average:125.10 Median:117.00 stddev:15.56 (13.3%) stddev-sans-first:15.40 03:17:51 INFO - PROCESS | 6361 | Values: 141.0 117.0 115.0 160.0 117.0 116.0 115.0 116.0 137.0 117.0 03:17:51 INFO - PROCESS | 6361 | 03:17:51 INFO - PROCESS | 6361 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 03:17:51 INFO - PROCESS | 6361 | Values: 161.0 160.0 160.0 161.0 162.0 161.0 161.0 160.0 161.0 162.0 03:17:51 INFO - PROCESS | 6361 | 03:17:51 INFO - PROCESS | 6361 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:11.51 (15.1%) stddev-sans-first:11.95 03:17:51 INFO - PROCESS | 6361 | Values: 75.0 76.0 76.0 104.0 77.0 77.0 76.0 76.0 103.0 77.0 03:17:51 INFO - PROCESS | 6361 | 03:17:51 INFO - PROCESS | 6361 | [#4] audio-oscillator Cycles:10 Average:88.00 Median:81.50 stddev:11.26 (13.8%) stddev-sans-first:11.66 03:17:51 INFO - PROCESS | 6361 | Values: 81.0 81.0 107.0 81.0 82.0 81.0 94.0 82.0 82.0 109.0 03:17:51 INFO - PROCESS | 6361 | 03:17:51 INFO - PROCESS | 6361 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:113.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 03:17:51 INFO - PROCESS | 6361 | Values: 113.0 112.0 113.0 113.0 114.0 114.0 114.0 113.0 113.0 113.0 03:17:51 INFO - PROCESS | 6361 | 03:17:51 INFO - PROCESS | 6361 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 03:17:51 INFO - PROCESS | 6361 | Values: 146.0 146.0 146.0 145.0 146.0 147.0 146.0 146.0 146.0 147.0 03:17:51 INFO - PROCESS | 6361 | 03:17:51 INFO - PROCESS | 6361 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 03:17:51 INFO - PROCESS | 6361 | Values: 95.0 94.0 94.0 94.0 93.0 93.0 93.0 94.0 94.0 94.0 03:17:51 INFO - PROCESS | 6361 | 03:17:51 INFO - PROCESS | 6361 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:0.95 (1.8%) stddev-sans-first:0.97 03:17:51 INFO - PROCESS | 6361 | Values: 53.0 54.0 54.0 53.0 54.0 54.0 53.0 56.0 53.0 53.0 03:17:51 INFO - PROCESS | 6361 | 03:17:51 INFO - PROCESS | 6361 | [#9] json-stringify-tinderbox Cycles:10 Average:53.70 Median:54.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 03:17:51 INFO - PROCESS | 6361 | Values: 54.0 54.0 53.0 54.0 54.0 54.0 54.0 54.0 53.0 53.0 03:17:51 INFO - PROCESS | 6361 | 03:17:51 INFO - PROCESS | 6361 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:80.50 stddev:3.78 (4.7%) stddev-sans-first:4.00 03:17:51 INFO - PROCESS | 6361 | Values: 79.0 76.0 86.0 78.0 83.0 75.0 80.0 81.0 82.0 74.0 03:17:51 INFO - PROCESS | 6361 | 03:17:51 INFO - PROCESS | 6361 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:123.50 stddev:13.07 (10.6%) stddev-sans-first:13.81 03:17:51 INFO - PROCESS | 6361 | Values: 124.0 121.0 123.0 119.0 129.0 138.0 118.0 118.0 160.0 121.0 03:17:51 INFO - PROCESS | 6361 | 03:17:51 INFO - PROCESS | 6361 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.10 Median:161.00 stddev:2.33 (1.4%) stddev-sans-first:2.45 03:17:51 INFO - PROCESS | 6361 | Values: 161.0 158.0 156.0 161.0 162.0 163.0 157.0 160.0 162.0 161.0 03:17:51 INFO - PROCESS | 6361 | 03:17:51 INFO - PROCESS | 6361 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.40 Median:60.00 stddev:3.13 (5.2%) stddev-sans-first:3.32 03:17:51 INFO - PROCESS | 6361 | Values: 60.0 59.0 60.0 60.0 61.0 59.0 59.0 69.0 59.0 58.0 03:17:51 INFO - PROCESS | 6361 | -------- Summary: end -------- 03:17:51 INFO - PROCESS | 6361 | 03:17:52 INFO - TEST-INFO | 6361: exit 0 03:17:52 INFO - TEST-OK | kraken | took 60083ms 03:17:52 INFO - SUITE-END | took 1175s 03:17:52 INFO - Completed test suite (00:19:36) 03:17:52 INFO - javascript benchmark 03:17:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7841.524246345559, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3413.2490852012556, 3449.741269404794, 3467.7225821934258, 3486.8256587170636, 3507.333606614743, 5785.247917770689, 5836.824895253149, 5842.0652695568715, 5846.766129354826, 5858.970705146474, 5897.174395584621, 5908.261467316585, 5913.438223368784, 5924.111383292508, 5927.85180370491, 5266.736663166846, 5289.920651190235, 5299.8410047698435, 5364.195370694408, 5371.838844834661, 5143.897122057557, 5422.078246698071, 5425.83722488326, 5426.565874730012, 5432.429594892538, 5170.870728231786, 5241.371035475749, 5301.0988132017455, 5384.6769193848295, 5402.027635025694, 5387.919181212285, 5403.918941215885, 5404.513593776579, 5415.756290966877, 5416.1063424534905, 5295.894082118374, 5307.230451584499, 5313.574914006909, 5340.49265319794, 5349.197620356938, 5585.162225666142, 5612.326520817487, 5687.203791469197, 5791.623544469596, 5862.032764593837, 6327.082573026885, 6327.335629758901, 6330.208723909512, 6332.398422149889, 6343.270523889765, 6373.458256048241, 6374.362563743635, 6375.553711240215, 6381.202349706286, 6389.233292004989, 5623.0721930881355, 5650.434956504358, 5828.358880523139, 5869.325027621878, 5909.2022576951995, 6411.4229719325485, 6460.773872914519, 6466.838329041718, 6473.838154046187, 6485.7405703772265, 6174.475169610633, 6232.906506402408, 6236.03341482071, 6241.75032998684, 6243.968780156161, 6082.695865206722, 6144.5084393248435, 6169.167162433014, 6361.173047503795, 6373.3945275198785, 6289.371062893674, 6294.559380843297, 6300.0234963580715, 6322.778702745381, 6322.873542529215, 5986.790462333797, 6024.578279520391, 6030.969845150747, 6137.420285946852, 6296.811095667137, 4708.976455117702, 4714.104320179155, 4746.644001699818, 4769.260764581495, 4783.425988881357, 4111.280525907954, 4119.237940980928, 4249.107687385622, 4262.296721040993, 4295.78521073945, 6028.819135425944, 6071.089336599545, 6110.224634763485, 6130.122981477994, 6144.77104579086, 6337.302896681362, 6354.26925903527, 6359.650219237894, 6363.7772677956045, 6369.5222858285815, 5843.474087332161, 6151.138840562325, 6152.600080994721, 6160.10678451622, 6165.383461653799, 5175.767090480937, 5179.896402072013, 5195.012947539955, 5279.577633789288, 5291.973540132351, 6618.338166183439, 6648.700808463631, 6652.501062420434, 6660.56706314088, 6670.0, 6249.0626406039455, 6272.686365681789, 6312.652804095819, 6322.936770632419, 6327.082573026793, 6233.906491402542, 6270.028145637433, 6481.675916204265, 6557.901631475436, 6635.270120286668, 6161.630302181704, 6176.629402235881, 6199.225096862892, 6211.0372892201785, 6222.315545290105, 6268.592541484789, 6300.495960323072, 6308.653024083719, 6310.873782524232, 6316.652584107918, 5824.5631577631, 5848.5028772553105, 6067.24159480065, 6104.847378815565, 6121.239585875057, 6164.0, 6217.844553886189, 6218.347073557392, 6220.875582488235, 6221.222347206599, 6188.164597779242, 6198.535109866688, 6205.844853878689, 6217.502599792097, 6219.502439804714, 5923.703814809329, 5932.525397968066, 5981.9401805983125, 5992.310884248367, 5996.760129594767, 5936.257967754031, 5948.405159484017, 5949.881002380015, 5951.464368206882, 5951.702414879325], "value": 5783.054182223406, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [771.8764997600382, 821.121400101891, 844.72968650032, 914.9999999999995, 930.139620850713, 31746.888858889943, 42006.0, 42727.0, 42859.0, 43065.56934430655, 45589.31616025754, 45868.0, 45878.31182532265, 45956.310655340196, 45958.310625340564, 7716.614169291541, 7882.881756773624, 8890.59992300348, 9024.684136055239, 9032.593533291018, 10392.220583456234, 10614.310069845475, 10620.78758424831, 10627.946860265687, 10939.671809845717, 10676.199285053613, 10710.41092739899, 10719.088877445427, 10720.195985301094, 10732.892671073267, 10638.734031649194, 10677.199210059276, 10678.51946662402, 10690.412027338492, 10690.572377104907, 10447.738806529822, 10492.21308401873, 10510.632127875488, 10515.631952881613, 10516.526756295985, 41413.0, 41596.0, 41676.79161604203, 41681.1663766726, 41765.0, 4168.124693814302, 4179.143275628519, 4225.091605304874, 4291.0130669945775, 4331.068820203672, 29562.556561651592, 29951.700482995107, 30090.0, 30579.69420305791, 31418.685813141805, 4370.300751879716, 4455.131249406367, 4464.196444639963, 4464.8214071437105, 4556.5215652356355, 234151.0, 234260.0, 234446.0, 234693.0, 234772.0, 54559.45440545623, 54564.45435545673, 54640.18039729407, 54658.45341546534, 54724.0, 56491.0, 56497.5875603105, 56935.0, 56961.145582816294, 57127.0, 16420.096894670667, 16759.07825069633, 16761.245743941552, 16775.664486710197, 16794.6641067178, 12920.41858116387, 13166.670833229246, 14322.928385358215, 14897.553073407815, 14898.553043408498, 13395.531156409479, 13411.597652070453, 13512.93243533776, 13543.45826166962, 13560.0, 5336.626436149432, 5338.3593968724, 5401.540869026098, 5412.296401467863, 5421.295231619864, 1000.8949060348705, 1027.091024443373, 1033.075397519216, 1041.4948749856314, 1043.582566973217, 28182.85908570444, 28212.85893570519, 28675.85662071718, 28789.136325910255, 28859.567106493418, 1062.8724553053682, 1097.5664612478186, 1111.0557023886765, 1120.3054106454051, 1127.932324060559, 14682.63293417673, 15913.681726365408, 16259.0, 16990.745138822927, 17118.828811711974, 327250.0, 328415.0, 339448.0, 478418.0, 481130.0, 50971.745141274056, 51154.0, 51171.232431513556, 51328.48671513237, 51344.48655513472, 1483.9332230049674, 1487.9628009299854, 1508.8792896568248, 1518.627936155649, 1533.6855944531344, 26857.597136043365, 28746.62985784566, 28753.712462875104, 28974.0, 29071.0, 36522.0, 36556.63443365532, 36579.817100914326, 36585.08537286589, 36613.0, 299925.0, 300834.0, 301286.0, 301608.0, 301979.0, 29244.0, 29464.410711786073, 29556.704432956256, 29947.70052299449, 30035.0, 39482.802585988036, 39637.0, 39673.80163099281, 39700.0, 40601.1879762409, 30443.0, 30562.694373056875, 30574.388512230074, 30937.690623094382, 31280.843595781877, 30434.543481847348, 30786.69213307838, 30875.382492350476, 31000.379992400478, 31127.53308700326, 35005.0, 35329.0, 36203.45694814527, 36844.0, 36916.446253306756, 30017.69982300149, 30360.960634708248, 30427.2393190172, 30546.585573627348, 30616.84691576528, 24989.625155623045, 25138.49723005493, 25340.0, 25381.238562843144, 25623.87188064122], "value": 18834.023755066584, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.25201385492244, 471.7216842063184, 485.85181519636495, 487.31146577110314, 489.5814078962486, 19148.712769308455, 21011.2646057388, 21474.89262553689, 21659.45851353717, 21759.6736048959, 22063.889680551576, 22080.337589872288, 22204.0, 22322.77677223227, 22555.0, 6564.671766411672, 6600.504962127836, 6734.764283250087, 6769.69536370862, 6847.794566163023, 4060.3909413587903, 4292.6780491463105, 6668.733250669968, 6741.966290168567, 6813.659317034128, 7442.292982166712, 7672.194419585919, 7693.807654808618, 7706.884396734054, 7914.24814642608, 7664.386849052063, 7707.267809558083, 7784.910112584243, 7831.451798374116, 7832.686692532292, 6886.139232595926, 7140.5358651687475, 7200.711971521133, 7629.427792915498, 7636.770896873103, 23613.409664758346, 24807.62788558173, 24814.751852481426, 25166.622500662506, 25347.0, 3053.9389212215633, 3172.0959526534825, 3240.5949256342956, 3246.5130230465384, 3319.3195394943978, 14558.854411455855, 15276.618084547865, 15730.764038539432, 15804.288807003597, 16142.354305827752, 2223.2329846203033, 2270.7729227077325, 2274.783895529922, 2322.988385058064, 2358.6344116661944, 113034.0, 115028.42485787517, 115778.42110789477, 115928.0, 117959.41020294843, 14090.156658589873, 16119.758203626954, 17055.232514536874, 17354.652906941792, 18220.36228731988, 31040.379192416025, 31308.217294567363, 31352.686473134978, 31414.0, 31712.36575268482, 10462.110720588684, 10502.789944201073, 10595.629152979609, 10688.0, 10786.78426431467, 8967.237784788236, 8971.955140224387, 9026.0, 9214.401063930824, 9243.075692430837, 9101.544922753836, 9116.270698344117, 9493.952530237304, 9523.666671666459, 9542.427454352623, 3814.599467055975, 3842.5773164951834, 3895.2988462077096, 3930.5479869815335, 3962.0, 989.4953573677476, 996.411524927712, 1000.2248257600418, 1000.949952502372, 1014.4572653630272, 19340.516487087654, 20424.591508169753, 20470.0, 20527.692084618742, 20701.68947465789, 1032.1845741863845, 1032.2155162076876, 1035.3994683083793, 1037.5901518899993, 1059.5814653212092, 10920.12638988879, 11376.715582110348, 11430.657080287605, 11460.598879039193, 11497.827532587018, 700613.0, 742605.0, 744476.0, 751540.0, 753195.0, 109648.0, 112114.0, 112695.0, 113376.0, 115557.0, 1230.1143176912608, 1259.4458438287124, 1291.7158225190442, 1292.9418176182094, 1298.1626850681257, 13812.516561920285, 17920.0, 19145.04274786283, 19316.0, 19420.320288789826, 49556.50443495663, 52150.0, 52166.47833521768, 52180.47819521756, 52199.73900130475, 60394.09408858958, 71316.0, 71762.28237717556, 72717.6364118176, 73610.0, 9889.0, 12118.757624847278, 12140.968017718593, 13055.608331750063, 13204.141730787467, 13949.930250349089, 14565.781513277097, 14581.635459113608, 14631.853681463475, 14780.187089710169, 12574.0, 12634.0, 12724.491020359452, 12740.617781466572, 12905.483780648668, 6930.618815964968, 11912.744155462498, 12004.819927700917, 12087.0, 12353.567625133077, 11944.16390852632, 11995.580154694893, 12083.39583020828, 12195.634130976085, 12244.938775306067, 12894.935525322313, 13068.869311307146, 13175.407106680414, 13241.602751917459, 13509.459621615026, 11515.136364772843, 11550.191486596193, 11848.052155827685, 12232.204906681038, 12286.754264914473], "value": 11528.338838437254, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1577.1719847080274, 1595.2741502616311, 1608.2119761316956, 1609.6217388913608, 1617.547086815692, 10742.355458672486, 11519.0, 11521.078313734892, 11524.308541487517, 11534.884651153496, 11178.496967636456, 11233.382163980978, 11480.368579728132, 11514.251573647727, 11518.539258429653, 2480.379905023744, 2508.5108403861254, 2514.1954574536157, 2522.3946252899354, 2522.4576716006054, 2372.395039264985, 2383.7854593086618, 2402.3633737059695, 2402.759724027601, 2406.879656017201, 2436.248177806185, 2446.388402899275, 2448.3144719478573, 2486.7264600893886, 2491.327341617762, 2378.2746262389965, 2413.963790543143, 2428.295794219674, 2431.744666809986, 2436.232586735173, 2339.5671800716923, 2350.917717879866, 2359.6814430051895, 2360.881955902198, 2363.869987150706, 11560.132990025782, 11785.705357366049, 11789.941050294694, 11799.528018879235, 11801.0, 5815.796447124372, 5923.259592550931, 5953.642781433085, 5961.225040744719, 5963.403659634002, 3440.569928758905, 3449.896503104911, 3502.1419752160627, 3527.1887465882733, 3569.1790888095884, 1326.2559733949824, 1334.379513526215, 1361.9523316683967, 1374.8556401577791, 1381.1436909116312, 14822.888283378681, 14831.851681483155, 17137.91431042837, 17450.0, 17595.824041759548, 4932.235503496964, 4988.501149885055, 5029.06962211992, 5122.692638441706, 5135.820246291437, 10872.293300935415, 11123.27698699582, 12635.0, 13395.397207125703, 13398.330083495786, 6070.817875463743, 6283.497320214463, 6297.685115744194, 6299.874002519924, 6310.05349197624, 5786.218860453869, 5799.072148456226, 5827.504662103769, 5829.5044921181325, 5850.0, 4210.915781684411, 4253.468316460442, 4300.182965236595, 4349.391085248068, 4353.172897149531, 1051.4322265976286, 1052.5159525069614, 1066.8399740039056, 1072.8337107748155, 1073.061071562383, 1015.2030655935056, 1022.3405903192548, 1025.108155904368, 1035.9119474844572, 1041.286718597763, 7051.92948070523, 7303.525270857377, 7342.816429589303, 7408.925910740823, 7555.16893141754, 1021.4126877045728, 1029.562435964712, 1036.5439206749006, 1052.8052310322614, 1078.7788503356794, 4651.3023046543285, 4673.836415725434, 4735.408073990751, 4804.327394164819, 4874.95125048745, 14444.205568693613, 15104.622384440258, 15110.244487775568, 15143.697126057417, 15144.318505667272, 13864.861351386357, 14416.85583144176, 14880.107193568421, 14929.776053358992, 14992.250387480583, 10664.306820056672, 10861.891381086247, 10897.455127243606, 10905.890941090487, 10910.127189824954, 7337.0828646419195, 7545.207753186056, 7755.0, 7825.647845846836, 7846.372290216883, 13295.268760218281, 13489.865101348862, 13492.380914289955, 13527.458901644217, 13563.050586458854, 11796.587119450778, 13763.793543097061, 13814.930925345308, 13990.580282591538, 14176.645583860485, 8939.508327042075, 9992.250581206585, 10045.397276163454, 10125.139363154214, 10134.746631334276, 11332.376719280519, 11389.0, 11424.200305978502, 11431.657050288171, 11438.542458301576, 9529.761755956157, 9591.9040809591, 9614.086661767122, 9617.182539484222, 9766.0, 9187.402818816756, 9334.906650933404, 9358.859617105885, 9454.0, 9727.9027209727, 8965.910340896507, 8991.0, 9028.729138125867, 9034.186923176945, 9148.908510915071, 6631.436327911989, 6763.289854565397, 6807.89788153188, 6841.452683785185, 6910.654467276717, 6783.660816959231, 6812.386885180357, 6831.863362732817, 6859.108315918898, 6911.032455456139], "value": 5520.401844151362, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.37572138906086, 432.2932006169913, 435.16882753939973, 435.8496318770023, 436.6310467654832, 5103.668261562996, 5111.744412779365, 5189.195674670423, 5194.272801807745, 5195.142801437768, 4836.395450568679, 5097.5157360050825, 5122.974385128078, 5151.871203219921, 5170.4312525622245, 4220.860367700719, 4258.488981322245, 4264.722793018459, 4287.7856107194675, 4295.140971805636, 4278.229918614648, 4306.418633484486, 4320.65434765218, 4332.523422423531, 4336.7181133226395, 4322.7406355618605, 4339.783010849461, 4345.391645169679, 4349.151915376503, 4360.672949528782, 4137.834486620532, 4310.3965444837595, 4322.011874537717, 4334.371516130175, 4396.450443694538, 4087.5299340575916, 4089.161721847014, 4104.774237416941, 4125.381192821071, 4134.193832202722, 5019.472955339674, 5046.924296135561, 5058.305467668336, 5076.873078173038, 5099.515546023122, 4743.857684269477, 4969.180085285923, 4985.651004429691, 5019.222020586815, 5043.848684539433, 5338.211699080813, 5356.38401583819, 5368.1679339702405, 5370.194470829407, 5379.488948549882, 4468.19572476954, 4522.547745225484, 4523.36672865799, 4546.636269098464, 4564.748938808364, 5514.944850551483, 5586.396774080695, 5587.161925711135, 5629.0, 5690.4025077367105, 4613.65397595175, 4621.676482646182, 4624.213883639789, 4625.676202665848, 4659.813607455664, 4680.46174689915, 4702.31816386622, 4702.659741973521, 4714.740689262055, 4718.4809670936165, 4874.319124481521, 4925.285833554186, 4928.827491037797, 4930.235813448921, 5009.423916249605, 5356.90183512379, 5365.731713414391, 5378.354597448331, 5409.594280428905, 5424.430434804368, 1596.5449846793608, 1614.2413065859027, 1631.4534630898781, 1639.401618409272, 1643.5126210779265, 1235.4502246500401, 1260.7100366915477, 1268.2580690296095, 1273.3505911984769, 1283.9471633260823, 5369.831799238468, 5394.865128371744, 5397.8380648580605, 5427.294451721251, 5439.102548079522, 5281.943611277759, 5552.278203833556, 5562.0, 5576.191452239403, 5640.605157639008, 5372.838814835562, 5390.649607775482, 5449.6730196188355, 5452.236686863842, 5468.4531546845, 2789.6373471448583, 2907.8400687961944, 2912.9854350728533, 2924.5174546200064, 2937.55936609506, 5780.393058728857, 5804.303483581997, 5804.332501762351, 5820.767169313265, 5825.126231065374, 5292.338457692788, 5441.755121019563, 5602.187682785973, 5647.181158731961, 5659.2456338535185, 5567.832965011056, 5667.829965101054, 5734.6845923473775, 5762.867738936537, 5770.201452295633, 5399.541039011728, 5401.648892821954, 5456.881339325508, 5478.439014640357, 5539.390667026704, 5332.440093790251, 5336.359636843604, 5392.6225164239695, 5404.702741349263, 5423.345879506788, 5676.4323567642905, 5702.287214098238, 5710.6300885132205, 5730.853829234086, 5738.799142030009, 4464.013513986245, 4546.204414227563, 4552.499225085172, 4590.517995610413, 4644.953550464452, 5492.697901615449, 5502.80740174092, 5516.731151835181, 5561.221429000024, 5565.248691426606, 5387.191921211849, 5392.793620975645, 5395.244665746877, 5398.866238090045, 5412.891742165213, 5185.844424667266, 5329.866753331198, 5411.428457218217, 5419.783208671766, 5460.372057213472, 5301.701083234632, 5340.5460535853335, 5351.5451186648015, 5360.919586206288, 5366.436524164907, 5310.1149092071755, 5314.362276526687, 5394.2987411637805, 5412.269343638716, 5414.593905457185, 5027.3464449621315, 5307.814226502054, 5330.173823057432, 5349.679019258857, 5370.4629537045985], "value": 4356.73824471619, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.0, 843.9704610338639, 900.85586306191, 914.8627705844118, 929.7954450020995, 16345.591360216, 16969.151542422875, 17320.653586928285, 17585.7362139568, 18094.0, 14773.48292809752, 14948.925255373708, 15137.621559460991, 16616.66766664666, 16806.159692015382, 845.7758693946109, 861.9525926074064, 874.7288340614398, 877.9868301975444, 881.8500854854658, 892.6027917576681, 894.0433735902554, 898.2006014646969, 898.9550522473883, 899.2626046641757, 944.5324564340661, 946.280826571807, 946.7396465971844, 946.8343039968013, 946.9005754395793, 931.0410277414275, 938.9154976052188, 939.4081728511063, 939.7556635274843, 939.8684184214216, 684.3669605614837, 684.5584597934354, 684.8698747238009, 684.934931181537, 685.4413652872893, 15847.920760396124, 15971.281292341873, 16012.759808602881, 17723.113844307733, 18016.819831801644, 15442.382304707799, 15523.379064837392, 15633.0, 15919.522414327588, 16149.515514534583, 13006.219626822327, 13262.270575118364, 13470.52853150135, 13473.393697283645, 13540.932295338558, 3910.393888947189, 3979.522457305142, 4005.2790497710403, 4075.7350772200007, 4195.811188496525, 49990.25014624783, 50109.74945125287, 53752.19371709428, 69637.30362696359, 84111.0, 11014.559417623206, 12153.756924861453, 12505.93747031259, 12579.023991384633, 12707.682307942376, 22172.667409988862, 22347.55304893893, 22496.21263255811, 22590.661140082913, 22690.432739181324, 8665.740027799176, 8684.43551169172, 8747.475151490931, 8827.955860220658, 8951.865722014176, 4939.2838038484215, 5098.260752190911, 5102.464241254689, 5116.9744151279, 5220.947790522122, 3627.3108109459117, 3669.486271921933, 3680.35593771089, 3683.1528748387486, 3721.330160571069, 596.7702434562725, 600.7717067514317, 608.8082254089948, 615.2340336281359, 615.3415845045758, 763.4808330335314, 765.6210175962823, 767.1982777997007, 772.8917951486796, 781.1524495921989, 10465.476726163814, 11036.944815276032, 11056.336619802838, 11633.360165190827, 11762.823557646641, 697.7243988624465, 714.5391222661355, 716.4340171264747, 719.3058698356007, 721.5273995532934, 5144.459831717691, 5292.444293349143, 5621.381648018714, 5850.5612079094235, 6029.758809647653, 80366.19633803586, 80883.0, 81073.59463202764, 81201.0, 83834.58082709547, 70582.64708676527, 70591.6470417655, 71152.2884771156, 71657.64171179215, 73450.0, 65657.08547132321, 66775.66612166908, 66805.0, 67458.66270668615, 68341.65829170922, 11710.70723231926, 11797.115216358636, 11826.940865295619, 12044.879551204376, 12137.514499420278, 42459.575404246796, 42915.0, 43576.0, 43921.0, 44422.3336649944, 51539.22691159711, 51722.48277517177, 52069.739651301505, 53209.733951331546, 54437.0, 13444.529441469502, 13445.663858403226, 13481.730365392834, 13568.321583920962, 13614.52349167814, 14742.189179595225, 14861.108333500024, 14929.402823886923, 15104.471343502924, 15206.847931520986, 16000.839991599934, 16019.519414417586, 16279.267432965782, 16423.42518011864, 17415.042172680118, 15247.542573722805, 15351.61620959485, 15629.921850390676, 15862.85303973191, 16018.27917743681, 13869.861301386856, 14283.42866285337, 14398.784018239945, 14918.104913705212, 14941.85058149448, 9293.581788819654, 9388.483633399956, 9435.150836424755, 9480.758936537215, 9619.0, 11529.654110376701, 11563.826542601699, 11572.884271157182, 11641.301521908712, 11692.298462092302], "value": 7697.777999184607, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1454.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 112.0, 112.0, 112.0, 114.0, 114.0, 113.0, 110.0, 112.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 117.0, 115.0, 160.0, 117.0, 116.0, 115.0, 116.0, 137.0, 117.0], "value": 125.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 162.0, 161.0, 161.0, 160.0, 161.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 104.0, 77.0, 77.0, 76.0, 76.0, 103.0, 77.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 107.0, 81.0, 82.0, 81.0, 94.0, 82.0, 82.0, 109.0], "value": 88.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 113.0, 113.0, 114.0, 114.0, 114.0, 113.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 93.0, 93.0, 93.0, 94.0, 94.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 53.0, 54.0, 54.0, 53.0, 56.0, 53.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 54.0, 54.0, 54.0, 54.0, 54.0, 53.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 86.0, 78.0, 83.0, 75.0, 80.0, 81.0, 82.0, 74.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 121.0, 123.0, 119.0, 129.0, 138.0, 118.0, 118.0, 160.0, 121.0], "value": 127.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 158.0, 156.0, 161.0, 162.0, 163.0, 157.0, 160.0, 162.0, 161.0], "value": 160.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 60.0, 60.0, 61.0, 59.0, 59.0, 69.0, 59.0, 58.0], "value": 60.4, "unit": "score"}]}]} 03:17:53 INFO - Return code: 0 03:17:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:17:53 ERROR - # TBPL SUCCESS # 03:17:53 INFO - Running post-action listener: _resource_record_post_action 03:17:53 INFO - [mozharness: 2017-04-18 10:17:53.129906Z] Finished run-tests step (success) 03:17:53 INFO - Running post-run listener: _resource_record_post_run 03:17:53 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 367370240; Read time: 16; Write time: 334672 03:17:53 INFO - TinderboxPrint: CPU usage
13.1% 03:17:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 03:17:53 INFO - TinderboxPrint: I/O write bytes / time
367,370,240 / 334,672 03:17:53 INFO - TinderboxPrint: CPU idle
8,269.0 (86.8%) 03:17:53 INFO - TinderboxPrint: CPU user
1,205.1 (12.7%) 03:17:53 INFO - TinderboxPrint: Swap in / out
0 / 0 03:17:53 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110346240; Read time: 0; Write time: 135868 03:17:53 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 254939136; Read time: 16; Write time: 198532 03:17:53 INFO - Running post-run listener: _upload_blobber_files 03:17:53 INFO - Blob upload gear active. 03:17:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:17: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 03:17: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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:17: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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:17:54 INFO - (blobuploader) - INFO - Open directory for files ... 03:17:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:17:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:17:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:17:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:17:55 INFO - (blobuploader) - INFO - Done attempting. 03:17:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:17:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:17:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:17:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:17:55 INFO - (blobuploader) - INFO - Done attempting. 03:17:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:17:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:17:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:17:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:17:58 INFO - (blobuploader) - INFO - Done attempting. 03:17:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:17:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:17:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:17:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:17:59 INFO - (blobuploader) - INFO - Done attempting. 03:17:59 INFO - (blobuploader) - INFO - Iteration through files over. 03:17:59 INFO - Return code: 0 03:17:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:17:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:17:59 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1e6d2e58687e0bba6ff53d18a1f04d6c0724e2f09436c2ca714b3aa160b5edf53dbab7af4bd5065fd820e4972ebc046b730c04106154b32408087a55cfa6856", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b68b670459476b501c50b43474f6e7608067de5ca9f92934f66839f8c516b100bb03d9b283c78a4d41272ff1a52468b75fe5a5d67418771c63181ba02b526d1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b676c12c9cf5d1529a2589e64971508c4b3691dec077f5f126a71b03c684e418e8e8277ae0f042019d6e5fc90a5ad2d61592b9eb5f667c0c1442e0c625837fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be33acbfeed5c096da6ff0971e219d67f4312ec039d3673a688e85aeda45ee428706f67ac4940efffbe0cf75efb919703563dbea48ece85dcca9dfd96b2c481e"} 03:17:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:17:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:17:59 INFO - Contents: 03:17:59 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1e6d2e58687e0bba6ff53d18a1f04d6c0724e2f09436c2ca714b3aa160b5edf53dbab7af4bd5065fd820e4972ebc046b730c04106154b32408087a55cfa6856", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b68b670459476b501c50b43474f6e7608067de5ca9f92934f66839f8c516b100bb03d9b283c78a4d41272ff1a52468b75fe5a5d67418771c63181ba02b526d1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b676c12c9cf5d1529a2589e64971508c4b3691dec077f5f126a71b03c684e418e8e8277ae0f042019d6e5fc90a5ad2d61592b9eb5f667c0c1442e0c625837fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be33acbfeed5c096da6ff0971e219d67f4312ec039d3673a688e85aeda45ee428706f67ac4940efffbe0cf75efb919703563dbea48ece85dcca9dfd96b2c481e"} 03:17:59 INFO - Running post-run listener: copy_logs_to_upload_dir 03:17:59 INFO - Copying logs to upload dir... 03:17:59 INFO - mkdir: /builds/slave/test/build/upload/logs 03:17:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.809901 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-04-18 03:17:59.192361) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 03:17:59.195360) ========= 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=826874ccc97bd7bf541b4875000001d5-1492509426.52743-702675126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1e6d2e58687e0bba6ff53d18a1f04d6c0724e2f09436c2ca714b3aa160b5edf53dbab7af4bd5065fd820e4972ebc046b730c04106154b32408087a55cfa6856", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b68b670459476b501c50b43474f6e7608067de5ca9f92934f66839f8c516b100bb03d9b283c78a4d41272ff1a52468b75fe5a5d67418771c63181ba02b526d1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b676c12c9cf5d1529a2589e64971508c4b3691dec077f5f126a71b03c684e418e8e8277ae0f042019d6e5fc90a5ad2d61592b9eb5f667c0c1442e0c625837fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be33acbfeed5c096da6ff0971e219d67f4312ec039d3673a688e85aeda45ee428706f67ac4940efffbe0cf75efb919703563dbea48ece85dcca9dfd96b2c481e"} build_url:https://queue.taskcluster.net/v1/task/OhNSSLPQRjmBcrb0lKJjAg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011197 build_url: 'https://queue.taskcluster.net/v1/task/OhNSSLPQRjmBcrb0lKJjAg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1e6d2e58687e0bba6ff53d18a1f04d6c0724e2f09436c2ca714b3aa160b5edf53dbab7af4bd5065fd820e4972ebc046b730c04106154b32408087a55cfa6856", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b68b670459476b501c50b43474f6e7608067de5ca9f92934f66839f8c516b100bb03d9b283c78a4d41272ff1a52468b75fe5a5d67418771c63181ba02b526d1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b676c12c9cf5d1529a2589e64971508c4b3691dec077f5f126a71b03c684e418e8e8277ae0f042019d6e5fc90a5ad2d61592b9eb5f667c0c1442e0c625837fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be33acbfeed5c096da6ff0971e219d67f4312ec039d3673a688e85aeda45ee428706f67ac4940efffbe0cf75efb919703563dbea48ece85dcca9dfd96b2c481e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 03:17:59.221715) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 03:17:59.222482) ========= 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=826874ccc97bd7bf541b4875000001d5-1492509426.52743-702675126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 03:17:59.306092) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 03:17:59.306541) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 03:17:59.306869) ========= ========= Total master_lag: 0.15 =========