builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-020 starttime: 1482197662.26 results: success (0) buildid: 20161219164223 builduid: 2118aee815754f0baf1681ce2055be6a revision: 5182a866ae5ab3558d43c6d348588a1269052b5e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-19 17:34:22.260514) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-19 17:34:22.260985) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-19 17:34:22.263960) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-19 17:34:22.278966) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 17:34:22.279290) ========= 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=af724c981e2a0f424dbabf99000001e7-1482197661.769031-944354883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-19 17:34:22-- 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% 66.8M=0s 2016-12-19 17:34:22 (66.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092752 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 17:34:22.385508) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 17:34:22.386286) ========= 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=af724c981e2a0f424dbabf99000001e7-1482197661.769031-944354883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019530 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 17:34:22.435749) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 17:34:22.436217) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5182a866ae5ab3558d43c6d348588a1269052b5e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5182a866ae5ab3558d43c6d348588a1269052b5e --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=af724c981e2a0f424dbabf99000001e7-1482197661.769031-944354883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-19 17:34:22,691 truncating revision to first 12 chars 2016-12-19 17:34:22,691 Setting DEBUG logging. 2016-12-19 17:34:22,691 attempt 1/10 2016-12-19 17:34:22,691 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5182a866ae5a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-19 17:34:23,007 unpacking tar archive at: mozilla-central-5182a866ae5a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.618500 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 17:34:23.067800) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-19 17:34:23.068117) ========= script_repo_revision: 5182a866ae5ab3558d43c6d348588a1269052b5e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-19 17:34:23.068499) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-19 17:34:23.068764) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-19 17:34:23.076387) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-12-19 17:34:23.076654) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1482197661.769031-944354883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:34:23 INFO - MultiFileLogger online at 20161219 17:34:23 in /builds/slave/test 17:34:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:34:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:34:23 INFO - {'append_to_log': False, 17:34:23 INFO - 'base_work_dir': '/builds/slave/test', 17:34:23 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:34:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:34:23 INFO - 'branch': 'Firefox-Non-PGO', 17:34:23 INFO - 'buildbot_json_path': 'buildprops.json', 17:34:23 INFO - 'config_files': ('talos/linux_config.py',), 17:34:23 INFO - 'default_actions': ('clobber', 17:34:23 INFO - 'read-buildbot-config', 17:34:23 INFO - 'download-and-extract', 17:34:23 INFO - 'populate-webroot', 17:34:23 INFO - 'create-virtualenv', 17:34:23 INFO - 'install', 17:34:23 INFO - 'run-tests'), 17:34:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:34:23 INFO - 'download_minidump_stackwalk': True, 17:34:23 INFO - 'download_symbols': 'ondemand', 17:34:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:34:23 INFO - 'tooltool.py': '/tools/tooltool.py', 17:34:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:34:23 INFO - '/tools/misc-python/virtualenv.py')}, 17:34:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:34:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:34:23 INFO - 'installer_path': 'installer.exe', 17:34:23 INFO - 'log_level': 'info', 17:34:23 INFO - 'log_name': 'talos', 17:34:23 INFO - 'log_to_console': True, 17:34:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:34:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:34:23 INFO - 'opt_config_files': (), 17:34:23 INFO - 'pip_index': False, 17:34:23 INFO - 'sps_profile': False, 17:34:23 INFO - 'sps_profile_interval': 0, 17:34:23 INFO - 'suite': 'dromaeojs', 17:34:23 INFO - 'system_bits': '32', 17:34:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:34:23 INFO - 'title': 'talos-linux64-ix-020', 17:34:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:34:23 INFO - 'use_talos_json': True, 17:34:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:34:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:34:23 INFO - 'work_dir': 'build'} 17:34:23 INFO - [mozharness: 2016-12-20 01:34:23.430756Z] Running clobber step. 17:34:23 INFO - Running pre-action listener: _resource_record_pre_action 17:34:23 INFO - Running main action method: clobber 17:34:23 INFO - rmtree: /builds/slave/test/build 17:34:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:34:23 INFO - Running post-action listener: _resource_record_post_action 17:34:23 INFO - [mozharness: 2016-12-20 01:34:23.890515Z] Finished clobber step (success) 17:34:23 INFO - [mozharness: 2016-12-20 01:34:23.890627Z] Running read-buildbot-config step. 17:34:23 INFO - Running pre-action listener: _resource_record_pre_action 17:34:23 INFO - Running main action method: read_buildbot_config 17:34:23 INFO - Using buildbot properties: 17:34:23 INFO - { 17:34:23 INFO - "project": "", 17:34:23 INFO - "product": "firefox", 17:34:23 INFO - "script_repo_revision": "production", 17:34:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 17:34:23 INFO - "repository": "", 17:34:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 17:34:23 INFO - "buildid": "20161219164223", 17:34:23 INFO - "pgo_build": "False", 17:34:23 INFO - "basedir": "/builds/slave/test", 17:34:23 INFO - "buildnumber": 883, 17:34:23 INFO - "slavename": "talos-linux64-ix-020", 17:34:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:34:23 INFO - "platform": "ubuntu64_hw", 17:34:23 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:34:23 INFO - "branch": "mozilla-central", 17:34:23 INFO - "repo_path": "mozilla-central", 17:34:23 INFO - "revision": "5182a866ae5ab3558d43c6d348588a1269052b5e", 17:34:23 INFO - "stage_platform": "linux64", 17:34:23 INFO - "builduid": "2118aee815754f0baf1681ce2055be6a", 17:34:23 INFO - "slavebuilddir": "test" 17:34:23 INFO - } 17:34:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/JHhvtG3-QMKPBVYId1TylA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 17:34:23 INFO - Running post-action listener: _resource_record_post_action 17:34:23 INFO - [mozharness: 2016-12-20 01:34:23.893128Z] Finished read-buildbot-config step (success) 17:34:23 INFO - [mozharness: 2016-12-20 01:34:23.893218Z] Running download-and-extract step. 17:34:23 INFO - Running pre-action listener: _resource_record_pre_action 17:34:23 INFO - Running main action method: download_and_extract 17:34:23 INFO - mkdir: /builds/slave/test/build/tests 17:34:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:23 INFO - trying https://queue.taskcluster.net/v1/task/JHhvtG3-QMKPBVYId1TylA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 17:34:23 INFO - Downloading https://queue.taskcluster.net/v1/task/JHhvtG3-QMKPBVYId1TylA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 17:34:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JHhvtG3-QMKPBVYId1TylA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:34:24 INFO - Downloaded 1361 bytes. 17:34:24 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 17:34:24 INFO - Using the following test package requirements: 17:34:24 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 17:34:24 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:34:24 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:34:24 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:34:24 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:34:24 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:34:24 INFO - u'jsshell-linux-x86_64.zip'], 17:34:24 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:34:24 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:34:24 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 17:34:24 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:34:24 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:34:24 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:34:24 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:34:24 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:34:24 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:34:24 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:34:24 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:34:24 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:34:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JHhvtG3-QMKPBVYId1TylA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 17:34:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JHhvtG3-QMKPBVYId1TylA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:34:24 INFO - Fetch https://queue.taskcluster.net/v1/task/JHhvtG3-QMKPBVYId1TylA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:34:25 INFO - Expected file size: 20258245 17:34:25 INFO - Obtained file size: 20258245 17:34:29 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:34:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JHhvtG3-QMKPBVYId1TylA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 17:34:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JHhvtG3-QMKPBVYId1TylA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:34:29 INFO - Fetch https://queue.taskcluster.net/v1/task/JHhvtG3-QMKPBVYId1TylA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:34:30 INFO - Expected file size: 20258245 17:34:30 INFO - Obtained file size: 20258245 17:34:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JHhvtG3-QMKPBVYId1TylA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 17:34:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JHhvtG3-QMKPBVYId1TylA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:34:34 INFO - Fetch https://queue.taskcluster.net/v1/task/JHhvtG3-QMKPBVYId1TylA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 17:34:35 INFO - Expected file size: 14409734 17:34:35 INFO - Obtained file size: 14409734 17:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:35 INFO - trying https://queue.taskcluster.net/v1/task/JHhvtG3-QMKPBVYId1TylA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 17:34:35 INFO - Downloading https://queue.taskcluster.net/v1/task/JHhvtG3-QMKPBVYId1TylA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 17:34:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JHhvtG3-QMKPBVYId1TylA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:34:36 INFO - Downloaded 55624586 bytes. 17:34:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JHhvtG3-QMKPBVYId1TylA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 17:34:36 INFO - mkdir: /builds/slave/test/properties 17:34:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:34:36 INFO - Writing to file /builds/slave/test/properties/build_url 17:34:36 INFO - Contents: 17:34:36 INFO - build_url:https://queue.taskcluster.net/v1/task/JHhvtG3-QMKPBVYId1TylA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 17:34:37 INFO - Running post-action listener: _resource_record_post_action 17:34:37 INFO - Running post-action listener: set_extra_try_arguments 17:34:37 INFO - [mozharness: 2016-12-20 01:34:37.395423Z] Finished download-and-extract step (success) 17:34:37 INFO - [mozharness: 2016-12-20 01:34:37.395651Z] Running populate-webroot step. 17:34:37 INFO - Running pre-action listener: _resource_record_pre_action 17:34:37 INFO - Running main action method: populate_webroot 17:34:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:34:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:34:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:34:37 INFO - '--tppagecycles', 17:34:37 INFO - '7'], 17:34:37 INFO - 'tests': ['tsvgm']}}, 17:34:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:34:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:34:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:34:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:34:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:34:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:34:37 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:34:37 INFO - 'talos_options': ['--disable-e10s'], 17:34:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:34:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:34:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:34:37 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:34:37 INFO - 'talos_options': ['--disable-e10s'], 17:34:37 INFO - 'tests': ['damp', 'tps']}, 17:34:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:34:37 INFO - 'tests': ['damp', 'tps']}, 17:34:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:34:37 INFO - 'tests': ['dromaeo_dom']}, 17:34:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:34:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:34:37 INFO - 'tests': ['basic_compositor_video']}, 17:34:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:34:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:34:37 INFO - 'tests': ['a11yr', 17:34:37 INFO - 'ts_paint', 17:34:37 INFO - 'tpaint', 17:34:37 INFO - 'sessionrestore', 17:34:37 INFO - 'sessionrestore_no_auto_restore', 17:34:37 INFO - 'tabpaint']}, 17:34:37 INFO - 'other-e10s': {'tests': ['a11yr', 17:34:37 INFO - 'ts_paint', 17:34:37 INFO - 'tpaint', 17:34:37 INFO - 'sessionrestore', 17:34:37 INFO - 'sessionrestore_no_auto_restore', 17:34:37 INFO - 'tabpaint']}, 17:34:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:34:37 INFO - 'ts_paint', 17:34:37 INFO - 'tpaint', 17:34:37 INFO - 'sessionrestore', 17:34:37 INFO - 'sessionrestore_no_auto_restore', 17:34:37 INFO - 'tabpaint']}, 17:34:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:34:37 INFO - 'ts_paint', 17:34:37 INFO - 'tpaint', 17:34:37 INFO - 'sessionrestore', 17:34:37 INFO - 'sessionrestore_no_auto_restore', 17:34:37 INFO - 'tabpaint']}, 17:34:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:34:37 INFO - 'tests': ['a11yr', 17:34:37 INFO - 'ts_paint', 17:34:37 INFO - 'tpaint', 17:34:37 INFO - 'sessionrestore', 17:34:37 INFO - 'sessionrestore_no_auto_restore', 17:34:37 INFO - 'tabpaint']}, 17:34:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:34:37 INFO - 'tests': ['a11yr', 17:34:37 INFO - 'ts_paint', 17:34:37 INFO - 'tpaint', 17:34:37 INFO - 'sessionrestore', 17:34:37 INFO - 'sessionrestore_no_auto_restore', 17:34:37 INFO - 'tabpaint']}, 17:34:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:34:37 INFO - 'tests': ['tsvgx', 17:34:37 INFO - 'tsvgr_opacity', 17:34:37 INFO - 'tart', 17:34:37 INFO - 'tscrollx', 17:34:37 INFO - 'cart', 17:34:37 INFO - 'tsvg_static']}, 17:34:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:34:37 INFO - 'tsvgr_opacity', 17:34:37 INFO - 'tart', 17:34:37 INFO - 'tscrollx', 17:34:37 INFO - 'cart', 17:34:37 INFO - 'tsvg_static']}, 17:34:37 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:34:37 INFO - 'talos_options': ['--disable-e10s'], 17:34:37 INFO - 'tests': ['tp5o']}, 17:34:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:34:37 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:34:37 INFO - 'talos_options': ['--disable-e10s', 17:34:37 INFO - '--xperf_path', 17:34:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:34:37 INFO - 'tests': ['tp5n']}, 17:34:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:34:37 INFO - 'talos_options': ['--xperf_path', 17:34:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:34:37 INFO - 'tests': ['tp5n']}}, 17:34:37 INFO - 'talos.zip': {'path': '', 17:34:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:34:37 INFO - Running post-action listener: _resource_record_post_action 17:34:37 INFO - [mozharness: 2016-12-20 01:34:37.415769Z] Finished populate-webroot step (success) 17:34:37 INFO - [mozharness: 2016-12-20 01:34:37.415858Z] Running create-virtualenv step. 17:34:37 INFO - Running pre-action listener: _resource_record_pre_action 17:34:37 INFO - Running main action method: create_virtualenv 17:34:37 INFO - Creating virtualenv /builds/slave/test/build/venv 17:34: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 17:34:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:34:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:34:37 INFO - Using real prefix '/usr' 17:34:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:34:38 INFO - Installing distribute.............................................................................................................................................................................................done. 17:34:39 INFO - Installing pip.................done. 17:34:39 INFO - Return code: 0 17:34:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:34:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:34:40 INFO - Reading from file tmpfile_stdout 17:34:40 INFO - Output received: 17:34:40 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) 17:34:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:34: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')]} 17:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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')]} 17:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x191b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16850>, '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 0x1c8b6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8bb60>, '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': 'af724c981e2a0f424dbabf99000001e7-1482197661.769031-944354883', '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 17:34: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', 'pip>=1.5'] in /builds/slave/test/build 17:34: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 pip>=1.5 17:34:40 INFO - Using env: {'DISPLAY': ':0', 17:34:40 INFO - 'HOME': '/home/cltbld', 17:34:40 INFO - 'LANG': 'en_US.UTF-8', 17:34:40 INFO - 'LANGUAGE': 'en_US:en', 17:34:40 INFO - 'LOGNAME': 'cltbld', 17:34:40 INFO - 'MAIL': '/var/mail/cltbld', 17:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:40 INFO - 'MOZ_NO_REMOTE': '1', 17:34:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:40 INFO - 'NO_EM_RESTART': '1', 17:34:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:40 INFO - 'PWD': '/builds/slave/test', 17:34:40 INFO - 'SHELL': '/bin/bash', 17:34:40 INFO - 'SHLVL': '1', 17:34:40 INFO - 'TERM': 'linux', 17:34:40 INFO - 'TMOUT': '86400', 17:34:40 INFO - 'USER': 'cltbld', 17:34:40 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482197661.769031-944354883', 17:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:40 INFO - '_': '/tools/buildbot/bin/python'} 17:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34: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 17:34:40 INFO - Cleaning up... 17:34:40 INFO - Return code: 0 17:34:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:34: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')]} 17:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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')]} 17:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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 0x191b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16850>, '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 0x1c8b6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8bb60>, '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': 'af724c981e2a0f424dbabf99000001e7-1482197661.769031-944354883', '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 17:34: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 17:34: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 17:34:40 INFO - Using env: {'DISPLAY': ':0', 17:34:40 INFO - 'HOME': '/home/cltbld', 17:34:40 INFO - 'LANG': 'en_US.UTF-8', 17:34:40 INFO - 'LANGUAGE': 'en_US:en', 17:34:40 INFO - 'LOGNAME': 'cltbld', 17:34:40 INFO - 'MAIL': '/var/mail/cltbld', 17:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:40 INFO - 'MOZ_NO_REMOTE': '1', 17:34:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:40 INFO - 'NO_EM_RESTART': '1', 17:34:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:40 INFO - 'PWD': '/builds/slave/test', 17:34:40 INFO - 'SHELL': '/bin/bash', 17:34:40 INFO - 'SHLVL': '1', 17:34:40 INFO - 'TERM': 'linux', 17:34:40 INFO - 'TMOUT': '86400', 17:34:40 INFO - 'USER': 'cltbld', 17:34:40 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482197661.769031-944354883', 17:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:40 INFO - '_': '/tools/buildbot/bin/python'} 17:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:40 INFO - Downloading/unpacking psutil>=3.1.1 17:34: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 17:34: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 17:34: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 17:34: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 17:34: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 17:34: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 17:34:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:34:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:34:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:34:42 INFO - Installing collected packages: psutil 17:34:42 INFO - Running setup.py install for psutil 17:34:42 INFO - building 'psutil._psutil_linux' extension 17:34: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 17:34: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 17:34:42 INFO - building 'psutil._psutil_posix' extension 17:34: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 17:34:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:34:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:34:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:34:43 INFO - Successfully installed psutil 17:34:43 INFO - Cleaning up... 17:34:43 INFO - Return code: 0 17:34:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:34: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')]} 17:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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')]} 17:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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 0x191b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16850>, '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 0x1c8b6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8bb60>, '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': 'af724c981e2a0f424dbabf99000001e7-1482197661.769031-944354883', '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 17:34: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 17:34: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 17:34:43 INFO - Using env: {'DISPLAY': ':0', 17:34:43 INFO - 'HOME': '/home/cltbld', 17:34:43 INFO - 'LANG': 'en_US.UTF-8', 17:34:43 INFO - 'LANGUAGE': 'en_US:en', 17:34:43 INFO - 'LOGNAME': 'cltbld', 17:34:43 INFO - 'MAIL': '/var/mail/cltbld', 17:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:43 INFO - 'MOZ_NO_REMOTE': '1', 17:34:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:43 INFO - 'NO_EM_RESTART': '1', 17:34:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:43 INFO - 'PWD': '/builds/slave/test', 17:34:43 INFO - 'SHELL': '/bin/bash', 17:34:43 INFO - 'SHLVL': '1', 17:34:43 INFO - 'TERM': 'linux', 17:34:43 INFO - 'TMOUT': '86400', 17:34:43 INFO - 'USER': 'cltbld', 17:34:43 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482197661.769031-944354883', 17:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:43 INFO - '_': '/tools/buildbot/bin/python'} 17:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:34: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 17:34: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 17:34: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 17:34: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 17:34: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 17:34: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 17:34:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:34:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:34:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:34:45 INFO - Installing collected packages: mozsystemmonitor 17:34:45 INFO - Running setup.py install for mozsystemmonitor 17:34:45 INFO - Successfully installed mozsystemmonitor 17:34:45 INFO - Cleaning up... 17:34:45 INFO - Return code: 0 17:34:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:34: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')]} 17:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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')]} 17:34:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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 0x191b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16850>, '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 0x1c8b6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8bb60>, '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': 'af724c981e2a0f424dbabf99000001e7-1482197661.769031-944354883', '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 17:34: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 17:34: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 17:34:45 INFO - Using env: {'DISPLAY': ':0', 17:34:45 INFO - 'HOME': '/home/cltbld', 17:34:45 INFO - 'LANG': 'en_US.UTF-8', 17:34:45 INFO - 'LANGUAGE': 'en_US:en', 17:34:45 INFO - 'LOGNAME': 'cltbld', 17:34:45 INFO - 'MAIL': '/var/mail/cltbld', 17:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:45 INFO - 'MOZ_NO_REMOTE': '1', 17:34:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:45 INFO - 'NO_EM_RESTART': '1', 17:34:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:45 INFO - 'PWD': '/builds/slave/test', 17:34:45 INFO - 'SHELL': '/bin/bash', 17:34:45 INFO - 'SHLVL': '1', 17:34:45 INFO - 'TERM': 'linux', 17:34:45 INFO - 'TMOUT': '86400', 17:34:45 INFO - 'USER': 'cltbld', 17:34:45 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482197661.769031-944354883', 17:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:45 INFO - '_': '/tools/buildbot/bin/python'} 17:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:45 INFO - Downloading/unpacking jsonschema==2.5.1 17:34: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 17:34: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 17:34: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 17:34: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 17:34: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 17:34: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 17:34:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:34:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:34: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 17:34: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 17:34: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 17:34: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 17:34: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 17:34: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 17:34:48 INFO - Downloading functools32-3.2.3-2.tar.gz 17:34:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:34:48 INFO - warning: no files found matching '*.txt' 17:34:48 INFO - no previously-included directories found matching 'build' 17:34:48 INFO - no previously-included directories found matching 'dist' 17:34:48 INFO - no previously-included directories found matching '.git*' 17:34:48 INFO - Installing collected packages: jsonschema, functools32 17:34:48 INFO - Running setup.py install for functools32 17:34:48 INFO - warning: no files found matching '*.txt' 17:34:48 INFO - no previously-included directories found matching 'build' 17:34:48 INFO - no previously-included directories found matching 'dist' 17:34:48 INFO - no previously-included directories found matching '.git*' 17:34:48 INFO - Successfully installed jsonschema functools32 17:34:48 INFO - Cleaning up... 17:34:48 INFO - Return code: 0 17:34:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:34: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')]} 17:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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')]} 17:34:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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 0x191b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16850>, '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 0x1c8b6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8bb60>, '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': 'af724c981e2a0f424dbabf99000001e7-1482197661.769031-944354883', '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 17:34: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 17:34: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 17:34:48 INFO - Using env: {'DISPLAY': ':0', 17:34:48 INFO - 'HOME': '/home/cltbld', 17:34:48 INFO - 'LANG': 'en_US.UTF-8', 17:34:48 INFO - 'LANGUAGE': 'en_US:en', 17:34:48 INFO - 'LOGNAME': 'cltbld', 17:34:48 INFO - 'MAIL': '/var/mail/cltbld', 17:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:48 INFO - 'MOZ_NO_REMOTE': '1', 17:34:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:48 INFO - 'NO_EM_RESTART': '1', 17:34:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:48 INFO - 'PWD': '/builds/slave/test', 17:34:48 INFO - 'SHELL': '/bin/bash', 17:34:48 INFO - 'SHLVL': '1', 17:34:48 INFO - 'TERM': 'linux', 17:34:48 INFO - 'TMOUT': '86400', 17:34:48 INFO - 'USER': 'cltbld', 17:34:48 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482197661.769031-944354883', 17:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:48 INFO - '_': '/tools/buildbot/bin/python'} 17:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:34:48 INFO - Cleaning up... 17:34:48 INFO - Return code: 0 17:34:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:34: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')]} 17:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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')]} 17:34:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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 0x191b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16850>, '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 0x1c8b6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8bb60>, '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': 'af724c981e2a0f424dbabf99000001e7-1482197661.769031-944354883', '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 17:34: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 17:34: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 17:34:48 INFO - Using env: {'DISPLAY': ':0', 17:34:48 INFO - 'HOME': '/home/cltbld', 17:34:48 INFO - 'LANG': 'en_US.UTF-8', 17:34:48 INFO - 'LANGUAGE': 'en_US:en', 17:34:48 INFO - 'LOGNAME': 'cltbld', 17:34:48 INFO - 'MAIL': '/var/mail/cltbld', 17:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:48 INFO - 'MOZ_NO_REMOTE': '1', 17:34:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:48 INFO - 'NO_EM_RESTART': '1', 17:34:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:48 INFO - 'PWD': '/builds/slave/test', 17:34:48 INFO - 'SHELL': '/bin/bash', 17:34:48 INFO - 'SHLVL': '1', 17:34:48 INFO - 'TERM': 'linux', 17:34:48 INFO - 'TMOUT': '86400', 17:34:48 INFO - 'USER': 'cltbld', 17:34:48 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482197661.769031-944354883', 17:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:48 INFO - '_': '/tools/buildbot/bin/python'} 17:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:48 INFO - Downloading/unpacking blobuploader==1.2.4 17:34: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 17:34: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 17:34: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 17:34: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 17:34: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 17:34: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 17:34:50 INFO - Downloading blobuploader-1.2.4.tar.gz 17:34:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:34:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:34: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 17:34: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 17:34: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 17:34: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 17:34: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 17:34: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 17:34:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:34:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:34: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 17:34: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 17:34: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 17:34: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 17:34: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 17:34: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 17:34:51 INFO - Downloading docopt-0.6.1.tar.gz 17:34:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:34:51 INFO - Installing collected packages: blobuploader, requests, docopt 17:34:51 INFO - Running setup.py install for blobuploader 17:34:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:34:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:34:51 INFO - Running setup.py install for requests 17:34:52 INFO - Running setup.py install for docopt 17:34:52 INFO - Successfully installed blobuploader requests docopt 17:34:52 INFO - Cleaning up... 17:34:52 INFO - Return code: 0 17:34:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:34: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')]} 17:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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')]} 17:34:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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 0x191b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16850>, '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 0x1c8b6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8bb60>, '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': 'af724c981e2a0f424dbabf99000001e7-1482197661.769031-944354883', '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 17:34: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 17:34: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 17:34:52 INFO - Using env: {'DISPLAY': ':0', 17:34:52 INFO - 'HOME': '/home/cltbld', 17:34:52 INFO - 'LANG': 'en_US.UTF-8', 17:34:52 INFO - 'LANGUAGE': 'en_US:en', 17:34:52 INFO - 'LOGNAME': 'cltbld', 17:34:52 INFO - 'MAIL': '/var/mail/cltbld', 17:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:52 INFO - 'MOZ_NO_REMOTE': '1', 17:34:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:52 INFO - 'NO_EM_RESTART': '1', 17:34:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:52 INFO - 'PWD': '/builds/slave/test', 17:34:52 INFO - 'SHELL': '/bin/bash', 17:34:52 INFO - 'SHLVL': '1', 17:34:52 INFO - 'TERM': 'linux', 17:34:52 INFO - 'TMOUT': '86400', 17:34:52 INFO - 'USER': 'cltbld', 17:34:52 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482197661.769031-944354883', 17:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:52 INFO - '_': '/tools/buildbot/bin/python'} 17:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:34:52 INFO - Running setup.py (path:/tmp/pip-Vk3cpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:34:52 INFO - Running setup.py (path:/tmp/pip-gGtxI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:34:52 INFO - Running setup.py (path:/tmp/pip-BkuYWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:34:52 INFO - Running setup.py (path:/tmp/pip-LIWpsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:34:52 INFO - Running setup.py (path:/tmp/pip-rmyQhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:34:52 INFO - Running setup.py (path:/tmp/pip-cHy_WK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:34:52 INFO - Running setup.py (path:/tmp/pip-ygAQf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:34:53 INFO - Running setup.py (path:/tmp/pip-YwJIE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:34:53 INFO - Running setup.py (path:/tmp/pip-osyrrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:34:53 INFO - Running setup.py (path:/tmp/pip-agfV1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:34:53 INFO - Running setup.py (path:/tmp/pip-AEieXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:34:53 INFO - Running setup.py (path:/tmp/pip-45DB3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:34:53 INFO - Running setup.py (path:/tmp/pip-3WHPzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:34:53 INFO - Running setup.py (path:/tmp/pip-PWtsTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:34:53 INFO - Running setup.py (path:/tmp/pip-2YqdMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:34:53 INFO - Running setup.py (path:/tmp/pip-msZKAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:34:53 INFO - Running setup.py (path:/tmp/pip-33oGZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:34:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:34:53 INFO - Running setup.py install for manifestparser 17:34:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:34:53 INFO - Running setup.py install for mozcrash 17:34:53 INFO - Running setup.py install for mozdebug 17:34:54 INFO - Running setup.py install for mozdevice 17:34:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:34:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:34:54 INFO - Running setup.py install for mozfile 17:34:54 INFO - Running setup.py install for mozhttpd 17:34:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:34:54 INFO - Running setup.py install for mozinfo 17:34:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:34:54 INFO - Running setup.py install for mozInstall 17:34:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:34:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:34:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:34:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:34:54 INFO - Running setup.py install for mozleak 17:34:54 INFO - Running setup.py install for mozlog 17:34:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:34:54 INFO - Running setup.py install for moznetwork 17:34:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:34:54 INFO - Running setup.py install for mozprocess 17:34:54 INFO - Running setup.py install for mozprofile 17:34:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:34:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:34:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:34:55 INFO - Running setup.py install for mozrunner 17:34:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:34:55 INFO - Running setup.py install for mozscreenshot 17:34:55 INFO - Running setup.py install for moztest 17:34:55 INFO - Running setup.py install for mozversion 17:34:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:34:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:34:55 INFO - Cleaning up... 17:34:55 INFO - Return code: 0 17:34:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:34: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')]} 17:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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')]} 17:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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 0x191b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16850>, '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 0x1c8b6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8bb60>, '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': 'af724c981e2a0f424dbabf99000001e7-1482197661.769031-944354883', '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 17:34: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 17:34: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 17:34:55 INFO - Using env: {'DISPLAY': ':0', 17:34:55 INFO - 'HOME': '/home/cltbld', 17:34:55 INFO - 'LANG': 'en_US.UTF-8', 17:34:55 INFO - 'LANGUAGE': 'en_US:en', 17:34:55 INFO - 'LOGNAME': 'cltbld', 17:34:55 INFO - 'MAIL': '/var/mail/cltbld', 17:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:55 INFO - 'MOZ_NO_REMOTE': '1', 17:34:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:55 INFO - 'NO_EM_RESTART': '1', 17:34:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:55 INFO - 'PWD': '/builds/slave/test', 17:34:55 INFO - 'SHELL': '/bin/bash', 17:34:55 INFO - 'SHLVL': '1', 17:34:55 INFO - 'TERM': 'linux', 17:34:55 INFO - 'TMOUT': '86400', 17:34:55 INFO - 'USER': 'cltbld', 17:34:55 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482197661.769031-944354883', 17:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:55 INFO - '_': '/tools/buildbot/bin/python'} 17:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:34:55 INFO - Running setup.py (path:/tmp/pip-Q3y6zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:34: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)) 17:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:34:55 INFO - Running setup.py (path:/tmp/pip-5McUpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:34: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)) 17:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:34:55 INFO - Running setup.py (path:/tmp/pip-byKXY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:34: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)) 17:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:34:55 INFO - Running setup.py (path:/tmp/pip-ly1gMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:34:56 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)) 17:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:34:56 INFO - Running setup.py (path:/tmp/pip-h2HeGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:34:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:34:56 INFO - Running setup.py (path:/tmp/pip-YnevMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:34:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:34:56 INFO - Running setup.py (path:/tmp/pip-xXFnkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:34: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)) 17:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:34:56 INFO - Running setup.py (path:/tmp/pip-WYTHHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:34: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)) 17:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:34:56 INFO - Running setup.py (path:/tmp/pip-tO6VOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:34: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)) 17:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:34:56 INFO - Running setup.py (path:/tmp/pip-m8xmsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:34: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)) 17:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:34:56 INFO - Running setup.py (path:/tmp/pip-2BcedU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:34: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)) 17:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:34:56 INFO - Running setup.py (path:/tmp/pip-QcNz6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:34:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:34:56 INFO - Running setup.py (path:/tmp/pip-ya2LZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:34: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)) 17:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:34:56 INFO - Running setup.py (path:/tmp/pip-sUOn3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:34: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)) 17:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:34:56 INFO - Running setup.py (path:/tmp/pip-czoAlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:34: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)) 17:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:34:56 INFO - Running setup.py (path:/tmp/pip-wNxSNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:34:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:34:56 INFO - Running setup.py (path:/tmp/pip-_yDh0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:34: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)) 17:34: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)) 17:34: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)) 17:34: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)) 17:34: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)) 17:34: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)) 17:34:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:58 INFO - Downloading blessings-1.6.tar.gz 17:34:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:34:59 INFO - Installing collected packages: blessings 17:34:59 INFO - Running setup.py install for blessings 17:34:59 INFO - Successfully installed blessings 17:34:59 INFO - Cleaning up... 17:34:59 INFO - Return code: 0 17:34:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:34:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:34:59 INFO - Reading from file tmpfile_stdout 17:34:59 INFO - Current package versions: 17:34:59 INFO - argparse == 1.2.1 17:34:59 INFO - blessings == 1.6 17:34:59 INFO - blobuploader == 1.2.4 17:34:59 INFO - docopt == 0.6.1 17:34:59 INFO - functools32 == 3.2.3-2 17:34:59 INFO - jsonschema == 2.5.1 17:34:59 INFO - manifestparser == 1.1 17:34:59 INFO - mozInstall == 1.12 17:34:59 INFO - mozcrash == 1.0 17:34:59 INFO - mozdebug == 0.1 17:34:59 INFO - mozdevice == 0.49 17:34:59 INFO - mozfile == 1.2 17:34:59 INFO - mozhttpd == 0.7 17:34:59 INFO - mozinfo == 0.9 17:34:59 INFO - mozleak == 0.1 17:34:59 INFO - mozlog == 3.4 17:34:59 INFO - moznetwork == 0.27 17:34:59 INFO - mozprocess == 0.23 17:34:59 INFO - mozprofile == 0.28 17:34:59 INFO - mozrunner == 6.13 17:34:59 INFO - mozscreenshot == 0.1 17:34:59 INFO - mozsystemmonitor == 0.3 17:34:59 INFO - moztest == 0.7 17:34:59 INFO - mozversion == 1.4 17:34:59 INFO - psutil == 3.1.1 17:34:59 INFO - requests == 1.2.3 17:34:59 INFO - wsgiref == 0.1.2 17:34:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:34: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')]} 17:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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')]} 17:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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 0x191b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16850>, '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 0x1c8b6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8bb60>, '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': 'af724c981e2a0f424dbabf99000001e7-1482197661.769031-944354883', '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 17:34: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 17:34: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 17:34:59 INFO - Using env: {'DISPLAY': ':0', 17:34:59 INFO - 'HOME': '/home/cltbld', 17:34:59 INFO - 'LANG': 'en_US.UTF-8', 17:34:59 INFO - 'LANGUAGE': 'en_US:en', 17:34:59 INFO - 'LOGNAME': 'cltbld', 17:34:59 INFO - 'MAIL': '/var/mail/cltbld', 17:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:59 INFO - 'MOZ_NO_REMOTE': '1', 17:34:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:59 INFO - 'NO_EM_RESTART': '1', 17:34:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:59 INFO - 'PWD': '/builds/slave/test', 17:34:59 INFO - 'SHELL': '/bin/bash', 17:34:59 INFO - 'SHLVL': '1', 17:34:59 INFO - 'TERM': 'linux', 17:34:59 INFO - 'TMOUT': '86400', 17:34:59 INFO - 'USER': 'cltbld', 17:34:59 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482197661.769031-944354883', 17:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:59 INFO - '_': '/tools/buildbot/bin/python'} 17:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34: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)) 17:34: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)) 17:34: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)) 17:34: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)) 17:34: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)) 17:34: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)) 17:34: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)) 17:34: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)) 17:34: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)) 17:34: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)) 17:34: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)) 17:34:59 INFO - Cleaning up... 17:34:59 INFO - Return code: 0 17:34:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:34: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')]} 17:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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')]} 17:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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 0x191b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16850>, '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 0x1c8b6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8bb60>, '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': 'af724c981e2a0f424dbabf99000001e7-1482197661.769031-944354883', '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 17:34: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 17:34: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 17:34:59 INFO - Using env: {'DISPLAY': ':0', 17:34:59 INFO - 'HOME': '/home/cltbld', 17:34:59 INFO - 'LANG': 'en_US.UTF-8', 17:34:59 INFO - 'LANGUAGE': 'en_US:en', 17:34:59 INFO - 'LOGNAME': 'cltbld', 17:34:59 INFO - 'MAIL': '/var/mail/cltbld', 17:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:59 INFO - 'MOZ_NO_REMOTE': '1', 17:34:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:59 INFO - 'NO_EM_RESTART': '1', 17:34:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:59 INFO - 'PWD': '/builds/slave/test', 17:34:59 INFO - 'SHELL': '/bin/bash', 17:34:59 INFO - 'SHLVL': '1', 17:34:59 INFO - 'TERM': 'linux', 17:34:59 INFO - 'TMOUT': '86400', 17:34:59 INFO - 'USER': 'cltbld', 17:34:59 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482197661.769031-944354883', 17:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:59 INFO - '_': '/tools/buildbot/bin/python'} 17:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:34:59 INFO - Cleaning up... 17:34:59 INFO - Return code: 0 17:34:59 INFO - Running post-action listener: _resource_record_post_action 17:34:59 INFO - Running post-action listener: _start_resource_monitoring 17:34:59 INFO - Starting resource monitoring. 17:34:59 INFO - [mozharness: 2016-12-20 01:34:59.959160Z] Finished create-virtualenv step (success) 17:34:59 INFO - [mozharness: 2016-12-20 01:34:59.959642Z] Running install step. 17:34:59 INFO - Running pre-action listener: _resource_record_pre_action 17:34:59 INFO - Running main action method: install 17:34:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:35:00 INFO - Reading from file tmpfile_stdout 17:35:00 INFO - Detecting whether we're running mozinstall >=1.0... 17:35:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:35:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:35:00 INFO - Reading from file tmpfile_stdout 17:35:00 INFO - Output received: 17:35:00 INFO - Usage: mozinstall [options] installer 17:35:00 INFO - Options: 17:35:00 INFO - -h, --help show this help message and exit 17:35:00 INFO - -d DEST, --destination=DEST 17:35:00 INFO - Directory to install application into. [default: 17:35:00 INFO - "/builds/slave/test"] 17:35:00 INFO - --app=APP Application being installed. [default: firefox] 17:35:00 INFO - mkdir: /builds/slave/test/build/application 17:35:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:35:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:35:16 INFO - Reading from file tmpfile_stdout 17:35:16 INFO - Output received: 17:35:16 INFO - /builds/slave/test/build/application/firefox/firefox 17:35:16 INFO - Running post-action listener: _resource_record_post_action 17:35:16 INFO - [mozharness: 2016-12-20 01:35:16.263760Z] Finished install step (success) 17:35:16 INFO - [mozharness: 2016-12-20 01:35:16.264007Z] Running run-tests step. 17:35:16 INFO - Running pre-action listener: _resource_record_pre_action 17:35:16 INFO - Running main action method: run_tests 17:35:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:35:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:35:16 INFO - Python 2.7.3 17:35:16 INFO - Return code: 0 17:35:16 INFO - grabbing minidump binary from tooltool 17:35: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')]} 17:35: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 0x1d16850>, '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 0x1c8b6d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8bb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:35: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 17:35: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 17:35: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 17:35:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:35:16 INFO - Return code: 0 17:35:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:35:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:35:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:35:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:35:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:35:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JHhvtG3-QMKPBVYId1TylA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 17:35:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JHhvtG3-QMKPBVYId1TylA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 17:35:16 INFO - Using env: {'DISPLAY': ':0', 17:35:16 INFO - 'HOME': '/home/cltbld', 17:35:16 INFO - 'LANG': 'en_US.UTF-8', 17:35:16 INFO - 'LANGUAGE': 'en_US:en', 17:35:16 INFO - 'LOGNAME': 'cltbld', 17:35:16 INFO - 'MAIL': '/var/mail/cltbld', 17:35:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:35:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:35:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:16 INFO - 'MOZ_NO_REMOTE': '1', 17:35:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:35:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:16 INFO - 'NO_EM_RESTART': '1', 17:35:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:16 INFO - 'PWD': '/builds/slave/test', 17:35:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:35:16 INFO - 'SHELL': '/bin/bash', 17:35:16 INFO - 'SHLVL': '1', 17:35:16 INFO - 'TERM': 'linux', 17:35:16 INFO - 'TMOUT': '86400', 17:35:16 INFO - 'USER': 'cltbld', 17:35:16 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482197661.769031-944354883', 17:35:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:16 INFO - '_': '/tools/buildbot/bin/python'} 17:35:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JHhvtG3-QMKPBVYId1TylA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 17:35:16 INFO - mozversion application_buildid: 20161219164223 17:35:16 INFO - mozversion application_changeset: 5182a866ae5ab3558d43c6d348588a1269052b5e 17:35:16 INFO - mozversion application_display_name: Nightly 17:35:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:35:16 INFO - mozversion application_name: Firefox 17:35:16 INFO - mozversion application_remotingname: firefox 17:35:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:35:16 INFO - mozversion application_vendor: Mozilla 17:35:16 INFO - mozversion application_version: 53.0a1 17:35:16 INFO - mozversion platform_buildid: 20161219164223 17:35:16 INFO - mozversion platform_changeset: 5182a866ae5ab3558d43c6d348588a1269052b5e 17:35:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:35:16 INFO - mozversion platform_version: 53.0a1 17:35:16 INFO - using testdate: 1482197716 17:35:16 INFO - actual date: 1482197716 17:35:16 INFO - starting webserver on 'localhost:44927' 17:35:16 INFO - SUITE-START | Running 2 tests 17:35:16 INFO - TEST-START | dromaeo_css 17:35:16 INFO - operating with platform_type : linux_ 17:35:16 INFO - Initialising browser for dromaeo_css test... 17:35:16 INFO - TEST-INFO | started process 18932 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMBVGTh/profile http://localhost:44927/getInfo.html) 17:35:20 INFO - PROCESS | 18932 | __metrics Screen width/height:1600/1200 17:35:20 INFO - PROCESS | 18932 | colorDepth:24 17:35:20 INFO - PROCESS | 18932 | Browser inner width/height: 1024/697 17:35:20 INFO - PROCESS | 18932 | __metrics 17:35:21 INFO - PROCESS | 18932 | 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" 17:35:21 INFO - PROCESS | 18932 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:35:23 INFO - TEST-INFO | 18932: exit 0 17:35:23 INFO - Browser initialized. 17:35:23 INFO - Running cycle 1/1 for dromaeo_css test... 17:35:23 INFO - TEST-INFO | started process 19013 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMBVGTh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:35:34 INFO - PROCESS | 19013 | RSS: Main: 156213248 17:35:34 INFO - PROCESS | 19013 | 17:36:26 INFO - PROCESS | 19013 | 1482197786168 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:38:40 INFO - PROCESS | 19013 | Cycle 1(1): loaded http://localhost:44927/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44927/tests/dromaeo/cssquery-ext.html) 17:38:42 INFO - PROCESS | 19013 | RSS: Main: 287170560 17:38:42 INFO - PROCESS | 19013 | 17:41:45 INFO - PROCESS | 19013 | Cycle 1(1): loaded http://localhost:44927/tests/dromaeo/cssquery-ext.html (next: http://localhost:44927/tests/dromaeo/cssquery-jquery.html) 17:41:45 INFO - PROCESS | 19013 | RSS: Main: 244903936 17:41:45 INFO - PROCESS | 19013 | 17:44:48 INFO - PROCESS | 19013 | Cycle 1(1): loaded http://localhost:44927/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44927/tests/dromaeo/cssquery-mootools.html) 17:44:48 INFO - PROCESS | 19013 | RSS: Main: 189366272 17:44:48 INFO - PROCESS | 19013 | 17:47:50 INFO - PROCESS | 19013 | Cycle 1(1): loaded http://localhost:44927/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44927/tests/dromaeo/cssquery-prototype.html) 17:47:51 INFO - PROCESS | 19013 | RSS: Main: 188637184 17:47:51 INFO - PROCESS | 19013 | 17:50:54 INFO - PROCESS | 19013 | Cycle 1(1): loaded http://localhost:44927/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44927/tests/dromaeo/cssquery-yui.html) 17:50:55 INFO - PROCESS | 19013 | RSS: Main: 189128704 17:50:55 INFO - PROCESS | 19013 | 17:53:58 INFO - PROCESS | 19013 | Cycle 1(1): loaded http://localhost:44927/tests/dromaeo/cssquery-yui.html (next: http://localhost:44927/tests/dromaeo/cssquery-dojo.html) 17:53:59 INFO - PROCESS | 19013 | RSS: Main: 279588864 17:53:59 INFO - PROCESS | 19013 | 17:53:59 INFO - PROCESS | 19013 | __start_tp_report 17:53:59 INFO - PROCESS | 19013 | _x_x_mozilla_page_load 17:53:59 INFO - PROCESS | 19013 | _x_x_mozilla_page_load_details 17:53:59 INFO - PROCESS | 19013 | |i|pagename|runs| 17:53:59 INFO - PROCESS | 19013 | |0;dojo.html;2668.079512568164;2694.9730502694993;2708.742669446402;2726.945461090777;2740.534109201437;4785.641076919236;4823.807047718087;4855.465898751139;4897.53473420025;4904.509549045094;4797.280407938802;4802.951970480294;4854.635902307324;4868.756562171886;4896.510348965111;4349.913001739963;4382.956170438287;4416.580424859633;4470.552944705536;4555.066211426666;4106.42970788227;4415.492218394877;4467;4492.685512014144;4546.363509108727;4345;4398.120375924827;4444.333349997494;4492.910141797146;4519.27691569349;4379.912401751979;4408.426904502427;4432.556744325574;4433.22418576751;4476.037651904823;4377.9781101094295;4396.1427521633295;4405.537418571068;4453.866384008485;4460.041091165415;4810.7113573185725;4835.637327200438;4849.927251091236;4854.320395144682;4858.319835223072;5033.270175824521;5078.949210507884;5083.085044691954;5166.664166829181;5199.220116982445;5189.42916279209;5206.401263854667;5217.373915130209;5243.134882744343;5304.045271851065;4884.755762211875;4888.2178851383605;4892.559669629751;4894.412670479494;4939.604831613462;5127.07712611726;5366.570674346043;5369.301990741179;5373.650712703662;5374;4951.777170027357;4975.527324904201;5010.874728131753;5031.874203144951;5045.924311135336;5162.045021671003;5163.509466600667;5188.11801993662;5216.243644671501;5219.712915789592;5052.242163675478;5065.569426598707;5120.513551212629;5121.564667003347;5175.430702622709;4961.280614310905;4994.275830004629;5106.642535022587;5109.897802044013;5118.513741194581;4384.254676704968;4393.494748103945;4394.318880573516;4412.183746006935;4449.1101779644205;3828.0429892526868;3829.1767270037076;3832.156925476391;3864.9806750966063;3869.5163104611925;4409.36064270679;4410.184115938561;4412.36020776992;4412.4705035395955;4455.799489023002;5021.07110184617;5043.36957880265;5046.798128074836;5102.158143906214;5126.333576635014;4309.676774241944;4334.501532323823;4352.760598167068;4361.6510679145595;4365;4654.138984287918;4660.930086048712;4664.86005419838;4687.039156972813;4708.058388322349;4809.495003024632;4811.78346974394;4816.518348165156;4852.44196917359;4855.75721213945;5048.217526283432;5077.086124497626;5149.536541711264;5152.948470515247;5153.3815942087185;4746.145693775154;4825.131476334293;4868.634852386014;4872.90254194907;4924.482929292372;5098.592112631055;5128.692278463304;5134.691918484903;5139.743012849268;5182.170852663707;5232.921506177487;5237.685738855681;5239.056969745482;5247.763850626655;5248.6325957182635;4869.342638743866;4945.18404463274;4950.801967921243;5008.974955125201;5013.448520662651;4996;5046.722430266371;5049.444561098203;5087.592992560512;5101.183810590288;4981.750912454435;4984.028114517634;4986;4991.376077990251;5024.246363045572;4974.228994505857;5014.674046186986;5016.423111342242;5095.490450954875;5101.872453188552;4892.363992680928;4913.557779799692;4922.384701912261;4948.233023881304;4991 17:53:59 INFO - PROCESS | 19013 | |1;ext.html;498.74065485947307;499.33338992445084;502.05864004990667;531.1422053383785;534.3320848938827;27666.861665691693;36844.263114737725;38478.23043539131;38571.228575428475;38658.613413865925;38543;39006.8049659752;39012;39019.21961560767;39096;7517.4737768356235;7721.266479684449;7728.111267204259;7740.303372696456;7742.496737712031;7145.285471452865;7289.817754556126;9765.853512197287;10009.049140331657;10014.198864090891;10003.89996100037;10027.298089133763;10052.698419047403;10098.949505252463;10108.595656173744;9828.803423931517;9922.007799220128;9986;9992.400455972593;10010.249231307609;9773.706788796348;9867.60529578816;9868.703938881845;9869.062439068277;9872.40765554069;35317.82341088304;35672.28655426877;35673.82163089194;35789.64210357915;35798.8210058948;2748.5190091734066;2974.9107526774233;3045.7867949243564;3049.9695003049906;3293.127321259868;27003.324916877038;27525.17424477269;27633.86183069092;28046.85976570104;28469.145925622266;3320.684534969174;3379.1721028347965;3391.253924136686;3412.505186747908;3421.8460169292443;231280;231673;232027;232713;233876.9999999983;50096;50462;50473.99052018939;50484.24273635898;50490.747546262035;53060.469395306325;53107.468925310255;53161;53394.73302633462;53417.1987420189;14692.338844752012;14895.851041489663;14935.327910244065;14962.251887405586;14970.70058598822;8791.604377803014;8886.4668119913;10635.893641063645;10685.57257709683;10691.358518488916;14028.649283767783;14180.290985450687;14205.218712970885;14252.928735356465;14866.851331486547;4928.852134435972;5822.126680997884;5891.263592050994;5909.497692696083;5914.260717410324;709.6948312225793;807.2411932783165;851.4423052900361;869.9347548933729;895.9417637853519;26017.739822601532;26729.19812405631;26740.866295668788;27200.183994480198;27238.45523089527;891.8528442806994;912.9908700913039;967.3567077893122;976.9658061967797;997.6209040564684;13671.726565468634;14141.929290353482;14443.133411995314;14597.708045839236;14605.12369257848;332889;344132;346660;347150;348553;37910.62089379071;44957;46466.76766616145;46615.53384466112;52297;1096.380544992077;1123.8258069999163;1143.1997601678693;1146.2148428326623;1147.65570328901;26840.865795670896;27828.30429239285;28373.85813071004;28506.287342816595;28989.27526811762;40957.590424095375;41248;41444.585554144076;41450.37824432696;41457.37813932733;300179;301325;301647;301672;301986;33839.81560645365;34166.12086335276;34350.31299374049;34578.65421345855;34585.84969803539;35345.646543535266;39534.604653953094;40083.799581001906;40832.79583602063;41192.588074120074;29726.702732972393;30671.53992690156;30774.84612576923;30918.22704432407;31970.36059278848;30618.387632247675;30816.691833081382;31179.220519487193;31242.843785781835;32270;29744.553831692974;29781.468575170486;30755;30863.2284192897;31904.521432179;27080.729192708608;28525.28686782847;28914.27714307075;29173;29261.70738292675;22812.4296892579;22925.197618083956;23194.652080219148;23237.468693604584;23287.32195797437 17:53:59 INFO - PROCESS | 19013 | |2;jquery.html;344.8000159907251;368.22121213633176;371.94234893591494;372.97762134271943;392.1001302011882;12551.686207844808;12553.121281510286;13213.735725285489;16234.269457874394;16880;14311.355988980495;14556.781648275284;14584.927075364634;14693.77959330611;14694.338754756034;4924.187509061001;5123.820666276681;5123.871903202413;5334;5375.838724838261;3470.514128022079;5397.190421436777;5425.26758887551;5434.864128396802;5435.320584926884;3640.6359364063514;5604.131359639263;5846.21076154718;5854.09261564456;5958.344582095966;5367.758450869681;5419.160030195287;5946.97026514869;5957.970210148921;5963.582549221556;5245.423003469616;5247;5249.081410753103;5250.238715386286;5252.159654455307;12298.75402491954;12488.313142777144;19486.80513194864;19615;19804.10881510321;1821.6812057889815;1856.4337876947525;1937.9127939242767;1990.3730324947596;2414.0464516516054;8840.778980525474;8860.113988601153;9265.907340926571;9280;9484.383515071568;1409.3869166912425;1525.458462245909;1597.5047735202124;1664.0431751742797;1693.6358682883117;62886.685566572334;67806.3219367805;67966.32033679698;69361.65319173422;71045.64477177581;9535.47554884488;9826;9840.261980351503;9892.406455612687;10082.596696132072;13672.589822305346;13689.589312320646;13699.726005479835;13700;13715.794263086062;6756.797296081126;7307.123145222501;7312.707491700379;7400.222976587381;7443.627818609048;6598.076269322299;6838.93161068383;6918.7232510699005;7092.255313192144;7116.608586527791;4260.893477663021;4314.892127696833;4384.890377740582;4448.088141930896;4512.887177820581;1779.350537053966;1804.6029873428088;1820.5812663087563;1830.675042695769;1833.4499650104915;790.9006480991427;793.8449555896158;795.1015352651582;832.3466079127855;892.1836519584507;15100.244987750788;16219.675606487805;16411.1794410279;16574;16679.6664066718;847.6270441005938;849.9447535910147;852.7569642651814;855.922966932979;909.9676071313818;8882.555872206363;9112.271018318519;9426.95286523563;9498.715038548855;9650.324477286522;328418;332382;333741;335765;336504;48901.75549122231;55590;75221.6238918802;75371.62314188395;76548.23451765522;858.2190206911805;883.5277359975358;896.8834051573253;900.1763386501278;900.1943260781563;10850.837237441603;15009;15939;15997.200139992721;16482.25829837684;28903.421931561672;31759.841200794774;32827.34345313128;34210.31579368349;36241.093972650895;47693.5230647703;48522.51477485321;48571.27143092927;48814.511854881;50835;10553.314034587727;11004.449777511252;11041.889581104086;11077.889221107685;11496.195266331611;12043.397830108284;12277.324747138637;12387.938060310002;12443.44004519817;12748.235105893677;10595.94702026485;10690.679279621623;10706.73233169177;10720.839187412352;11187.272827266203;10529.4735263235;10552;10634.627788027381;10714.839277410689;10728.946355268174;10928.50821713009;10951.56193752241;10993.505292262027;11161.609343672932;11382.94308528452;10943.28868623537;11141.2201145919;11146.832797508207;11208.103351732005;11365.488553015299;10434;10715;10770.461476926279;10989.285696430026;11103.333799972028 17:53:59 INFO - PROCESS | 19013 | |3;mootools.html;1305.3081866610696;1345.4483661698705;1408.8943329250308;1590.7454807230831;1619.6436783907536;7226.783196504107;7531.736389226378;7540.245975402464;7546.584937828431;7556.659950302236;6475.352464753522;6718.563293385926;7052.964735176317;7225.530340527862;7227;2087.697283893838;2121.9151233950624;2122.1405330841035;2122.490602255455;2123.2568600989607;2115.386537904006;2141.957160856782;2168.0677308757226;2170.2621108822996;2171.6525355943054;1816.355193906164;1875.1749230338676;1878.9812101878942;1884.2839720906036;2073.5956488484676;2106.799854013866;2153.0526568309892;2153.4616345913523;2154.967675484869;2156.967645485319;2167.328128280238;2189.5839790439763;2195.484061245606;2220.755716871143;2225.432514708739;7427.554346739213;7479.551226926402;7486.737964171228;7488.4009279257525;7493.138289096769;4347.130573885235;4490.236659767847;4492.842750503717;4495.910081798345;4497.572730590621;2796.790240731933;2895.1025182193375;2970.59896913916;2990.760739140885;3004.6244219472565;868.2966796894535;873.4497266721925;913.2785099771173;913.8629205619144;918.2011649864661;10122.898771012344;10143.64497242593;10216.13162881156;10217.080462758313;10225.795484090351;3961.603839616015;4098.200850834059;4152.854650087293;4174.791260436966;4187.036981494273;8498.787530311793;8500.27747641445;8505.10696376884;8522.062573116953;8529.360297977677;4393.560643935581;4466.776661166994;4467.441569803775;4472.08322293929;4476.37330773692;3966.5438474575217;4015.598440155961;4020.296448121567;4024.557298697141;4024.5774193709826;3204.198950262434;3209.6308924473983;3263.233140212096;3279.950800737991;3300.1254667513126;976.2873102635116;984.3552473130111;1000.5847573257017;1002.9899701003043;1010.9393436393693;635.3519410201661;700.9579425234502;780.8438312337441;827.1025936858456;838.7064527415478;4786;4986.202207646759;5056.570191533688;5080.59355251579;5338.199270109515;801.867691830853;812.8577498937663;830.8546004449197;847.7795773099039;884.3544212724619;3260.820654864005;3588.802615856153;3723.3484140275345;3728.8881333560034;3730.8321125549414;8522.57387130641;8868.822623547621;9051.094890510896;9077.546122693971;9103.908960910307;8976.955115224513;8996.325275604357;9007.459552426875;9012.819743605221;9046.276297896153;6839;6901.896471552931;7020.052292940388;7058.153021637437;7114.786556403213;5043.193089105725;5091.618128640441;5094.217024041556;5131.127708289525;5195.584353251656;8178.754637360888;8200.220979006985;8219.342452603658;8272.710455134042;8348.791280218044;8423.410361274651;8453.323734101381;8486.660533578588;8494.617742201739;8580.570971451527;5812.5349972001295;5926.525877929842;5926.614770039933;5932.822015339547;5966.254218222723;6924.4460443165435;7037.225905150327;7044.084269044992;7114.964425177841;7118.323759242864;6352.68236588178;6407.967960160356;6461.386168314003;6473.838154046187;6528.183977002875;5608.85977850557;6110.236220472441;6286.717097730704;6329.683515824282;6342.143810585512;5868.061110222344;6005.36943620931;6013.218281623361;6018.668973206516;6021.789237376671;4258.382534532538;4339.934900976425;4343.3484977253665;4427.048184640318;4480.843170489017;4364.454443194601;4561.2017896867255;4562.794674239601;4661.673682842168;4732.621390288838 17:53:59 INFO - PROCESS | 19013 | |4;prototype.html;355.9875404360846;357.57091490211747;358.05652106698847;360.238096426059;365.46459436924914;4851.514848515147;4888.608911287098;4898.191798353272;4906.190478571036;4932.309476673268;4818.602884966099;4842.612590992721;4848.200046992242;4850.34520339754;4853.296272040552;3563.7883119739286;3683.2081102562943;3798.9240215195678;3810.047488127968;3862.875418519817;3828.1386687995255;3837.846486140565;3845.961640330629;3853.5183102112237;3860.613938606145;3832.1569254764045;3848.249591329678;3857.9421308680394;3870.9225815483674;3873.9806300968457;3633.509476220716;3757.7369584129124;3785.356489396809;3861.7489863158803;3862.1889403225355;3467.1158854492196;3471.6007659119273;3479.9478007829903;3488.372093023255;3491.1446695559753;4705.952940470585;4707.882302942419;4711.787969541345;4735.857924262244;4762.904741905177;4311.33174357975;4442.222611043055;4445.73325600465;4453.977730111361;4458.95214624563;5023.949760502422;5055.9241611375855;5058.392992840846;5062.443131255559;5063.291139240509;3831.7700937943814;3832.7038746677836;3833.252515759428;3839.1361943562756;3843.442700808367;4972.055309491185;5111.309973153651;5206.973965130226;5316.846677095782;5340.412554618989;3915.138669492707;3932.3511620582285;3933.5476420212044;3934.272159650474;3953.1303113315025;3986.4618276532296;4012.4382586437923;4019.959800402017;4022.91954160921;4024;4070.9185816284103;4435.534268901783;4444.599986001211;4444.6666500012625;4476.776161191992;5048.924266136011;5049.722265275372;5055.393352797688;5074.695518268915;5088.262201980766;1259.3451405269209;1260.962171134849;1263.4377701922556;1270.9491620335268;1271.1419791640606;819.5861090149436;855.3157474020759;858.8539948208819;873.3449912565576;883.2933653077512;4365.236083685342;4368.4102646143;4372.322290045048;4378.16814805186;4378.365137055172;5079.796808127633;5116.974415127975;5120.1039818031695;5123.847134394806;5163.457836927144;4347.804348804311;4358.302671572533;4373.343998400202;4381;4386.627136693417;2593.312772115391;2727.263638817548;2741.931451713723;2746.8025579536293;2751.477219328321;4778.4982576829625;4782.904341913142;4784.378030856036;4795.328653988445;4795.923465054676;5101;5185.637005409661;5213.7914483421;5260.421353651095;5280.175106318102;4912.484189160158;4919.729414882216;4929.778159982738;4932.506749325039;4945.629077819106;5272.787258930544;5277.551408130352;5287.695190505934;5330.626856120034;5340.572754179579;4978.502149785138;5177.145770947902;5209.322788037531;5216.921746173886;5234.895302093861;4707.17624415719;4802.255650374198;4817.772092697831;4934.679245849152;4966.279889415942;3726.944095838619;3745.213505163946;3748.925021499609;3758.116842542055;3758.210775737126;5265.842024739264;5301.946980530145;5321.973390133025;5323.893522129459;5327.360716714019;4928.728919909439;5089.949100509096;5131.512506311894;5134.792039422935;5176.870578235575;5090.389153301628;5094.981003799181;5100.923486147785;5118.181091025418;5121.539061484485;5050.141475949024;5066.645334826527;5083;5085.110105731556;5098.821541246039;4904.852854414374;5164.8192313268855;5183.196604526304;5197.688138711689;5198.792048318176;5036.589754868643;5058.1654027085115;5058.9494105058475;5067.579383915916;5080.847574572768 17:53:59 INFO - PROCESS | 19013 | |5;yui.html;597.2713289786459;602.2875057484338;614.057421857449;713.8108401273663;722.8373615936413;12078.69803254918;12577.434015469304;12667.619971400849;12680.365981700925;12694.04794640401;12113.818292725595;12159.148859579833;12196.207246528991;12235.632931012084;12237.571684991028;595.5563105486418;611.1443978430211;724.5869854183118;733.5158795195172;745.4744405194325;746.9626518674072;749.3630414147985;750.5796753817853;750.6284389227313;750.6847124207818;802.297989259398;802.9558374289412;803.6825453945688;803.907550631679;803.9155888631698;629.6064959400375;644.310587671192;647.9578827376206;650.39513252675;790.8971833661616;478.3088437208236;563.6730696196238;580.083468120373;582.6853499110475;584.0975692555013;13215.60353189406;13221.669458263525;13274.137181083199;13276.535321263806;13283.468661253539;12461.376931153496;12518.374081295899;12567.245965242115;12569.93715031419;12706.809397859039;11326.603568875049;11402.429878506042;11556.595519156874;11742.765144697143;11891.04871610269;3069.7083777041144;3195.8242296673675;3261.2173078461237;3329.96670033299;3351.2962277921665;51843.481565184244;52528.999999999614;52609.47390526084;53408.732956335356;61940;9626.326157169071;9867.161291290176;10076.647317344004;10123.797524049478;10177.84733229002;18705.532361690795;18886.905565472083;18896.24415023411;18916.432507024812;18947.052647367578;6533.640649764214;6642.114298261454;6683;6694.966525167343;6698.330166983263;3498.2478767065204;3644.416893297113;3648.1973965727498;3662.560492740835;3704.49989251453;2697.6223328733995;2839.346950201465;2873.482773100862;2875.4536638038708;2878.7409133178116;547.7261369315343;555.7749111609804;557.6319629044892;567.1662655895826;572.321798668579;425.79987405919167;545.1277955271613;562.8592851787054;574.7413663851283;591.8518074934613;7448.217937116633;7762.611869406507;7793.844123117506;7959.721409750631;8023.197680232047;445.65461767130734;451.5371743962465;478.12025872394264;502.7511381866;566.5014786987507;3479.408500554912;3488.808115553669;3551.94672079919;3632.1646021414695;3723.832427540767;62550.68724656347;65743.34256657468;66581.66709166423;66590.66704666446;67498.66250668715;44864.10271794546;51804.22293665598;54881.45118548843;57661;59992.400075999554;50473.747631261605;50932.92536597137;51622.22566661503;52200;52680.736596316776;6981.75563855283;7039.366457018893;7076.787696369117;7191.993120962965;7269.636518173965;37275.645191932854;37304.69433569812;37749;38174.618253817105;39354.60645393509;45170.77414612906;47900;48897.75551122222;50960.98078038344;51432.22851657153;8494.22760846765;8812.471251724917;9065.68270110543;9990.400575965175;10249.590016399261;11712.70718232051;11885.643430697093;11958.701032474257;11986;12411.193272437262;9455.905440945502;10830.837537437103;11119.332840029625;11534.769304614028;11616.303021818718;10179.7455063624;10877.564897404016;11002.669919902415;11009.2843965142;11264.267822591506;10326.690199294033;10627.787444251226;11280.830787538029;11609.6517104487;11634.418279085843;8904.376693631384;9222.492762898106;9393.295502837178;9440.19758320523;9572.90427095748;9362.672306469512;10039.598416063567;10067.546960386946;10108.595656173671;10127.442990635585 17:53:59 INFO - PROCESS | 19013 | __end_tp_report 17:53:59 INFO - PROCESS | 19013 | __start_cc_report 17:53:59 INFO - PROCESS | 19013 | _x_x_mozilla_cycle_collect,1411 17:53:59 INFO - PROCESS | 19013 | __end_cc_report 17:53:59 INFO - PROCESS | 19013 | __startTimestamp1482198839132__endTimestamp 17:53:59 INFO - PROCESS | 19013 | 17:53:59 INFO - PROCESS | 19013 | ------- Summary: start ------- 17:53:59 INFO - PROCESS | 19013 | Number of tests: 6 17:53:59 INFO - PROCESS | 19013 | 17:53:59 INFO - PROCESS | 19013 | [#0] dojo.html Cycles:165 Average:4763.89 Median:4896.51 stddev:499.02 (10.2%) stddev-sans-first:472.69 17:53:59 INFO - PROCESS | 19013 | Values: 2668.1 2695.0 2708.7 2726.9 2740.5 4785.6 4823.8 4855.5 4897.5 4904.5 4797.3 4803.0 4854.6 4868.8 4896.5 4349.9 4383.0 4416.6 4470.6 4555.1 4106.4 4415.5 4467.0 4492.7 4546.4 4345.0 4398.1 4444.3 4492.9 4519.3 4379.9 4408.4 4432.6 4433.2 4476.0 4378.0 4396.1 4405.5 4453.9 4460.0 4810.7 4835.6 4849.9 4854.3 4858.3 5033.3 5078.9 5083.1 5166.7 5199.2 5189.4 5206.4 5217.4 5243.1 5304.0 4884.8 4888.2 4892.6 4894.4 4939.6 5127.1 5366.6 5369.3 5373.7 5374.0 4951.8 4975.5 5010.9 5031.9 5045.9 5162.0 5163.5 5188.1 5216.2 5219.7 5052.2 5065.6 5120.5 5121.6 5175.4 4961.3 4994.3 5106.6 5109.9 5118.5 4384.3 4393.5 4394.3 4412.2 4449.1 3828.0 3829.2 3832.2 3865.0 3869.5 4409.4 4410.2 4412.4 4412.5 4455.8 5021.1 5043.4 5046.8 5102.2 5126.3 4309.7 4334.5 4352.8 4361.7 4365.0 4654.1 4660.9 4664.9 4687.0 4708.1 4809.5 4811.8 4816.5 4852.4 4855.8 5048.2 5077.1 5149.5 5152.9 5153.4 4746.1 4825.1 4868.6 4872.9 4924.5 5098.6 5128.7 5134.7 5139.7 5182.2 5232.9 5237.7 5239.1 5247.8 5248.6 4869.3 4945.2 4950.8 5009.0 5013.4 4996.0 5046.7 5049.4 5087.6 5101.2 4981.8 4984.0 4986.0 4991.4 5024.2 4974.2 5014.7 5016.4 5095.5 5101.9 4892.4 4913.6 4922.4 4948.2 4991.0 17:53:59 INFO - PROCESS | 19013 | 17:53:59 INFO - PROCESS | 19013 | [#1] ext.html Cycles:180 Average:44299.29 Median:18615.53 stddev:77705.23 (417.4%) stddev-sans-first:77853.63 17:53:59 INFO - PROCESS | 19013 | Values: 498.7 499.3 502.1 531.1 534.3 27666.9 36844.3 38478.2 38571.2 38658.6 38543.0 39006.8 39012.0 39019.2 39096.0 7517.5 7721.3 7728.1 7740.3 7742.5 7145.3 7289.8 9765.9 10009.0 10014.2 10003.9 10027.3 10052.7 10098.9 10108.6 9828.8 9922.0 9986.0 9992.4 10010.2 9773.7 9867.6 9868.7 9869.1 9872.4 35317.8 35672.3 35673.8 35789.6 35798.8 2748.5 2974.9 3045.8 3050.0 3293.1 27003.3 27525.2 27633.9 28046.9 28469.1 3320.7 3379.2 3391.3 3412.5 3421.8 231280.0 231673.0 232027.0 232713.0 233877.0 50096.0 50462.0 50474.0 50484.2 50490.7 53060.5 53107.5 53161.0 53394.7 53417.2 14692.3 14895.9 14935.3 14962.3 14970.7 8791.6 8886.5 10635.9 10685.6 10691.4 14028.6 14180.3 14205.2 14252.9 14866.9 4928.9 5822.1 5891.3 5909.5 5914.3 709.7 807.2 851.4 869.9 895.9 26017.7 26729.2 26740.9 27200.2 27238.5 891.9 913.0 967.4 977.0 997.6 13671.7 14141.9 14443.1 14597.7 14605.1 332889.0 344132.0 346660.0 347150.0 348553.0 37910.6 44957.0 46466.8 46615.5 52297.0 1096.4 1123.8 1143.2 1146.2 1147.7 26840.9 27828.3 28373.9 28506.3 28989.3 40957.6 41248.0 41444.6 41450.4 41457.4 300179.0 301325.0 301647.0 301672.0 301986.0 33839.8 34166.1 34350.3 34578.7 34585.8 35345.6 39534.6 40083.8 40832.8 41192.6 29726.7 30671.5 30774.8 30918.2 31970.4 30618.4 30816.7 31179.2 31242.8 32270.0 29744.6 29781.5 30755.0 30863.2 31904.5 27080.7 28525.3 28914.3 29173.0 29261.7 22812.4 22925.2 23194.7 23237.5 23287.3 17:53:59 INFO - PROCESS | 19013 | 17:53:59 INFO - PROCESS | 19013 | [#2] jquery.html Cycles:180 Average:22198.27 Median:1907.66 stddev:55131.10 (2890.0%) stddev-sans-first:55261.34 17:53:59 INFO - PROCESS | 19013 | Values: 344.8 368.2 371.9 373.0 392.1 12551.7 12553.1 13213.7 16234.3 16880.0 14311.4 14556.8 14584.9 14693.8 14694.3 4924.2 5123.8 5123.9 5334.0 5375.8 3470.5 5397.2 5425.3 5434.9 5435.3 3640.6 5604.1 5846.2 5854.1 5958.3 5367.8 5419.2 5947.0 5958.0 5963.6 5245.4 5247.0 5249.1 5250.2 5252.2 12298.8 12488.3 19486.8 19615.0 19804.1 1821.7 1856.4 1937.9 1990.4 2414.0 8840.8 8860.1 9265.9 9280.0 9484.4 1409.4 1525.5 1597.5 1664.0 1693.6 62886.7 67806.3 67966.3 69361.7 71045.6 9535.5 9826.0 9840.3 9892.4 10082.6 13672.6 13689.6 13699.7 13700.0 13715.8 6756.8 7307.1 7312.7 7400.2 7443.6 6598.1 6838.9 6918.7 7092.3 7116.6 4260.9 4314.9 4384.9 4448.1 4512.9 1779.4 1804.6 1820.6 1830.7 1833.4 790.9 793.8 795.1 832.3 892.2 15100.2 16219.7 16411.2 16574.0 16679.7 847.6 849.9 852.8 855.9 910.0 8882.6 9112.3 9427.0 9498.7 9650.3 328418.0 332382.0 333741.0 335765.0 336504.0 48901.8 55590.0 75221.6 75371.6 76548.2 858.2 883.5 896.9 900.2 900.2 10850.8 15009.0 15939.0 15997.2 16482.3 28903.4 31759.8 32827.3 34210.3 36241.1 47693.5 48522.5 48571.3 48814.5 50835.0 10553.3 11004.4 11041.9 11077.9 11496.2 12043.4 12277.3 12387.9 12443.4 12748.2 10595.9 10690.7 10706.7 10720.8 11187.3 10529.5 10552.0 10634.6 10714.8 10728.9 10928.5 10951.6 10993.5 11161.6 11382.9 10943.3 11141.2 11146.8 11208.1 11365.5 10434.0 10715.0 10770.5 10989.3 11103.3 17:53:59 INFO - PROCESS | 19013 | 17:53:59 INFO - PROCESS | 19013 | [#3] mootools.html Cycles:180 Average:4865.81 Median:5163.36 stddev:2681.86 (51.9%) stddev-sans-first:2676.03 17:53:59 INFO - PROCESS | 19013 | Values: 1305.3 1345.4 1408.9 1590.7 1619.6 7226.8 7531.7 7540.2 7546.6 7556.7 6475.4 6718.6 7053.0 7225.5 7227.0 2087.7 2121.9 2122.1 2122.5 2123.3 2115.4 2142.0 2168.1 2170.3 2171.7 1816.4 1875.2 1879.0 1884.3 2073.6 2106.8 2153.1 2153.5 2155.0 2157.0 2167.3 2189.6 2195.5 2220.8 2225.4 7427.6 7479.6 7486.7 7488.4 7493.1 4347.1 4490.2 4492.8 4495.9 4497.6 2796.8 2895.1 2970.6 2990.8 3004.6 868.3 873.4 913.3 913.9 918.2 10122.9 10143.6 10216.1 10217.1 10225.8 3961.6 4098.2 4152.9 4174.8 4187.0 8498.8 8500.3 8505.1 8522.1 8529.4 4393.6 4466.8 4467.4 4472.1 4476.4 3966.5 4015.6 4020.3 4024.6 4024.6 3204.2 3209.6 3263.2 3280.0 3300.1 976.3 984.4 1000.6 1003.0 1010.9 635.4 701.0 780.8 827.1 838.7 4786.0 4986.2 5056.6 5080.6 5338.2 801.9 812.9 830.9 847.8 884.4 3260.8 3588.8 3723.3 3728.9 3730.8 8522.6 8868.8 9051.1 9077.5 9103.9 8977.0 8996.3 9007.5 9012.8 9046.3 6839.0 6901.9 7020.1 7058.2 7114.8 5043.2 5091.6 5094.2 5131.1 5195.6 8178.8 8200.2 8219.3 8272.7 8348.8 8423.4 8453.3 8486.7 8494.6 8580.6 5812.5 5926.5 5926.6 5932.8 5966.3 6924.4 7037.2 7044.1 7115.0 7118.3 6352.7 6408.0 6461.4 6473.8 6528.2 5608.9 6110.2 6286.7 6329.7 6342.1 5868.1 6005.4 6013.2 6018.7 6021.8 4258.4 4339.9 4343.3 4427.0 4480.8 4364.5 4561.2 4562.8 4661.7 4732.6 17:53:59 INFO - PROCESS | 19013 | 17:53:59 INFO - PROCESS | 19013 | [#4] prototype.html Cycles:180 Average:4246.28 Median:4799.09 stddev:1212.73 (25.3%) stddev-sans-first:1180.46 17:53:59 INFO - PROCESS | 19013 | Values: 356.0 357.6 358.1 360.2 365.5 4851.5 4888.6 4898.2 4906.2 4932.3 4818.6 4842.6 4848.2 4850.3 4853.3 3563.8 3683.2 3798.9 3810.0 3862.9 3828.1 3837.8 3846.0 3853.5 3860.6 3832.2 3848.2 3857.9 3870.9 3874.0 3633.5 3757.7 3785.4 3861.7 3862.2 3467.1 3471.6 3479.9 3488.4 3491.1 4706.0 4707.9 4711.8 4735.9 4762.9 4311.3 4442.2 4445.7 4454.0 4459.0 5023.9 5055.9 5058.4 5062.4 5063.3 3831.8 3832.7 3833.3 3839.1 3843.4 4972.1 5111.3 5207.0 5316.8 5340.4 3915.1 3932.4 3933.5 3934.3 3953.1 3986.5 4012.4 4020.0 4022.9 4024.0 4070.9 4435.5 4444.6 4444.7 4476.8 5048.9 5049.7 5055.4 5074.7 5088.3 1259.3 1261.0 1263.4 1270.9 1271.1 819.6 855.3 858.9 873.3 883.3 4365.2 4368.4 4372.3 4378.2 4378.4 5079.8 5117.0 5120.1 5123.8 5163.5 4347.8 4358.3 4373.3 4381.0 4386.6 2593.3 2727.3 2741.9 2746.8 2751.5 4778.5 4782.9 4784.4 4795.3 4795.9 5101.0 5185.6 5213.8 5260.4 5280.2 4912.5 4919.7 4929.8 4932.5 4945.6 5272.8 5277.6 5287.7 5330.6 5340.6 4978.5 5177.1 5209.3 5216.9 5234.9 4707.2 4802.3 4817.8 4934.7 4966.3 3726.9 3745.2 3748.9 3758.1 3758.2 5265.8 5301.9 5322.0 5323.9 5327.4 4928.7 5089.9 5131.5 5134.8 5176.9 5090.4 5095.0 5100.9 5118.2 5121.5 5050.1 5066.6 5083.0 5085.1 5098.8 4904.9 5164.8 5183.2 5197.7 5198.8 5036.6 5058.2 5058.9 5067.6 5080.8 17:53:59 INFO - PROCESS | 19013 | 17:53:59 INFO - PROCESS | 19013 | [#5] yui.html Cycles:180 Average:14374.52 Median:24700.25 stddev:17929.87 (72.6%) stddev-sans-first:17950.32 17:53:59 INFO - PROCESS | 19013 | Values: 597.3 602.3 614.1 713.8 722.8 12078.7 12577.4 12667.6 12680.4 12694.0 12113.8 12159.1 12196.2 12235.6 12237.6 595.6 611.1 724.6 733.5 745.5 747.0 749.4 750.6 750.6 750.7 802.3 803.0 803.7 803.9 803.9 629.6 644.3 648.0 650.4 790.9 478.3 563.7 580.1 582.7 584.1 13215.6 13221.7 13274.1 13276.5 13283.5 12461.4 12518.4 12567.2 12569.9 12706.8 11326.6 11402.4 11556.6 11742.8 11891.0 3069.7 3195.8 3261.2 3330.0 3351.3 51843.5 52529.0 52609.5 53408.7 61940.0 9626.3 9867.2 10076.6 10123.8 10177.8 18705.5 18886.9 18896.2 18916.4 18947.1 6533.6 6642.1 6683.0 6695.0 6698.3 3498.2 3644.4 3648.2 3662.6 3704.5 2697.6 2839.3 2873.5 2875.5 2878.7 547.7 555.8 557.6 567.2 572.3 425.8 545.1 562.9 574.7 591.9 7448.2 7762.6 7793.8 7959.7 8023.2 445.7 451.5 478.1 502.8 566.5 3479.4 3488.8 3551.9 3632.2 3723.8 62550.7 65743.3 66581.7 66590.7 67498.7 44864.1 51804.2 54881.5 57661.0 59992.4 50473.7 50932.9 51622.2 52200.0 52680.7 6981.8 7039.4 7076.8 7192.0 7269.6 37275.6 37304.7 37749.0 38174.6 39354.6 45170.8 47900.0 48897.8 50961.0 51432.2 8494.2 8812.5 9065.7 9990.4 10249.6 11712.7 11885.6 11958.7 11986.0 12411.2 9455.9 10830.8 11119.3 11534.8 11616.3 10179.7 10877.6 11002.7 11009.3 11264.3 10326.7 10627.8 11280.8 11609.7 11634.4 8904.4 9222.5 9393.3 9440.2 9572.9 9362.7 10039.6 10067.5 10108.6 10127.4 17:53:59 INFO - PROCESS | 19013 | -------- Summary: end -------- 17:53:59 INFO - PROCESS | 19013 | 17:53:59 INFO - TEST-INFO | 19013: exit 0 17:53:59 INFO - TEST-OK | dromaeo_css | took 1123464ms 17:53:59 INFO - TEST-START | kraken 17:53:59 INFO - operating with platform_type : linux_ 17:53:59 INFO - Initialising browser for kraken test... 17:54:00 INFO - TEST-INFO | started process 19323 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHpdA7Z/profile http://localhost:44927/getInfo.html) 17:54:04 INFO - PROCESS | 19323 | __metrics Screen width/height:1600/1200 17:54:04 INFO - PROCESS | 19323 | colorDepth:24 17:54:04 INFO - PROCESS | 19323 | Browser inner width/height: 1024/697 17:54:04 INFO - PROCESS | 19323 | __metrics 17:54:04 INFO - PROCESS | 19323 | 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" 17:54:04 INFO - PROCESS | 19323 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:54:05 INFO - PROCESS | 19323 | console.error: PushService: 17:54:05 INFO - PROCESS | 19323 | stateChangeProcessEnqueue: Error transitioning state 17:54:05 INFO - PROCESS | 19323 | UnknownError 17:54:06 INFO - TEST-INFO | 19323: exit 0 17:54:06 INFO - Browser initialized. 17:54:06 INFO - Running cycle 1/1 for kraken test... 17:54:06 INFO - TEST-INFO | started process 19405 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHpdA7Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:54:18 INFO - PROCESS | 19405 | RSS: Main: 155586560 17:54:18 INFO - PROCESS | 19405 | 17:54:20 INFO - PROCESS | 19405 | Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44927/tests/kraken/driver.html?testName=audio-beat-detection) 17:54:21 INFO - PROCESS | 19405 | RSS: Main: 209719296 17:54:21 INFO - PROCESS | 19405 | 17:54:24 INFO - PROCESS | 19405 | Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44927/tests/kraken/driver.html?testName=audio-dft) 17:54:25 INFO - PROCESS | 19405 | RSS: Main: 187805696 17:54:25 INFO - PROCESS | 19405 | 17:54:28 INFO - PROCESS | 19405 | Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44927/tests/kraken/driver.html?testName=audio-fft) 17:54:28 INFO - PROCESS | 19405 | RSS: Main: 270487552 17:54:28 INFO - PROCESS | 19405 | 17:54:31 INFO - PROCESS | 19405 | Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44927/tests/kraken/driver.html?testName=audio-oscillator) 17:54:31 INFO - PROCESS | 19405 | RSS: Main: 180543488 17:54:31 INFO - PROCESS | 19405 | 17:54:33 INFO - PROCESS | 19405 | Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44927/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:54:34 INFO - PROCESS | 19405 | RSS: Main: 185430016 17:54:34 INFO - PROCESS | 19405 | 17:54:37 INFO - PROCESS | 19405 | Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44927/tests/kraken/driver.html?testName=imaging-darkroom) 17:54:38 INFO - PROCESS | 19405 | RSS: Main: 224706560 17:54:38 INFO - PROCESS | 19405 | 17:54:41 INFO - PROCESS | 19405 | Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44927/tests/kraken/driver.html?testName=imaging-desaturate) 17:54:42 INFO - PROCESS | 19405 | RSS: Main: 218292224 17:54:42 INFO - PROCESS | 19405 | 17:54:45 INFO - PROCESS | 19405 | Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44927/tests/kraken/driver.html?testName=json-parse-financial) 17:54:45 INFO - PROCESS | 19405 | RSS: Main: 220352512 17:54:45 INFO - PROCESS | 19405 | 17:54:47 INFO - PROCESS | 19405 | Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44927/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:54:48 INFO - PROCESS | 19405 | RSS: Main: 184197120 17:54:48 INFO - PROCESS | 19405 | 17:54:50 INFO - PROCESS | 19405 | Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44927/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:54:50 INFO - PROCESS | 19405 | RSS: Main: 192282624 17:54:50 INFO - PROCESS | 19405 | 17:54:53 INFO - PROCESS | 19405 | Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44927/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:54:53 INFO - PROCESS | 19405 | RSS: Main: 198995968 17:54:53 INFO - PROCESS | 19405 | 17:54:56 INFO - PROCESS | 19405 | Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44927/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:54:57 INFO - PROCESS | 19405 | RSS: Main: 209186816 17:54:57 INFO - PROCESS | 19405 | 17:55:00 INFO - PROCESS | 19405 | Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44927/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:55:00 INFO - PROCESS | 19405 | RSS: Main: 204636160 17:55:00 INFO - PROCESS | 19405 | 17:55:02 INFO - PROCESS | 19405 | Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44927/tests/kraken/driver.html?testName=ai-astar) 17:55:02 INFO - PROCESS | 19405 | RSS: Main: 257220608 17:55:02 INFO - PROCESS | 19405 | 17:55:02 INFO - PROCESS | 19405 | __start_tp_report 17:55:02 INFO - PROCESS | 19405 | _x_x_mozilla_page_load 17:55:02 INFO - PROCESS | 19405 | _x_x_mozilla_page_load_details 17:55:02 INFO - PROCESS | 19405 | |i|pagename|runs| 17:55:02 INFO - PROCESS | 19405 | |0;ai-astar;112;116;115;114;115;116;114;113;115;114 17:55:02 INFO - PROCESS | 19405 | |1;audio-beat-detection;152;129;125;162;132;132;125;127;159;132 17:55:02 INFO - PROCESS | 19405 | |2;audio-dft;162;161;163;161;163;163;161;163;160;161 17:55:02 INFO - PROCESS | 19405 | |3;audio-fft;76;76;75;107;78;76;76;76;106;75 17:55:02 INFO - PROCESS | 19405 | |4;audio-oscillator;84;85;112;84;85;85;104;85;85;115 17:55:02 INFO - PROCESS | 19405 | |5;imaging-gaussian-blur;128;127;128;127;127;127;127;127;128;127 17:55:02 INFO - PROCESS | 19405 | |6;imaging-darkroom;147;147;146;146;146;147;147;146;146;147 17:55:02 INFO - PROCESS | 19405 | |7;imaging-desaturate;96;96;96;96;95;95;96;96;96;95 17:55:02 INFO - PROCESS | 19405 | |8;json-parse-financial;65;63;62;63;69;65;63;64;64;63 17:55:02 INFO - PROCESS | 19405 | |9;json-stringify-tinderbox;65;66;65;65;65;66;66;66;66;66 17:55:02 INFO - PROCESS | 19405 | |10;stanford-crypto-aes;87;84;85;85;95;91;85;91;88;83 17:55:02 INFO - PROCESS | 19405 | |11;stanford-crypto-ccm;144;136;138;135;134;134;132;144;182;142 17:55:02 INFO - PROCESS | 19405 | |12;stanford-crypto-pbkdf2;180;178;176;180;186;178;180;190;177;177 17:55:02 INFO - PROCESS | 19405 | |13;stanford-crypto-sha256-iterative;69;69;69;67;68;68;68;68;68;69 17:55:02 INFO - PROCESS | 19405 | __end_tp_report 17:55:02 INFO - PROCESS | 19405 | __start_cc_report 17:55:02 INFO - PROCESS | 19405 | _x_x_mozilla_cycle_collect,1938 17:55:02 INFO - PROCESS | 19405 | __end_cc_report 17:55:02 INFO - PROCESS | 19405 | __startTimestamp1482198902830__endTimestamp 17:55:02 INFO - PROCESS | 19405 | 17:55:02 INFO - PROCESS | 19405 | ------- Summary: start ------- 17:55:02 INFO - PROCESS | 19405 | Number of tests: 14 17:55:02 INFO - PROCESS | 19405 | 17:55:02 INFO - PROCESS | 19405 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:1.26 (1.1%) stddev-sans-first:1.00 17:55:02 INFO - PROCESS | 19405 | Values: 112.0 116.0 115.0 114.0 115.0 116.0 114.0 113.0 115.0 114.0 17:55:02 INFO - PROCESS | 19405 | 17:55:02 INFO - PROCESS | 19405 | [#1] audio-beat-detection Cycles:10 Average:137.50 Median:132.00 stddev:14.37 (10.9%) stddev-sans-first:14.25 17:55:02 INFO - PROCESS | 19405 | Values: 152.0 129.0 125.0 162.0 132.0 132.0 125.0 127.0 159.0 132.0 17:55:02 INFO - PROCESS | 19405 | 17:55:02 INFO - PROCESS | 19405 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.50 stddev:1.14 (0.7%) stddev-sans-first:1.20 17:55:02 INFO - PROCESS | 19405 | Values: 162.0 161.0 163.0 161.0 163.0 163.0 161.0 163.0 160.0 161.0 17:55:02 INFO - PROCESS | 19405 | 17:55:02 INFO - PROCESS | 19405 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:12.89 (17.0%) stddev-sans-first:13.48 17:55:02 INFO - PROCESS | 19405 | Values: 76.0 76.0 75.0 107.0 78.0 76.0 76.0 76.0 106.0 75.0 17:55:02 INFO - PROCESS | 19405 | 17:55:02 INFO - PROCESS | 19405 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:85.00 stddev:12.67 (14.9%) stddev-sans-first:13.07 17:55:02 INFO - PROCESS | 19405 | Values: 84.0 85.0 112.0 84.0 85.0 85.0 104.0 85.0 85.0 115.0 17:55:02 INFO - PROCESS | 19405 | 17:55:02 INFO - PROCESS | 19405 | [#5] imaging-gaussian-blur Cycles:10 Average:127.30 Median:127.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 17:55:02 INFO - PROCESS | 19405 | Values: 128.0 127.0 128.0 127.0 127.0 127.0 127.0 127.0 128.0 127.0 17:55:02 INFO - PROCESS | 19405 | 17:55:02 INFO - PROCESS | 19405 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 17:55:02 INFO - PROCESS | 19405 | Values: 147.0 147.0 146.0 146.0 146.0 147.0 147.0 146.0 146.0 147.0 17:55:02 INFO - PROCESS | 19405 | 17:55:02 INFO - PROCESS | 19405 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 17:55:02 INFO - PROCESS | 19405 | Values: 96.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 17:55:02 INFO - PROCESS | 19405 | 17:55:02 INFO - PROCESS | 19405 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.00 stddev:1.97 (3.1%) stddev-sans-first:2.06 17:55:02 INFO - PROCESS | 19405 | Values: 65.0 63.0 62.0 63.0 69.0 65.0 63.0 64.0 64.0 63.0 17:55:02 INFO - PROCESS | 19405 | 17:55:02 INFO - PROCESS | 19405 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 17:55:02 INFO - PROCESS | 19405 | Values: 65.0 66.0 65.0 65.0 65.0 66.0 66.0 66.0 66.0 66.0 17:55:02 INFO - PROCESS | 19405 | 17:55:02 INFO - PROCESS | 19405 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:87.50 stddev:3.84 (4.4%) stddev-sans-first:4.07 17:55:02 INFO - PROCESS | 19405 | Values: 87.0 84.0 85.0 85.0 95.0 91.0 85.0 91.0 88.0 83.0 17:55:02 INFO - PROCESS | 19405 | 17:55:02 INFO - PROCESS | 19405 | [#11] stanford-crypto-ccm Cycles:10 Average:142.10 Median:140.00 stddev:14.67 (10.5%) stddev-sans-first:15.54 17:55:02 INFO - PROCESS | 19405 | Values: 144.0 136.0 138.0 135.0 134.0 134.0 132.0 144.0 182.0 142.0 17:55:02 INFO - PROCESS | 19405 | 17:55:02 INFO - PROCESS | 19405 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.20 Median:180.00 stddev:4.44 (2.5%) stddev-sans-first:4.71 17:55:02 INFO - PROCESS | 19405 | Values: 180.0 178.0 176.0 180.0 186.0 178.0 180.0 190.0 177.0 177.0 17:55:02 INFO - PROCESS | 19405 | 17:55:02 INFO - PROCESS | 19405 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 17:55:02 INFO - PROCESS | 19405 | Values: 69.0 69.0 69.0 67.0 68.0 68.0 68.0 68.0 68.0 69.0 17:55:02 INFO - PROCESS | 19405 | -------- Summary: end -------- 17:55:02 INFO - PROCESS | 19405 | 17:55:03 INFO - TEST-INFO | 19405: exit 0 17:55:04 INFO - TEST-OK | kraken | took 64024ms 17:55:04 INFO - SUITE-END | took 1187s 17:55:04 INFO - Completed test suite (00:19:47) 17:55:04 INFO - javascript benchmark 17:55:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2668.079512568164, 2694.9730502694993, 2708.742669446402, 2726.945461090777, 2740.534109201437, 4785.641076919236, 4823.807047718087, 4855.465898751139, 4897.53473420025, 4904.509549045094, 4797.280407938802, 4802.951970480294, 4854.635902307324, 4868.756562171886, 4896.510348965111, 4349.913001739963, 4382.956170438287, 4416.580424859633, 4470.552944705536, 4555.066211426666, 4106.42970788227, 4415.492218394877, 4467.0, 4492.685512014144, 4546.363509108727, 4345.0, 4398.120375924827, 4444.333349997494, 4492.910141797146, 4519.27691569349, 4379.912401751979, 4408.426904502427, 4432.556744325574, 4433.22418576751, 4476.037651904823, 4377.9781101094295, 4396.1427521633295, 4405.537418571068, 4453.866384008485, 4460.041091165415, 4810.7113573185725, 4835.637327200438, 4849.927251091236, 4854.320395144682, 4858.319835223072, 5033.270175824521, 5078.949210507884, 5083.085044691954, 5166.664166829181, 5199.220116982445, 5189.42916279209, 5206.401263854667, 5217.373915130209, 5243.134882744343, 5304.045271851065, 4884.755762211875, 4888.2178851383605, 4892.559669629751, 4894.412670479494, 4939.604831613462, 5127.07712611726, 5366.570674346043, 5369.301990741179, 5373.650712703662, 5374.0, 4951.777170027357, 4975.527324904201, 5010.874728131753, 5031.874203144951, 5045.924311135336, 5162.045021671003, 5163.509466600667, 5188.11801993662, 5216.243644671501, 5219.712915789592, 5052.242163675478, 5065.569426598707, 5120.513551212629, 5121.564667003347, 5175.430702622709, 4961.280614310905, 4994.275830004629, 5106.642535022587, 5109.897802044013, 5118.513741194581, 4384.254676704968, 4393.494748103945, 4394.318880573516, 4412.183746006935, 4449.1101779644205, 3828.0429892526868, 3829.1767270037076, 3832.156925476391, 3864.9806750966063, 3869.5163104611925, 4409.36064270679, 4410.184115938561, 4412.36020776992, 4412.4705035395955, 4455.799489023002, 5021.07110184617, 5043.36957880265, 5046.798128074836, 5102.158143906214, 5126.333576635014, 4309.676774241944, 4334.501532323823, 4352.760598167068, 4361.6510679145595, 4365.0, 4654.138984287918, 4660.930086048712, 4664.86005419838, 4687.039156972813, 4708.058388322349, 4809.495003024632, 4811.78346974394, 4816.518348165156, 4852.44196917359, 4855.75721213945, 5048.217526283432, 5077.086124497626, 5149.536541711264, 5152.948470515247, 5153.3815942087185, 4746.145693775154, 4825.131476334293, 4868.634852386014, 4872.90254194907, 4924.482929292372, 5098.592112631055, 5128.692278463304, 5134.691918484903, 5139.743012849268, 5182.170852663707, 5232.921506177487, 5237.685738855681, 5239.056969745482, 5247.763850626655, 5248.6325957182635, 4869.342638743866, 4945.18404463274, 4950.801967921243, 5008.974955125201, 5013.448520662651, 4996.0, 5046.722430266371, 5049.444561098203, 5087.592992560512, 5101.183810590288, 4981.750912454435, 4984.028114517634, 4986.0, 4991.376077990251, 5024.246363045572, 4974.228994505857, 5014.674046186986, 5016.423111342242, 5095.490450954875, 5101.872453188552, 4892.363992680928, 4913.557779799692, 4922.384701912261, 4948.233023881304, 4991.0], "value": 4732.236683619099, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.74065485947307, 499.33338992445084, 502.05864004990667, 531.1422053383785, 534.3320848938827, 27666.861665691693, 36844.263114737725, 38478.23043539131, 38571.228575428475, 38658.613413865925, 38543.0, 39006.8049659752, 39012.0, 39019.21961560767, 39096.0, 7517.4737768356235, 7721.266479684449, 7728.111267204259, 7740.303372696456, 7742.496737712031, 7145.285471452865, 7289.817754556126, 9765.853512197287, 10009.049140331657, 10014.198864090891, 10003.89996100037, 10027.298089133763, 10052.698419047403, 10098.949505252463, 10108.595656173744, 9828.803423931517, 9922.007799220128, 9986.0, 9992.400455972593, 10010.249231307609, 9773.706788796348, 9867.60529578816, 9868.703938881845, 9869.062439068277, 9872.40765554069, 35317.82341088304, 35672.28655426877, 35673.82163089194, 35789.64210357915, 35798.8210058948, 2748.5190091734066, 2974.9107526774233, 3045.7867949243564, 3049.9695003049906, 3293.127321259868, 27003.324916877038, 27525.17424477269, 27633.86183069092, 28046.85976570104, 28469.145925622266, 3320.684534969174, 3379.1721028347965, 3391.253924136686, 3412.505186747908, 3421.8460169292443, 231280.0, 231673.0, 232027.0, 232713.0, 233876.9999999983, 50096.0, 50462.0, 50473.99052018939, 50484.24273635898, 50490.747546262035, 53060.469395306325, 53107.468925310255, 53161.0, 53394.73302633462, 53417.1987420189, 14692.338844752012, 14895.851041489663, 14935.327910244065, 14962.251887405586, 14970.70058598822, 8791.604377803014, 8886.4668119913, 10635.893641063645, 10685.57257709683, 10691.358518488916, 14028.649283767783, 14180.290985450687, 14205.218712970885, 14252.928735356465, 14866.851331486547, 4928.852134435972, 5822.126680997884, 5891.263592050994, 5909.497692696083, 5914.260717410324, 709.6948312225793, 807.2411932783165, 851.4423052900361, 869.9347548933729, 895.9417637853519, 26017.739822601532, 26729.19812405631, 26740.866295668788, 27200.183994480198, 27238.45523089527, 891.8528442806994, 912.9908700913039, 967.3567077893122, 976.9658061967797, 997.6209040564684, 13671.726565468634, 14141.929290353482, 14443.133411995314, 14597.708045839236, 14605.12369257848, 332889.0, 344132.0, 346660.0, 347150.0, 348553.0, 37910.62089379071, 44957.0, 46466.76766616145, 46615.53384466112, 52297.0, 1096.380544992077, 1123.8258069999163, 1143.1997601678693, 1146.2148428326623, 1147.65570328901, 26840.865795670896, 27828.30429239285, 28373.85813071004, 28506.287342816595, 28989.27526811762, 40957.590424095375, 41248.0, 41444.585554144076, 41450.37824432696, 41457.37813932733, 300179.0, 301325.0, 301647.0, 301672.0, 301986.0, 33839.81560645365, 34166.12086335276, 34350.31299374049, 34578.65421345855, 34585.84969803539, 35345.646543535266, 39534.604653953094, 40083.799581001906, 40832.79583602063, 41192.588074120074, 29726.702732972393, 30671.53992690156, 30774.84612576923, 30918.22704432407, 31970.36059278848, 30618.387632247675, 30816.691833081382, 31179.220519487193, 31242.843785781835, 32270.0, 29744.553831692974, 29781.468575170486, 30755.0, 30863.2284192897, 31904.521432179, 27080.729192708608, 28525.28686782847, 28914.27714307075, 29173.0, 29261.70738292675, 22812.4296892579, 22925.197618083956, 23194.652080219148, 23237.468693604584, 23287.32195797437], "value": 16958.20385987585, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.8000159907251, 368.22121213633176, 371.94234893591494, 372.97762134271943, 392.1001302011882, 12551.686207844808, 12553.121281510286, 13213.735725285489, 16234.269457874394, 16880.0, 14311.355988980495, 14556.781648275284, 14584.927075364634, 14693.77959330611, 14694.338754756034, 4924.187509061001, 5123.820666276681, 5123.871903202413, 5334.0, 5375.838724838261, 3470.514128022079, 5397.190421436777, 5425.26758887551, 5434.864128396802, 5435.320584926884, 3640.6359364063514, 5604.131359639263, 5846.21076154718, 5854.09261564456, 5958.344582095966, 5367.758450869681, 5419.160030195287, 5946.97026514869, 5957.970210148921, 5963.582549221556, 5245.423003469616, 5247.0, 5249.081410753103, 5250.238715386286, 5252.159654455307, 12298.75402491954, 12488.313142777144, 19486.80513194864, 19615.0, 19804.10881510321, 1821.6812057889815, 1856.4337876947525, 1937.9127939242767, 1990.3730324947596, 2414.0464516516054, 8840.778980525474, 8860.113988601153, 9265.907340926571, 9280.0, 9484.383515071568, 1409.3869166912425, 1525.458462245909, 1597.5047735202124, 1664.0431751742797, 1693.6358682883117, 62886.685566572334, 67806.3219367805, 67966.32033679698, 69361.65319173422, 71045.64477177581, 9535.47554884488, 9826.0, 9840.261980351503, 9892.406455612687, 10082.596696132072, 13672.589822305346, 13689.589312320646, 13699.726005479835, 13700.0, 13715.794263086062, 6756.797296081126, 7307.123145222501, 7312.707491700379, 7400.222976587381, 7443.627818609048, 6598.076269322299, 6838.93161068383, 6918.7232510699005, 7092.255313192144, 7116.608586527791, 4260.893477663021, 4314.892127696833, 4384.890377740582, 4448.088141930896, 4512.887177820581, 1779.350537053966, 1804.6029873428088, 1820.5812663087563, 1830.675042695769, 1833.4499650104915, 790.9006480991427, 793.8449555896158, 795.1015352651582, 832.3466079127855, 892.1836519584507, 15100.244987750788, 16219.675606487805, 16411.1794410279, 16574.0, 16679.6664066718, 847.6270441005938, 849.9447535910147, 852.7569642651814, 855.922966932979, 909.9676071313818, 8882.555872206363, 9112.271018318519, 9426.95286523563, 9498.715038548855, 9650.324477286522, 328418.0, 332382.0, 333741.0, 335765.0, 336504.0, 48901.75549122231, 55590.0, 75221.6238918802, 75371.62314188395, 76548.23451765522, 858.2190206911805, 883.5277359975358, 896.8834051573253, 900.1763386501278, 900.1943260781563, 10850.837237441603, 15009.0, 15939.0, 15997.200139992721, 16482.25829837684, 28903.421931561672, 31759.841200794774, 32827.34345313128, 34210.31579368349, 36241.093972650895, 47693.5230647703, 48522.51477485321, 48571.27143092927, 48814.511854881, 50835.0, 10553.314034587727, 11004.449777511252, 11041.889581104086, 11077.889221107685, 11496.195266331611, 12043.397830108284, 12277.324747138637, 12387.938060310002, 12443.44004519817, 12748.235105893677, 10595.94702026485, 10690.679279621623, 10706.73233169177, 10720.839187412352, 11187.272827266203, 10529.4735263235, 10552.0, 10634.627788027381, 10714.839277410689, 10728.946355268174, 10928.50821713009, 10951.56193752241, 10993.505292262027, 11161.609343672932, 11382.94308528452, 10943.28868623537, 11141.2201145919, 11146.832797508207, 11208.103351732005, 11365.488553015299, 10434.0, 10715.0, 10770.461476926279, 10989.285696430026, 11103.333799972028], "value": 8138.3965076467775, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1305.3081866610696, 1345.4483661698705, 1408.8943329250308, 1590.7454807230831, 1619.6436783907536, 7226.783196504107, 7531.736389226378, 7540.245975402464, 7546.584937828431, 7556.659950302236, 6475.352464753522, 6718.563293385926, 7052.964735176317, 7225.530340527862, 7227.0, 2087.697283893838, 2121.9151233950624, 2122.1405330841035, 2122.490602255455, 2123.2568600989607, 2115.386537904006, 2141.957160856782, 2168.0677308757226, 2170.2621108822996, 2171.6525355943054, 1816.355193906164, 1875.1749230338676, 1878.9812101878942, 1884.2839720906036, 2073.5956488484676, 2106.799854013866, 2153.0526568309892, 2153.4616345913523, 2154.967675484869, 2156.967645485319, 2167.328128280238, 2189.5839790439763, 2195.484061245606, 2220.755716871143, 2225.432514708739, 7427.554346739213, 7479.551226926402, 7486.737964171228, 7488.4009279257525, 7493.138289096769, 4347.130573885235, 4490.236659767847, 4492.842750503717, 4495.910081798345, 4497.572730590621, 2796.790240731933, 2895.1025182193375, 2970.59896913916, 2990.760739140885, 3004.6244219472565, 868.2966796894535, 873.4497266721925, 913.2785099771173, 913.8629205619144, 918.2011649864661, 10122.898771012344, 10143.64497242593, 10216.13162881156, 10217.080462758313, 10225.795484090351, 3961.603839616015, 4098.200850834059, 4152.854650087293, 4174.791260436966, 4187.036981494273, 8498.787530311793, 8500.27747641445, 8505.10696376884, 8522.062573116953, 8529.360297977677, 4393.560643935581, 4466.776661166994, 4467.441569803775, 4472.08322293929, 4476.37330773692, 3966.5438474575217, 4015.598440155961, 4020.296448121567, 4024.557298697141, 4024.5774193709826, 3204.198950262434, 3209.6308924473983, 3263.233140212096, 3279.950800737991, 3300.1254667513126, 976.2873102635116, 984.3552473130111, 1000.5847573257017, 1002.9899701003043, 1010.9393436393693, 635.3519410201661, 700.9579425234502, 780.8438312337441, 827.1025936858456, 838.7064527415478, 4786.0, 4986.202207646759, 5056.570191533688, 5080.59355251579, 5338.199270109515, 801.867691830853, 812.8577498937663, 830.8546004449197, 847.7795773099039, 884.3544212724619, 3260.820654864005, 3588.802615856153, 3723.3484140275345, 3728.8881333560034, 3730.8321125549414, 8522.57387130641, 8868.822623547621, 9051.094890510896, 9077.546122693971, 9103.908960910307, 8976.955115224513, 8996.325275604357, 9007.459552426875, 9012.819743605221, 9046.276297896153, 6839.0, 6901.896471552931, 7020.052292940388, 7058.153021637437, 7114.786556403213, 5043.193089105725, 5091.618128640441, 5094.217024041556, 5131.127708289525, 5195.584353251656, 8178.754637360888, 8200.220979006985, 8219.342452603658, 8272.710455134042, 8348.791280218044, 8423.410361274651, 8453.323734101381, 8486.660533578588, 8494.617742201739, 8580.570971451527, 5812.5349972001295, 5926.525877929842, 5926.614770039933, 5932.822015339547, 5966.254218222723, 6924.4460443165435, 7037.225905150327, 7044.084269044992, 7114.964425177841, 7118.323759242864, 6352.68236588178, 6407.967960160356, 6461.386168314003, 6473.838154046187, 6528.183977002875, 5608.85977850557, 6110.236220472441, 6286.717097730704, 6329.683515824282, 6342.143810585512, 5868.061110222344, 6005.36943620931, 6013.218281623361, 6018.668973206516, 6021.789237376671, 4258.382534532538, 4339.934900976425, 4343.3484977253665, 4427.048184640318, 4480.843170489017, 4364.454443194601, 4561.2017896867255, 4562.794674239601, 4661.673682842168, 4732.621390288838], "value": 3932.6322945865654, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.9875404360846, 357.57091490211747, 358.05652106698847, 360.238096426059, 365.46459436924914, 4851.514848515147, 4888.608911287098, 4898.191798353272, 4906.190478571036, 4932.309476673268, 4818.602884966099, 4842.612590992721, 4848.200046992242, 4850.34520339754, 4853.296272040552, 3563.7883119739286, 3683.2081102562943, 3798.9240215195678, 3810.047488127968, 3862.875418519817, 3828.1386687995255, 3837.846486140565, 3845.961640330629, 3853.5183102112237, 3860.613938606145, 3832.1569254764045, 3848.249591329678, 3857.9421308680394, 3870.9225815483674, 3873.9806300968457, 3633.509476220716, 3757.7369584129124, 3785.356489396809, 3861.7489863158803, 3862.1889403225355, 3467.1158854492196, 3471.6007659119273, 3479.9478007829903, 3488.372093023255, 3491.1446695559753, 4705.952940470585, 4707.882302942419, 4711.787969541345, 4735.857924262244, 4762.904741905177, 4311.33174357975, 4442.222611043055, 4445.73325600465, 4453.977730111361, 4458.95214624563, 5023.949760502422, 5055.9241611375855, 5058.392992840846, 5062.443131255559, 5063.291139240509, 3831.7700937943814, 3832.7038746677836, 3833.252515759428, 3839.1361943562756, 3843.442700808367, 4972.055309491185, 5111.309973153651, 5206.973965130226, 5316.846677095782, 5340.412554618989, 3915.138669492707, 3932.3511620582285, 3933.5476420212044, 3934.272159650474, 3953.1303113315025, 3986.4618276532296, 4012.4382586437923, 4019.959800402017, 4022.91954160921, 4024.0, 4070.9185816284103, 4435.534268901783, 4444.599986001211, 4444.6666500012625, 4476.776161191992, 5048.924266136011, 5049.722265275372, 5055.393352797688, 5074.695518268915, 5088.262201980766, 1259.3451405269209, 1260.962171134849, 1263.4377701922556, 1270.9491620335268, 1271.1419791640606, 819.5861090149436, 855.3157474020759, 858.8539948208819, 873.3449912565576, 883.2933653077512, 4365.236083685342, 4368.4102646143, 4372.322290045048, 4378.16814805186, 4378.365137055172, 5079.796808127633, 5116.974415127975, 5120.1039818031695, 5123.847134394806, 5163.457836927144, 4347.804348804311, 4358.302671572533, 4373.343998400202, 4381.0, 4386.627136693417, 2593.312772115391, 2727.263638817548, 2741.931451713723, 2746.8025579536293, 2751.477219328321, 4778.4982576829625, 4782.904341913142, 4784.378030856036, 4795.328653988445, 4795.923465054676, 5101.0, 5185.637005409661, 5213.7914483421, 5260.421353651095, 5280.175106318102, 4912.484189160158, 4919.729414882216, 4929.778159982738, 4932.506749325039, 4945.629077819106, 5272.787258930544, 5277.551408130352, 5287.695190505934, 5330.626856120034, 5340.572754179579, 4978.502149785138, 5177.145770947902, 5209.322788037531, 5216.921746173886, 5234.895302093861, 4707.17624415719, 4802.255650374198, 4817.772092697831, 4934.679245849152, 4966.279889415942, 3726.944095838619, 3745.213505163946, 3748.925021499609, 3758.116842542055, 3758.210775737126, 5265.842024739264, 5301.946980530145, 5321.973390133025, 5323.893522129459, 5327.360716714019, 4928.728919909439, 5089.949100509096, 5131.512506311894, 5134.792039422935, 5176.870578235575, 5090.389153301628, 5094.981003799181, 5100.923486147785, 5118.181091025418, 5121.539061484485, 5050.141475949024, 5066.645334826527, 5083.0, 5085.110105731556, 5098.821541246039, 4904.852854414374, 5164.8192313268855, 5183.196604526304, 5197.688138711689, 5198.792048318176, 5036.589754868643, 5058.1654027085115, 5058.9494105058475, 5067.579383915916, 5080.847574572768], "value": 3872.2409754805717, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.2713289786459, 602.2875057484338, 614.057421857449, 713.8108401273663, 722.8373615936413, 12078.69803254918, 12577.434015469304, 12667.619971400849, 12680.365981700925, 12694.04794640401, 12113.818292725595, 12159.148859579833, 12196.207246528991, 12235.632931012084, 12237.571684991028, 595.5563105486418, 611.1443978430211, 724.5869854183118, 733.5158795195172, 745.4744405194325, 746.9626518674072, 749.3630414147985, 750.5796753817853, 750.6284389227313, 750.6847124207818, 802.297989259398, 802.9558374289412, 803.6825453945688, 803.907550631679, 803.9155888631698, 629.6064959400375, 644.310587671192, 647.9578827376206, 650.39513252675, 790.8971833661616, 478.3088437208236, 563.6730696196238, 580.083468120373, 582.6853499110475, 584.0975692555013, 13215.60353189406, 13221.669458263525, 13274.137181083199, 13276.535321263806, 13283.468661253539, 12461.376931153496, 12518.374081295899, 12567.245965242115, 12569.93715031419, 12706.809397859039, 11326.603568875049, 11402.429878506042, 11556.595519156874, 11742.765144697143, 11891.04871610269, 3069.7083777041144, 3195.8242296673675, 3261.2173078461237, 3329.96670033299, 3351.2962277921665, 51843.481565184244, 52528.999999999614, 52609.47390526084, 53408.732956335356, 61940.0, 9626.326157169071, 9867.161291290176, 10076.647317344004, 10123.797524049478, 10177.84733229002, 18705.532361690795, 18886.905565472083, 18896.24415023411, 18916.432507024812, 18947.052647367578, 6533.640649764214, 6642.114298261454, 6683.0, 6694.966525167343, 6698.330166983263, 3498.2478767065204, 3644.416893297113, 3648.1973965727498, 3662.560492740835, 3704.49989251453, 2697.6223328733995, 2839.346950201465, 2873.482773100862, 2875.4536638038708, 2878.7409133178116, 547.7261369315343, 555.7749111609804, 557.6319629044892, 567.1662655895826, 572.321798668579, 425.79987405919167, 545.1277955271613, 562.8592851787054, 574.7413663851283, 591.8518074934613, 7448.217937116633, 7762.611869406507, 7793.844123117506, 7959.721409750631, 8023.197680232047, 445.65461767130734, 451.5371743962465, 478.12025872394264, 502.7511381866, 566.5014786987507, 3479.408500554912, 3488.808115553669, 3551.94672079919, 3632.1646021414695, 3723.832427540767, 62550.68724656347, 65743.34256657468, 66581.66709166423, 66590.66704666446, 67498.66250668715, 44864.10271794546, 51804.22293665598, 54881.45118548843, 57661.0, 59992.400075999554, 50473.747631261605, 50932.92536597137, 51622.22566661503, 52200.0, 52680.736596316776, 6981.75563855283, 7039.366457018893, 7076.787696369117, 7191.993120962965, 7269.636518173965, 37275.645191932854, 37304.69433569812, 37749.0, 38174.618253817105, 39354.60645393509, 45170.77414612906, 47900.0, 48897.75551122222, 50960.98078038344, 51432.22851657153, 8494.22760846765, 8812.471251724917, 9065.68270110543, 9990.400575965175, 10249.590016399261, 11712.70718232051, 11885.643430697093, 11958.701032474257, 11986.0, 12411.193272437262, 9455.905440945502, 10830.837537437103, 11119.332840029625, 11534.769304614028, 11616.303021818718, 10179.7455063624, 10877.564897404016, 11002.669919902415, 11009.2843965142, 11264.267822591506, 10326.690199294033, 10627.787444251226, 11280.830787538029, 11609.6517104487, 11634.418279085843, 8904.376693631384, 9222.492762898106, 9393.295502837178, 9440.19758320523, 9572.90427095748, 9362.672306469512, 10039.598416063567, 10067.546960386946, 10108.595656173671, 10127.442990635585], "value": 5980.813560062296, "unit": "score"}], "name": "dromaeo_css", "value": 6247.985350415931, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 115.0, 114.0, 115.0, 116.0, 114.0, 113.0, 115.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 129.0, 125.0, 162.0, 132.0, 132.0, 125.0, 127.0, 159.0, 132.0], "value": 137.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 161.0, 163.0, 163.0, 161.0, 163.0, 160.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 107.0, 78.0, 76.0, 76.0, 76.0, 106.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 112.0, 84.0, 85.0, 85.0, 104.0, 85.0, 85.0, 115.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 128.0, 127.0, 127.0, 127.0, 127.0, 127.0, 128.0, 127.0], "value": 127.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 62.0, 63.0, 69.0, 65.0, 63.0, 64.0, 64.0, 63.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 85.0, 85.0, 95.0, 91.0, 85.0, 91.0, 88.0, 83.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 136.0, 138.0, 135.0, 134.0, 134.0, 132.0, 144.0, 182.0, 142.0], "value": 142.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 178.0, 176.0, 180.0, 186.0, 178.0, 180.0, 190.0, 177.0, 177.0], "value": 180.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1565.4, "alertThreshold": 2.0}]} 17:55:04 INFO - Return code: 0 17:55:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:55:04 INFO - # TBPL SUCCESS # 17:55:04 INFO - Running post-action listener: _resource_record_post_action 17:55:04 INFO - [mozharness: 2016-12-20 01:55:04.614391Z] Finished run-tests step (success) 17:55:04 INFO - Running post-run listener: _resource_record_post_run 17:55:04 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 77824; Write bytes: 405151744; Read time: 24; Write time: 637312 17:55:04 INFO - TinderboxPrint: CPU usage
13.1% 17:55:04 INFO - TinderboxPrint: I/O read bytes / time
77,824 / 24 17:55:04 INFO - TinderboxPrint: I/O write bytes / time
405,151,744 / 637,312 17:55:04 INFO - TinderboxPrint: CPU idle
8,348.0 (86.9%) 17:55:04 INFO - TinderboxPrint: CPU user
1,214.7 (12.6%) 17:55:04 INFO - TinderboxPrint: Swap in / out
0 / 0 17:55:04 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 99241984; Read time: 0; Write time: 242424 17:55:04 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 73728; Write bytes: 294023168; Read time: 12; Write time: 392240 17:55:05 INFO - Running post-run listener: _upload_blobber_files 17:55:05 INFO - Blob upload gear active. 17:55:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:55:05 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 17:55:05 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:55:05 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:55:05 INFO - (blobuploader) - INFO - Open directory for files ... 17:55:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:55:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:55:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:09 INFO - (blobuploader) - INFO - Done attempting. 17:55:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:55:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:55:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:10 INFO - (blobuploader) - INFO - Done attempting. 17:55:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:55:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:55:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:11 INFO - (blobuploader) - INFO - Done attempting. 17:55:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:55:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:55:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:12 INFO - (blobuploader) - INFO - Done attempting. 17:55:12 INFO - (blobuploader) - INFO - Iteration through files over. 17:55:12 INFO - Return code: 0 17:55:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:55:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:55:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b5e2d1225b575ff50fa8830293442ecd267cb2bd951828aa6bd851f866306919b7740d46d805444a43c7d6630065e3fd49b317ab61d4acc18a7dcefbe3372f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/446a4652bbf17bc10453d0521deeb18bf4cc5ae9800293b9339eede1e5991779c22458a810e5b506afe4ff745753f3f6cabcc23c0edc9b700c18090ccb8eba32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/492eca873e1649fe3bcfbf5859a15440974861b45ba94a552b07b4dfe9b184962bdb0a2b1126d2616f4b03ca2a764e7e629712efc27f24225eb37bd67baeef7a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe21c0a1bed1e987476435ad03b87efbab1adcbaa528029d975c8dbc9d6d051c178d1ff4a776ec203863f260245aef2439423fb6995167ff6c06a36b3c35e91b"} 17:55:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:55:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:55:12 INFO - Contents: 17:55:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b5e2d1225b575ff50fa8830293442ecd267cb2bd951828aa6bd851f866306919b7740d46d805444a43c7d6630065e3fd49b317ab61d4acc18a7dcefbe3372f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/446a4652bbf17bc10453d0521deeb18bf4cc5ae9800293b9339eede1e5991779c22458a810e5b506afe4ff745753f3f6cabcc23c0edc9b700c18090ccb8eba32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/492eca873e1649fe3bcfbf5859a15440974861b45ba94a552b07b4dfe9b184962bdb0a2b1126d2616f4b03ca2a764e7e629712efc27f24225eb37bd67baeef7a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe21c0a1bed1e987476435ad03b87efbab1adcbaa528029d975c8dbc9d6d051c178d1ff4a776ec203863f260245aef2439423fb6995167ff6c06a36b3c35e91b"} 17:55:12 INFO - Running post-run listener: copy_logs_to_upload_dir 17:55:12 INFO - Copying logs to upload dir... 17:55:12 INFO - mkdir: /builds/slave/test/build/upload/logs 17:55:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.996650 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-12-19 17:55:12.086466) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-19 17:55:12.090248) ========= 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=af724c981e2a0f424dbabf99000001e7-1482197661.769031-944354883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b5e2d1225b575ff50fa8830293442ecd267cb2bd951828aa6bd851f866306919b7740d46d805444a43c7d6630065e3fd49b317ab61d4acc18a7dcefbe3372f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/446a4652bbf17bc10453d0521deeb18bf4cc5ae9800293b9339eede1e5991779c22458a810e5b506afe4ff745753f3f6cabcc23c0edc9b700c18090ccb8eba32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/492eca873e1649fe3bcfbf5859a15440974861b45ba94a552b07b4dfe9b184962bdb0a2b1126d2616f4b03ca2a764e7e629712efc27f24225eb37bd67baeef7a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe21c0a1bed1e987476435ad03b87efbab1adcbaa528029d975c8dbc9d6d051c178d1ff4a776ec203863f260245aef2439423fb6995167ff6c06a36b3c35e91b"} build_url:https://queue.taskcluster.net/v1/task/JHhvtG3-QMKPBVYId1TylA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011767 build_url: 'https://queue.taskcluster.net/v1/task/JHhvtG3-QMKPBVYId1TylA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3b5e2d1225b575ff50fa8830293442ecd267cb2bd951828aa6bd851f866306919b7740d46d805444a43c7d6630065e3fd49b317ab61d4acc18a7dcefbe3372f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/446a4652bbf17bc10453d0521deeb18bf4cc5ae9800293b9339eede1e5991779c22458a810e5b506afe4ff745753f3f6cabcc23c0edc9b700c18090ccb8eba32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/492eca873e1649fe3bcfbf5859a15440974861b45ba94a552b07b4dfe9b184962bdb0a2b1126d2616f4b03ca2a764e7e629712efc27f24225eb37bd67baeef7a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe21c0a1bed1e987476435ad03b87efbab1adcbaa528029d975c8dbc9d6d051c178d1ff4a776ec203863f260245aef2439423fb6995167ff6c06a36b3c35e91b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-19 17:55:12.115966) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 17:55:12.116299) ========= 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=af724c981e2a0f424dbabf99000001e7-1482197661.769031-944354883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 17:55:12.199705) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-19 17:55:12.200037) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-19 17:55:12.200333) ========= ========= Total master_lag: 0.16 =========